builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1457010476.69 results: success (0) buildid: 20160303023018 builduid: f6d080f1fbd84f66a1321edd02911545 revision: ca53292a4ca31712c9c826296d90d231f8a0bca2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:56.688363) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:56.688829) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:56.689461) ========= 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=232498196343f89f466a4a9a000001c8-1457009043.339429-96061994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006337 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:56.717566) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:56.717909) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:56.777922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:56.778221) ========= 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=232498196343f89f466a4a9a000001c8-1457009043.339429-96061994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009920 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:56.830939) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:56.831263) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:56.831703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:56.832016) ========= 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=232498196343f89f466a4a9a000001c8-1457009043.339429-96061994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-03 05:07:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 215M=0s 2016-03-03 05:07:56 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092537 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:56.941192) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:56.941511) ========= 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=232498196343f89f466a4a9a000001c8-1457009043.339429-96061994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.103497 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:57.057234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:57.057589) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ca53292a4ca31712c9c826296d90d231f8a0bca2 --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/fx-team --rev ca53292a4ca31712c9c826296d90d231f8a0bca2 --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=232498196343f89f466a4a9a000001c8-1457009043.339429-96061994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-03 05:07:57,182 truncating revision to first 12 chars 2016-03-03 05:07:57,182 Setting DEBUG logging. 2016-03-03 05:07:57,182 attempt 1/10 2016-03-03 05:07:57,182 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ca53292a4ca3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-03 05:07:57,534 unpacking tar archive at: fx-team-ca53292a4ca3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.650541 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:57.722300) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:57.722669) ========= echo ca53292a4ca31712c9c826296d90d231f8a0bca2 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ca53292a4ca31712c9c826296d90d231f8a0bca2'] 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=232498196343f89f466a4a9a000001c8-1457009043.339429-96061994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ca53292a4ca31712c9c826296d90d231f8a0bca2 program finished with exit code 0 elapsedTime=0.003749 script_repo_revision: 'ca53292a4ca31712c9c826296d90d231f8a0bca2' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:57.771821) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:57.772177) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 05:07:57.786203) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-03 05:07:57.786519) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=232498196343f89f466a4a9a000001c8-1457009043.339429-96061994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:07:58 INFO - MultiFileLogger online at 20160303 05:07:58 in /builds/slave/test-pgo 05:07:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:07:58 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:07:58 INFO - {'append_to_log': False, 05:07:58 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:07:58 INFO - 'blob_upload_branch': 'Fx-Team', 05:07:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:07:58 INFO - 'branch': 'Fx-Team', 05:07:58 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:58 INFO - 'config_files': ('talos/linux_config.py',), 05:07:58 INFO - 'default_actions': ('clobber', 05:07:58 INFO - 'read-buildbot-config', 05:07:58 INFO - 'download-and-extract', 05:07:58 INFO - 'populate-webroot', 05:07:58 INFO - 'create-virtualenv', 05:07:58 INFO - 'install', 05:07:58 INFO - 'run-tests'), 05:07:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:58 INFO - 'download_minidump_stackwalk': True, 05:07:58 INFO - 'download_symbols': 'ondemand', 05:07:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:58 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:58 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:58 INFO - 'installer_path': 'installer.exe', 05:07:58 INFO - 'log_level': 'info', 05:07:58 INFO - 'log_name': 'talos', 05:07:58 INFO - 'log_to_console': True, 05:07:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:07:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:07:58 INFO - 'opt_config_files': (), 05:07:58 INFO - 'pip_index': False, 05:07:58 INFO - 'sps_profile': False, 05:07:58 INFO - 'sps_profile_interval': 0, 05:07:58 INFO - 'suite': 'dromaeojs-e10s', 05:07:58 INFO - 'system_bits': '32', 05:07:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:58 INFO - 'title': 'talos-linux64-ix-025', 05:07:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:58 INFO - 'use_talos_json': True, 05:07:58 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:07:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:58 INFO - 'work_dir': 'build'} 05:07:58 INFO - ##### 05:07:58 INFO - ##### Running clobber step. 05:07:58 INFO - ##### 05:07:58 INFO - Running pre-action listener: _resource_record_pre_action 05:07:58 INFO - Running main action method: clobber 05:07:58 INFO - rmtree: /builds/slave/test-pgo/build 05:07:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:08:03 INFO - Running post-action listener: _resource_record_post_action 05:08:03 INFO - ##### 05:08:03 INFO - ##### Running read-buildbot-config step. 05:08:03 INFO - ##### 05:08:03 INFO - Running pre-action listener: _resource_record_pre_action 05:08:03 INFO - Running main action method: read_buildbot_config 05:08:03 INFO - Using buildbot properties: 05:08:03 INFO - { 05:08:03 INFO - "project": "", 05:08:03 INFO - "product": "firefox", 05:08:03 INFO - "script_repo_revision": "production", 05:08:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:08:03 INFO - "repository": "", 05:08:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:08:03 INFO - "buildid": "20160303023018", 05:08:03 INFO - "pgo_build": "True", 05:08:03 INFO - "basedir": "/builds/slave/test-pgo", 05:08:03 INFO - "buildnumber": 536, 05:08:03 INFO - "slavename": "talos-linux64-ix-025", 05:08:03 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:08:03 INFO - "platform": "ubuntu64_hw", 05:08:03 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:08:03 INFO - "branch": "fx-team", 05:08:03 INFO - "repo_path": "integration/fx-team", 05:08:03 INFO - "revision": "ca53292a4ca31712c9c826296d90d231f8a0bca2", 05:08:03 INFO - "stage_platform": "linux64-pgo", 05:08:03 INFO - "builduid": "f6d080f1fbd84f66a1321edd02911545", 05:08:03 INFO - "slavebuilddir": "test" 05:08:03 INFO - } 05:08:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 05:08:03 INFO - Running post-action listener: _resource_record_post_action 05:08:03 INFO - ##### 05:08:03 INFO - ##### Running download-and-extract step. 05:08:03 INFO - ##### 05:08:03 INFO - Running pre-action listener: _resource_record_pre_action 05:08:03 INFO - Running main action method: download_and_extract 05:08:03 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:03 INFO - https://queue.taskcluster.net/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:08:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 05:08:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 05:08:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 05:08:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:08:05 INFO - Downloaded 1448 bytes. 05:08:05 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 05:08:05 INFO - Using the following test package requirements: 05:08:05 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:08:05 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:08:05 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:08:05 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:05 INFO - u'jsshell-linux-x86_64.zip'], 05:08:05 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:08:05 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:08:05 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:08:05 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:08:05 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:08:05 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:08:05 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:08:05 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:08: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')]} 05:08:05 INFO - https://queue.taskcluster.net/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:08:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:08:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:08:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:08:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:08:07 INFO - Downloaded 23394711 bytes. 05:08:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:08:07 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:08:08 INFO - Return code: 0 05:08:08 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:08 INFO - https://queue.taskcluster.net/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:08:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:08:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:08:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:08:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:08:11 INFO - Downloaded 23394711 bytes. 05:08:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:08:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:08:12 INFO - Return code: 0 05:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:12 INFO - https://queue.taskcluster.net/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:08:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:08:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:08:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:08:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:08:13 INFO - Downloaded 10808263 bytes. 05:08:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:08:13 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:08:13 INFO - Return code: 0 05:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:13 INFO - https://queue.taskcluster.net/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:08:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:08:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:08:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:08:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:08:14 INFO - Downloaded 56077274 bytes. 05:08:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:08:14 INFO - mkdir: /builds/slave/test-pgo/properties 05:08:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:08:14 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:08:14 INFO - Contents: 05:08:14 INFO - build_url:https://queue.taskcluster.net/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:08:15 INFO - Running post-action listener: _resource_record_post_action 05:08:15 INFO - Running post-action listener: set_extra_try_arguments 05:08:15 INFO - ##### 05:08:15 INFO - ##### Running populate-webroot step. 05:08:15 INFO - ##### 05:08:15 INFO - Running pre-action listener: _resource_record_pre_action 05:08:15 INFO - Running main action method: populate_webroot 05:08:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:08:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:08:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:08:15 INFO - '--tppagecycles', 05:08:15 INFO - '7'], 05:08:15 INFO - 'tests': ['tsvgm']}}, 05:08:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:08:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:08:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:08:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:08:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:08:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:08:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:15 INFO - 'talos_options': ['--e10s'], 05:08:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:15 INFO - 'tests': ['damp', 'tps']}, 05:08:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:15 INFO - 'talos_options': ['--e10s'], 05:08:15 INFO - 'tests': ['damp', 'tps']}, 05:08:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:08:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:08:15 INFO - 'other': {'tests': ['a11yr', 05:08:15 INFO - 'ts_paint', 05:08:15 INFO - 'tpaint', 05:08:15 INFO - 'sessionrestore', 05:08:15 INFO - 'sessionrestore_no_auto_restore']}, 05:08:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:08:15 INFO - 'tests': ['a11yr', 05:08:15 INFO - 'ts_paint', 05:08:15 INFO - 'tpaint', 05:08:15 INFO - 'sessionrestore', 05:08:15 INFO - 'sessionrestore_no_auto_restore']}, 05:08:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:08:15 INFO - 'tests': ['a11yr', 05:08:15 INFO - 'ts_paint', 05:08:15 INFO - 'tpaint', 05:08:15 INFO - 'sessionrestore', 05:08:15 INFO - 'sessionrestore_no_auto_restore']}, 05:08:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:08:15 INFO - 'tests': ['a11yr', 05:08:15 INFO - 'ts_paint', 05:08:15 INFO - 'tpaint', 05:08:15 INFO - 'sessionrestore', 05:08:15 INFO - 'sessionrestore_no_auto_restore']}, 05:08:15 INFO - 'other_l64': {'tests': ['a11yr', 05:08:15 INFO - 'ts_paint', 05:08:15 INFO - 'tpaint', 05:08:15 INFO - 'sessionrestore', 05:08:15 INFO - 'sessionrestore_no_auto_restore']}, 05:08:15 INFO - 'other_nol64': {'tests': ['a11yr', 05:08:15 INFO - 'ts_paint', 05:08:15 INFO - 'tpaint', 05:08:15 INFO - 'sessionrestore', 05:08:15 INFO - 'sessionrestore_no_auto_restore']}, 05:08:15 INFO - 'svgr': {'tests': ['tsvgx', 05:08:15 INFO - 'tsvgr_opacity', 05:08:15 INFO - 'tart', 05:08:15 INFO - 'tscrollx', 05:08:15 INFO - 'cart']}, 05:08:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:08:15 INFO - 'tests': ['tsvgx', 05:08:15 INFO - 'tsvgr_opacity', 05:08:15 INFO - 'tart', 05:08:15 INFO - 'tscrollx', 05:08:15 INFO - 'cart']}, 05:08:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:15 INFO - 'tests': ['tp5o']}, 05:08:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:15 INFO - 'talos_options': ['--e10s'], 05:08:15 INFO - 'tests': ['tp5o']}, 05:08:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:15 INFO - 'talos_options': ['--xperf_path', 05:08:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:15 INFO - 'tests': ['tp5n']}, 05:08:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:15 INFO - 'talos_options': ['--e10s', 05:08:15 INFO - '--xperf_path', 05:08:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:15 INFO - 'tests': ['tp5n']}}, 05:08:15 INFO - 'talos.zip': {'path': '', 05:08:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:08:15 INFO - Running post-action listener: _resource_record_post_action 05:08:15 INFO - ##### 05:08:15 INFO - ##### Running create-virtualenv step. 05:08:15 INFO - ##### 05:08:15 INFO - Running pre-action listener: _resource_record_pre_action 05:08:15 INFO - Running main action method: create_virtualenv 05:08:15 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:08:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:08:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:08:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:08:15 INFO - Using real prefix '/usr' 05:08:15 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:08:16 INFO - Installing distribute.............................................................................................................................................................................................done. 05:08:18 INFO - Installing pip.................done. 05:08:18 INFO - Return code: 0 05:08:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:18 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 0x7f14a9fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2051920>, '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 0x2052820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2052cb0>, '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': '232498196343f89f466a4a9a000001c8-1457009043.339429-96061994', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:08:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:08:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:08:18 INFO - Using env: {'DISPLAY': ':0', 05:08:18 INFO - 'HOME': '/home/cltbld', 05:08:18 INFO - 'LANG': 'en_US.UTF-8', 05:08:18 INFO - 'LANGUAGE': 'en_US:en', 05:08:18 INFO - 'LOGNAME': 'cltbld', 05:08:18 INFO - 'MAIL': '/var/mail/cltbld', 05:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:18 INFO - 'MOZ_NO_REMOTE': '1', 05:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:18 INFO - 'NO_EM_RESTART': '1', 05:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:08:18 INFO - 'PWD': '/builds/slave/test-pgo', 05:08:18 INFO - 'SHELL': '/bin/bash', 05:08:18 INFO - 'SHLVL': '1', 05:08:18 INFO - 'TERM': 'linux', 05:08:18 INFO - 'TMOUT': '86400', 05:08:18 INFO - 'USER': 'cltbld', 05:08:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457009043.339429-96061994', 05:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:18 INFO - '_': '/tools/buildbot/bin/python'} 05:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:08:18 INFO - Cleaning up... 05:08:18 INFO - Return code: 0 05:08:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:18 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 0x7f14a9fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2051920>, '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 0x2052820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2052cb0>, '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': '232498196343f89f466a4a9a000001c8-1457009043.339429-96061994', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:08:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:08:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:08:18 INFO - Using env: {'DISPLAY': ':0', 05:08:18 INFO - 'HOME': '/home/cltbld', 05:08:18 INFO - 'LANG': 'en_US.UTF-8', 05:08:18 INFO - 'LANGUAGE': 'en_US:en', 05:08:18 INFO - 'LOGNAME': 'cltbld', 05:08:18 INFO - 'MAIL': '/var/mail/cltbld', 05:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:18 INFO - 'MOZ_NO_REMOTE': '1', 05:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:18 INFO - 'NO_EM_RESTART': '1', 05:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:08:18 INFO - 'PWD': '/builds/slave/test-pgo', 05:08:18 INFO - 'SHELL': '/bin/bash', 05:08:18 INFO - 'SHLVL': '1', 05:08:18 INFO - 'TERM': 'linux', 05:08:18 INFO - 'TMOUT': '86400', 05:08:18 INFO - 'USER': 'cltbld', 05:08:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457009043.339429-96061994', 05:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:18 INFO - '_': '/tools/buildbot/bin/python'} 05:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:18 INFO - Downloading/unpacking psutil>=0.7.1 05:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:08:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:20 INFO - Installing collected packages: psutil 05:08:20 INFO - Running setup.py install for psutil 05:08:20 INFO - building 'psutil._psutil_linux' extension 05:08:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:08:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:08:20 INFO - building 'psutil._psutil_posix' extension 05:08:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:08:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:08:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:20 INFO - Successfully installed psutil 05:08:21 INFO - Cleaning up... 05:08:21 INFO - Return code: 0 05:08:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:08: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')]} 05:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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', '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 0x7f14a9fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2051920>, '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 0x2052820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2052cb0>, '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': '232498196343f89f466a4a9a000001c8-1457009043.339429-96061994', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:08: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:08: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 mozsystemmonitor==0.0.0 05:08:21 INFO - Using env: {'DISPLAY': ':0', 05:08:21 INFO - 'HOME': '/home/cltbld', 05:08:21 INFO - 'LANG': 'en_US.UTF-8', 05:08:21 INFO - 'LANGUAGE': 'en_US:en', 05:08:21 INFO - 'LOGNAME': 'cltbld', 05:08:21 INFO - 'MAIL': '/var/mail/cltbld', 05:08:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:21 INFO - 'MOZ_NO_REMOTE': '1', 05:08:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:21 INFO - 'NO_EM_RESTART': '1', 05:08:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:08:21 INFO - 'PWD': '/builds/slave/test-pgo', 05:08:21 INFO - 'SHELL': '/bin/bash', 05:08:21 INFO - 'SHLVL': '1', 05:08:21 INFO - 'TERM': 'linux', 05:08:21 INFO - 'TMOUT': '86400', 05:08:21 INFO - 'USER': 'cltbld', 05:08:21 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457009043.339429-96061994', 05:08:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:21 INFO - '_': '/tools/buildbot/bin/python'} 05:08:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:08:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:08:23 INFO - Installing collected packages: mozsystemmonitor 05:08:23 INFO - Running setup.py install for mozsystemmonitor 05:08:23 INFO - Successfully installed mozsystemmonitor 05:08:23 INFO - Cleaning up... 05:08:23 INFO - Return code: 0 05:08:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:23 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 0x7f14a9fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2051920>, '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 0x2052820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2052cb0>, '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': '232498196343f89f466a4a9a000001c8-1457009043.339429-96061994', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:08:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:08:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:08:23 INFO - Using env: {'DISPLAY': ':0', 05:08:23 INFO - 'HOME': '/home/cltbld', 05:08:23 INFO - 'LANG': 'en_US.UTF-8', 05:08:23 INFO - 'LANGUAGE': 'en_US:en', 05:08:23 INFO - 'LOGNAME': 'cltbld', 05:08:23 INFO - 'MAIL': '/var/mail/cltbld', 05:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:23 INFO - 'MOZ_NO_REMOTE': '1', 05:08:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:23 INFO - 'NO_EM_RESTART': '1', 05:08:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:08:23 INFO - 'PWD': '/builds/slave/test-pgo', 05:08:23 INFO - 'SHELL': '/bin/bash', 05:08:23 INFO - 'SHLVL': '1', 05:08:23 INFO - 'TERM': 'linux', 05:08:23 INFO - 'TMOUT': '86400', 05:08:23 INFO - 'USER': 'cltbld', 05:08:23 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457009043.339429-96061994', 05:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:23 INFO - '_': '/tools/buildbot/bin/python'} 05:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:23 INFO - Downloading/unpacking blobuploader==1.2.4 05:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:25 INFO - Downloading blobuploader-1.2.4.tar.gz 05:08:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:08:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:08:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:26 INFO - Downloading docopt-0.6.1.tar.gz 05:08:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:08:26 INFO - Installing collected packages: blobuploader, requests, docopt 05:08:26 INFO - Running setup.py install for blobuploader 05:08:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:08:26 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:08:26 INFO - Running setup.py install for requests 05:08:26 INFO - Running setup.py install for docopt 05:08:26 INFO - Successfully installed blobuploader requests docopt 05:08:26 INFO - Cleaning up... 05:08:26 INFO - Return code: 0 05:08:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:26 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 0x7f14a9fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2051920>, '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 0x2052820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2052cb0>, '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': '232498196343f89f466a4a9a000001c8-1457009043.339429-96061994', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:08:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:08:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:08:26 INFO - Using env: {'DISPLAY': ':0', 05:08:26 INFO - 'HOME': '/home/cltbld', 05:08:26 INFO - 'LANG': 'en_US.UTF-8', 05:08:26 INFO - 'LANGUAGE': 'en_US:en', 05:08:26 INFO - 'LOGNAME': 'cltbld', 05:08:26 INFO - 'MAIL': '/var/mail/cltbld', 05:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:26 INFO - 'MOZ_NO_REMOTE': '1', 05:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:26 INFO - 'NO_EM_RESTART': '1', 05:08:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:08:26 INFO - 'PWD': '/builds/slave/test-pgo', 05:08:26 INFO - 'SHELL': '/bin/bash', 05:08:26 INFO - 'SHLVL': '1', 05:08:26 INFO - 'TERM': 'linux', 05:08:26 INFO - 'TMOUT': '86400', 05:08:26 INFO - 'USER': 'cltbld', 05:08:26 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457009043.339429-96061994', 05:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:26 INFO - '_': '/tools/buildbot/bin/python'} 05:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:08:26 INFO - Running setup.py (path:/tmp/pip-XwPlLi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:08:27 INFO - Running setup.py (path:/tmp/pip-c2xL5P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:08:27 INFO - Running setup.py (path:/tmp/pip-zVfLND-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:08:27 INFO - Running setup.py (path:/tmp/pip-Ge160c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:08:27 INFO - Running setup.py (path:/tmp/pip-42_KI1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:08:27 INFO - Running setup.py (path:/tmp/pip-xl88ay-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:08:27 INFO - Running setup.py (path:/tmp/pip-_bZG22-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:08:27 INFO - Running setup.py (path:/tmp/pip-EZ9IER-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:08:27 INFO - Running setup.py (path:/tmp/pip-HBM1JU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:08:27 INFO - Running setup.py (path:/tmp/pip-5FwMCv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:08:27 INFO - Running setup.py (path:/tmp/pip-dqz6Fv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:08:27 INFO - Running setup.py (path:/tmp/pip-bjUdud-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:08:27 INFO - Running setup.py (path:/tmp/pip-KtzT2q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:08:27 INFO - Running setup.py (path:/tmp/pip-lr4oiQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:08:27 INFO - Running setup.py (path:/tmp/pip-9xYf7y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:08:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:08:28 INFO - Running setup.py (path:/tmp/pip-ezx1Z5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:08:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:08:28 INFO - Running setup.py (path:/tmp/pip-S_ak87-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:08:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:08:28 INFO - Running setup.py install for manifestparser 05:08:28 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:08:28 INFO - Running setup.py install for mozcrash 05:08:28 INFO - Running setup.py install for mozdebug 05:08:28 INFO - Running setup.py install for mozdevice 05:08:28 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:08:28 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:08:28 INFO - Running setup.py install for mozfile 05:08:28 INFO - Running setup.py install for mozhttpd 05:08:28 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:08:28 INFO - Running setup.py install for mozinfo 05:08:28 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:08:28 INFO - Running setup.py install for mozInstall 05:08:28 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:08:28 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:08:28 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:08:28 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:08:28 INFO - Running setup.py install for mozleak 05:08:29 INFO - Running setup.py install for mozlog 05:08:29 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:08:29 INFO - Running setup.py install for moznetwork 05:08:29 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:08:29 INFO - Running setup.py install for mozprocess 05:08:29 INFO - Running setup.py install for mozprofile 05:08:29 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:08:29 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:08:29 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:08:29 INFO - Running setup.py install for mozrunner 05:08:29 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:08:29 INFO - Running setup.py install for mozscreenshot 05:08:29 INFO - Running setup.py install for moztest 05:08:29 INFO - Running setup.py install for mozversion 05:08:29 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:08:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:08:29 INFO - Cleaning up... 05:08:29 INFO - Return code: 0 05:08:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:29 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 0x7f14a9fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2051920>, '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 0x2052820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2052cb0>, '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': '232498196343f89f466a4a9a000001c8-1457009043.339429-96061994', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:08:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:08:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:08:29 INFO - Using env: {'DISPLAY': ':0', 05:08:29 INFO - 'HOME': '/home/cltbld', 05:08:29 INFO - 'LANG': 'en_US.UTF-8', 05:08:29 INFO - 'LANGUAGE': 'en_US:en', 05:08:29 INFO - 'LOGNAME': 'cltbld', 05:08:29 INFO - 'MAIL': '/var/mail/cltbld', 05:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:29 INFO - 'MOZ_NO_REMOTE': '1', 05:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:29 INFO - 'NO_EM_RESTART': '1', 05:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:08:29 INFO - 'PWD': '/builds/slave/test-pgo', 05:08:29 INFO - 'SHELL': '/bin/bash', 05:08:29 INFO - 'SHLVL': '1', 05:08:29 INFO - 'TERM': 'linux', 05:08:29 INFO - 'TMOUT': '86400', 05:08:29 INFO - 'USER': 'cltbld', 05:08:29 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457009043.339429-96061994', 05:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:29 INFO - '_': '/tools/buildbot/bin/python'} 05:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:08:30 INFO - Running setup.py (path:/tmp/pip-DVNQAj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:08:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:08:30 INFO - Running setup.py (path:/tmp/pip-jTjdiB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:08:30 INFO - Running setup.py (path:/tmp/pip-ajfh0a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:08:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:08:30 INFO - Running setup.py (path:/tmp/pip-MtR6cD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:08:30 INFO - Running setup.py (path:/tmp/pip-LT1lDt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:08:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:08:30 INFO - Running setup.py (path:/tmp/pip-Gs0cPb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:08:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:08:30 INFO - Running setup.py (path:/tmp/pip-vigykE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:08:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:08:30 INFO - Running setup.py (path:/tmp/pip-JIgqoR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:08:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:08:30 INFO - Running setup.py (path:/tmp/pip-ji4jmk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:08:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:08:30 INFO - Running setup.py (path:/tmp/pip-1rE6FV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:08:30 INFO - Running setup.py (path:/tmp/pip-Feb7kg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:08:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:08:30 INFO - Running setup.py (path:/tmp/pip-uWqlBU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:08:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:08:31 INFO - Running setup.py (path:/tmp/pip-fmx4tA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:08:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:08:31 INFO - Running setup.py (path:/tmp/pip-i7ON_t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:08:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:08:31 INFO - Running setup.py (path:/tmp/pip-QqTAp_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:08:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:08:31 INFO - Running setup.py (path:/tmp/pip-zYKMGX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:08:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:08:31 INFO - Running setup.py (path:/tmp/pip-mXch28-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:33 INFO - Downloading blessings-1.6.tar.gz 05:08:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:33 INFO - Installing collected packages: blessings 05:08:33 INFO - Running setup.py install for blessings 05:08:33 INFO - Successfully installed blessings 05:08:33 INFO - Cleaning up... 05:08:33 INFO - Return code: 0 05:08:33 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:08:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:08:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:08:33 INFO - Reading from file tmpfile_stdout 05:08:33 INFO - Current package versions: 05:08:33 INFO - argparse == 1.2.1 05:08:33 INFO - blessings == 1.6 05:08:33 INFO - blobuploader == 1.2.4 05:08:33 INFO - docopt == 0.6.1 05:08:33 INFO - manifestparser == 1.1 05:08:33 INFO - mozInstall == 1.12 05:08:33 INFO - mozcrash == 0.16 05:08:33 INFO - mozdebug == 0.1 05:08:33 INFO - mozdevice == 0.48 05:08:33 INFO - mozfile == 1.2 05:08:33 INFO - mozhttpd == 0.7 05:08:33 INFO - mozinfo == 0.9 05:08:33 INFO - mozleak == 0.1 05:08:33 INFO - mozlog == 3.1 05:08:33 INFO - moznetwork == 0.27 05:08:33 INFO - mozprocess == 0.22 05:08:33 INFO - mozprofile == 0.28 05:08:33 INFO - mozrunner == 6.11 05:08:33 INFO - mozscreenshot == 0.1 05:08:33 INFO - mozsystemmonitor == 0.0 05:08:33 INFO - moztest == 0.7 05:08:33 INFO - mozversion == 1.4 05:08:33 INFO - psutil == 3.1.1 05:08:33 INFO - requests == 1.2.3 05:08:33 INFO - wsgiref == 0.1.2 05:08:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:33 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 0x7f14a9fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2051920>, '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 0x2052820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2052cb0>, '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': '232498196343f89f466a4a9a000001c8-1457009043.339429-96061994', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:08:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:08:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:08:33 INFO - Using env: {'DISPLAY': ':0', 05:08:33 INFO - 'HOME': '/home/cltbld', 05:08:33 INFO - 'LANG': 'en_US.UTF-8', 05:08:33 INFO - 'LANGUAGE': 'en_US:en', 05:08:33 INFO - 'LOGNAME': 'cltbld', 05:08:33 INFO - 'MAIL': '/var/mail/cltbld', 05:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:33 INFO - 'MOZ_NO_REMOTE': '1', 05:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:33 INFO - 'NO_EM_RESTART': '1', 05:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:08:33 INFO - 'PWD': '/builds/slave/test-pgo', 05:08:33 INFO - 'SHELL': '/bin/bash', 05:08:33 INFO - 'SHLVL': '1', 05:08:33 INFO - 'TERM': 'linux', 05:08:33 INFO - 'TMOUT': '86400', 05:08:33 INFO - 'USER': 'cltbld', 05:08:33 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457009043.339429-96061994', 05:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:33 INFO - '_': '/tools/buildbot/bin/python'} 05:08:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:08:33 INFO - Cleaning up... 05:08:33 INFO - Return code: 0 05:08:33 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:33 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 0x7f14a9fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2051920>, '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 0x2052820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2052cb0>, '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': '232498196343f89f466a4a9a000001c8-1457009043.339429-96061994', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:08:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:08:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:08:33 INFO - Using env: {'DISPLAY': ':0', 05:08:33 INFO - 'HOME': '/home/cltbld', 05:08:33 INFO - 'LANG': 'en_US.UTF-8', 05:08:33 INFO - 'LANGUAGE': 'en_US:en', 05:08:33 INFO - 'LOGNAME': 'cltbld', 05:08:33 INFO - 'MAIL': '/var/mail/cltbld', 05:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:33 INFO - 'MOZ_NO_REMOTE': '1', 05:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:33 INFO - 'NO_EM_RESTART': '1', 05:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:08:33 INFO - 'PWD': '/builds/slave/test-pgo', 05:08:33 INFO - 'SHELL': '/bin/bash', 05:08:33 INFO - 'SHLVL': '1', 05:08:33 INFO - 'TERM': 'linux', 05:08:33 INFO - 'TMOUT': '86400', 05:08:33 INFO - 'USER': 'cltbld', 05:08:33 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457009043.339429-96061994', 05:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:33 INFO - '_': '/tools/buildbot/bin/python'} 05:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:34 INFO - Downloading/unpacking jsonschema 05:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:08:35 INFO - Downloading/unpacking functools32 (from jsonschema) 05:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:36 INFO - Downloading functools32-3.2.3-2.tar.gz 05:08:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:08:36 INFO - warning: no files found matching '*.txt' 05:08:36 INFO - no previously-included directories found matching 'build' 05:08:36 INFO - no previously-included directories found matching 'dist' 05:08:36 INFO - no previously-included directories found matching '.git*' 05:08:36 INFO - Installing collected packages: jsonschema, functools32 05:08:36 INFO - Running setup.py install for functools32 05:08:36 INFO - warning: no files found matching '*.txt' 05:08:36 INFO - no previously-included directories found matching 'build' 05:08:36 INFO - no previously-included directories found matching 'dist' 05:08:36 INFO - no previously-included directories found matching '.git*' 05:08:36 INFO - Successfully installed jsonschema functools32 05:08:36 INFO - Cleaning up... 05:08:36 INFO - Return code: 0 05:08:36 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f14a9fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2051920>, '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 0x2052820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2052cb0>, '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': '232498196343f89f466a4a9a000001c8-1457009043.339429-96061994', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:08:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:08:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:08:36 INFO - Using env: {'DISPLAY': ':0', 05:08:36 INFO - 'HOME': '/home/cltbld', 05:08:36 INFO - 'LANG': 'en_US.UTF-8', 05:08:36 INFO - 'LANGUAGE': 'en_US:en', 05:08:36 INFO - 'LOGNAME': 'cltbld', 05:08:36 INFO - 'MAIL': '/var/mail/cltbld', 05:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:36 INFO - 'MOZ_NO_REMOTE': '1', 05:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:36 INFO - 'NO_EM_RESTART': '1', 05:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:08:36 INFO - 'PWD': '/builds/slave/test-pgo', 05:08:36 INFO - 'SHELL': '/bin/bash', 05:08:36 INFO - 'SHLVL': '1', 05:08:36 INFO - 'TERM': 'linux', 05:08:36 INFO - 'TMOUT': '86400', 05:08:36 INFO - 'USER': 'cltbld', 05:08:36 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457009043.339429-96061994', 05:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:36 INFO - '_': '/tools/buildbot/bin/python'} 05:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:36 INFO - Downloading/unpacking flake8 05:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:08:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:08:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:08:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:39 INFO - no previously-included directories found matching 'docs/_build' 05:08:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:08:39 INFO - Running setup.py install for pep8 05:08:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:39 INFO - no previously-included directories found matching 'docs/_build' 05:08:39 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:08:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:08:39 INFO - Cleaning up... 05:08:39 INFO - Return code: 0 05:08:39 INFO - Running post-action listener: _resource_record_post_action 05:08:39 INFO - Running post-action listener: _start_resource_monitoring 05:08:39 INFO - Starting resource monitoring. 05:08:39 INFO - ##### 05:08:39 INFO - ##### Running install step. 05:08:39 INFO - ##### 05:08:39 INFO - Running pre-action listener: _resource_record_pre_action 05:08:39 INFO - Running main action method: install 05:08:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:08:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:08:39 INFO - Reading from file tmpfile_stdout 05:08:39 INFO - Detecting whether we're running mozinstall >=1.0... 05:08:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:08:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:08:39 INFO - Reading from file tmpfile_stdout 05:08:39 INFO - Output received: 05:08:39 INFO - Usage: mozinstall [options] installer 05:08:39 INFO - Options: 05:08:39 INFO - -h, --help show this help message and exit 05:08:39 INFO - -d DEST, --destination=DEST 05:08:39 INFO - Directory to install application into. [default: 05:08:39 INFO - "/builds/slave/test-pgo"] 05:08:39 INFO - --app=APP Application being installed. [default: firefox] 05:08:39 INFO - mkdir: /builds/slave/test-pgo/build/application 05:08:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:08:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:08:55 INFO - Reading from file tmpfile_stdout 05:08:55 INFO - Output received: 05:08:55 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:08:55 INFO - Running post-action listener: _resource_record_post_action 05:08:55 INFO - ##### 05:08:55 INFO - ##### Running run-tests step. 05:08:55 INFO - ##### 05:08:55 INFO - Running pre-action listener: _resource_record_pre_action 05:08:55 INFO - Running main action method: run_tests 05:08:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:08:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:08:55 INFO - Python 2.7.3 05:08:55 INFO - Return code: 0 05:08:55 INFO - grabbing minidump binary from tooltool 05:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:55 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 0x2051920>, '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 0x2052820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2052cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:08:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:08:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:08:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:08:55 INFO - Return code: 0 05:08:55 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:08:55 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:08:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:08:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:08:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:08:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:08:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:08:56 INFO - Return code: 0 05:08:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:08:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:08:56 INFO - Using env: {'DISPLAY': ':0', 05:08:56 INFO - 'HOME': '/home/cltbld', 05:08:56 INFO - 'LANG': 'en_US.UTF-8', 05:08:56 INFO - 'LANGUAGE': 'en_US:en', 05:08:56 INFO - 'LOGNAME': 'cltbld', 05:08:56 INFO - 'MAIL': '/var/mail/cltbld', 05:08:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:08:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:56 INFO - 'MOZ_NO_REMOTE': '1', 05:08:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:56 INFO - 'NO_EM_RESTART': '1', 05:08:56 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:08:56 INFO - 'PWD': '/builds/slave/test-pgo', 05:08:56 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:08:56 INFO - 'SHELL': '/bin/bash', 05:08:56 INFO - 'SHLVL': '1', 05:08:56 INFO - 'TERM': 'linux', 05:08:56 INFO - 'TMOUT': '86400', 05:08:56 INFO - 'USER': 'cltbld', 05:08:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1457009043.339429-96061994', 05:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:56 INFO - '_': '/tools/buildbot/bin/python'} 05:08:56 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:08:57 INFO - mozversion application_buildid: 20160303023018 05:08:57 INFO - mozversion application_changeset: ca53292a4ca31712c9c826296d90d231f8a0bca2 05:08:57 INFO - mozversion application_display_name: Nightly 05:08:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:08:57 INFO - mozversion application_name: Firefox 05:08:57 INFO - mozversion application_remotingname: firefox 05:08:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:08:57 INFO - mozversion application_vendor: Mozilla 05:08:57 INFO - mozversion application_version: 47.0a1 05:08:57 INFO - mozversion platform_buildid: 20160303023018 05:08:57 INFO - mozversion platform_changeset: ca53292a4ca31712c9c826296d90d231f8a0bca2 05:08:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:08:57 INFO - mozversion platform_version: 47.0a1 05:08:57 INFO - using testdate: 1457010537 05:08:57 INFO - actual date: 1457010537 05:08:57 INFO - starting webserver on 'localhost:42378' 05:08:57 INFO - SUITE-START | Running 2 tests 05:08:57 INFO - TEST-START | dromaeo_css 05:08:57 INFO - operating with platform_type : linux_ 05:08:57 INFO - Initialising browser for dromaeo_css test... 05:08:57 INFO - TEST-INFO | started process 23457 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqJAvY8/profile http://localhost:42378/getInfo.html) 05:09:00 INFO - PROCESS | 23457 | 05:09:00 INFO - PROCESS | 23457 | (process:23535): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:09:01 INFO - PROCESS | 23457 | __metrics Screen width/height:1600/1200 05:09:01 INFO - PROCESS | 23457 | colorDepth:24 05:09:01 INFO - PROCESS | 23457 | Browser inner width/height: 1024/697 05:09:01 INFO - PROCESS | 23457 | __metrics 05:09:02 ERROR - PROCESS | 23457 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:09:03 INFO - TEST-INFO | 23457: exit 0 05:09:03 INFO - Browser initialized. 05:09:03 INFO - Running cycle 1/1 for dromaeo_css test... 05:09:03 INFO - TEST-INFO | started process 23586 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqJAvY8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:04 INFO - PROCESS | 23586 | 05:09:04 INFO - PROCESS | 23586 | (process:23644): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:09:14 INFO - PROCESS | 23586 | RSS: Main: 160464896 05:09:14 INFO - PROCESS | 23586 | 05:10:04 INFO - PROCESS | 23586 | 1457010604562 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:12:13 INFO - PROCESS | 23586 | Cycle 1(1): loaded http://localhost:42378/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42378/tests/dromaeo/cssquery-ext.html) 05:12:14 INFO - PROCESS | 23586 | RSS: Main: 169238528 05:12:14 INFO - PROCESS | 23586 | 05:15:16 INFO - PROCESS | 23586 | Cycle 1(1): loaded http://localhost:42378/tests/dromaeo/cssquery-ext.html (next: http://localhost:42378/tests/dromaeo/cssquery-jquery.html) 05:15:16 INFO - PROCESS | 23586 | RSS: Main: 165113856 05:15:16 INFO - PROCESS | 23586 | 05:18:18 INFO - PROCESS | 23586 | Cycle 1(1): loaded http://localhost:42378/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42378/tests/dromaeo/cssquery-mootools.html) 05:18:19 INFO - PROCESS | 23586 | RSS: Main: 166498304 05:18:19 INFO - PROCESS | 23586 | 05:21:20 INFO - PROCESS | 23586 | Cycle 1(1): loaded http://localhost:42378/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42378/tests/dromaeo/cssquery-prototype.html) 05:21:21 INFO - PROCESS | 23586 | RSS: Main: 164352000 05:21:21 INFO - PROCESS | 23586 | 05:24:23 INFO - PROCESS | 23586 | Cycle 1(1): loaded http://localhost:42378/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42378/tests/dromaeo/cssquery-yui.html) 05:24:24 INFO - PROCESS | 23586 | RSS: Main: 164360192 05:24:24 INFO - PROCESS | 23586 | 05:27:27 INFO - PROCESS | 23586 | Cycle 1(1): loaded http://localhost:42378/tests/dromaeo/cssquery-yui.html (next: http://localhost:42378/tests/dromaeo/cssquery-dojo.html) 05:27:27 INFO - PROCESS | 23586 | RSS: Main: 168783872 05:27:27 INFO - PROCESS | 23586 | 05:27:27 INFO - PROCESS | 23586 | __start_tp_report 05:27:27 INFO - PROCESS | 23586 | _x_x_mozilla_page_load 05:27:27 INFO - PROCESS | 23586 | _x_x_mozilla_page_load_details 05:27:27 INFO - PROCESS | 23586 | |i|pagename|runs| 05:27:27 INFO - PROCESS | 23586 | |0;dojo.html;3190.744740420766;3234.4339740545397;3267.166872447526;3271.607407111147;3287.753418493612;5105.132127538318;5191.299174611427;5288.15389537674;5314.362276526817;5320.973395133029;5210.192420174879;5273.419923808378;5287.233351164079;5295.258663787073;5314.548263397606;4719.2685133804225;4735.479097299294;4833.3716616839765;4928.186849169882;4933.851984440473;4750.76246187691;4813.614910807127;4831.396075490564;4845.830395936143;4903.166461701519;4792.736399498026;4802.351682522884;4814.494478079821;4848.733319667417;4849.660523763338;4790.065937142259;4822.180229361017;4830.975845120787;4832.057748738997;4855.126077306083;4703.623710103184;4800.855974320741;4817.253325734517;4866.416030076378;4878.8292409765845;4981.128302547076;5007.298978143063;5028.245763135559;5037.823676171316;5074.949250507521;5450.345958484968;5505.174223866452;5508.586855985777;5514.6691198528215;5520.1167813150105;5602.13166959122;5610.579206559483;5669.348024977139;5691.288588926384;5736.8852622947725;5283.28675628789;5283.841484755463;5290.1800220965815;5290.444503327172;5293.550048245904;5705.600607957404;5707.71461426927;5729.770809167587;5769.913451298234;5804.419558044162;5458.399576046631;5479.506844383945;5487.396386397493;5509.696966666872;5538.612297139242;5592.944070559323;5626.943730562642;5663.405342438985;5670;5677.489025987681;5544.667319960815;5564.360098588633;5588.9720551397795;5602.719864006784;5651.434856514398;5633.971830140823;5647.435256474319;5674.092145256739;5681.517071048925;5707.743151558107;4286.057067445157;4320.200762858881;4320.373545835836;4331.740095594275;4356.237658409829;3859.749116307431;3892.2215556888737;3895.4935858338235;3908.843646254118;3926.332523471017;5299;5318.627696061316;5324.121519949243;5331.147016477423;5357.142857142839;5638.2670252866865;5644.520215781622;5647.632903861236;5653;5653.717314134276;5248.1340578804065;5323.387810401853;5329.25390445338;5359.946400536022;5378.838634840961;4846.491118432585;4855.198892182751;4874.707517548958;4894.510548945148;4898.167311557044;5914.378990205966;5920.230370051866;5922.703864806743;5930.8813823723285;5957.314908785545;5568.832935011957;5666.121751128581;5668.801591944262;5684.602077854511;5706.885862282648;5866.970665146647;5882.1470886722045;5884.617499862496;5895.882082358243;5944.197533332945;5611.186377975089;5612.663240205601;5613.382527921844;5620.185073164286;5629.605927585029;5547.140193270049;5605.271314729059;5648.435156484483;5682.9147562785765;5689.914651280317;5539.196816461671;5580.274564306615;5582.916256256078;5603.607747457639;5610.971945140248;5568.91646625309;5585.860353491195;5588.161775733673;5588.580856435865;5588.580856435865;5273.997940391313;5329.387120481194;5359.249705041375;5443.210734443563;5470.562355011669;5415.079436495726;5451.48210919962;5495.203195536705;5503.504684578407;5520.613557050968;5419.620626556103;5419.89516297485;5420.891582168413;5432.837014889559;5474.808381706621 05:27:27 INFO - PROCESS | 23586 | |1;ext.html;472.3646695194964;516.2901011109724;518.5307296896309;534.3561008984175;543.1797985042584;34828.30343393131;35320.646793532054;35530.644693553026;35547.466787998135;35577;38775.22449551014;39072.21855562887;39191;39564.60435395652;39739.60260397395;8440.535770532619;8596.054434012254;8618.052014278424;8626.827463450758;8654.177853103976;8269.627866745981;8403.789905252386;8413;8460.323174146084;8462.23839854413;8624.65501379944;8648.827023459527;8654.913450865506;8660;8689.782755431133;8583.656653733844;8633.050364459905;8638.136186381344;8646.783830404227;8659.393842431033;8452.028016778087;8586.957065214634;8589.141085891424;8590.484570925764;8591.183837535424;40038.79980600107;40661.18677626461;40728;40757.79621101905;40772.184556309;3403.897883063512;3477.0959550516795;3500.859965601373;3605.729570282213;4011.0373510357304;29201;29423.41153176946;30194.54708179379;30200.24499387533;30330.393392132035;3781.8487260509546;3796.1838204785827;3811.6950643948694;3950.920981580381;3958.5645578986287;284272;284800;286005.5699721509;286220;286403;51777;51942.74028629833;52178;52228;52249.738751306;53378.19932701012;60265.69867150636;60276.39723602796;62092;62524.687376563736;15132.621684457976;15379.384824607114;15454.150021748912;15458.227088645523;15459.458918937784;10793.29843560166;10836.945815270874;10854.782904342026;10879.728006799893;10890.509927053301;18392.25273599006;18486.445406637824;18561.81438185628;18604.16281267346;18625.348112815987;7106.360427561544;7333.0933957170455;7384.704611815575;7387.335139837333;7442.813929651802;842.6839935024366;893.7050773244814;904.3488688144525;947.6067432015636;1062.6068354708652;27716;28360.574591381144;28432.43135137327;28537.286567835556;28865.42269154647;1032.7056788815153;1044.2272718188485;1098.6594155811724;1122.4443900269418;1150.5915400033034;14684.706305873822;14857.70284594302;14886.851131488547;15008.549743507494;15142.848571514363;316837;323639;326046;327040;327487;52025.7398713004;52334.738326308885;52383.73808130935;52413.213801793005;52473.2129018065;1292.7414517096618;1329.4349901291912;1344.4890941442188;1352.0940969550425;1352.7429788340185;24693;25331;25533.489330213662;25600.61599075978;25673.743262567135;45605.77197113993;45693.77153114346;46103.53896460992;46150;46157.07685846331;295519;298143;298416;298987;299427;31753;32202.677973220903;32229.355412891142;32788.180295492806;32842.67157328396;41990.37014444847;42900.141997159255;43006.35490467708;43139.784301078296;43686.56313436952;36449.635503644626;37236.255274894895;37265.6273437273;37390;37416.62583374132;35779.642203577634;36110.94458765512;37150.814245928595;37266.441003384425;37456.625433745314;34836;35994.46008309825;36172.09569760777;36339.81830090833;36373.09067273339;27365.86317068402;31413.528797067604;31642.683573163973;31708;31710.207244818142;24210;24323.39191520226;24424.26727198187;24767;24856 05:27:27 INFO - PROCESS | 23586 | |2;jquery.html;320.18193515567725;320.5688349170365;324.10493992379156;326.8953934740884;327.9442494775888;16249.268782904768;16343.75484367734;17045.06252156134;17048.062356570383;17104.14479276036;15810.209489525507;16030.35878564859;16131.193440327996;16517.752233716474;16520.66958660826;5218.452062533436;5335.33308336458;5417.864553386177;5419.620626556142;5434.538064264542;5273.314469119028;5398.595105367093;5438;5446.782128714846;5447.319085114361;5366.490183432587;5370.516653501184;5401.6218864679295;5404.027275090482;5404.297441332621;5154.278401023859;5323.22813192087;5378.112611419111;5379.462053794608;5387.730613469311;4658.440987081538;4698.412698412699;4702.882427939295;4728;4742.407199100113;20331.593368132704;20798.792012079837;20944.47638809027;21013.78986210149;21092.578148436944;1979.544704717923;2121.098533123432;2156.094440335063;2267.455810605443;2426.8786560671897;8649.394542382035;8762.824743505158;8901.821963560693;8924.598393072327;9077.137671921222;1820.8088150744245;1844.2162081115607;1868.0456986312226;1879;1900.9144588493414;51226.743866280805;63363.683181583794;64656;66479.66760166216;68648.6567567164;9299.53502324881;9307.53462326881;9348.392354496937;9582.377145485521;9773.12041916231;12272.693182670504;12480.81278780819;12491.125621206611;12518.937405312916;12536.185147965352;7139.535930164627;7281.089863767029;7365.594892280868;7532.962335188289;7609.353204977529;6797.966010169917;6959.478039147084;7304.926950730531;7404.296591823768;7576.583287919218;4047.797610119482;4120.91758164835;4127.711060225755;4134.441850350225;4157.043879907638;1630.502696677501;1635.419426103716;1681.5123614152003;1694.4493039762126;1712.8544073753621;891.1845661219911;930.6975233049286;963.5471328475605;979.6179489998906;989.8713167288206;16370.508884733477;16647.91676041612;16948.915255423643;17139.143042848056;17247.310107595807;931.4644079654225;931.6971984105057;940.83535381308;941.1059493481221;941.1247539788063;9474.763130921781;9647.228221742243;9671.226301895831;10031.598736050622;10106.898931010743;415443;424259.3935151646;427129;458407;470769;77748.22251777523;78848.60575697085;78860.60569697115;80675.59662201769;81423.59288203521;1068.2522234435771;1069.6308724832227;1093.5516438260433;1134.4497918509517;1137.016480744167;15416.768748468558;15501.224938752792;15502.147381894105;15703.764443533128;15707.057576545443;33346;33823.83088084544;34126.488102677984;34384;34902.476462853585;46795;47979.28031079467;48397.27404088871;49148.75425622849;49596.504034960635;7167.605781682058;7208.423326133792;7335.963320183365;7513.436492262993;7593.088829340514;9785.510724463891;11556.88443115558;12080.75838483208;12374.75250494967;12409.193402428813;10568.731752189786;10803.513841876977;10804.945975270073;10871.67384978452;10993.505292262027;10578.100861426865;10580.523876425425;10834.349939003685;10922.399268040333;11043.779124417628;10559.63041293551;10717.678469645924;10819.134469242284;10839;10840.512176952214;7231.240719724353;7277.417806575355;7359.668814903449;7447.478676492594;7489.28851759082;9920.801583968425;10363.585456581652;10377.117944974761;10382.169426446017;10601.25791194609 05:27:27 INFO - PROCESS | 23586 | |3;mootools.html;1430.2276770543906;1445.0751519027824;1599.6640705451855;1753.7720096387468;1782.6345599152176;6520.1523801905805;7001.824954376143;7145.428365730742;7376.778696639103;7387.630618469075;7217.711291548332;7234.385077268425;7237.203907570163;7295.708171673126;7296.37980771635;2122.61792877282;2161.7730138335482;2163.8485306028506;2164.6969424280614;2168.4036889855256;2115.058798834519;2131.1794958940764;2177.172674383732;2182.901769420372;2183.4977955070344;2127.946801329964;2157.66556183791;2159.0284372032647;2161.556880839424;2175.760666326703;2127.372425134589;2139.5720855828818;2145.7854214578574;2146.0879126371306;2149.4948687058527;2128.6806978953127;2142.046789178816;2145.238440353683;2155.9784402155933;2159.3521943417068;7365.594892280922;7396.889046664304;7399.186089530147;7408.407327413794;7408.629568521553;4349.325854492558;4446.244138496463;4455.598996090335;4464.866054018385;4467.396901418332;2777.819441736301;2780.916572502808;2904.0416662501325;2917.5186094294418;2938.823670579772;964.686476895005;980.4509474694194;984.0651381187829;987.8419452887575;1003.82934901067;9721.930587635425;9800.95099524505;9802.264830137769;9813.803723925554;9837.55730992107;3971.821268042945;4041.3533834586324;4066.0648050947857;4071.0840060986634;4073.165001174752;8467.915320846836;8478.830423391497;8485.872711909326;8569.057403685589;8600.956995214983;4527.886802829956;4532.9320060199125;4533.886652833639;4539.500654927955;4557.156925968707;3700.3709369407266;3985.1830374773103;4035.3543433050572;4117.3206420940805;4183.142455796555;3438.1748380388526;3464.636213197578;3479.4258947273415;3494.7728397654073;3528.4707293906117;1068.1668298727006;1077.6659235636978;1086.7011571817654;1089.5478376473834;1090.738222826516;1297.7209899871573;1302.2772361339548;1303.1659737767836;1321.2732996851694;1344.9865501344862;6669.7665581704405;6691.59850408977;6946.722131114699;6953.374196322254;7003.194632617212;436.5699785711072;436.6223216917407;440.12195669638635;442.5729171349663;456.6415363939292;5317.069512835238;5350.759215835296;5365.892682146336;5377.462253774669;5386.245925570423;8090.959545202236;8210.343172546181;8280.213379728915;8343;8594.52730099838;8116.228958248957;8116.472429292196;8142.145074767182;8155.46989445696;8174.019117705913;6590.340965903371;6654.933450665529;6716.227633822173;6720.495962802809;6747.662616869137;6860.279670634711;6861.622610756456;6874.553154044971;6925.065116209449;6929.237783843672;7617.314441700052;7690.807729806799;8021.15777843318;8033.277005069572;8088.555129467935;8057.919420805952;8187.590620468834;8309.086000540057;8319.417640765088;8321.12628174033;6369.554131210771;6496.6751662415745;6527.412532871875;6556.114924485133;6574.868502629825;7052.788416347517;7062.117235345582;7089.574625522278;7090.574565526085;7101.928980710127;6295.55931084838;6440.2915679276175;6443.7744678936015;6457.935420645734;6474.223093228843;6374.362563743589;6396.360363963567;6398.1362516059735;6477.319881412383;6486;6403.903941440789;6448.322926092693;6460.773872914426;6462.547621666438;6468.870622587616;6111.083337499411;6143.907841382472;6201.162843016135;6270.874582508415;6281.026440901667;6287.811365659038;6303.905441418291;6310.905336419865;6338.080978258219;6366.681665916593 05:27:27 INFO - PROCESS | 23586 | |4;prototype.html;283.85665239054276;289.5902298247978;293.7062937062937;296.5270393722013;297.63539663911706;6217.564770466063;6246.843828904274;6247.468965137963;6273.466755325803;6310.621362718241;6212.565120441571;6237.906431403532;6269.185005949232;6278.6232826030355;6279;4504.752238626874;4621.491635920046;4629.2824612184995;4648.209804333254;4654.115718013583;4629;4633.837815676452;4635.814567417299;4661.347411362412;4672.766361681903;4581.541845815425;4602.12559613674;4613.723176609397;4617.353570500116;4620.1221767864;4609.101225261059;4611.976940115294;4613.423322084739;4626.028534007863;4636.281376386665;3935.2523020626277;3936.1734035852505;3942;3945.0334668006235;3946.3685810270217;5866.73599688015;5924.348321684612;5924.407559244084;5931.614445061057;5941.168236446901;5164.431912489623;5221.869453263661;5246.449122842085;5258.13240815265;5267.578593712494;6560;6579;6579.47364210862;6601;6605.834854128685;4225.598568136023;4231.767252801094;4237.279662457358;4239.639630631369;4258.9565556438565;6860.970854371834;6931.0643063186835;6935.271796461349;6948.930510694879;6981.301869812978;4423.358613001097;4424.491183513937;4426.070525189682;4434.512203657595;4444.9998750281575;4328.43730315057;4466.2630665940405;4469.9553004469535;4472.463304403493;4474.217012022883;5265.973670131625;5284.841454756363;5300.6024548158275;5304.681719096867;5306.734663266899;6626.53614246998;6673.099131617267;6677.499187560952;6678.465722742169;6698.665066746643;1531.7166324230054;1541.8535239152263;1541.8612324890814;1545.5981444824201;1551.4259723902228;962.3311798300255;981.8625392445064;987.3631507677508;996.8305388084043;1012.4178597306578;6228.5017198624;6238.906416403667;6279.937200627935;6282.089097080898;6288.402601752826;6778;6791.3548212919695;6801.965990170018;6802.285759995129;6854.862902741917;6206.844828879224;6239.812805615838;6296.401841825019;6351.523635727246;6380.0748891410485;3712.8700495483067;3726.3851464508593;3727.4036154215196;3741.1956429367274;3749.437584362313;7216.278372162742;7218.747343842941;7246.347828695442;7281.927180728125;7284.672189751368;7078.752243671447;7103.715851365991;7110.786676399716;7124.038254835635;7125.42996560274;7005.229424763272;7247.855042899112;7251.818704532535;7259.6007219603425;7264.055672762507;6847.281035491401;6875.106236189264;6880.243173251039;6882.655867206519;6891.3797758202;6852.6916288768125;6853.862922741617;6857.622830744157;6859.142607174103;6872.312768723287;7214.74748383804;7224.638768061471;7249.6950548901705;7253.238409967089;7260.491765576359;4323.632491238154;4361.978190109029;4387.188370151533;4460.888477787951;4467.419235499494;6835.692393842389;6839.110915580943;6848.554843935129;6898.655067246718;6898.965505172442;6663.666816659051;6671.199456065303;6677.83305417349;6680.832979175365;6694.665266736741;6662.433693136138;6665;6671.132752742113;6677.69950352245;6681.632510211985;6296.212973378328;6485.481161507162;6496.123023391781;6509.772157974448;6521.5108866834225;6700.229473610597;6716.496262780409;6728.8654226914205;6740.157480314961;6753.493487988519;6520.315366886409;6556.147700798866;6562.671866406756;6572.047053177358;6576.408123268929 05:27:27 INFO - PROCESS | 23586 | |5;yui.html;805.7461899501657;810.0967421325222;810.7243537197352;821.0516853034746;841.970531031414;13361.198328100309;13422.328883555832;13432.66418339542;13482.730345393098;13499.39252733627;12314.507419703223;13914.791278130837;13948.302584870742;13951.651208719788;14020.579382618513;820.8686610142379;826.8181000179951;828.1470085811624;829.179112678447;829.4774292195908;635.9332270111641;815.1685281013363;829.9626516806758;831.0899564976371;831.5925196653626;874.0647507167333;876.3164731509432;876.3296078499952;879.4767113567417;881.0440671871028;863.0851297624538;869.5695630662863;870.182028892845;872.7294538692994;876.8640860666607;637.5250438423358;640.0591131037368;642.0177128992649;642.6465444005778;644.7227692092398;13943.233122178277;14034.157950522898;14043.578692639136;14057.507987220399;14151.646208844759;13438;13525.458981640722;13551.59345219645;13650;13675.179489230679;10911.454427278604;11066.723331916766;11140.108791296676;11236.550537978472;11621.360825154614;3708.9258214835554;3710.8144592770254;3722.274156539449;3808.0479880029993;3837.9232415351535;50182;50771.746141269425;51209.743951280376;51387.22919156215;51656;10371.740706482398;10429.374237545771;10470.842937355947;10570.947145264377;10624.203184761174;17949.192286347145;18101.7284740729;18154.727679084823;18300.359487417878;18367.35714249995;7490;7948.523088614702;8154.918450815535;8158.469699469515;8418.957905210435;4376.452943382077;4436.489803672554;4531.682782205214;4598.287265473857;4690.249560070372;3049.283418396675;3095.5511450839504;3096.7677424193275;3097.1792474994145;3113.081640915935;559.636236446305;570.0138759945318;571.7741492110677;572.241779641976;573.0744847071949;585.1924344404779;594.8721024979563;684.3191024930227;689.9793006209821;700.190961171227;8684.739457816275;8800.515971621622;8810.383273170944;8892.532732099131;9279.164875161268;688.3460712323313;690.9550879192836;710.4777988178685;710.761894765249;725.6621419885478;3844.4233364994916;4411.625011873963;4452.688311818207;4511.526289739596;4547.522510136388;53704.46295536995;53910.730446347516;54300.45699543033;55160;55515;47975.28037079447;48538.5146148541;48888.755556222706;49774.75112624414;50028;48538;48985;49070.75464622654;49201.2619810696;50797.49202507928;8619.374523264674;8725.781855453664;8787.824243515222;8796.868046979173;8994.460332380078;32939.67060329366;33468.49797252994;34078.48882266817;34110.147246319044;34628;40860.59139408687;40947;43785;43926.12147756963;44297.33553996757;11738.647840564796;11852.466639001093;11978.520859165885;12046.156769026435;12103.939480302543;11757.76484470323;11793.11551633648;11822.586209482626;11847.881521184678;12332.075094368138;11157.66527004191;11246.325220486797;11382.430878456209;11719.414029298672;12028.75942481128;11450.141239406912;11759.88240117622;12308.446119924803;12340.382980851102;12341.50633974631;10909;11831;12051.457684404399;12061.035117190779;12399.644955070831;10060.798784024424;10093.747656308651;10127.291089623655;10153.39079655223;10228.897711022795;9518.666846660333;9526.476043817656;9944.204463643036;10445.9477702611;10469.581216751245 05:27:27 INFO - PROCESS | 23586 | __end_tp_report 05:27:27 INFO - PROCESS | 23586 | __start_cc_report 05:27:27 INFO - PROCESS | 23586 | _x_x_mozilla_cycle_collect,317 05:27:27 INFO - PROCESS | 23586 | __end_cc_report 05:27:27 INFO - PROCESS | 23586 | __startTimestamp1457011647335__endTimestamp 05:27:27 INFO - PROCESS | 23586 | 05:27:27 INFO - PROCESS | 23586 | ------- Summary: start ------- 05:27:27 INFO - PROCESS | 23586 | Number of tests: 6 05:27:27 INFO - PROCESS | 23586 | 05:27:27 INFO - PROCESS | 23586 | [#0] dojo.html Cycles:165 Average:5245.25 Median:5432.84 stddev:569.76 (10.5%) stddev-sans-first:548.23 05:27:27 INFO - PROCESS | 23586 | Values: 3190.7 3234.4 3267.2 3271.6 3287.8 5105.1 5191.3 5288.2 5314.4 5321.0 5210.2 5273.4 5287.2 5295.3 5314.5 4719.3 4735.5 4833.4 4928.2 4933.9 4750.8 4813.6 4831.4 4845.8 4903.2 4792.7 4802.4 4814.5 4848.7 4849.7 4790.1 4822.2 4831.0 4832.1 4855.1 4703.6 4800.9 4817.3 4866.4 4878.8 4981.1 5007.3 5028.2 5037.8 5074.9 5450.3 5505.2 5508.6 5514.7 5520.1 5602.1 5610.6 5669.3 5691.3 5736.9 5283.3 5283.8 5290.2 5290.4 5293.6 5705.6 5707.7 5729.8 5769.9 5804.4 5458.4 5479.5 5487.4 5509.7 5538.6 5592.9 5626.9 5663.4 5670.0 5677.5 5544.7 5564.4 5589.0 5602.7 5651.4 5634.0 5647.4 5674.1 5681.5 5707.7 4286.1 4320.2 4320.4 4331.7 4356.2 3859.7 3892.2 3895.5 3908.8 3926.3 5299.0 5318.6 5324.1 5331.1 5357.1 5638.3 5644.5 5647.6 5653.0 5653.7 5248.1 5323.4 5329.3 5359.9 5378.8 4846.5 4855.2 4874.7 4894.5 4898.2 5914.4 5920.2 5922.7 5930.9 5957.3 5568.8 5666.1 5668.8 5684.6 5706.9 5867.0 5882.1 5884.6 5895.9 5944.2 5611.2 5612.7 5613.4 5620.2 5629.6 5547.1 5605.3 5648.4 5682.9 5689.9 5539.2 5580.3 5582.9 5603.6 5611.0 5568.9 5585.9 5588.2 5588.6 5588.6 5274.0 5329.4 5359.2 5443.2 5470.6 5415.1 5451.5 5495.2 5503.5 5520.6 5419.6 5419.9 5420.9 5432.8 5474.8 05:27:27 INFO - PROCESS | 23586 | 05:27:27 INFO - PROCESS | 23586 | [#1] ext.html Cycles:180 Average:46621.01 Median:36356.45 stddev:79284.03 (218.1%) stddev-sans-first:79430.73 05:27:27 INFO - PROCESS | 23586 | Values: 472.4 516.3 518.5 534.4 543.2 34828.3 35320.6 35530.6 35547.5 35577.0 38775.2 39072.2 39191.0 39564.6 39739.6 8440.5 8596.1 8618.1 8626.8 8654.2 8269.6 8403.8 8413.0 8460.3 8462.2 8624.7 8648.8 8654.9 8660.0 8689.8 8583.7 8633.1 8638.1 8646.8 8659.4 8452.0 8587.0 8589.1 8590.5 8591.2 40038.8 40661.2 40728.0 40757.8 40772.2 3403.9 3477.1 3500.9 3605.7 4011.0 29201.0 29423.4 30194.5 30200.2 30330.4 3781.8 3796.2 3811.7 3950.9 3958.6 284272.0 284800.0 286005.6 286220.0 286403.0 51777.0 51942.7 52178.0 52228.0 52249.7 53378.2 60265.7 60276.4 62092.0 62524.7 15132.6 15379.4 15454.2 15458.2 15459.5 10793.3 10836.9 10854.8 10879.7 10890.5 18392.3 18486.4 18561.8 18604.2 18625.3 7106.4 7333.1 7384.7 7387.3 7442.8 842.7 893.7 904.3 947.6 1062.6 27716.0 28360.6 28432.4 28537.3 28865.4 1032.7 1044.2 1098.7 1122.4 1150.6 14684.7 14857.7 14886.9 15008.5 15142.8 316837.0 323639.0 326046.0 327040.0 327487.0 52025.7 52334.7 52383.7 52413.2 52473.2 1292.7 1329.4 1344.5 1352.1 1352.7 24693.0 25331.0 25533.5 25600.6 25673.7 45605.8 45693.8 46103.5 46150.0 46157.1 295519.0 298143.0 298416.0 298987.0 299427.0 31753.0 32202.7 32229.4 32788.2 32842.7 41990.4 42900.1 43006.4 43139.8 43686.6 36449.6 37236.3 37265.6 37390.0 37416.6 35779.6 36110.9 37150.8 37266.4 37456.6 34836.0 35994.5 36172.1 36339.8 36373.1 27365.9 31413.5 31642.7 31708.0 31710.2 24210.0 24323.4 24424.3 24767.0 24856.0 05:27:27 INFO - PROCESS | 23586 | 05:27:27 INFO - PROCESS | 23586 | [#2] jquery.html Cycles:180 Average:25385.49 Median:214208.22 stddev:72250.11 (33.7%) stddev-sans-first:72428.28 05:27:27 INFO - PROCESS | 23586 | Values: 320.2 320.6 324.1 326.9 327.9 16249.3 16343.8 17045.1 17048.1 17104.1 15810.2 16030.4 16131.2 16517.8 16520.7 5218.5 5335.3 5417.9 5419.6 5434.5 5273.3 5398.6 5438.0 5446.8 5447.3 5366.5 5370.5 5401.6 5404.0 5404.3 5154.3 5323.2 5378.1 5379.5 5387.7 4658.4 4698.4 4702.9 4728.0 4742.4 20331.6 20798.8 20944.5 21013.8 21092.6 1979.5 2121.1 2156.1 2267.5 2426.9 8649.4 8762.8 8901.8 8924.6 9077.1 1820.8 1844.2 1868.0 1879.0 1900.9 51226.7 63363.7 64656.0 66479.7 68648.7 9299.5 9307.5 9348.4 9582.4 9773.1 12272.7 12480.8 12491.1 12518.9 12536.2 7139.5 7281.1 7365.6 7533.0 7609.4 6798.0 6959.5 7304.9 7404.3 7576.6 4047.8 4120.9 4127.7 4134.4 4157.0 1630.5 1635.4 1681.5 1694.4 1712.9 891.2 930.7 963.5 979.6 989.9 16370.5 16647.9 16948.9 17139.1 17247.3 931.5 931.7 940.8 941.1 941.1 9474.8 9647.2 9671.2 10031.6 10106.9 415443.0 424259.4 427129.0 458407.0 470769.0 77748.2 78848.6 78860.6 80675.6 81423.6 1068.3 1069.6 1093.6 1134.4 1137.0 15416.8 15501.2 15502.1 15703.8 15707.1 33346.0 33823.8 34126.5 34384.0 34902.5 46795.0 47979.3 48397.3 49148.8 49596.5 7167.6 7208.4 7336.0 7513.4 7593.1 9785.5 11556.9 12080.8 12374.8 12409.2 10568.7 10803.5 10804.9 10871.7 10993.5 10578.1 10580.5 10834.3 10922.4 11043.8 10559.6 10717.7 10819.1 10839.0 10840.5 7231.2 7277.4 7359.7 7447.5 7489.3 9920.8 10363.6 10377.1 10382.2 10601.3 05:27:27 INFO - PROCESS | 23586 | 05:27:27 INFO - PROCESS | 23586 | [#3] mootools.html Cycles:180 Average:5093.74 Median:6352.38 stddev:2607.08 (41.0%) stddev-sans-first:2599.85 05:27:27 INFO - PROCESS | 23586 | Values: 1430.2 1445.1 1599.7 1753.8 1782.6 6520.2 7001.8 7145.4 7376.8 7387.6 7217.7 7234.4 7237.2 7295.7 7296.4 2122.6 2161.8 2163.8 2164.7 2168.4 2115.1 2131.2 2177.2 2182.9 2183.5 2127.9 2157.7 2159.0 2161.6 2175.8 2127.4 2139.6 2145.8 2146.1 2149.5 2128.7 2142.0 2145.2 2156.0 2159.4 7365.6 7396.9 7399.2 7408.4 7408.6 4349.3 4446.2 4455.6 4464.9 4467.4 2777.8 2780.9 2904.0 2917.5 2938.8 964.7 980.5 984.1 987.8 1003.8 9721.9 9801.0 9802.3 9813.8 9837.6 3971.8 4041.4 4066.1 4071.1 4073.2 8467.9 8478.8 8485.9 8569.1 8601.0 4527.9 4532.9 4533.9 4539.5 4557.2 3700.4 3985.2 4035.4 4117.3 4183.1 3438.2 3464.6 3479.4 3494.8 3528.5 1068.2 1077.7 1086.7 1089.5 1090.7 1297.7 1302.3 1303.2 1321.3 1345.0 6669.8 6691.6 6946.7 6953.4 7003.2 436.6 436.6 440.1 442.6 456.6 5317.1 5350.8 5365.9 5377.5 5386.2 8091.0 8210.3 8280.2 8343.0 8594.5 8116.2 8116.5 8142.1 8155.5 8174.0 6590.3 6654.9 6716.2 6720.5 6747.7 6860.3 6861.6 6874.6 6925.1 6929.2 7617.3 7690.8 8021.2 8033.3 8088.6 8057.9 8187.6 8309.1 8319.4 8321.1 6369.6 6496.7 6527.4 6556.1 6574.9 7052.8 7062.1 7089.6 7090.6 7101.9 6295.6 6440.3 6443.8 6457.9 6474.2 6374.4 6396.4 6398.1 6477.3 6486.0 6403.9 6448.3 6460.8 6462.5 6468.9 6111.1 6143.9 6201.2 6270.9 6281.0 6287.8 6303.9 6310.9 6338.1 6366.7 05:27:27 INFO - PROCESS | 23586 | 05:27:27 INFO - PROCESS | 23586 | [#4] prototype.html Cycles:180 Average:5486.09 Median:6285.25 stddev:1747.61 (27.8%) stddev-sans-first:1708.34 05:27:27 INFO - PROCESS | 23586 | Values: 283.9 289.6 293.7 296.5 297.6 6217.6 6246.8 6247.5 6273.5 6310.6 6212.6 6237.9 6269.2 6278.6 6279.0 4504.8 4621.5 4629.3 4648.2 4654.1 4629.0 4633.8 4635.8 4661.3 4672.8 4581.5 4602.1 4613.7 4617.4 4620.1 4609.1 4612.0 4613.4 4626.0 4636.3 3935.3 3936.2 3942.0 3945.0 3946.4 5866.7 5924.3 5924.4 5931.6 5941.2 5164.4 5221.9 5246.4 5258.1 5267.6 6560.0 6579.0 6579.5 6601.0 6605.8 4225.6 4231.8 4237.3 4239.6 4259.0 6861.0 6931.1 6935.3 6948.9 6981.3 4423.4 4424.5 4426.1 4434.5 4445.0 4328.4 4466.3 4470.0 4472.5 4474.2 5266.0 5284.8 5300.6 5304.7 5306.7 6626.5 6673.1 6677.5 6678.5 6698.7 1531.7 1541.9 1541.9 1545.6 1551.4 962.3 981.9 987.4 996.8 1012.4 6228.5 6238.9 6279.9 6282.1 6288.4 6778.0 6791.4 6802.0 6802.3 6854.9 6206.8 6239.8 6296.4 6351.5 6380.1 3712.9 3726.4 3727.4 3741.2 3749.4 7216.3 7218.7 7246.3 7281.9 7284.7 7078.8 7103.7 7110.8 7124.0 7125.4 7005.2 7247.9 7251.8 7259.6 7264.1 6847.3 6875.1 6880.2 6882.7 6891.4 6852.7 6853.9 6857.6 6859.1 6872.3 7214.7 7224.6 7249.7 7253.2 7260.5 4323.6 4362.0 4387.2 4460.9 4467.4 6835.7 6839.1 6848.6 6898.7 6899.0 6663.7 6671.2 6677.8 6680.8 6694.7 6662.4 6665.0 6671.1 6677.7 6681.6 6296.2 6485.5 6496.1 6509.8 6521.5 6700.2 6716.5 6728.9 6740.2 6753.5 6520.3 6556.1 6562.7 6572.0 6576.4 05:27:27 INFO - PROCESS | 23586 | 05:27:27 INFO - PROCESS | 23586 | [#5] yui.html Cycles:180 Average:13961.92 Median:4444.59 stddev:15753.59 (354.4%) stddev-sans-first:15766.80 05:27:27 INFO - PROCESS | 23586 | Values: 805.7 810.1 810.7 821.1 842.0 13361.2 13422.3 13432.7 13482.7 13499.4 12314.5 13914.8 13948.3 13951.7 14020.6 820.9 826.8 828.1 829.2 829.5 635.9 815.2 830.0 831.1 831.6 874.1 876.3 876.3 879.5 881.0 863.1 869.6 870.2 872.7 876.9 637.5 640.1 642.0 642.6 644.7 13943.2 14034.2 14043.6 14057.5 14151.6 13438.0 13525.5 13551.6 13650.0 13675.2 10911.5 11066.7 11140.1 11236.6 11621.4 3708.9 3710.8 3722.3 3808.0 3837.9 50182.0 50771.7 51209.7 51387.2 51656.0 10371.7 10429.4 10470.8 10570.9 10624.2 17949.2 18101.7 18154.7 18300.4 18367.4 7490.0 7948.5 8154.9 8158.5 8419.0 4376.5 4436.5 4531.7 4598.3 4690.2 3049.3 3095.6 3096.8 3097.2 3113.1 559.6 570.0 571.8 572.2 573.1 585.2 594.9 684.3 690.0 700.2 8684.7 8800.5 8810.4 8892.5 9279.2 688.3 691.0 710.5 710.8 725.7 3844.4 4411.6 4452.7 4511.5 4547.5 53704.5 53910.7 54300.5 55160.0 55515.0 47975.3 48538.5 48888.8 49774.8 50028.0 48538.0 48985.0 49070.8 49201.3 50797.5 8619.4 8725.8 8787.8 8796.9 8994.5 32939.7 33468.5 34078.5 34110.1 34628.0 40860.6 40947.0 43785.0 43926.1 44297.3 11738.6 11852.5 11978.5 12046.2 12103.9 11757.8 11793.1 11822.6 11847.9 12332.1 11157.7 11246.3 11382.4 11719.4 12028.8 11450.1 11759.9 12308.4 12340.4 12341.5 10909.0 11831.0 12051.5 12061.0 12399.6 10060.8 10093.7 10127.3 10153.4 10228.9 9518.7 9526.5 9944.2 10445.9 10469.6 05:27:27 INFO - PROCESS | 23586 | -------- Summary: end -------- 05:27:27 INFO - PROCESS | 23586 | 05:27:28 INFO - TEST-INFO | 23586: exit 0 05:27:28 INFO - TEST-OK | dromaeo_css | took 1110903ms 05:27:28 INFO - TEST-START | kraken 05:27:28 INFO - operating with platform_type : linux_ 05:27:28 INFO - Initialising browser for kraken test... 05:27:28 INFO - TEST-INFO | started process 23825 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9qp_Ps/profile http://localhost:42378/getInfo.html) 05:27:31 INFO - PROCESS | 23825 | 05:27:31 INFO - PROCESS | 23825 | (process:23894): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:27:32 INFO - PROCESS | 23825 | __metrics Screen width/height:1600/1200 05:27:32 INFO - PROCESS | 23825 | colorDepth:24 05:27:32 INFO - PROCESS | 23825 | Browser inner width/height: 1024/697 05:27:32 INFO - PROCESS | 23825 | __metrics 05:27:33 ERROR - PROCESS | 23825 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:27:34 INFO - TEST-INFO | 23825: exit 0 05:27:34 INFO - Browser initialized. 05:27:34 INFO - Running cycle 1/1 for kraken test... 05:27:34 INFO - TEST-INFO | started process 23945 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9qp_Ps/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:35 INFO - PROCESS | 23945 | 05:27:35 INFO - PROCESS | 23945 | (process:24004): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:27:45 INFO - PROCESS | 23945 | RSS: Main: 160673792 05:27:45 INFO - PROCESS | 23945 | 05:27:48 INFO - PROCESS | 23945 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42378/tests/kraken/driver.html?testName=audio-beat-detection) 05:27:49 INFO - PROCESS | 23945 | RSS: Main: 167231488 05:27:49 INFO - PROCESS | 23945 | 05:27:51 INFO - PROCESS | 23945 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42378/tests/kraken/driver.html?testName=audio-dft) 05:27:52 INFO - PROCESS | 23945 | RSS: Main: 169619456 05:27:52 INFO - PROCESS | 23945 | 05:27:55 INFO - PROCESS | 23945 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42378/tests/kraken/driver.html?testName=audio-fft) 05:27:55 INFO - PROCESS | 23945 | RSS: Main: 161779712 05:27:55 INFO - PROCESS | 23945 | 05:27:57 INFO - PROCESS | 23945 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42378/tests/kraken/driver.html?testName=audio-oscillator) 05:27:58 INFO - PROCESS | 23945 | RSS: Main: 163024896 05:27:58 INFO - PROCESS | 23945 | 05:28:00 INFO - PROCESS | 23945 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42378/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:28:01 INFO - PROCESS | 23945 | RSS: Main: 164847616 05:28:01 INFO - PROCESS | 23945 | 05:28:04 INFO - PROCESS | 23945 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42378/tests/kraken/driver.html?testName=imaging-darkroom) 05:28:04 INFO - PROCESS | 23945 | RSS: Main: 164900864 05:28:04 INFO - PROCESS | 23945 | 05:28:08 INFO - PROCESS | 23945 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42378/tests/kraken/driver.html?testName=imaging-desaturate) 05:28:08 INFO - PROCESS | 23945 | RSS: Main: 164872192 05:28:08 INFO - PROCESS | 23945 | 05:28:11 INFO - PROCESS | 23945 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42378/tests/kraken/driver.html?testName=json-parse-financial) 05:28:12 INFO - PROCESS | 23945 | RSS: Main: 167362560 05:28:12 INFO - PROCESS | 23945 | 05:28:13 INFO - PROCESS | 23945 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42378/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:28:14 INFO - PROCESS | 23945 | RSS: Main: 167354368 05:28:14 INFO - PROCESS | 23945 | 05:28:16 INFO - PROCESS | 23945 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42378/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:28:16 INFO - PROCESS | 23945 | RSS: Main: 165502976 05:28:16 INFO - PROCESS | 23945 | 05:28:18 INFO - PROCESS | 23945 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42378/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:28:19 INFO - PROCESS | 23945 | RSS: Main: 167731200 05:28:19 INFO - PROCESS | 23945 | 05:28:21 INFO - PROCESS | 23945 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:28:22 INFO - PROCESS | 23945 | RSS: Main: 166137856 05:28:22 INFO - PROCESS | 23945 | 05:28:25 INFO - PROCESS | 23945 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:28:25 INFO - PROCESS | 23945 | RSS: Main: 165998592 05:28:25 INFO - PROCESS | 23945 | 05:28:27 INFO - PROCESS | 23945 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42378/tests/kraken/driver.html?testName=ai-astar) 05:28:27 INFO - PROCESS | 23945 | RSS: Main: 167706624 05:28:27 INFO - PROCESS | 23945 | 05:28:27 INFO - PROCESS | 23945 | __start_tp_report 05:28:27 INFO - PROCESS | 23945 | _x_x_mozilla_page_load 05:28:27 INFO - PROCESS | 23945 | _x_x_mozilla_page_load_details 05:28:27 INFO - PROCESS | 23945 | |i|pagename|runs| 05:28:27 INFO - PROCESS | 23945 | |0;ai-astar;112;107;112;111;112;124;113;112;111;112 05:28:27 INFO - PROCESS | 23945 | |1;audio-beat-detection;153;126;149;179;134;149;160;127;176;128 05:28:27 INFO - PROCESS | 23945 | |2;audio-dft;162;162;161;162;162;163;163;167;169;162 05:28:27 INFO - PROCESS | 23945 | |3;audio-fft;73;75;75;74;76;135;75;75;73;75 05:28:27 INFO - PROCESS | 23945 | |4;audio-oscillator;93;93;148;93;94;93;147;94;94;147 05:28:27 INFO - PROCESS | 23945 | |5;imaging-gaussian-blur;118;118;118;117;117;117;118;118;118;118 05:28:27 INFO - PROCESS | 23945 | |6;imaging-darkroom;146;146;147;147;150;147;146;147;146;147 05:28:27 INFO - PROCESS | 23945 | |7;imaging-desaturate;97;96;98;96;98;96;96;97;96;96 05:28:27 INFO - PROCESS | 23945 | |8;json-parse-financial;59;59;59;59;60;58;62;66;59;56 05:28:27 INFO - PROCESS | 23945 | |9;json-stringify-tinderbox;67;69;68;67;67;68;67;68;68;67 05:28:27 INFO - PROCESS | 23945 | |10;stanford-crypto-aes;83;82;84;85;83;85;83;84;85;86 05:28:27 INFO - PROCESS | 23945 | |11;stanford-crypto-ccm;116;116;114;129;118;117;121;119;124;122 05:28:27 INFO - PROCESS | 23945 | |12;stanford-crypto-pbkdf2;145;143;154;153;166;159;147;148;155;143 05:28:27 INFO - PROCESS | 23945 | |13;stanford-crypto-sha256-iterative;70;69;72;73;71;71;70;69;70;69 05:28:27 INFO - PROCESS | 23945 | __end_tp_report 05:28:27 INFO - PROCESS | 23945 | __start_cc_report 05:28:27 INFO - PROCESS | 23945 | _x_x_mozilla_cycle_collect,809 05:28:27 INFO - PROCESS | 23945 | __end_cc_report 05:28:27 INFO - PROCESS | 23945 | __startTimestamp1457011707681__endTimestamp 05:28:27 INFO - PROCESS | 23945 | 05:28:27 INFO - PROCESS | 23945 | ------- Summary: start ------- 05:28:27 INFO - PROCESS | 23945 | Number of tests: 14 05:28:27 INFO - PROCESS | 23945 | 05:28:27 INFO - PROCESS | 23945 | [#0] ai-astar Cycles:10 Average:112.60 Median:112.00 stddev:4.33 (3.9%) stddev-sans-first:4.58 05:28:27 INFO - PROCESS | 23945 | Values: 112.0 107.0 112.0 111.0 112.0 124.0 113.0 112.0 111.0 112.0 05:28:27 INFO - PROCESS | 23945 | 05:28:27 INFO - PROCESS | 23945 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:151.00 stddev:19.54 (12.9%) stddev-sans-first:20.65 05:28:27 INFO - PROCESS | 23945 | Values: 153.0 126.0 149.0 179.0 134.0 149.0 160.0 127.0 176.0 128.0 05:28:27 INFO - PROCESS | 23945 | 05:28:27 INFO - PROCESS | 23945 | [#2] audio-dft Cycles:10 Average:163.30 Median:162.50 stddev:2.58 (1.6%) stddev-sans-first:2.70 05:28:27 INFO - PROCESS | 23945 | Values: 162.0 162.0 161.0 162.0 162.0 163.0 163.0 167.0 169.0 162.0 05:28:27 INFO - PROCESS | 23945 | 05:28:27 INFO - PROCESS | 23945 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:19.14 (25.5%) stddev-sans-first:20.10 05:28:27 INFO - PROCESS | 23945 | Values: 73.0 75.0 75.0 74.0 76.0 135.0 75.0 75.0 73.0 75.0 05:28:27 INFO - PROCESS | 23945 | 05:28:27 INFO - PROCESS | 23945 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:93.00 stddev:26.04 (28.0%) stddev-sans-first:26.92 05:28:27 INFO - PROCESS | 23945 | Values: 93.0 93.0 148.0 93.0 94.0 93.0 147.0 94.0 94.0 147.0 05:28:27 INFO - PROCESS | 23945 | 05:28:27 INFO - PROCESS | 23945 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:28:27 INFO - PROCESS | 23945 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 05:28:27 INFO - PROCESS | 23945 | 05:28:27 INFO - PROCESS | 23945 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.20 (0.8%) stddev-sans-first:1.22 05:28:27 INFO - PROCESS | 23945 | Values: 146.0 146.0 147.0 147.0 150.0 147.0 146.0 147.0 146.0 147.0 05:28:27 INFO - PROCESS | 23945 | 05:28:27 INFO - PROCESS | 23945 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 05:28:27 INFO - PROCESS | 23945 | Values: 97.0 96.0 98.0 96.0 98.0 96.0 96.0 97.0 96.0 96.0 05:28:27 INFO - PROCESS | 23945 | 05:28:27 INFO - PROCESS | 23945 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:59.00 stddev:2.67 (4.5%) stddev-sans-first:2.82 05:28:27 INFO - PROCESS | 23945 | Values: 59.0 59.0 59.0 59.0 60.0 58.0 62.0 66.0 59.0 56.0 05:28:27 INFO - PROCESS | 23945 | 05:28:27 INFO - PROCESS | 23945 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 05:28:27 INFO - PROCESS | 23945 | Values: 67.0 69.0 68.0 67.0 67.0 68.0 67.0 68.0 68.0 67.0 05:28:27 INFO - PROCESS | 23945 | 05:28:27 INFO - PROCESS | 23945 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.50 stddev:1.25 (1.5%) stddev-sans-first:1.27 05:28:27 INFO - PROCESS | 23945 | Values: 83.0 82.0 84.0 85.0 83.0 85.0 83.0 84.0 85.0 86.0 05:28:27 INFO - PROCESS | 23945 | 05:28:27 INFO - PROCESS | 23945 | [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:120.00 stddev:4.50 (3.8%) stddev-sans-first:4.58 05:28:27 INFO - PROCESS | 23945 | Values: 116.0 116.0 114.0 129.0 118.0 117.0 121.0 119.0 124.0 122.0 05:28:27 INFO - PROCESS | 23945 | 05:28:27 INFO - PROCESS | 23945 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.30 Median:153.50 stddev:7.50 (4.9%) stddev-sans-first:7.60 05:28:27 INFO - PROCESS | 23945 | Values: 145.0 143.0 154.0 153.0 166.0 159.0 147.0 148.0 155.0 143.0 05:28:27 INFO - PROCESS | 23945 | 05:28:27 INFO - PROCESS | 23945 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:1.35 (1.9%) stddev-sans-first:1.42 05:28:27 INFO - PROCESS | 23945 | Values: 70.0 69.0 72.0 73.0 71.0 71.0 70.0 69.0 70.0 69.0 05:28:27 INFO - PROCESS | 23945 | -------- Summary: end -------- 05:28:27 INFO - PROCESS | 23945 | 05:28:28 INFO - TEST-INFO | 23945: exit 0 05:28:28 INFO - TEST-OK | kraken | took 60496ms 05:28:28 INFO - SUITE-END | took 1171s 05:28:28 INFO - Completed test suite (00:19:31) 05:28:28 INFO - Working with test: dromaeo_css 05:28:28 INFO - Generating results file: dromaeo_css 05:28:28 INFO - Working with test: kraken 05:28:28 INFO - Generating results file: kraken 05:28:28 INFO - javascript benchmark 05:28:28 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:28:28 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 05:28:28 INFO - process_Request line: dromaeo_css 6833.80 graph.html#tests=[[72,64,43]] 05:28:28 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:28:28 INFO - process_Request line: kraken 1528.00 graph.html#tests=[[232,64,43]] 05:28:28 INFO - RETURN: dromaeo_css: 6833.80 05:28:28 INFO - RETURN: kraken: 1528.00 05:28:28 INFO - javascript benchmark 05:28:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3190.744740420766, 3234.4339740545397, 3267.166872447526, 3271.607407111147, 3287.753418493612, 5105.132127538318, 5191.299174611427, 5288.15389537674, 5314.362276526817, 5320.973395133029, 5210.192420174879, 5273.419923808378, 5287.233351164079, 5295.258663787073, 5314.548263397606, 4719.2685133804225, 4735.479097299294, 4833.3716616839765, 4928.186849169882, 4933.851984440473, 4750.76246187691, 4813.614910807127, 4831.396075490564, 4845.830395936143, 4903.166461701519, 4792.736399498026, 4802.351682522884, 4814.494478079821, 4848.733319667417, 4849.660523763338, 4790.065937142259, 4822.180229361017, 4830.975845120787, 4832.057748738997, 4855.126077306083, 4703.623710103184, 4800.855974320741, 4817.253325734517, 4866.416030076378, 4878.8292409765845, 4981.128302547076, 5007.298978143063, 5028.245763135559, 5037.823676171316, 5074.949250507521, 5450.345958484968, 5505.174223866452, 5508.586855985777, 5514.6691198528215, 5520.1167813150105, 5602.13166959122, 5610.579206559483, 5669.348024977139, 5691.288588926384, 5736.8852622947725, 5283.28675628789, 5283.841484755463, 5290.1800220965815, 5290.444503327172, 5293.550048245904, 5705.600607957404, 5707.71461426927, 5729.770809167587, 5769.913451298234, 5804.419558044162, 5458.399576046631, 5479.506844383945, 5487.396386397493, 5509.696966666872, 5538.612297139242, 5592.944070559323, 5626.943730562642, 5663.405342438985, 5670.0, 5677.489025987681, 5544.667319960815, 5564.360098588633, 5588.9720551397795, 5602.719864006784, 5651.434856514398, 5633.971830140823, 5647.435256474319, 5674.092145256739, 5681.517071048925, 5707.743151558107, 4286.057067445157, 4320.200762858881, 4320.373545835836, 4331.740095594275, 4356.237658409829, 3859.749116307431, 3892.2215556888737, 3895.4935858338235, 3908.843646254118, 3926.332523471017, 5299.0, 5318.627696061316, 5324.121519949243, 5331.147016477423, 5357.142857142839, 5638.2670252866865, 5644.520215781622, 5647.632903861236, 5653.0, 5653.717314134276, 5248.1340578804065, 5323.387810401853, 5329.25390445338, 5359.946400536022, 5378.838634840961, 4846.491118432585, 4855.198892182751, 4874.707517548958, 4894.510548945148, 4898.167311557044, 5914.378990205966, 5920.230370051866, 5922.703864806743, 5930.8813823723285, 5957.314908785545, 5568.832935011957, 5666.121751128581, 5668.801591944262, 5684.602077854511, 5706.885862282648, 5866.970665146647, 5882.1470886722045, 5884.617499862496, 5895.882082358243, 5944.197533332945, 5611.186377975089, 5612.663240205601, 5613.382527921844, 5620.185073164286, 5629.605927585029, 5547.140193270049, 5605.271314729059, 5648.435156484483, 5682.9147562785765, 5689.914651280317, 5539.196816461671, 5580.274564306615, 5582.916256256078, 5603.607747457639, 5610.971945140248, 5568.91646625309, 5585.860353491195, 5588.161775733673, 5588.580856435865, 5588.580856435865, 5273.997940391313, 5329.387120481194, 5359.249705041375, 5443.210734443563, 5470.562355011669, 5415.079436495726, 5451.48210919962, 5495.203195536705, 5503.504684578407, 5520.613557050968, 5419.620626556103, 5419.89516297485, 5420.891582168413, 5432.837014889559, 5474.808381706621], "unit": "score", "name": "dojo.html", "value": 5209.499565596364}, {"lowerIsBetter": false, "replicates": [472.3646695194964, 516.2901011109724, 518.5307296896309, 534.3561008984175, 543.1797985042584, 34828.30343393131, 35320.646793532054, 35530.644693553026, 35547.466787998135, 35577.0, 38775.22449551014, 39072.21855562887, 39191.0, 39564.60435395652, 39739.60260397395, 8440.535770532619, 8596.054434012254, 8618.052014278424, 8626.827463450758, 8654.177853103976, 8269.627866745981, 8403.789905252386, 8413.0, 8460.323174146084, 8462.23839854413, 8624.65501379944, 8648.827023459527, 8654.913450865506, 8660.0, 8689.782755431133, 8583.656653733844, 8633.050364459905, 8638.136186381344, 8646.783830404227, 8659.393842431033, 8452.028016778087, 8586.957065214634, 8589.141085891424, 8590.484570925764, 8591.183837535424, 40038.79980600107, 40661.18677626461, 40728.0, 40757.79621101905, 40772.184556309, 3403.897883063512, 3477.0959550516795, 3500.859965601373, 3605.729570282213, 4011.0373510357304, 29201.0, 29423.41153176946, 30194.54708179379, 30200.24499387533, 30330.393392132035, 3781.8487260509546, 3796.1838204785827, 3811.6950643948694, 3950.920981580381, 3958.5645578986287, 284272.0, 284800.0, 286005.5699721509, 286220.0, 286403.0, 51777.0, 51942.74028629833, 52178.0, 52228.0, 52249.738751306, 53378.19932701012, 60265.69867150636, 60276.39723602796, 62092.0, 62524.687376563736, 15132.621684457976, 15379.384824607114, 15454.150021748912, 15458.227088645523, 15459.458918937784, 10793.29843560166, 10836.945815270874, 10854.782904342026, 10879.728006799893, 10890.509927053301, 18392.25273599006, 18486.445406637824, 18561.81438185628, 18604.16281267346, 18625.348112815987, 7106.360427561544, 7333.0933957170455, 7384.704611815575, 7387.335139837333, 7442.813929651802, 842.6839935024366, 893.7050773244814, 904.3488688144525, 947.6067432015636, 1062.6068354708652, 27716.0, 28360.574591381144, 28432.43135137327, 28537.286567835556, 28865.42269154647, 1032.7056788815153, 1044.2272718188485, 1098.6594155811724, 1122.4443900269418, 1150.5915400033034, 14684.706305873822, 14857.70284594302, 14886.851131488547, 15008.549743507494, 15142.848571514363, 316837.0, 323639.0, 326046.0, 327040.0, 327487.0, 52025.7398713004, 52334.738326308885, 52383.73808130935, 52413.213801793005, 52473.2129018065, 1292.7414517096618, 1329.4349901291912, 1344.4890941442188, 1352.0940969550425, 1352.7429788340185, 24693.0, 25331.0, 25533.489330213662, 25600.61599075978, 25673.743262567135, 45605.77197113993, 45693.77153114346, 46103.53896460992, 46150.0, 46157.07685846331, 295519.0, 298143.0, 298416.0, 298987.0, 299427.0, 31753.0, 32202.677973220903, 32229.355412891142, 32788.180295492806, 32842.67157328396, 41990.37014444847, 42900.141997159255, 43006.35490467708, 43139.784301078296, 43686.56313436952, 36449.635503644626, 37236.255274894895, 37265.6273437273, 37390.0, 37416.62583374132, 35779.642203577634, 36110.94458765512, 37150.814245928595, 37266.441003384425, 37456.625433745314, 34836.0, 35994.46008309825, 36172.09569760777, 36339.81830090833, 36373.09067273339, 27365.86317068402, 31413.528797067604, 31642.683573163973, 31708.0, 31710.207244818142, 24210.0, 24323.39191520226, 24424.26727198187, 24767.0, 24856.0], "unit": "score", "name": "ext.html", "value": 18118.2444731804}, {"lowerIsBetter": false, "replicates": [320.18193515567725, 320.5688349170365, 324.10493992379156, 326.8953934740884, 327.9442494775888, 16249.268782904768, 16343.75484367734, 17045.06252156134, 17048.062356570383, 17104.14479276036, 15810.209489525507, 16030.35878564859, 16131.193440327996, 16517.752233716474, 16520.66958660826, 5218.452062533436, 5335.33308336458, 5417.864553386177, 5419.620626556142, 5434.538064264542, 5273.314469119028, 5398.595105367093, 5438.0, 5446.782128714846, 5447.319085114361, 5366.490183432587, 5370.516653501184, 5401.6218864679295, 5404.027275090482, 5404.297441332621, 5154.278401023859, 5323.22813192087, 5378.112611419111, 5379.462053794608, 5387.730613469311, 4658.440987081538, 4698.412698412699, 4702.882427939295, 4728.0, 4742.407199100113, 20331.593368132704, 20798.792012079837, 20944.47638809027, 21013.78986210149, 21092.578148436944, 1979.544704717923, 2121.098533123432, 2156.094440335063, 2267.455810605443, 2426.8786560671897, 8649.394542382035, 8762.824743505158, 8901.821963560693, 8924.598393072327, 9077.137671921222, 1820.8088150744245, 1844.2162081115607, 1868.0456986312226, 1879.0, 1900.9144588493414, 51226.743866280805, 63363.683181583794, 64656.0, 66479.66760166216, 68648.6567567164, 9299.53502324881, 9307.53462326881, 9348.392354496937, 9582.377145485521, 9773.12041916231, 12272.693182670504, 12480.81278780819, 12491.125621206611, 12518.937405312916, 12536.185147965352, 7139.535930164627, 7281.089863767029, 7365.594892280868, 7532.962335188289, 7609.353204977529, 6797.966010169917, 6959.478039147084, 7304.926950730531, 7404.296591823768, 7576.583287919218, 4047.797610119482, 4120.91758164835, 4127.711060225755, 4134.441850350225, 4157.043879907638, 1630.502696677501, 1635.419426103716, 1681.5123614152003, 1694.4493039762126, 1712.8544073753621, 891.1845661219911, 930.6975233049286, 963.5471328475605, 979.6179489998906, 989.8713167288206, 16370.508884733477, 16647.91676041612, 16948.915255423643, 17139.143042848056, 17247.310107595807, 931.4644079654225, 931.6971984105057, 940.83535381308, 941.1059493481221, 941.1247539788063, 9474.763130921781, 9647.228221742243, 9671.226301895831, 10031.598736050622, 10106.898931010743, 415443.0, 424259.3935151646, 427129.0, 458407.0, 470769.0, 77748.22251777523, 78848.60575697085, 78860.60569697115, 80675.59662201769, 81423.59288203521, 1068.2522234435771, 1069.6308724832227, 1093.5516438260433, 1134.4497918509517, 1137.016480744167, 15416.768748468558, 15501.224938752792, 15502.147381894105, 15703.764443533128, 15707.057576545443, 33346.0, 33823.83088084544, 34126.488102677984, 34384.0, 34902.476462853585, 46795.0, 47979.28031079467, 48397.27404088871, 49148.75425622849, 49596.504034960635, 7167.605781682058, 7208.423326133792, 7335.963320183365, 7513.436492262993, 7593.088829340514, 9785.510724463891, 11556.88443115558, 12080.75838483208, 12374.75250494967, 12409.193402428813, 10568.731752189786, 10803.513841876977, 10804.945975270073, 10871.67384978452, 10993.505292262027, 10578.100861426865, 10580.523876425425, 10834.349939003685, 10922.399268040333, 11043.779124417628, 10559.63041293551, 10717.678469645924, 10819.134469242284, 10839.0, 10840.512176952214, 7231.240719724353, 7277.417806575355, 7359.668814903449, 7447.478676492594, 7489.28851759082, 9920.801583968425, 10363.585456581652, 10377.117944974761, 10382.169426446017, 10601.25791194609], "unit": "score", "name": "jquery.html", "value": 8214.687016111959}, {"lowerIsBetter": false, "replicates": [1430.2276770543906, 1445.0751519027824, 1599.6640705451855, 1753.7720096387468, 1782.6345599152176, 6520.1523801905805, 7001.824954376143, 7145.428365730742, 7376.778696639103, 7387.630618469075, 7217.711291548332, 7234.385077268425, 7237.203907570163, 7295.708171673126, 7296.37980771635, 2122.61792877282, 2161.7730138335482, 2163.8485306028506, 2164.6969424280614, 2168.4036889855256, 2115.058798834519, 2131.1794958940764, 2177.172674383732, 2182.901769420372, 2183.4977955070344, 2127.946801329964, 2157.66556183791, 2159.0284372032647, 2161.556880839424, 2175.760666326703, 2127.372425134589, 2139.5720855828818, 2145.7854214578574, 2146.0879126371306, 2149.4948687058527, 2128.6806978953127, 2142.046789178816, 2145.238440353683, 2155.9784402155933, 2159.3521943417068, 7365.594892280922, 7396.889046664304, 7399.186089530147, 7408.407327413794, 7408.629568521553, 4349.325854492558, 4446.244138496463, 4455.598996090335, 4464.866054018385, 4467.396901418332, 2777.819441736301, 2780.916572502808, 2904.0416662501325, 2917.5186094294418, 2938.823670579772, 964.686476895005, 980.4509474694194, 984.0651381187829, 987.8419452887575, 1003.82934901067, 9721.930587635425, 9800.95099524505, 9802.264830137769, 9813.803723925554, 9837.55730992107, 3971.821268042945, 4041.3533834586324, 4066.0648050947857, 4071.0840060986634, 4073.165001174752, 8467.915320846836, 8478.830423391497, 8485.872711909326, 8569.057403685589, 8600.956995214983, 4527.886802829956, 4532.9320060199125, 4533.886652833639, 4539.500654927955, 4557.156925968707, 3700.3709369407266, 3985.1830374773103, 4035.3543433050572, 4117.3206420940805, 4183.142455796555, 3438.1748380388526, 3464.636213197578, 3479.4258947273415, 3494.7728397654073, 3528.4707293906117, 1068.1668298727006, 1077.6659235636978, 1086.7011571817654, 1089.5478376473834, 1090.738222826516, 1297.7209899871573, 1302.2772361339548, 1303.1659737767836, 1321.2732996851694, 1344.9865501344862, 6669.7665581704405, 6691.59850408977, 6946.722131114699, 6953.374196322254, 7003.194632617212, 436.5699785711072, 436.6223216917407, 440.12195669638635, 442.5729171349663, 456.6415363939292, 5317.069512835238, 5350.759215835296, 5365.892682146336, 5377.462253774669, 5386.245925570423, 8090.959545202236, 8210.343172546181, 8280.213379728915, 8343.0, 8594.52730099838, 8116.228958248957, 8116.472429292196, 8142.145074767182, 8155.46989445696, 8174.019117705913, 6590.340965903371, 6654.933450665529, 6716.227633822173, 6720.495962802809, 6747.662616869137, 6860.279670634711, 6861.622610756456, 6874.553154044971, 6925.065116209449, 6929.237783843672, 7617.314441700052, 7690.807729806799, 8021.15777843318, 8033.277005069572, 8088.555129467935, 8057.919420805952, 8187.590620468834, 8309.086000540057, 8319.417640765088, 8321.12628174033, 6369.554131210771, 6496.6751662415745, 6527.412532871875, 6556.114924485133, 6574.868502629825, 7052.788416347517, 7062.117235345582, 7089.574625522278, 7090.574565526085, 7101.928980710127, 6295.55931084838, 6440.2915679276175, 6443.7744678936015, 6457.935420645734, 6474.223093228843, 6374.362563743589, 6396.360363963567, 6398.1362516059735, 6477.319881412383, 6486.0, 6403.903941440789, 6448.322926092693, 6460.773872914426, 6462.547621666438, 6468.870622587616, 6111.083337499411, 6143.907841382472, 6201.162843016135, 6270.874582508415, 6281.026440901667, 6287.811365659038, 6303.905441418291, 6310.905336419865, 6338.080978258219, 6366.681665916593], "unit": "score", "name": "mootools.html", "value": 4144.464221305523}, {"lowerIsBetter": false, "replicates": [283.85665239054276, 289.5902298247978, 293.7062937062937, 296.5270393722013, 297.63539663911706, 6217.564770466063, 6246.843828904274, 6247.468965137963, 6273.466755325803, 6310.621362718241, 6212.565120441571, 6237.906431403532, 6269.185005949232, 6278.6232826030355, 6279.0, 4504.752238626874, 4621.491635920046, 4629.2824612184995, 4648.209804333254, 4654.115718013583, 4629.0, 4633.837815676452, 4635.814567417299, 4661.347411362412, 4672.766361681903, 4581.541845815425, 4602.12559613674, 4613.723176609397, 4617.353570500116, 4620.1221767864, 4609.101225261059, 4611.976940115294, 4613.423322084739, 4626.028534007863, 4636.281376386665, 3935.2523020626277, 3936.1734035852505, 3942.0, 3945.0334668006235, 3946.3685810270217, 5866.73599688015, 5924.348321684612, 5924.407559244084, 5931.614445061057, 5941.168236446901, 5164.431912489623, 5221.869453263661, 5246.449122842085, 5258.13240815265, 5267.578593712494, 6560.0, 6579.0, 6579.47364210862, 6601.0, 6605.834854128685, 4225.598568136023, 4231.767252801094, 4237.279662457358, 4239.639630631369, 4258.9565556438565, 6860.970854371834, 6931.0643063186835, 6935.271796461349, 6948.930510694879, 6981.301869812978, 4423.358613001097, 4424.491183513937, 4426.070525189682, 4434.512203657595, 4444.9998750281575, 4328.43730315057, 4466.2630665940405, 4469.9553004469535, 4472.463304403493, 4474.217012022883, 5265.973670131625, 5284.841454756363, 5300.6024548158275, 5304.681719096867, 5306.734663266899, 6626.53614246998, 6673.099131617267, 6677.499187560952, 6678.465722742169, 6698.665066746643, 1531.7166324230054, 1541.8535239152263, 1541.8612324890814, 1545.5981444824201, 1551.4259723902228, 962.3311798300255, 981.8625392445064, 987.3631507677508, 996.8305388084043, 1012.4178597306578, 6228.5017198624, 6238.906416403667, 6279.937200627935, 6282.089097080898, 6288.402601752826, 6778.0, 6791.3548212919695, 6801.965990170018, 6802.285759995129, 6854.862902741917, 6206.844828879224, 6239.812805615838, 6296.401841825019, 6351.523635727246, 6380.0748891410485, 3712.8700495483067, 3726.3851464508593, 3727.4036154215196, 3741.1956429367274, 3749.437584362313, 7216.278372162742, 7218.747343842941, 7246.347828695442, 7281.927180728125, 7284.672189751368, 7078.752243671447, 7103.715851365991, 7110.786676399716, 7124.038254835635, 7125.42996560274, 7005.229424763272, 7247.855042899112, 7251.818704532535, 7259.6007219603425, 7264.055672762507, 6847.281035491401, 6875.106236189264, 6880.243173251039, 6882.655867206519, 6891.3797758202, 6852.6916288768125, 6853.862922741617, 6857.622830744157, 6859.142607174103, 6872.312768723287, 7214.74748383804, 7224.638768061471, 7249.6950548901705, 7253.238409967089, 7260.491765576359, 4323.632491238154, 4361.978190109029, 4387.188370151533, 4460.888477787951, 4467.419235499494, 6835.692393842389, 6839.110915580943, 6848.554843935129, 6898.655067246718, 6898.965505172442, 6663.666816659051, 6671.199456065303, 6677.83305417349, 6680.832979175365, 6694.665266736741, 6662.433693136138, 6665.0, 6671.132752742113, 6677.69950352245, 6681.632510211985, 6296.212973378328, 6485.481161507162, 6496.123023391781, 6509.772157974448, 6521.5108866834225, 6700.229473610597, 6716.496262780409, 6728.8654226914205, 6740.157480314961, 6753.493487988519, 6520.315366886409, 6556.147700798866, 6562.671866406756, 6572.047053177358, 6576.408123268929], "unit": "score", "name": "prototype.html", "value": 4886.712674468438}, {"lowerIsBetter": false, "replicates": [805.7461899501657, 810.0967421325222, 810.7243537197352, 821.0516853034746, 841.970531031414, 13361.198328100309, 13422.328883555832, 13432.66418339542, 13482.730345393098, 13499.39252733627, 12314.507419703223, 13914.791278130837, 13948.302584870742, 13951.651208719788, 14020.579382618513, 820.8686610142379, 826.8181000179951, 828.1470085811624, 829.179112678447, 829.4774292195908, 635.9332270111641, 815.1685281013363, 829.9626516806758, 831.0899564976371, 831.5925196653626, 874.0647507167333, 876.3164731509432, 876.3296078499952, 879.4767113567417, 881.0440671871028, 863.0851297624538, 869.5695630662863, 870.182028892845, 872.7294538692994, 876.8640860666607, 637.5250438423358, 640.0591131037368, 642.0177128992649, 642.6465444005778, 644.7227692092398, 13943.233122178277, 14034.157950522898, 14043.578692639136, 14057.507987220399, 14151.646208844759, 13438.0, 13525.458981640722, 13551.59345219645, 13650.0, 13675.179489230679, 10911.454427278604, 11066.723331916766, 11140.108791296676, 11236.550537978472, 11621.360825154614, 3708.9258214835554, 3710.8144592770254, 3722.274156539449, 3808.0479880029993, 3837.9232415351535, 50182.0, 50771.746141269425, 51209.743951280376, 51387.22919156215, 51656.0, 10371.740706482398, 10429.374237545771, 10470.842937355947, 10570.947145264377, 10624.203184761174, 17949.192286347145, 18101.7284740729, 18154.727679084823, 18300.359487417878, 18367.35714249995, 7490.0, 7948.523088614702, 8154.918450815535, 8158.469699469515, 8418.957905210435, 4376.452943382077, 4436.489803672554, 4531.682782205214, 4598.287265473857, 4690.249560070372, 3049.283418396675, 3095.5511450839504, 3096.7677424193275, 3097.1792474994145, 3113.081640915935, 559.636236446305, 570.0138759945318, 571.7741492110677, 572.241779641976, 573.0744847071949, 585.1924344404779, 594.8721024979563, 684.3191024930227, 689.9793006209821, 700.190961171227, 8684.739457816275, 8800.515971621622, 8810.383273170944, 8892.532732099131, 9279.164875161268, 688.3460712323313, 690.9550879192836, 710.4777988178685, 710.761894765249, 725.6621419885478, 3844.4233364994916, 4411.625011873963, 4452.688311818207, 4511.526289739596, 4547.522510136388, 53704.46295536995, 53910.730446347516, 54300.45699543033, 55160.0, 55515.0, 47975.28037079447, 48538.5146148541, 48888.755556222706, 49774.75112624414, 50028.0, 48538.0, 48985.0, 49070.75464622654, 49201.2619810696, 50797.49202507928, 8619.374523264674, 8725.781855453664, 8787.824243515222, 8796.868046979173, 8994.460332380078, 32939.67060329366, 33468.49797252994, 34078.48882266817, 34110.147246319044, 34628.0, 40860.59139408687, 40947.0, 43785.0, 43926.12147756963, 44297.33553996757, 11738.647840564796, 11852.466639001093, 11978.520859165885, 12046.156769026435, 12103.939480302543, 11757.76484470323, 11793.11551633648, 11822.586209482626, 11847.881521184678, 12332.075094368138, 11157.66527004191, 11246.325220486797, 11382.430878456209, 11719.414029298672, 12028.75942481128, 11450.141239406912, 11759.88240117622, 12308.446119924803, 12340.382980851102, 12341.50633974631, 10909.0, 11831.0, 12051.457684404399, 12061.035117190779, 12399.644955070831, 10060.798784024424, 10093.747656308651, 10127.291089623655, 10153.39079655223, 10228.897711022795, 9518.666846660333, 9526.476043817656, 9944.204463643036, 10445.9477702611, 10469.581216751245], "unit": "score", "name": "yui.html", "value": 6485.548812953956}], "name": "dromaeo_css", "value": 6833.802622787743}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 112.0, 111.0, 112.0, 124.0, 113.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [153.0, 126.0, 149.0, 179.0, 134.0, 149.0, 160.0, 127.0, 176.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 148.1}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 162.0, 162.0, 163.0, 163.0, 167.0, 169.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 75.0, 74.0, 76.0, 135.0, 75.0, 75.0, 73.0, 75.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 148.0, 93.0, 94.0, 93.0, 147.0, 94.0, 94.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 147.0, 150.0, 147.0, 146.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 98.0, 96.0, 98.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 58.0, 62.0, 66.0, 59.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 59.7}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 84.0, 85.0, 83.0, 85.0, 83.0, 84.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 114.0, 129.0, 118.0, 117.0, 121.0, 119.0, 124.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.6}, {"lowerIsBetter": true, "replicates": [145.0, 143.0, 154.0, 153.0, 166.0, 159.0, 147.0, 148.0, 155.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.3}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 72.0, 73.0, 71.0, 71.0, 70.0, 69.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1528.0}]} 05:28:28 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1528.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6833.80"}}} 05:28:29 INFO - Return code: 0 05:28:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:28:29 ERROR - # TBPL SUCCESS # 05:28:29 INFO - Running post-action listener: _resource_record_post_action 05:28:29 INFO - Running post-run listener: _resource_record_post_run 05:28:30 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 28672; Write bytes: 534355968; Read time: 432; Write time: 495872 05:28:30 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 240521216; Read time: 188; Write time: 284792 05:28:30 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 24576; Write bytes: 293834752; Read time: 244; Write time: 211080 05:28:30 INFO - Running post-run listener: _upload_blobber_files 05:28:30 INFO - Blob upload gear active. 05:28:30 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:28:30 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:28:30 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:28:30 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:28:30 INFO - (blobuploader) - INFO - Open directory for files ... 05:28:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:28:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:28:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:31 INFO - (blobuploader) - INFO - Done attempting. 05:28:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:28:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:28:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:32 INFO - (blobuploader) - INFO - Done attempting. 05:28:32 INFO - (blobuploader) - INFO - Iteration through files over. 05:28:32 INFO - Return code: 0 05:28:32 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:28:32 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:28:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/409ed0f5acad691753adb5cd130eded2bea48ba074bdefa7e6187793bcb2ec845f4b9cec57f55cc3e22056e171835387c478306a382f7a3a5e0d3ff0534fc353", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce8059fa45e5fdf17fe0079d3c868b2bc0239b17e987b9d2cbedc999751b91d542a1256687bd731e0f8bc4a9b60b76c1a085752c636b9e2dbc587d9117d12898"} 05:28:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:28:32 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:28:32 INFO - Contents: 05:28:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/409ed0f5acad691753adb5cd130eded2bea48ba074bdefa7e6187793bcb2ec845f4b9cec57f55cc3e22056e171835387c478306a382f7a3a5e0d3ff0534fc353", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce8059fa45e5fdf17fe0079d3c868b2bc0239b17e987b9d2cbedc999751b91d542a1256687bd731e0f8bc4a9b60b76c1a085752c636b9e2dbc587d9117d12898"} 05:28:32 INFO - Running post-run listener: copy_logs_to_upload_dir 05:28:32 INFO - Copying logs to upload dir... 05:28:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:28:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.287447 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-03 05:28:32.081389) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 05:28:32.085051) ========= 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=232498196343f89f466a4a9a000001c8-1457009043.339429-96061994 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/Fx-Team/sha512/409ed0f5acad691753adb5cd130eded2bea48ba074bdefa7e6187793bcb2ec845f4b9cec57f55cc3e22056e171835387c478306a382f7a3a5e0d3ff0534fc353", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce8059fa45e5fdf17fe0079d3c868b2bc0239b17e987b9d2cbedc999751b91d542a1256687bd731e0f8bc4a9b60b76c1a085752c636b9e2dbc587d9117d12898"} build_url:https://queue.taskcluster.net/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/C8e40-DRSsKFbLMspKApXw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/409ed0f5acad691753adb5cd130eded2bea48ba074bdefa7e6187793bcb2ec845f4b9cec57f55cc3e22056e171835387c478306a382f7a3a5e0d3ff0534fc353", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce8059fa45e5fdf17fe0079d3c868b2bc0239b17e987b9d2cbedc999751b91d542a1256687bd731e0f8bc4a9b60b76c1a085752c636b9e2dbc587d9117d12898"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 05:28:32.109927) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 05:28:32.110252) ========= 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=232498196343f89f466a4a9a000001c8-1457009043.339429-96061994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 05:28:32.191459) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 05:28:32.191801) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 05:28:32.192114) ========= ========= Total master_lag: 0.25 =========