builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1453555815.93 results: success (0) buildid: 20160123030348 builduid: ba4172364f6c4da2befe2605e4704566 revision: 5f7c184ccd800b2ed512c23fb609007efd198eaf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:15.934355) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:15.934914) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:15.935328) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006329 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:15.985870) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:15.986215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:16.021401) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:16.021751) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.033442 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:16.071826) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:16.072176) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:16.072594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:16.073003) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-23 05:30:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.9M=0s 2016-01-23 05:30:16 (34.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160201 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:16.247236) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:16.247658) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.151234 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:16.413269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:16.413696) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5f7c184ccd800b2ed512c23fb609007efd198eaf --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5f7c184ccd800b2ed512c23fb609007efd198eaf --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-23 05:30:17,179 truncating revision to first 12 chars 2016-01-23 05:30:17,179 Setting DEBUG logging. 2016-01-23 05:30:17,179 attempt 1/10 2016-01-23 05:30:17,180 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5f7c184ccd80?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-23 05:30:17,423 unpacking tar archive at: mozilla-central-5f7c184ccd80/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545855 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:16.973021) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:16.973425) ========= echo 5f7c184ccd800b2ed512c23fb609007efd198eaf in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5f7c184ccd800b2ed512c23fb609007efd198eaf'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5f7c184ccd800b2ed512c23fb609007efd198eaf program finished with exit code 0 elapsedTime=0.003517 script_repo_revision: '5f7c184ccd800b2ed512c23fb609007efd198eaf' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:17.022528) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:17.022924) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:17.033267) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-23 05:30:17.033641) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:30:17 INFO - MultiFileLogger online at 20160123 05:30:17 in /builds/slave/test-pgo 05:30:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:30:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:30:17 INFO - {'append_to_log': False, 05:30:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:30:17 INFO - 'blob_upload_branch': 'Firefox', 05:30:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:30:17 INFO - 'branch': 'Firefox', 05:30:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:30:17 INFO - 'config_files': ('talos/linux_config.py',), 05:30:17 INFO - 'default_actions': ('clobber', 05:30:17 INFO - 'read-buildbot-config', 05:30:17 INFO - 'download-and-extract', 05:30:17 INFO - 'populate-webroot', 05:30:17 INFO - 'create-virtualenv', 05:30:17 INFO - 'install', 05:30:17 INFO - 'run-tests'), 05:30:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:30:17 INFO - 'download_minidump_stackwalk': True, 05:30:17 INFO - 'download_symbols': 'ondemand', 05:30:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:30:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:30:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:30:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:30:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:30:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:30:17 INFO - 'installer_path': 'installer.exe', 05:30:17 INFO - 'log_level': 'info', 05:30:17 INFO - 'log_name': 'talos', 05:30:17 INFO - 'log_to_console': True, 05:30:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:30:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:30:17 INFO - 'opt_config_files': (), 05:30:17 INFO - 'pip_index': False, 05:30:17 INFO - 'sps_profile': False, 05:30:17 INFO - 'sps_profile_interval': 0, 05:30:17 INFO - 'suite': 'dromaeojs-e10s', 05:30:17 INFO - 'system_bits': '32', 05:30:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:30:17 INFO - 'title': 'talos-linux64-ix-064', 05:30:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:30:17 INFO - 'use_talos_json': True, 05:30:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:30:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:30:17 INFO - 'work_dir': 'build'} 05:30:17 INFO - ##### 05:30:17 INFO - ##### Running clobber step. 05:30:17 INFO - ##### 05:30:17 INFO - Running pre-action listener: _resource_record_pre_action 05:30:17 INFO - Running main action method: clobber 05:30:17 INFO - rmtree: /builds/slave/test-pgo/build 05:30:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:30:19 INFO - Running post-action listener: _resource_record_post_action 05:30:19 INFO - ##### 05:30:19 INFO - ##### Running read-buildbot-config step. 05:30:19 INFO - ##### 05:30:19 INFO - Running pre-action listener: _resource_record_pre_action 05:30:19 INFO - Running main action method: read_buildbot_config 05:30:19 INFO - Using buildbot properties: 05:30:19 INFO - { 05:30:19 INFO - "project": "", 05:30:19 INFO - "product": "firefox", 05:30:19 INFO - "script_repo_revision": "production", 05:30:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:30:19 INFO - "repository": "", 05:30:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:30:19 INFO - "buildid": "20160123030348", 05:30:19 INFO - "stage_platform": "linux64-pgo", 05:30:19 INFO - "basedir": "/builds/slave/test-pgo", 05:30:19 INFO - "nightly_build": "True", 05:30:19 INFO - "buildnumber": 82, 05:30:19 INFO - "slavename": "talos-linux64-ix-064", 05:30:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:30:19 INFO - "platform": "ubuntu64_hw", 05:30:19 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:30:19 INFO - "branch": "mozilla-central", 05:30:19 INFO - "repo_path": "mozilla-central", 05:30:19 INFO - "revision": "5f7c184ccd800b2ed512c23fb609007efd198eaf", 05:30:19 INFO - "pgo_build": "True", 05:30:19 INFO - "builduid": "ba4172364f6c4da2befe2605e4704566", 05:30:19 INFO - "slavebuilddir": "test" 05:30:19 INFO - } 05:30:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:30:19 INFO - Running post-action listener: _resource_record_post_action 05:30:19 INFO - ##### 05:30:19 INFO - ##### Running download-and-extract step. 05:30:19 INFO - ##### 05:30:19 INFO - Running pre-action listener: _resource_record_pre_action 05:30:19 INFO - Running main action method: download_and_extract 05:30:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:19 INFO - https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:30:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/test_packages.json 05:30:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/test_packages.json 05:30:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:30:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:30:20 INFO - Downloaded 1448 bytes. 05:30:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:30:20 INFO - Using the following test package requirements: 05:30:20 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:30:20 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:30:20 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:30:20 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:20 INFO - u'jsshell-linux-x86_64.zip'], 05:30:20 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:30:20 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:30:20 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:30:20 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:30:20 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:30:20 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:30:20 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:30:20 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:20 INFO - https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:30:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:30:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:30:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:30:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:30:22 INFO - Downloaded 22488900 bytes. 05:30:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:30:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:30:23 INFO - Return code: 0 05:30:23 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:23 INFO - https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:30:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:30:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:30:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:30:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:30:25 INFO - Downloaded 22488900 bytes. 05:30:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:30:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:30:26 INFO - Return code: 0 05:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:26 INFO - https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:30:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:30:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:30:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:30:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:30:27 INFO - Downloaded 10706572 bytes. 05:30:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:30:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:30:27 INFO - Return code: 0 05:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:27 INFO - https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:30:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:30:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:30:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:30:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:30:29 INFO - Downloaded 55971568 bytes. 05:30:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:30:29 INFO - mkdir: /builds/slave/test-pgo/properties 05:30:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:30:29 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:30:29 INFO - Contents: 05:30:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:30:29 INFO - Running post-action listener: _resource_record_post_action 05:30:29 INFO - Running post-action listener: set_extra_try_arguments 05:30:29 INFO - ##### 05:30:29 INFO - ##### Running populate-webroot step. 05:30:29 INFO - ##### 05:30:29 INFO - Running pre-action listener: _resource_record_pre_action 05:30:29 INFO - Running main action method: populate_webroot 05:30:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:30:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:30:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:30:29 INFO - '--tppagecycles', 05:30:29 INFO - '7'], 05:30:29 INFO - 'tests': ['tsvgm']}}, 05:30:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:30:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:30:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:30:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:30:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:30:29 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:30:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:29 INFO - 'talos_options': ['--e10s'], 05:30:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:29 INFO - 'tests': ['damp', 'tps']}, 05:30:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:29 INFO - 'talos_options': ['--e10s'], 05:30:29 INFO - 'tests': ['damp', 'tps']}, 05:30:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:30:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:30:29 INFO - 'other': {'tests': ['a11yr', 05:30:29 INFO - 'ts_paint', 05:30:29 INFO - 'tpaint', 05:30:29 INFO - 'sessionrestore', 05:30:29 INFO - 'sessionrestore_no_auto_restore']}, 05:30:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:30:29 INFO - 'tests': ['a11yr', 05:30:29 INFO - 'ts_paint', 05:30:29 INFO - 'tpaint', 05:30:29 INFO - 'sessionrestore', 05:30:29 INFO - 'sessionrestore_no_auto_restore']}, 05:30:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:30:29 INFO - 'tests': ['a11yr', 05:30:29 INFO - 'ts_paint', 05:30:29 INFO - 'tpaint', 05:30:29 INFO - 'sessionrestore', 05:30:29 INFO - 'sessionrestore_no_auto_restore']}, 05:30:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:30:29 INFO - 'tests': ['a11yr', 05:30:29 INFO - 'ts_paint', 05:30:29 INFO - 'tpaint', 05:30:29 INFO - 'sessionrestore', 05:30:29 INFO - 'sessionrestore_no_auto_restore']}, 05:30:29 INFO - 'other_l64': {'tests': ['a11yr', 05:30:29 INFO - 'ts_paint', 05:30:29 INFO - 'tpaint', 05:30:29 INFO - 'sessionrestore', 05:30:29 INFO - 'sessionrestore_no_auto_restore']}, 05:30:29 INFO - 'other_nol64': {'tests': ['a11yr', 05:30:29 INFO - 'ts_paint', 05:30:29 INFO - 'tpaint', 05:30:29 INFO - 'sessionrestore', 05:30:29 INFO - 'sessionrestore_no_auto_restore']}, 05:30:29 INFO - 'svgr': {'tests': ['tsvgx', 05:30:29 INFO - 'tsvgr_opacity', 05:30:29 INFO - 'tart', 05:30:29 INFO - 'tscrollx', 05:30:29 INFO - 'cart']}, 05:30:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:30:29 INFO - 'tests': ['tsvgx', 05:30:29 INFO - 'tsvgr_opacity', 05:30:29 INFO - 'tart', 05:30:29 INFO - 'tscrollx', 05:30:29 INFO - 'cart']}, 05:30:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:29 INFO - 'tests': ['tp5o']}, 05:30:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:29 INFO - 'talos_options': ['--e10s'], 05:30:29 INFO - 'tests': ['tp5o']}, 05:30:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:29 INFO - 'talos_options': ['--xperf_path', 05:30:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:29 INFO - 'tests': ['tp5n']}, 05:30:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:29 INFO - 'talos_options': ['--e10s', 05:30:29 INFO - '--xperf_path', 05:30:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:29 INFO - 'tests': ['tp5n']}}, 05:30:29 INFO - 'talos.zip': {'path': '', 05:30:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:30:29 INFO - Running post-action listener: _resource_record_post_action 05:30:29 INFO - ##### 05:30:29 INFO - ##### Running create-virtualenv step. 05:30:29 INFO - ##### 05:30:29 INFO - Running pre-action listener: _resource_record_pre_action 05:30:29 INFO - Running main action method: create_virtualenv 05:30:29 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:30:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:30:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:30:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:30:29 INFO - Using real prefix '/usr' 05:30:29 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:30:29 INFO - Installing distribute.............................................................................................................................................................................................done. 05:30:31 INFO - Installing pip.................done. 05:30:31 INFO - Return code: 0 05:30:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f546e936f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1982630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a13840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1980b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:30:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:30:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:30:31 INFO - Using env: {'DISPLAY': ':0', 05:30:31 INFO - 'HOME': '/home/cltbld', 05:30:31 INFO - 'LANG': 'en_US.UTF-8', 05:30:31 INFO - 'LANGUAGE': 'en_US:en', 05:30:31 INFO - 'LOGNAME': 'cltbld', 05:30:31 INFO - 'MAIL': '/var/mail/cltbld', 05:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:31 INFO - 'MOZ_NO_REMOTE': '1', 05:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:31 INFO - 'NO_EM_RESTART': '1', 05:30:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:31 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:31 INFO - 'SHELL': '/bin/bash', 05:30:31 INFO - 'SHLVL': '1', 05:30:31 INFO - 'TERM': 'linux', 05:30:31 INFO - 'TMOUT': '86400', 05:30:31 INFO - 'USER': 'cltbld', 05:30:31 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980', 05:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:31 INFO - '_': '/tools/buildbot/bin/python'} 05:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:30:31 INFO - Cleaning up... 05:30:31 INFO - Return code: 0 05:30:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f546e936f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1982630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a13840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1980b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:30:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:30:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:30:31 INFO - Using env: {'DISPLAY': ':0', 05:30:31 INFO - 'HOME': '/home/cltbld', 05:30:31 INFO - 'LANG': 'en_US.UTF-8', 05:30:31 INFO - 'LANGUAGE': 'en_US:en', 05:30:31 INFO - 'LOGNAME': 'cltbld', 05:30:31 INFO - 'MAIL': '/var/mail/cltbld', 05:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:31 INFO - 'MOZ_NO_REMOTE': '1', 05:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:31 INFO - 'NO_EM_RESTART': '1', 05:30:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:31 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:31 INFO - 'SHELL': '/bin/bash', 05:30:31 INFO - 'SHLVL': '1', 05:30:31 INFO - 'TERM': 'linux', 05:30:31 INFO - 'TMOUT': '86400', 05:30:31 INFO - 'USER': 'cltbld', 05:30:31 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980', 05:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:31 INFO - '_': '/tools/buildbot/bin/python'} 05:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:32 INFO - Downloading/unpacking psutil>=0.7.1 05:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:30:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:33 INFO - Installing collected packages: psutil 05:30:33 INFO - Running setup.py install for psutil 05:30:33 INFO - building 'psutil._psutil_linux' extension 05:30:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:30:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:30:34 INFO - building 'psutil._psutil_posix' extension 05:30:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:30:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:30:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:34 INFO - Successfully installed psutil 05:30:34 INFO - Cleaning up... 05:30:34 INFO - Return code: 0 05:30:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f546e936f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1982630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a13840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1980b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:30:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:30:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:30:34 INFO - Using env: {'DISPLAY': ':0', 05:30:34 INFO - 'HOME': '/home/cltbld', 05:30:34 INFO - 'LANG': 'en_US.UTF-8', 05:30:34 INFO - 'LANGUAGE': 'en_US:en', 05:30:34 INFO - 'LOGNAME': 'cltbld', 05:30:34 INFO - 'MAIL': '/var/mail/cltbld', 05:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:34 INFO - 'MOZ_NO_REMOTE': '1', 05:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:34 INFO - 'NO_EM_RESTART': '1', 05:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:34 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:34 INFO - 'SHELL': '/bin/bash', 05:30:34 INFO - 'SHLVL': '1', 05:30:34 INFO - 'TERM': 'linux', 05:30:34 INFO - 'TMOUT': '86400', 05:30:34 INFO - 'USER': 'cltbld', 05:30:34 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980', 05:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:34 INFO - '_': '/tools/buildbot/bin/python'} 05:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:30:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:30:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:30:36 INFO - Installing collected packages: mozsystemmonitor 05:30:36 INFO - Running setup.py install for mozsystemmonitor 05:30:36 INFO - Successfully installed mozsystemmonitor 05:30:36 INFO - Cleaning up... 05:30:36 INFO - Return code: 0 05:30:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f546e936f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1982630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a13840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1980b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:30:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:30:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:30:36 INFO - Using env: {'DISPLAY': ':0', 05:30:36 INFO - 'HOME': '/home/cltbld', 05:30:36 INFO - 'LANG': 'en_US.UTF-8', 05:30:36 INFO - 'LANGUAGE': 'en_US:en', 05:30:36 INFO - 'LOGNAME': 'cltbld', 05:30:36 INFO - 'MAIL': '/var/mail/cltbld', 05:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:36 INFO - 'MOZ_NO_REMOTE': '1', 05:30:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:36 INFO - 'NO_EM_RESTART': '1', 05:30:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:36 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:36 INFO - 'SHELL': '/bin/bash', 05:30:36 INFO - 'SHLVL': '1', 05:30:36 INFO - 'TERM': 'linux', 05:30:36 INFO - 'TMOUT': '86400', 05:30:36 INFO - 'USER': 'cltbld', 05:30:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980', 05:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:36 INFO - '_': '/tools/buildbot/bin/python'} 05:30:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:36 INFO - Downloading/unpacking blobuploader==1.2.4 05:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:38 INFO - Downloading blobuploader-1.2.4.tar.gz 05:30:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:30:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:30:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:39 INFO - Downloading docopt-0.6.1.tar.gz 05:30:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:30:39 INFO - Installing collected packages: blobuploader, requests, docopt 05:30:39 INFO - Running setup.py install for blobuploader 05:30:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:30:39 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:30:39 INFO - Running setup.py install for requests 05:30:39 INFO - Running setup.py install for docopt 05:30:39 INFO - Successfully installed blobuploader requests docopt 05:30:39 INFO - Cleaning up... 05:30:39 INFO - Return code: 0 05:30:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f546e936f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1982630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a13840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1980b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:30:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:30:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:30:39 INFO - Using env: {'DISPLAY': ':0', 05:30:39 INFO - 'HOME': '/home/cltbld', 05:30:39 INFO - 'LANG': 'en_US.UTF-8', 05:30:39 INFO - 'LANGUAGE': 'en_US:en', 05:30:39 INFO - 'LOGNAME': 'cltbld', 05:30:39 INFO - 'MAIL': '/var/mail/cltbld', 05:30:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:39 INFO - 'MOZ_NO_REMOTE': '1', 05:30:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:39 INFO - 'NO_EM_RESTART': '1', 05:30:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:39 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:39 INFO - 'SHELL': '/bin/bash', 05:30:39 INFO - 'SHLVL': '1', 05:30:39 INFO - 'TERM': 'linux', 05:30:39 INFO - 'TMOUT': '86400', 05:30:39 INFO - 'USER': 'cltbld', 05:30:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980', 05:30:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:39 INFO - '_': '/tools/buildbot/bin/python'} 05:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:30:40 INFO - Running setup.py (path:/tmp/pip-cajaC0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:30:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:30:40 INFO - Running setup.py (path:/tmp/pip-TU0Bkw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:30:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:30:40 INFO - Running setup.py (path:/tmp/pip-ZKxwAT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:30:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:30:40 INFO - Running setup.py (path:/tmp/pip-Sk5Tw_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:30:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:30:40 INFO - Running setup.py (path:/tmp/pip-pZzVYy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:30:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:30:40 INFO - Running setup.py (path:/tmp/pip-H7mg8l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:30:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:30:40 INFO - Running setup.py (path:/tmp/pip-_kQtAw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:30:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:30:40 INFO - Running setup.py (path:/tmp/pip-lV5epS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:30:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:30:40 INFO - Running setup.py (path:/tmp/pip-SaTiYZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:30:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:30:40 INFO - Running setup.py (path:/tmp/pip-Tm0RIo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:30:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:30:40 INFO - Running setup.py (path:/tmp/pip-JFvIj6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:30:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:30:40 INFO - Running setup.py (path:/tmp/pip-y_87_P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:30:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:30:40 INFO - Running setup.py (path:/tmp/pip-eVf7rU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:30:41 INFO - Running setup.py (path:/tmp/pip-eBzSvz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:30:41 INFO - Running setup.py (path:/tmp/pip-AIwVx3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:30:41 INFO - Running setup.py (path:/tmp/pip-oXD7SH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:30:41 INFO - Running setup.py (path:/tmp/pip-rdPJUC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:30:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:30:41 INFO - Running setup.py install for manifestparser 05:30:41 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:30:41 INFO - Running setup.py install for mozcrash 05:30:41 INFO - Running setup.py install for mozdebug 05:30:41 INFO - Running setup.py install for mozdevice 05:30:41 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:30:41 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:30:41 INFO - Running setup.py install for mozfile 05:30:41 INFO - Running setup.py install for mozhttpd 05:30:41 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:30:41 INFO - Running setup.py install for mozinfo 05:30:42 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:30:42 INFO - Running setup.py install for mozInstall 05:30:42 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:30:42 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:30:42 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:30:42 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:30:42 INFO - Running setup.py install for mozleak 05:30:42 INFO - Running setup.py install for mozlog 05:30:42 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:30:42 INFO - Running setup.py install for moznetwork 05:30:42 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:30:42 INFO - Running setup.py install for mozprocess 05:30:42 INFO - Running setup.py install for mozprofile 05:30:42 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:30:42 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:30:42 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:30:42 INFO - Running setup.py install for mozrunner 05:30:42 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:30:42 INFO - Running setup.py install for mozscreenshot 05:30:42 INFO - Running setup.py install for moztest 05:30:42 INFO - Running setup.py install for mozversion 05:30:43 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:30:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:30:43 INFO - Cleaning up... 05:30:43 INFO - Return code: 0 05:30:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f546e936f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1982630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a13840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1980b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:30:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:30:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:30:43 INFO - Using env: {'DISPLAY': ':0', 05:30:43 INFO - 'HOME': '/home/cltbld', 05:30:43 INFO - 'LANG': 'en_US.UTF-8', 05:30:43 INFO - 'LANGUAGE': 'en_US:en', 05:30:43 INFO - 'LOGNAME': 'cltbld', 05:30:43 INFO - 'MAIL': '/var/mail/cltbld', 05:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:43 INFO - 'MOZ_NO_REMOTE': '1', 05:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:43 INFO - 'NO_EM_RESTART': '1', 05:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:43 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:43 INFO - 'SHELL': '/bin/bash', 05:30:43 INFO - 'SHLVL': '1', 05:30:43 INFO - 'TERM': 'linux', 05:30:43 INFO - 'TMOUT': '86400', 05:30:43 INFO - 'USER': 'cltbld', 05:30:43 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980', 05:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:43 INFO - '_': '/tools/buildbot/bin/python'} 05:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:30:43 INFO - Running setup.py (path:/tmp/pip-iRtjlQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:30:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:30:43 INFO - Running setup.py (path:/tmp/pip-dOVCfG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:30:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:30:43 INFO - Running setup.py (path:/tmp/pip-ITe5gC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:30:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:30:43 INFO - Running setup.py (path:/tmp/pip-84vuv7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:30:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:30:43 INFO - Running setup.py (path:/tmp/pip-0iuFh7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:30:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:30:43 INFO - Running setup.py (path:/tmp/pip-H3h_uu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:30:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:30:43 INFO - Running setup.py (path:/tmp/pip-BELDMU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:30:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:30:43 INFO - Running setup.py (path:/tmp/pip-0ph_zw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:30:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:30:43 INFO - Running setup.py (path:/tmp/pip-p8fhI3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:30:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:30:43 INFO - Running setup.py (path:/tmp/pip-3srtkG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:30:44 INFO - Running setup.py (path:/tmp/pip-43Qg72-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:30:44 INFO - Running setup.py (path:/tmp/pip-qIe7m2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:30:44 INFO - Running setup.py (path:/tmp/pip-3vYVaK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:30:44 INFO - Running setup.py (path:/tmp/pip-Z6lxIn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:30:44 INFO - Running setup.py (path:/tmp/pip-vIPWPI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:30:44 INFO - Running setup.py (path:/tmp/pip-cjNeJU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:30:44 INFO - Running setup.py (path:/tmp/pip-Eof1e_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:30:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:46 INFO - Downloading blessings-1.6.tar.gz 05:30:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:30:46 INFO - Installing collected packages: blessings 05:30:46 INFO - Running setup.py install for blessings 05:30:46 INFO - Successfully installed blessings 05:30:46 INFO - Cleaning up... 05:30:46 INFO - Return code: 0 05:30:46 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:30:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:30:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:30:46 INFO - Reading from file tmpfile_stdout 05:30:46 INFO - Current package versions: 05:30:46 INFO - argparse == 1.2.1 05:30:46 INFO - blessings == 1.6 05:30:46 INFO - blobuploader == 1.2.4 05:30:46 INFO - docopt == 0.6.1 05:30:46 INFO - manifestparser == 1.1 05:30:46 INFO - mozInstall == 1.12 05:30:46 INFO - mozcrash == 0.16 05:30:46 INFO - mozdebug == 0.1 05:30:46 INFO - mozdevice == 0.48 05:30:46 INFO - mozfile == 1.2 05:30:46 INFO - mozhttpd == 0.7 05:30:46 INFO - mozinfo == 0.9 05:30:46 INFO - mozleak == 0.1 05:30:46 INFO - mozlog == 3.1 05:30:46 INFO - moznetwork == 0.27 05:30:46 INFO - mozprocess == 0.22 05:30:46 INFO - mozprofile == 0.28 05:30:46 INFO - mozrunner == 6.11 05:30:46 INFO - mozscreenshot == 0.1 05:30:46 INFO - mozsystemmonitor == 0.0 05:30:46 INFO - moztest == 0.7 05:30:46 INFO - mozversion == 1.4 05:30:46 INFO - psutil == 3.1.1 05:30:46 INFO - requests == 1.2.3 05:30:46 INFO - wsgiref == 0.1.2 05:30:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f546e936f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1982630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a13840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1980b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:30:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:30:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:30:46 INFO - Using env: {'DISPLAY': ':0', 05:30:46 INFO - 'HOME': '/home/cltbld', 05:30:46 INFO - 'LANG': 'en_US.UTF-8', 05:30:46 INFO - 'LANGUAGE': 'en_US:en', 05:30:46 INFO - 'LOGNAME': 'cltbld', 05:30:46 INFO - 'MAIL': '/var/mail/cltbld', 05:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:46 INFO - 'MOZ_NO_REMOTE': '1', 05:30:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:46 INFO - 'NO_EM_RESTART': '1', 05:30:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:46 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:46 INFO - 'SHELL': '/bin/bash', 05:30:46 INFO - 'SHLVL': '1', 05:30:46 INFO - 'TERM': 'linux', 05:30:46 INFO - 'TMOUT': '86400', 05:30:46 INFO - 'USER': 'cltbld', 05:30:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980', 05:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:46 INFO - '_': '/tools/buildbot/bin/python'} 05:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:30:46 INFO - Cleaning up... 05:30:46 INFO - Return code: 0 05:30:46 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f546e936f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1982630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a13840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1980b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:30:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:30:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:30:46 INFO - Using env: {'DISPLAY': ':0', 05:30:46 INFO - 'HOME': '/home/cltbld', 05:30:46 INFO - 'LANG': 'en_US.UTF-8', 05:30:46 INFO - 'LANGUAGE': 'en_US:en', 05:30:46 INFO - 'LOGNAME': 'cltbld', 05:30:46 INFO - 'MAIL': '/var/mail/cltbld', 05:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:46 INFO - 'MOZ_NO_REMOTE': '1', 05:30:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:46 INFO - 'NO_EM_RESTART': '1', 05:30:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:46 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:46 INFO - 'SHELL': '/bin/bash', 05:30:46 INFO - 'SHLVL': '1', 05:30:46 INFO - 'TERM': 'linux', 05:30:46 INFO - 'TMOUT': '86400', 05:30:46 INFO - 'USER': 'cltbld', 05:30:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980', 05:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:46 INFO - '_': '/tools/buildbot/bin/python'} 05:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:47 INFO - Downloading/unpacking jsonschema 05:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:30:48 INFO - Downloading/unpacking functools32 (from jsonschema) 05:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:49 INFO - Downloading functools32-3.2.3-2.tar.gz 05:30:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:30:49 INFO - warning: no files found matching '*.txt' 05:30:49 INFO - no previously-included directories found matching 'build' 05:30:49 INFO - no previously-included directories found matching 'dist' 05:30:49 INFO - no previously-included directories found matching '.git*' 05:30:49 INFO - Installing collected packages: jsonschema, functools32 05:30:49 INFO - Running setup.py install for functools32 05:30:49 INFO - warning: no files found matching '*.txt' 05:30:49 INFO - no previously-included directories found matching 'build' 05:30:49 INFO - no previously-included directories found matching 'dist' 05:30:49 INFO - no previously-included directories found matching '.git*' 05:30:49 INFO - Successfully installed jsonschema functools32 05:30:49 INFO - Cleaning up... 05:30:49 INFO - Return code: 0 05:30:49 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f546e936f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1982630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a13840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1980b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:30:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:30:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:30:49 INFO - Using env: {'DISPLAY': ':0', 05:30:49 INFO - 'HOME': '/home/cltbld', 05:30:49 INFO - 'LANG': 'en_US.UTF-8', 05:30:49 INFO - 'LANGUAGE': 'en_US:en', 05:30:49 INFO - 'LOGNAME': 'cltbld', 05:30:49 INFO - 'MAIL': '/var/mail/cltbld', 05:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:49 INFO - 'MOZ_NO_REMOTE': '1', 05:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:49 INFO - 'NO_EM_RESTART': '1', 05:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:49 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:49 INFO - 'SHELL': '/bin/bash', 05:30:49 INFO - 'SHLVL': '1', 05:30:49 INFO - 'TERM': 'linux', 05:30:49 INFO - 'TMOUT': '86400', 05:30:49 INFO - 'USER': 'cltbld', 05:30:49 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980', 05:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:49 INFO - '_': '/tools/buildbot/bin/python'} 05:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:49 INFO - Downloading/unpacking flake8 05:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:30:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:30:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:30:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:30:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:30:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:30:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:30:52 INFO - no previously-included directories found matching 'docs/_build' 05:30:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:30:52 INFO - Running setup.py install for pep8 05:30:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:30:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:30:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:30:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:30:52 INFO - no previously-included directories found matching 'docs/_build' 05:30:52 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:30:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:30:52 INFO - Cleaning up... 05:30:52 INFO - Return code: 0 05:30:52 INFO - Running post-action listener: _resource_record_post_action 05:30:52 INFO - Running post-action listener: _start_resource_monitoring 05:30:52 INFO - Starting resource monitoring. 05:30:52 INFO - ##### 05:30:52 INFO - ##### Running install step. 05:30:52 INFO - ##### 05:30:52 INFO - Running pre-action listener: _resource_record_pre_action 05:30:52 INFO - Running main action method: install 05:30:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:30:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:30:52 INFO - Reading from file tmpfile_stdout 05:30:52 INFO - Detecting whether we're running mozinstall >=1.0... 05:30:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:30:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:30:52 INFO - Reading from file tmpfile_stdout 05:30:52 INFO - Output received: 05:30:52 INFO - Usage: mozinstall [options] installer 05:30:52 INFO - Options: 05:30:52 INFO - -h, --help show this help message and exit 05:30:52 INFO - -d DEST, --destination=DEST 05:30:52 INFO - Directory to install application into. [default: 05:30:52 INFO - "/builds/slave/test-pgo"] 05:30:52 INFO - --app=APP Application being installed. [default: firefox] 05:30:52 INFO - mkdir: /builds/slave/test-pgo/build/application 05:30:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:30:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:31:08 INFO - Reading from file tmpfile_stdout 05:31:08 INFO - Output received: 05:31:08 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:31:08 INFO - Running post-action listener: _resource_record_post_action 05:31:08 INFO - ##### 05:31:08 INFO - ##### Running run-tests step. 05:31:08 INFO - ##### 05:31:08 INFO - Running pre-action listener: _resource_record_pre_action 05:31:08 INFO - Running main action method: run_tests 05:31:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:31:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:31:08 INFO - Python 2.7.3 05:31:08 INFO - Return code: 0 05:31:08 INFO - grabbing minidump binary from tooltool 05:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:08 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a13840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1980b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:31:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:31:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:31:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:31:08 INFO - Return code: 0 05:31:08 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:31:08 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:31:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:31:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:31:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:31:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:31:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:31:09 INFO - Return code: 0 05:31:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:31:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:31:09 INFO - Using env: {'DISPLAY': ':0', 05:31:09 INFO - 'HOME': '/home/cltbld', 05:31:09 INFO - 'LANG': 'en_US.UTF-8', 05:31:09 INFO - 'LANGUAGE': 'en_US:en', 05:31:09 INFO - 'LOGNAME': 'cltbld', 05:31:09 INFO - 'MAIL': '/var/mail/cltbld', 05:31:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:31:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:09 INFO - 'MOZ_NO_REMOTE': '1', 05:31:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:31:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:09 INFO - 'NO_EM_RESTART': '1', 05:31:09 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:09 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:09 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:31:09 INFO - 'SHELL': '/bin/bash', 05:31:09 INFO - 'SHLVL': '1', 05:31:09 INFO - 'TERM': 'linux', 05:31:09 INFO - 'TMOUT': '86400', 05:31:09 INFO - 'USER': 'cltbld', 05:31:09 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980', 05:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:09 INFO - '_': '/tools/buildbot/bin/python'} 05:31:09 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:31:10 INFO - mozversion application_buildid: 20160123030348 05:31:10 INFO - mozversion application_changeset: 5f7c184ccd800b2ed512c23fb609007efd198eaf 05:31:10 INFO - mozversion application_display_name: Nightly 05:31:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:31:10 INFO - mozversion application_name: Firefox 05:31:10 INFO - mozversion application_remotingname: firefox 05:31:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:31:10 INFO - mozversion application_vendor: Mozilla 05:31:10 INFO - mozversion application_version: 46.0a1 05:31:10 INFO - mozversion platform_buildid: 20160123030348 05:31:10 INFO - mozversion platform_changeset: 5f7c184ccd800b2ed512c23fb609007efd198eaf 05:31:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:31:10 INFO - mozversion platform_version: 46.0a1 05:31:10 INFO - using testdate: 1453555870 05:31:10 INFO - actual date: 1453555870 05:31:10 INFO - starting webserver on 'localhost:55441' 05:31:10 INFO - SUITE-START | Running 3 tests 05:31:10 INFO - TEST-START | dromaeo_css 05:31:10 INFO - operating with platform_type : linux_ 05:31:10 INFO - Initialising browser for dromaeo_css test... 05:31:10 INFO - TEST-INFO | started process 16469 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqZfIiK/profile http://localhost:55441/getInfo.html) 05:31:14 INFO - PROCESS | 16469 | 05:31:14 INFO - PROCESS | 16469 | (process:16551): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:31:15 INFO - PROCESS | 16469 | __metrics Screen width/height:1600/1200 05:31:15 INFO - PROCESS | 16469 | colorDepth:24 05:31:15 INFO - PROCESS | 16469 | Browser inner width/height: 1024/697 05:31:15 INFO - PROCESS | 16469 | __metrics 05:31:15 INFO - PROCESS | 16469 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:31:16 INFO - TEST-INFO | 16469: exit 0 05:31:16 INFO - Browser initialized. 05:31:16 INFO - Running cycle 1/1 for dromaeo_css test... 05:31:16 INFO - TEST-INFO | started process 16600 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqZfIiK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:17 INFO - PROCESS | 16600 | 05:31:17 INFO - PROCESS | 16600 | (process:16657): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:31:28 INFO - PROCESS | 16600 | RSS: Main: 151838720 05:31:28 INFO - PROCESS | 16600 | 05:32:17 INFO - PROCESS | 16600 | 1453555937726 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:34:25 INFO - PROCESS | 16600 | Cycle 1(1): loaded http://localhost:55441/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55441/tests/dromaeo/cssquery-ext.html) 05:34:26 INFO - PROCESS | 16600 | RSS: Main: 158138368 05:34:26 INFO - PROCESS | 16600 | 05:37:28 INFO - PROCESS | 16600 | Cycle 1(1): loaded http://localhost:55441/tests/dromaeo/cssquery-ext.html (next: http://localhost:55441/tests/dromaeo/cssquery-jquery.html) 05:37:29 INFO - PROCESS | 16600 | RSS: Main: 155283456 05:37:29 INFO - PROCESS | 16600 | 05:40:30 INFO - PROCESS | 16600 | Cycle 1(1): loaded http://localhost:55441/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55441/tests/dromaeo/cssquery-mootools.html) 05:40:31 INFO - PROCESS | 16600 | RSS: Main: 156614656 05:40:31 INFO - PROCESS | 16600 | 05:43:33 INFO - PROCESS | 16600 | Cycle 1(1): loaded http://localhost:55441/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55441/tests/dromaeo/cssquery-prototype.html) 05:43:33 INFO - PROCESS | 16600 | RSS: Main: 154271744 05:43:33 INFO - PROCESS | 16600 | 05:46:36 INFO - PROCESS | 16600 | Cycle 1(1): loaded http://localhost:55441/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55441/tests/dromaeo/cssquery-yui.html) 05:46:36 INFO - PROCESS | 16600 | RSS: Main: 156147712 05:46:36 INFO - PROCESS | 16600 | 05:49:39 INFO - PROCESS | 16600 | Cycle 1(1): loaded http://localhost:55441/tests/dromaeo/cssquery-yui.html (next: http://localhost:55441/tests/dromaeo/cssquery-dojo.html) 05:49:39 INFO - PROCESS | 16600 | RSS: Main: 158412800 05:49:39 INFO - PROCESS | 16600 | 05:49:39 INFO - PROCESS | 16600 | __start_tp_report 05:49:39 INFO - PROCESS | 16600 | _x_x_mozilla_page_load 05:49:39 INFO - PROCESS | 16600 | _x_x_mozilla_page_load_details 05:49:39 INFO - PROCESS | 16600 | |i|pagename|runs| 05:49:39 INFO - PROCESS | 16600 | |0;dojo.html;3194.2972546039864;3209.5988001499813;3231.224506118532;3245;3245.172481017341;5250;5290.8412747617585;5304.65519741217;5308.575313974888;5312.123499622568;5240.502152295536;5254.238135470355;5273.657212281209;5359.651622644526;5484.588655850807;4864.975675121628;4910.1898186799135;4974.577160941324;4991.700497970115;4997.150484417658;107.04989728021096;4892.192788189945;4954.355933728628;4984.875378115558;4991.625628077891;4904.239842824368;4908.092002979461;4915.967646794177;4943.233798761198;4950.356453661019;4881.8779530511665;4890.437599676047;4917.926231106536;4936.33359496467;4961;4737.455192652855;4810.759462026885;4969.527894849984;4991.126552853272;5037;5204.271402003723;5241.68549887008;5277.234800953878;5282.947170528284;5323.148296272578;5697.572682048863;5701.543876489871;5710.828675139711;5718.513926316268;5719.799807006776;5582.106862901916;5672.461116193955;5685.516731077863;5761.53907687384;5830.183774271605;5324.840254792362;5405.648632838853;5451.618386712932;5452.318460192436;5505.889882202374;5844.824655260349;5845.09401042839;5852.297724273115;5855.970720146372;5856.0630299151935;5586.1062230043;5593.664380137124;5597.244372009726;5667.659940403589;5684.63049901755;5725.885482290414;5809.128630705428;5811.476967072984;5815.9709201453725;5867.559933005042;5652.85867853307;5667.688277144714;5684.516816070598;5684.602077854511;5707.71461426927;5592.245046918614;5664.745086471119;5681.403452637496;5685.1756495307945;5709.029464990961;4403.603675669206;4406.735595864258;4413.801378937956;4420.248557745191;4463.866084017484;3934.7639141651593;3973.364261718169;3990.06233535119;3995.780232087263;4018.1160144768687;5250;5288.603354748409;5327.387350454747;5339.199120131933;5366.195070739343;5679.545636349165;5701.116326969326;5707.400722924116;5717.771289148387;5727.971360143172;5241.213817927265;5292.894142117136;5302.946970530245;5304.761285742151;5350.411454739976;4798.3042458843975;4845;4855.975720121377;4879.804807807648;4901.5588597026435;5894.970525147347;5915.112733090071;5929.644221346733;5939.792107276225;5963.224780778558;5601.131824567198;5713.400092990342;5743.368229494836;5751.1085781703905;5755.453231943043;5842.824715258549;5849.795257165979;5863.413658634103;5895.528357731457;5956.940430595639;5584.078627026658;5624.212610234488;5644.2380278663495;5671.602987790815;5683.60214784961;5725.770969161187;5727.39862314451;5729.398413166724;5738.713064346849;5747.19539264495;5457.317835270591;5500.119980803052;5555.916661250165;5570.498655120897;5710.771569137188;5608.971955140199;5612.382637909908;5619.8595035124445;5621.10062390032;5631.099024156116;5513.889722205453;5525.309336332958;5528.281323428089;5534.972325138348;5536.031194540858;5525.198846167364;5559.360673522435;5614.466625670555;5748.9425105748405;5775.1914731938405;5471.5896307777875;5478.726063696719;5510.724463776875;5515.531179849758;5521.585881059017 05:49:39 INFO - PROCESS | 16600 | |1;ext.html;510.49971028392173;516.4757770862575;535.5956253028962;559.8264537993219;571.1062187676287;34603.826980865095;35128;35244.118897027554;35385.64614353856;35397;38262.234755304875;38647;38659.42010869839;38751;39000.21999560007;8260.132686067967;8408.24325810677;8444.408891377576;8450.239478446938;8472.322214222848;8251.711190108348;8286.378521610874;8329.292010179142;8360.707375241867;8388.454750441202;8430;8551.444156129863;8553.230209281164;8564.186402291773;8576.356773242002;8416.915830841674;8518.531480768586;8525.872111918326;8544.359173061983;8558.957205213934;8451.83096338076;8553.914460855374;8556.101609330994;8580.656773729042;8589.484630922165;37990.251218597674;38360.42459363112;38385.61614383848;38599.42100868489;38723.22553548913;3055.882250772918;3083.1058992892035;3097.860596273151;3138.5135304027913;3176.5870436843293;28330.716692833015;28414.28964275889;28526.572101418496;28901.12142710717;29051.854740726372;3776.2258736958856;3799.4300854871713;3799.449079883429;3878.650921417058;3882.8835134946;265305;265665;266431;267328;267629;50306.49693503091;51368.48631513712;53643;53976.730116349165;54297.45702542924;62730.372696272454;64071.359286406536;64080;64483;64547.35452645413;13858.653533661538;13963.650908727363;14033.71932561343;14056;14077.366518506487;11160.497777600027;11302.434878256054;11317.83023254652;11356.48895799691;11363.431828408711;19737.309194178135;20280.59438811245;20378.796212037985;20388.592228155652;20425.591488170154;7317.231690672403;7542.849143017219;7623.542587444771;7730.188330225358;7771.6891324347525;865.0959747064333;895.3285036222833;952.0859974424629;1025.4257615735212;1108.362691452402;27846.5823012655;28370.43259134847;30349.544756828665;30561;30998.380032399677;982.6462473509531;983.7048885334372;1004.9949750251202;1016.1667432705111;1086.750047489082;14746.557603271918;15773.763393549107;15908.602284942968;15986.440474583334;16208.189590520427;314642;319498;320040;320353;320909;50756.23865642018;50824;51041;51159;51213.48786512162;1346.3672074125145;1351.2568087551808;1359.2931675528669;1368.0560413314781;1488.8660020598197;26382.73617263803;27634.309142271602;27721.861390692917;28196.154115376572;28415.147545573665;44908;45153.54846451493;45542.544574555155;45545.54454455546;45554;288344;289163;290302;290672;290750;30889.536656949713;31217.843910780302;31883.68116318807;31904.202394940312;31983.200419988756;35943.82028089843;36112.8194359037;36693.63306367009;36960.815195923846;37214;31253;31518.36963260768;31912.840435797672;32070.35859282848;32080.839595802805;32960.505592415655;34316.82841585776;34947.30105397929;35052.29895402129;35250.647493525765;33096;33894.491582625786;34078.82960585181;34182.65817341795;34208;30882.38235235238;31931.201719957186;32407.83796081099;32709.34581308408;32793.83603081969;24046.27861164168;24260.63609045901;24277.514449710554;24493.265202043967;24709.629355559322 05:49:39 INFO - PROCESS | 16600 | |2;jquery.html;367.5203858964052;370.6201143827577;370.62381682592155;373.07105307783627;373.76452834714144;15462.381504739811;16308.429204977829;17172.570685732848;17604.911975440136;18372.17325220365;11037.3377597344;12280.201786883847;16569;16605.41881034161;16612.086335251555;4560.179167749804;4752.881177970544;4759.071980963713;4760.4525479569775;4798.904021919559;4762.809487620491;4815.422149342066;5124.461931497195;5325.281087053257;5335.599830012745;3740.214554943465;3826.923461530768;5293.655912365684;5333.866653333678;5579.525740312079;5376.811811586615;5545.057340252167;5588.189712491686;5589.077802162638;5590.217369568264;5288.9735551322;5310.893782124374;5319.946800531984;5346.251524786533;5365.141577347645;18174.091295435177;18591.721124183146;18868.43394698161;18893.622127557508;18894.433167005012;1770.1857145712859;1988.6420444320017;2006.047127614386;2014.0936578539715;2064.989675051615;9161.633534658606;9235.215006724437;9514.429134251966;9878.654247101316;9895.505224738807;1680.8319168083217;1734.4623166818326;1748.8775785695007;1766.7703198584102;1801.3875282403915;54225.1866222003;57450.71274643642;58431.70784146094;59178.70410647962;59979.400205997816;9821.901780982242;9864.210863130933;9893.25800564946;10308.278420510642;14569.125852448888;13297.667558310926;13341.132826366254;13350.866491335157;13423.865761342262;13447;6866.725330986805;6871.14110736158;6949.235584085746;7225.241349658315;7394.5932973685885;6738.460923126138;6930.792076237721;6975.372216500539;6993.685284162225;7112.182099058571;4430.756308403069;4446.399736035659;4460.330950357472;4474.865754027384;4503.909921801611;1843.658923099204;1856.5822689894665;1880.1633273193572;1892.139076720089;1903.8572107092023;416.0846138495322;849.9405041647026;870.8127752533236;918.7519369770125;941.3880977364631;10196.745081373025;10408.739781505372;10633;10701.522005348294;10819.809820919692;849.515776007682;878.4553576782436;933.6125507914276;933.8785957825439;993.1657407777501;6394.71223794921;9028;9034.457932523937;9174.403663761834;9433.71698849022;480809;481693;494801;501796;504623.76881155797;69235.65382173056;71187.64406178039;71225.28774712187;72398.63800680963;73814;1092.3282181458346;1111.2610114273916;1119.7424592343807;1158.4129742252999;1174.9412529373496;14012.089214201043;14134.646633834236;14369.353379097756;14405.78391324152;14687.706245875237;31740.682593174697;31779.682203177672;32400.837995810813;32596.83701581477;33173.66826331706;41437.58562414337;43090.78454607707;43165.56834431741;45797.31304030509;48525.27212091892;7254.202037775946;7345.5959922202655;7382.852342953003;7387.113546374255;7405.370543503863;3602.963970360263;3892.7080468965505;8417.242448179693;11159.442027898735;11511.19421640477;7164.570125792469;8363.749087527383;9194.816103678022;9703.5148242589;9708.417494950043;9309.627614895327;9403.153716165578;9591.280653950842;10077.453570305017;10172.79654406893;8908.198262156437;9823.36148150368;9919.752006199902;9978.800423991624;10117.392956422344;7386.815329616803;7508.474406791473;7548.094228692373;7585.355244804254;7667.194944530967;9495.810083798424;10185.898141018495;10309.175265978854;10316.535755891153;10454.059134677611 05:49:39 INFO - PROCESS | 16600 | |3;mootools.html;1437.5184313255058;1463.52435458476;1614.5640677017207;1762.947111586653;1776.0586888948862;7408.259174082589;7431.62841857907;7570.167281599033;7607.961960190199;7622.65698043588;7420.888686669704;7424.257574242573;7450.217727138654;7458.88811667824;7462.514936529122;2302.4128847143998;2322.326525307659;2323.384303159664;2326.2439707095177;2329.860208387494;2283.4405570635136;2307.469282065126;2346.800521955627;2359.716833979925;2360.7285162206394;1922.807719228073;1941.5825597496535;2232.352617740861;2271.114265436481;2272.0457407888644;2304.1704986204954;2304.4238940264936;2309.1686992682703;2310.5378924215056;2313.375388645073;2213.7896899794496;2276.988615056914;2280.954380912389;2283.703118594589;2288.302067869299;7378.335949764493;7469.253074692541;7481.738139165158;7497.4376921730545;7497.700091996368;4680.4383473983;4798.1843086675;4808.495108013678;4817.590504807095;4855.053264613402;3083.6607973122937;3120.7971481853833;3154.9842250788597;3177.952330715041;3178.1895616617844;1065.5045403887152;1069.5294070608907;1085.3921803789904;1123.7303047268679;1128.8081026225561;9793.510324483746;9853.211743060538;9878.407295562289;9908.058734420218;9918.504074796232;4092.202020606013;4125.443065186221;4188.434561334242;4193.18232944579;4197.769122698281;8111.067227268822;8155.918440815516;8163.79590510242;8167.673293068211;8170.673173073129;4654.069186162713;4669.556392142741;4681.274402467623;4718.528147185322;4721.5986641135205;4251.4685664291965;4330.783460826946;4332.960089578479;4342.413774140514;4355.107203023373;3440.0539851541025;3473.878414255489;3506.403911335028;3521.5774107107313;3549.680528752373;1082.112667612566;1101.581399068349;1107.3023994883172;1129.0403157316216;1140.6292954789726;822.5558198572704;825.9752207433787;832.8792325112825;924.912133347331;949.1362859797551;6943.270956549591;6960;6982.546134501343;7017.649117544204;7018.157821061505;1108.5288752280248;1112.732944093428;1114.8461342510464;1122.7698321844002;1144.6852115668091;5384.596155288291;5435.103207970719;5499.50504454601;5500.614956953055;5512.972435137799;8667.739967800977;8680.565971701515;8802.779930501789;8841.69054083104;8888.955555222183;8680.392372533863;8732;8744.431611945203;8746.300295976307;8798.47209167452;6986.196587392414;7045.7181712731945;7142.4286057115305;7164.9641751790905;7230.927690723131;6652.268250492539;6674.065630811788;6697.2633010367845;6700.396964273239;6708.42978346846;7813.218678132142;8020.598970051591;8032.236937490929;8062.072861620754;8171.591420429074;7950.24472675095;8150.062742784656;8225.465344752572;8293.792655183668;8313.293370063613;6093.390660933871;6165.84585385369;6468.741250349934;6566.606003639797;6573.80278591643;7023.859522809617;7108;7119.074520312326;7119.2168861426235;7130.180029296697;6716.966415167893;6740.528163028737;6778.796636100925;6842.965785171043;6847.075644788089;6328.240611126695;6529.216494020558;6568.9014664781025;6684.131062961784;6795.660216989229;6600.2409722882485;6627.9337206627315;6633.6019838809825;6639.6680165992475;6675.566088204251;6135.07973803933;6192.845178870384;6194.0708893664505;6199.876002479835;6200.844978875564;6155.84610384744;6186.1648677427975;6187.195664563578;6220.813375598739;6294.055891616111 05:49:39 INFO - PROCESS | 16600 | |4;prototype.html;338.47874273618623;343.61171875780366;346.1312106612405;348.1765624298534;349.69576468472417;6142.232220972379;6216.445888527868;6278.68606569672;6334.556581039329;6379.17070780799;6070.150178974936;6168.043953187252;6203.782867599635;6221.346758590351;6237.719302631381;4800.519948005198;4817.421909370881;4831.613470922318;4840;4851.27230915362;4844.20070688336;4846.927296090544;4853.223484242522;4855.053264613402;4862.197737373329;4717.740524271164;4783.736894470802;4789.640776941726;4804.351412559312;4814.061258054663;4761.119192949315;4763.904721905577;4775.331453596499;4777.450593181794;4785.68893021956;4011.4183443400543;4114.670826333886;4187.267228235077;4188.518320393163;4195.244855925932;5918.733656985403;5932.822015339503;5954.642721436728;5957.344692083867;6022;5485.890282194334;5504.366997795265;5506.476884695948;5523.751431185607;5567.081431563787;6513.544051916368;6570.408663220333;6580.078788969548;6582.637954912478;6631.1379520662;4542.636589072867;4560.726356418625;4561.817527298904;4565.794539245742;4582.725036497821;6917.100776899021;6931.480138989596;6971.930280697229;6977.93022069783;6983.89524157138;4616.307553866947;4652.511486293958;4658.417697787777;4662.906741865211;4681.110588988149;4569.543045695404;4671.556202160789;4671.906561868812;4727.2909063640045;4774.188387974053;5518.33779946409;5523.309586301712;5526.447355264441;5535.25274087993;5548.278723765965;6678.96660516704;6686;6701.463882889358;6708.731650734014;6724.831879203059;1665.6751933372875;1674.1880188109;1676.1954261954331;1678.9748153777703;1681.9495415137565;1085.473545330514;1094.0481780850712;1108.1578000719512;1123.0959077942334;1129.6441620889393;6289.811305660837;6290.528210384239;6298.685065746786;6305.887527678279;6315.273743519462;6817.181938167451;6864.622445765531;6873;6902.033715279765;6912.585244885323;6105.633661980295;6242.968785156136;6263.248410190715;6270.811875643738;6283.748650053946;3682.3739964206147;3727.8322475488667;3738.971782759763;3745.4943582615997;3751;7010.123734533184;7184.9640751795905;7222.422206223489;7230.530015549078;7242;7051.753188638476;7057.400120989773;7058;7080.548487560038;7115.53749006313;7086.610236436943;7167.068281123525;7171.92828071723;7194.280571942764;7260.4554658399775;6893.379595836399;6935.3411425914455;6941.514094013371;6941.618210998242;6944.166699996033;6841.657917104026;6882.931170688229;6888.690008949509;6890.827729306808;6898.172219333712;7090.6100164491445;7232.602206878672;7239.986401903632;7240.601766902871;7256.346928776436;4591.311303304531;4597.149527337453;4602.585767280961;4609.331646911112;4611.538846115362;6924.896126558207;6942.791716248521;6960.338767817049;6963.303669632996;6991.440684745106;6629.5359324846795;6777.864442711217;6779.694913728993;6790.898136528055;6791.185057793096;6757.222919364336;6762.188537375349;6766.323367663194;6768.492363072691;6780.288069752605;6591.406773390418;6628.204615446178;6639.502037347122;6650.534462587766;6670.966645166744;6647.069410282467;6772.153480814898;6801.761938332134;6816.284290149463;6819.4544436443975;6620.602763833993;6647.434968027772;6649.567778094602;6649.667516624246;6659.866802663822 05:49:39 INFO - PROCESS | 16600 | |5;yui.html;750.4146765522893;782.2842099478976;800.8518424091543;843.350620022583;852.7356519478966;13099.54151604694;13191.868081319184;13230.735385292312;13256.469741210352;13267.071305008642;12480.313582752944;12536.247825130498;12609.30648814315;12637.55768548101;12637.747245055094;781.6990458673409;799.7081065411141;800.7517669522438;801.8316153607749;804.0672819529348;795.5902710104301;797.5135167547792;801.6432687454085;805.3959530352236;805.4241217529466;825.2160447574798;831.5883637599396;836.3016880904452;837.1879277101233;838.6771093129158;823.8311146215011;824.756696774453;825.9174082591722;826.4834478450969;829.274384913201;604.7822783797873;611.3641812514979;611.3672349118685;614.342653360904;615.6521565315583;13546.59360219195;13556.932215338958;13636.454541818415;13646.658833529142;13647.727045459134;12267;12297.139200255986;12466.563670271496;12615.873841261562;12820.931648426751;10321.896781032168;10330.328528645688;10363.274570780048;10595.841062383994;10635.415052172128;3471.444568868994;3506.1760486285702;3546.929061418757;3591.6947059499976;3594.28114377123;43675.12649746987;43924.780376098235;43941.78029109866;43978.56021439777;44143;8605.483670979762;8839.646414143492;8849.380543361904;8897.777555561033;8909.955450222837;15483.5354939352;15549.766753498707;15549.922250388676;15568.532944011698;15591.610209744847;7530.359919406912;7584.734534291384;7601.923980760233;7603.0876294844975;7606.505577137468;4153.626173644387;4163.687723420756;4183.079722461053;4190.392393102983;4378.715383500063;3036.2864726789185;3047.116336262459;3060.7857449978733;3064.831434271092;3068.064240406653;535.143769968048;544.2353493341861;545.4790674905456;554.6200852416108;556.7578103524979;653.5817077070678;664.2394458345168;668.5787953589207;680.6222546486648;691.3294104718415;7883.802904927423;8085.5957202140835;8132.878006829902;8338.332933365316;8440.45137066101;525.6898429926362;659.0865100674556;692.6458773098581;702.9543079699803;728.4712496350279;3827.5789663137034;4092.7748973806133;4181.184668989518;4300.204462174445;4302.290122129876;51780.482195178316;52128.47871521236;52508.21237681438;53291.73354133205;59085.409145907994;49350;50616.49383506118;51439;51674.48325516772;51676.74161629243;44060.118797623865;44552.77723611426;44796;45457.54542454599;45909.7704511482;8867.403867303947;8881.200691937498;8993.010768815557;9075;9177.495237761987;32593.511097333085;33025.83487082549;33398.66601334053;34035;34060.31879362449;40479;40927.1814563713;45026.54973450224;45994.77002614966;46065.30902036405;10444.373337599769;10638.361698298128;10881.401522916316;10964.945175274073;11272.267302625303;11283.548658053585;11639.6508104757;12363.32001739913;12479.688007799878;12824.102312838386;11231.26996745209;11231.494582743633;11311.264767790068;11393.202475826612;11465.19743617972;10667.573297068031;10733.785324293314;10804.945975270073;11478.385052512716;11622.128340374336;10568.154547636017;10843;10867.184961128105;11363.318200907972;11371.43142842871;9808.705738827846;9849.507524623883;10006.249531285328;10161.062052743871;10184.134348580157;8742.300615950835;8943.776405589912;9010.324225682969;9540.141387275178;9565.139137477661 05:49:39 INFO - PROCESS | 16600 | __end_tp_report 05:49:39 INFO - PROCESS | 16600 | __start_cc_report 05:49:39 INFO - PROCESS | 16600 | _x_x_mozilla_cycle_collect,311 05:49:39 INFO - PROCESS | 16600 | __end_cc_report 05:49:39 INFO - PROCESS | 16600 | __startTimestamp1453556979685__endTimestamp 05:49:39 INFO - PROCESS | 16600 | 05:49:39 INFO - PROCESS | 16600 | ------- Summary: start ------- 05:49:39 INFO - PROCESS | 16600 | Number of tests: 6 05:49:39 INFO - PROCESS | 16600 | 05:49:39 INFO - PROCESS | 16600 | [#0] dojo.html Cycles:165 Average:5290.66 Median:5521.59 stddev:702.44 (12.7%) stddev-sans-first:685.07 05:49:39 INFO - PROCESS | 16600 | Values: 3194.3 3209.6 3231.2 3245.0 3245.2 5250.0 5290.8 5304.7 5308.6 5312.1 5240.5 5254.2 5273.7 5359.7 5484.6 4865.0 4910.2 4974.6 4991.7 4997.2 107.0 4892.2 4954.4 4984.9 4991.6 4904.2 4908.1 4916.0 4943.2 4950.4 4881.9 4890.4 4917.9 4936.3 4961.0 4737.5 4810.8 4969.5 4991.1 5037.0 5204.3 5241.7 5277.2 5282.9 5323.1 5697.6 5701.5 5710.8 5718.5 5719.8 5582.1 5672.5 5685.5 5761.5 5830.2 5324.8 5405.6 5451.6 5452.3 5505.9 5844.8 5845.1 5852.3 5856.0 5856.1 5586.1 5593.7 5597.2 5667.7 5684.6 5725.9 5809.1 5811.5 5816.0 5867.6 5652.9 5667.7 5684.5 5684.6 5707.7 5592.2 5664.7 5681.4 5685.2 5709.0 4403.6 4406.7 4413.8 4420.2 4463.9 3934.8 3973.4 3990.1 3995.8 4018.1 5250.0 5288.6 5327.4 5339.2 5366.2 5679.5 5701.1 5707.4 5717.8 5728.0 5241.2 5292.9 5302.9 5304.8 5350.4 4798.3 4845.0 4856.0 4879.8 4901.6 5895.0 5915.1 5929.6 5939.8 5963.2 5601.1 5713.4 5743.4 5751.1 5755.5 5842.8 5849.8 5863.4 5895.5 5956.9 5584.1 5624.2 5644.2 5671.6 5683.6 5725.8 5727.4 5729.4 5738.7 5747.2 5457.3 5500.1 5555.9 5570.5 5710.8 5609.0 5612.4 5619.9 5621.1 5631.1 5513.9 5525.3 5528.3 5535.0 5536.0 5525.2 5559.4 5614.5 5748.9 5775.2 5471.6 5478.7 5510.7 5515.5 5521.6 05:49:39 INFO - PROCESS | 16600 | 05:49:39 INFO - PROCESS | 16600 | [#1] ext.html Cycles:180 Average:45374.22 Median:34262.41 stddev:76528.67 (223.4%) stddev-sans-first:76669.22 05:49:39 INFO - PROCESS | 16600 | Values: 510.5 516.5 535.6 559.8 571.1 34603.8 35128.0 35244.1 35385.6 35397.0 38262.2 38647.0 38659.4 38751.0 39000.2 8260.1 8408.2 8444.4 8450.2 8472.3 8251.7 8286.4 8329.3 8360.7 8388.5 8430.0 8551.4 8553.2 8564.2 8576.4 8416.9 8518.5 8525.9 8544.4 8559.0 8451.8 8553.9 8556.1 8580.7 8589.5 37990.3 38360.4 38385.6 38599.4 38723.2 3055.9 3083.1 3097.9 3138.5 3176.6 28330.7 28414.3 28526.6 28901.1 29051.9 3776.2 3799.4 3799.4 3878.7 3882.9 265305.0 265665.0 266431.0 267328.0 267629.0 50306.5 51368.5 53643.0 53976.7 54297.5 62730.4 64071.4 64080.0 64483.0 64547.4 13858.7 13963.7 14033.7 14056.0 14077.4 11160.5 11302.4 11317.8 11356.5 11363.4 19737.3 20280.6 20378.8 20388.6 20425.6 7317.2 7542.8 7623.5 7730.2 7771.7 865.1 895.3 952.1 1025.4 1108.4 27846.6 28370.4 30349.5 30561.0 30998.4 982.6 983.7 1005.0 1016.2 1086.8 14746.6 15773.8 15908.6 15986.4 16208.2 314642.0 319498.0 320040.0 320353.0 320909.0 50756.2 50824.0 51041.0 51159.0 51213.5 1346.4 1351.3 1359.3 1368.1 1488.9 26382.7 27634.3 27721.9 28196.2 28415.1 44908.0 45153.5 45542.5 45545.5 45554.0 288344.0 289163.0 290302.0 290672.0 290750.0 30889.5 31217.8 31883.7 31904.2 31983.2 35943.8 36112.8 36693.6 36960.8 37214.0 31253.0 31518.4 31912.8 32070.4 32080.8 32960.5 34316.8 34947.3 35052.3 35250.6 33096.0 33894.5 34078.8 34182.7 34208.0 30882.4 31931.2 32407.8 32709.3 32793.8 24046.3 24260.6 24277.5 24493.3 24709.6 05:49:39 INFO - PROCESS | 16600 | 05:49:39 INFO - PROCESS | 16600 | [#2] jquery.html Cycles:180 Average:25840.05 Median:242803.95 stddev:80642.67 (33.2%) stddev-sans-first:80846.21 05:49:39 INFO - PROCESS | 16600 | Values: 367.5 370.6 370.6 373.1 373.8 15462.4 16308.4 17172.6 17604.9 18372.2 11037.3 12280.2 16569.0 16605.4 16612.1 4560.2 4752.9 4759.1 4760.5 4798.9 4762.8 4815.4 5124.5 5325.3 5335.6 3740.2 3826.9 5293.7 5333.9 5579.5 5376.8 5545.1 5588.2 5589.1 5590.2 5289.0 5310.9 5319.9 5346.3 5365.1 18174.1 18591.7 18868.4 18893.6 18894.4 1770.2 1988.6 2006.0 2014.1 2065.0 9161.6 9235.2 9514.4 9878.7 9895.5 1680.8 1734.5 1748.9 1766.8 1801.4 54225.2 57450.7 58431.7 59178.7 59979.4 9821.9 9864.2 9893.3 10308.3 14569.1 13297.7 13341.1 13350.9 13423.9 13447.0 6866.7 6871.1 6949.2 7225.2 7394.6 6738.5 6930.8 6975.4 6993.7 7112.2 4430.8 4446.4 4460.3 4474.9 4503.9 1843.7 1856.6 1880.2 1892.1 1903.9 416.1 849.9 870.8 918.8 941.4 10196.7 10408.7 10633.0 10701.5 10819.8 849.5 878.5 933.6 933.9 993.2 6394.7 9028.0 9034.5 9174.4 9433.7 480809.0 481693.0 494801.0 501796.0 504623.8 69235.7 71187.6 71225.3 72398.6 73814.0 1092.3 1111.3 1119.7 1158.4 1174.9 14012.1 14134.6 14369.4 14405.8 14687.7 31740.7 31779.7 32400.8 32596.8 33173.7 41437.6 43090.8 43165.6 45797.3 48525.3 7254.2 7345.6 7382.9 7387.1 7405.4 3603.0 3892.7 8417.2 11159.4 11511.2 7164.6 8363.7 9194.8 9703.5 9708.4 9309.6 9403.2 9591.3 10077.5 10172.8 8908.2 9823.4 9919.8 9978.8 10117.4 7386.8 7508.5 7548.1 7585.4 7667.2 9495.8 10185.9 10309.2 10316.5 10454.1 05:49:39 INFO - PROCESS | 16600 | 05:49:39 INFO - PROCESS | 16600 | [#3] mootools.html Cycles:180 Average:5224.32 Median:6257.43 stddev:2617.20 (41.8%) stddev-sans-first:2609.06 05:49:39 INFO - PROCESS | 16600 | Values: 1437.5 1463.5 1614.6 1762.9 1776.1 7408.3 7431.6 7570.2 7608.0 7622.7 7420.9 7424.3 7450.2 7458.9 7462.5 2302.4 2322.3 2323.4 2326.2 2329.9 2283.4 2307.5 2346.8 2359.7 2360.7 1922.8 1941.6 2232.4 2271.1 2272.0 2304.2 2304.4 2309.2 2310.5 2313.4 2213.8 2277.0 2281.0 2283.7 2288.3 7378.3 7469.3 7481.7 7497.4 7497.7 4680.4 4798.2 4808.5 4817.6 4855.1 3083.7 3120.8 3155.0 3178.0 3178.2 1065.5 1069.5 1085.4 1123.7 1128.8 9793.5 9853.2 9878.4 9908.1 9918.5 4092.2 4125.4 4188.4 4193.2 4197.8 8111.1 8155.9 8163.8 8167.7 8170.7 4654.1 4669.6 4681.3 4718.5 4721.6 4251.5 4330.8 4333.0 4342.4 4355.1 3440.1 3473.9 3506.4 3521.6 3549.7 1082.1 1101.6 1107.3 1129.0 1140.6 822.6 826.0 832.9 924.9 949.1 6943.3 6960.0 6982.5 7017.6 7018.2 1108.5 1112.7 1114.8 1122.8 1144.7 5384.6 5435.1 5499.5 5500.6 5513.0 8667.7 8680.6 8802.8 8841.7 8889.0 8680.4 8732.0 8744.4 8746.3 8798.5 6986.2 7045.7 7142.4 7165.0 7230.9 6652.3 6674.1 6697.3 6700.4 6708.4 7813.2 8020.6 8032.2 8062.1 8171.6 7950.2 8150.1 8225.5 8293.8 8313.3 6093.4 6165.8 6468.7 6566.6 6573.8 7023.9 7108.0 7119.1 7119.2 7130.2 6717.0 6740.5 6778.8 6843.0 6847.1 6328.2 6529.2 6568.9 6684.1 6795.7 6600.2 6627.9 6633.6 6639.7 6675.6 6135.1 6192.8 6194.1 6199.9 6200.8 6155.8 6186.2 6187.2 6220.8 6294.1 05:49:39 INFO - PROCESS | 16600 | 05:49:39 INFO - PROCESS | 16600 | [#4] prototype.html Cycles:180 Average:5578.05 Median:6274.75 stddev:1703.17 (27.1%) stddev-sans-first:1661.92 05:49:39 INFO - PROCESS | 16600 | Values: 338.5 343.6 346.1 348.2 349.7 6142.2 6216.4 6278.7 6334.6 6379.2 6070.2 6168.0 6203.8 6221.3 6237.7 4800.5 4817.4 4831.6 4840.0 4851.3 4844.2 4846.9 4853.2 4855.1 4862.2 4717.7 4783.7 4789.6 4804.4 4814.1 4761.1 4763.9 4775.3 4777.5 4785.7 4011.4 4114.7 4187.3 4188.5 4195.2 5918.7 5932.8 5954.6 5957.3 6022.0 5485.9 5504.4 5506.5 5523.8 5567.1 6513.5 6570.4 6580.1 6582.6 6631.1 4542.6 4560.7 4561.8 4565.8 4582.7 6917.1 6931.5 6971.9 6977.9 6983.9 4616.3 4652.5 4658.4 4662.9 4681.1 4569.5 4671.6 4671.9 4727.3 4774.2 5518.3 5523.3 5526.4 5535.3 5548.3 6679.0 6686.0 6701.5 6708.7 6724.8 1665.7 1674.2 1676.2 1679.0 1681.9 1085.5 1094.0 1108.2 1123.1 1129.6 6289.8 6290.5 6298.7 6305.9 6315.3 6817.2 6864.6 6873.0 6902.0 6912.6 6105.6 6243.0 6263.2 6270.8 6283.7 3682.4 3727.8 3739.0 3745.5 3751.0 7010.1 7185.0 7222.4 7230.5 7242.0 7051.8 7057.4 7058.0 7080.5 7115.5 7086.6 7167.1 7171.9 7194.3 7260.5 6893.4 6935.3 6941.5 6941.6 6944.2 6841.7 6882.9 6888.7 6890.8 6898.2 7090.6 7232.6 7240.0 7240.6 7256.3 4591.3 4597.1 4602.6 4609.3 4611.5 6924.9 6942.8 6960.3 6963.3 6991.4 6629.5 6777.9 6779.7 6790.9 6791.2 6757.2 6762.2 6766.3 6768.5 6780.3 6591.4 6628.2 6639.5 6650.5 6671.0 6647.1 6772.2 6801.8 6816.3 6819.5 6620.6 6647.4 6649.6 6649.7 6659.9 05:49:39 INFO - PROCESS | 16600 | 05:49:39 INFO - PROCESS | 16600 | [#5] yui.html Cycles:180 Average:13311.33 Median:44347.89 stddev:15217.84 (34.3%) stddev-sans-first:15231.29 05:49:39 INFO - PROCESS | 16600 | Values: 750.4 782.3 800.9 843.4 852.7 13099.5 13191.9 13230.7 13256.5 13267.1 12480.3 12536.2 12609.3 12637.6 12637.7 781.7 799.7 800.8 801.8 804.1 795.6 797.5 801.6 805.4 805.4 825.2 831.6 836.3 837.2 838.7 823.8 824.8 825.9 826.5 829.3 604.8 611.4 611.4 614.3 615.7 13546.6 13556.9 13636.5 13646.7 13647.7 12267.0 12297.1 12466.6 12615.9 12820.9 10321.9 10330.3 10363.3 10595.8 10635.4 3471.4 3506.2 3546.9 3591.7 3594.3 43675.1 43924.8 43941.8 43978.6 44143.0 8605.5 8839.6 8849.4 8897.8 8910.0 15483.5 15549.8 15549.9 15568.5 15591.6 7530.4 7584.7 7601.9 7603.1 7606.5 4153.6 4163.7 4183.1 4190.4 4378.7 3036.3 3047.1 3060.8 3064.8 3068.1 535.1 544.2 545.5 554.6 556.8 653.6 664.2 668.6 680.6 691.3 7883.8 8085.6 8132.9 8338.3 8440.5 525.7 659.1 692.6 703.0 728.5 3827.6 4092.8 4181.2 4300.2 4302.3 51780.5 52128.5 52508.2 53291.7 59085.4 49350.0 50616.5 51439.0 51674.5 51676.7 44060.1 44552.8 44796.0 45457.5 45909.8 8867.4 8881.2 8993.0 9075.0 9177.5 32593.5 33025.8 33398.7 34035.0 34060.3 40479.0 40927.2 45026.5 45994.8 46065.3 10444.4 10638.4 10881.4 10964.9 11272.3 11283.5 11639.7 12363.3 12479.7 12824.1 11231.3 11231.5 11311.3 11393.2 11465.2 10667.6 10733.8 10804.9 11478.4 11622.1 10568.2 10843.0 10867.2 11363.3 11371.4 9808.7 9849.5 10006.2 10161.1 10184.1 8742.3 8943.8 9010.3 9540.1 9565.1 05:49:39 INFO - PROCESS | 16600 | -------- Summary: end -------- 05:49:39 INFO - PROCESS | 16600 | 05:49:40 INFO - TEST-INFO | 16600: exit 0 05:49:40 INFO - TEST-OK | dromaeo_css | took 1110063ms 05:49:40 INFO - TEST-START | kraken 05:49:40 INFO - operating with platform_type : linux_ 05:49:40 INFO - Initialising browser for kraken test... 05:49:40 INFO - TEST-INFO | started process 16840 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKPrfhv/profile http://localhost:55441/getInfo.html) 05:49:44 INFO - PROCESS | 16840 | 05:49:44 INFO - PROCESS | 16840 | (process:16913): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:49:45 INFO - PROCESS | 16840 | __metrics Screen width/height:1600/1200 05:49:45 INFO - PROCESS | 16840 | colorDepth:24 05:49:45 INFO - PROCESS | 16840 | Browser inner width/height: 1024/697 05:49:45 INFO - PROCESS | 16840 | __metrics 05:49:45 INFO - PROCESS | 16840 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:49:46 INFO - TEST-INFO | 16840: exit 0 05:49:46 INFO - Browser initialized. 05:49:46 INFO - Running cycle 1/1 for kraken test... 05:49:46 INFO - TEST-INFO | started process 16962 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKPrfhv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:47 INFO - PROCESS | 16962 | 05:49:47 INFO - PROCESS | 16962 | (process:17019): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:49:57 INFO - PROCESS | 16962 | RSS: Main: 151953408 05:49:57 INFO - PROCESS | 16962 | 05:50:00 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55441/tests/kraken/driver.html?testName=audio-beat-detection) 05:50:01 INFO - PROCESS | 16962 | RSS: Main: 154271744 05:50:01 INFO - PROCESS | 16962 | 05:50:03 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55441/tests/kraken/driver.html?testName=audio-dft) 05:50:04 INFO - PROCESS | 16962 | RSS: Main: 159080448 05:50:04 INFO - PROCESS | 16962 | 05:50:07 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55441/tests/kraken/driver.html?testName=audio-fft) 05:50:07 INFO - PROCESS | 16962 | RSS: Main: 152887296 05:50:07 INFO - PROCESS | 16962 | 05:50:10 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55441/tests/kraken/driver.html?testName=audio-oscillator) 05:50:10 INFO - PROCESS | 16962 | RSS: Main: 152256512 05:50:10 INFO - PROCESS | 16962 | 05:50:12 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55441/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:50:13 INFO - PROCESS | 16962 | RSS: Main: 152530944 05:50:13 INFO - PROCESS | 16962 | 05:50:16 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55441/tests/kraken/driver.html?testName=imaging-darkroom) 05:50:16 INFO - PROCESS | 16962 | RSS: Main: 152580096 05:50:16 INFO - PROCESS | 16962 | 05:50:20 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55441/tests/kraken/driver.html?testName=imaging-desaturate) 05:50:20 INFO - PROCESS | 16962 | RSS: Main: 153018368 05:50:20 INFO - PROCESS | 16962 | 05:50:23 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55441/tests/kraken/driver.html?testName=json-parse-financial) 05:50:24 INFO - PROCESS | 16962 | RSS: Main: 153260032 05:50:24 INFO - PROCESS | 16962 | 05:50:25 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55441/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:50:26 INFO - PROCESS | 16962 | RSS: Main: 154025984 05:50:26 INFO - PROCESS | 16962 | 05:50:28 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:50:28 INFO - PROCESS | 16962 | RSS: Main: 154308608 05:50:28 INFO - PROCESS | 16962 | 05:50:31 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:50:31 INFO - PROCESS | 16962 | RSS: Main: 153759744 05:50:31 INFO - PROCESS | 16962 | 05:50:34 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:50:34 INFO - PROCESS | 16962 | RSS: Main: 154316800 05:50:34 INFO - PROCESS | 16962 | 05:50:37 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:50:37 INFO - PROCESS | 16962 | RSS: Main: 153763840 05:50:37 INFO - PROCESS | 16962 | 05:50:39 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55441/tests/kraken/driver.html?testName=ai-astar) 05:50:39 INFO - PROCESS | 16962 | RSS: Main: 155439104 05:50:39 INFO - PROCESS | 16962 | 05:50:39 INFO - PROCESS | 16962 | __start_tp_report 05:50:39 INFO - PROCESS | 16962 | _x_x_mozilla_page_load 05:50:39 INFO - PROCESS | 16962 | _x_x_mozilla_page_load_details 05:50:39 INFO - PROCESS | 16962 | |i|pagename|runs| 05:50:39 INFO - PROCESS | 16962 | |0;ai-astar;111;107;111;110;112;124;111;110;111;109 05:50:39 INFO - PROCESS | 16962 | |1;audio-beat-detection;155;127;151;163;130;149;156;135;168;133 05:50:39 INFO - PROCESS | 16962 | |2;audio-dft;161;163;162;166;163;160;164;165;168;163 05:50:39 INFO - PROCESS | 16962 | |3;audio-fft;73;75;74;73;74;129;73;73;74;73 05:50:39 INFO - PROCESS | 16962 | |4;audio-oscillator;97;97;151;96;100;98;140;97;96;133 05:50:39 INFO - PROCESS | 16962 | |5;imaging-gaussian-blur;110;111;109;110;109;110;110;110;109;110 05:50:39 INFO - PROCESS | 16962 | |6;imaging-darkroom;148;147;148;147;146;147;148;147;147;146 05:50:39 INFO - PROCESS | 16962 | |7;imaging-desaturate;96;98;97;96;97;97;97;97;96;96 05:50:39 INFO - PROCESS | 16962 | |8;json-parse-financial;59;59;61;58;60;60;58;59;68;59 05:50:39 INFO - PROCESS | 16962 | |9;json-stringify-tinderbox;68;68;68;68;68;68;67;67;68;69 05:50:39 INFO - PROCESS | 16962 | |10;stanford-crypto-aes;81;88;83;84;84;87;83;81;83;82 05:50:39 INFO - PROCESS | 16962 | |11;stanford-crypto-ccm;123;119;118;120;132;116;117;120;119;119 05:50:39 INFO - PROCESS | 16962 | |12;stanford-crypto-pbkdf2;128;144;129;149;145;144;148;138;141;140 05:50:39 INFO - PROCESS | 16962 | |13;stanford-crypto-sha256-iterative;66;70;68;70;68;68;67;66;66;66 05:50:39 INFO - PROCESS | 16962 | __end_tp_report 05:50:39 INFO - PROCESS | 16962 | __start_cc_report 05:50:39 INFO - PROCESS | 16962 | _x_x_mozilla_cycle_collect,738 05:50:39 INFO - PROCESS | 16962 | __end_cc_report 05:50:39 INFO - PROCESS | 16962 | __startTimestamp1453557039655__endTimestamp 05:50:39 INFO - PROCESS | 16962 | 05:50:39 INFO - PROCESS | 16962 | ------- Summary: start ------- 05:50:39 INFO - PROCESS | 16962 | Number of tests: 14 05:50:39 INFO - PROCESS | 16962 | 05:50:39 INFO - PROCESS | 16962 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.00 stddev:4.58 (4.1%) stddev-sans-first:4.85 05:50:39 INFO - PROCESS | 16962 | Values: 111.0 107.0 111.0 110.0 112.0 124.0 111.0 110.0 111.0 109.0 05:50:39 INFO - PROCESS | 16962 | 05:50:39 INFO - PROCESS | 16962 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:153.00 stddev:14.49 (9.5%) stddev-sans-first:15.06 05:50:39 INFO - PROCESS | 16962 | Values: 155.0 127.0 151.0 163.0 130.0 149.0 156.0 135.0 168.0 133.0 05:50:39 INFO - PROCESS | 16962 | 05:50:39 INFO - PROCESS | 16962 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:2.37 (1.4%) stddev-sans-first:2.33 05:50:39 INFO - PROCESS | 16962 | Values: 161.0 163.0 162.0 166.0 163.0 160.0 164.0 165.0 168.0 163.0 05:50:39 INFO - PROCESS | 16962 | 05:50:39 INFO - PROCESS | 16962 | [#3] audio-fft Cycles:10 Average:79.10 Median:73.50 stddev:17.55 (23.9%) stddev-sans-first:18.47 05:50:39 INFO - PROCESS | 16962 | Values: 73.0 75.0 74.0 73.0 74.0 129.0 73.0 73.0 74.0 73.0 05:50:39 INFO - PROCESS | 16962 | 05:50:39 INFO - PROCESS | 16962 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:96.50 stddev:21.73 (22.5%) stddev-sans-first:22.49 05:50:39 INFO - PROCESS | 16962 | Values: 97.0 97.0 151.0 96.0 100.0 98.0 140.0 97.0 96.0 133.0 05:50:39 INFO - PROCESS | 16962 | 05:50:39 INFO - PROCESS | 16962 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 05:50:39 INFO - PROCESS | 16962 | Values: 110.0 111.0 109.0 110.0 109.0 110.0 110.0 110.0 109.0 110.0 05:50:39 INFO - PROCESS | 16962 | 05:50:39 INFO - PROCESS | 16962 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 05:50:39 INFO - PROCESS | 16962 | Values: 148.0 147.0 148.0 147.0 146.0 147.0 148.0 147.0 147.0 146.0 05:50:39 INFO - PROCESS | 16962 | 05:50:39 INFO - PROCESS | 16962 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 05:50:39 INFO - PROCESS | 16962 | Values: 96.0 98.0 97.0 96.0 97.0 97.0 97.0 97.0 96.0 96.0 05:50:39 INFO - PROCESS | 16962 | 05:50:39 INFO - PROCESS | 16962 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:59.50 stddev:2.92 (4.9%) stddev-sans-first:3.07 05:50:39 INFO - PROCESS | 16962 | Values: 59.0 59.0 61.0 58.0 60.0 60.0 58.0 59.0 68.0 59.0 05:50:39 INFO - PROCESS | 16962 | 05:50:39 INFO - PROCESS | 16962 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 05:50:39 INFO - PROCESS | 16962 | Values: 68.0 68.0 68.0 68.0 68.0 68.0 67.0 67.0 68.0 69.0 05:50:39 INFO - PROCESS | 16962 | 05:50:39 INFO - PROCESS | 16962 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.50 stddev:2.32 (2.8%) stddev-sans-first:2.26 05:50:39 INFO - PROCESS | 16962 | Values: 81.0 88.0 83.0 84.0 84.0 87.0 83.0 81.0 83.0 82.0 05:50:39 INFO - PROCESS | 16962 | 05:50:39 INFO - PROCESS | 16962 | [#11] stanford-crypto-ccm Cycles:10 Average:120.30 Median:119.50 stddev:4.52 (3.8%) stddev-sans-first:4.69 05:50:39 INFO - PROCESS | 16962 | Values: 123.0 119.0 118.0 120.0 132.0 116.0 117.0 120.0 119.0 119.0 05:50:39 INFO - PROCESS | 16962 | 05:50:39 INFO - PROCESS | 16962 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.60 Median:144.00 stddev:7.21 (5.0%) stddev-sans-first:6.04 05:50:39 INFO - PROCESS | 16962 | Values: 128.0 144.0 129.0 149.0 145.0 144.0 148.0 138.0 141.0 140.0 05:50:39 INFO - PROCESS | 16962 | 05:50:39 INFO - PROCESS | 16962 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.58 (2.3%) stddev-sans-first:1.58 05:50:39 INFO - PROCESS | 16962 | Values: 66.0 70.0 68.0 70.0 68.0 68.0 67.0 66.0 66.0 66.0 05:50:39 INFO - PROCESS | 16962 | -------- Summary: end -------- 05:50:39 INFO - PROCESS | 16962 | 05:50:40 INFO - TEST-INFO | 16962: exit 0 05:50:40 INFO - TEST-OK | kraken | took 60298ms 05:50:40 INFO - TEST-START | v8_7 05:50:40 INFO - operating with platform_type : linux_ 05:50:40 INFO - Initialising browser for v8_7 test... 05:50:40 INFO - TEST-INFO | started process 17247 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZbKUwD/profile http://localhost:55441/getInfo.html) 05:50:44 INFO - PROCESS | 17247 | 05:50:44 INFO - PROCESS | 17247 | (process:17318): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:50:45 INFO - PROCESS | 17247 | __metrics Screen width/height:1600/1200 05:50:45 INFO - PROCESS | 17247 | colorDepth:24 05:50:45 INFO - PROCESS | 17247 | Browser inner width/height: 1024/697 05:50:45 INFO - PROCESS | 17247 | __metrics 05:50:45 INFO - PROCESS | 17247 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:50:46 INFO - TEST-INFO | 17247: exit 0 05:50:46 INFO - Browser initialized. 05:50:46 INFO - Running cycle 1/1 for v8_7 test... 05:50:46 INFO - TEST-INFO | started process 17367 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZbKUwD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:47 INFO - PROCESS | 17367 | 05:50:47 INFO - PROCESS | 17367 | (process:17425): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:50:58 INFO - PROCESS | 17367 | RSS: Main: 151912448 05:50:58 INFO - PROCESS | 17367 | 05:51:20 INFO - PROCESS | 17367 | Cycle 1(1): loaded http://localhost:55441/tests/v8_7/run.html (next: http://localhost:55441/tests/v8_7/run.html) 05:51:21 INFO - PROCESS | 17367 | RSS: Main: 150671360 05:51:21 INFO - PROCESS | 17367 | 05:51:21 INFO - PROCESS | 17367 | __start_tp_report 05:51:21 INFO - PROCESS | 17367 | _x_x_mozilla_page_load 05:51:21 INFO - PROCESS | 17367 | _x_x_mozilla_page_load_details 05:51:21 INFO - PROCESS | 17367 | |i|pagename|runs| 05:51:21 INFO - PROCESS | 17367 | |0;Richards;166.77785190126752 05:51:21 INFO - PROCESS | 17367 | |1;DeltaBlue;190.69412662090008 05:51:21 INFO - PROCESS | 17367 | |2;Encrypt;279.9552071668533 05:51:21 INFO - PROCESS | 17367 | |3;Decrypt;5235.602094240838 05:51:21 INFO - PROCESS | 17367 | |4;RayTrace;1081.081081081081 05:51:21 INFO - PROCESS | 17367 | |5;Earley;713.7758743754462 05:51:21 INFO - PROCESS | 17367 | |6;Boyer;12304.878048780487 05:51:21 INFO - PROCESS | 17367 | |7;RegExp;40640 05:51:21 INFO - PROCESS | 17367 | |8;Splay;638.9776357827476 05:51:21 INFO - PROCESS | 17367 | |9;NavierStokes;4830.917874396136 05:51:21 INFO - PROCESS | 17367 | __end_tp_report 05:51:21 INFO - PROCESS | 17367 | __startTimestamp1453557081095__endTimestamp 05:51:21 INFO - PROCESS | 17367 | 05:51:21 INFO - PROCESS | 17367 | ------- Summary: start ------- 05:51:21 INFO - PROCESS | 17367 | Number of tests: 10 05:51:21 INFO - PROCESS | 17367 | 05:51:21 INFO - PROCESS | 17367 | [#0] Richards Cycles:1 Average:166.78 Median:166.78 stddev:0.00 (0.0%) 05:51:21 INFO - PROCESS | 17367 | Values: 166.8 05:51:21 INFO - PROCESS | 17367 | 05:51:21 INFO - PROCESS | 17367 | [#1] DeltaBlue Cycles:1 Average:190.69 Median:190.69 stddev:0.00 (0.0%) 05:51:21 INFO - PROCESS | 17367 | Values: 190.7 05:51:21 INFO - PROCESS | 17367 | 05:51:21 INFO - PROCESS | 17367 | [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 05:51:21 INFO - PROCESS | 17367 | Values: 280.0 05:51:21 INFO - PROCESS | 17367 | 05:51:21 INFO - PROCESS | 17367 | [#3] Decrypt Cycles:1 Average:5235.60 Median:5235.60 stddev:0.00 (0.0%) 05:51:21 INFO - PROCESS | 17367 | Values: 5235.6 05:51:21 INFO - PROCESS | 17367 | 05:51:21 INFO - PROCESS | 17367 | [#4] RayTrace Cycles:1 Average:1081.08 Median:1081.08 stddev:0.00 (0.0%) 05:51:21 INFO - PROCESS | 17367 | Values: 1081.1 05:51:21 INFO - PROCESS | 17367 | 05:51:21 INFO - PROCESS | 17367 | [#5] Earley Cycles:1 Average:713.78 Median:713.78 stddev:0.00 (0.0%) 05:51:21 INFO - PROCESS | 17367 | Values: 713.8 05:51:21 INFO - PROCESS | 17367 | 05:51:21 INFO - PROCESS | 17367 | [#6] Boyer Cycles:1 Average:12304.88 Median:12304.88 stddev:0.00 (0.0%) 05:51:21 INFO - PROCESS | 17367 | Values: 12304.9 05:51:21 INFO - PROCESS | 17367 | 05:51:21 INFO - PROCESS | 17367 | [#7] RegExp Cycles:1 Average:40640.00 Median:40640.00 stddev:0.00 (0.0%) 05:51:21 INFO - PROCESS | 17367 | Values: 40640.0 05:51:21 INFO - PROCESS | 17367 | 05:51:21 INFO - PROCESS | 17367 | [#8] Splay Cycles:1 Average:638.98 Median:638.98 stddev:0.00 (0.0%) 05:51:21 INFO - PROCESS | 17367 | Values: 639.0 05:51:21 INFO - PROCESS | 17367 | 05:51:21 INFO - PROCESS | 17367 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 05:51:21 INFO - PROCESS | 17367 | Values: 4830.9 05:51:21 INFO - PROCESS | 17367 | -------- Summary: end -------- 05:51:21 INFO - PROCESS | 17367 | 05:51:22 INFO - TEST-INFO | 17367: exit 0 05:51:22 INFO - TEST-OK | v8_7 | took 41411ms 05:51:22 INFO - SUITE-END | took 1211s 05:51:22 INFO - Completed test suite (00:20:11) 05:51:22 INFO - Working with test: dromaeo_css 05:51:22 INFO - Generating results file: dromaeo_css 05:51:22 INFO - Working with test: kraken 05:51:22 INFO - Generating results file: kraken 05:51:22 INFO - javascript benchmark 05:51:22 INFO - Working with test: v8_7 05:51:22 INFO - Generating results file: v8_7 05:51:22 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:22 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 05:51:22 INFO - process_Request line: dromaeo_css 6792.33 graph.html#tests=[[72,1,43]] 05:51:22 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:22 INFO - process_Request line: kraken 1505.00 graph.html#tests=[[232,1,43]] 05:51:22 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:22 INFO - process_Request line: v8_7 20213.39 graph.html#tests=[[230,1,43]] 05:51:22 INFO - RETURN: dromaeo_css: 6792.33 05:51:22 INFO - RETURN: kraken: 1505.00 05:51:22 INFO - RETURN: v8_7: 20213.39 05:51:22 INFO - javascript benchmark 05:51:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3194.2972546039864, 3209.5988001499813, 3231.224506118532, 3245.0, 3245.172481017341, 5250.0, 5290.8412747617585, 5304.65519741217, 5308.575313974888, 5312.123499622568, 5240.502152295536, 5254.238135470355, 5273.657212281209, 5359.651622644526, 5484.588655850807, 4864.975675121628, 4910.1898186799135, 4974.577160941324, 4991.700497970115, 4997.150484417658, 107.04989728021096, 4892.192788189945, 4954.355933728628, 4984.875378115558, 4991.625628077891, 4904.239842824368, 4908.092002979461, 4915.967646794177, 4943.233798761198, 4950.356453661019, 4881.8779530511665, 4890.437599676047, 4917.926231106536, 4936.33359496467, 4961.0, 4737.455192652855, 4810.759462026885, 4969.527894849984, 4991.126552853272, 5037.0, 5204.271402003723, 5241.68549887008, 5277.234800953878, 5282.947170528284, 5323.148296272578, 5697.572682048863, 5701.543876489871, 5710.828675139711, 5718.513926316268, 5719.799807006776, 5582.106862901916, 5672.461116193955, 5685.516731077863, 5761.53907687384, 5830.183774271605, 5324.840254792362, 5405.648632838853, 5451.618386712932, 5452.318460192436, 5505.889882202374, 5844.824655260349, 5845.09401042839, 5852.297724273115, 5855.970720146372, 5856.0630299151935, 5586.1062230043, 5593.664380137124, 5597.244372009726, 5667.659940403589, 5684.63049901755, 5725.885482290414, 5809.128630705428, 5811.476967072984, 5815.9709201453725, 5867.559933005042, 5652.85867853307, 5667.688277144714, 5684.516816070598, 5684.602077854511, 5707.71461426927, 5592.245046918614, 5664.745086471119, 5681.403452637496, 5685.1756495307945, 5709.029464990961, 4403.603675669206, 4406.735595864258, 4413.801378937956, 4420.248557745191, 4463.866084017484, 3934.7639141651593, 3973.364261718169, 3990.06233535119, 3995.780232087263, 4018.1160144768687, 5250.0, 5288.603354748409, 5327.387350454747, 5339.199120131933, 5366.195070739343, 5679.545636349165, 5701.116326969326, 5707.400722924116, 5717.771289148387, 5727.971360143172, 5241.213817927265, 5292.894142117136, 5302.946970530245, 5304.761285742151, 5350.411454739976, 4798.3042458843975, 4845.0, 4855.975720121377, 4879.804807807648, 4901.5588597026435, 5894.970525147347, 5915.112733090071, 5929.644221346733, 5939.792107276225, 5963.224780778558, 5601.131824567198, 5713.400092990342, 5743.368229494836, 5751.1085781703905, 5755.453231943043, 5842.824715258549, 5849.795257165979, 5863.413658634103, 5895.528357731457, 5956.940430595639, 5584.078627026658, 5624.212610234488, 5644.2380278663495, 5671.602987790815, 5683.60214784961, 5725.770969161187, 5727.39862314451, 5729.398413166724, 5738.713064346849, 5747.19539264495, 5457.317835270591, 5500.119980803052, 5555.916661250165, 5570.498655120897, 5710.771569137188, 5608.971955140199, 5612.382637909908, 5619.8595035124445, 5621.10062390032, 5631.099024156116, 5513.889722205453, 5525.309336332958, 5528.281323428089, 5534.972325138348, 5536.031194540858, 5525.198846167364, 5559.360673522435, 5614.466625670555, 5748.9425105748405, 5775.1914731938405, 5471.5896307777875, 5478.726063696719, 5510.724463776875, 5515.531179849758, 5521.585881059017], "unit": "score", "name": "dojo.html", "value": 5249.07382785792}, {"lowerIsBetter": false, "replicates": [510.49971028392173, 516.4757770862575, 535.5956253028962, 559.8264537993219, 571.1062187676287, 34603.826980865095, 35128.0, 35244.118897027554, 35385.64614353856, 35397.0, 38262.234755304875, 38647.0, 38659.42010869839, 38751.0, 39000.21999560007, 8260.132686067967, 8408.24325810677, 8444.408891377576, 8450.239478446938, 8472.322214222848, 8251.711190108348, 8286.378521610874, 8329.292010179142, 8360.707375241867, 8388.454750441202, 8430.0, 8551.444156129863, 8553.230209281164, 8564.186402291773, 8576.356773242002, 8416.915830841674, 8518.531480768586, 8525.872111918326, 8544.359173061983, 8558.957205213934, 8451.83096338076, 8553.914460855374, 8556.101609330994, 8580.656773729042, 8589.484630922165, 37990.251218597674, 38360.42459363112, 38385.61614383848, 38599.42100868489, 38723.22553548913, 3055.882250772918, 3083.1058992892035, 3097.860596273151, 3138.5135304027913, 3176.5870436843293, 28330.716692833015, 28414.28964275889, 28526.572101418496, 28901.12142710717, 29051.854740726372, 3776.2258736958856, 3799.4300854871713, 3799.449079883429, 3878.650921417058, 3882.8835134946, 265305.0, 265665.0, 266431.0, 267328.0, 267629.0, 50306.49693503091, 51368.48631513712, 53643.0, 53976.730116349165, 54297.45702542924, 62730.372696272454, 64071.359286406536, 64080.0, 64483.0, 64547.35452645413, 13858.653533661538, 13963.650908727363, 14033.71932561343, 14056.0, 14077.366518506487, 11160.497777600027, 11302.434878256054, 11317.83023254652, 11356.48895799691, 11363.431828408711, 19737.309194178135, 20280.59438811245, 20378.796212037985, 20388.592228155652, 20425.591488170154, 7317.231690672403, 7542.849143017219, 7623.542587444771, 7730.188330225358, 7771.6891324347525, 865.0959747064333, 895.3285036222833, 952.0859974424629, 1025.4257615735212, 1108.362691452402, 27846.5823012655, 28370.43259134847, 30349.544756828665, 30561.0, 30998.380032399677, 982.6462473509531, 983.7048885334372, 1004.9949750251202, 1016.1667432705111, 1086.750047489082, 14746.557603271918, 15773.763393549107, 15908.602284942968, 15986.440474583334, 16208.189590520427, 314642.0, 319498.0, 320040.0, 320353.0, 320909.0, 50756.23865642018, 50824.0, 51041.0, 51159.0, 51213.48786512162, 1346.3672074125145, 1351.2568087551808, 1359.2931675528669, 1368.0560413314781, 1488.8660020598197, 26382.73617263803, 27634.309142271602, 27721.861390692917, 28196.154115376572, 28415.147545573665, 44908.0, 45153.54846451493, 45542.544574555155, 45545.54454455546, 45554.0, 288344.0, 289163.0, 290302.0, 290672.0, 290750.0, 30889.536656949713, 31217.843910780302, 31883.68116318807, 31904.202394940312, 31983.200419988756, 35943.82028089843, 36112.8194359037, 36693.63306367009, 36960.815195923846, 37214.0, 31253.0, 31518.36963260768, 31912.840435797672, 32070.35859282848, 32080.839595802805, 32960.505592415655, 34316.82841585776, 34947.30105397929, 35052.29895402129, 35250.647493525765, 33096.0, 33894.491582625786, 34078.82960585181, 34182.65817341795, 34208.0, 30882.38235235238, 31931.201719957186, 32407.83796081099, 32709.34581308408, 32793.83603081969, 24046.27861164168, 24260.63609045901, 24277.514449710554, 24493.265202043967, 24709.629355559322], "unit": "score", "name": "ext.html", "value": 17853.351730465893}, {"lowerIsBetter": false, "replicates": [367.5203858964052, 370.6201143827577, 370.62381682592155, 373.07105307783627, 373.76452834714144, 15462.381504739811, 16308.429204977829, 17172.570685732848, 17604.911975440136, 18372.17325220365, 11037.3377597344, 12280.201786883847, 16569.0, 16605.41881034161, 16612.086335251555, 4560.179167749804, 4752.881177970544, 4759.071980963713, 4760.4525479569775, 4798.904021919559, 4762.809487620491, 4815.422149342066, 5124.461931497195, 5325.281087053257, 5335.599830012745, 3740.214554943465, 3826.923461530768, 5293.655912365684, 5333.866653333678, 5579.525740312079, 5376.811811586615, 5545.057340252167, 5588.189712491686, 5589.077802162638, 5590.217369568264, 5288.9735551322, 5310.893782124374, 5319.946800531984, 5346.251524786533, 5365.141577347645, 18174.091295435177, 18591.721124183146, 18868.43394698161, 18893.622127557508, 18894.433167005012, 1770.1857145712859, 1988.6420444320017, 2006.047127614386, 2014.0936578539715, 2064.989675051615, 9161.633534658606, 9235.215006724437, 9514.429134251966, 9878.654247101316, 9895.505224738807, 1680.8319168083217, 1734.4623166818326, 1748.8775785695007, 1766.7703198584102, 1801.3875282403915, 54225.1866222003, 57450.71274643642, 58431.70784146094, 59178.70410647962, 59979.400205997816, 9821.901780982242, 9864.210863130933, 9893.25800564946, 10308.278420510642, 14569.125852448888, 13297.667558310926, 13341.132826366254, 13350.866491335157, 13423.865761342262, 13447.0, 6866.725330986805, 6871.14110736158, 6949.235584085746, 7225.241349658315, 7394.5932973685885, 6738.460923126138, 6930.792076237721, 6975.372216500539, 6993.685284162225, 7112.182099058571, 4430.756308403069, 4446.399736035659, 4460.330950357472, 4474.865754027384, 4503.909921801611, 1843.658923099204, 1856.5822689894665, 1880.1633273193572, 1892.139076720089, 1903.8572107092023, 416.0846138495322, 849.9405041647026, 870.8127752533236, 918.7519369770125, 941.3880977364631, 10196.745081373025, 10408.739781505372, 10633.0, 10701.522005348294, 10819.809820919692, 849.515776007682, 878.4553576782436, 933.6125507914276, 933.8785957825439, 993.1657407777501, 6394.71223794921, 9028.0, 9034.457932523937, 9174.403663761834, 9433.71698849022, 480809.0, 481693.0, 494801.0, 501796.0, 504623.76881155797, 69235.65382173056, 71187.64406178039, 71225.28774712187, 72398.63800680963, 73814.0, 1092.3282181458346, 1111.2610114273916, 1119.7424592343807, 1158.4129742252999, 1174.9412529373496, 14012.089214201043, 14134.646633834236, 14369.353379097756, 14405.78391324152, 14687.706245875237, 31740.682593174697, 31779.682203177672, 32400.837995810813, 32596.83701581477, 33173.66826331706, 41437.58562414337, 43090.78454607707, 43165.56834431741, 45797.31304030509, 48525.27212091892, 7254.202037775946, 7345.5959922202655, 7382.852342953003, 7387.113546374255, 7405.370543503863, 3602.963970360263, 3892.7080468965505, 8417.242448179693, 11159.442027898735, 11511.19421640477, 7164.570125792469, 8363.749087527383, 9194.816103678022, 9703.5148242589, 9708.417494950043, 9309.627614895327, 9403.153716165578, 9591.280653950842, 10077.453570305017, 10172.79654406893, 8908.198262156437, 9823.36148150368, 9919.752006199902, 9978.800423991624, 10117.392956422344, 7386.815329616803, 7508.474406791473, 7548.094228692373, 7585.355244804254, 7667.194944530967, 9495.810083798424, 10185.898141018495, 10309.175265978854, 10316.535755891153, 10454.059134677611], "unit": "score", "name": "jquery.html", "value": 7801.441467774858}, {"lowerIsBetter": false, "replicates": [1437.5184313255058, 1463.52435458476, 1614.5640677017207, 1762.947111586653, 1776.0586888948862, 7408.259174082589, 7431.62841857907, 7570.167281599033, 7607.961960190199, 7622.65698043588, 7420.888686669704, 7424.257574242573, 7450.217727138654, 7458.88811667824, 7462.514936529122, 2302.4128847143998, 2322.326525307659, 2323.384303159664, 2326.2439707095177, 2329.860208387494, 2283.4405570635136, 2307.469282065126, 2346.800521955627, 2359.716833979925, 2360.7285162206394, 1922.807719228073, 1941.5825597496535, 2232.352617740861, 2271.114265436481, 2272.0457407888644, 2304.1704986204954, 2304.4238940264936, 2309.1686992682703, 2310.5378924215056, 2313.375388645073, 2213.7896899794496, 2276.988615056914, 2280.954380912389, 2283.703118594589, 2288.302067869299, 7378.335949764493, 7469.253074692541, 7481.738139165158, 7497.4376921730545, 7497.700091996368, 4680.4383473983, 4798.1843086675, 4808.495108013678, 4817.590504807095, 4855.053264613402, 3083.6607973122937, 3120.7971481853833, 3154.9842250788597, 3177.952330715041, 3178.1895616617844, 1065.5045403887152, 1069.5294070608907, 1085.3921803789904, 1123.7303047268679, 1128.8081026225561, 9793.510324483746, 9853.211743060538, 9878.407295562289, 9908.058734420218, 9918.504074796232, 4092.202020606013, 4125.443065186221, 4188.434561334242, 4193.18232944579, 4197.769122698281, 8111.067227268822, 8155.918440815516, 8163.79590510242, 8167.673293068211, 8170.673173073129, 4654.069186162713, 4669.556392142741, 4681.274402467623, 4718.528147185322, 4721.5986641135205, 4251.4685664291965, 4330.783460826946, 4332.960089578479, 4342.413774140514, 4355.107203023373, 3440.0539851541025, 3473.878414255489, 3506.403911335028, 3521.5774107107313, 3549.680528752373, 1082.112667612566, 1101.581399068349, 1107.3023994883172, 1129.0403157316216, 1140.6292954789726, 822.5558198572704, 825.9752207433787, 832.8792325112825, 924.912133347331, 949.1362859797551, 6943.270956549591, 6960.0, 6982.546134501343, 7017.649117544204, 7018.157821061505, 1108.5288752280248, 1112.732944093428, 1114.8461342510464, 1122.7698321844002, 1144.6852115668091, 5384.596155288291, 5435.103207970719, 5499.50504454601, 5500.614956953055, 5512.972435137799, 8667.739967800977, 8680.565971701515, 8802.779930501789, 8841.69054083104, 8888.955555222183, 8680.392372533863, 8732.0, 8744.431611945203, 8746.300295976307, 8798.47209167452, 6986.196587392414, 7045.7181712731945, 7142.4286057115305, 7164.9641751790905, 7230.927690723131, 6652.268250492539, 6674.065630811788, 6697.2633010367845, 6700.396964273239, 6708.42978346846, 7813.218678132142, 8020.598970051591, 8032.236937490929, 8062.072861620754, 8171.591420429074, 7950.24472675095, 8150.062742784656, 8225.465344752572, 8293.792655183668, 8313.293370063613, 6093.390660933871, 6165.84585385369, 6468.741250349934, 6566.606003639797, 6573.80278591643, 7023.859522809617, 7108.0, 7119.074520312326, 7119.2168861426235, 7130.180029296697, 6716.966415167893, 6740.528163028737, 6778.796636100925, 6842.965785171043, 6847.075644788089, 6328.240611126695, 6529.216494020558, 6568.9014664781025, 6684.131062961784, 6795.660216989229, 6600.2409722882485, 6627.9337206627315, 6633.6019838809825, 6639.6680165992475, 6675.566088204251, 6135.07973803933, 6192.845178870384, 6194.0708893664505, 6199.876002479835, 6200.844978875564, 6155.84610384744, 6186.1648677427975, 6187.195664563578, 6220.813375598739, 6294.055891616111], "unit": "score", "name": "mootools.html", "value": 4329.368666290785}, {"lowerIsBetter": false, "replicates": [338.47874273618623, 343.61171875780366, 346.1312106612405, 348.1765624298534, 349.69576468472417, 6142.232220972379, 6216.445888527868, 6278.68606569672, 6334.556581039329, 6379.17070780799, 6070.150178974936, 6168.043953187252, 6203.782867599635, 6221.346758590351, 6237.719302631381, 4800.519948005198, 4817.421909370881, 4831.613470922318, 4840.0, 4851.27230915362, 4844.20070688336, 4846.927296090544, 4853.223484242522, 4855.053264613402, 4862.197737373329, 4717.740524271164, 4783.736894470802, 4789.640776941726, 4804.351412559312, 4814.061258054663, 4761.119192949315, 4763.904721905577, 4775.331453596499, 4777.450593181794, 4785.68893021956, 4011.4183443400543, 4114.670826333886, 4187.267228235077, 4188.518320393163, 4195.244855925932, 5918.733656985403, 5932.822015339503, 5954.642721436728, 5957.344692083867, 6022.0, 5485.890282194334, 5504.366997795265, 5506.476884695948, 5523.751431185607, 5567.081431563787, 6513.544051916368, 6570.408663220333, 6580.078788969548, 6582.637954912478, 6631.1379520662, 4542.636589072867, 4560.726356418625, 4561.817527298904, 4565.794539245742, 4582.725036497821, 6917.100776899021, 6931.480138989596, 6971.930280697229, 6977.93022069783, 6983.89524157138, 4616.307553866947, 4652.511486293958, 4658.417697787777, 4662.906741865211, 4681.110588988149, 4569.543045695404, 4671.556202160789, 4671.906561868812, 4727.2909063640045, 4774.188387974053, 5518.33779946409, 5523.309586301712, 5526.447355264441, 5535.25274087993, 5548.278723765965, 6678.96660516704, 6686.0, 6701.463882889358, 6708.731650734014, 6724.831879203059, 1665.6751933372875, 1674.1880188109, 1676.1954261954331, 1678.9748153777703, 1681.9495415137565, 1085.473545330514, 1094.0481780850712, 1108.1578000719512, 1123.0959077942334, 1129.6441620889393, 6289.811305660837, 6290.528210384239, 6298.685065746786, 6305.887527678279, 6315.273743519462, 6817.181938167451, 6864.622445765531, 6873.0, 6902.033715279765, 6912.585244885323, 6105.633661980295, 6242.968785156136, 6263.248410190715, 6270.811875643738, 6283.748650053946, 3682.3739964206147, 3727.8322475488667, 3738.971782759763, 3745.4943582615997, 3751.0, 7010.123734533184, 7184.9640751795905, 7222.422206223489, 7230.530015549078, 7242.0, 7051.753188638476, 7057.400120989773, 7058.0, 7080.548487560038, 7115.53749006313, 7086.610236436943, 7167.068281123525, 7171.92828071723, 7194.280571942764, 7260.4554658399775, 6893.379595836399, 6935.3411425914455, 6941.514094013371, 6941.618210998242, 6944.166699996033, 6841.657917104026, 6882.931170688229, 6888.690008949509, 6890.827729306808, 6898.172219333712, 7090.6100164491445, 7232.602206878672, 7239.986401903632, 7240.601766902871, 7256.346928776436, 4591.311303304531, 4597.149527337453, 4602.585767280961, 4609.331646911112, 4611.538846115362, 6924.896126558207, 6942.791716248521, 6960.338767817049, 6963.303669632996, 6991.440684745106, 6629.5359324846795, 6777.864442711217, 6779.694913728993, 6790.898136528055, 6791.185057793096, 6757.222919364336, 6762.188537375349, 6766.323367663194, 6768.492363072691, 6780.288069752605, 6591.406773390418, 6628.204615446178, 6639.502037347122, 6650.534462587766, 6670.966645166744, 6647.069410282467, 6772.153480814898, 6801.761938332134, 6816.284290149463, 6819.4544436443975, 6620.602763833993, 6647.434968027772, 6649.567778094602, 6649.667516624246, 6659.866802663822], "unit": "score", "name": "prototype.html", "value": 5020.261804419324}, {"lowerIsBetter": false, "replicates": [750.4146765522893, 782.2842099478976, 800.8518424091543, 843.350620022583, 852.7356519478966, 13099.54151604694, 13191.868081319184, 13230.735385292312, 13256.469741210352, 13267.071305008642, 12480.313582752944, 12536.247825130498, 12609.30648814315, 12637.55768548101, 12637.747245055094, 781.6990458673409, 799.7081065411141, 800.7517669522438, 801.8316153607749, 804.0672819529348, 795.5902710104301, 797.5135167547792, 801.6432687454085, 805.3959530352236, 805.4241217529466, 825.2160447574798, 831.5883637599396, 836.3016880904452, 837.1879277101233, 838.6771093129158, 823.8311146215011, 824.756696774453, 825.9174082591722, 826.4834478450969, 829.274384913201, 604.7822783797873, 611.3641812514979, 611.3672349118685, 614.342653360904, 615.6521565315583, 13546.59360219195, 13556.932215338958, 13636.454541818415, 13646.658833529142, 13647.727045459134, 12267.0, 12297.139200255986, 12466.563670271496, 12615.873841261562, 12820.931648426751, 10321.896781032168, 10330.328528645688, 10363.274570780048, 10595.841062383994, 10635.415052172128, 3471.444568868994, 3506.1760486285702, 3546.929061418757, 3591.6947059499976, 3594.28114377123, 43675.12649746987, 43924.780376098235, 43941.78029109866, 43978.56021439777, 44143.0, 8605.483670979762, 8839.646414143492, 8849.380543361904, 8897.777555561033, 8909.955450222837, 15483.5354939352, 15549.766753498707, 15549.922250388676, 15568.532944011698, 15591.610209744847, 7530.359919406912, 7584.734534291384, 7601.923980760233, 7603.0876294844975, 7606.505577137468, 4153.626173644387, 4163.687723420756, 4183.079722461053, 4190.392393102983, 4378.715383500063, 3036.2864726789185, 3047.116336262459, 3060.7857449978733, 3064.831434271092, 3068.064240406653, 535.143769968048, 544.2353493341861, 545.4790674905456, 554.6200852416108, 556.7578103524979, 653.5817077070678, 664.2394458345168, 668.5787953589207, 680.6222546486648, 691.3294104718415, 7883.802904927423, 8085.5957202140835, 8132.878006829902, 8338.332933365316, 8440.45137066101, 525.6898429926362, 659.0865100674556, 692.6458773098581, 702.9543079699803, 728.4712496350279, 3827.5789663137034, 4092.7748973806133, 4181.184668989518, 4300.204462174445, 4302.290122129876, 51780.482195178316, 52128.47871521236, 52508.21237681438, 53291.73354133205, 59085.409145907994, 49350.0, 50616.49383506118, 51439.0, 51674.48325516772, 51676.74161629243, 44060.118797623865, 44552.77723611426, 44796.0, 45457.54542454599, 45909.7704511482, 8867.403867303947, 8881.200691937498, 8993.010768815557, 9075.0, 9177.495237761987, 32593.511097333085, 33025.83487082549, 33398.66601334053, 34035.0, 34060.31879362449, 40479.0, 40927.1814563713, 45026.54973450224, 45994.77002614966, 46065.30902036405, 10444.373337599769, 10638.361698298128, 10881.401522916316, 10964.945175274073, 11272.267302625303, 11283.548658053585, 11639.6508104757, 12363.32001739913, 12479.688007799878, 12824.102312838386, 11231.26996745209, 11231.494582743633, 11311.264767790068, 11393.202475826612, 11465.19743617972, 10667.573297068031, 10733.785324293314, 10804.945975270073, 11478.385052512716, 11622.128340374336, 10568.154547636017, 10843.0, 10867.184961128105, 11363.318200907972, 11371.43142842871, 9808.705738827846, 9849.507524623883, 10006.249531285328, 10161.062052743871, 10184.134348580157, 8742.300615950835, 8943.776405589912, 9010.324225682969, 9540.141387275178, 9565.139137477661], "unit": "score", "name": "yui.html", "value": 6179.415441780004}], "name": "dromaeo_css", "value": 6792.327787303403}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 111.0, 110.0, 112.0, 124.0, 111.0, 110.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [155.0, 127.0, 151.0, 163.0, 130.0, 149.0, 156.0, 135.0, 168.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 162.0, 166.0, 163.0, 160.0, 164.0, 165.0, 168.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 74.0, 73.0, 74.0, 129.0, 73.0, 73.0, 74.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 151.0, 96.0, 100.0, 98.0, 140.0, 97.0, 96.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 97.0, 96.0, 97.0, 97.0, 97.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 61.0, 58.0, 60.0, 60.0, 58.0, 59.0, 68.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 60.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [81.0, 88.0, 83.0, 84.0, 84.0, 87.0, 83.0, 81.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [123.0, 119.0, 118.0, 120.0, 132.0, 116.0, 117.0, 120.0, 119.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.3}, {"lowerIsBetter": true, "replicates": [128.0, 144.0, 129.0, 149.0, 145.0, 144.0, 148.0, 138.0, 141.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.6}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 68.0, 70.0, 68.0, 68.0, 67.0, 66.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1504.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.77785190126752], "unit": "score", "name": "Richards", "value": 211.67079199999998}, {"lowerIsBetter": false, "replicates": [190.69412662090008], "unit": "score", "name": "DeltaBlue", "value": 346.72279200000014}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [5235.602094240838], "unit": "score", "name": "Decrypt", "value": 50.84057100000005}, {"lowerIsBetter": false, "replicates": [1081.081081081081], "unit": "score", "name": "RayTrace", "value": 684.4898250000002}, {"lowerIsBetter": false, "replicates": [713.7758743754462], "unit": "score", "name": "Earley", "value": 933.7146630000002}, {"lowerIsBetter": false, "replicates": [12304.878048780487], "unit": "score", "name": "Boyer", "value": 54.16250346878094}, {"lowerIsBetter": false, "replicates": [40640.0], "unit": "score", "name": "RegExp", "value": 22.41596948818897}, {"lowerIsBetter": false, "replicates": [638.9776357827476], "unit": "score", "name": "Splay", "value": 127.53341499999998}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20213.38858405269}]} 05:51:22 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20213.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1505.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6792.33"}}} 05:51:22 INFO - Return code: 0 05:51:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:51:22 INFO - # TBPL SUCCESS # 05:51:22 INFO - Running post-action listener: _resource_record_post_action 05:51:22 INFO - Running post-run listener: _resource_record_post_run 05:51:23 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 20480; Write bytes: 557772800; Read time: 148; Write time: 628644 05:51:23 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245977088; Read time: 0; Write time: 304952 05:51:23 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 20480; Write bytes: 311795712; Read time: 148; Write time: 323692 05:51:23 INFO - Running post-run listener: _upload_blobber_files 05:51:23 INFO - Blob upload gear active. 05:51:23 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:51:23 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:51:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:51:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:51:24 INFO - (blobuploader) - INFO - Open directory for files ... 05:51:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:51:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:51:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:25 INFO - (blobuploader) - INFO - Done attempting. 05:51:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:51:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:51:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:26 INFO - (blobuploader) - INFO - Done attempting. 05:51:26 INFO - (blobuploader) - INFO - Iteration through files over. 05:51:26 INFO - Return code: 0 05:51:26 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:51:26 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:51:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b4b9644683065b0d92946d375bbf047ba764159184d204260277b7c421e9761f2082060f2fc9a8f0b0124ea842c861de222b59b9ca58d375c5c767bfcdd43d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77307d300f60691ad7594fc6f410f12eb3ea53d580d95df4dcb968bcc4e134ab7dad140bd6958e897c2f9bc5742b2c6c32427f65faf8b56f40802a8d2b0b1334"} 05:51:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:51:26 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:51:26 INFO - Contents: 05:51:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b4b9644683065b0d92946d375bbf047ba764159184d204260277b7c421e9761f2082060f2fc9a8f0b0124ea842c861de222b59b9ca58d375c5c767bfcdd43d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77307d300f60691ad7594fc6f410f12eb3ea53d580d95df4dcb968bcc4e134ab7dad140bd6958e897c2f9bc5742b2c6c32427f65faf8b56f40802a8d2b0b1334"} 05:51:26 INFO - Running post-run listener: copy_logs_to_upload_dir 05:51:26 INFO - Copying logs to upload dir... 05:51:26 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:51:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.448624 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-23 05:51:25.480845) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-23 05:51:25.484575) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b4b9644683065b0d92946d375bbf047ba764159184d204260277b7c421e9761f2082060f2fc9a8f0b0124ea842c861de222b59b9ca58d375c5c767bfcdd43d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77307d300f60691ad7594fc6f410f12eb3ea53d580d95df4dcb968bcc4e134ab7dad140bd6958e897c2f9bc5742b2c6c32427f65faf8b56f40802a8d2b0b1334"} build_url:https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011240 build_url: 'https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b4b9644683065b0d92946d375bbf047ba764159184d204260277b7c421e9761f2082060f2fc9a8f0b0124ea842c861de222b59b9ca58d375c5c767bfcdd43d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77307d300f60691ad7594fc6f410f12eb3ea53d580d95df4dcb968bcc4e134ab7dad140bd6958e897c2f9bc5742b2c6c32427f65faf8b56f40802a8d2b0b1334"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-23 05:51:25.512135) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 05:51:25.512714) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1453537697.992585-1126455980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 05:51:25.596758) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 05:51:25.597222) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 05:51:25.597751) ========= ========= Total master_lag: 0.24 =========