builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1459745771.3 results: success (0) buildid: 20160403193250 builduid: 54ff50009bc84010ab2bb52b463c2616 revision: 600f96d25f8c94c73849dc98f0ad36769f9b57d3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.303926) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.304391) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.304774) ========= 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=af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006373 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.336177) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.336497) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.366233) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.366544) ========= 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=af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004622 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.418866) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.419191) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.419580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.419930) ========= 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=af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-03 21:56:13-- 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% 225M=0s 2016-04-03 21:56:13 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101959 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.535912) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.536271) ========= 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=af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019736 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.586556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.586929) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 600f96d25f8c94c73849dc98f0ad36769f9b57d3 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 600f96d25f8c94c73849dc98f0ad36769f9b57d3 --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=af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-03 21:56:13,550 truncating revision to first 12 chars 2016-04-03 21:56:13,550 Setting DEBUG logging. 2016-04-03 21:56:13,550 attempt 1/10 2016-04-03 21:56:13,550 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/600f96d25f8c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-03 21:56:13,911 unpacking tar archive at: mozilla-inbound-600f96d25f8c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640648 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:12.240946) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:12.241407) ========= echo 600f96d25f8c94c73849dc98f0ad36769f9b57d3 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'600f96d25f8c94c73849dc98f0ad36769f9b57d3'] 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=af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 600f96d25f8c94c73849dc98f0ad36769f9b57d3 program finished with exit code 0 elapsedTime=0.004704 script_repo_revision: '600f96d25f8c94c73849dc98f0ad36769f9b57d3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:12.293635) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:12.293984) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:12.311181) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-03 21:56:12.311543) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:56:14 INFO - MultiFileLogger online at 20160403 21:56:14 in /builds/slave/test-pgo 21:56:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:56:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:56:14 INFO - {'append_to_log': False, 21:56:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:56:14 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:56:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:56:14 INFO - 'branch': 'Mozilla-Inbound', 21:56:14 INFO - 'buildbot_json_path': 'buildprops.json', 21:56:14 INFO - 'config_files': ('talos/linux_config.py',), 21:56:14 INFO - 'default_actions': ('clobber', 21:56:14 INFO - 'read-buildbot-config', 21:56:14 INFO - 'download-and-extract', 21:56:14 INFO - 'populate-webroot', 21:56:14 INFO - 'create-virtualenv', 21:56:14 INFO - 'install', 21:56:14 INFO - 'run-tests'), 21:56:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:56:14 INFO - 'download_minidump_stackwalk': True, 21:56:14 INFO - 'download_symbols': 'ondemand', 21:56:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:56:14 INFO - 'tooltool.py': '/tools/tooltool.py', 21:56:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:56:14 INFO - '/tools/misc-python/virtualenv.py')}, 21:56:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:56:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:56:14 INFO - 'installer_path': 'installer.exe', 21:56:14 INFO - 'log_level': 'info', 21:56:14 INFO - 'log_name': 'talos', 21:56:14 INFO - 'log_to_console': True, 21:56:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:56:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:56:14 INFO - 'opt_config_files': (), 21:56:14 INFO - 'pip_index': False, 21:56:14 INFO - 'sps_profile': False, 21:56:14 INFO - 'sps_profile_interval': 0, 21:56:14 INFO - 'suite': 'dromaeojs-e10s', 21:56:14 INFO - 'system_bits': '32', 21:56:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:56:14 INFO - 'title': 'talos-linux64-ix-020', 21:56:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:56:14 INFO - 'use_talos_json': True, 21:56:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:56:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:56:14 INFO - 'work_dir': 'build'} 21:56:14 INFO - ##### 21:56:14 INFO - ##### Running clobber step. 21:56:14 INFO - ##### 21:56:14 INFO - Running pre-action listener: _resource_record_pre_action 21:56:14 INFO - Running main action method: clobber 21:56:14 INFO - rmtree: /builds/slave/test-pgo/build 21:56:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:56:15 INFO - Running post-action listener: _resource_record_post_action 21:56:15 INFO - ##### 21:56:15 INFO - ##### Running read-buildbot-config step. 21:56:15 INFO - ##### 21:56:15 INFO - Running pre-action listener: _resource_record_pre_action 21:56:15 INFO - Running main action method: read_buildbot_config 21:56:15 INFO - Using buildbot properties: 21:56:15 INFO - { 21:56:15 INFO - "project": "", 21:56:15 INFO - "product": "firefox", 21:56:15 INFO - "script_repo_revision": "production", 21:56:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 21:56:15 INFO - "repository": "", 21:56:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 21:56:15 INFO - "buildid": "20160403193250", 21:56:15 INFO - "pgo_build": "True", 21:56:15 INFO - "basedir": "/builds/slave/test-pgo", 21:56:15 INFO - "buildnumber": 883, 21:56:15 INFO - "slavename": "talos-linux64-ix-020", 21:56:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:56:15 INFO - "platform": "ubuntu64_hw", 21:56:15 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:56:15 INFO - "branch": "mozilla-inbound", 21:56:15 INFO - "repo_path": "integration/mozilla-inbound", 21:56:15 INFO - "revision": "600f96d25f8c94c73849dc98f0ad36769f9b57d3", 21:56:15 INFO - "stage_platform": "linux64-pgo", 21:56:15 INFO - "builduid": "54ff50009bc84010ab2bb52b463c2616", 21:56:15 INFO - "slavebuilddir": "test" 21:56:15 INFO - } 21:56:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 21:56:15 INFO - Running post-action listener: _resource_record_post_action 21:56:15 INFO - ##### 21:56:15 INFO - ##### Running download-and-extract step. 21:56:15 INFO - ##### 21:56:15 INFO - Running pre-action listener: _resource_record_pre_action 21:56:15 INFO - Running main action method: download_and_extract 21:56:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:15 INFO - https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:56:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:56:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:56:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:56:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:56:17 INFO - Downloaded 1361 bytes. 21:56:17 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:56:17 INFO - Using the following test package requirements: 21:56:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:56:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:56:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:56:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:17 INFO - u'jsshell-linux-x86_64.zip'], 21:56:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:56:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:56:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:56:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:56:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:56:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:56:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:56:17 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')]} 21:56:17 INFO - https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:56:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:56:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:56:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:56:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:56:18 INFO - Downloaded 23696118 bytes. 21:56:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:56:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:56:19 INFO - Return code: 0 21:56:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:19 INFO - https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:56:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:56:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:56:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:56:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:56:31 INFO - Downloaded 23696118 bytes. 21:56:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:56:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:56:32 INFO - Return code: 0 21:56:32 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')]} 21:56:32 INFO - https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:56:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:56:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:56:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:56:33 INFO - Downloaded 10847584 bytes. 21:56:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:56:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 21:56:33 INFO - Return code: 0 21:56: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')]} 21:56:33 INFO - https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:56:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:56:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:56:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:56:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:56:36 INFO - Downloaded 57685198 bytes. 21:56:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:56:36 INFO - mkdir: /builds/slave/test-pgo/properties 21:56:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:56:36 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:56:36 INFO - Contents: 21:56:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:56:37 INFO - Running post-action listener: _resource_record_post_action 21:56:37 INFO - Running post-action listener: set_extra_try_arguments 21:56:37 INFO - ##### 21:56:37 INFO - ##### Running populate-webroot step. 21:56:37 INFO - ##### 21:56:37 INFO - Running pre-action listener: _resource_record_pre_action 21:56:37 INFO - Running main action method: populate_webroot 21:56:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:56:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:56:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:56:37 INFO - '--tppagecycles', 21:56:37 INFO - '7'], 21:56:37 INFO - 'tests': ['tsvgm']}}, 21:56:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:56:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:56:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:56:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 21:56:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:56:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:56:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:37 INFO - 'talos_options': ['--e10s'], 21:56:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:37 INFO - 'tests': ['damp', 'tps']}, 21:56:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:37 INFO - 'talos_options': ['--e10s'], 21:56:37 INFO - 'tests': ['damp', 'tps']}, 21:56:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:56:37 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 21:56:37 INFO - 'tests': ['dromaeo_dom']}, 21:56:37 INFO - 'other': {'tests': ['a11yr', 21:56:37 INFO - 'ts_paint', 21:56:37 INFO - 'tpaint', 21:56:37 INFO - 'sessionrestore', 21:56:37 INFO - 'sessionrestore_no_auto_restore', 21:56:37 INFO - 'tabpaint']}, 21:56:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:56:37 INFO - 'tests': ['a11yr', 21:56:37 INFO - 'ts_paint', 21:56:37 INFO - 'tpaint', 21:56:37 INFO - 'sessionrestore', 21:56:37 INFO - 'sessionrestore_no_auto_restore', 21:56:37 INFO - 'tabpaint']}, 21:56:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:56:37 INFO - 'tests': ['a11yr', 21:56:37 INFO - 'ts_paint', 21:56:37 INFO - 'tpaint', 21:56:37 INFO - 'sessionrestore', 21:56:37 INFO - 'sessionrestore_no_auto_restore', 21:56:37 INFO - 'tabpaint']}, 21:56:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:56:37 INFO - 'tests': ['a11yr', 21:56:37 INFO - 'ts_paint', 21:56:37 INFO - 'tpaint', 21:56:37 INFO - 'sessionrestore', 21:56:37 INFO - 'sessionrestore_no_auto_restore', 21:56:37 INFO - 'tabpaint']}, 21:56:37 INFO - 'other_l64': {'tests': ['a11yr', 21:56:37 INFO - 'ts_paint', 21:56:37 INFO - 'tpaint', 21:56:37 INFO - 'sessionrestore', 21:56:37 INFO - 'sessionrestore_no_auto_restore', 21:56:37 INFO - 'tabpaint']}, 21:56:37 INFO - 'other_nol64': {'tests': ['a11yr', 21:56:37 INFO - 'ts_paint', 21:56:37 INFO - 'tpaint', 21:56:37 INFO - 'sessionrestore', 21:56:37 INFO - 'sessionrestore_no_auto_restore', 21:56:37 INFO - 'tabpaint']}, 21:56:37 INFO - 'svgr': {'tests': ['tsvgx', 21:56:37 INFO - 'tsvgr_opacity', 21:56:37 INFO - 'tart', 21:56:37 INFO - 'tscrollx', 21:56:37 INFO - 'cart']}, 21:56:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:56:37 INFO - 'tests': ['tsvgx', 21:56:37 INFO - 'tsvgr_opacity', 21:56:37 INFO - 'tart', 21:56:37 INFO - 'tscrollx', 21:56:37 INFO - 'cart']}, 21:56:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:37 INFO - 'tests': ['tp5o']}, 21:56:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:37 INFO - 'talos_options': ['--e10s'], 21:56:37 INFO - 'tests': ['tp5o']}, 21:56:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:37 INFO - 'talos_options': ['--xperf_path', 21:56:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:37 INFO - 'tests': ['tp5n']}, 21:56:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:37 INFO - 'talos_options': ['--e10s', 21:56:37 INFO - '--xperf_path', 21:56:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:37 INFO - 'tests': ['tp5n']}}, 21:56:37 INFO - 'talos.zip': {'path': '', 21:56:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:56:37 INFO - Running post-action listener: _resource_record_post_action 21:56:37 INFO - ##### 21:56:37 INFO - ##### Running create-virtualenv step. 21:56:37 INFO - ##### 21:56:37 INFO - Running pre-action listener: _resource_record_pre_action 21:56:37 INFO - Running main action method: create_virtualenv 21:56:37 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:56:37 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 21:56:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:56:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:56:37 INFO - Using real prefix '/usr' 21:56:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:56:37 INFO - Installing distribute.............................................................................................................................................................................................done. 21:56:39 INFO - Installing pip.................done. 21:56:39 INFO - Return code: 0 21:56:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:39 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 0x7f3b30988f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be08d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f8b0>, '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 0x2c707b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70c60>, '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': 'af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854', '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 21:56:39 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 21:56:39 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 21:56:39 INFO - Using env: {'DISPLAY': ':0', 21:56:39 INFO - 'HOME': '/home/cltbld', 21:56:39 INFO - 'LANG': 'en_US.UTF-8', 21:56:39 INFO - 'LANGUAGE': 'en_US:en', 21:56:39 INFO - 'LOGNAME': 'cltbld', 21:56:39 INFO - 'MAIL': '/var/mail/cltbld', 21:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:39 INFO - 'MOZ_NO_REMOTE': '1', 21:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:39 INFO - 'NO_EM_RESTART': '1', 21:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:39 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:39 INFO - 'SHELL': '/bin/bash', 21:56:39 INFO - 'SHLVL': '1', 21:56:39 INFO - 'TERM': 'linux', 21:56:39 INFO - 'TMOUT': '86400', 21:56:39 INFO - 'USER': 'cltbld', 21:56:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854', 21:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:39 INFO - '_': '/tools/buildbot/bin/python'} 21:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:39 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 21:56:39 INFO - Cleaning up... 21:56:39 INFO - Return code: 0 21:56:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:39 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 0x7f3b30988f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be08d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f8b0>, '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 0x2c707b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70c60>, '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': 'af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854', '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 21:56:39 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 21:56:39 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 21:56:39 INFO - Using env: {'DISPLAY': ':0', 21:56:39 INFO - 'HOME': '/home/cltbld', 21:56:39 INFO - 'LANG': 'en_US.UTF-8', 21:56:39 INFO - 'LANGUAGE': 'en_US:en', 21:56:39 INFO - 'LOGNAME': 'cltbld', 21:56:39 INFO - 'MAIL': '/var/mail/cltbld', 21:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:39 INFO - 'MOZ_NO_REMOTE': '1', 21:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:39 INFO - 'NO_EM_RESTART': '1', 21:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:39 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:39 INFO - 'SHELL': '/bin/bash', 21:56:39 INFO - 'SHLVL': '1', 21:56:39 INFO - 'TERM': 'linux', 21:56:39 INFO - 'TMOUT': '86400', 21:56:39 INFO - 'USER': 'cltbld', 21:56:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854', 21:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:39 INFO - '_': '/tools/buildbot/bin/python'} 21:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:40 INFO - Downloading/unpacking psutil>=0.7.1 21:56:40 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 21:56:40 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 21:56:40 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 21:56:40 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 21:56:40 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 21:56:40 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 21:56:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:56:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:42 INFO - Installing collected packages: psutil 21:56:42 INFO - Running setup.py install for psutil 21:56:42 INFO - building 'psutil._psutil_linux' extension 21:56:42 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 21:56:42 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 21:56:42 INFO - building 'psutil._psutil_posix' extension 21:56:42 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 21:56:42 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 21:56:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:42 INFO - Successfully installed psutil 21:56:42 INFO - Cleaning up... 21:56:42 INFO - Return code: 0 21:56:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:56:42 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')]} 21:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:42 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')]} 21:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:42 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 0x7f3b30988f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be08d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f8b0>, '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 0x2c707b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70c60>, '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': 'af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854', '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 21:56:42 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 21:56:42 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 21:56:42 INFO - Using env: {'DISPLAY': ':0', 21:56:42 INFO - 'HOME': '/home/cltbld', 21:56:42 INFO - 'LANG': 'en_US.UTF-8', 21:56:42 INFO - 'LANGUAGE': 'en_US:en', 21:56:42 INFO - 'LOGNAME': 'cltbld', 21:56:42 INFO - 'MAIL': '/var/mail/cltbld', 21:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:42 INFO - 'MOZ_NO_REMOTE': '1', 21:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:42 INFO - 'NO_EM_RESTART': '1', 21:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:42 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:42 INFO - 'SHELL': '/bin/bash', 21:56:42 INFO - 'SHLVL': '1', 21:56:42 INFO - 'TERM': 'linux', 21:56:42 INFO - 'TMOUT': '86400', 21:56:42 INFO - 'USER': 'cltbld', 21:56:42 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854', 21:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:42 INFO - '_': '/tools/buildbot/bin/python'} 21:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:56:42 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 21:56:42 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 21:56:42 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 21:56:42 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 21:56:42 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 21:56:42 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 21:56:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:56:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:56:44 INFO - Installing collected packages: mozsystemmonitor 21:56:44 INFO - Running setup.py install for mozsystemmonitor 21:56:44 INFO - Successfully installed mozsystemmonitor 21:56:44 INFO - Cleaning up... 21:56:44 INFO - Return code: 0 21:56:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:56:44 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')]} 21:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:44 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')]} 21:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:44 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 0x7f3b30988f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be08d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f8b0>, '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 0x2c707b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70c60>, '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': 'af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854', '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 21:56:44 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 21:56:44 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 21:56:44 INFO - Using env: {'DISPLAY': ':0', 21:56:44 INFO - 'HOME': '/home/cltbld', 21:56:44 INFO - 'LANG': 'en_US.UTF-8', 21:56:44 INFO - 'LANGUAGE': 'en_US:en', 21:56:44 INFO - 'LOGNAME': 'cltbld', 21:56:44 INFO - 'MAIL': '/var/mail/cltbld', 21:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:44 INFO - 'MOZ_NO_REMOTE': '1', 21:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:44 INFO - 'NO_EM_RESTART': '1', 21:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:44 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:44 INFO - 'SHELL': '/bin/bash', 21:56:44 INFO - 'SHLVL': '1', 21:56:44 INFO - 'TERM': 'linux', 21:56:44 INFO - 'TMOUT': '86400', 21:56:44 INFO - 'USER': 'cltbld', 21:56:44 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854', 21:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:44 INFO - '_': '/tools/buildbot/bin/python'} 21:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:45 INFO - Downloading/unpacking blobuploader==1.2.4 21:56:45 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 21:56:45 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 21:56:45 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 21:56:45 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 21:56:45 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 21:56:45 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 21:56:46 INFO - Downloading blobuploader-1.2.4.tar.gz 21:56:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:56:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:56:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:47 INFO - Downloading docopt-0.6.1.tar.gz 21:56:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:56:47 INFO - Installing collected packages: blobuploader, requests, docopt 21:56:47 INFO - Running setup.py install for blobuploader 21:56:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:56:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:56:47 INFO - Running setup.py install for requests 21:56:48 INFO - Running setup.py install for docopt 21:56:48 INFO - Successfully installed blobuploader requests docopt 21:56:48 INFO - Cleaning up... 21:56:48 INFO - Return code: 0 21:56:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:56:48 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')]} 21:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:48 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')]} 21:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:48 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 0x7f3b30988f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be08d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f8b0>, '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 0x2c707b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70c60>, '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': 'af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854', '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 21:56:48 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 21:56:48 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 21:56:48 INFO - Using env: {'DISPLAY': ':0', 21:56:48 INFO - 'HOME': '/home/cltbld', 21:56:48 INFO - 'LANG': 'en_US.UTF-8', 21:56:48 INFO - 'LANGUAGE': 'en_US:en', 21:56:48 INFO - 'LOGNAME': 'cltbld', 21:56:48 INFO - 'MAIL': '/var/mail/cltbld', 21:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:48 INFO - 'MOZ_NO_REMOTE': '1', 21:56:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:48 INFO - 'NO_EM_RESTART': '1', 21:56:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:48 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:48 INFO - 'SHELL': '/bin/bash', 21:56:48 INFO - 'SHLVL': '1', 21:56:48 INFO - 'TERM': 'linux', 21:56:48 INFO - 'TMOUT': '86400', 21:56:48 INFO - 'USER': 'cltbld', 21:56:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854', 21:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:48 INFO - '_': '/tools/buildbot/bin/python'} 21:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:56:48 INFO - Running setup.py (path:/tmp/pip-VBNR6W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:56:48 INFO - Running setup.py (path:/tmp/pip-_X9HKo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:56:48 INFO - Running setup.py (path:/tmp/pip-h2I9qg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:56:48 INFO - Running setup.py (path:/tmp/pip-w735qk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:56:48 INFO - Running setup.py (path:/tmp/pip-VZ0bjj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:56:48 INFO - Running setup.py (path:/tmp/pip-_sMqgE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:56:48 INFO - Running setup.py (path:/tmp/pip-IBYLgt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:56:49 INFO - Running setup.py (path:/tmp/pip-NQLMCE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:56:49 INFO - Running setup.py (path:/tmp/pip-hnqGSD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:56:49 INFO - Running setup.py (path:/tmp/pip-2l90FN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:56:49 INFO - Running setup.py (path:/tmp/pip-TPOQU0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:56:49 INFO - Running setup.py (path:/tmp/pip-dvFoNB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:56:49 INFO - Running setup.py (path:/tmp/pip-ZrDND1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:56:49 INFO - Running setup.py (path:/tmp/pip-cc5371-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:56:49 INFO - Running setup.py (path:/tmp/pip-o948TP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:56:49 INFO - Running setup.py (path:/tmp/pip-WJAhZS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:56:49 INFO - Running setup.py (path:/tmp/pip-GPP1k9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:56:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:56:49 INFO - Running setup.py install for manifestparser 21:56:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:56:49 INFO - Running setup.py install for mozcrash 21:56:49 INFO - Running setup.py install for mozdebug 21:56:50 INFO - Running setup.py install for mozdevice 21:56:50 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:56:50 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:56:50 INFO - Running setup.py install for mozfile 21:56:50 INFO - Running setup.py install for mozhttpd 21:56:50 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:56:50 INFO - Running setup.py install for mozinfo 21:56:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:56:50 INFO - Running setup.py install for mozInstall 21:56:50 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:56:50 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:56:50 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:56:50 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:56:50 INFO - Running setup.py install for mozleak 21:56:50 INFO - Running setup.py install for mozlog 21:56:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:56:50 INFO - Running setup.py install for moznetwork 21:56:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:56:50 INFO - Running setup.py install for mozprocess 21:56:50 INFO - Running setup.py install for mozprofile 21:56:51 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:56:51 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:56:51 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:56:51 INFO - Running setup.py install for mozrunner 21:56:51 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:56:51 INFO - Running setup.py install for mozscreenshot 21:56:51 INFO - Running setup.py install for moztest 21:56:51 INFO - Running setup.py install for mozversion 21:56:51 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:56:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:56:51 INFO - Cleaning up... 21:56:51 INFO - Return code: 0 21:56:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:56:51 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')]} 21:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:51 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')]} 21:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:51 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 0x7f3b30988f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be08d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f8b0>, '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 0x2c707b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70c60>, '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': 'af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854', '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 21:56:51 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 21:56:51 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 21:56:51 INFO - Using env: {'DISPLAY': ':0', 21:56:51 INFO - 'HOME': '/home/cltbld', 21:56:51 INFO - 'LANG': 'en_US.UTF-8', 21:56:51 INFO - 'LANGUAGE': 'en_US:en', 21:56:51 INFO - 'LOGNAME': 'cltbld', 21:56:51 INFO - 'MAIL': '/var/mail/cltbld', 21:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:51 INFO - 'MOZ_NO_REMOTE': '1', 21:56:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:51 INFO - 'NO_EM_RESTART': '1', 21:56:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:51 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:51 INFO - 'SHELL': '/bin/bash', 21:56:51 INFO - 'SHLVL': '1', 21:56:51 INFO - 'TERM': 'linux', 21:56:51 INFO - 'TMOUT': '86400', 21:56:51 INFO - 'USER': 'cltbld', 21:56:51 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854', 21:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:51 INFO - '_': '/tools/buildbot/bin/python'} 21:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:56:51 INFO - Running setup.py (path:/tmp/pip-hNL0bJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:56:51 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)) 21:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:56:51 INFO - Running setup.py (path:/tmp/pip-jTJO9U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:56:51 INFO - Running setup.py (path:/tmp/pip-u4JWhK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:56:51 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)) 21:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:56:51 INFO - Running setup.py (path:/tmp/pip-r2cfcs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:56:52 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)) 21:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:56:52 INFO - Running setup.py (path:/tmp/pip-5as2Fq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:56:52 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)) 21:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:56:52 INFO - Running setup.py (path:/tmp/pip-Cc8vOS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:56:52 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)) 21:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:56:52 INFO - Running setup.py (path:/tmp/pip-sUQcJC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:56:52 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)) 21:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:56:52 INFO - Running setup.py (path:/tmp/pip-Wy639K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:56:52 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)) 21:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:56:52 INFO - Running setup.py (path:/tmp/pip-tbWu1I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:56:52 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)) 21:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:56:52 INFO - Running setup.py (path:/tmp/pip-VTwNAu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:56:52 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)) 21:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:56:52 INFO - Running setup.py (path:/tmp/pip-VduOkx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:56:52 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)) 21:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:56:52 INFO - Running setup.py (path:/tmp/pip-jPaF02-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:56:52 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)) 21:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:56:52 INFO - Running setup.py (path:/tmp/pip-lNT0MX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:56:52 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)) 21:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:56:52 INFO - Running setup.py (path:/tmp/pip-I0vG6o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:56:52 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)) 21:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:56:52 INFO - Running setup.py (path:/tmp/pip-vajo6g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:56:52 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)) 21:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:56:52 INFO - Running setup.py (path:/tmp/pip-9ZXEtB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:56:52 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)) 21:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:56:52 INFO - Running setup.py (path:/tmp/pip-3h3In0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:56:53 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)) 21:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:56:53 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)) 21:56:53 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)) 21:56:53 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)) 21:56:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:56:53 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 21:56:53 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 21:56:53 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 21:56:53 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 21:56:53 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 21:56:53 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 21:56:54 INFO - Downloading blessings-1.6.tar.gz 21:56:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:56:54 INFO - Installing collected packages: blessings 21:56:54 INFO - Running setup.py install for blessings 21:56:55 INFO - Successfully installed blessings 21:56:55 INFO - Cleaning up... 21:56:55 INFO - Return code: 0 21:56:55 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:56:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:56:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:56:55 INFO - Reading from file tmpfile_stdout 21:56:55 INFO - Current package versions: 21:56:55 INFO - argparse == 1.2.1 21:56:55 INFO - blessings == 1.6 21:56:55 INFO - blobuploader == 1.2.4 21:56:55 INFO - docopt == 0.6.1 21:56:55 INFO - manifestparser == 1.1 21:56:55 INFO - mozInstall == 1.12 21:56:55 INFO - mozcrash == 0.17 21:56:55 INFO - mozdebug == 0.1 21:56:55 INFO - mozdevice == 0.48 21:56:55 INFO - mozfile == 1.2 21:56:55 INFO - mozhttpd == 0.7 21:56:55 INFO - mozinfo == 0.9 21:56:55 INFO - mozleak == 0.1 21:56:55 INFO - mozlog == 3.1 21:56:55 INFO - moznetwork == 0.27 21:56:55 INFO - mozprocess == 0.22 21:56:55 INFO - mozprofile == 0.28 21:56:55 INFO - mozrunner == 6.11 21:56:55 INFO - mozscreenshot == 0.1 21:56:55 INFO - mozsystemmonitor == 0.0 21:56:55 INFO - moztest == 0.7 21:56:55 INFO - mozversion == 1.4 21:56:55 INFO - psutil == 3.1.1 21:56:55 INFO - requests == 1.2.3 21:56:55 INFO - wsgiref == 0.1.2 21:56:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:56: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')]} 21:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56: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')]} 21:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:55 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 0x7f3b30988f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be08d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f8b0>, '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 0x2c707b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70c60>, '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': 'af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854', '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 21:56:55 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 21:56:55 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 21:56:55 INFO - Using env: {'DISPLAY': ':0', 21:56:55 INFO - 'HOME': '/home/cltbld', 21:56:55 INFO - 'LANG': 'en_US.UTF-8', 21:56:55 INFO - 'LANGUAGE': 'en_US:en', 21:56:55 INFO - 'LOGNAME': 'cltbld', 21:56:55 INFO - 'MAIL': '/var/mail/cltbld', 21:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:55 INFO - 'MOZ_NO_REMOTE': '1', 21:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:55 INFO - 'NO_EM_RESTART': '1', 21:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:55 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:55 INFO - 'SHELL': '/bin/bash', 21:56:55 INFO - 'SHLVL': '1', 21:56:55 INFO - 'TERM': 'linux', 21:56:55 INFO - 'TMOUT': '86400', 21:56:55 INFO - 'USER': 'cltbld', 21:56:55 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854', 21:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:55 INFO - '_': '/tools/buildbot/bin/python'} 21:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:55 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)) 21:56:55 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)) 21:56:55 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)) 21:56:55 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)) 21:56:55 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)) 21:56:55 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)) 21:56:55 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)) 21:56:55 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)) 21:56:55 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)) 21:56:55 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)) 21:56:55 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)) 21:56:55 INFO - Cleaning up... 21:56:55 INFO - Return code: 0 21:56:55 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:56: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')]} 21:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56: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')]} 21:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:55 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 0x7f3b30988f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be08d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f8b0>, '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 0x2c707b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70c60>, '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': 'af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854', '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 21:56:55 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 21:56:55 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 21:56:55 INFO - Using env: {'DISPLAY': ':0', 21:56:55 INFO - 'HOME': '/home/cltbld', 21:56:55 INFO - 'LANG': 'en_US.UTF-8', 21:56:55 INFO - 'LANGUAGE': 'en_US:en', 21:56:55 INFO - 'LOGNAME': 'cltbld', 21:56:55 INFO - 'MAIL': '/var/mail/cltbld', 21:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:55 INFO - 'MOZ_NO_REMOTE': '1', 21:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:55 INFO - 'NO_EM_RESTART': '1', 21:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:55 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:55 INFO - 'SHELL': '/bin/bash', 21:56:55 INFO - 'SHLVL': '1', 21:56:55 INFO - 'TERM': 'linux', 21:56:55 INFO - 'TMOUT': '86400', 21:56:55 INFO - 'USER': 'cltbld', 21:56:55 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854', 21:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:55 INFO - '_': '/tools/buildbot/bin/python'} 21:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:55 INFO - Downloading/unpacking jsonschema 21:56:55 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 21:56:55 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 21:56:55 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 21:56:55 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 21:56:55 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 21:56:55 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 21:56:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:56:57 INFO - Downloading/unpacking functools32 (from jsonschema) 21:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:57 INFO - Downloading functools32-3.2.3-2.tar.gz 21:56:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:56:57 INFO - warning: no files found matching '*.txt' 21:56:57 INFO - no previously-included directories found matching 'build' 21:56:57 INFO - no previously-included directories found matching 'dist' 21:56:57 INFO - no previously-included directories found matching '.git*' 21:56:57 INFO - Installing collected packages: jsonschema, functools32 21:56:58 INFO - Running setup.py install for functools32 21:56:58 INFO - warning: no files found matching '*.txt' 21:56:58 INFO - no previously-included directories found matching 'build' 21:56:58 INFO - no previously-included directories found matching 'dist' 21:56:58 INFO - no previously-included directories found matching '.git*' 21:56:58 INFO - Successfully installed jsonschema functools32 21:56:58 INFO - Cleaning up... 21:56:58 INFO - Return code: 0 21:56:58 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:56:58 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')]} 21:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:58 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')]} 21:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:58 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 0x7f3b30988f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be08d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f8b0>, '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 0x2c707b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70c60>, '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': 'af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854', '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 21:56:58 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 21:56:58 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 21:56:58 INFO - Using env: {'DISPLAY': ':0', 21:56:58 INFO - 'HOME': '/home/cltbld', 21:56:58 INFO - 'LANG': 'en_US.UTF-8', 21:56:58 INFO - 'LANGUAGE': 'en_US:en', 21:56:58 INFO - 'LOGNAME': 'cltbld', 21:56:58 INFO - 'MAIL': '/var/mail/cltbld', 21:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:58 INFO - 'MOZ_NO_REMOTE': '1', 21:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:58 INFO - 'NO_EM_RESTART': '1', 21:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:58 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:58 INFO - 'SHELL': '/bin/bash', 21:56:58 INFO - 'SHLVL': '1', 21:56:58 INFO - 'TERM': 'linux', 21:56:58 INFO - 'TMOUT': '86400', 21:56:58 INFO - 'USER': 'cltbld', 21:56:58 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854', 21:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:58 INFO - '_': '/tools/buildbot/bin/python'} 21:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:58 INFO - Downloading/unpacking flake8 21:56:58 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 21:56:58 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 21:56:58 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 21:56:58 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 21:56:58 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 21:56:58 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 21:57:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:57:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:57:00 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 21:57:00 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 21:57:00 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 21:57:00 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 21:57:00 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 21:57:00 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 21:57:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:57:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:57:00 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 21:57:00 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 21:57:00 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 21:57:00 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 21:57:00 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 21:57:00 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 21:57:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:57:00 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 21:57:00 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 21:57:00 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 21:57:00 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 21:57:00 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 21:57:00 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 21:57:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:57:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:57:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:57:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:57:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:57:01 INFO - no previously-included directories found matching 'docs/_build' 21:57:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:57:01 INFO - Running setup.py install for pep8 21:57:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:57:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:57:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:57:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:57:01 INFO - no previously-included directories found matching 'docs/_build' 21:57:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:57:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:57:01 INFO - Cleaning up... 21:57:01 INFO - Return code: 0 21:57:01 INFO - Running post-action listener: _resource_record_post_action 21:57:01 INFO - Running post-action listener: _start_resource_monitoring 21:57:01 INFO - Starting resource monitoring. 21:57:01 INFO - ##### 21:57:01 INFO - ##### Running install step. 21:57:01 INFO - ##### 21:57:01 INFO - Running pre-action listener: _resource_record_pre_action 21:57:01 INFO - Running main action method: install 21:57:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:57:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:57:01 INFO - Reading from file tmpfile_stdout 21:57:01 INFO - Detecting whether we're running mozinstall >=1.0... 21:57:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:57:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:57:01 INFO - Reading from file tmpfile_stdout 21:57:01 INFO - Output received: 21:57:01 INFO - Usage: mozinstall [options] installer 21:57:01 INFO - Options: 21:57:01 INFO - -h, --help show this help message and exit 21:57:01 INFO - -d DEST, --destination=DEST 21:57:01 INFO - Directory to install application into. [default: 21:57:01 INFO - "/builds/slave/test-pgo"] 21:57:01 INFO - --app=APP Application being installed. [default: firefox] 21:57:01 INFO - mkdir: /builds/slave/test-pgo/build/application 21:57:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 21:57:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 21:57:17 INFO - Reading from file tmpfile_stdout 21:57:17 INFO - Output received: 21:57:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:57:17 INFO - Running post-action listener: _resource_record_post_action 21:57:17 INFO - ##### 21:57:17 INFO - ##### Running run-tests step. 21:57:17 INFO - ##### 21:57:17 INFO - Running pre-action listener: _resource_record_pre_action 21:57:17 INFO - Running main action method: run_tests 21:57:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:57:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:57:18 INFO - Python 2.7.3 21:57:18 INFO - Return code: 0 21:57:18 INFO - grabbing minidump binary from tooltool 21:57: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')]} 21:57:18 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 0x2c6f8b0>, '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 0x2c707b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c70c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:57:18 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 21:57:18 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 21:57:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:57:18 INFO - Return code: 0 21:57:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:57:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:57:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:57:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:57:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:57:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:57:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:57:19 INFO - Return code: 0 21:57:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 21:57:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 21:57:19 INFO - Using env: {'DISPLAY': ':0', 21:57:19 INFO - 'HOME': '/home/cltbld', 21:57:19 INFO - 'LANG': 'en_US.UTF-8', 21:57:19 INFO - 'LANGUAGE': 'en_US:en', 21:57:19 INFO - 'LOGNAME': 'cltbld', 21:57:19 INFO - 'MAIL': '/var/mail/cltbld', 21:57:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:57:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:19 INFO - 'MOZ_NO_REMOTE': '1', 21:57:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:19 INFO - 'NO_EM_RESTART': '1', 21:57:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:19 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:57:19 INFO - 'SHELL': '/bin/bash', 21:57:19 INFO - 'SHLVL': '1', 21:57:19 INFO - 'TERM': 'linux', 21:57:19 INFO - 'TMOUT': '86400', 21:57:19 INFO - 'USER': 'cltbld', 21:57:19 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854', 21:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:19 INFO - '_': '/tools/buildbot/bin/python'} 21:57:19 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 21:57:19 INFO - mozversion application_buildid: 20160403193250 21:57:19 INFO - mozversion application_changeset: 600f96d25f8c94c73849dc98f0ad36769f9b57d3 21:57:19 INFO - mozversion application_display_name: Nightly 21:57:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:57:19 INFO - mozversion application_name: Firefox 21:57:19 INFO - mozversion application_remotingname: firefox 21:57:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:57:19 INFO - mozversion application_vendor: Mozilla 21:57:19 INFO - mozversion application_version: 48.0a1 21:57:19 INFO - mozversion platform_buildid: 20160403193250 21:57:19 INFO - mozversion platform_changeset: 600f96d25f8c94c73849dc98f0ad36769f9b57d3 21:57:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:57:19 INFO - mozversion platform_version: 48.0a1 21:57:19 INFO - using testdate: 1459745839 21:57:19 INFO - actual date: 1459745839 21:57:19 INFO - starting webserver on 'localhost:47283' 21:57:19 INFO - SUITE-START | Running 2 tests 21:57:19 INFO - TEST-START | dromaeo_css 21:57:19 INFO - operating with platform_type : linux_ 21:57:19 INFO - Initialising browser for dromaeo_css test... 21:57:19 INFO - TEST-INFO | started process 3342 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBVQQ6U/profile http://localhost:47283/getInfo.html) 21:57:23 INFO - PROCESS | 3342 | 21:57:23 INFO - PROCESS | 3342 | (process:3409): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:57:23 INFO - PROCESS | 3342 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 21:57:24 INFO - PROCESS | 3342 | __metrics Screen width/height:1600/1200 21:57:24 INFO - PROCESS | 3342 | colorDepth:24 21:57:24 INFO - PROCESS | 3342 | Browser inner width/height: 1024/697 21:57:24 INFO - PROCESS | 3342 | __metrics 21:57:25 ERROR - PROCESS | 3342 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 21:57:26 INFO - TEST-INFO | 3342: exit 0 21:57:26 INFO - Browser initialized. 21:57:26 INFO - Running cycle 1/1 for dromaeo_css test... 21:57:26 INFO - TEST-INFO | started process 3460 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBVQQ6U/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:57:27 INFO - PROCESS | 3460 | 21:57:27 INFO - PROCESS | 3460 | (process:3521): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:57:37 INFO - PROCESS | 3460 | RSS: Main: 163188736 21:57:37 INFO - PROCESS | 3460 | 21:58:27 INFO - PROCESS | 3460 | 1459745907489 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] 22:00:35 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:47283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47283/tests/dromaeo/cssquery-ext.html) 22:00:36 INFO - PROCESS | 3460 | RSS: Main: 168292352 22:00:36 INFO - PROCESS | 3460 | 22:03:38 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:47283/tests/dromaeo/cssquery-ext.html (next: http://localhost:47283/tests/dromaeo/cssquery-jquery.html) 22:03:38 INFO - PROCESS | 3460 | RSS: Main: 165068800 22:03:38 INFO - PROCESS | 3460 | 22:06:40 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:47283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47283/tests/dromaeo/cssquery-mootools.html) 22:06:41 INFO - PROCESS | 3460 | RSS: Main: 166559744 22:06:41 INFO - PROCESS | 3460 | 22:09:42 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:47283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47283/tests/dromaeo/cssquery-prototype.html) 22:09:43 INFO - PROCESS | 3460 | RSS: Main: 163835904 22:09:43 INFO - PROCESS | 3460 | 22:12:45 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:47283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47283/tests/dromaeo/cssquery-yui.html) 22:12:46 INFO - PROCESS | 3460 | RSS: Main: 164601856 22:12:46 INFO - PROCESS | 3460 | 22:15:48 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:47283/tests/dromaeo/cssquery-yui.html (next: http://localhost:47283/tests/dromaeo/cssquery-dojo.html) 22:15:48 INFO - PROCESS | 3460 | RSS: Main: 166924288 22:15:48 INFO - PROCESS | 3460 | 22:15:48 INFO - PROCESS | 3460 | __start_tp_report 22:15:48 INFO - PROCESS | 3460 | _x_x_mozilla_page_load 22:15:48 INFO - PROCESS | 3460 | _x_x_mozilla_page_load_details 22:15:48 INFO - PROCESS | 3460 | |i|pagename|runs| 22:15:48 INFO - PROCESS | 3460 | |0;dojo.html;3125.781195316328;3155.2585142491516;3191.202199450139;3225.32268223673;3227.2254658881875;5265.8946821063555;5311.176767601023;5317.9468205317935;5357.678539287641;5359.678419294835;5235.58115350772;5421.728913554326;5458.727063646822;5475.67145971242;5543.861403464915;4651.418572678415;4844.757762111898;4915.16442204826;5022.246663000561;5035.269885866547;4946.901061978776;4960.429550601672;4982.128127577677;4994.775235114428;5024.5226703463295;4770.0459908018365;4836.903261934742;4840.4675485696725;4855.660103792736;4898.90202195954;4815.951840481585;4856.854294371175;4877.170880950247;4878.390201224847;4916.410030796327;4764.380630518011;4816.44610869751;4825.2520859266515;4827.637927155442;4854.2718592211095;5307.495787900143;5319.308489896327;5374;5384.5692344612335;5387.299651045339;5801.0428279333855;5804.970975145139;5818.8254352369495;5846.736896839652;5846.947549441099;5658.43415658435;5786.971065144689;5858;5865.648061116304;5900.203472531196;5516.889662206733;5526.06056970316;5529.861753456155;5541.3904470507805;5581.665100094007;5997.580169388189;6007.27912650476;6010.669413182317;6019.548533859978;6029.276486821522;5435.456454354533;5539;5623.803166889221;5759.049756790083;5765.769369225184;5628.60599758013;5721;5781;5797.913031304533;5847.502962248172;5726.79956201531;5756.740946657411;5770.2498675171955;5773.769049238067;5790.507806836466;5534.142207957692;5732;5794.362620111784;5812.041013232853;5829.183914252008;4404.11917616478;4416.712913660666;4417.977910110429;4435.157320109169;4446.310821822558;3929.980350098231;3931.744436611611;3933.213357328546;3957.5250969883223;3959.3467077932396;5381.7578208980685;5566.34821388445;5580.9441905580425;5612.186232996192;5619.325680918234;5822.475977162076;5836.358000619928;5840.912386314209;5861.267341582302;5865;5498.367687715884;5546.889062218733;5558.082916318762;5594.524465420403;5608.214849921014;4757.5718185363485;4788.592969597554;4847.3698419205275;4931.284963680247;4937.11131996237;6004.6697431640805;6009.429104235091;6031.547633927473;6038.849028774228;6046.3651316612;5870.53035757147;5872.706364681834;5892.234009578728;5895.469407753323;5900.262467191601;5863.061910094364;5925.081612350093;5933.792317268875;5972.223610930725;6012.6392416455155;5685.744141513725;5694.515966142924;5714.085746280575;5733.9713301434895;5762.049261871744;5664.773409063756;5722.799702010409;5853.912191317048;5853.94146058534;5884.941150588611;5467.4532546745;5732.05421105513;5788.768449261982;5791.710414479344;5831.562632802642;5585.832425027255;5665.348484924121;5723.971380143073;5755.165501002248;5772.307323121252;5563.610547261653;5603.747831347518;5607.243022192115;5623.550115990629;5633.521150702236;5483.75323110469;5636.408177141341;5764.42355764437;5773.826785196451;5789.8263052108505;5632.352279487911;5632.802851900164;5651.15232715096;5654.6889921054735;5659.066254068032 22:15:48 INFO - PROCESS | 3460 | |1;ext.html;548.0826573016159;576.7635269539488;577.6505214345322;594.4293478260869;596.8746563221723;36892;38148.61851381485;38172.80913595432;38191.23617527648;38381.232375352476;38794.4180837287;39157;39189.60810391895;39196.80401597988;39310.21379572414;8428.999999999985;8675.305975521944;8743.95628021859;8745.912540874573;8751.95624021879;8460.703875364363;8531.829363412728;8535.871961920577;8571.271441927413;8619;8625.95687021564;8674.262687671524;8678.698195270697;8736;8761.474311541328;8618.827623447496;8624.870626940601;8682.044975052771;8684.652613895436;8693.7826554336;8538.82922341556;8666.826663466758;8669.046404895456;8672.60973256205;8673.479591224484;32961.67038329634;37832;38217.23565528702;38217.61782382168;38558.22883542341;3391.321735652855;3487.930241395183;3572.5534308211472;3661.7253705971893;4076.347784354519;30138.54792178119;30573.38853222945;30651.846740766152;30848.228794280098;30856.228594285323;3996.800159991989;4180.602842729966;4187.392828039948;4219.472565929259;4237.576242375738;102273;102395;103247.48376258071;103291;104240;67753.3224667747;68046;68236;68378.3162168382;68429;71734.2826571738;72285.63857180785;72731.63634181795;72843;72880.63559682274;15220.619484512754;15362.155081470402;15458;15484.07095574269;15499.690006199813;11355.772884542263;11402.657920262405;11440.542378304775;11448.141389395829;11481.942590286995;22663.433414164778;23048.539029219322;23106.7689323108;23127.7687223129;23148.18981335645;7865.842683146305;8136.308413784895;8160.306373958161;8460.57697115154;8621.61202745878;1068.3216157739892;1096.780643871229;1120.8318752187074;1137.175547727907;1215.9209651372632;29779.702202977693;30060.54909176364;31123.377532449224;31524.36951260962;31789.8410507946;1107.8061339265757;1152.8847115288572;1195.491915935724;1252.47720967103;1258.3205069262497;15570;16236.675266494603;16264.512064637844;16503.17484125789;16640.6671866562;401581;402780;406735;408849;409315;54629.726851365485;56324.71837640786;56343.43656563464;56385;56414.15378769322;1385.8497447119069;1408.4577437686564;1413.3074793351184;1424.2380326525258;1426.265473281261;30400.239994000327;30439.847800760854;30927;31699.366012679155;31699.52450713195;49239.50760492349;49441;49633.25550116679;49724;49899.50100499094;360711;365657;366357;366531;367117.3153073847;33116.668833311356;33586.32827343488;33769.83115084507;33816.661833382335;37201.25597488089;47992.520074798806;48253.5174648249;49337.25994110163;50110.24834627411;50997.49002510076;39211.41182882202;39431.408528872664;40059.39316978585;40218.1956360877;40221.1955760889;38342.80828595839;39261;39653.00867478336;39687.206255875295;40368.596314037655;35329;40388.990275243355;42125;42344;42944.35583466188;34188.48717269293;34754.478682819274;34900.50295211029;35068.82465587656;35266.82366588253;27919.581206282328;27985.580216297178;27991;28284.15147545577;28513.714862851106 22:15:48 INFO - PROCESS | 3460 | |2;jquery.html;381.3593163485344;383.80617788017037;384.1356946869544;386.3200766650694;387.58334790100633;17599.47201583953;18418.171182296814;19041.839922010222;19118.61762764744;19172.80827191726;13234.404451799668;17459.3016279349;18152.36466723665;18303.35938242162;18306.725399119023;5009.7996080156845;5208.374995000605;5223.164293713006;5246.947530524684;5262.473752624726;5294;5491.478309560585;5495.890082198353;5501.614886957915;5511.696856672901;5342.786288548454;5476.534494567946;5486.149646804732;5695.03184458643;5722.97138514309;5669.348024977118;5680.3467601225975;5687.7156142192725;5704.429557044283;5713.5714821388565;5383.246345511631;5451.890962180734;5507.421720719347;5509.559235261169;5512.5589952803675;20950.476238094016;20989.790102098937;21361.35915922525;22374;22555;2117.608242475147;2132.9786702132933;2186.9890650546804;2296.0815673730476;2822.4214036122544;9844.458554779485;9893.950530247375;10946.343219406861;13953.860461395358;13998.580042598738;1921.5100149461798;1926.402815127315;1943.1741509858396;1990.920363185471;2012.7987201279755;70174;72883.63558182228;74822;77240;77780.22219777844;10378.221633377376;10561.735956601147;10677.572897084185;10992.28550144238;11012.229143960007;14660.560183194308;14859.479918202811;14908.70182596342;14950.70098598022;14968.625784355478;7335.77992660221;7706.614669266514;7775.3390961767755;7805.492642978188;7860.6855725771475;7394.519356241827;7479;7482.289182527651;7505.962470187614;7641.426892983049;4571.177188106173;4586.701864378805;4660;4670;4774.618030557616;1856.0997916010724;1926.4798504403732;1931.4012656076661;1956.5402130499322;1973.8716983396034;979.2068424576116;982.1749730226644;1018.7300365403174;1040.006793512194;1042.1454407386022;17448;18671.81328186728;18829.811701883078;18900.243990240237;19010.619787604446;999.5252255178877;1006.0894890124449;1021.5964693945998;1034.255336157965;1097.0346095435966;10710.785784284271;10960.506777195045;10987.670369888916;10994.120470362512;10995.34027958325;451959;457643;461749;466003;470752;72784.63607682033;82616.58691706623;83749.58125209456;86636.56681716678;87369.56315218384;1024.7284469615558;1042.0361165921493;1072.6270373921393;1073.1843798712878;1078.8975047370486;16915.323387064378;16989.150542473075;17111.401100961408;17115.400960966308;17191.914040429718;37694.246115078095;37940.24119517539;37955.24089518139;38420.42369364406;38797.2240555193;54506;54634.726826365615;54726.17910731262;54831.725841370535;54986.72506637601;8429.367797415096;8484.957575212084;8523.914760852313;8525.573721313785;8537.658493660185;12351.75296494083;12960.481580737041;13043.739125217633;13072.411741471466;13178.341082945622;11209.821673252036;11229.157813164209;11706.414679265832;11712.180147389601;12153.331566763913;11386;11888;11916.761664766484;11941.223820451643;12030.578929737418;11804.40977951082;11873.703157421134;12258.14193006481;12397.318147501974;12412.317322547347;8432.915670843213;8605.698800541952;8623.439476434012;8736.737897863075;8764.649414023368;11208.103351732005;11647.242929209913;11784.175107742376;11796.29222246668;11918.165728398928 22:15:48 INFO - PROCESS | 3460 | |3;mootools.html;1470.558832350295;1471.2570152073204;1645.7613646021327;1649.70305345038;1793.2826869252306;7301.598412087333;7964.96017519913;8089.150639182889;8286.709965151213;8311.91688083119;7687.846243075135;7692.9230707692905;7705.49914255573;7757.456978011542;7763.417743669219;2249.167807911075;2276.226083131735;2278.5670722562745;2278.715160604924;2283.9657405138937;2182.4980254541465;2221.0671517962496;2236.9776302237015;2251.470904337479;2256.9887150564223;2211.4803021290063;2225.2879078694823;2228.320362289501;2250.4823890505195;2252.1779550464125;2244.371575958734;2249.4488850231633;2251.7072780538506;2255.751867294596;2260.6495993121093;2246.8876556172127;2247.763984781607;2255.064148378421;2261.479859632294;2267.240474441064;8130.674773009132;8134.552599607019;8149;8170.795730106735;8171.877421838677;5085.415177254589;5154.484551544853;5163.974180129076;5166.173412254021;5168.7415629218385;3232.143481977278;3245.2860370718404;3435.4846772984;3447.1037530242315;3449.7757645752945;1105.7401510644993;1113.5434471866577;1136.0570726297235;1144.5879483386057;1176.5117476247347;11866.762664746742;11873.881261187364;11925.344106074162;11970.401479926057;12000.69998250042;4361.5856493633055;4431.667624928144;4505.684602077823;4512.255477846119;4527.456705195397;9944.900550994398;10037.598496060222;10044.146247569039;10067.697969060793;10080.949595251977;5085;5105.412877519058;5112.258722485293;5144.742762861842;5151.330327057459;4151.813168407429;4553.612942899825;4564.109998550251;4624.560666736655;4702.788374523155;3750.137468382233;3786.5645450772963;3813.733038687321;3821.636944490269;3871.399933010388;1222.3155033181447;1228.4533382644638;1233.734747029393;1241.391718058145;1242.5837344489516;1371.9245441500614;1394.6652803327331;1401.2713389037847;1406.985930140706;1431.9427222911174;7628.122765881883;7992.5204487730925;8001.5599142046585;8003.279704826594;8007.159248278964;486.60098719050745;491.6533843640225;498.8378776897523;498.88026873550086;509.7272958966935;5871.236739223874;5965.254343207099;5972.462478376967;5978.372270911578;5980.730867110903;9850.852237216448;10470.057694807503;10518.526666300035;10653.414062226497;10701;10087.142592879687;10391.116755075904;10410.791784164274;10415.843762343571;10501.422421766723;7903.288704016666;7957.602119894098;7958.403119765925;8020.5588692621295;8044.839103217902;7606.467547271859;7659.88510172359;7681.692732290646;7706.499077559941;7838.960805195938;8800.779980500538;8964;9048.819023619622;9159.816803663756;9185.357025008452;9223;9462.101100395452;9564.378315409476;9603;9708.466034368177;6496.1230233919705;6913.585184888922;7134.821629459305;7302.96348518254;7388.963055184689;7906.407019473678;7917;7917.524948503108;7959.9602001989615;7962.044554653247;6677.632730199885;6876.140482439695;6923.9307606923285;7137.607431591312;7156.033935418652;6907.309269073053;7012.1935977363255;7057.188423331178;7059.011738356531;7070.36366726997;7060.823479413056;7113.359797618239;7135.143782746104;7160.677769500489;7169.605671687898;6885.036094946611;6966.059581956371;6994.090768200102;6996.05553250325;7004.929950700428;6774.729010839708;6793.218779840184;6858.5199036067;6859.279775623488;7103.112110986127 22:15:48 INFO - PROCESS | 3460 | |4;prototype.html;339.4890689512284;341.19988626670454;349.1707195410899;351.7309258417311;353.44156233151625;6357.459615932651;6380.106785050091;6404.96797516013;6421.13314702515;6425.8714825703455;6372.713227904744;6374.235091788992;6383.744650213997;6384.393482619155;6384.776532821352;4510.706804057726;4633.884152896171;4785.808567657289;4791.544803243686;4795.2807078938085;4768.451628062782;4775.164346239411;4775.952240477603;4791.928121078186;4795.784189711454;4740.857774266778;4743.383360163174;4743.62051035918;4752;4753.762311884392;4756.90486190276;4766.523347665223;4772.3795906532105;4773.665843390964;4792.305115758196;4184.958150418487;4185.58144185582;4186.35111557709;4194.3498757692605;4200.201961627281;5881.85295367615;6127.356627554132;6155.661438620874;6170.382961703794;6174.5060395168275;5495.340559132889;5520.392756796749;5532.28080349556;5544.251526044013;5546.112621980464;6724.865502689919;6730;6730.596164230162;6755.324467553254;6767.796966091025;4614.838480653195;4615.307703844416;4617.12274667812;4617.168909596271;4628.953710462886;6984.580925144508;7018.789436316919;7045.436365090832;7053.2594077621625;7054.118235220598;4527.456705195332;4665.206914824488;4674.579287864109;4691.483936767021;4710.481846996828;4676.953230467651;4680.180968330528;4710.105080034782;4720.480747117815;4722.6221902247735;5490.450954904478;5511.862203444946;5544.473275038865;5545.889082218333;5576.609637325349;6707.765228216989;6770.458363330922;6789.083473730983;6791.864162716718;6805.843006688776;1651.6696660667915;1669.766232727419;1677.1195122560753;1683.8484536391538;1683.890547114458;1067.114295135036;1088.4176965323672;1092.257265059751;1095.9287646302964;1107.5735841700841;6444.871102577922;6492.707828147744;6492.837679058061;6508.056331831858;6514.120593719882;6772;6971.8605627887155;6974.476914231453;6979.546329488567;7010.719571217094;6448.387403196689;6549.508786841006;6557.639329836905;6598.571092878948;6604.174478190226;3762.3227818992295;3787.7348585598743;3803.790791506494;3803.961960380361;3815.923681526354;7189.6405179740805;7212.134543854771;7248.637568121573;7260.9636951815955;7274.854502909912;6968.268331825187;7093.1488221413765;7121.003059571664;7176.138863336433;7192.957021231892;7223.9638801806705;7231.783046508614;7237.927620723831;7242.058532390755;7252.166000909963;7000.684969176501;7002.544834585736;7005.54463959841;7014.088168538057;7017.649117544204;6925.238223795479;6932.0988271524375;6934.341237582624;6959.791206263821;6964.512484126265;6968.268331825288;7203.315685009916;7204.675789589376;7248.637568121679;7262.782116536512;4804.375431193923;4818.566329030404;4837.37114175155;4840.636952228668;4873.926891096708;6947.513674042971;6970.093887794555;6970.23327433992;6982.755603553851;7004.929950700632;6827;6839.418649414855;6844.589324640538;6847.417969472651;6848.246692863681;6668.099806526056;6773.051772751917;6783.728650853911;6784.966075169593;6796.796096117125;6537.084808126771;6547.672616369067;6551.082848401133;6551.44312733423;6587.670616469253;6756.4257038150345;6800.115984921928;6804.5163515317545;6815.42068924147;6855.280195579392;6580.539362244597;6595.472362211108;6602.240742314695;6604.273529911802;6612.933870661424 22:15:48 INFO - PROCESS | 3460 | |5;yui.html;732.6117157906305;776.9611519424029;800.4876878797567;848.3976376772489;858.0689951402728;12563.937180314097;12570.560030398938;12603.621891343251;12654.683632909182;12744.617661470147;14398.208098554602;14644.633884152901;14683.412663493475;14689.338979745911;14689.77965330521;696.7631005458143;814.8411059843332;820.3273315880965;825.4593241426875;829.5022986208287;817.9182081791803;818.9262966333029;821.6056292979373;825.9297959673435;827.4497459189631;862.482510493705;863.9568021598894;864.6238886084542;865.2818160926447;868.2229404682805;855.6064210463163;856.5503110866814;857.022993787077;858.0561382479285;859.7119964811795;622.0420552349376;625.6402568523072;625.6433832715354;626.8464226264595;627.3350248736355;13601.455941762317;14040.36818343177;14057.64855878601;14067.296635168303;14092.154470731788;12823.807642885364;12927.288999105045;13024.153430027018;13086.345682715826;13338.199708017453;10928.836067458995;11350.20548561601;11448.942755286254;11545.826812597817;11623.709407264885;3670.522832031819;3685.907852303687;3755.586885442599;3819.1597848473293;3823.636754508345;53626.92746145094;53753;53761.1935820963;53808.19287710688;53810.730946345015;10091.545880435398;10163.441010744333;10261.897381026094;10333.483325833678;10680.092192163598;18475.722864157047;18592.349267775564;18629.789063710814;18715.906420468084;18720.8767473952;7863.803404914923;7871.606419679108;7962.960185199037;7991.600419978978;8108.472949258397;4376.7811609419405;4463.665225108065;4480.081583275421;4587.72473651582;4613.377194078824;3244.318693074481;3293.1108600677685;3307.536944827726;3320.236345640516;3330.6169790473923;559.5467671186352;621.1521273461692;626.764963138823;630.1681780050382;631.9304876463585;709.9361057504849;786.3373878854896;789.4276649429232;792.5205250823284;810.2100452059195;9100.954495227614;9294.302927280482;9300.488473134043;9368.90631093694;9446.197073248852;617.5399327500951;744.891955765194;755.5167440171809;781.386611509962;784.3215618489965;4324.675649326313;4390;4409.977950110293;4459.219636563588;4616.469106052779;59796.10305845416;60581.39418605846;60591;61027;61048.38951610427;53367;53783;53808.73095634497;55386;55420;46138.769306153925;47687.28469072967;47742.28386574204;47799.52200477951;48318.27522587164;9086.182243598108;9133.132352426508;9140.63437462494;9260.675876344296;9380.81238375215;36935;37431.251374971805;37695.246095078495;38337.2332553353;38574.80712596419;43314.350284745124;45651;47320.763396182796;48014.519854801;48311;11971;12074.154809163274;12100.636980890587;12160.75678486443;12239.510419583474;13165.831153008787;13365.39855706515;13485.190888546718;13816;13841.515546955809;11789.528418863149;11894;12092.516299347928;12099.213551119148;12366.134370593973;11827.881721182677;11862.22895511789;12115.333656648969;12236.388180591113;12241.449134789134;11827.586034489095;12389.566365177176;12602.936985315015;12660.30368329714;12833.294168820805;9486.95256523713;9804.313698041069;10061.195104391778;10080.243981701255;10130.493475326057;10263.332883362558;10286.331388459726;10367.792644147226;10590;10674.946625266824 22:15:48 INFO - PROCESS | 3460 | __end_tp_report 22:15:48 INFO - PROCESS | 3460 | __start_cc_report 22:15:48 INFO - PROCESS | 3460 | _x_x_mozilla_cycle_collect,332 22:15:48 INFO - PROCESS | 3460 | __end_cc_report 22:15:48 INFO - PROCESS | 3460 | __startTimestamp1459746948714__endTimestamp 22:15:48 INFO - PROCESS | 3460 | 22:15:48 INFO - PROCESS | 3460 | ------- Summary: start ------- 22:15:48 INFO - PROCESS | 3460 | Number of tests: 6 22:15:48 INFO - PROCESS | 3460 | 22:15:48 INFO - PROCESS | 3460 | [#0] dojo.html Cycles:165 Average:5384.09 Median:5612.19 stddev:624.00 (11.1%) stddev-sans-first:600.24 22:15:48 INFO - PROCESS | 3460 | Values: 3125.8 3155.3 3191.2 3225.3 3227.2 5265.9 5311.2 5317.9 5357.7 5359.7 5235.6 5421.7 5458.7 5475.7 5543.9 4651.4 4844.8 4915.2 5022.2 5035.3 4946.9 4960.4 4982.1 4994.8 5024.5 4770.0 4836.9 4840.5 4855.7 4898.9 4816.0 4856.9 4877.2 4878.4 4916.4 4764.4 4816.4 4825.3 4827.6 4854.3 5307.5 5319.3 5374.0 5384.6 5387.3 5801.0 5805.0 5818.8 5846.7 5846.9 5658.4 5787.0 5858.0 5865.6 5900.2 5516.9 5526.1 5529.9 5541.4 5581.7 5997.6 6007.3 6010.7 6019.5 6029.3 5435.5 5539.0 5623.8 5759.0 5765.8 5628.6 5721.0 5781.0 5797.9 5847.5 5726.8 5756.7 5770.2 5773.8 5790.5 5534.1 5732.0 5794.4 5812.0 5829.2 4404.1 4416.7 4418.0 4435.2 4446.3 3930.0 3931.7 3933.2 3957.5 3959.3 5381.8 5566.3 5580.9 5612.2 5619.3 5822.5 5836.4 5840.9 5861.3 5865.0 5498.4 5546.9 5558.1 5594.5 5608.2 4757.6 4788.6 4847.4 4931.3 4937.1 6004.7 6009.4 6031.5 6038.8 6046.4 5870.5 5872.7 5892.2 5895.5 5900.3 5863.1 5925.1 5933.8 5972.2 6012.6 5685.7 5694.5 5714.1 5734.0 5762.0 5664.8 5722.8 5853.9 5853.9 5884.9 5467.5 5732.1 5788.8 5791.7 5831.6 5585.8 5665.3 5724.0 5755.2 5772.3 5563.6 5603.7 5607.2 5623.6 5633.5 5483.8 5636.4 5764.4 5773.8 5789.8 5632.4 5632.8 5651.2 5654.7 5659.1 22:15:48 INFO - PROCESS | 3460 | 22:15:48 INFO - PROCESS | 3460 | [#1] ext.html Cycles:180 Average:47873.05 Median:38676.32 stddev:85392.76 (220.8%) stddev-sans-first:85558.39 22:15:48 INFO - PROCESS | 3460 | Values: 548.1 576.8 577.7 594.4 596.9 36892.0 38148.6 38172.8 38191.2 38381.2 38794.4 39157.0 39189.6 39196.8 39310.2 8429.0 8675.3 8744.0 8745.9 8752.0 8460.7 8531.8 8535.9 8571.3 8619.0 8626.0 8674.3 8678.7 8736.0 8761.5 8618.8 8624.9 8682.0 8684.7 8693.8 8538.8 8666.8 8669.0 8672.6 8673.5 32961.7 37832.0 38217.2 38217.6 38558.2 3391.3 3487.9 3572.6 3661.7 4076.3 30138.5 30573.4 30651.8 30848.2 30856.2 3996.8 4180.6 4187.4 4219.5 4237.6 102273.0 102395.0 103247.5 103291.0 104240.0 67753.3 68046.0 68236.0 68378.3 68429.0 71734.3 72285.6 72731.6 72843.0 72880.6 15220.6 15362.2 15458.0 15484.1 15499.7 11355.8 11402.7 11440.5 11448.1 11481.9 22663.4 23048.5 23106.8 23127.8 23148.2 7865.8 8136.3 8160.3 8460.6 8621.6 1068.3 1096.8 1120.8 1137.2 1215.9 29779.7 30060.5 31123.4 31524.4 31789.8 1107.8 1152.9 1195.5 1252.5 1258.3 15570.0 16236.7 16264.5 16503.2 16640.7 401581.0 402780.0 406735.0 408849.0 409315.0 54629.7 56324.7 56343.4 56385.0 56414.2 1385.8 1408.5 1413.3 1424.2 1426.3 30400.2 30439.8 30927.0 31699.4 31699.5 49239.5 49441.0 49633.3 49724.0 49899.5 360711.0 365657.0 366357.0 366531.0 367117.3 33116.7 33586.3 33769.8 33816.7 37201.3 47992.5 48253.5 49337.3 50110.2 50997.5 39211.4 39431.4 40059.4 40218.2 40221.2 38342.8 39261.0 39653.0 39687.2 40368.6 35329.0 40389.0 42125.0 42344.0 42944.4 34188.5 34754.5 34900.5 35068.8 35266.8 27919.6 27985.6 27991.0 28284.2 28513.7 22:15:48 INFO - PROCESS | 3460 | 22:15:48 INFO - PROCESS | 3460 | [#2] jquery.html Cycles:180 Average:27423.04 Median:12280.49 stddev:75941.89 (618.4%) stddev-sans-first:76127.78 22:15:48 INFO - PROCESS | 3460 | Values: 381.4 383.8 384.1 386.3 387.6 17599.5 18418.2 19041.8 19118.6 19172.8 13234.4 17459.3 18152.4 18303.4 18306.7 5009.8 5208.4 5223.2 5246.9 5262.5 5294.0 5491.5 5495.9 5501.6 5511.7 5342.8 5476.5 5486.1 5695.0 5723.0 5669.3 5680.3 5687.7 5704.4 5713.6 5383.2 5451.9 5507.4 5509.6 5512.6 20950.5 20989.8 21361.4 22374.0 22555.0 2117.6 2133.0 2187.0 2296.1 2822.4 9844.5 9894.0 10946.3 13953.9 13998.6 1921.5 1926.4 1943.2 1990.9 2012.8 70174.0 72883.6 74822.0 77240.0 77780.2 10378.2 10561.7 10677.6 10992.3 11012.2 14660.6 14859.5 14908.7 14950.7 14968.6 7335.8 7706.6 7775.3 7805.5 7860.7 7394.5 7479.0 7482.3 7506.0 7641.4 4571.2 4586.7 4660.0 4670.0 4774.6 1856.1 1926.5 1931.4 1956.5 1973.9 979.2 982.2 1018.7 1040.0 1042.1 17448.0 18671.8 18829.8 18900.2 19010.6 999.5 1006.1 1021.6 1034.3 1097.0 10710.8 10960.5 10987.7 10994.1 10995.3 451959.0 457643.0 461749.0 466003.0 470752.0 72784.6 82616.6 83749.6 86636.6 87369.6 1024.7 1042.0 1072.6 1073.2 1078.9 16915.3 16989.2 17111.4 17115.4 17191.9 37694.2 37940.2 37955.2 38420.4 38797.2 54506.0 54634.7 54726.2 54831.7 54986.7 8429.4 8485.0 8523.9 8525.6 8537.7 12351.8 12960.5 13043.7 13072.4 13178.3 11209.8 11229.2 11706.4 11712.2 12153.3 11386.0 11888.0 11916.8 11941.2 12030.6 11804.4 11873.7 12258.1 12397.3 12412.3 8432.9 8605.7 8623.4 8736.7 8764.6 11208.1 11647.2 11784.2 11796.3 11918.2 22:15:48 INFO - PROCESS | 3460 | 22:15:48 INFO - PROCESS | 3460 | [#3] mootools.html Cycles:180 Average:5783.33 Median:5108.84 stddev:3116.19 (61.0%) stddev-sans-first:3108.08 22:15:48 INFO - PROCESS | 3460 | Values: 1470.6 1471.3 1645.8 1649.7 1793.3 7301.6 7965.0 8089.2 8286.7 8311.9 7687.8 7692.9 7705.5 7757.5 7763.4 2249.2 2276.2 2278.6 2278.7 2284.0 2182.5 2221.1 2237.0 2251.5 2257.0 2211.5 2225.3 2228.3 2250.5 2252.2 2244.4 2249.4 2251.7 2255.8 2260.6 2246.9 2247.8 2255.1 2261.5 2267.2 8130.7 8134.6 8149.0 8170.8 8171.9 5085.4 5154.5 5164.0 5166.2 5168.7 3232.1 3245.3 3435.5 3447.1 3449.8 1105.7 1113.5 1136.1 1144.6 1176.5 11866.8 11873.9 11925.3 11970.4 12000.7 4361.6 4431.7 4505.7 4512.3 4527.5 9944.9 10037.6 10044.1 10067.7 10080.9 5085.0 5105.4 5112.3 5144.7 5151.3 4151.8 4553.6 4564.1 4624.6 4702.8 3750.1 3786.6 3813.7 3821.6 3871.4 1222.3 1228.5 1233.7 1241.4 1242.6 1371.9 1394.7 1401.3 1407.0 1431.9 7628.1 7992.5 8001.6 8003.3 8007.2 486.6 491.7 498.8 498.9 509.7 5871.2 5965.3 5972.5 5978.4 5980.7 9850.9 10470.1 10518.5 10653.4 10701.0 10087.1 10391.1 10410.8 10415.8 10501.4 7903.3 7957.6 7958.4 8020.6 8044.8 7606.5 7659.9 7681.7 7706.5 7839.0 8800.8 8964.0 9048.8 9159.8 9185.4 9223.0 9462.1 9564.4 9603.0 9708.5 6496.1 6913.6 7134.8 7303.0 7389.0 7906.4 7917.0 7917.5 7960.0 7962.0 6677.6 6876.1 6923.9 7137.6 7156.0 6907.3 7012.2 7057.2 7059.0 7070.4 7060.8 7113.4 7135.1 7160.7 7169.6 6885.0 6966.1 6994.1 6996.1 7004.9 6774.7 6793.2 6858.5 6859.3 7103.1 22:15:48 INFO - PROCESS | 3460 | 22:15:48 INFO - PROCESS | 3460 | [#4] prototype.html Cycles:180 Average:5628.68 Median:6446.63 stddev:1725.37 (26.8%) stddev-sans-first:1683.91 22:15:48 INFO - PROCESS | 3460 | Values: 339.5 341.2 349.2 351.7 353.4 6357.5 6380.1 6405.0 6421.1 6425.9 6372.7 6374.2 6383.7 6384.4 6384.8 4510.7 4633.9 4785.8 4791.5 4795.3 4768.5 4775.2 4776.0 4791.9 4795.8 4740.9 4743.4 4743.6 4752.0 4753.8 4756.9 4766.5 4772.4 4773.7 4792.3 4185.0 4185.6 4186.4 4194.3 4200.2 5881.9 6127.4 6155.7 6170.4 6174.5 5495.3 5520.4 5532.3 5544.3 5546.1 6724.9 6730.0 6730.6 6755.3 6767.8 4614.8 4615.3 4617.1 4617.2 4629.0 6984.6 7018.8 7045.4 7053.3 7054.1 4527.5 4665.2 4674.6 4691.5 4710.5 4677.0 4680.2 4710.1 4720.5 4722.6 5490.5 5511.9 5544.5 5545.9 5576.6 6707.8 6770.5 6789.1 6791.9 6805.8 1651.7 1669.8 1677.1 1683.8 1683.9 1067.1 1088.4 1092.3 1095.9 1107.6 6444.9 6492.7 6492.8 6508.1 6514.1 6772.0 6971.9 6974.5 6979.5 7010.7 6448.4 6549.5 6557.6 6598.6 6604.2 3762.3 3787.7 3803.8 3804.0 3815.9 7189.6 7212.1 7248.6 7261.0 7274.9 6968.3 7093.1 7121.0 7176.1 7193.0 7224.0 7231.8 7237.9 7242.1 7252.2 7000.7 7002.5 7005.5 7014.1 7017.6 6925.2 6932.1 6934.3 6959.8 6964.5 6968.3 7203.3 7204.7 7248.6 7262.8 4804.4 4818.6 4837.4 4840.6 4873.9 6947.5 6970.1 6970.2 6982.8 7004.9 6827.0 6839.4 6844.6 6847.4 6848.2 6668.1 6773.1 6783.7 6785.0 6796.8 6537.1 6547.7 6551.1 6551.4 6587.7 6756.4 6800.1 6804.5 6815.4 6855.3 6580.5 6595.5 6602.2 6604.3 6612.9 22:15:48 INFO - PROCESS | 3460 | 22:15:48 INFO - PROCESS | 3460 | [#5] yui.html Cycles:180 Average:14640.49 Median:25065.54 stddev:16935.52 (67.6%) stddev-sans-first:16950.83 22:15:48 INFO - PROCESS | 3460 | Values: 732.6 777.0 800.5 848.4 858.1 12563.9 12570.6 12603.6 12654.7 12744.6 14398.2 14644.6 14683.4 14689.3 14689.8 696.8 814.8 820.3 825.5 829.5 817.9 818.9 821.6 825.9 827.4 862.5 864.0 864.6 865.3 868.2 855.6 856.6 857.0 858.1 859.7 622.0 625.6 625.6 626.8 627.3 13601.5 14040.4 14057.6 14067.3 14092.2 12823.8 12927.3 13024.2 13086.3 13338.2 10928.8 11350.2 11448.9 11545.8 11623.7 3670.5 3685.9 3755.6 3819.2 3823.6 53626.9 53753.0 53761.2 53808.2 53810.7 10091.5 10163.4 10261.9 10333.5 10680.1 18475.7 18592.3 18629.8 18715.9 18720.9 7863.8 7871.6 7963.0 7991.6 8108.5 4376.8 4463.7 4480.1 4587.7 4613.4 3244.3 3293.1 3307.5 3320.2 3330.6 559.5 621.2 626.8 630.2 631.9 709.9 786.3 789.4 792.5 810.2 9101.0 9294.3 9300.5 9368.9 9446.2 617.5 744.9 755.5 781.4 784.3 4324.7 4390.0 4410.0 4459.2 4616.5 59796.1 60581.4 60591.0 61027.0 61048.4 53367.0 53783.0 53808.7 55386.0 55420.0 46138.8 47687.3 47742.3 47799.5 48318.3 9086.2 9133.1 9140.6 9260.7 9380.8 36935.0 37431.3 37695.2 38337.2 38574.8 43314.4 45651.0 47320.8 48014.5 48311.0 11971.0 12074.2 12100.6 12160.8 12239.5 13165.8 13365.4 13485.2 13816.0 13841.5 11789.5 11894.0 12092.5 12099.2 12366.1 11827.9 11862.2 12115.3 12236.4 12241.4 11827.6 12389.6 12602.9 12660.3 12833.3 9487.0 9804.3 10061.2 10080.2 10130.5 10263.3 10286.3 10367.8 10590.0 10674.9 22:15:48 INFO - PROCESS | 3460 | -------- Summary: end -------- 22:15:48 INFO - PROCESS | 3460 | 22:15:49 INFO - TEST-INFO | 3460: exit 0 22:15:49 INFO - TEST-OK | dromaeo_css | took 1110149ms 22:15:49 INFO - TEST-START | kraken 22:15:49 INFO - operating with platform_type : linux_ 22:15:49 INFO - Initialising browser for kraken test... 22:15:49 INFO - TEST-INFO | started process 3695 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplfDLUb/profile http://localhost:47283/getInfo.html) 22:15:53 INFO - PROCESS | 3695 | 22:15:53 INFO - PROCESS | 3695 | (process:3762): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:15:53 INFO - PROCESS | 3695 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 22:15:54 INFO - PROCESS | 3695 | __metrics Screen width/height:1600/1200 22:15:54 INFO - PROCESS | 3695 | colorDepth:24 22:15:54 INFO - PROCESS | 3695 | Browser inner width/height: 1024/697 22:15:54 INFO - PROCESS | 3695 | __metrics 22:15:54 ERROR - PROCESS | 3695 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 22:15:55 INFO - TEST-INFO | 3695: exit 0 22:15:55 INFO - Browser initialized. 22:15:55 INFO - Running cycle 1/1 for kraken test... 22:15:55 INFO - TEST-INFO | started process 3813 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplfDLUb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:15:57 INFO - PROCESS | 3813 | 22:15:57 INFO - PROCESS | 3813 | (process:3874): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:16:07 INFO - PROCESS | 3813 | RSS: Main: 163192832 22:16:07 INFO - PROCESS | 3813 | 22:16:10 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47283/tests/kraken/driver.html?testName=audio-beat-detection) 22:16:10 INFO - PROCESS | 3813 | RSS: Main: 168046592 22:16:10 INFO - PROCESS | 3813 | 22:16:13 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47283/tests/kraken/driver.html?testName=audio-dft) 22:16:14 INFO - PROCESS | 3813 | RSS: Main: 171073536 22:16:14 INFO - PROCESS | 3813 | 22:16:16 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47283/tests/kraken/driver.html?testName=audio-fft) 22:16:17 INFO - PROCESS | 3813 | RSS: Main: 164040704 22:16:17 INFO - PROCESS | 3813 | 22:16:19 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47283/tests/kraken/driver.html?testName=audio-oscillator) 22:16:20 INFO - PROCESS | 3813 | RSS: Main: 164945920 22:16:20 INFO - PROCESS | 3813 | 22:16:22 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:16:22 INFO - PROCESS | 3813 | RSS: Main: 164814848 22:16:22 INFO - PROCESS | 3813 | 22:16:26 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47283/tests/kraken/driver.html?testName=imaging-darkroom) 22:16:26 INFO - PROCESS | 3813 | RSS: Main: 165199872 22:16:26 INFO - PROCESS | 3813 | 22:16:30 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47283/tests/kraken/driver.html?testName=imaging-desaturate) 22:16:30 INFO - PROCESS | 3813 | RSS: Main: 165494784 22:16:30 INFO - PROCESS | 3813 | 22:16:33 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47283/tests/kraken/driver.html?testName=json-parse-financial) 22:16:34 INFO - PROCESS | 3813 | RSS: Main: 165515264 22:16:34 INFO - PROCESS | 3813 | 22:16:35 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:16:36 INFO - PROCESS | 3813 | RSS: Main: 165613568 22:16:36 INFO - PROCESS | 3813 | 22:16:37 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47283/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:16:38 INFO - PROCESS | 3813 | RSS: Main: 165601280 22:16:38 INFO - PROCESS | 3813 | 22:16:40 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:16:41 INFO - PROCESS | 3813 | RSS: Main: 166162432 22:16:41 INFO - PROCESS | 3813 | 22:16:43 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:16:44 INFO - PROCESS | 3813 | RSS: Main: 166612992 22:16:44 INFO - PROCESS | 3813 | 22:16:46 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:16:47 INFO - PROCESS | 3813 | RSS: Main: 166674432 22:16:47 INFO - PROCESS | 3813 | 22:16:49 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:47283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47283/tests/kraken/driver.html?testName=ai-astar) 22:16:49 INFO - PROCESS | 3813 | RSS: Main: 167608320 22:16:49 INFO - PROCESS | 3813 | 22:16:49 INFO - PROCESS | 3813 | __start_tp_report 22:16:49 INFO - PROCESS | 3813 | _x_x_mozilla_page_load 22:16:49 INFO - PROCESS | 3813 | _x_x_mozilla_page_load_details 22:16:49 INFO - PROCESS | 3813 | |i|pagename|runs| 22:16:49 INFO - PROCESS | 3813 | |0;ai-astar;110;107;111;111;111;125;109;110;111;109 22:16:49 INFO - PROCESS | 3813 | |1;audio-beat-detection;151;130;166;170;126;156;159;137;170;131 22:16:49 INFO - PROCESS | 3813 | |2;audio-dft;162;162;163;162;163;161;165;175;167;162 22:16:49 INFO - PROCESS | 3813 | |3;audio-fft;73;77;74;75;78;79;73;76;147;77 22:16:49 INFO - PROCESS | 3813 | |4;audio-oscillator;98;94;141;93;94;93;141;93;94;147 22:16:49 INFO - PROCESS | 3813 | |5;imaging-gaussian-blur;118;118;118;118;117;117;118;117;118;117 22:16:49 INFO - PROCESS | 3813 | |6;imaging-darkroom;145;146;146;147;147;146;146;146;147;147 22:16:49 INFO - PROCESS | 3813 | |7;imaging-desaturate;96;96;96;96;96;96;95;95;95;96 22:16:49 INFO - PROCESS | 3813 | |8;json-parse-financial;58;58;58;60;58;58;58;60;57;56 22:16:49 INFO - PROCESS | 3813 | |9;json-stringify-tinderbox;61;65;61;67;62;63;62;61;61;61 22:16:49 INFO - PROCESS | 3813 | |10;stanford-crypto-aes;77;79;81;82;78;79;79;78;88;80 22:16:49 INFO - PROCESS | 3813 | |11;stanford-crypto-ccm;108;112;129;113;135;114;123;118;127;120 22:16:49 INFO - PROCESS | 3813 | |12;stanford-crypto-pbkdf2;147;143;145;156;144;149;145;156;143;137 22:16:49 INFO - PROCESS | 3813 | |13;stanford-crypto-sha256-iterative;63;68;62;65;66;63;71;65;65;62 22:16:49 INFO - PROCESS | 3813 | __end_tp_report 22:16:49 INFO - PROCESS | 3813 | __start_cc_report 22:16:49 INFO - PROCESS | 3813 | _x_x_mozilla_cycle_collect,812 22:16:49 INFO - PROCESS | 3813 | __end_cc_report 22:16:49 INFO - PROCESS | 3813 | __startTimestamp1459747009331__endTimestamp 22:16:49 INFO - PROCESS | 3813 | 22:16:49 INFO - PROCESS | 3813 | ------- Summary: start ------- 22:16:49 INFO - PROCESS | 3813 | Number of tests: 14 22:16:49 INFO - PROCESS | 3813 | 22:16:49 INFO - PROCESS | 3813 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:4.95 (4.5%) stddev-sans-first:5.22 22:16:49 INFO - PROCESS | 3813 | Values: 110.0 107.0 111.0 111.0 111.0 125.0 109.0 110.0 111.0 109.0 22:16:49 INFO - PROCESS | 3813 | 22:16:49 INFO - PROCESS | 3813 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:157.50 stddev:17.25 (11.0%) stddev-sans-first:18.29 22:16:49 INFO - PROCESS | 3813 | Values: 151.0 130.0 166.0 170.0 126.0 156.0 159.0 137.0 170.0 131.0 22:16:49 INFO - PROCESS | 3813 | 22:16:49 INFO - PROCESS | 3813 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.00 stddev:4.18 (2.6%) stddev-sans-first:4.36 22:16:49 INFO - PROCESS | 3813 | Values: 162.0 162.0 163.0 162.0 163.0 161.0 165.0 175.0 167.0 162.0 22:16:49 INFO - PROCESS | 3813 | 22:16:49 INFO - PROCESS | 3813 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.50 stddev:22.61 (29.6%) stddev-sans-first:23.70 22:16:49 INFO - PROCESS | 3813 | Values: 73.0 77.0 74.0 75.0 78.0 79.0 73.0 76.0 147.0 77.0 22:16:49 INFO - PROCESS | 3813 | 22:16:49 INFO - PROCESS | 3813 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:93.50 stddev:23.70 (25.3%) stddev-sans-first:24.81 22:16:49 INFO - PROCESS | 3813 | Values: 98.0 94.0 141.0 93.0 94.0 93.0 141.0 93.0 94.0 147.0 22:16:49 INFO - PROCESS | 3813 | 22:16:49 INFO - PROCESS | 3813 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 22:16:49 INFO - PROCESS | 3813 | Values: 118.0 118.0 118.0 118.0 117.0 117.0 118.0 117.0 118.0 117.0 22:16:49 INFO - PROCESS | 3813 | 22:16:49 INFO - PROCESS | 3813 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.53 22:16:49 INFO - PROCESS | 3813 | Values: 145.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 147.0 147.0 22:16:49 INFO - PROCESS | 3813 | 22:16:49 INFO - PROCESS | 3813 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 22:16:49 INFO - PROCESS | 3813 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 22:16:49 INFO - PROCESS | 3813 | 22:16:49 INFO - PROCESS | 3813 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:1.20 (2.1%) stddev-sans-first:1.27 22:16:49 INFO - PROCESS | 3813 | Values: 58.0 58.0 58.0 60.0 58.0 58.0 58.0 60.0 57.0 56.0 22:16:49 INFO - PROCESS | 3813 | 22:16:49 INFO - PROCESS | 3813 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.00 stddev:2.07 (3.3%) stddev-sans-first:2.13 22:16:49 INFO - PROCESS | 3813 | Values: 61.0 65.0 61.0 67.0 62.0 63.0 62.0 61.0 61.0 61.0 22:16:49 INFO - PROCESS | 3813 | 22:16:49 INFO - PROCESS | 3813 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.50 stddev:3.14 (4.0%) stddev-sans-first:3.13 22:16:49 INFO - PROCESS | 3813 | Values: 77.0 79.0 81.0 82.0 78.0 79.0 79.0 78.0 88.0 80.0 22:16:49 INFO - PROCESS | 3813 | 22:16:49 INFO - PROCESS | 3813 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:121.50 stddev:8.57 (7.1%) stddev-sans-first:7.93 22:16:49 INFO - PROCESS | 3813 | Values: 108.0 112.0 129.0 113.0 135.0 114.0 123.0 118.0 127.0 120.0 22:16:49 INFO - PROCESS | 3813 | 22:16:49 INFO - PROCESS | 3813 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.50 Median:146.00 stddev:5.89 (4.0%) stddev-sans-first:6.25 22:16:49 INFO - PROCESS | 3813 | Values: 147.0 143.0 145.0 156.0 144.0 149.0 145.0 156.0 143.0 137.0 22:16:49 INFO - PROCESS | 3813 | 22:16:49 INFO - PROCESS | 3813 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:2.83 (4.4%) stddev-sans-first:2.91 22:16:49 INFO - PROCESS | 3813 | Values: 63.0 68.0 62.0 65.0 66.0 63.0 71.0 65.0 65.0 62.0 22:16:49 INFO - PROCESS | 3813 | -------- Summary: end -------- 22:16:49 INFO - PROCESS | 3813 | 22:16:50 INFO - TEST-INFO | 3813: exit 0 22:16:50 INFO - TEST-OK | kraken | took 60849ms 22:16:50 INFO - SUITE-END | took 1170s 22:16:50 INFO - Completed test suite (00:19:31) 22:16:50 INFO - javascript benchmark 22:16:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3125.781195316328, 3155.2585142491516, 3191.202199450139, 3225.32268223673, 3227.2254658881875, 5265.8946821063555, 5311.176767601023, 5317.9468205317935, 5357.678539287641, 5359.678419294835, 5235.58115350772, 5421.728913554326, 5458.727063646822, 5475.67145971242, 5543.861403464915, 4651.418572678415, 4844.757762111898, 4915.16442204826, 5022.246663000561, 5035.269885866547, 4946.901061978776, 4960.429550601672, 4982.128127577677, 4994.775235114428, 5024.5226703463295, 4770.0459908018365, 4836.903261934742, 4840.4675485696725, 4855.660103792736, 4898.90202195954, 4815.951840481585, 4856.854294371175, 4877.170880950247, 4878.390201224847, 4916.410030796327, 4764.380630518011, 4816.44610869751, 4825.2520859266515, 4827.637927155442, 4854.2718592211095, 5307.495787900143, 5319.308489896327, 5374.0, 5384.5692344612335, 5387.299651045339, 5801.0428279333855, 5804.970975145139, 5818.8254352369495, 5846.736896839652, 5846.947549441099, 5658.43415658435, 5786.971065144689, 5858.0, 5865.648061116304, 5900.203472531196, 5516.889662206733, 5526.06056970316, 5529.861753456155, 5541.3904470507805, 5581.665100094007, 5997.580169388189, 6007.27912650476, 6010.669413182317, 6019.548533859978, 6029.276486821522, 5435.456454354533, 5539.0, 5623.803166889221, 5759.049756790083, 5765.769369225184, 5628.60599758013, 5721.0, 5781.0, 5797.913031304533, 5847.502962248172, 5726.79956201531, 5756.740946657411, 5770.2498675171955, 5773.769049238067, 5790.507806836466, 5534.142207957692, 5732.0, 5794.362620111784, 5812.041013232853, 5829.183914252008, 4404.11917616478, 4416.712913660666, 4417.977910110429, 4435.157320109169, 4446.310821822558, 3929.980350098231, 3931.744436611611, 3933.213357328546, 3957.5250969883223, 3959.3467077932396, 5381.7578208980685, 5566.34821388445, 5580.9441905580425, 5612.186232996192, 5619.325680918234, 5822.475977162076, 5836.358000619928, 5840.912386314209, 5861.267341582302, 5865.0, 5498.367687715884, 5546.889062218733, 5558.082916318762, 5594.524465420403, 5608.214849921014, 4757.5718185363485, 4788.592969597554, 4847.3698419205275, 4931.284963680247, 4937.11131996237, 6004.6697431640805, 6009.429104235091, 6031.547633927473, 6038.849028774228, 6046.3651316612, 5870.53035757147, 5872.706364681834, 5892.234009578728, 5895.469407753323, 5900.262467191601, 5863.061910094364, 5925.081612350093, 5933.792317268875, 5972.223610930725, 6012.6392416455155, 5685.744141513725, 5694.515966142924, 5714.085746280575, 5733.9713301434895, 5762.049261871744, 5664.773409063756, 5722.799702010409, 5853.912191317048, 5853.94146058534, 5884.941150588611, 5467.4532546745, 5732.05421105513, 5788.768449261982, 5791.710414479344, 5831.562632802642, 5585.832425027255, 5665.348484924121, 5723.971380143073, 5755.165501002248, 5772.307323121252, 5563.610547261653, 5603.747831347518, 5607.243022192115, 5623.550115990629, 5633.521150702236, 5483.75323110469, 5636.408177141341, 5764.42355764437, 5773.826785196451, 5789.8263052108505, 5632.352279487911, 5632.802851900164, 5651.15232715096, 5654.6889921054735, 5659.066254068032], "unit": "score", "name": "dojo.html", "value": 5341.834755972246}, {"lowerIsBetter": false, "replicates": [548.0826573016159, 576.7635269539488, 577.6505214345322, 594.4293478260869, 596.8746563221723, 36892.0, 38148.61851381485, 38172.80913595432, 38191.23617527648, 38381.232375352476, 38794.4180837287, 39157.0, 39189.60810391895, 39196.80401597988, 39310.21379572414, 8428.999999999985, 8675.305975521944, 8743.95628021859, 8745.912540874573, 8751.95624021879, 8460.703875364363, 8531.829363412728, 8535.871961920577, 8571.271441927413, 8619.0, 8625.95687021564, 8674.262687671524, 8678.698195270697, 8736.0, 8761.474311541328, 8618.827623447496, 8624.870626940601, 8682.044975052771, 8684.652613895436, 8693.7826554336, 8538.82922341556, 8666.826663466758, 8669.046404895456, 8672.60973256205, 8673.479591224484, 32961.67038329634, 37832.0, 38217.23565528702, 38217.61782382168, 38558.22883542341, 3391.321735652855, 3487.930241395183, 3572.5534308211472, 3661.7253705971893, 4076.347784354519, 30138.54792178119, 30573.38853222945, 30651.846740766152, 30848.228794280098, 30856.228594285323, 3996.800159991989, 4180.602842729966, 4187.392828039948, 4219.472565929259, 4237.576242375738, 102273.0, 102395.0, 103247.48376258071, 103291.0, 104240.0, 67753.3224667747, 68046.0, 68236.0, 68378.3162168382, 68429.0, 71734.2826571738, 72285.63857180785, 72731.63634181795, 72843.0, 72880.63559682274, 15220.619484512754, 15362.155081470402, 15458.0, 15484.07095574269, 15499.690006199813, 11355.772884542263, 11402.657920262405, 11440.542378304775, 11448.141389395829, 11481.942590286995, 22663.433414164778, 23048.539029219322, 23106.7689323108, 23127.7687223129, 23148.18981335645, 7865.842683146305, 8136.308413784895, 8160.306373958161, 8460.57697115154, 8621.61202745878, 1068.3216157739892, 1096.780643871229, 1120.8318752187074, 1137.175547727907, 1215.9209651372632, 29779.702202977693, 30060.54909176364, 31123.377532449224, 31524.36951260962, 31789.8410507946, 1107.8061339265757, 1152.8847115288572, 1195.491915935724, 1252.47720967103, 1258.3205069262497, 15570.0, 16236.675266494603, 16264.512064637844, 16503.17484125789, 16640.6671866562, 401581.0, 402780.0, 406735.0, 408849.0, 409315.0, 54629.726851365485, 56324.71837640786, 56343.43656563464, 56385.0, 56414.15378769322, 1385.8497447119069, 1408.4577437686564, 1413.3074793351184, 1424.2380326525258, 1426.265473281261, 30400.239994000327, 30439.847800760854, 30927.0, 31699.366012679155, 31699.52450713195, 49239.50760492349, 49441.0, 49633.25550116679, 49724.0, 49899.50100499094, 360711.0, 365657.0, 366357.0, 366531.0, 367117.3153073847, 33116.668833311356, 33586.32827343488, 33769.83115084507, 33816.661833382335, 37201.25597488089, 47992.520074798806, 48253.5174648249, 49337.25994110163, 50110.24834627411, 50997.49002510076, 39211.41182882202, 39431.408528872664, 40059.39316978585, 40218.1956360877, 40221.1955760889, 38342.80828595839, 39261.0, 39653.00867478336, 39687.206255875295, 40368.596314037655, 35329.0, 40388.990275243355, 42125.0, 42344.0, 42944.35583466188, 34188.48717269293, 34754.478682819274, 34900.50295211029, 35068.82465587656, 35266.82366588253, 27919.581206282328, 27985.580216297178, 27991.0, 28284.15147545577, 28513.714862851106], "unit": "score", "name": "ext.html", "value": 19197.79930233734}, {"lowerIsBetter": false, "replicates": [381.3593163485344, 383.80617788017037, 384.1356946869544, 386.3200766650694, 387.58334790100633, 17599.47201583953, 18418.171182296814, 19041.839922010222, 19118.61762764744, 19172.80827191726, 13234.404451799668, 17459.3016279349, 18152.36466723665, 18303.35938242162, 18306.725399119023, 5009.7996080156845, 5208.374995000605, 5223.164293713006, 5246.947530524684, 5262.473752624726, 5294.0, 5491.478309560585, 5495.890082198353, 5501.614886957915, 5511.696856672901, 5342.786288548454, 5476.534494567946, 5486.149646804732, 5695.03184458643, 5722.97138514309, 5669.348024977118, 5680.3467601225975, 5687.7156142192725, 5704.429557044283, 5713.5714821388565, 5383.246345511631, 5451.890962180734, 5507.421720719347, 5509.559235261169, 5512.5589952803675, 20950.476238094016, 20989.790102098937, 21361.35915922525, 22374.0, 22555.0, 2117.608242475147, 2132.9786702132933, 2186.9890650546804, 2296.0815673730476, 2822.4214036122544, 9844.458554779485, 9893.950530247375, 10946.343219406861, 13953.860461395358, 13998.580042598738, 1921.5100149461798, 1926.402815127315, 1943.1741509858396, 1990.920363185471, 2012.7987201279755, 70174.0, 72883.63558182228, 74822.0, 77240.0, 77780.22219777844, 10378.221633377376, 10561.735956601147, 10677.572897084185, 10992.28550144238, 11012.229143960007, 14660.560183194308, 14859.479918202811, 14908.70182596342, 14950.70098598022, 14968.625784355478, 7335.77992660221, 7706.614669266514, 7775.3390961767755, 7805.492642978188, 7860.6855725771475, 7394.519356241827, 7479.0, 7482.289182527651, 7505.962470187614, 7641.426892983049, 4571.177188106173, 4586.701864378805, 4660.0, 4670.0, 4774.618030557616, 1856.0997916010724, 1926.4798504403732, 1931.4012656076661, 1956.5402130499322, 1973.8716983396034, 979.2068424576116, 982.1749730226644, 1018.7300365403174, 1040.006793512194, 1042.1454407386022, 17448.0, 18671.81328186728, 18829.811701883078, 18900.243990240237, 19010.619787604446, 999.5252255178877, 1006.0894890124449, 1021.5964693945998, 1034.255336157965, 1097.0346095435966, 10710.785784284271, 10960.506777195045, 10987.670369888916, 10994.120470362512, 10995.34027958325, 451959.0, 457643.0, 461749.0, 466003.0, 470752.0, 72784.63607682033, 82616.58691706623, 83749.58125209456, 86636.56681716678, 87369.56315218384, 1024.7284469615558, 1042.0361165921493, 1072.6270373921393, 1073.1843798712878, 1078.8975047370486, 16915.323387064378, 16989.150542473075, 17111.401100961408, 17115.400960966308, 17191.914040429718, 37694.246115078095, 37940.24119517539, 37955.24089518139, 38420.42369364406, 38797.2240555193, 54506.0, 54634.726826365615, 54726.17910731262, 54831.725841370535, 54986.72506637601, 8429.367797415096, 8484.957575212084, 8523.914760852313, 8525.573721313785, 8537.658493660185, 12351.75296494083, 12960.481580737041, 13043.739125217633, 13072.411741471466, 13178.341082945622, 11209.821673252036, 11229.157813164209, 11706.414679265832, 11712.180147389601, 12153.331566763913, 11386.0, 11888.0, 11916.761664766484, 11941.223820451643, 12030.578929737418, 11804.40977951082, 11873.703157421134, 12258.14193006481, 12397.318147501974, 12412.317322547347, 8432.915670843213, 8605.698800541952, 8623.439476434012, 8736.737897863075, 8764.649414023368, 11208.103351732005, 11647.242929209913, 11784.175107742376, 11796.29222246668, 11918.165728398928], "unit": "score", "name": "jquery.html", "value": 9016.727583927623}, {"lowerIsBetter": false, "replicates": [1470.558832350295, 1471.2570152073204, 1645.7613646021327, 1649.70305345038, 1793.2826869252306, 7301.598412087333, 7964.96017519913, 8089.150639182889, 8286.709965151213, 8311.91688083119, 7687.846243075135, 7692.9230707692905, 7705.49914255573, 7757.456978011542, 7763.417743669219, 2249.167807911075, 2276.226083131735, 2278.5670722562745, 2278.715160604924, 2283.9657405138937, 2182.4980254541465, 2221.0671517962496, 2236.9776302237015, 2251.470904337479, 2256.9887150564223, 2211.4803021290063, 2225.2879078694823, 2228.320362289501, 2250.4823890505195, 2252.1779550464125, 2244.371575958734, 2249.4488850231633, 2251.7072780538506, 2255.751867294596, 2260.6495993121093, 2246.8876556172127, 2247.763984781607, 2255.064148378421, 2261.479859632294, 2267.240474441064, 8130.674773009132, 8134.552599607019, 8149.0, 8170.795730106735, 8171.877421838677, 5085.415177254589, 5154.484551544853, 5163.974180129076, 5166.173412254021, 5168.7415629218385, 3232.143481977278, 3245.2860370718404, 3435.4846772984, 3447.1037530242315, 3449.7757645752945, 1105.7401510644993, 1113.5434471866577, 1136.0570726297235, 1144.5879483386057, 1176.5117476247347, 11866.762664746742, 11873.881261187364, 11925.344106074162, 11970.401479926057, 12000.69998250042, 4361.5856493633055, 4431.667624928144, 4505.684602077823, 4512.255477846119, 4527.456705195397, 9944.900550994398, 10037.598496060222, 10044.146247569039, 10067.697969060793, 10080.949595251977, 5085.0, 5105.412877519058, 5112.258722485293, 5144.742762861842, 5151.330327057459, 4151.813168407429, 4553.612942899825, 4564.109998550251, 4624.560666736655, 4702.788374523155, 3750.137468382233, 3786.5645450772963, 3813.733038687321, 3821.636944490269, 3871.399933010388, 1222.3155033181447, 1228.4533382644638, 1233.734747029393, 1241.391718058145, 1242.5837344489516, 1371.9245441500614, 1394.6652803327331, 1401.2713389037847, 1406.985930140706, 1431.9427222911174, 7628.122765881883, 7992.5204487730925, 8001.5599142046585, 8003.279704826594, 8007.159248278964, 486.60098719050745, 491.6533843640225, 498.8378776897523, 498.88026873550086, 509.7272958966935, 5871.236739223874, 5965.254343207099, 5972.462478376967, 5978.372270911578, 5980.730867110903, 9850.852237216448, 10470.057694807503, 10518.526666300035, 10653.414062226497, 10701.0, 10087.142592879687, 10391.116755075904, 10410.791784164274, 10415.843762343571, 10501.422421766723, 7903.288704016666, 7957.602119894098, 7958.403119765925, 8020.5588692621295, 8044.839103217902, 7606.467547271859, 7659.88510172359, 7681.692732290646, 7706.499077559941, 7838.960805195938, 8800.779980500538, 8964.0, 9048.819023619622, 9159.816803663756, 9185.357025008452, 9223.0, 9462.101100395452, 9564.378315409476, 9603.0, 9708.466034368177, 6496.1230233919705, 6913.585184888922, 7134.821629459305, 7302.96348518254, 7388.963055184689, 7906.407019473678, 7917.0, 7917.524948503108, 7959.9602001989615, 7962.044554653247, 6677.632730199885, 6876.140482439695, 6923.9307606923285, 7137.607431591312, 7156.033935418652, 6907.309269073053, 7012.1935977363255, 7057.188423331178, 7059.011738356531, 7070.36366726997, 7060.823479413056, 7113.359797618239, 7135.143782746104, 7160.677769500489, 7169.605671687898, 6885.036094946611, 6966.059581956371, 6994.090768200102, 6996.05553250325, 7004.929950700428, 6774.729010839708, 6793.218779840184, 6858.5199036067, 6859.279775623488, 7103.112110986127], "unit": "score", "name": "mootools.html", "value": 4632.498841458564}, {"lowerIsBetter": false, "replicates": [339.4890689512284, 341.19988626670454, 349.1707195410899, 351.7309258417311, 353.44156233151625, 6357.459615932651, 6380.106785050091, 6404.96797516013, 6421.13314702515, 6425.8714825703455, 6372.713227904744, 6374.235091788992, 6383.744650213997, 6384.393482619155, 6384.776532821352, 4510.706804057726, 4633.884152896171, 4785.808567657289, 4791.544803243686, 4795.2807078938085, 4768.451628062782, 4775.164346239411, 4775.952240477603, 4791.928121078186, 4795.784189711454, 4740.857774266778, 4743.383360163174, 4743.62051035918, 4752.0, 4753.762311884392, 4756.90486190276, 4766.523347665223, 4772.3795906532105, 4773.665843390964, 4792.305115758196, 4184.958150418487, 4185.58144185582, 4186.35111557709, 4194.3498757692605, 4200.201961627281, 5881.85295367615, 6127.356627554132, 6155.661438620874, 6170.382961703794, 6174.5060395168275, 5495.340559132889, 5520.392756796749, 5532.28080349556, 5544.251526044013, 5546.112621980464, 6724.865502689919, 6730.0, 6730.596164230162, 6755.324467553254, 6767.796966091025, 4614.838480653195, 4615.307703844416, 4617.12274667812, 4617.168909596271, 4628.953710462886, 6984.580925144508, 7018.789436316919, 7045.436365090832, 7053.2594077621625, 7054.118235220598, 4527.456705195332, 4665.206914824488, 4674.579287864109, 4691.483936767021, 4710.481846996828, 4676.953230467651, 4680.180968330528, 4710.105080034782, 4720.480747117815, 4722.6221902247735, 5490.450954904478, 5511.862203444946, 5544.473275038865, 5545.889082218333, 5576.609637325349, 6707.765228216989, 6770.458363330922, 6789.083473730983, 6791.864162716718, 6805.843006688776, 1651.6696660667915, 1669.766232727419, 1677.1195122560753, 1683.8484536391538, 1683.890547114458, 1067.114295135036, 1088.4176965323672, 1092.257265059751, 1095.9287646302964, 1107.5735841700841, 6444.871102577922, 6492.707828147744, 6492.837679058061, 6508.056331831858, 6514.120593719882, 6772.0, 6971.8605627887155, 6974.476914231453, 6979.546329488567, 7010.719571217094, 6448.387403196689, 6549.508786841006, 6557.639329836905, 6598.571092878948, 6604.174478190226, 3762.3227818992295, 3787.7348585598743, 3803.790791506494, 3803.961960380361, 3815.923681526354, 7189.6405179740805, 7212.134543854771, 7248.637568121573, 7260.9636951815955, 7274.854502909912, 6968.268331825187, 7093.1488221413765, 7121.003059571664, 7176.138863336433, 7192.957021231892, 7223.9638801806705, 7231.783046508614, 7237.927620723831, 7242.058532390755, 7252.166000909963, 7000.684969176501, 7002.544834585736, 7005.54463959841, 7014.088168538057, 7017.649117544204, 6925.238223795479, 6932.0988271524375, 6934.341237582624, 6959.791206263821, 6964.512484126265, 6968.268331825288, 7203.315685009916, 7204.675789589376, 7248.637568121679, 7262.782116536512, 4804.375431193923, 4818.566329030404, 4837.37114175155, 4840.636952228668, 4873.926891096708, 6947.513674042971, 6970.093887794555, 6970.23327433992, 6982.755603553851, 7004.929950700632, 6827.0, 6839.418649414855, 6844.589324640538, 6847.417969472651, 6848.246692863681, 6668.099806526056, 6773.051772751917, 6783.728650853911, 6784.966075169593, 6796.796096117125, 6537.084808126771, 6547.672616369067, 6551.082848401133, 6551.44312733423, 6587.670616469253, 6756.4257038150345, 6800.115984921928, 6804.5163515317545, 6815.42068924147, 6855.280195579392, 6580.539362244597, 6595.472362211108, 6602.240742314695, 6604.273529911802, 6612.933870661424], "unit": "score", "name": "prototype.html", "value": 5060.4171199489965}, {"lowerIsBetter": false, "replicates": [732.6117157906305, 776.9611519424029, 800.4876878797567, 848.3976376772489, 858.0689951402728, 12563.937180314097, 12570.560030398938, 12603.621891343251, 12654.683632909182, 12744.617661470147, 14398.208098554602, 14644.633884152901, 14683.412663493475, 14689.338979745911, 14689.77965330521, 696.7631005458143, 814.8411059843332, 820.3273315880965, 825.4593241426875, 829.5022986208287, 817.9182081791803, 818.9262966333029, 821.6056292979373, 825.9297959673435, 827.4497459189631, 862.482510493705, 863.9568021598894, 864.6238886084542, 865.2818160926447, 868.2229404682805, 855.6064210463163, 856.5503110866814, 857.022993787077, 858.0561382479285, 859.7119964811795, 622.0420552349376, 625.6402568523072, 625.6433832715354, 626.8464226264595, 627.3350248736355, 13601.455941762317, 14040.36818343177, 14057.64855878601, 14067.296635168303, 14092.154470731788, 12823.807642885364, 12927.288999105045, 13024.153430027018, 13086.345682715826, 13338.199708017453, 10928.836067458995, 11350.20548561601, 11448.942755286254, 11545.826812597817, 11623.709407264885, 3670.522832031819, 3685.907852303687, 3755.586885442599, 3819.1597848473293, 3823.636754508345, 53626.92746145094, 53753.0, 53761.1935820963, 53808.19287710688, 53810.730946345015, 10091.545880435398, 10163.441010744333, 10261.897381026094, 10333.483325833678, 10680.092192163598, 18475.722864157047, 18592.349267775564, 18629.789063710814, 18715.906420468084, 18720.8767473952, 7863.803404914923, 7871.606419679108, 7962.960185199037, 7991.600419978978, 8108.472949258397, 4376.7811609419405, 4463.665225108065, 4480.081583275421, 4587.72473651582, 4613.377194078824, 3244.318693074481, 3293.1108600677685, 3307.536944827726, 3320.236345640516, 3330.6169790473923, 559.5467671186352, 621.1521273461692, 626.764963138823, 630.1681780050382, 631.9304876463585, 709.9361057504849, 786.3373878854896, 789.4276649429232, 792.5205250823284, 810.2100452059195, 9100.954495227614, 9294.302927280482, 9300.488473134043, 9368.90631093694, 9446.197073248852, 617.5399327500951, 744.891955765194, 755.5167440171809, 781.386611509962, 784.3215618489965, 4324.675649326313, 4390.0, 4409.977950110293, 4459.219636563588, 4616.469106052779, 59796.10305845416, 60581.39418605846, 60591.0, 61027.0, 61048.38951610427, 53367.0, 53783.0, 53808.73095634497, 55386.0, 55420.0, 46138.769306153925, 47687.28469072967, 47742.28386574204, 47799.52200477951, 48318.27522587164, 9086.182243598108, 9133.132352426508, 9140.63437462494, 9260.675876344296, 9380.81238375215, 36935.0, 37431.251374971805, 37695.246095078495, 38337.2332553353, 38574.80712596419, 43314.350284745124, 45651.0, 47320.763396182796, 48014.519854801, 48311.0, 11971.0, 12074.154809163274, 12100.636980890587, 12160.75678486443, 12239.510419583474, 13165.831153008787, 13365.39855706515, 13485.190888546718, 13816.0, 13841.515546955809, 11789.528418863149, 11894.0, 12092.516299347928, 12099.213551119148, 12366.134370593973, 11827.881721182677, 11862.22895511789, 12115.333656648969, 12236.388180591113, 12241.449134789134, 11827.586034489095, 12389.566365177176, 12602.936985315015, 12660.30368329714, 12833.294168820805, 9486.95256523713, 9804.313698041069, 10061.195104391778, 10080.243981701255, 10130.493475326057, 10263.332883362558, 10286.331388459726, 10367.792644147226, 10590.0, 10674.946625266824], "unit": "score", "name": "yui.html", "value": 6678.550236296564}], "name": "dromaeo_css", "value": 7246.338649952613}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 107.0, 111.0, 111.0, 111.0, 125.0, 109.0, 110.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [151.0, 130.0, 166.0, 170.0, 126.0, 156.0, 159.0, 137.0, 170.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 162.0, 163.0, 161.0, 165.0, 175.0, 167.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.2}, {"lowerIsBetter": true, "replicates": [73.0, 77.0, 74.0, 75.0, 78.0, 79.0, 73.0, 76.0, 147.0, 77.0], "unit": "score", "name": "audio-fft", "value": 82.9}, {"lowerIsBetter": true, "replicates": [98.0, 94.0, 141.0, 93.0, 94.0, 93.0, 141.0, 93.0, 94.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.6}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 58.0, 60.0, 58.0, 58.0, 58.0, 60.0, 57.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [61.0, 65.0, 61.0, 67.0, 62.0, 63.0, 62.0, 61.0, 61.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 62.4}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 81.0, 82.0, 78.0, 79.0, 79.0, 78.0, 88.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.1}, {"lowerIsBetter": true, "replicates": [108.0, 112.0, 129.0, 113.0, 135.0, 114.0, 123.0, 118.0, 127.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.9}, {"lowerIsBetter": true, "replicates": [147.0, 143.0, 145.0, 156.0, 144.0, 149.0, 145.0, 156.0, 143.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.5}, {"lowerIsBetter": true, "replicates": [63.0, 68.0, 62.0, 65.0, 66.0, 63.0, 71.0, 65.0, 65.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.0}], "name": "kraken", "value": 1508.5}]} 22:16:50 INFO - Return code: 0 22:16:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:16:50 ERROR - # TBPL SUCCESS # 22:16:50 INFO - Running post-action listener: _resource_record_post_action 22:16:50 INFO - Running post-run listener: _resource_record_post_run 22:16:51 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535826432; Read time: 16; Write time: 864148 22:16:51 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 243183616; Read time: 0; Write time: 616448 22:16:51 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292642816; Read time: 16; Write time: 247700 22:16:51 INFO - Running post-run listener: _upload_blobber_files 22:16:51 INFO - Blob upload gear active. 22:16:51 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:16:51 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 22:16:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:16:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:16:52 INFO - (blobuploader) - INFO - Open directory for files ... 22:16:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:16:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:16:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:53 INFO - (blobuploader) - INFO - Done attempting. 22:16:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:16:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:16:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:54 INFO - (blobuploader) - INFO - Done attempting. 22:16:54 INFO - (blobuploader) - INFO - Iteration through files over. 22:16:54 INFO - Return code: 0 22:16:54 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:16:54 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:16:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/27a0d76f2b70b22fcd7b55237a307b648f94500aeb56c342194e1848514d58917b85a7b45c38b947a688006b9cf78b7c769c690cc2bd9209bd9f014e0dd01132", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb616b8c1dd0d3d672e1f4450ea51f56c8de6c31af6a28a0980ed228fdc303c6fece8dcab8ac447b5b5d4a89cee2cc2b7e4ef7707af271cfd6374f1db4a1962c"} 22:16:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:16:54 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:16:54 INFO - Contents: 22:16:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/27a0d76f2b70b22fcd7b55237a307b648f94500aeb56c342194e1848514d58917b85a7b45c38b947a688006b9cf78b7c769c690cc2bd9209bd9f014e0dd01132", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb616b8c1dd0d3d672e1f4450ea51f56c8de6c31af6a28a0980ed228fdc303c6fece8dcab8ac447b5b5d4a89cee2cc2b7e4ef7707af271cfd6374f1db4a1962c"} 22:16:54 INFO - Running post-run listener: copy_logs_to_upload_dir 22:16:54 INFO - Copying logs to upload dir... 22:16:54 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:16:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.358976 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-03 22:16:52.689841) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-03 22:16:52.693070) ========= 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=af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/27a0d76f2b70b22fcd7b55237a307b648f94500aeb56c342194e1848514d58917b85a7b45c38b947a688006b9cf78b7c769c690cc2bd9209bd9f014e0dd01132", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb616b8c1dd0d3d672e1f4450ea51f56c8de6c31af6a28a0980ed228fdc303c6fece8dcab8ac447b5b5d4a89cee2cc2b7e4ef7707af271cfd6374f1db4a1962c"} build_url:https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/27a0d76f2b70b22fcd7b55237a307b648f94500aeb56c342194e1848514d58917b85a7b45c38b947a688006b9cf78b7c769c690cc2bd9209bd9f014e0dd01132", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb616b8c1dd0d3d672e1f4450ea51f56c8de6c31af6a28a0980ed228fdc303c6fece8dcab8ac447b5b5d4a89cee2cc2b7e4ef7707af271cfd6374f1db4a1962c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-03 22:16:52.721849) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 22:16:52.722180) ========= 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=af724c981e2a0f424dbabf99000001e7-1459735076.607628-1269514854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 22:16:52.808365) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-03 22:16:52.809100) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-03 22:16:52.809847) ========= ========= Total master_lag: 0.30 =========