builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1460251238.37 results: success (0) buildid: 20160409133033 builduid: 8b0460fdefc941d48d728a298da9bd0d revision: 7a50cf3a5b570222108d96cbe71b48850f570c61 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:38.372417) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:38.373004) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:38.373398) ========= 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=ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004865 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.17 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:38.548833) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:38.549660) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:39.493299) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:39.493739) ========= 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=ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.040522 ========= master_lag: 0.68 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:40.219244) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:40.219592) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:40.220003) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:40.220335) ========= 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=ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-09 18:20:40-- 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% 228M=0s 2016-04-09 18:20:40 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.270611 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:40.567426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:40.567764) ========= 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=ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.226229 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:40.869920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:40.870278) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7a50cf3a5b570222108d96cbe71b48850f570c61 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7a50cf3a5b570222108d96cbe71b48850f570c61 --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=ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-09 18:20:41,034 truncating revision to first 12 chars 2016-04-09 18:20:41,034 Setting DEBUG logging. 2016-04-09 18:20:41,034 attempt 1/10 2016-04-09 18:20:41,034 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7a50cf3a5b57?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-09 18:20:41,372 unpacking tar archive at: mozilla-inbound-7a50cf3a5b57/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643418 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:41.596517) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:41.597418) ========= echo 7a50cf3a5b570222108d96cbe71b48850f570c61 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7a50cf3a5b570222108d96cbe71b48850f570c61'] 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=ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7a50cf3a5b570222108d96cbe71b48850f570c61 program finished with exit code 0 elapsedTime=0.004739 script_repo_revision: '7a50cf3a5b570222108d96cbe71b48850f570c61' ========= master_lag: 0.20 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:41.800898) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:41.801308) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-09 18:20:42.111151) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2016-04-09 18:20:42.111648) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:20:42 INFO - MultiFileLogger online at 20160409 18:20:42 in /builds/slave/test-pgo 18:20:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:20:42 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:20:42 INFO - {'append_to_log': False, 18:20:42 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:20:42 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:20:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:20:42 INFO - 'branch': 'Mozilla-Inbound', 18:20:42 INFO - 'buildbot_json_path': 'buildprops.json', 18:20:42 INFO - 'config_files': ('talos/linux_config.py',), 18:20:42 INFO - 'default_actions': ('clobber', 18:20:42 INFO - 'read-buildbot-config', 18:20:42 INFO - 'download-and-extract', 18:20:42 INFO - 'populate-webroot', 18:20:42 INFO - 'create-virtualenv', 18:20:42 INFO - 'install', 18:20:42 INFO - 'run-tests'), 18:20:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:20:42 INFO - 'download_minidump_stackwalk': True, 18:20:42 INFO - 'download_symbols': 'ondemand', 18:20:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:20:42 INFO - 'tooltool.py': '/tools/tooltool.py', 18:20:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:20:42 INFO - '/tools/misc-python/virtualenv.py')}, 18:20:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:20:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:20:42 INFO - 'installer_path': 'installer.exe', 18:20:42 INFO - 'log_level': 'info', 18:20:42 INFO - 'log_name': 'talos', 18:20:42 INFO - 'log_to_console': True, 18:20:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:20:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:20:42 INFO - 'opt_config_files': (), 18:20:42 INFO - 'pip_index': False, 18:20:42 INFO - 'sps_profile': False, 18:20:42 INFO - 'sps_profile_interval': 0, 18:20:42 INFO - 'suite': 'dromaeojs-e10s', 18:20:42 INFO - 'system_bits': '32', 18:20:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:20:42 INFO - 'title': 'talos-linux64-ix-035', 18:20:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:20:42 INFO - 'use_talos_json': True, 18:20:42 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:20:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:20:42 INFO - 'work_dir': 'build'} 18:20:42 INFO - ##### 18:20:42 INFO - ##### Running clobber step. 18:20:42 INFO - ##### 18:20:42 INFO - Running pre-action listener: _resource_record_pre_action 18:20:42 INFO - Running main action method: clobber 18:20:42 INFO - rmtree: /builds/slave/test-pgo/build 18:20:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:20:43 INFO - Running post-action listener: _resource_record_post_action 18:20:43 INFO - ##### 18:20:43 INFO - ##### Running read-buildbot-config step. 18:20:43 INFO - ##### 18:20:43 INFO - Running pre-action listener: _resource_record_pre_action 18:20:43 INFO - Running main action method: read_buildbot_config 18:20:43 INFO - Using buildbot properties: 18:20:43 INFO - { 18:20:43 INFO - "project": "", 18:20:43 INFO - "product": "firefox", 18:20:43 INFO - "script_repo_revision": "production", 18:20:43 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 18:20:43 INFO - "repository": "", 18:20:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 18:20:43 INFO - "buildid": "20160409133033", 18:20:43 INFO - "pgo_build": "True", 18:20:43 INFO - "basedir": "/builds/slave/test-pgo", 18:20:43 INFO - "buildnumber": 463, 18:20:43 INFO - "slavename": "talos-linux64-ix-035", 18:20:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:20:43 INFO - "platform": "ubuntu64_hw", 18:20:43 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:20:43 INFO - "branch": "mozilla-inbound", 18:20:43 INFO - "repo_path": "integration/mozilla-inbound", 18:20:43 INFO - "revision": "7a50cf3a5b570222108d96cbe71b48850f570c61", 18:20:43 INFO - "stage_platform": "linux64-pgo", 18:20:43 INFO - "builduid": "8b0460fdefc941d48d728a298da9bd0d", 18:20:43 INFO - "slavebuilddir": "test" 18:20:43 INFO - } 18:20:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:20:43 INFO - Running post-action listener: _resource_record_post_action 18:20:43 INFO - ##### 18:20:43 INFO - ##### Running download-and-extract step. 18:20:43 INFO - ##### 18:20:43 INFO - Running pre-action listener: _resource_record_pre_action 18:20:43 INFO - Running main action method: download_and_extract 18:20:43 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:20: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')]} 18:20:43 INFO - https://queue.taskcluster.net/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:20:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:20:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:20:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:20:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:20:45 INFO - Downloaded 1361 bytes. 18:20:45 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:20:45 INFO - Using the following test package requirements: 18:20:45 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:20:45 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:20:45 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:20:45 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:45 INFO - u'jsshell-linux-x86_64.zip'], 18:20:45 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:20:45 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:20:45 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:20:45 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:20:45 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:20:45 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:20:45 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:20:45 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')]} 18:20:45 INFO - https://queue.taskcluster.net/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:20:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:20:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:20:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:20:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:21:03 INFO - Downloaded 23762388 bytes. 18:21:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:21:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:21:05 INFO - Return code: 0 18:21:05 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:21:05 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')]} 18:21:05 INFO - https://queue.taskcluster.net/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:21:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:21:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:21:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:21:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:21:25 INFO - Downloaded 23762388 bytes. 18:21:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:21:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:21:26 INFO - Return code: 0 18:21: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')]} 18:21:26 INFO - https://queue.taskcluster.net/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:21:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:21:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:21:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:21:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:21:34 INFO - Downloaded 10841046 bytes. 18:21:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:21:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 18:21:34 INFO - Return code: 0 18:21: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')]} 18:21:34 INFO - https://queue.taskcluster.net/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:21:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:21:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:21:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:21:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:21:37 INFO - Downloaded 57797236 bytes. 18:21:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:21:37 INFO - mkdir: /builds/slave/test-pgo/properties 18:21:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:21:37 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:21:37 INFO - Contents: 18:21:37 INFO - build_url:https://queue.taskcluster.net/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:21:38 INFO - Running post-action listener: _resource_record_post_action 18:21:38 INFO - Running post-action listener: set_extra_try_arguments 18:21:38 INFO - ##### 18:21:38 INFO - ##### Running populate-webroot step. 18:21:38 INFO - ##### 18:21:38 INFO - Running pre-action listener: _resource_record_pre_action 18:21:38 INFO - Running main action method: populate_webroot 18:21:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:21:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:21:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:21:38 INFO - '--tppagecycles', 18:21:38 INFO - '7'], 18:21:38 INFO - 'tests': ['tsvgm']}}, 18:21:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:21:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:21:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:21:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:21:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:21:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:21:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:38 INFO - 'talos_options': ['--disable-e10s'], 18:21:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:21:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:21:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:38 INFO - 'talos_options': ['--disable-e10s'], 18:21:38 INFO - 'tests': ['damp', 'tps']}, 18:21:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:38 INFO - 'tests': ['damp', 'tps']}, 18:21:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:21:38 INFO - 'tests': ['dromaeo_dom']}, 18:21:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:21:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:21:38 INFO - 'tests': ['a11yr', 18:21:38 INFO - 'ts_paint', 18:21:38 INFO - 'tpaint', 18:21:38 INFO - 'sessionrestore', 18:21:38 INFO - 'sessionrestore_no_auto_restore', 18:21:38 INFO - 'tabpaint']}, 18:21:38 INFO - 'other-e10s': {'tests': ['a11yr', 18:21:38 INFO - 'ts_paint', 18:21:38 INFO - 'tpaint', 18:21:38 INFO - 'sessionrestore', 18:21:38 INFO - 'sessionrestore_no_auto_restore', 18:21:38 INFO - 'tabpaint']}, 18:21:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:21:38 INFO - 'ts_paint', 18:21:38 INFO - 'tpaint', 18:21:38 INFO - 'sessionrestore', 18:21:38 INFO - 'sessionrestore_no_auto_restore', 18:21:38 INFO - 'tabpaint']}, 18:21:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:21:38 INFO - 'ts_paint', 18:21:38 INFO - 'tpaint', 18:21:38 INFO - 'sessionrestore', 18:21:38 INFO - 'sessionrestore_no_auto_restore', 18:21:38 INFO - 'tabpaint']}, 18:21:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:21:38 INFO - 'tests': ['a11yr', 18:21:38 INFO - 'ts_paint', 18:21:38 INFO - 'tpaint', 18:21:38 INFO - 'sessionrestore', 18:21:38 INFO - 'sessionrestore_no_auto_restore', 18:21:38 INFO - 'tabpaint']}, 18:21:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:21:38 INFO - 'tests': ['a11yr', 18:21:38 INFO - 'ts_paint', 18:21:38 INFO - 'tpaint', 18:21:38 INFO - 'sessionrestore', 18:21:38 INFO - 'sessionrestore_no_auto_restore', 18:21:38 INFO - 'tabpaint']}, 18:21:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:21:38 INFO - 'tests': ['tsvgx', 18:21:38 INFO - 'tsvgr_opacity', 18:21:38 INFO - 'tart', 18:21:38 INFO - 'tscrollx', 18:21:38 INFO - 'cart']}, 18:21:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:21:38 INFO - 'tsvgr_opacity', 18:21:38 INFO - 'tart', 18:21:38 INFO - 'tscrollx', 18:21:38 INFO - 'cart']}, 18:21:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:38 INFO - 'talos_options': ['--disable-e10s'], 18:21:38 INFO - 'tests': ['tp5o']}, 18:21:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:38 INFO - 'tests': ['tp5o']}, 18:21:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:38 INFO - 'talos_options': ['--disable-e10s', 18:21:38 INFO - '--xperf_path', 18:21:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:21:38 INFO - 'tests': ['tp5n']}, 18:21:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:38 INFO - 'talos_options': ['--xperf_path', 18:21:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:21:38 INFO - 'tests': ['tp5n']}}, 18:21:38 INFO - 'talos.zip': {'path': '', 18:21:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:21:38 INFO - Running post-action listener: _resource_record_post_action 18:21:38 INFO - ##### 18:21:38 INFO - ##### Running create-virtualenv step. 18:21:38 INFO - ##### 18:21:38 INFO - Running pre-action listener: _resource_record_pre_action 18:21:38 INFO - Running main action method: create_virtualenv 18:21:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:21:38 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 18:21:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:21:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:21:38 INFO - Using real prefix '/usr' 18:21:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:21:39 INFO - Installing distribute.............................................................................................................................................................................................done. 18:21:41 INFO - Installing pip.................done. 18:21:41 INFO - Return code: 0 18:21:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:21:41 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')]} 18:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:41 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')]} 18:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:41 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 0x7f74e1bd4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f708d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fff8b0>, '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 0x20007b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000c60>, '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': 'ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313', '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 18:21:41 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 18:21:41 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 18:21:41 INFO - Using env: {'DISPLAY': ':0', 18:21:41 INFO - 'HOME': '/home/cltbld', 18:21:41 INFO - 'LANG': 'en_US.UTF-8', 18:21:41 INFO - 'LANGUAGE': 'en_US:en', 18:21:41 INFO - 'LOGNAME': 'cltbld', 18:21:41 INFO - 'MAIL': '/var/mail/cltbld', 18:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:41 INFO - 'MOZ_NO_REMOTE': '1', 18:21:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:41 INFO - 'NO_EM_RESTART': '1', 18:21:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:21:41 INFO - 'PWD': '/builds/slave/test-pgo', 18:21:41 INFO - 'SHELL': '/bin/bash', 18:21:41 INFO - 'SHLVL': '1', 18:21:41 INFO - 'TERM': 'linux', 18:21:41 INFO - 'TMOUT': '86400', 18:21:41 INFO - 'USER': 'cltbld', 18:21:41 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313', 18:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:41 INFO - '_': '/tools/buildbot/bin/python'} 18:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:41 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 18:21:41 INFO - Cleaning up... 18:21:41 INFO - Return code: 0 18:21:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:21:41 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')]} 18:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:41 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')]} 18:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:41 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 0x7f74e1bd4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f708d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fff8b0>, '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 0x20007b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000c60>, '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': 'ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313', '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 18:21:41 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 18:21:41 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 18:21:41 INFO - Using env: {'DISPLAY': ':0', 18:21:41 INFO - 'HOME': '/home/cltbld', 18:21:41 INFO - 'LANG': 'en_US.UTF-8', 18:21:41 INFO - 'LANGUAGE': 'en_US:en', 18:21:41 INFO - 'LOGNAME': 'cltbld', 18:21:41 INFO - 'MAIL': '/var/mail/cltbld', 18:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:41 INFO - 'MOZ_NO_REMOTE': '1', 18:21:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:41 INFO - 'NO_EM_RESTART': '1', 18:21:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:21:41 INFO - 'PWD': '/builds/slave/test-pgo', 18:21:41 INFO - 'SHELL': '/bin/bash', 18:21:41 INFO - 'SHLVL': '1', 18:21:41 INFO - 'TERM': 'linux', 18:21:41 INFO - 'TMOUT': '86400', 18:21:41 INFO - 'USER': 'cltbld', 18:21:41 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313', 18:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:41 INFO - '_': '/tools/buildbot/bin/python'} 18:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:41 INFO - Downloading/unpacking psutil>=0.7.1 18:21:41 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 18:21:41 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 18:21:41 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 18:21:41 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 18:21:41 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 18:21:41 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 18:21:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:21:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:21:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:21:48 INFO - Installing collected packages: psutil 18:21:48 INFO - Running setup.py install for psutil 18:21:48 INFO - building 'psutil._psutil_linux' extension 18:21:48 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 18:21:49 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 18:21:49 INFO - building 'psutil._psutil_posix' extension 18:21:49 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 18:21:50 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 18:21:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:21:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:21:50 INFO - Successfully installed psutil 18:21:50 INFO - Cleaning up... 18:21:50 INFO - Return code: 0 18:21:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:21:50 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')]} 18:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:50 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')]} 18:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:50 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 0x7f74e1bd4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f708d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fff8b0>, '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 0x20007b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000c60>, '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': 'ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313', '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 18:21:50 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 18:21:50 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 18:21:50 INFO - Using env: {'DISPLAY': ':0', 18:21:50 INFO - 'HOME': '/home/cltbld', 18:21:50 INFO - 'LANG': 'en_US.UTF-8', 18:21:50 INFO - 'LANGUAGE': 'en_US:en', 18:21:50 INFO - 'LOGNAME': 'cltbld', 18:21:50 INFO - 'MAIL': '/var/mail/cltbld', 18:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:50 INFO - 'MOZ_NO_REMOTE': '1', 18:21:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:50 INFO - 'NO_EM_RESTART': '1', 18:21:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:21:50 INFO - 'PWD': '/builds/slave/test-pgo', 18:21:50 INFO - 'SHELL': '/bin/bash', 18:21:50 INFO - 'SHLVL': '1', 18:21:50 INFO - 'TERM': 'linux', 18:21:50 INFO - 'TMOUT': '86400', 18:21:50 INFO - 'USER': 'cltbld', 18:21:50 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313', 18:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:50 INFO - '_': '/tools/buildbot/bin/python'} 18:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:21:50 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 18:21:50 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 18:21:50 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 18:21:50 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 18:21:50 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 18:21:50 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 18:21:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:21:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:21:56 INFO - Installing collected packages: mozsystemmonitor 18:21:56 INFO - Running setup.py install for mozsystemmonitor 18:21:56 INFO - Successfully installed mozsystemmonitor 18:21:56 INFO - Cleaning up... 18:21:56 INFO - Return code: 0 18:21:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:21:56 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')]} 18:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:56 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')]} 18:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:56 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 0x7f74e1bd4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f708d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fff8b0>, '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 0x20007b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000c60>, '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': 'ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313', '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 18:21:56 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 18:21:56 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 18:21:56 INFO - Using env: {'DISPLAY': ':0', 18:21:56 INFO - 'HOME': '/home/cltbld', 18:21:56 INFO - 'LANG': 'en_US.UTF-8', 18:21:56 INFO - 'LANGUAGE': 'en_US:en', 18:21:56 INFO - 'LOGNAME': 'cltbld', 18:21:56 INFO - 'MAIL': '/var/mail/cltbld', 18:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:56 INFO - 'MOZ_NO_REMOTE': '1', 18:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:56 INFO - 'NO_EM_RESTART': '1', 18:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:21:56 INFO - 'PWD': '/builds/slave/test-pgo', 18:21:56 INFO - 'SHELL': '/bin/bash', 18:21:56 INFO - 'SHLVL': '1', 18:21:56 INFO - 'TERM': 'linux', 18:21:56 INFO - 'TMOUT': '86400', 18:21:56 INFO - 'USER': 'cltbld', 18:21:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313', 18:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:56 INFO - '_': '/tools/buildbot/bin/python'} 18:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:57 INFO - Downloading/unpacking blobuploader==1.2.4 18:21:57 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 18:21:57 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 18:21:57 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 18:21:57 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 18:21:57 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 18:21:57 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 18:22:02 INFO - Downloading blobuploader-1.2.4.tar.gz 18:22:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:22:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:22:02 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 18:22:02 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 18:22:02 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 18:22:02 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 18:22:02 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 18:22:02 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 18:22:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:22:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:22:04 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 18:22:04 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 18:22:04 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 18:22:04 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 18:22:04 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 18:22:04 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 18:22:04 INFO - Downloading docopt-0.6.1.tar.gz 18:22:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:22:04 INFO - Installing collected packages: blobuploader, requests, docopt 18:22:04 INFO - Running setup.py install for blobuploader 18:22:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:22:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:22:04 INFO - Running setup.py install for requests 18:22:05 INFO - Running setup.py install for docopt 18:22:05 INFO - Successfully installed blobuploader requests docopt 18:22:05 INFO - Cleaning up... 18:22:05 INFO - Return code: 0 18:22:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:22:05 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')]} 18:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:05 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')]} 18:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:05 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 0x7f74e1bd4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f708d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fff8b0>, '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 0x20007b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000c60>, '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': 'ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313', '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 18:22:05 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 18:22:05 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 18:22:05 INFO - Using env: {'DISPLAY': ':0', 18:22:05 INFO - 'HOME': '/home/cltbld', 18:22:05 INFO - 'LANG': 'en_US.UTF-8', 18:22:05 INFO - 'LANGUAGE': 'en_US:en', 18:22:05 INFO - 'LOGNAME': 'cltbld', 18:22:05 INFO - 'MAIL': '/var/mail/cltbld', 18:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:05 INFO - 'MOZ_NO_REMOTE': '1', 18:22:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:05 INFO - 'NO_EM_RESTART': '1', 18:22:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:22:05 INFO - 'PWD': '/builds/slave/test-pgo', 18:22:05 INFO - 'SHELL': '/bin/bash', 18:22:05 INFO - 'SHLVL': '1', 18:22:05 INFO - 'TERM': 'linux', 18:22:05 INFO - 'TMOUT': '86400', 18:22:05 INFO - 'USER': 'cltbld', 18:22:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313', 18:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:05 INFO - '_': '/tools/buildbot/bin/python'} 18:22:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:22:05 INFO - Running setup.py (path:/tmp/pip-K8kUw1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:22:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:22:05 INFO - Running setup.py (path:/tmp/pip-vk1BiU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:22:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:22:05 INFO - Running setup.py (path:/tmp/pip-xlXCob-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:22:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:22:05 INFO - Running setup.py (path:/tmp/pip-SQsVgm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:22:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:22:05 INFO - Running setup.py (path:/tmp/pip-ykTVC3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:22:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:22:05 INFO - Running setup.py (path:/tmp/pip-ovkBF8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:22:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:22:05 INFO - Running setup.py (path:/tmp/pip-R3eVPF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:22:06 INFO - Running setup.py (path:/tmp/pip-0oAXem-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:22:06 INFO - Running setup.py (path:/tmp/pip-iHUhUM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:22:06 INFO - Running setup.py (path:/tmp/pip-dfKaHO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:22:06 INFO - Running setup.py (path:/tmp/pip-t9OP42-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:22:06 INFO - Running setup.py (path:/tmp/pip-kQzFjG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:22:06 INFO - Running setup.py (path:/tmp/pip-2_69qS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:22:06 INFO - Running setup.py (path:/tmp/pip-hfvb8h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:22:06 INFO - Running setup.py (path:/tmp/pip-2g01Uv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:22:06 INFO - Running setup.py (path:/tmp/pip-kmcXqN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:22:06 INFO - Running setup.py (path:/tmp/pip-FIuNu7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:22:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:22:06 INFO - Running setup.py install for manifestparser 18:22:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:22:06 INFO - Running setup.py install for mozcrash 18:22:06 INFO - Running setup.py install for mozdebug 18:22:07 INFO - Running setup.py install for mozdevice 18:22:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:22:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:22:07 INFO - Running setup.py install for mozfile 18:22:07 INFO - Running setup.py install for mozhttpd 18:22:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:22:07 INFO - Running setup.py install for mozinfo 18:22:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:22:07 INFO - Running setup.py install for mozInstall 18:22:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:22:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:22:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:22:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:22:07 INFO - Running setup.py install for mozleak 18:22:07 INFO - Running setup.py install for mozlog 18:22:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:22:07 INFO - Running setup.py install for moznetwork 18:22:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:22:07 INFO - Running setup.py install for mozprocess 18:22:07 INFO - Running setup.py install for mozprofile 18:22:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:22:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:22:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:22:08 INFO - Running setup.py install for mozrunner 18:22:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:22:08 INFO - Running setup.py install for mozscreenshot 18:22:08 INFO - Running setup.py install for moztest 18:22:08 INFO - Running setup.py install for mozversion 18:22:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:22:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:22:08 INFO - Cleaning up... 18:22:08 INFO - Return code: 0 18:22:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:22: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')]} 18:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22: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')]} 18:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:08 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 0x7f74e1bd4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f708d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fff8b0>, '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 0x20007b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000c60>, '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': 'ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313', '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 18:22:08 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 18:22:08 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 18:22:08 INFO - Using env: {'DISPLAY': ':0', 18:22:08 INFO - 'HOME': '/home/cltbld', 18:22:08 INFO - 'LANG': 'en_US.UTF-8', 18:22:08 INFO - 'LANGUAGE': 'en_US:en', 18:22:08 INFO - 'LOGNAME': 'cltbld', 18:22:08 INFO - 'MAIL': '/var/mail/cltbld', 18:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:08 INFO - 'MOZ_NO_REMOTE': '1', 18:22:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:08 INFO - 'NO_EM_RESTART': '1', 18:22:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:22:08 INFO - 'PWD': '/builds/slave/test-pgo', 18:22:08 INFO - 'SHELL': '/bin/bash', 18:22:08 INFO - 'SHLVL': '1', 18:22:08 INFO - 'TERM': 'linux', 18:22:08 INFO - 'TMOUT': '86400', 18:22:08 INFO - 'USER': 'cltbld', 18:22:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313', 18:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:08 INFO - '_': '/tools/buildbot/bin/python'} 18:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:22:08 INFO - Running setup.py (path:/tmp/pip-WfbgDi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:22:08 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)) 18:22:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:22:08 INFO - Running setup.py (path:/tmp/pip-6DVmN2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:22:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 18:22:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:22:08 INFO - Running setup.py (path:/tmp/pip-Jxgj5w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:22:08 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)) 18:22:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:22:08 INFO - Running setup.py (path:/tmp/pip-4M12BU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:22:09 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)) 18:22:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:22:09 INFO - Running setup.py (path:/tmp/pip-etfuqQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:22:09 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)) 18:22:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:22:09 INFO - Running setup.py (path:/tmp/pip-TDWsBY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:22:09 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)) 18:22:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:22:09 INFO - Running setup.py (path:/tmp/pip-4zzsvq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:22:09 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)) 18:22:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:22:09 INFO - Running setup.py (path:/tmp/pip-vpANSb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:22:09 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)) 18:22:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:22:09 INFO - Running setup.py (path:/tmp/pip-Kk3k5_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:22:09 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)) 18:22:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:22:09 INFO - Running setup.py (path:/tmp/pip-6US8yR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:22:09 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)) 18:22:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:22:09 INFO - Running setup.py (path:/tmp/pip-jM3zo_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:22:09 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)) 18:22:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:22:09 INFO - Running setup.py (path:/tmp/pip-j0WeiC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:22:09 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)) 18:22:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:22:09 INFO - Running setup.py (path:/tmp/pip-EtpcaI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:22:09 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)) 18:22:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:22:09 INFO - Running setup.py (path:/tmp/pip-tTu9sZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:22:09 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)) 18:22:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:22:09 INFO - Running setup.py (path:/tmp/pip-93kv3x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:22:09 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)) 18:22:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:22:09 INFO - Running setup.py (path:/tmp/pip-MfzeFD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:22:09 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)) 18:22:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:22:09 INFO - Running setup.py (path:/tmp/pip-T86EWX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:22:09 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)) 18:22:10 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:22:10 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:22:10 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)) 18:22:10 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)) 18:22:10 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)) 18:22:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:22:10 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 18:22:10 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 18:22:10 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 18:22:10 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 18:22:10 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 18:22:10 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 18:22:15 INFO - Downloading blessings-1.6.tar.gz 18:22:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:22:15 INFO - Installing collected packages: blessings 18:22:15 INFO - Running setup.py install for blessings 18:22:15 INFO - Successfully installed blessings 18:22:15 INFO - Cleaning up... 18:22:15 INFO - Return code: 0 18:22:15 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:22:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:22:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:22:15 INFO - Reading from file tmpfile_stdout 18:22:15 INFO - Current package versions: 18:22:15 INFO - argparse == 1.2.1 18:22:15 INFO - blessings == 1.6 18:22:15 INFO - blobuploader == 1.2.4 18:22:15 INFO - docopt == 0.6.1 18:22:15 INFO - manifestparser == 1.1 18:22:15 INFO - mozInstall == 1.12 18:22:15 INFO - mozcrash == 0.17 18:22:15 INFO - mozdebug == 0.1 18:22:15 INFO - mozdevice == 0.48 18:22:15 INFO - mozfile == 1.2 18:22:15 INFO - mozhttpd == 0.7 18:22:15 INFO - mozinfo == 0.9 18:22:15 INFO - mozleak == 0.1 18:22:15 INFO - mozlog == 3.1 18:22:15 INFO - moznetwork == 0.27 18:22:15 INFO - mozprocess == 0.22 18:22:15 INFO - mozprofile == 0.28 18:22:15 INFO - mozrunner == 6.11 18:22:15 INFO - mozscreenshot == 0.1 18:22:15 INFO - mozsystemmonitor == 0.0 18:22:15 INFO - moztest == 0.7 18:22:15 INFO - mozversion == 1.4 18:22:15 INFO - psutil == 3.1.1 18:22:15 INFO - requests == 1.2.3 18:22:15 INFO - wsgiref == 0.1.2 18:22:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:22:15 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')]} 18:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:15 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')]} 18:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:15 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 0x7f74e1bd4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f708d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fff8b0>, '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 0x20007b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000c60>, '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': 'ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313', '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 18:22:15 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 18:22:15 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 18:22:15 INFO - Using env: {'DISPLAY': ':0', 18:22:15 INFO - 'HOME': '/home/cltbld', 18:22:15 INFO - 'LANG': 'en_US.UTF-8', 18:22:15 INFO - 'LANGUAGE': 'en_US:en', 18:22:15 INFO - 'LOGNAME': 'cltbld', 18:22:15 INFO - 'MAIL': '/var/mail/cltbld', 18:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:15 INFO - 'MOZ_NO_REMOTE': '1', 18:22:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:15 INFO - 'NO_EM_RESTART': '1', 18:22:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:22:15 INFO - 'PWD': '/builds/slave/test-pgo', 18:22:15 INFO - 'SHELL': '/bin/bash', 18:22:15 INFO - 'SHLVL': '1', 18:22:15 INFO - 'TERM': 'linux', 18:22:15 INFO - 'TMOUT': '86400', 18:22:15 INFO - 'USER': 'cltbld', 18:22:15 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313', 18:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:15 INFO - '_': '/tools/buildbot/bin/python'} 18:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:15 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)) 18:22:15 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)) 18:22:15 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)) 18:22:15 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)) 18:22:15 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)) 18:22:15 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)) 18:22:15 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)) 18:22:15 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)) 18:22:15 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)) 18:22:15 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)) 18:22:15 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)) 18:22:15 INFO - Cleaning up... 18:22:15 INFO - Return code: 0 18:22:15 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:22:15 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')]} 18:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:15 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')]} 18:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:15 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 0x7f74e1bd4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f708d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fff8b0>, '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 0x20007b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000c60>, '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': 'ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313', '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 18:22:15 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 18:22:15 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 18:22:15 INFO - Using env: {'DISPLAY': ':0', 18:22:15 INFO - 'HOME': '/home/cltbld', 18:22:15 INFO - 'LANG': 'en_US.UTF-8', 18:22:15 INFO - 'LANGUAGE': 'en_US:en', 18:22:15 INFO - 'LOGNAME': 'cltbld', 18:22:15 INFO - 'MAIL': '/var/mail/cltbld', 18:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:15 INFO - 'MOZ_NO_REMOTE': '1', 18:22:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:15 INFO - 'NO_EM_RESTART': '1', 18:22:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:22:15 INFO - 'PWD': '/builds/slave/test-pgo', 18:22:15 INFO - 'SHELL': '/bin/bash', 18:22:15 INFO - 'SHLVL': '1', 18:22:15 INFO - 'TERM': 'linux', 18:22:15 INFO - 'TMOUT': '86400', 18:22:15 INFO - 'USER': 'cltbld', 18:22:15 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313', 18:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:15 INFO - '_': '/tools/buildbot/bin/python'} 18:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:16 INFO - Downloading/unpacking jsonschema 18:22:16 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 18:22:16 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 18:22:16 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 18:22:16 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 18:22:16 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 18:22:16 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 18:22:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:22:21 INFO - Downloading/unpacking functools32 (from jsonschema) 18:22:21 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 18:22:21 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 18:22:21 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 18:22:21 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 18:22:21 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 18:22:21 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 18:22:21 INFO - Downloading functools32-3.2.3-2.tar.gz 18:22:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:22:21 INFO - warning: no files found matching '*.txt' 18:22:21 INFO - no previously-included directories found matching 'build' 18:22:21 INFO - no previously-included directories found matching 'dist' 18:22:21 INFO - no previously-included directories found matching '.git*' 18:22:21 INFO - Installing collected packages: jsonschema, functools32 18:22:21 INFO - Running setup.py install for functools32 18:22:21 INFO - warning: no files found matching '*.txt' 18:22:21 INFO - no previously-included directories found matching 'build' 18:22:21 INFO - no previously-included directories found matching 'dist' 18:22:21 INFO - no previously-included directories found matching '.git*' 18:22:21 INFO - Successfully installed jsonschema functools32 18:22:21 INFO - Cleaning up... 18:22:21 INFO - Return code: 0 18:22:21 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:22:21 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')]} 18:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:21 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')]} 18:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:21 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 0x7f74e1bd4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f708d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fff8b0>, '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 0x20007b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000c60>, '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': 'ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313', '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 18:22:21 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 18:22:21 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 18:22:21 INFO - Using env: {'DISPLAY': ':0', 18:22:21 INFO - 'HOME': '/home/cltbld', 18:22:21 INFO - 'LANG': 'en_US.UTF-8', 18:22:21 INFO - 'LANGUAGE': 'en_US:en', 18:22:21 INFO - 'LOGNAME': 'cltbld', 18:22:21 INFO - 'MAIL': '/var/mail/cltbld', 18:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:21 INFO - 'MOZ_NO_REMOTE': '1', 18:22:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:21 INFO - 'NO_EM_RESTART': '1', 18:22:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:22:21 INFO - 'PWD': '/builds/slave/test-pgo', 18:22:21 INFO - 'SHELL': '/bin/bash', 18:22:21 INFO - 'SHLVL': '1', 18:22:21 INFO - 'TERM': 'linux', 18:22:21 INFO - 'TMOUT': '86400', 18:22:21 INFO - 'USER': 'cltbld', 18:22:21 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313', 18:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:21 INFO - '_': '/tools/buildbot/bin/python'} 18:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:21 INFO - Downloading/unpacking flake8 18:22:21 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 18:22:21 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 18:22:21 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 18:22:21 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 18:22:21 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 18:22:21 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 18:22:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:22:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:22:27 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 18:22:27 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 18:22:27 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 18:22:27 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 18:22:27 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 18:22:27 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 18:22:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:22:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:22:27 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 18:22:27 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 18:22:27 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 18:22:27 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 18:22:27 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 18:22:27 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 18:22:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:22:28 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 18:22:28 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 18:22:28 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 18:22:28 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 18:22:28 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 18:22:28 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 18:22:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:22:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:22:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:22:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:22:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:22:29 INFO - no previously-included directories found matching 'docs/_build' 18:22:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:22:29 INFO - Running setup.py install for pep8 18:22:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:22:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:22:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:22:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:22:29 INFO - no previously-included directories found matching 'docs/_build' 18:22:29 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:22:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:22:29 INFO - Cleaning up... 18:22:29 INFO - Return code: 0 18:22:29 INFO - Running post-action listener: _resource_record_post_action 18:22:29 INFO - Running post-action listener: _start_resource_monitoring 18:22:29 INFO - Starting resource monitoring. 18:22:29 INFO - ##### 18:22:29 INFO - ##### Running install step. 18:22:29 INFO - ##### 18:22:29 INFO - Running pre-action listener: _resource_record_pre_action 18:22:29 INFO - Running main action method: install 18:22:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:22:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:22:29 INFO - Reading from file tmpfile_stdout 18:22:29 INFO - Detecting whether we're running mozinstall >=1.0... 18:22:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:22:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:22:29 INFO - Reading from file tmpfile_stdout 18:22:29 INFO - Output received: 18:22:29 INFO - Usage: mozinstall [options] installer 18:22:29 INFO - Options: 18:22:29 INFO - -h, --help show this help message and exit 18:22:29 INFO - -d DEST, --destination=DEST 18:22:29 INFO - Directory to install application into. [default: 18:22:29 INFO - "/builds/slave/test-pgo"] 18:22:29 INFO - --app=APP Application being installed. [default: firefox] 18:22:29 INFO - mkdir: /builds/slave/test-pgo/build/application 18:22:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:22:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:22:46 INFO - Reading from file tmpfile_stdout 18:22:46 INFO - Output received: 18:22:46 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:22:46 INFO - Running post-action listener: _resource_record_post_action 18:22:46 INFO - ##### 18:22:46 INFO - ##### Running run-tests step. 18:22:46 INFO - ##### 18:22:46 INFO - Running pre-action listener: _resource_record_pre_action 18:22:46 INFO - Running main action method: run_tests 18:22:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:22:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:22:46 INFO - Python 2.7.3 18:22:46 INFO - Return code: 0 18:22:46 INFO - grabbing minidump binary from tooltool 18:22: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')]} 18:22:46 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 0x1fff8b0>, '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 0x20007b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2000c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:22:46 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 18:22:46 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 18:22:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:22:46 INFO - Return code: 0 18:22:46 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:22:46 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:22:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:22:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:22:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:22:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:22:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:22:47 INFO - Return code: 0 18:22:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 18:22:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 18:22:47 INFO - Using env: {'DISPLAY': ':0', 18:22:47 INFO - 'HOME': '/home/cltbld', 18:22:47 INFO - 'LANG': 'en_US.UTF-8', 18:22:47 INFO - 'LANGUAGE': 'en_US:en', 18:22:47 INFO - 'LOGNAME': 'cltbld', 18:22:47 INFO - 'MAIL': '/var/mail/cltbld', 18:22:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:22:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:47 INFO - 'MOZ_NO_REMOTE': '1', 18:22:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:47 INFO - 'NO_EM_RESTART': '1', 18:22:47 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:22:47 INFO - 'PWD': '/builds/slave/test-pgo', 18:22:47 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:22:47 INFO - 'SHELL': '/bin/bash', 18:22:47 INFO - 'SHLVL': '1', 18:22:47 INFO - 'TERM': 'linux', 18:22:47 INFO - 'TMOUT': '86400', 18:22:47 INFO - 'USER': 'cltbld', 18:22:47 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313', 18:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:47 INFO - '_': '/tools/buildbot/bin/python'} 18:22:47 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 18:22:48 INFO - mozversion application_buildid: 20160409133033 18:22:48 INFO - mozversion application_changeset: 7a50cf3a5b570222108d96cbe71b48850f570c61 18:22:48 INFO - mozversion application_display_name: Nightly 18:22:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:22:48 INFO - mozversion application_name: Firefox 18:22:48 INFO - mozversion application_remotingname: firefox 18:22:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:22:48 INFO - mozversion application_vendor: Mozilla 18:22:48 INFO - mozversion application_version: 48.0a1 18:22:48 INFO - mozversion platform_buildid: 20160409133033 18:22:48 INFO - mozversion platform_changeset: 7a50cf3a5b570222108d96cbe71b48850f570c61 18:22:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:22:48 INFO - mozversion platform_version: 48.0a1 18:22:48 INFO - using testdate: 1460251368 18:22:48 INFO - actual date: 1460251368 18:22:48 INFO - starting webserver on 'localhost:47196' 18:22:48 INFO - SUITE-START | Running 2 tests 18:22:48 INFO - TEST-START | dromaeo_css 18:22:48 INFO - operating with platform_type : linux_ 18:22:48 INFO - Initialising browser for dromaeo_css test... 18:22:48 INFO - TEST-INFO | started process 3297 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkvEQkJ/profile http://localhost:47196/getInfo.html) 18:22:52 INFO - PROCESS | 3297 | 18:22:52 INFO - PROCESS | 3297 | (process:3365): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:22:52 INFO - PROCESS | 3297 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 18:22:55 INFO - PROCESS | 3297 | __metrics Screen width/height:1600/1200 18:22:55 INFO - PROCESS | 3297 | colorDepth:24 18:22:55 INFO - PROCESS | 3297 | Browser inner width/height: 1024/697 18:22:55 INFO - PROCESS | 3297 | __metrics 18:22:55 ERROR - PROCESS | 3297 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 18:22:56 INFO - TEST-INFO | 3297: exit 0 18:22:56 INFO - Browser initialized. 18:22:56 INFO - Running cycle 1/1 for dromaeo_css test... 18:22:56 INFO - TEST-INFO | started process 3416 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkvEQkJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:22:58 INFO - PROCESS | 3416 | 18:22:58 INFO - PROCESS | 3416 | (process:3476): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:23:08 INFO - PROCESS | 3416 | RSS: Main: 162631680 18:23:08 INFO - PROCESS | 3416 | 18:23:57 INFO - PROCESS | 3416 | 1460251437829 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] 18:26:05 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:47196/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47196/tests/dromaeo/cssquery-ext.html) 18:26:06 INFO - PROCESS | 3416 | RSS: Main: 168468480 18:26:06 INFO - PROCESS | 3416 | 18:29:08 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:47196/tests/dromaeo/cssquery-ext.html (next: http://localhost:47196/tests/dromaeo/cssquery-jquery.html) 18:29:08 INFO - PROCESS | 3416 | RSS: Main: 165572608 18:29:08 INFO - PROCESS | 3416 | 18:32:10 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:47196/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47196/tests/dromaeo/cssquery-mootools.html) 18:32:11 INFO - PROCESS | 3416 | RSS: Main: 166199296 18:32:11 INFO - PROCESS | 3416 | 18:35:12 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:47196/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47196/tests/dromaeo/cssquery-prototype.html) 18:35:13 INFO - PROCESS | 3416 | RSS: Main: 163975168 18:35:13 INFO - PROCESS | 3416 | 18:38:15 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:47196/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47196/tests/dromaeo/cssquery-yui.html) 18:38:16 INFO - PROCESS | 3416 | RSS: Main: 165920768 18:38:16 INFO - PROCESS | 3416 | 18:41:18 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:47196/tests/dromaeo/cssquery-yui.html (next: http://localhost:47196/tests/dromaeo/cssquery-dojo.html) 18:41:19 INFO - PROCESS | 3416 | RSS: Main: 167845888 18:41:19 INFO - PROCESS | 3416 | 18:41:19 INFO - PROCESS | 3416 | __start_tp_report 18:41:19 INFO - PROCESS | 3416 | _x_x_mozilla_page_load 18:41:19 INFO - PROCESS | 3416 | _x_x_mozilla_page_load_details 18:41:19 INFO - PROCESS | 3416 | |i|pagename|runs| 18:41:19 INFO - PROCESS | 3416 | |0;dojo.html;3174.1747145742106;3230.580024596803;3243.7242834359076;3262.1844538865284;3276.9508457373145;5614.29821272341;5617.634853734505;5632.859178520539;5633.577481688869;5640.0975843864935;5448.618596698233;5604.215409842615;5626.409227031164;5634.32388113427;5687.402822703619;4992.625553083515;5056.595472362221;5113.718745468997;5128.53843154116;5188.896222075557;661.9421303594186;5064.79740810369;5143.3313669223135;5163.044836705203;5192.55863251624;5126.615503837208;5139.074966506046;5144.17693169093;5147.38231412231;5153.587712982952;4951.702897826142;5218.452062533455;5225.817096401645;5239.502247286502;5248.160294352923;5027.145385284511;5073.289739436482;5079.212722028092;5093;5116.104681680691;5478.780848766084;5502.8349149525175;5523.889522209573;5535.197396377543;5545.085060964936;5986.191864098335;5994.820155395345;5999.700014999276;6008.699565021731;6043.848903777397;5937.287525496925;5985.431384018511;5997.040473524259;6004.579679422399;6059.424354686298;5599.748011339459;5601.915971260434;5610.298712660918;5622.437756224385;5627.634203776742;6017.2779266488305;6119.632822030692;6140.62695141751;6142.170806941006;6185.381461853869;5942.197803296586;5943.138244954544;5943.673097979653;5955.583109182316;5969.253843269591;6002.309734380602;6009.278886533644;6012.699365031731;6023.247094113236;6026.638401695912;5816.796412125555;5961.463468287789;5983;5992.101184822312;6052.727627256784;5728.169415434739;5865.4134586541;5875.441833025856;5950.018246989285;6014.248218972629;4444.355568442557;4445.2887537993765;4464.531224221475;4469.597736203757;4475.037866858576;3869.110104675884;3944.6647035001774;3975.483187185705;3978.1645854370327;3987.1228329767405;5650.85872853182;5655.406182350794;5681.119426488901;5702.087665973424;5725.255716756878;5924.496417804448;6024.698765061729;6052.818415447544;6056.636601803906;6068.120122582201;5614.129809879475;5714.342850572154;5728.942710572925;5782.045962416239;5806.1000544915605;5131.974340128276;5134.332536770196;5135;5138;5148.510891465305;6248.50011999039;6258.749650013949;6259.780907668301;6263.937360626426;6270.6864656766975;5845.678487683048;5872.823815285548;5909.349971503218;5932.970335148297;5950.613210141327;6178.814635560941;6191.351841608287;6243.750249990131;6250.656213908279;6260.561760676709;5733.713314334183;5949;5954.98765209924;5955.315138759098;6011.458968692838;6016.87966240664;6025.969870150797;6054;6066.605670631395;6108.938910610837;5746.109353050284;5771.249737534094;5780.913286300624;5786.855328616818;5849.210356601804;5749.223854779719;5817.563682723898;5824.126381042877;5838.854028649318;5854.268216472941;5654.46282603152;5727.140928860705;5736.139579063174;5806.071028635398;5863.912041319299;5781.4507621775865;5782.826515204551;5906.26171728534;5957.046872500379;5980.37206093354;5773.220615216892;5809.099589563624;5814.098814683731;5815.2149459822385;5830.679312637845 18:41:19 INFO - PROCESS | 3416 | |1;ext.html;612.4916319454853;620.7641096383373;663.3697986912433;665.5308007854463;672.2269390201269;38240.42639360408;38924.61075389252;38980.22039559207;39100.80449597748;39235.21529569407;40631.796841015755;41422.37866432006;41547.58452415475;41602.375964360486;41716.37425438621;8470.110638382957;8607.655693772273;8710.390272680916;8753.518556479392;8754.343424243176;8522.531260780655;8667.479951202917;8690.261327787146;8839.823203535958;8850.203481686647;8862.645494180226;8900.332475064397;8906.554672266393;8939.195472407482;8956.955215223914;8817.515036672981;8844.823103537925;8897.377183597184;8902.910970890272;8939.106089391009;8699.782505437352;8754.737357879274;8802.119788021211;8810.867836982387;8860.069692682304;41442.37836432456;41516.169676606296;41624.58375416238;41705.1658966822;41976;3457.222125021875;3520.2783429396914;3927.410888366739;4021.939670904939;4094.7952602369764;32123.357532849444;32184.19539511531;32357.83821080903;33790.155246119044;33797;4348.543402942709;4386.1008493258805;4467.128909862578;4478.193925093482;4515.096980603859;295868;297511;297598;297987;298890;35438.82280588581;36474;36705.63294367075;60327.09509357363;60689;35081.82459087688;35167.824160879034;35295;35339.823300883334;35429;14154.504592339219;14417;14424.42302307896;14425.92787036079;14440.277986100653;12035.939820300842;12167.391630418444;12242.877571224351;12264.080193985308;12267.57063502773;8633.740987770378;8637.524936128448;8667.523286219319;8702.434341767765;8786.384953053353;3346.252197538772;3371.494275858641;3395.5585773849243;3403.761736678409;3419.743519236067;1008.0776089877826;1013.2350075692805;1065.5577935156823;1124.966251012471;1207.8369420128347;31714.682853171635;32171.678283217338;32204.033878983668;32458.675413246037;32743;1087.217203613413;1123.1239633086207;1135.5798354608683;1184.5557915781583;1200.6878211664855;17005.57486062858;17263.56841078983;17295.827041729422;17343.785934984684;17411.65176696459;423861;429655;430013;430888;432836;57471.42528574744;58843;59015.704921475975;59314.40685593089;59323.406765932654;1402.0676250293645;1404.9367778449994;1423.224342733192;1424.423108641002;1431.99044673507;30769.384612308077;31964.84017579897;32118.19704507406;32443.837780810944;33076.66923330736;50683.74658126686;50820.74589627028;51022.48977510326;51038.74480627573;51202;379708;381456;384242;384461;384672;27047.323816903947;27899.16302510928;29458.116256511483;29508.557371639014;29541.85229073927;48358.27462587994;48887.26669099895;49587.50412495829;49775.502244977084;50166.74916625393;40213.798931005156;40918.1816363677;41038.17923641451;41469.377959331236;42457;39743.602563975146;40319.79840100781;41050.41766701677;41453;41746;42644;42821.78589107034;43075;43808.78095609502;43969.560304396546;33079;34581.27882932992;34844.30311393707;35394.292114157055;35614.64385356217;27766.722332777223;28381.858090709415;28466;28678.71321286844;28726.281842954093 18:41:19 INFO - PROCESS | 3416 | |2;jquery.html;398.15193637552045;399.16375193968645;399.43280541630884;402.7100487648893;413.7414116177389;13454.932725336384;15445.84554154458;17940.282388704454;18618.906905465472;18636.62726745466;15511.92244038781;17771.91114044428;18758.06209689517;18795.154218060186;18990.81009189908;5216.26972223889;5285;5366.248725178478;5421.430749771257;5454.945450545483;5314.468553144693;5358.035553600351;5358.65168764031;5376.596755243353;5395.298611180541;5174;5299.072662284104;5316.229146773716;5375.516203541681;5385.7307134643115;5271.077561426754;5312.256284120226;5328.17413300939;5353.839384818461;5377.946220537803;4768.57082862544;5146.6911985281;5148.897022059576;5172.715500647463;5182.637215394924;13185.472581096745;13352;16757.748633770505;22514.66228006581;22571.661425078637;2157.7087093242367;2162.102727368156;2293.3578597992587;2374.25211058516;2616.0974463810144;9666.516674166263;9847.80304393908;10075.969612155124;10115.241356898188;10196.796064078677;1831.3224107080332;1886;1916.9520761980923;1942.4949513126548;1985.642584334819;76040;77393;77936;79800.60099699523;81821;10448.164146868232;10638.468076596138;10786.083182929538;10825.837612435662;10853.294535855144;15447.5365739028;15506.069635821887;15509.146996915279;15514.224288785741;15542.378304867678;6983.685734141975;7469.887951680729;7518.624068796538;7664.118626357928;7787.338076263581;6961.199462061826;7532.7740167795055;7641.847163056707;7650.617469126632;7772.455928085093;4652.930206046912;4675.13510000651;4698.788554515055;4698.906021879611;4711.882202944886;1947.9707804382945;1954.5113721569608;1964.1912065745835;2010.3767831971843;2046.19175425709;916.812053529025;935.9251259899191;1022.7136401807505;1063.3619828103076;1100.3068067117665;17861.28554857791;18314.45056648303;18646.720299195524;18763.81236187648;19027.619447611247;952.6808519146025;956.8995255498072;1014.1329163565046;1021.3463383434607;1024.538957469142;10701.571937122428;10910.672679819618;10914;10934.726631834268;10959.726006849893;438047;456811;490822;495411;497281;89993.55003224942;95543;95801;96227;96500.51749741347;1059.814532456817;1069.3316677076828;1082.4966390628394;1091.939943303126;1108.4790148630132;17158.742618860975;17268;17275.308987640354;17347.219375127897;17460.301587936847;36099;36848.526058957345;36882.44676329911;37375.62624373721;37629;39170;46029.76985115053;48559;48572;48965.510344896094;8072.717454889051;8422.115677853983;8464.280536154249;8635.179657932485;8775.605097770744;11769.823452648046;12940.611781646188;13022.4139913706;13234.139780914209;13352.532661356807;10610.098141658045;10620.150387969099;11122.666320010412;11128.332300061698;11386;11355.716107097389;11591.304521728724;11596;11664.241824281395;11896.345700986529;11352.772944540899;11432.314061156358;11480.540778368771;11533.480993355486;11548.59579914699;7463.253674632493;7928.960355198187;8461.23848853606;8625.051244362989;8901.287896968357;11289;11424.086073113966;11484.36835973996;11499.482523286304;11649.242799218024 18:41:19 INFO - PROCESS | 3416 | |3;mootools.html;1495.2150121186373;1512.092744353388;1691.906945118018;1781.9910900445511;1822.14359251152;7568.659410326535;8071.596420178989;8223.91776082239;8301.460405073674;8304.50172989621;8215;8266.338692904568;8287.46131501452;8314;8325.791855203623;2326.720793504782;2368.5026144509675;2371.3360259127385;2373.2524254859663;2379.0602711928777;2308.1805958884606;2323.14043803792;2331.4171457135717;2333.754955729641;2335.2877372401413;2318.2813327868416;2322.2104484475276;2342.61346877765;2365.6688063671013;2369.052379048386;2227.7994980451836;2247.5617254635354;2250.4373906523288;2255.76314486979;2303.55080759252;2261.604219261623;2265.592193405186;2266.05958527211;2271.6251818449937;2281.5094754627667;8451.11263317349;8454.788630284293;8480.618372173267;8512.531810750406;8546.487210767375;4976.8755781105765;5097.286379906816;5113.82101626445;5146.330976972969;5146.485351464824;3290.4899740540254;3337.8831740888954;3380.070480617825;3439.8968030959113;3445.6898879101;1123.2979387882574;1131.377742241772;1135.7217481717032;1153.5155234801402;1177.8115501519715;10953;11087.168462365275;11094.55621775128;11126.777464450828;11144.498497567629;4367.10474352757;4391.187630288407;4494.70784399013;4512.684112112186;4532.864014079583;9028.503432311287;9159.992400835903;9197.448153110834;9205.539723013822;9207.907920920705;5161.587073034223;5168.3539557555305;5201.375834899836;5201.921971170435;5226.059309324282;4288.228118938621;4551.6813823032735;4734.810607575659;4756.239001759771;4851.975740121276;3668.3947148720695;3677.5219221501034;3753.9061523461587;3786.5456145262747;3798.525184351956;1141.560499207811;1146.220570012383;1147.6729132197283;1160.512584714422;1162.3490845126587;1318.314476472229;1347.3734713358335;1349.1837438349853;1453.5348688419815;1459.9926051024759;8097.190280971973;8180.222878826502;8234.341252699769;8243.587820608946;8245.505269683837;453.14808160657753;466.8109415686652;472.357593672605;478.7965114826185;479.5899505922456;6362.491000719931;6376.3623637635865;6429.38920802523;6516.413522782972;6526.216853977553;9927.354721943051;10199.18406527476;10349.534270957825;10382.688519344432;10456.947715261374;10046.547905344278;10075.445850478294;10258.230632702576;10282.07461328484;10325.690229293134;7782.6886924523515;7861.095973962953;7864.921350786533;7875.251851074138;7912.169222231698;7772.45592808498;8003.5197888126895;8029.197080291924;8040.155783642867;8089.514629122272;9113.77215569616;9356.625734970525;9565.139137477661;9611;9672.226221902372;9112.544372781467;9376.109269619375;9442.716718498456;9496.525173741424;9538.332316738039;6872.862542749017;7218.205997340184;7438.479306448497;7479.177290497932;7637.274458926393;8022.9197708022175;8047.436679432383;8084.959575202086;8087.878681819895;8090.757277281691;7077.893831592633;7338.926610734038;7358.448116391185;7422.294881986203;7460.0301960744755;7111.53775004623;7250.129984401906;7329.890051649336;7334.193238743627;7382.3724983377015;7764.767056988299;7773.572453514885;7835.686572537263;7850.803729906798;7858.0570331560575;6812.352826481477;7181.281871812777;7198.244184360567;7242.022326986;7258.237885021997;7186.496945213785;7244.094488188976;7252.927470725225;7267.563946163247;7281.635918203962 18:41:19 INFO - PROCESS | 3416 | |4;prototype.html;340.19204389574764;344.4402845376262;345.93427248822735;353.1330583417709;353.1947160474118;6016.157737916689;6091.025435930252;6103.572749907508;6142.631442113477;6169.969150154248;5849.619774714641;6012.3085845127825;6020.849478763033;6021.548383871216;6039.5772295939305;4615.746133962631;4617.399738034051;4626.4910859805395;4630.791614377345;4643.767811609423;4646.79089440976;4652.255639097745;4655.092257009885;4655.185342565038;4659.813607455715;4519.937814613563;4599.402077729907;4618.191816432128;4624.075184963004;4625.098105869357;4577.313402989545;4587.288970209606;4592.15045216636;4607.516210797869;4608.124456353282;4042.818073186684;4044.6359827615656;4060.112047897742;4060.898477538085;4066.2680717470844;5658.179563963244;5798.42015798421;5818.330891947396;5824.737886795105;5831.183634291203;5321.866953326159;5335.866603334909;5336.946630533723;5374.355077390738;5378.46215378463;6303.432691057827;6306.653134077624;6318.905216421757;6327.746890124389;6337.239531256233;4413.867583972486;4429.446319210098;4480.977595112036;4525;4529.796159172845;6258.24901011877;6456.8062958111805;6590.110335104795;6593.50548708844;6612.86774264512;4589.495155532889;4613.746243956614;4648.0239149778245;4650.4186976627925;4654.232051711429;4644.419447569054;4650.465196502378;4672.929906051412;4683.625309975194;4699.953000469952;5248.6588371755715;5363.597730170253;5364.946350536445;5367.194920761917;5379.354477462652;6353.332900045429;6359.618422894641;6376.7043864208845;6387.457066149336;6403.199600049994;1599.912004839745;1632.330744394816;1643.7205675035034;1648.3406637345158;1651.5293141454629;1023.2325755683238;1055.6780182044397;1057.8889216632297;1060.2578195263347;1113.916456265767;6084.209052823193;6093.329733729286;6112.349665590355;6163.291221509494;6171.352008039181;6348;6450.161703914362;6458.6770661466735;6495.6752162391695;6574.967125164344;6051.788187413419;6120.898238317057;6131.264248290145;6135.233095863017;6157.415045570664;3488.8081155536183;3507.105688049531;3508.8596456141977;3533.823308834548;3550.928981420357;6563.474922006228;6648.634325112069;6662.267150613428;6766.424853887376;6790.932090679129;6566.244881838554;6592.835179120464;6594.802155935329;6595.439387652007;6639.435647969976;6624.39247413353;6730.158730158731;6739.528233023641;6784.559003664746;6795.864082718318;6409.230892292955;6430.582012169194;6467.450266727193;6489.286178520453;6531.836704082436;6222.3910132124165;6298.1812364392335;6303.6532990685955;6404.807855764335;6440.486485675956;6737.787198304352;6833.214180369122;6886.24251332363;6905.102336696197;6932.861342773217;4487.967767413448;4530.660200485043;4531.297648864432;4564.680472366902;4571.1771881060395;6453.322401147811;6599.703013364506;6646.60120392778;6673.733050677918;6679.730851138268;6374.310807636073;6419.325970773189;6430.614163150226;6436.292007879036;6436.935630643821;6194.132821405097;6352.36476352361;6443.355664433519;6464.288928217987;6466.838329041811;6316.526260530387;6325.240971083499;6349.111124442674;6374.521910856612;6397.712102955285;6116.480099191618;6467.482601391972;6509.804705858832;6523.282438931618;6541;6321.807487218925;6321.810345689637;6322.36776322364;6350.555461117678;6352.538916049242 18:41:19 INFO - PROCESS | 3416 | |5;yui.html;775.4765533265048;784.690047431265;787.3425689549227;812.4069429316598;870.0777176193232;13634.318284085793;13779.379927903243;13796.586102416932;14475.710485790278;15073.849261507381;15696.529104126867;15700.76448853268;15717.214139293046;15809.288582013809;15831.287592058356;676.1784431915222;825.7110011495988;827.9793005174889;834.0075310380628;834.1741675741018;815.6329651656748;828.1263267253075;830.0703212402088;831.2518733140192;832.3549249331755;853.4154104438448;870.6734974384606;872.1540106097108;874.5976850648709;874.6982291109557;861.6725644255174;870.0820634230884;873.0701802580263;873.9388242822941;874.6326542851954;629.0752593687272;635.2884769058637;635.4916067146264;637.1557686065981;639.6034458635629;13317.467301308034;13329;13332.866671333259;13365.198088114745;13371.465141394332;14103.224322662249;14158.858411415857;14171.645708857259;14234.786478202835;14250.073745206631;11998.760024799543;12043.698907527381;12069.57756478519;12183.634490965285;12203;3863.5750067492554;3870.2646497165447;3968.0675041365257;3970.7419017763755;4021.316376216021;57421;57528.42471575273;57741.711291443695;57898.13152802754;57908.71045644745;11087.667369978913;11271.211015229019;11354.48904799286;11948.701282467833;12018.75962480763;19509.414717558495;19596.118174682175;19780.71425357347;19805.30681426172;19871.900640496704;8285.088640249567;8356.874646880302;8587.484750914966;8828.382013259139;8883.822323553493;4823;4866.659333846596;4955.430125535538;4961.305417241589;5028.667403138172;3352.782069165545;3746.269477451925;3907.4138879168354;3908.4332771747936;3912.7456715313415;704.2605264472284;707.5860621536459;716.3839098375392;719.5682590445796;735.5586648011257;765.2959277464635;772.748856621589;785.4227143049853;802.1096582793095;821.4167940762006;9254.35219534626;9531.857022144535;9574.281928855364;9715.417074975525;9809.166220871162;618.9009758438629;701.260170520096;761.3566536276837;764.10217993857;767.6046835879526;4435.933460998088;4545.931811022837;4548.090381923628;4548.295014272793;4569.885752856138;67088;67461;68071.65964170148;68437.3156268441;68514.31485685079;59945;59974.70012649996;60133.699331503936;60642;60980.39019609836;52836.47163528315;54163.72918135384;54498.45501544934;55064;55262;8647;8870.556472176237;8950.597223124845;8981.461112333282;9111.137719770699;33980.32039359248;34623.13442163966;34821;34979.82510087535;35403.29193416169;44868.32697509605;47690.28464572965;47981.76009119932;48364.274535882694;48574;12373.75252494963;12445.37773111359;12547.3098979557;12728.936355318165;12916.8062479061;13418.731625367633;13860.099093558887;13939.51211707626;13969.511067112602;14025.859741402455;13171.802422963472;13359.53241636538;13634.181949083088;13860.306984650928;14142.22217778032;12845.486180552673;13476.595702128952;13600.93199533996;13736.244506552235;13801.585952421443;13514.662133446742;13590.728185436434;13643.727125457634;13734.862651373758;14204.076735012191;10946.890531094905;11210.551577937118;11263.943680281875;11431.199816013132;11752.70618234551;11580.189386743185;11600.767984640092;11639;11911.166218364979;12153.817692734792 18:41:19 INFO - PROCESS | 3416 | __end_tp_report 18:41:19 INFO - PROCESS | 3416 | __start_cc_report 18:41:19 INFO - PROCESS | 3416 | _x_x_mozilla_cycle_collect,335 18:41:19 INFO - PROCESS | 3416 | __end_cc_report 18:41:19 INFO - PROCESS | 3416 | __startTimestamp1460252479046__endTimestamp 18:41:19 INFO - PROCESS | 3416 | 18:41:19 INFO - PROCESS | 3416 | ------- Summary: start ------- 18:41:19 INFO - PROCESS | 3416 | Number of tests: 6 18:41:19 INFO - PROCESS | 3416 | 18:41:19 INFO - PROCESS | 3416 | [#0] dojo.html Cycles:165 Average:5535.47 Median:5781.45 stddev:750.95 (13.0%) stddev-sans-first:730.05 18:41:19 INFO - PROCESS | 3416 | Values: 3174.2 3230.6 3243.7 3262.2 3277.0 5614.3 5617.6 5632.9 5633.6 5640.1 5448.6 5604.2 5626.4 5634.3 5687.4 4992.6 5056.6 5113.7 5128.5 5188.9 661.9 5064.8 5143.3 5163.0 5192.6 5126.6 5139.1 5144.2 5147.4 5153.6 4951.7 5218.5 5225.8 5239.5 5248.2 5027.1 5073.3 5079.2 5093.0 5116.1 5478.8 5502.8 5523.9 5535.2 5545.1 5986.2 5994.8 5999.7 6008.7 6043.8 5937.3 5985.4 5997.0 6004.6 6059.4 5599.7 5601.9 5610.3 5622.4 5627.6 6017.3 6119.6 6140.6 6142.2 6185.4 5942.2 5943.1 5943.7 5955.6 5969.3 6002.3 6009.3 6012.7 6023.2 6026.6 5816.8 5961.5 5983.0 5992.1 6052.7 5728.2 5865.4 5875.4 5950.0 6014.2 4444.4 4445.3 4464.5 4469.6 4475.0 3869.1 3944.7 3975.5 3978.2 3987.1 5650.9 5655.4 5681.1 5702.1 5725.3 5924.5 6024.7 6052.8 6056.6 6068.1 5614.1 5714.3 5728.9 5782.0 5806.1 5132.0 5134.3 5135.0 5138.0 5148.5 6248.5 6258.7 6259.8 6263.9 6270.7 5845.7 5872.8 5909.3 5933.0 5950.6 6178.8 6191.4 6243.8 6250.7 6260.6 5733.7 5949.0 5955.0 5955.3 6011.5 6016.9 6026.0 6054.0 6066.6 6108.9 5746.1 5771.2 5780.9 5786.9 5849.2 5749.2 5817.6 5824.1 5838.9 5854.3 5654.5 5727.1 5736.1 5806.1 5863.9 5781.5 5782.8 5906.3 5957.0 5980.4 5773.2 5809.1 5814.1 5815.2 5830.7 18:41:19 INFO - PROCESS | 3416 | 18:41:19 INFO - PROCESS | 3416 | [#1] ext.html Cycles:180 Average:52746.56 Median:21835.51 stddev:98705.09 (452.0%) stddev-sans-first:98904.37 18:41:19 INFO - PROCESS | 3416 | Values: 612.5 620.8 663.4 665.5 672.2 38240.4 38924.6 38980.2 39100.8 39235.2 40631.8 41422.4 41547.6 41602.4 41716.4 8470.1 8607.7 8710.4 8753.5 8754.3 8522.5 8667.5 8690.3 8839.8 8850.2 8862.6 8900.3 8906.6 8939.2 8957.0 8817.5 8844.8 8897.4 8902.9 8939.1 8699.8 8754.7 8802.1 8810.9 8860.1 41442.4 41516.2 41624.6 41705.2 41976.0 3457.2 3520.3 3927.4 4021.9 4094.8 32123.4 32184.2 32357.8 33790.2 33797.0 4348.5 4386.1 4467.1 4478.2 4515.1 295868.0 297511.0 297598.0 297987.0 298890.0 35438.8 36474.0 36705.6 60327.1 60689.0 35081.8 35167.8 35295.0 35339.8 35429.0 14154.5 14417.0 14424.4 14425.9 14440.3 12035.9 12167.4 12242.9 12264.1 12267.6 8633.7 8637.5 8667.5 8702.4 8786.4 3346.3 3371.5 3395.6 3403.8 3419.7 1008.1 1013.2 1065.6 1125.0 1207.8 31714.7 32171.7 32204.0 32458.7 32743.0 1087.2 1123.1 1135.6 1184.6 1200.7 17005.6 17263.6 17295.8 17343.8 17411.7 423861.0 429655.0 430013.0 430888.0 432836.0 57471.4 58843.0 59015.7 59314.4 59323.4 1402.1 1404.9 1423.2 1424.4 1432.0 30769.4 31964.8 32118.2 32443.8 33076.7 50683.7 50820.7 51022.5 51038.7 51202.0 379708.0 381456.0 384242.0 384461.0 384672.0 27047.3 27899.2 29458.1 29508.6 29541.9 48358.3 48887.3 49587.5 49775.5 50166.7 40213.8 40918.2 41038.2 41469.4 42457.0 39743.6 40319.8 41050.4 41453.0 41746.0 42644.0 42821.8 43075.0 43808.8 43969.6 33079.0 34581.3 34844.3 35394.3 35614.6 27766.7 28381.9 28466.0 28678.7 28726.3 18:41:19 INFO - PROCESS | 3416 | 18:41:19 INFO - PROCESS | 3416 | [#2] jquery.html Cycles:180 Average:27740.11 Median:12432.51 stddev:78588.42 (632.1%) stddev-sans-first:78782.07 18:41:19 INFO - PROCESS | 3416 | Values: 398.2 399.2 399.4 402.7 413.7 13454.9 15445.8 17940.3 18618.9 18636.6 15511.9 17771.9 18758.1 18795.2 18990.8 5216.3 5285.0 5366.2 5421.4 5454.9 5314.5 5358.0 5358.7 5376.6 5395.3 5174.0 5299.1 5316.2 5375.5 5385.7 5271.1 5312.3 5328.2 5353.8 5377.9 4768.6 5146.7 5148.9 5172.7 5182.6 13185.5 13352.0 16757.7 22514.7 22571.7 2157.7 2162.1 2293.4 2374.3 2616.1 9666.5 9847.8 10076.0 10115.2 10196.8 1831.3 1886.0 1917.0 1942.5 1985.6 76040.0 77393.0 77936.0 79800.6 81821.0 10448.2 10638.5 10786.1 10825.8 10853.3 15447.5 15506.1 15509.1 15514.2 15542.4 6983.7 7469.9 7518.6 7664.1 7787.3 6961.2 7532.8 7641.8 7650.6 7772.5 4652.9 4675.1 4698.8 4698.9 4711.9 1948.0 1954.5 1964.2 2010.4 2046.2 916.8 935.9 1022.7 1063.4 1100.3 17861.3 18314.5 18646.7 18763.8 19027.6 952.7 956.9 1014.1 1021.3 1024.5 10701.6 10910.7 10914.0 10934.7 10959.7 438047.0 456811.0 490822.0 495411.0 497281.0 89993.6 95543.0 95801.0 96227.0 96500.5 1059.8 1069.3 1082.5 1091.9 1108.5 17158.7 17268.0 17275.3 17347.2 17460.3 36099.0 36848.5 36882.4 37375.6 37629.0 39170.0 46029.8 48559.0 48572.0 48965.5 8072.7 8422.1 8464.3 8635.2 8775.6 11769.8 12940.6 13022.4 13234.1 13352.5 10610.1 10620.2 11122.7 11128.3 11386.0 11355.7 11591.3 11596.0 11664.2 11896.3 11352.8 11432.3 11480.5 11533.5 11548.6 7463.3 7929.0 8461.2 8625.1 8901.3 11289.0 11424.1 11484.4 11499.5 11649.2 18:41:19 INFO - PROCESS | 3416 | 18:41:19 INFO - PROCESS | 3416 | [#3] mootools.html Cycles:180 Average:5860.99 Median:5184.86 stddev:3091.57 (59.6%) stddev-sans-first:3082.82 18:41:19 INFO - PROCESS | 3416 | Values: 1495.2 1512.1 1691.9 1782.0 1822.1 7568.7 8071.6 8223.9 8301.5 8304.5 8215.0 8266.3 8287.5 8314.0 8325.8 2326.7 2368.5 2371.3 2373.3 2379.1 2308.2 2323.1 2331.4 2333.8 2335.3 2318.3 2322.2 2342.6 2365.7 2369.1 2227.8 2247.6 2250.4 2255.8 2303.6 2261.6 2265.6 2266.1 2271.6 2281.5 8451.1 8454.8 8480.6 8512.5 8546.5 4976.9 5097.3 5113.8 5146.3 5146.5 3290.5 3337.9 3380.1 3439.9 3445.7 1123.3 1131.4 1135.7 1153.5 1177.8 10953.0 11087.2 11094.6 11126.8 11144.5 4367.1 4391.2 4494.7 4512.7 4532.9 9028.5 9160.0 9197.4 9205.5 9207.9 5161.6 5168.4 5201.4 5201.9 5226.1 4288.2 4551.7 4734.8 4756.2 4852.0 3668.4 3677.5 3753.9 3786.5 3798.5 1141.6 1146.2 1147.7 1160.5 1162.3 1318.3 1347.4 1349.2 1453.5 1460.0 8097.2 8180.2 8234.3 8243.6 8245.5 453.1 466.8 472.4 478.8 479.6 6362.5 6376.4 6429.4 6516.4 6526.2 9927.4 10199.2 10349.5 10382.7 10456.9 10046.5 10075.4 10258.2 10282.1 10325.7 7782.7 7861.1 7864.9 7875.3 7912.2 7772.5 8003.5 8029.2 8040.2 8089.5 9113.8 9356.6 9565.1 9611.0 9672.2 9112.5 9376.1 9442.7 9496.5 9538.3 6872.9 7218.2 7438.5 7479.2 7637.3 8022.9 8047.4 8085.0 8087.9 8090.8 7077.9 7338.9 7358.4 7422.3 7460.0 7111.5 7250.1 7329.9 7334.2 7382.4 7764.8 7773.6 7835.7 7850.8 7858.1 6812.4 7181.3 7198.2 7242.0 7258.2 7186.5 7244.1 7252.9 7267.6 7281.6 18:41:19 INFO - PROCESS | 3416 | 18:41:19 INFO - PROCESS | 3416 | [#4] prototype.html Cycles:180 Average:5335.98 Median:6107.96 stddev:1590.16 (26.0%) stddev-sans-first:1549.78 18:41:19 INFO - PROCESS | 3416 | Values: 340.2 344.4 345.9 353.1 353.2 6016.2 6091.0 6103.6 6142.6 6170.0 5849.6 6012.3 6020.8 6021.5 6039.6 4615.7 4617.4 4626.5 4630.8 4643.8 4646.8 4652.3 4655.1 4655.2 4659.8 4519.9 4599.4 4618.2 4624.1 4625.1 4577.3 4587.3 4592.2 4607.5 4608.1 4042.8 4044.6 4060.1 4060.9 4066.3 5658.2 5798.4 5818.3 5824.7 5831.2 5321.9 5335.9 5336.9 5374.4 5378.5 6303.4 6306.7 6318.9 6327.7 6337.2 4413.9 4429.4 4481.0 4525.0 4529.8 6258.2 6456.8 6590.1 6593.5 6612.9 4589.5 4613.7 4648.0 4650.4 4654.2 4644.4 4650.5 4672.9 4683.6 4700.0 5248.7 5363.6 5364.9 5367.2 5379.4 6353.3 6359.6 6376.7 6387.5 6403.2 1599.9 1632.3 1643.7 1648.3 1651.5 1023.2 1055.7 1057.9 1060.3 1113.9 6084.2 6093.3 6112.3 6163.3 6171.4 6348.0 6450.2 6458.7 6495.7 6575.0 6051.8 6120.9 6131.3 6135.2 6157.4 3488.8 3507.1 3508.9 3533.8 3550.9 6563.5 6648.6 6662.3 6766.4 6790.9 6566.2 6592.8 6594.8 6595.4 6639.4 6624.4 6730.2 6739.5 6784.6 6795.9 6409.2 6430.6 6467.5 6489.3 6531.8 6222.4 6298.2 6303.7 6404.8 6440.5 6737.8 6833.2 6886.2 6905.1 6932.9 4488.0 4530.7 4531.3 4564.7 4571.2 6453.3 6599.7 6646.6 6673.7 6679.7 6374.3 6419.3 6430.6 6436.3 6436.9 6194.1 6352.4 6443.4 6464.3 6466.8 6316.5 6325.2 6349.1 6374.5 6397.7 6116.5 6467.5 6509.8 6523.3 6541.0 6321.8 6321.8 6322.4 6350.6 6352.5 18:41:19 INFO - PROCESS | 3416 | 18:41:19 INFO - PROCESS | 3416 | [#5] yui.html Cycles:180 Average:15695.33 Median:26130.09 stddev:18409.02 (70.5%) stddev-sans-first:18426.57 18:41:19 INFO - PROCESS | 3416 | Values: 775.5 784.7 787.3 812.4 870.1 13634.3 13779.4 13796.6 14475.7 15073.8 15696.5 15700.8 15717.2 15809.3 15831.3 676.2 825.7 828.0 834.0 834.2 815.6 828.1 830.1 831.3 832.4 853.4 870.7 872.2 874.6 874.7 861.7 870.1 873.1 873.9 874.6 629.1 635.3 635.5 637.2 639.6 13317.5 13329.0 13332.9 13365.2 13371.5 14103.2 14158.9 14171.6 14234.8 14250.1 11998.8 12043.7 12069.6 12183.6 12203.0 3863.6 3870.3 3968.1 3970.7 4021.3 57421.0 57528.4 57741.7 57898.1 57908.7 11087.7 11271.2 11354.5 11948.7 12018.8 19509.4 19596.1 19780.7 19805.3 19871.9 8285.1 8356.9 8587.5 8828.4 8883.8 4823.0 4866.7 4955.4 4961.3 5028.7 3352.8 3746.3 3907.4 3908.4 3912.7 704.3 707.6 716.4 719.6 735.6 765.3 772.7 785.4 802.1 821.4 9254.4 9531.9 9574.3 9715.4 9809.2 618.9 701.3 761.4 764.1 767.6 4435.9 4545.9 4548.1 4548.3 4569.9 67088.0 67461.0 68071.7 68437.3 68514.3 59945.0 59974.7 60133.7 60642.0 60980.4 52836.5 54163.7 54498.5 55064.0 55262.0 8647.0 8870.6 8950.6 8981.5 9111.1 33980.3 34623.1 34821.0 34979.8 35403.3 44868.3 47690.3 47981.8 48364.3 48574.0 12373.8 12445.4 12547.3 12728.9 12916.8 13418.7 13860.1 13939.5 13969.5 14025.9 13171.8 13359.5 13634.2 13860.3 14142.2 12845.5 13476.6 13600.9 13736.2 13801.6 13514.7 13590.7 13643.7 13734.9 14204.1 10946.9 11210.6 11263.9 11431.2 11752.7 11580.2 11600.8 11639.0 11911.2 12153.8 18:41:19 INFO - PROCESS | 3416 | -------- Summary: end -------- 18:41:19 INFO - PROCESS | 3416 | 18:41:19 INFO - TEST-INFO | 3416: exit 0 18:41:19 INFO - TEST-OK | dromaeo_css | took 1111667ms 18:41:19 INFO - TEST-START | kraken 18:41:19 INFO - operating with platform_type : linux_ 18:41:19 INFO - Initialising browser for kraken test... 18:41:19 INFO - TEST-INFO | started process 3651 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplxFvqW/profile http://localhost:47196/getInfo.html) 18:41:23 INFO - PROCESS | 3651 | 18:41:23 INFO - PROCESS | 3651 | (process:3717): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:41:23 INFO - PROCESS | 3651 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 18:41:24 INFO - PROCESS | 3651 | __metrics Screen width/height:1600/1200 18:41:24 INFO - PROCESS | 3651 | colorDepth:24 18:41:24 INFO - PROCESS | 3651 | Browser inner width/height: 1024/697 18:41:24 INFO - PROCESS | 3651 | __metrics 18:41:25 ERROR - PROCESS | 3651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 18:41:25 INFO - TEST-INFO | 3651: exit 0 18:41:25 INFO - Browser initialized. 18:41:25 INFO - Running cycle 1/1 for kraken test... 18:41:25 INFO - TEST-INFO | started process 3768 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplxFvqW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:41:27 INFO - PROCESS | 3768 | 18:41:27 INFO - PROCESS | 3768 | (process:3827): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:41:37 INFO - PROCESS | 3768 | RSS: Main: 163110912 18:41:37 INFO - PROCESS | 3768 | 18:41:40 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:47196/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47196/tests/kraken/driver.html?testName=audio-beat-detection) 18:41:41 INFO - PROCESS | 3768 | RSS: Main: 167268352 18:41:41 INFO - PROCESS | 3768 | 18:41:43 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:47196/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47196/tests/kraken/driver.html?testName=audio-dft) 18:41:44 INFO - PROCESS | 3768 | RSS: Main: 170549248 18:41:44 INFO - PROCESS | 3768 | 18:41:47 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:47196/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47196/tests/kraken/driver.html?testName=audio-fft) 18:41:47 INFO - PROCESS | 3768 | RSS: Main: 160710656 18:41:47 INFO - PROCESS | 3768 | 18:41:49 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:47196/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47196/tests/kraken/driver.html?testName=audio-oscillator) 18:41:50 INFO - PROCESS | 3768 | RSS: Main: 161308672 18:41:50 INFO - PROCESS | 3768 | 18:41:52 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:47196/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47196/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:41:53 INFO - PROCESS | 3768 | RSS: Main: 162537472 18:41:53 INFO - PROCESS | 3768 | 18:41:56 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:47196/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47196/tests/kraken/driver.html?testName=imaging-darkroom) 18:41:56 INFO - PROCESS | 3768 | RSS: Main: 163459072 18:41:56 INFO - PROCESS | 3768 | 18:42:00 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:47196/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47196/tests/kraken/driver.html?testName=imaging-desaturate) 18:42:00 INFO - PROCESS | 3768 | RSS: Main: 163328000 18:42:00 INFO - PROCESS | 3768 | 18:42:03 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:47196/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47196/tests/kraken/driver.html?testName=json-parse-financial) 18:42:04 INFO - PROCESS | 3768 | RSS: Main: 165666816 18:42:04 INFO - PROCESS | 3768 | 18:42:05 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:47196/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47196/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:42:06 INFO - PROCESS | 3768 | RSS: Main: 165441536 18:42:06 INFO - PROCESS | 3768 | 18:42:08 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:47196/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47196/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:42:08 INFO - PROCESS | 3768 | RSS: Main: 165220352 18:42:08 INFO - PROCESS | 3768 | 18:42:11 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:47196/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47196/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:42:12 INFO - PROCESS | 3768 | RSS: Main: 165765120 18:42:12 INFO - PROCESS | 3768 | 18:42:15 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:47196/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47196/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:42:15 INFO - PROCESS | 3768 | RSS: Main: 166047744 18:42:15 INFO - PROCESS | 3768 | 18:42:18 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:47196/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47196/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:42:19 INFO - PROCESS | 3768 | RSS: Main: 165957632 18:42:19 INFO - PROCESS | 3768 | 18:42:20 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:47196/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47196/tests/kraken/driver.html?testName=ai-astar) 18:42:21 INFO - PROCESS | 3768 | RSS: Main: 167555072 18:42:21 INFO - PROCESS | 3768 | 18:42:21 INFO - PROCESS | 3768 | __start_tp_report 18:42:21 INFO - PROCESS | 3768 | _x_x_mozilla_page_load 18:42:21 INFO - PROCESS | 3768 | _x_x_mozilla_page_load_details 18:42:21 INFO - PROCESS | 3768 | |i|pagename|runs| 18:42:21 INFO - PROCESS | 3768 | |0;ai-astar;114;105;113;112;113;123;111;112;111;113 18:42:21 INFO - PROCESS | 3768 | |1;audio-beat-detection;154;130;152;191;128;154;155;129;174;135 18:42:21 INFO - PROCESS | 3768 | |2;audio-dft;162;162;166;164;162;165;167;175;165;163 18:42:21 INFO - PROCESS | 3768 | |3;audio-fft;73;77;77;151;74;74;77;76;161;75 18:42:21 INFO - PROCESS | 3768 | |4;audio-oscillator;93;93;158;93;92;93;139;93;92;138 18:42:21 INFO - PROCESS | 3768 | |5;imaging-gaussian-blur;120;118;118;117;117;117;118;117;117;117 18:42:21 INFO - PROCESS | 3768 | |6;imaging-darkroom;147;147;146;147;146;145;145;147;146;146 18:42:21 INFO - PROCESS | 3768 | |7;imaging-desaturate;95;95;97;96;96;96;95;96;95;96 18:42:21 INFO - PROCESS | 3768 | |8;json-parse-financial;58;58;61;58;58;68;57;78;56;65 18:42:21 INFO - PROCESS | 3768 | |9;json-stringify-tinderbox;63;64;64;63;63;63;63;63;66;62 18:42:21 INFO - PROCESS | 3768 | |10;stanford-crypto-aes;82;81;80;79;81;83;82;81;83;82 18:42:21 INFO - PROCESS | 3768 | |11;stanford-crypto-ccm;136;130;129;143;142;126;131;134;166;132 18:42:21 INFO - PROCESS | 3768 | |12;stanford-crypto-pbkdf2;167;181;172;163;175;166;168;164;167;166 18:42:21 INFO - PROCESS | 3768 | |13;stanford-crypto-sha256-iterative;71;67;70;69;70;71;74;67;68;67 18:42:21 INFO - PROCESS | 3768 | __end_tp_report 18:42:21 INFO - PROCESS | 3768 | __start_cc_report 18:42:21 INFO - PROCESS | 3768 | _x_x_mozilla_cycle_collect,863 18:42:21 INFO - PROCESS | 3768 | __end_cc_report 18:42:21 INFO - PROCESS | 3768 | __startTimestamp1460252541215__endTimestamp 18:42:21 INFO - PROCESS | 3768 | 18:42:21 INFO - PROCESS | 3768 | ------- Summary: start ------- 18:42:21 INFO - PROCESS | 3768 | Number of tests: 14 18:42:21 INFO - PROCESS | 3768 | 18:42:21 INFO - PROCESS | 3768 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:4.40 (3.9%) stddev-sans-first:4.64 18:42:21 INFO - PROCESS | 3768 | Values: 114.0 105.0 113.0 112.0 113.0 123.0 111.0 112.0 111.0 113.0 18:42:21 INFO - PROCESS | 3768 | 18:42:21 INFO - PROCESS | 3768 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:154.00 stddev:20.73 (13.5%) stddev-sans-first:21.94 18:42:21 INFO - PROCESS | 3768 | Values: 154.0 130.0 152.0 191.0 128.0 154.0 155.0 129.0 174.0 135.0 18:42:21 INFO - PROCESS | 3768 | 18:42:21 INFO - PROCESS | 3768 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:3.90 (2.4%) stddev-sans-first:3.97 18:42:21 INFO - PROCESS | 3768 | Values: 162.0 162.0 166.0 164.0 162.0 165.0 167.0 175.0 165.0 163.0 18:42:21 INFO - PROCESS | 3768 | 18:42:21 INFO - PROCESS | 3768 | [#3] audio-fft Cycles:10 Average:91.50 Median:75.50 stddev:34.11 (45.2%) stddev-sans-first:35.51 18:42:21 INFO - PROCESS | 3768 | Values: 73.0 77.0 77.0 151.0 74.0 74.0 77.0 76.0 161.0 75.0 18:42:21 INFO - PROCESS | 3768 | 18:42:21 INFO - PROCESS | 3768 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:93.00 stddev:25.81 (27.8%) stddev-sans-first:26.77 18:42:21 INFO - PROCESS | 3768 | Values: 93.0 93.0 158.0 93.0 92.0 93.0 139.0 93.0 92.0 138.0 18:42:21 INFO - PROCESS | 3768 | 18:42:21 INFO - PROCESS | 3768 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:0.97 (0.8%) stddev-sans-first:0.50 18:42:21 INFO - PROCESS | 3768 | Values: 120.0 118.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 18:42:21 INFO - PROCESS | 3768 | 18:42:21 INFO - PROCESS | 3768 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 18:42:21 INFO - PROCESS | 3768 | Values: 147.0 147.0 146.0 147.0 146.0 145.0 145.0 147.0 146.0 146.0 18:42:21 INFO - PROCESS | 3768 | 18:42:21 INFO - PROCESS | 3768 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 18:42:21 INFO - PROCESS | 3768 | Values: 95.0 95.0 97.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 18:42:21 INFO - PROCESS | 3768 | 18:42:21 INFO - PROCESS | 3768 | [#8] json-parse-financial Cycles:10 Average:61.70 Median:59.50 stddev:6.88 (11.6%) stddev-sans-first:7.17 18:42:21 INFO - PROCESS | 3768 | Values: 58.0 58.0 61.0 58.0 58.0 68.0 57.0 78.0 56.0 65.0 18:42:21 INFO - PROCESS | 3768 | 18:42:21 INFO - PROCESS | 3768 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.00 stddev:1.07 (1.7%) stddev-sans-first:1.13 18:42:21 INFO - PROCESS | 3768 | Values: 63.0 64.0 64.0 63.0 63.0 63.0 63.0 63.0 66.0 62.0 18:42:21 INFO - PROCESS | 3768 | 18:42:21 INFO - PROCESS | 3768 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:82.00 stddev:1.26 (1.5%) stddev-sans-first:1.32 18:42:21 INFO - PROCESS | 3768 | Values: 82.0 81.0 80.0 79.0 81.0 83.0 82.0 81.0 83.0 82.0 18:42:21 INFO - PROCESS | 3768 | 18:42:21 INFO - PROCESS | 3768 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:135.00 stddev:11.58 (8.6%) stddev-sans-first:12.28 18:42:21 INFO - PROCESS | 3768 | Values: 136.0 130.0 129.0 143.0 142.0 126.0 131.0 134.0 166.0 132.0 18:42:21 INFO - PROCESS | 3768 | 18:42:21 INFO - PROCESS | 3768 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:167.50 stddev:5.55 (3.3%) stddev-sans-first:5.84 18:42:21 INFO - PROCESS | 3768 | Values: 167.0 181.0 172.0 163.0 175.0 166.0 168.0 164.0 167.0 166.0 18:42:21 INFO - PROCESS | 3768 | 18:42:21 INFO - PROCESS | 3768 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:2.27 (3.2%) stddev-sans-first:2.33 18:42:21 INFO - PROCESS | 3768 | Values: 71.0 67.0 70.0 69.0 70.0 71.0 74.0 67.0 68.0 67.0 18:42:21 INFO - PROCESS | 3768 | -------- Summary: end -------- 18:42:21 INFO - PROCESS | 3768 | 18:42:22 INFO - TEST-INFO | 3768: exit 0 18:42:22 INFO - TEST-OK | kraken | took 62460ms 18:42:22 INFO - SUITE-END | took 1174s 18:42:22 INFO - Completed test suite (00:19:34) 18:42:22 INFO - javascript benchmark 18:42:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3174.1747145742106, 3230.580024596803, 3243.7242834359076, 3262.1844538865284, 3276.9508457373145, 5614.29821272341, 5617.634853734505, 5632.859178520539, 5633.577481688869, 5640.0975843864935, 5448.618596698233, 5604.215409842615, 5626.409227031164, 5634.32388113427, 5687.402822703619, 4992.625553083515, 5056.595472362221, 5113.718745468997, 5128.53843154116, 5188.896222075557, 661.9421303594186, 5064.79740810369, 5143.3313669223135, 5163.044836705203, 5192.55863251624, 5126.615503837208, 5139.074966506046, 5144.17693169093, 5147.38231412231, 5153.587712982952, 4951.702897826142, 5218.452062533455, 5225.817096401645, 5239.502247286502, 5248.160294352923, 5027.145385284511, 5073.289739436482, 5079.212722028092, 5093.0, 5116.104681680691, 5478.780848766084, 5502.8349149525175, 5523.889522209573, 5535.197396377543, 5545.085060964936, 5986.191864098335, 5994.820155395345, 5999.700014999276, 6008.699565021731, 6043.848903777397, 5937.287525496925, 5985.431384018511, 5997.040473524259, 6004.579679422399, 6059.424354686298, 5599.748011339459, 5601.915971260434, 5610.298712660918, 5622.437756224385, 5627.634203776742, 6017.2779266488305, 6119.632822030692, 6140.62695141751, 6142.170806941006, 6185.381461853869, 5942.197803296586, 5943.138244954544, 5943.673097979653, 5955.583109182316, 5969.253843269591, 6002.309734380602, 6009.278886533644, 6012.699365031731, 6023.247094113236, 6026.638401695912, 5816.796412125555, 5961.463468287789, 5983.0, 5992.101184822312, 6052.727627256784, 5728.169415434739, 5865.4134586541, 5875.441833025856, 5950.018246989285, 6014.248218972629, 4444.355568442557, 4445.2887537993765, 4464.531224221475, 4469.597736203757, 4475.037866858576, 3869.110104675884, 3944.6647035001774, 3975.483187185705, 3978.1645854370327, 3987.1228329767405, 5650.85872853182, 5655.406182350794, 5681.119426488901, 5702.087665973424, 5725.255716756878, 5924.496417804448, 6024.698765061729, 6052.818415447544, 6056.636601803906, 6068.120122582201, 5614.129809879475, 5714.342850572154, 5728.942710572925, 5782.045962416239, 5806.1000544915605, 5131.974340128276, 5134.332536770196, 5135.0, 5138.0, 5148.510891465305, 6248.50011999039, 6258.749650013949, 6259.780907668301, 6263.937360626426, 6270.6864656766975, 5845.678487683048, 5872.823815285548, 5909.349971503218, 5932.970335148297, 5950.613210141327, 6178.814635560941, 6191.351841608287, 6243.750249990131, 6250.656213908279, 6260.561760676709, 5733.713314334183, 5949.0, 5954.98765209924, 5955.315138759098, 6011.458968692838, 6016.87966240664, 6025.969870150797, 6054.0, 6066.605670631395, 6108.938910610837, 5746.109353050284, 5771.249737534094, 5780.913286300624, 5786.855328616818, 5849.210356601804, 5749.223854779719, 5817.563682723898, 5824.126381042877, 5838.854028649318, 5854.268216472941, 5654.46282603152, 5727.140928860705, 5736.139579063174, 5806.071028635398, 5863.912041319299, 5781.4507621775865, 5782.826515204551, 5906.26171728534, 5957.046872500379, 5980.37206093354, 5773.220615216892, 5809.099589563624, 5814.098814683731, 5815.2149459822385, 5830.679312637845], "value": 5485.665197395175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.4916319454853, 620.7641096383373, 663.3697986912433, 665.5308007854463, 672.2269390201269, 38240.42639360408, 38924.61075389252, 38980.22039559207, 39100.80449597748, 39235.21529569407, 40631.796841015755, 41422.37866432006, 41547.58452415475, 41602.375964360486, 41716.37425438621, 8470.110638382957, 8607.655693772273, 8710.390272680916, 8753.518556479392, 8754.343424243176, 8522.531260780655, 8667.479951202917, 8690.261327787146, 8839.823203535958, 8850.203481686647, 8862.645494180226, 8900.332475064397, 8906.554672266393, 8939.195472407482, 8956.955215223914, 8817.515036672981, 8844.823103537925, 8897.377183597184, 8902.910970890272, 8939.106089391009, 8699.782505437352, 8754.737357879274, 8802.119788021211, 8810.867836982387, 8860.069692682304, 41442.37836432456, 41516.169676606296, 41624.58375416238, 41705.1658966822, 41976.0, 3457.222125021875, 3520.2783429396914, 3927.410888366739, 4021.939670904939, 4094.7952602369764, 32123.357532849444, 32184.19539511531, 32357.83821080903, 33790.155246119044, 33797.0, 4348.543402942709, 4386.1008493258805, 4467.128909862578, 4478.193925093482, 4515.096980603859, 295868.0, 297511.0, 297598.0, 297987.0, 298890.0, 35438.82280588581, 36474.0, 36705.63294367075, 60327.09509357363, 60689.0, 35081.82459087688, 35167.824160879034, 35295.0, 35339.823300883334, 35429.0, 14154.504592339219, 14417.0, 14424.42302307896, 14425.92787036079, 14440.277986100653, 12035.939820300842, 12167.391630418444, 12242.877571224351, 12264.080193985308, 12267.57063502773, 8633.740987770378, 8637.524936128448, 8667.523286219319, 8702.434341767765, 8786.384953053353, 3346.252197538772, 3371.494275858641, 3395.5585773849243, 3403.761736678409, 3419.743519236067, 1008.0776089877826, 1013.2350075692805, 1065.5577935156823, 1124.966251012471, 1207.8369420128347, 31714.682853171635, 32171.678283217338, 32204.033878983668, 32458.675413246037, 32743.0, 1087.217203613413, 1123.1239633086207, 1135.5798354608683, 1184.5557915781583, 1200.6878211664855, 17005.57486062858, 17263.56841078983, 17295.827041729422, 17343.785934984684, 17411.65176696459, 423861.0, 429655.0, 430013.0, 430888.0, 432836.0, 57471.42528574744, 58843.0, 59015.704921475975, 59314.40685593089, 59323.406765932654, 1402.0676250293645, 1404.9367778449994, 1423.224342733192, 1424.423108641002, 1431.99044673507, 30769.384612308077, 31964.84017579897, 32118.19704507406, 32443.837780810944, 33076.66923330736, 50683.74658126686, 50820.74589627028, 51022.48977510326, 51038.74480627573, 51202.0, 379708.0, 381456.0, 384242.0, 384461.0, 384672.0, 27047.323816903947, 27899.16302510928, 29458.116256511483, 29508.557371639014, 29541.85229073927, 48358.27462587994, 48887.26669099895, 49587.50412495829, 49775.502244977084, 50166.74916625393, 40213.798931005156, 40918.1816363677, 41038.17923641451, 41469.377959331236, 42457.0, 39743.602563975146, 40319.79840100781, 41050.41766701677, 41453.0, 41746.0, 42644.0, 42821.78589107034, 43075.0, 43808.78095609502, 43969.560304396546, 33079.0, 34581.27882932992, 34844.30311393707, 35394.292114157055, 35614.64385356217, 27766.722332777223, 28381.858090709415, 28466.0, 28678.71321286844, 28726.281842954093], "value": 18592.332376616243, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.15193637552045, 399.16375193968645, 399.43280541630884, 402.7100487648893, 413.7414116177389, 13454.932725336384, 15445.84554154458, 17940.282388704454, 18618.906905465472, 18636.62726745466, 15511.92244038781, 17771.91114044428, 18758.06209689517, 18795.154218060186, 18990.81009189908, 5216.26972223889, 5285.0, 5366.248725178478, 5421.430749771257, 5454.945450545483, 5314.468553144693, 5358.035553600351, 5358.65168764031, 5376.596755243353, 5395.298611180541, 5174.0, 5299.072662284104, 5316.229146773716, 5375.516203541681, 5385.7307134643115, 5271.077561426754, 5312.256284120226, 5328.17413300939, 5353.839384818461, 5377.946220537803, 4768.57082862544, 5146.6911985281, 5148.897022059576, 5172.715500647463, 5182.637215394924, 13185.472581096745, 13352.0, 16757.748633770505, 22514.66228006581, 22571.661425078637, 2157.7087093242367, 2162.102727368156, 2293.3578597992587, 2374.25211058516, 2616.0974463810144, 9666.516674166263, 9847.80304393908, 10075.969612155124, 10115.241356898188, 10196.796064078677, 1831.3224107080332, 1886.0, 1916.9520761980923, 1942.4949513126548, 1985.642584334819, 76040.0, 77393.0, 77936.0, 79800.60099699523, 81821.0, 10448.164146868232, 10638.468076596138, 10786.083182929538, 10825.837612435662, 10853.294535855144, 15447.5365739028, 15506.069635821887, 15509.146996915279, 15514.224288785741, 15542.378304867678, 6983.685734141975, 7469.887951680729, 7518.624068796538, 7664.118626357928, 7787.338076263581, 6961.199462061826, 7532.7740167795055, 7641.847163056707, 7650.617469126632, 7772.455928085093, 4652.930206046912, 4675.13510000651, 4698.788554515055, 4698.906021879611, 4711.882202944886, 1947.9707804382945, 1954.5113721569608, 1964.1912065745835, 2010.3767831971843, 2046.19175425709, 916.812053529025, 935.9251259899191, 1022.7136401807505, 1063.3619828103076, 1100.3068067117665, 17861.28554857791, 18314.45056648303, 18646.720299195524, 18763.81236187648, 19027.619447611247, 952.6808519146025, 956.8995255498072, 1014.1329163565046, 1021.3463383434607, 1024.538957469142, 10701.571937122428, 10910.672679819618, 10914.0, 10934.726631834268, 10959.726006849893, 438047.0, 456811.0, 490822.0, 495411.0, 497281.0, 89993.55003224942, 95543.0, 95801.0, 96227.0, 96500.51749741347, 1059.814532456817, 1069.3316677076828, 1082.4966390628394, 1091.939943303126, 1108.4790148630132, 17158.742618860975, 17268.0, 17275.308987640354, 17347.219375127897, 17460.301587936847, 36099.0, 36848.526058957345, 36882.44676329911, 37375.62624373721, 37629.0, 39170.0, 46029.76985115053, 48559.0, 48572.0, 48965.510344896094, 8072.717454889051, 8422.115677853983, 8464.280536154249, 8635.179657932485, 8775.605097770744, 11769.823452648046, 12940.611781646188, 13022.4139913706, 13234.139780914209, 13352.532661356807, 10610.098141658045, 10620.150387969099, 11122.666320010412, 11128.332300061698, 11386.0, 11355.716107097389, 11591.304521728724, 11596.0, 11664.241824281395, 11896.345700986529, 11352.772944540899, 11432.314061156358, 11480.540778368771, 11533.480993355486, 11548.59579914699, 7463.253674632493, 7928.960355198187, 8461.23848853606, 8625.051244362989, 8901.287896968357, 11289.0, 11424.086073113966, 11484.36835973996, 11499.482523286304, 11649.242799218024], "value": 8841.985033451549, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.2150121186373, 1512.092744353388, 1691.906945118018, 1781.9910900445511, 1822.14359251152, 7568.659410326535, 8071.596420178989, 8223.91776082239, 8301.460405073674, 8304.50172989621, 8215.0, 8266.338692904568, 8287.46131501452, 8314.0, 8325.791855203623, 2326.720793504782, 2368.5026144509675, 2371.3360259127385, 2373.2524254859663, 2379.0602711928777, 2308.1805958884606, 2323.14043803792, 2331.4171457135717, 2333.754955729641, 2335.2877372401413, 2318.2813327868416, 2322.2104484475276, 2342.61346877765, 2365.6688063671013, 2369.052379048386, 2227.7994980451836, 2247.5617254635354, 2250.4373906523288, 2255.76314486979, 2303.55080759252, 2261.604219261623, 2265.592193405186, 2266.05958527211, 2271.6251818449937, 2281.5094754627667, 8451.11263317349, 8454.788630284293, 8480.618372173267, 8512.531810750406, 8546.487210767375, 4976.8755781105765, 5097.286379906816, 5113.82101626445, 5146.330976972969, 5146.485351464824, 3290.4899740540254, 3337.8831740888954, 3380.070480617825, 3439.8968030959113, 3445.6898879101, 1123.2979387882574, 1131.377742241772, 1135.7217481717032, 1153.5155234801402, 1177.8115501519715, 10953.0, 11087.168462365275, 11094.55621775128, 11126.777464450828, 11144.498497567629, 4367.10474352757, 4391.187630288407, 4494.70784399013, 4512.684112112186, 4532.864014079583, 9028.503432311287, 9159.992400835903, 9197.448153110834, 9205.539723013822, 9207.907920920705, 5161.587073034223, 5168.3539557555305, 5201.375834899836, 5201.921971170435, 5226.059309324282, 4288.228118938621, 4551.6813823032735, 4734.810607575659, 4756.239001759771, 4851.975740121276, 3668.3947148720695, 3677.5219221501034, 3753.9061523461587, 3786.5456145262747, 3798.525184351956, 1141.560499207811, 1146.220570012383, 1147.6729132197283, 1160.512584714422, 1162.3490845126587, 1318.314476472229, 1347.3734713358335, 1349.1837438349853, 1453.5348688419815, 1459.9926051024759, 8097.190280971973, 8180.222878826502, 8234.341252699769, 8243.587820608946, 8245.505269683837, 453.14808160657753, 466.8109415686652, 472.357593672605, 478.7965114826185, 479.5899505922456, 6362.491000719931, 6376.3623637635865, 6429.38920802523, 6516.413522782972, 6526.216853977553, 9927.354721943051, 10199.18406527476, 10349.534270957825, 10382.688519344432, 10456.947715261374, 10046.547905344278, 10075.445850478294, 10258.230632702576, 10282.07461328484, 10325.690229293134, 7782.6886924523515, 7861.095973962953, 7864.921350786533, 7875.251851074138, 7912.169222231698, 7772.45592808498, 8003.5197888126895, 8029.197080291924, 8040.155783642867, 8089.514629122272, 9113.77215569616, 9356.625734970525, 9565.139137477661, 9611.0, 9672.226221902372, 9112.544372781467, 9376.109269619375, 9442.716718498456, 9496.525173741424, 9538.332316738039, 6872.862542749017, 7218.205997340184, 7438.479306448497, 7479.177290497932, 7637.274458926393, 8022.9197708022175, 8047.436679432383, 8084.959575202086, 8087.878681819895, 8090.757277281691, 7077.893831592633, 7338.926610734038, 7358.448116391185, 7422.294881986203, 7460.0301960744755, 7111.53775004623, 7250.129984401906, 7329.890051649336, 7334.193238743627, 7382.3724983377015, 7764.767056988299, 7773.572453514885, 7835.686572537263, 7850.803729906798, 7858.0570331560575, 6812.352826481477, 7181.281871812777, 7198.244184360567, 7242.022326986, 7258.237885021997, 7186.496945213785, 7244.094488188976, 7252.927470725225, 7267.563946163247, 7281.635918203962], "value": 4692.738094618527, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.19204389574764, 344.4402845376262, 345.93427248822735, 353.1330583417709, 353.1947160474118, 6016.157737916689, 6091.025435930252, 6103.572749907508, 6142.631442113477, 6169.969150154248, 5849.619774714641, 6012.3085845127825, 6020.849478763033, 6021.548383871216, 6039.5772295939305, 4615.746133962631, 4617.399738034051, 4626.4910859805395, 4630.791614377345, 4643.767811609423, 4646.79089440976, 4652.255639097745, 4655.092257009885, 4655.185342565038, 4659.813607455715, 4519.937814613563, 4599.402077729907, 4618.191816432128, 4624.075184963004, 4625.098105869357, 4577.313402989545, 4587.288970209606, 4592.15045216636, 4607.516210797869, 4608.124456353282, 4042.818073186684, 4044.6359827615656, 4060.112047897742, 4060.898477538085, 4066.2680717470844, 5658.179563963244, 5798.42015798421, 5818.330891947396, 5824.737886795105, 5831.183634291203, 5321.866953326159, 5335.866603334909, 5336.946630533723, 5374.355077390738, 5378.46215378463, 6303.432691057827, 6306.653134077624, 6318.905216421757, 6327.746890124389, 6337.239531256233, 4413.867583972486, 4429.446319210098, 4480.977595112036, 4525.0, 4529.796159172845, 6258.24901011877, 6456.8062958111805, 6590.110335104795, 6593.50548708844, 6612.86774264512, 4589.495155532889, 4613.746243956614, 4648.0239149778245, 4650.4186976627925, 4654.232051711429, 4644.419447569054, 4650.465196502378, 4672.929906051412, 4683.625309975194, 4699.953000469952, 5248.6588371755715, 5363.597730170253, 5364.946350536445, 5367.194920761917, 5379.354477462652, 6353.332900045429, 6359.618422894641, 6376.7043864208845, 6387.457066149336, 6403.199600049994, 1599.912004839745, 1632.330744394816, 1643.7205675035034, 1648.3406637345158, 1651.5293141454629, 1023.2325755683238, 1055.6780182044397, 1057.8889216632297, 1060.2578195263347, 1113.916456265767, 6084.209052823193, 6093.329733729286, 6112.349665590355, 6163.291221509494, 6171.352008039181, 6348.0, 6450.161703914362, 6458.6770661466735, 6495.6752162391695, 6574.967125164344, 6051.788187413419, 6120.898238317057, 6131.264248290145, 6135.233095863017, 6157.415045570664, 3488.8081155536183, 3507.105688049531, 3508.8596456141977, 3533.823308834548, 3550.928981420357, 6563.474922006228, 6648.634325112069, 6662.267150613428, 6766.424853887376, 6790.932090679129, 6566.244881838554, 6592.835179120464, 6594.802155935329, 6595.439387652007, 6639.435647969976, 6624.39247413353, 6730.158730158731, 6739.528233023641, 6784.559003664746, 6795.864082718318, 6409.230892292955, 6430.582012169194, 6467.450266727193, 6489.286178520453, 6531.836704082436, 6222.3910132124165, 6298.1812364392335, 6303.6532990685955, 6404.807855764335, 6440.486485675956, 6737.787198304352, 6833.214180369122, 6886.24251332363, 6905.102336696197, 6932.861342773217, 4487.967767413448, 4530.660200485043, 4531.297648864432, 4564.680472366902, 4571.1771881060395, 6453.322401147811, 6599.703013364506, 6646.60120392778, 6673.733050677918, 6679.730851138268, 6374.310807636073, 6419.325970773189, 6430.614163150226, 6436.292007879036, 6436.935630643821, 6194.132821405097, 6352.36476352361, 6443.355664433519, 6464.288928217987, 6466.838329041811, 6316.526260530387, 6325.240971083499, 6349.111124442674, 6374.521910856612, 6397.712102955285, 6116.480099191618, 6467.482601391972, 6509.804705858832, 6523.282438931618, 6541.0, 6321.807487218925, 6321.810345689637, 6322.36776322364, 6350.555461117678, 6352.538916049242], "value": 4819.530380412539, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.4765533265048, 784.690047431265, 787.3425689549227, 812.4069429316598, 870.0777176193232, 13634.318284085793, 13779.379927903243, 13796.586102416932, 14475.710485790278, 15073.849261507381, 15696.529104126867, 15700.76448853268, 15717.214139293046, 15809.288582013809, 15831.287592058356, 676.1784431915222, 825.7110011495988, 827.9793005174889, 834.0075310380628, 834.1741675741018, 815.6329651656748, 828.1263267253075, 830.0703212402088, 831.2518733140192, 832.3549249331755, 853.4154104438448, 870.6734974384606, 872.1540106097108, 874.5976850648709, 874.6982291109557, 861.6725644255174, 870.0820634230884, 873.0701802580263, 873.9388242822941, 874.6326542851954, 629.0752593687272, 635.2884769058637, 635.4916067146264, 637.1557686065981, 639.6034458635629, 13317.467301308034, 13329.0, 13332.866671333259, 13365.198088114745, 13371.465141394332, 14103.224322662249, 14158.858411415857, 14171.645708857259, 14234.786478202835, 14250.073745206631, 11998.760024799543, 12043.698907527381, 12069.57756478519, 12183.634490965285, 12203.0, 3863.5750067492554, 3870.2646497165447, 3968.0675041365257, 3970.7419017763755, 4021.316376216021, 57421.0, 57528.42471575273, 57741.711291443695, 57898.13152802754, 57908.71045644745, 11087.667369978913, 11271.211015229019, 11354.48904799286, 11948.701282467833, 12018.75962480763, 19509.414717558495, 19596.118174682175, 19780.71425357347, 19805.30681426172, 19871.900640496704, 8285.088640249567, 8356.874646880302, 8587.484750914966, 8828.382013259139, 8883.822323553493, 4823.0, 4866.659333846596, 4955.430125535538, 4961.305417241589, 5028.667403138172, 3352.782069165545, 3746.269477451925, 3907.4138879168354, 3908.4332771747936, 3912.7456715313415, 704.2605264472284, 707.5860621536459, 716.3839098375392, 719.5682590445796, 735.5586648011257, 765.2959277464635, 772.748856621589, 785.4227143049853, 802.1096582793095, 821.4167940762006, 9254.35219534626, 9531.857022144535, 9574.281928855364, 9715.417074975525, 9809.166220871162, 618.9009758438629, 701.260170520096, 761.3566536276837, 764.10217993857, 767.6046835879526, 4435.933460998088, 4545.931811022837, 4548.090381923628, 4548.295014272793, 4569.885752856138, 67088.0, 67461.0, 68071.65964170148, 68437.3156268441, 68514.31485685079, 59945.0, 59974.70012649996, 60133.699331503936, 60642.0, 60980.39019609836, 52836.47163528315, 54163.72918135384, 54498.45501544934, 55064.0, 55262.0, 8647.0, 8870.556472176237, 8950.597223124845, 8981.461112333282, 9111.137719770699, 33980.32039359248, 34623.13442163966, 34821.0, 34979.82510087535, 35403.29193416169, 44868.32697509605, 47690.28464572965, 47981.76009119932, 48364.274535882694, 48574.0, 12373.75252494963, 12445.37773111359, 12547.3098979557, 12728.936355318165, 12916.8062479061, 13418.731625367633, 13860.099093558887, 13939.51211707626, 13969.511067112602, 14025.859741402455, 13171.802422963472, 13359.53241636538, 13634.181949083088, 13860.306984650928, 14142.22217778032, 12845.486180552673, 13476.595702128952, 13600.93199533996, 13736.244506552235, 13801.585952421443, 13514.662133446742, 13590.728185436434, 13643.727125457634, 13734.862651373758, 14204.076735012191, 10946.890531094905, 11210.551577937118, 11263.943680281875, 11431.199816013132, 11752.70618234551, 11580.189386743185, 11600.767984640092, 11639.0, 11911.166218364979, 12153.817692734792], "value": 7065.898171721175, "unit": "score"}], "name": "dromaeo_css", "value": 7240.877633057186, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 105.0, 113.0, 112.0, 113.0, 123.0, 111.0, 112.0, 111.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 130.0, 152.0, 191.0, 128.0, 154.0, 155.0, 129.0, 174.0, 135.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 166.0, 164.0, 162.0, 165.0, 167.0, 175.0, 165.0, 163.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 77.0, 151.0, 74.0, 74.0, 77.0, 76.0, 161.0, 75.0], "value": 91.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 158.0, 93.0, 92.0, 93.0, 139.0, 93.0, 92.0, 138.0], "value": 108.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 145.0, 145.0, 147.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 61.0, 58.0, 58.0, 68.0, 57.0, 78.0, 56.0, 65.0], "value": 61.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 66.0, 62.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 80.0, 79.0, 81.0, 83.0, 82.0, 81.0, 83.0, 82.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 130.0, 129.0, 143.0, 142.0, 126.0, 131.0, 134.0, 166.0, 132.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 181.0, 172.0, 163.0, 175.0, 166.0, 168.0, 164.0, 167.0, 166.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 70.0, 69.0, 70.0, 71.0, 74.0, 67.0, 68.0, 67.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1569.1000000000006, "alertThreshold": 2.0}]} 18:42:22 INFO - Return code: 0 18:42:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 18:42:22 ERROR - # TBPL SUCCESS # 18:42:22 INFO - Running post-action listener: _resource_record_post_action 18:42:22 INFO - Running post-run listener: _resource_record_post_run 18:42:23 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 7933952; Write bytes: 417320960; Read time: 1748; Write time: 441924 18:42:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5836800; Read time: 0; Write time: 1336 18:42:23 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 6172672; Write bytes: 411484160; Read time: 1700; Write time: 440588 18:42:23 INFO - Running post-run listener: _upload_blobber_files 18:42:23 INFO - Blob upload gear active. 18:42:23 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 18:42: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 18:42: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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 18:42: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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 18:42:24 INFO - (blobuploader) - INFO - Open directory for files ... 18:42:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:42:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:42:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:24 INFO - (blobuploader) - INFO - Done attempting. 18:42:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:42:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:42:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:25 INFO - (blobuploader) - INFO - Done attempting. 18:42:25 INFO - (blobuploader) - INFO - Iteration through files over. 18:42:25 INFO - Return code: 0 18:42:25 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 18:42:25 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 18:42:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2e87005a6c6dc630d6ae23cefbf201d227f532e024320c865cd55d405a3a1b156a9ad7b6dc1a16d9b46a54071eda07a501dd86d3ac8d495db8815034d8b92a8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f5ba3a2ae9e1ea6ca802203998641f1428eb7ed7a65f588b14dc581d8f19f77faa8250eca5d34794756f605ed98485aab8922ed97cd1c6807093ee6c767fa348"} 18:42:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 18:42:25 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 18:42:25 INFO - Contents: 18:42:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2e87005a6c6dc630d6ae23cefbf201d227f532e024320c865cd55d405a3a1b156a9ad7b6dc1a16d9b46a54071eda07a501dd86d3ac8d495db8815034d8b92a8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f5ba3a2ae9e1ea6ca802203998641f1428eb7ed7a65f588b14dc581d8f19f77faa8250eca5d34794756f605ed98485aab8922ed97cd1c6807093ee6c767fa348"} 18:42:25 INFO - Running post-run listener: copy_logs_to_upload_dir 18:42:25 INFO - Copying logs to upload dir... 18:42:25 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 18:42:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1303.464126 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2016-04-09 18:42:25.621743) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-09 18:42:25.625683) ========= 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=ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313 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/Mozilla-Inbound/sha512/2e87005a6c6dc630d6ae23cefbf201d227f532e024320c865cd55d405a3a1b156a9ad7b6dc1a16d9b46a54071eda07a501dd86d3ac8d495db8815034d8b92a8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f5ba3a2ae9e1ea6ca802203998641f1428eb7ed7a65f588b14dc581d8f19f77faa8250eca5d34794756f605ed98485aab8922ed97cd1c6807093ee6c767fa348"} build_url:https://queue.taskcluster.net/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011157 build_url: 'https://queue.taskcluster.net/v1/task/D8gEd8kLTkWKcJTThSeSjQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2e87005a6c6dc630d6ae23cefbf201d227f532e024320c865cd55d405a3a1b156a9ad7b6dc1a16d9b46a54071eda07a501dd86d3ac8d495db8815034d8b92a8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f5ba3a2ae9e1ea6ca802203998641f1428eb7ed7a65f588b14dc581d8f19f77faa8250eca5d34794756f605ed98485aab8922ed97cd1c6807093ee6c767fa348"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-09 18:42:25.650845) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:42:25.651203) ========= 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=ed14279e38b05397cf4aa391000001a4-1460248363.807199-1284510313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.005071 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:42:25.733076) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-09 18:42:25.733409) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-09 18:42:25.733703) ========= ========= Total master_lag: 1.43 =========