builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1457522952.92 results: success (0) buildid: 20160309004036 builduid: f0241834d86f4346bb5e8166bb559d5a revision: ce9a5e723e4b21ce0dac5ede64e156023bb70534 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 03:29:12.924553) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 03:29:12.925579) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 03:29:12.926372) ========= 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=745a4373a2a16df560f216e000000264-1457522952.410600-539033305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006057 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 03:29:12.954583) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 03:29:12.955267) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 03:29:12.970278) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 03:29:12.970970) ========= 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=745a4373a2a16df560f216e000000264-1457522952.410600-539033305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 03:29:13.024187) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 03:29:13.024877) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 03:29:13.025749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 03:29:13.026446) ========= 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=745a4373a2a16df560f216e000000264-1457522952.410600-539033305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-09 03:29: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 81.4M=0s 2016-03-09 03:29:13 (81.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175055 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 03:29:13.222111) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 03:29:13.222481) ========= 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=745a4373a2a16df560f216e000000264-1457522952.410600-539033305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018684 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 03:29:13.272612) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 03:29:13.273017) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ce9a5e723e4b21ce0dac5ede64e156023bb70534 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ce9a5e723e4b21ce0dac5ede64e156023bb70534 --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=745a4373a2a16df560f216e000000264-1457522952.410600-539033305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-09 03:29:13,497 truncating revision to first 12 chars 2016-03-09 03:29:13,497 Setting DEBUG logging. 2016-03-09 03:29:13,497 attempt 1/10 2016-03-09 03:29:13,497 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ce9a5e723e4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-09 03:29:14,659 unpacking tar archive at: mozilla-aurora-ce9a5e723e4b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.470022 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 03:29:14.756379) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 03:29:14.756804) ========= echo ce9a5e723e4b21ce0dac5ede64e156023bb70534 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ce9a5e723e4b21ce0dac5ede64e156023bb70534'] 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=745a4373a2a16df560f216e000000264-1457522952.410600-539033305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ce9a5e723e4b21ce0dac5ede64e156023bb70534 program finished with exit code 0 elapsedTime=0.003605 script_repo_revision: 'ce9a5e723e4b21ce0dac5ede64e156023bb70534' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 03:29:14.809997) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 03:29:14.810703) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 03:29:14.822699) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 34 secs) (at 2016-03-09 03:29:14.823395) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=745a4373a2a16df560f216e000000264-1457522952.410600-539033305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:29:15 INFO - MultiFileLogger online at 20160309 03:29:15 in /builds/slave/test-pgo 03:29:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:29:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:29:15 INFO - {'append_to_log': False, 03:29:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:29:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:29:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:29:15 INFO - 'branch': 'Mozilla-Aurora', 03:29:15 INFO - 'buildbot_json_path': 'buildprops.json', 03:29:15 INFO - 'config_files': ('talos/linux_config.py',), 03:29:15 INFO - 'default_actions': ('clobber', 03:29:15 INFO - 'read-buildbot-config', 03:29:15 INFO - 'download-and-extract', 03:29:15 INFO - 'populate-webroot', 03:29:15 INFO - 'create-virtualenv', 03:29:15 INFO - 'install', 03:29:15 INFO - 'run-tests'), 03:29:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:29:15 INFO - 'download_minidump_stackwalk': True, 03:29:15 INFO - 'download_symbols': 'ondemand', 03:29:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:29:15 INFO - 'tooltool.py': '/tools/tooltool.py', 03:29:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:29:15 INFO - '/tools/misc-python/virtualenv.py')}, 03:29:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:29:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:29:15 INFO - 'installer_path': 'installer.exe', 03:29:15 INFO - 'log_level': 'info', 03:29:15 INFO - 'log_name': 'talos', 03:29:15 INFO - 'log_to_console': True, 03:29:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:29:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:29:15 INFO - 'opt_config_files': (), 03:29:15 INFO - 'pip_index': False, 03:29:15 INFO - 'sps_profile': False, 03:29:15 INFO - 'sps_profile_interval': 0, 03:29:15 INFO - 'suite': 'dromaeojs-e10s', 03:29:15 INFO - 'system_bits': '32', 03:29:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:29:15 INFO - 'title': 'talos-linux64-ix-032', 03:29:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:29:15 INFO - 'use_talos_json': True, 03:29:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:29:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:29:15 INFO - 'work_dir': 'build'} 03:29:15 INFO - ##### 03:29:15 INFO - ##### Running clobber step. 03:29:15 INFO - ##### 03:29:15 INFO - Running pre-action listener: _resource_record_pre_action 03:29:15 INFO - Running main action method: clobber 03:29:15 INFO - rmtree: /builds/slave/test-pgo/build 03:29:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:29:15 INFO - Running post-action listener: _resource_record_post_action 03:29:15 INFO - ##### 03:29:15 INFO - ##### Running read-buildbot-config step. 03:29:15 INFO - ##### 03:29:15 INFO - Running pre-action listener: _resource_record_pre_action 03:29:15 INFO - Running main action method: read_buildbot_config 03:29:15 INFO - Using buildbot properties: 03:29:15 INFO - { 03:29:15 INFO - "project": "", 03:29:15 INFO - "product": "firefox", 03:29:15 INFO - "script_repo_revision": "production", 03:29:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:29:15 INFO - "repository": "", 03:29:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:29:15 INFO - "buildid": "20160309004036", 03:29:15 INFO - "stage_platform": "linux64-pgo", 03:29:15 INFO - "basedir": "/builds/slave/test-pgo", 03:29:15 INFO - "nightly_build": "True", 03:29:15 INFO - "buildnumber": 221, 03:29:15 INFO - "slavename": "talos-linux64-ix-032", 03:29:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:29:15 INFO - "platform": "ubuntu64_hw", 03:29:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:29:15 INFO - "branch": "mozilla-aurora", 03:29:15 INFO - "repo_path": "releases/mozilla-aurora", 03:29:15 INFO - "revision": "ce9a5e723e4b21ce0dac5ede64e156023bb70534", 03:29:15 INFO - "pgo_build": "True", 03:29:15 INFO - "builduid": "f0241834d86f4346bb5e8166bb559d5a", 03:29:15 INFO - "slavebuilddir": "test" 03:29:15 INFO - } 03:29:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 03:29:15 INFO - Running post-action listener: _resource_record_post_action 03:29:15 INFO - ##### 03:29:15 INFO - ##### Running download-and-extract step. 03:29:15 INFO - ##### 03:29:15 INFO - Running pre-action listener: _resource_record_pre_action 03:29:15 INFO - Running main action method: download_and_extract 03:29:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:29: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')]} 03:29:15 INFO - https://queue.taskcluster.net/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:29:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:29:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:29:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:29:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:29:16 INFO - Downloaded 1448 bytes. 03:29:16 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:29:16 INFO - Using the following test package requirements: 03:29:16 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:29:16 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:29:16 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:29:16 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:16 INFO - u'jsshell-linux-x86_64.zip'], 03:29:16 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:29:16 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:29:16 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:29:16 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:29:16 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:29:16 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:29:16 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:29:16 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:29:16 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')]} 03:29:16 INFO - https://queue.taskcluster.net/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:29:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:29:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:29:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:29:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:29:17 INFO - Downloaded 23305697 bytes. 03:29:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:29:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 03:29:18 INFO - Return code: 0 03:29:18 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:29: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')]} 03:29:18 INFO - https://queue.taskcluster.net/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:29:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:29:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:29:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:29:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:29:19 INFO - Downloaded 23305697 bytes. 03:29:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:29:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 03:29:21 INFO - Return code: 0 03:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:21 INFO - https://queue.taskcluster.net/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:29:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:29:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:29:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:29:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:29:23 INFO - Downloaded 10845161 bytes. 03:29:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:29:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 03:29:23 INFO - Return code: 0 03:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:23 INFO - https://queue.taskcluster.net/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:29:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:29:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:29:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:29:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:29:27 INFO - Downloaded 60408294 bytes. 03:29:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:29:27 INFO - mkdir: /builds/slave/test-pgo/properties 03:29:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:29:27 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:29:27 INFO - Contents: 03:29:27 INFO - build_url:https://queue.taskcluster.net/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:29:27 INFO - Running post-action listener: _resource_record_post_action 03:29:27 INFO - Running post-action listener: set_extra_try_arguments 03:29:27 INFO - ##### 03:29:27 INFO - ##### Running populate-webroot step. 03:29:27 INFO - ##### 03:29:27 INFO - Running pre-action listener: _resource_record_pre_action 03:29:27 INFO - Running main action method: populate_webroot 03:29:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:29:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:29:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:29:27 INFO - '--tppagecycles', 03:29:27 INFO - '7'], 03:29:27 INFO - 'tests': ['tsvgm']}}, 03:29:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:29:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:29:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:29:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:29:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:29:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:29:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:27 INFO - 'talos_options': ['--e10s'], 03:29:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:27 INFO - 'tests': ['damp', 'tps']}, 03:29:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:27 INFO - 'talos_options': ['--e10s'], 03:29:27 INFO - 'tests': ['damp', 'tps']}, 03:29:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:29:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:29:27 INFO - 'other': {'tests': ['a11yr', 03:29:27 INFO - 'ts_paint', 03:29:27 INFO - 'tpaint', 03:29:27 INFO - 'sessionrestore', 03:29:27 INFO - 'sessionrestore_no_auto_restore', 03:29:27 INFO - 'tabpaint']}, 03:29:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:29:27 INFO - 'tests': ['a11yr', 03:29:27 INFO - 'ts_paint', 03:29:27 INFO - 'tpaint', 03:29:27 INFO - 'sessionrestore', 03:29:27 INFO - 'sessionrestore_no_auto_restore', 03:29:27 INFO - 'tabpaint']}, 03:29:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:29:27 INFO - 'tests': ['a11yr', 03:29:27 INFO - 'ts_paint', 03:29:27 INFO - 'tpaint', 03:29:27 INFO - 'sessionrestore', 03:29:27 INFO - 'sessionrestore_no_auto_restore', 03:29:27 INFO - 'tabpaint']}, 03:29:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:29:27 INFO - 'tests': ['a11yr', 03:29:27 INFO - 'ts_paint', 03:29:27 INFO - 'tpaint', 03:29:27 INFO - 'sessionrestore', 03:29:27 INFO - 'sessionrestore_no_auto_restore', 03:29:27 INFO - 'tabpaint']}, 03:29:27 INFO - 'other_l64': {'tests': ['a11yr', 03:29:27 INFO - 'ts_paint', 03:29:27 INFO - 'tpaint', 03:29:27 INFO - 'sessionrestore', 03:29:27 INFO - 'sessionrestore_no_auto_restore', 03:29:27 INFO - 'tabpaint']}, 03:29:27 INFO - 'other_nol64': {'tests': ['a11yr', 03:29:27 INFO - 'ts_paint', 03:29:27 INFO - 'tpaint', 03:29:27 INFO - 'sessionrestore', 03:29:27 INFO - 'sessionrestore_no_auto_restore', 03:29:27 INFO - 'tabpaint']}, 03:29:27 INFO - 'svgr': {'tests': ['tsvgx', 03:29:27 INFO - 'tsvgr_opacity', 03:29:27 INFO - 'tart', 03:29:27 INFO - 'tscrollx', 03:29:27 INFO - 'cart']}, 03:29:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:29:27 INFO - 'tests': ['tsvgx', 03:29:27 INFO - 'tsvgr_opacity', 03:29:27 INFO - 'tart', 03:29:27 INFO - 'tscrollx', 03:29:27 INFO - 'cart']}, 03:29:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:27 INFO - 'tests': ['tp5o']}, 03:29:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:27 INFO - 'talos_options': ['--e10s'], 03:29:27 INFO - 'tests': ['tp5o']}, 03:29:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:27 INFO - 'talos_options': ['--xperf_path', 03:29:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:27 INFO - 'tests': ['tp5n']}, 03:29:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:27 INFO - 'talos_options': ['--e10s', 03:29:27 INFO - '--xperf_path', 03:29:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:27 INFO - 'tests': ['tp5n']}}, 03:29:27 INFO - 'talos.zip': {'path': '', 03:29:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:29:27 INFO - Running post-action listener: _resource_record_post_action 03:29:27 INFO - ##### 03:29:27 INFO - ##### Running create-virtualenv step. 03:29:27 INFO - ##### 03:29:27 INFO - Running pre-action listener: _resource_record_pre_action 03:29:27 INFO - Running main action method: create_virtualenv 03:29:27 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:29:27 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 03:29:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:29:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:29:27 INFO - Using real prefix '/usr' 03:29:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:29:28 INFO - Installing distribute.............................................................................................................................................................................................done. 03:29:30 INFO - Installing pip.................done. 03:29:30 INFO - Return code: 0 03:29:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:29:30 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')]} 03:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:30 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')]} 03:29:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:30 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 0x7fa4c96a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e920>, '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 0x1b9f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9fcb0>, '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': '745a4373a2a16df560f216e000000264-1457522952.410600-539033305', '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 03:29:30 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 03:29:30 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 03:29:30 INFO - Using env: {'DISPLAY': ':0', 03:29:30 INFO - 'HOME': '/home/cltbld', 03:29:30 INFO - 'LANG': 'en_US.UTF-8', 03:29:30 INFO - 'LANGUAGE': 'en_US:en', 03:29:30 INFO - 'LOGNAME': 'cltbld', 03:29:30 INFO - 'MAIL': '/var/mail/cltbld', 03:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:30 INFO - 'MOZ_NO_REMOTE': '1', 03:29:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:30 INFO - 'NO_EM_RESTART': '1', 03:29:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:29:30 INFO - 'PWD': '/builds/slave/test-pgo', 03:29:30 INFO - 'SHELL': '/bin/bash', 03:29:30 INFO - 'SHLVL': '1', 03:29:30 INFO - 'TERM': 'linux', 03:29:30 INFO - 'TMOUT': '86400', 03:29:30 INFO - 'USER': 'cltbld', 03:29:30 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457522952.410600-539033305', 03:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:30 INFO - '_': '/tools/buildbot/bin/python'} 03:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:30 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 03:29:30 INFO - Cleaning up... 03:29:30 INFO - Return code: 0 03:29:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:29:30 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')]} 03:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:30 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')]} 03:29:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:30 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 0x7fa4c96a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e920>, '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 0x1b9f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9fcb0>, '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': '745a4373a2a16df560f216e000000264-1457522952.410600-539033305', '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 03:29:30 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 03:29:30 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 03:29:30 INFO - Using env: {'DISPLAY': ':0', 03:29:30 INFO - 'HOME': '/home/cltbld', 03:29:30 INFO - 'LANG': 'en_US.UTF-8', 03:29:30 INFO - 'LANGUAGE': 'en_US:en', 03:29:30 INFO - 'LOGNAME': 'cltbld', 03:29:30 INFO - 'MAIL': '/var/mail/cltbld', 03:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:30 INFO - 'MOZ_NO_REMOTE': '1', 03:29:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:30 INFO - 'NO_EM_RESTART': '1', 03:29:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:29:30 INFO - 'PWD': '/builds/slave/test-pgo', 03:29:30 INFO - 'SHELL': '/bin/bash', 03:29:30 INFO - 'SHLVL': '1', 03:29:30 INFO - 'TERM': 'linux', 03:29:30 INFO - 'TMOUT': '86400', 03:29:30 INFO - 'USER': 'cltbld', 03:29:30 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457522952.410600-539033305', 03:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:30 INFO - '_': '/tools/buildbot/bin/python'} 03:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:30 INFO - Downloading/unpacking psutil>=0.7.1 03:29:30 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 03:29:30 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 03:29:30 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 03:29:30 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 03:29:30 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 03:29:30 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 03:29:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:29:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:32 INFO - Installing collected packages: psutil 03:29:32 INFO - Running setup.py install for psutil 03:29:32 INFO - building 'psutil._psutil_linux' extension 03:29:32 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 03:29:33 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 03:29:33 INFO - building 'psutil._psutil_posix' extension 03:29:33 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 03:29:33 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 03:29:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:33 INFO - Successfully installed psutil 03:29:33 INFO - Cleaning up... 03:29:33 INFO - Return code: 0 03:29:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:29: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')]} 03:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29: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')]} 03:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa4c96a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e920>, '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 0x1b9f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9fcb0>, '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': '745a4373a2a16df560f216e000000264-1457522952.410600-539033305', '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 03:29:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:29:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:29:33 INFO - Using env: {'DISPLAY': ':0', 03:29:33 INFO - 'HOME': '/home/cltbld', 03:29:33 INFO - 'LANG': 'en_US.UTF-8', 03:29:33 INFO - 'LANGUAGE': 'en_US:en', 03:29:33 INFO - 'LOGNAME': 'cltbld', 03:29:33 INFO - 'MAIL': '/var/mail/cltbld', 03:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:33 INFO - 'MOZ_NO_REMOTE': '1', 03:29:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:33 INFO - 'NO_EM_RESTART': '1', 03:29:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:29:33 INFO - 'PWD': '/builds/slave/test-pgo', 03:29:33 INFO - 'SHELL': '/bin/bash', 03:29:33 INFO - 'SHLVL': '1', 03:29:33 INFO - 'TERM': 'linux', 03:29:33 INFO - 'TMOUT': '86400', 03:29:33 INFO - 'USER': 'cltbld', 03:29:33 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457522952.410600-539033305', 03:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:33 INFO - '_': '/tools/buildbot/bin/python'} 03:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:29:33 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 03:29:33 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 03:29:33 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 03:29:33 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 03:29:33 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 03:29:33 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 03:29:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:29:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:29:35 INFO - Installing collected packages: mozsystemmonitor 03:29:35 INFO - Running setup.py install for mozsystemmonitor 03:29:35 INFO - Successfully installed mozsystemmonitor 03:29:35 INFO - Cleaning up... 03:29:35 INFO - Return code: 0 03:29:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:29:35 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')]} 03:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:35 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')]} 03:29:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:35 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 0x7fa4c96a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e920>, '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 0x1b9f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9fcb0>, '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': '745a4373a2a16df560f216e000000264-1457522952.410600-539033305', '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 03:29:35 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 03:29:35 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 03:29:35 INFO - Using env: {'DISPLAY': ':0', 03:29:35 INFO - 'HOME': '/home/cltbld', 03:29:35 INFO - 'LANG': 'en_US.UTF-8', 03:29:35 INFO - 'LANGUAGE': 'en_US:en', 03:29:35 INFO - 'LOGNAME': 'cltbld', 03:29:35 INFO - 'MAIL': '/var/mail/cltbld', 03:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:35 INFO - 'MOZ_NO_REMOTE': '1', 03:29:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:35 INFO - 'NO_EM_RESTART': '1', 03:29:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:29:35 INFO - 'PWD': '/builds/slave/test-pgo', 03:29:35 INFO - 'SHELL': '/bin/bash', 03:29:35 INFO - 'SHLVL': '1', 03:29:35 INFO - 'TERM': 'linux', 03:29:35 INFO - 'TMOUT': '86400', 03:29:35 INFO - 'USER': 'cltbld', 03:29:35 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457522952.410600-539033305', 03:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:35 INFO - '_': '/tools/buildbot/bin/python'} 03:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:35 INFO - Downloading/unpacking blobuploader==1.2.4 03:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:37 INFO - Downloading blobuploader-1.2.4.tar.gz 03:29:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:29:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:29:37 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 03:29:37 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 03:29:37 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 03:29:37 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 03:29:37 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 03:29:37 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 03:29:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:29:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:38 INFO - Downloading docopt-0.6.1.tar.gz 03:29:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:29:38 INFO - Installing collected packages: blobuploader, requests, docopt 03:29:38 INFO - Running setup.py install for blobuploader 03:29:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:29:38 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:29:38 INFO - Running setup.py install for requests 03:29:38 INFO - Running setup.py install for docopt 03:29:38 INFO - Successfully installed blobuploader requests docopt 03:29:38 INFO - Cleaning up... 03:29:39 INFO - Return code: 0 03:29:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:29: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')]} 03:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29: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')]} 03:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4c96a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e920>, '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 0x1b9f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9fcb0>, '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': '745a4373a2a16df560f216e000000264-1457522952.410600-539033305', '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 03:29:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:29:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:39 INFO - Using env: {'DISPLAY': ':0', 03:29:39 INFO - 'HOME': '/home/cltbld', 03:29:39 INFO - 'LANG': 'en_US.UTF-8', 03:29:39 INFO - 'LANGUAGE': 'en_US:en', 03:29:39 INFO - 'LOGNAME': 'cltbld', 03:29:39 INFO - 'MAIL': '/var/mail/cltbld', 03:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:39 INFO - 'MOZ_NO_REMOTE': '1', 03:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:39 INFO - 'NO_EM_RESTART': '1', 03:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:29:39 INFO - 'PWD': '/builds/slave/test-pgo', 03:29:39 INFO - 'SHELL': '/bin/bash', 03:29:39 INFO - 'SHLVL': '1', 03:29:39 INFO - 'TERM': 'linux', 03:29:39 INFO - 'TMOUT': '86400', 03:29:39 INFO - 'USER': 'cltbld', 03:29:39 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457522952.410600-539033305', 03:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:39 INFO - '_': '/tools/buildbot/bin/python'} 03:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:29:39 INFO - Running setup.py (path:/tmp/pip-82Qe4F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:29:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:29:39 INFO - Running setup.py (path:/tmp/pip-WatbOU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:29:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:29:39 INFO - Running setup.py (path:/tmp/pip-Xyb33w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:29:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:29:39 INFO - Running setup.py (path:/tmp/pip-gtDBsi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:29:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:29:39 INFO - Running setup.py (path:/tmp/pip-Z07mVU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:29:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:29:39 INFO - Running setup.py (path:/tmp/pip-SP5iaJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:29:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:29:39 INFO - Running setup.py (path:/tmp/pip-MsHGhn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:29:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:29:39 INFO - Running setup.py (path:/tmp/pip-XDPQUf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:29:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:29:39 INFO - Running setup.py (path:/tmp/pip-gn7ttG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:29:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:29:39 INFO - Running setup.py (path:/tmp/pip-E345V6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:29:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:29:39 INFO - Running setup.py (path:/tmp/pip-9aoJjC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:29:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:29:40 INFO - Running setup.py (path:/tmp/pip-SakKuO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:29:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:29:40 INFO - Running setup.py (path:/tmp/pip-sXKoYH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:29:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:29:40 INFO - Running setup.py (path:/tmp/pip-TJ2yX8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:29:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:29:40 INFO - Running setup.py (path:/tmp/pip-gnSbqx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:29:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:29:40 INFO - Running setup.py (path:/tmp/pip-wlU5om-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:29:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:29:40 INFO - Running setup.py (path:/tmp/pip-9ochUs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:29:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:29:40 INFO - Running setup.py install for manifestparser 03:29:40 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:29:40 INFO - Running setup.py install for mozcrash 03:29:40 INFO - Running setup.py install for mozdebug 03:29:40 INFO - Running setup.py install for mozdevice 03:29:40 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:29:40 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:29:40 INFO - Running setup.py install for mozfile 03:29:41 INFO - Running setup.py install for mozhttpd 03:29:41 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:29:41 INFO - Running setup.py install for mozinfo 03:29:41 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:29:41 INFO - Running setup.py install for mozInstall 03:29:41 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:29:41 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:29:41 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:29:41 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:29:41 INFO - Running setup.py install for mozleak 03:29:41 INFO - Running setup.py install for mozlog 03:29:41 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:29:41 INFO - Running setup.py install for moznetwork 03:29:41 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:29:41 INFO - Running setup.py install for mozprocess 03:29:41 INFO - Running setup.py install for mozprofile 03:29:41 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:29:41 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:29:41 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:29:41 INFO - Running setup.py install for mozrunner 03:29:41 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:29:41 INFO - Running setup.py install for mozscreenshot 03:29:42 INFO - Running setup.py install for moztest 03:29:42 INFO - Running setup.py install for mozversion 03:29:42 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:29:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:29:42 INFO - Cleaning up... 03:29:42 INFO - Return code: 0 03:29:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:29: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')]} 03:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29: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')]} 03:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:42 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 0x7fa4c96a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e920>, '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 0x1b9f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9fcb0>, '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': '745a4373a2a16df560f216e000000264-1457522952.410600-539033305', '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 03:29:42 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 03:29:42 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 03:29:42 INFO - Using env: {'DISPLAY': ':0', 03:29:42 INFO - 'HOME': '/home/cltbld', 03:29:42 INFO - 'LANG': 'en_US.UTF-8', 03:29:42 INFO - 'LANGUAGE': 'en_US:en', 03:29:42 INFO - 'LOGNAME': 'cltbld', 03:29:42 INFO - 'MAIL': '/var/mail/cltbld', 03:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:42 INFO - 'MOZ_NO_REMOTE': '1', 03:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:42 INFO - 'NO_EM_RESTART': '1', 03:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:29:42 INFO - 'PWD': '/builds/slave/test-pgo', 03:29:42 INFO - 'SHELL': '/bin/bash', 03:29:42 INFO - 'SHLVL': '1', 03:29:42 INFO - 'TERM': 'linux', 03:29:42 INFO - 'TMOUT': '86400', 03:29:42 INFO - 'USER': 'cltbld', 03:29:42 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457522952.410600-539033305', 03:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:42 INFO - '_': '/tools/buildbot/bin/python'} 03:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:29:42 INFO - Running setup.py (path:/tmp/pip-gjRrMv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:29:42 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)) 03:29:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:29:42 INFO - Running setup.py (path:/tmp/pip-CAI0o4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:29:42 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)) 03:29:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:29:42 INFO - Running setup.py (path:/tmp/pip-O3HegZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:29:42 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)) 03:29:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:29:42 INFO - Running setup.py (path:/tmp/pip-xttNMx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:29:42 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)) 03:29:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:29:42 INFO - Running setup.py (path:/tmp/pip-LNhWgw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:29:42 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)) 03:29:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:29:42 INFO - Running setup.py (path:/tmp/pip-RqZA27-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:29:42 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)) 03:29:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:29:42 INFO - Running setup.py (path:/tmp/pip-dgOWiL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:29:42 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)) 03:29:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:29:42 INFO - Running setup.py (path:/tmp/pip-VwNAeP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 03:29:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:29:43 INFO - Running setup.py (path:/tmp/pip-t_Nr8S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 03:29:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:29:43 INFO - Running setup.py (path:/tmp/pip-RvbpHu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:29:43 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)) 03:29:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:29:43 INFO - Running setup.py (path:/tmp/pip-eyCj2v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:29:43 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)) 03:29:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:29:43 INFO - Running setup.py (path:/tmp/pip-4gSmR5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:29:43 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)) 03:29:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:29:43 INFO - Running setup.py (path:/tmp/pip-qhCG8E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:29:43 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)) 03:29:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:29:43 INFO - Running setup.py (path:/tmp/pip-TEkyGN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:29:43 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)) 03:29:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:29:43 INFO - Running setup.py (path:/tmp/pip-pYjrRZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:29:43 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)) 03:29:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:29:43 INFO - Running setup.py (path:/tmp/pip-U8six9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:29:43 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)) 03:29:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:29:43 INFO - Running setup.py (path:/tmp/pip-FdogJm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:29:43 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)) 03:29:43 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)) 03:29:43 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)) 03:29:43 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)) 03:29:43 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)) 03:29:43 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)) 03:29:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:29:43 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 03:29:43 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 03:29:43 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 03:29:43 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 03:29:43 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 03:29:43 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 03:29:45 INFO - Downloading blessings-1.6.tar.gz 03:29:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:29:45 INFO - Installing collected packages: blessings 03:29:45 INFO - Running setup.py install for blessings 03:29:45 INFO - Successfully installed blessings 03:29:45 INFO - Cleaning up... 03:29:45 INFO - Return code: 0 03:29:45 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:29:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:29:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:29:46 INFO - Reading from file tmpfile_stdout 03:29:46 INFO - Current package versions: 03:29:46 INFO - argparse == 1.2.1 03:29:46 INFO - blessings == 1.6 03:29:46 INFO - blobuploader == 1.2.4 03:29:46 INFO - docopt == 0.6.1 03:29:46 INFO - manifestparser == 1.1 03:29:46 INFO - mozInstall == 1.12 03:29:46 INFO - mozcrash == 0.17 03:29:46 INFO - mozdebug == 0.1 03:29:46 INFO - mozdevice == 0.48 03:29:46 INFO - mozfile == 1.2 03:29:46 INFO - mozhttpd == 0.7 03:29:46 INFO - mozinfo == 0.9 03:29:46 INFO - mozleak == 0.1 03:29:46 INFO - mozlog == 3.1 03:29:46 INFO - moznetwork == 0.27 03:29:46 INFO - mozprocess == 0.22 03:29:46 INFO - mozprofile == 0.28 03:29:46 INFO - mozrunner == 6.11 03:29:46 INFO - mozscreenshot == 0.1 03:29:46 INFO - mozsystemmonitor == 0.0 03:29:46 INFO - moztest == 0.7 03:29:46 INFO - mozversion == 1.4 03:29:46 INFO - psutil == 3.1.1 03:29:46 INFO - requests == 1.2.3 03:29:46 INFO - wsgiref == 0.1.2 03:29:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4c96a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e920>, '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 0x1b9f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9fcb0>, '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': '745a4373a2a16df560f216e000000264-1457522952.410600-539033305', '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 03:29:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 03:29:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:46 INFO - Using env: {'DISPLAY': ':0', 03:29:46 INFO - 'HOME': '/home/cltbld', 03:29:46 INFO - 'LANG': 'en_US.UTF-8', 03:29:46 INFO - 'LANGUAGE': 'en_US:en', 03:29:46 INFO - 'LOGNAME': 'cltbld', 03:29:46 INFO - 'MAIL': '/var/mail/cltbld', 03:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:46 INFO - 'MOZ_NO_REMOTE': '1', 03:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:46 INFO - 'NO_EM_RESTART': '1', 03:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:29:46 INFO - 'PWD': '/builds/slave/test-pgo', 03:29:46 INFO - 'SHELL': '/bin/bash', 03:29:46 INFO - 'SHLVL': '1', 03:29:46 INFO - 'TERM': 'linux', 03:29:46 INFO - 'TMOUT': '86400', 03:29:46 INFO - 'USER': 'cltbld', 03:29:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457522952.410600-539033305', 03:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:46 INFO - '_': '/tools/buildbot/bin/python'} 03:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 03:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 03:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 03:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 03:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 03:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 03:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:29:46 INFO - Cleaning up... 03:29:46 INFO - Return code: 0 03:29:46 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4c96a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e920>, '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 0x1b9f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9fcb0>, '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': '745a4373a2a16df560f216e000000264-1457522952.410600-539033305', '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 03:29:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 03:29:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:29:46 INFO - Using env: {'DISPLAY': ':0', 03:29:46 INFO - 'HOME': '/home/cltbld', 03:29:46 INFO - 'LANG': 'en_US.UTF-8', 03:29:46 INFO - 'LANGUAGE': 'en_US:en', 03:29:46 INFO - 'LOGNAME': 'cltbld', 03:29:46 INFO - 'MAIL': '/var/mail/cltbld', 03:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:46 INFO - 'MOZ_NO_REMOTE': '1', 03:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:46 INFO - 'NO_EM_RESTART': '1', 03:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:29:46 INFO - 'PWD': '/builds/slave/test-pgo', 03:29:46 INFO - 'SHELL': '/bin/bash', 03:29:46 INFO - 'SHLVL': '1', 03:29:46 INFO - 'TERM': 'linux', 03:29:46 INFO - 'TMOUT': '86400', 03:29:46 INFO - 'USER': 'cltbld', 03:29:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457522952.410600-539033305', 03:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:46 INFO - '_': '/tools/buildbot/bin/python'} 03:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:46 INFO - Downloading/unpacking jsonschema 03:29:46 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 03:29:46 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 03:29:46 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 03:29:46 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 03:29:46 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 03:29:46 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 03:29:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:29:48 INFO - Downloading/unpacking functools32 (from jsonschema) 03:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:48 INFO - Downloading functools32-3.2.3-2.tar.gz 03:29:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:29:48 INFO - warning: no files found matching '*.txt' 03:29:48 INFO - no previously-included directories found matching 'build' 03:29:48 INFO - no previously-included directories found matching 'dist' 03:29:48 INFO - no previously-included directories found matching '.git*' 03:29:48 INFO - Installing collected packages: jsonschema, functools32 03:29:48 INFO - Running setup.py install for functools32 03:29:48 INFO - warning: no files found matching '*.txt' 03:29:48 INFO - no previously-included directories found matching 'build' 03:29:48 INFO - no previously-included directories found matching 'dist' 03:29:48 INFO - no previously-included directories found matching '.git*' 03:29:48 INFO - Successfully installed jsonschema functools32 03:29:48 INFO - Cleaning up... 03:29:48 INFO - Return code: 0 03:29:48 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:29: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')]} 03:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29: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')]} 03:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:48 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 0x7fa4c96a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9e920>, '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 0x1b9f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9fcb0>, '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': '745a4373a2a16df560f216e000000264-1457522952.410600-539033305', '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 03:29:48 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 03:29:48 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 03:29:48 INFO - Using env: {'DISPLAY': ':0', 03:29:48 INFO - 'HOME': '/home/cltbld', 03:29:48 INFO - 'LANG': 'en_US.UTF-8', 03:29:48 INFO - 'LANGUAGE': 'en_US:en', 03:29:48 INFO - 'LOGNAME': 'cltbld', 03:29:48 INFO - 'MAIL': '/var/mail/cltbld', 03:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:48 INFO - 'MOZ_NO_REMOTE': '1', 03:29:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:48 INFO - 'NO_EM_RESTART': '1', 03:29:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:29:48 INFO - 'PWD': '/builds/slave/test-pgo', 03:29:48 INFO - 'SHELL': '/bin/bash', 03:29:48 INFO - 'SHLVL': '1', 03:29:48 INFO - 'TERM': 'linux', 03:29:48 INFO - 'TMOUT': '86400', 03:29:48 INFO - 'USER': 'cltbld', 03:29:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457522952.410600-539033305', 03:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:48 INFO - '_': '/tools/buildbot/bin/python'} 03:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:48 INFO - Downloading/unpacking flake8 03:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:29:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:29:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:29:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:29:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:29:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:29:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:29:51 INFO - no previously-included directories found matching 'docs/_build' 03:29:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:29:51 INFO - Running setup.py install for pep8 03:29:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:29:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:29:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:29:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:29:51 INFO - no previously-included directories found matching 'docs/_build' 03:29:51 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:29:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:29:51 INFO - Cleaning up... 03:29:51 INFO - Return code: 0 03:29:51 INFO - Running post-action listener: _resource_record_post_action 03:29:51 INFO - Running post-action listener: _start_resource_monitoring 03:29:51 INFO - Starting resource monitoring. 03:29:51 INFO - ##### 03:29:51 INFO - ##### Running install step. 03:29:51 INFO - ##### 03:29:51 INFO - Running pre-action listener: _resource_record_pre_action 03:29:51 INFO - Running main action method: install 03:29:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:29:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:29:51 INFO - Reading from file tmpfile_stdout 03:29:51 INFO - Detecting whether we're running mozinstall >=1.0... 03:29:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:29:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:29:51 INFO - Reading from file tmpfile_stdout 03:29:51 INFO - Output received: 03:29:51 INFO - Usage: mozinstall [options] installer 03:29:51 INFO - Options: 03:29:51 INFO - -h, --help show this help message and exit 03:29:51 INFO - -d DEST, --destination=DEST 03:29:51 INFO - Directory to install application into. [default: 03:29:51 INFO - "/builds/slave/test-pgo"] 03:29:52 INFO - --app=APP Application being installed. [default: firefox] 03:29:52 INFO - mkdir: /builds/slave/test-pgo/build/application 03:29:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:29:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:30:07 INFO - Reading from file tmpfile_stdout 03:30:07 INFO - Output received: 03:30:07 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:30:07 INFO - Running post-action listener: _resource_record_post_action 03:30:07 INFO - ##### 03:30:07 INFO - ##### Running run-tests step. 03:30:07 INFO - ##### 03:30:07 INFO - Running pre-action listener: _resource_record_pre_action 03:30:07 INFO - Running main action method: run_tests 03:30:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:30:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:30:07 INFO - Python 2.7.3 03:30:07 INFO - Return code: 0 03:30:07 INFO - grabbing minidump binary from tooltool 03:30:07 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')]} 03:30:07 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 0x1b9e920>, '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 0x1b9f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9fcb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:30:07 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 03:30:07 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 03:30:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:30:07 INFO - Return code: 0 03:30:07 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:30:07 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:30:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:30:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:30:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:30:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:30:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:30:08 INFO - Return code: 0 03:30:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 03:30:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 03:30:08 INFO - Using env: {'DISPLAY': ':0', 03:30:08 INFO - 'HOME': '/home/cltbld', 03:30:08 INFO - 'LANG': 'en_US.UTF-8', 03:30:08 INFO - 'LANGUAGE': 'en_US:en', 03:30:08 INFO - 'LOGNAME': 'cltbld', 03:30:08 INFO - 'MAIL': '/var/mail/cltbld', 03:30:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:30:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:08 INFO - 'MOZ_NO_REMOTE': '1', 03:30:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:08 INFO - 'NO_EM_RESTART': '1', 03:30:08 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:30:08 INFO - 'PWD': '/builds/slave/test-pgo', 03:30:08 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:30:08 INFO - 'SHELL': '/bin/bash', 03:30:08 INFO - 'SHLVL': '1', 03:30:08 INFO - 'TERM': 'linux', 03:30:08 INFO - 'TMOUT': '86400', 03:30:08 INFO - 'USER': 'cltbld', 03:30:08 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457522952.410600-539033305', 03:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:08 INFO - '_': '/tools/buildbot/bin/python'} 03:30:08 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 03:30:08 INFO - mozversion application_buildid: 20160309004036 03:30:08 INFO - mozversion application_changeset: ce9a5e723e4b21ce0dac5ede64e156023bb70534 03:30:08 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:30:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:30:08 INFO - mozversion application_name: Firefox 03:30:08 INFO - mozversion application_remotingname: firefox-dev 03:30:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:30:08 INFO - mozversion application_vendor: Mozilla 03:30:08 INFO - mozversion application_version: 47.0a2 03:30:08 INFO - mozversion platform_buildid: 20160309004036 03:30:08 INFO - mozversion platform_changeset: ce9a5e723e4b21ce0dac5ede64e156023bb70534 03:30:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:30:08 INFO - mozversion platform_version: 47.0a2 03:30:08 INFO - using testdate: 1457523008 03:30:08 INFO - actual date: 1457523008 03:30:08 INFO - starting webserver on 'localhost:59723' 03:30:08 INFO - SUITE-START | Running 2 tests 03:30:08 INFO - TEST-START | dromaeo_css 03:30:08 INFO - operating with platform_type : linux_ 03:30:08 INFO - Initialising browser for dromaeo_css test... 03:30:08 INFO - TEST-INFO | started process 28669 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHimgHU/profile http://localhost:59723/getInfo.html) 03:30:12 INFO - PROCESS | 28669 | 03:30:12 INFO - PROCESS | 28669 | (process:28744): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:30:13 INFO - PROCESS | 28669 | __metrics Screen width/height:1600/1200 03:30:13 INFO - PROCESS | 28669 | colorDepth:24 03:30:13 INFO - PROCESS | 28669 | Browser inner width/height: 1024/697 03:30:13 INFO - PROCESS | 28669 | __metrics 03:30:14 ERROR - PROCESS | 28669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:30:15 INFO - TEST-INFO | 28669: exit 0 03:30:15 INFO - Browser initialized. 03:30:15 INFO - Running cycle 1/1 for dromaeo_css test... 03:30:15 INFO - TEST-INFO | started process 28795 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHimgHU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:30:17 INFO - PROCESS | 28795 | 03:30:17 INFO - PROCESS | 28795 | (process:28863): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:30:27 INFO - PROCESS | 28795 | RSS: Main: 154316800 03:30:27 INFO - PROCESS | 28795 | 03:31:16 INFO - PROCESS | 28795 | 1457523076757 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] 03:33:24 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:59723/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59723/tests/dromaeo/cssquery-ext.html) 03:33:25 INFO - PROCESS | 28795 | RSS: Main: 157405184 03:33:25 INFO - PROCESS | 28795 | 03:36:27 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:59723/tests/dromaeo/cssquery-ext.html (next: http://localhost:59723/tests/dromaeo/cssquery-jquery.html) 03:36:28 INFO - PROCESS | 28795 | RSS: Main: 154783744 03:36:28 INFO - PROCESS | 28795 | 03:39:30 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:59723/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59723/tests/dromaeo/cssquery-mootools.html) 03:39:30 INFO - PROCESS | 28795 | RSS: Main: 155529216 03:39:30 INFO - PROCESS | 28795 | 03:42:32 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:59723/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59723/tests/dromaeo/cssquery-prototype.html) 03:42:33 INFO - PROCESS | 28795 | RSS: Main: 154714112 03:42:33 INFO - PROCESS | 28795 | 03:45:35 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:59723/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59723/tests/dromaeo/cssquery-yui.html) 03:45:35 INFO - PROCESS | 28795 | RSS: Main: 156307456 03:45:35 INFO - PROCESS | 28795 | 03:48:37 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:59723/tests/dromaeo/cssquery-yui.html (next: http://localhost:59723/tests/dromaeo/cssquery-dojo.html) 03:48:38 INFO - PROCESS | 28795 | RSS: Main: 158179328 03:48:38 INFO - PROCESS | 28795 | 03:48:38 INFO - PROCESS | 28795 | __start_tp_report 03:48:38 INFO - PROCESS | 28795 | _x_x_mozilla_page_load 03:48:38 INFO - PROCESS | 28795 | _x_x_mozilla_page_load_details 03:48:38 INFO - PROCESS | 28795 | |i|pagename|runs| 03:48:38 INFO - PROCESS | 28795 | |0;dojo.html;3339.883104091357;3370.6123795763488;3391.677790609894;3409.624941256461;3430.0738800523845;5542.251796007537;5561.082421400469;5589.608727389079;5602.7758889644465;5631.633943793656;5564.638298510604;5566.610337276392;5584.581156413265;5590.720463976805;5598.076317407633;5045.445001049881;5119.257707632391;5144.717040562768;5150.665206761549;5183.17069268917;5012.198048312271;5118.360204974379;5186.636935414523;5191.714455704935;5204.791808327663;5083.84748457545;5141.331626888518;5149.922751158736;5202.635815492917;5217;5108.080545501808;5154.639175257734;5161.458046905059;5171.974140129294;5201.609879259033;4887.902241955141;4931.80272789088;5050.747462626854;5082.4663410341755;5120.1039818031695;5293.735313234323;5320.414754377015;5325.4142044375085;5334.959682861843;5358.866028349284;5860.208871802295;5898.852528686817;5910.8817823643285;5914.260717410324;5928.170056192136;5833.387494313079;5938.435848594377;6001.06983417571;6018.337982821886;6018.8194354169445;5552.7223638817895;5623.943760562423;5632.774689012475;5634.408387119375;5635.295588051494;5952.851178720567;6127.938720612737;6138.693065346715;6153.815385538441;6158.7228574714245;5907.734151963086;5956.52347812174;5960.37416071315;5965.582409231312;5999.130126131774;5991.951408503494;5992.820215393545;5993.550483713739;6002.819915402458;6015.127806468037;5751.712414379264;5916.319623243296;5921.940780592225;5927.199828023248;5930.318013428425;5931.940680593225;5954.374790647006;5984.072468767348;5985.25184351956;6019.157317975487;4510.233260345749;4541.182587134282;4545.727256364563;4547.590716835434;4564.543545645475;4022.7586344819406;4022.7988600569856;4027.81874815634;4053.8783836484363;4111.732737372061;5473.06957817172;5643.435656434406;5647.1529270609735;5727.05503591911;5776.653400795965;5975.103734439782;5976.223090998143;5979.312379076375;5987.820365389045;5991.400859913973;5558.944410555923;5643.80246691372;5664.235328230719;5684.289463817023;5695.914561281584;5093.2360145977655;5113.105206588906;5170;5172.991266702957;5173.224016397495;6163.8150855474405;6253.843653908689;6271.529635277281;6271.62370257786;6284.245890493079;5858.619189752652;6015.578909476295;6042.607230530001;6070.848228794315;6078.209832721718;6134.375358695336;6170.568060235741;6178.474829639351;6223.688815559294;6224.284207316216;5896;5925.564878320551;5979.641221526722;5983.192269043623;5994;5947.405259474018;6006.189164462741;6064.605800622945;6069.757209711562;6080.543959202989;5886.735096920564;5888.793892213752;5890.087036509348;5924.7926322578505;5952.732127054206;5901.262342207224;5903.91144132847;5907.704614769158;5909.940900590939;5911.201987731602;5635.774569017357;5826.621269617462;5831.562632802472;5840.415958404295;5866.472017518444;5878.3239927408895;5898.970505147447;5921.822345329647;5929.318128415115;5931.733072011683;5737.627054241461;5748.45389687979;5767.163761254678;5780.132980053026;5786.537077033743 03:48:38 INFO - PROCESS | 28795 | |1;ext.html;532.1034057612923;567.8580354911271;577.7515668262647;585.9209006784083;587.6297932302649;31292.84353578232;39242.803785981065;39710.8014459928;39947.20105597886;40068.39897401534;41727;41786.373204401956;42130.15739685212;42507.787461062726;42568;8786.6924657637;8962.910370896305;8966.103389661046;8972.461652300883;9031.367804253705;8722.825543489158;8774.385792994493;8837.204651581356;8858.689945851896;8869.423487473327;8812.911870881273;8956.373053886231;8956.417832840845;8964.820703585925;8965.775855603597;8890.777730556756;8954.820903581956;8957.462552246854;9100.681476148304;9154.084591540859;8963.372563920528;9113.0886911309;9172.036936121745;9179.81640367189;9185.724428267162;42311.1537769246;42412;42585.787071064755;42675;42781.786091069655;3729.589745128034;3791.109089363997;3857.787821669807;3950.111224974358;4277.657787377002;31731.682683173105;31819.204519886956;32017.199570010704;32101;32936.176595585064;4080.6939479538855;4129.545749967501;4151.584841515854;4167.979160104211;4168.874933751992;217623;222906;224328;225066;225505;63976.36023639704;71999;72155.63922180461;72708.27291727121;72890;75745.24254757381;76623.61688191524;78233.60883195662;78455;79120.20879791243;16097;16294.42969496062;16329.918350408172;16388.590285242724;16512.25694843735;12823.679408014874;12938.09433339676;12965.870341296655;13071.346432678329;13166.407511661999;22825.20111796079;23081.07675692987;23226.53546929052;23285.883570582377;23373;9047.638094476279;9346.719598412059;9525.190358819578;9559.808803824024;9636.566354514063;1010.2524132142162;1081.551156270139;1123.2811000959393;1131.1572878205789;1216.0028776403265;30048.248793779894;30207.395852083275;30225.395492090036;30487.085387438412;30582.69417305843;1126.380490730095;1142.114860982745;1209.0810983652486;1214.6356093172012;1247.289045244202;15490.535283941499;15532.534023979299;15605.453809116854;15787.763183552255;15977.680446391007;355996;521175;521824;524673;525855;54700.179497307574;55280;55702;55722.72138639362;55745.721271393384;1478.9334479948427;1511.1613054754496;1519.270750039965;1523.5886310696271;1534.4245907784805;30161.69838301589;30481.54277685881;30882.53676194904;31002.224944376572;31246.37507249797;48879.266810998575;48975.510244897094;49243.50756492533;49480.50519494903;49710.25434618556;315321;318406;318995;319734;319777;34454.82772586121;34537;35208.823955880056;35314.293714126085;35642.64357356393;44226;44758.36801834437;44990.550094499944;44991.77504112459;45250.54749452595;38306;38404;38545;38738.41892371673;39647;37771.2445751078;37842.621573785014;38602.227955440176;38782.41826372663;39157;37796.055098621655;38219;38332.80833595926;38513.614863851006;38658.613413866624;33246.00261992144;34412.13969650779;34507;34559;34739.305213896085;25965.22104336873;26509.867450662623;26960.460790783683;27108.051218207267;27149.321266968484 03:48:38 INFO - PROCESS | 28795 | |2;jquery.html;371.8902923637527;373.25908072476113;373.74211793862236;374.880038387716;380.708757800283;17649.29402823887;17930.641387172247;18568.907155464236;18571.90714046428;18657.34699285525;17379.91310043448;17922.19350129244;18033.63932721345;18086.5478363041;18102.81897181031;5671.7164141793055;5884.529237660977;5901.4098590141075;5908.438698323653;5911.46796788289;4209.810558524874;5776.971115144418;6243.56295059346;6465.159529261189;6503.869922601545;6428.164338635971;6456.35436456353;6457.418832305091;6461.450776683988;6470.450011749007;6696.062551242806;6936.028955946172;6940.687669054904;6990.056342393788;7007.299270072952;6245.281792593864;6431.517636177258;6699.5310328276555;6729.32706729328;6729.495287853381;24491.87754061236;24975.250742477754;25059.87470062638;25503.617445738328;25592.104276350237;2510.4602510460154;2529.848209107441;2593.351662084479;2617.9607305890427;2726.9590956135676;14023.228722420263;14688.779668304984;14878.256087195598;14975.715056664829;15355.616109597238;1990.9004549772453;2099.653557163066;2112.7781582933876;2118.8199003084756;2135.0178917697876;74655;76306.23693763102;76337;76856.61571692162;77605;15723.606909827346;17122.14389280531;17167.227474763415;17194.39819606333;17218.31126754941;26924.057657981877;26926.92292308325;27138;27308.726912731017;27324.180274591796;9297.442153470813;9612.615495380247;9623.470709110927;9635.518224088768;9684.95157524208;8240.62917168729;8248.381371397169;8413.747587572383;8482.406231563855;8513.914860851311;8400.663973441116;8471.703490377808;8516.787080323042;8563.529005904735;8666.176713212235;1967.1836187982112;1989.4529004523583;1991.830694390993;2017.0519855667812;3227.499737540685;955.6273053509137;1005.7385079879137;1008.9142422893989;1063.7819247054335;1104.779567560568;16093.839061609468;16621.91957522757;17308.048057356966;17424.47726568205;17598.416778960695;1015.9796804064025;1023.5701005577675;1042.744527590745;1048.5438834107188;1095.808233559124;9967.501624918725;10041.397516149054;10121.898781012243;10137.543810528545;10364.896351036394;364125;365451;422070;428039;431052;78240;79156;80314;80494;82207.58896205481;1023.3348323589578;1058.4760543530847;1068.273573969708;1068.9358638481715;1075.5267682219642;16162.515124546282;16328.755068674218;16358.182090895645;16396.180190990643;16770.664586707953;33688.326233474705;34431.483527746605;34933.47599786056;35071.47392789161;36004;48519.51480485291;49125.263121053926;49356;49393.50606494033;49664;8278.130796266305;8385.83228335442;8445.746627601182;8517.531535765593;8558.443701159405;10046.949765251127;12826.294553799631;12983;13101;13215.207087574776;11050.889491105308;11236.94381528087;11403.828942566033;11482.196246262682;11509.712257193638;11005.559777609125;11006.779864402828;11313.943430282796;11376.089912807121;11575.652730418102;11118.49966751482;11156.44217789091;11349.54601815918;11386.43067846621;11873.881261187624;8187.754367368989;8249.381296402673;8365.749027529184;8482.024567174607;8505.23452889243;10475.413424608272;10599.993000664925;10913.508892099715;11015.449227538431;11106.333619982826 03:48:38 INFO - PROCESS | 28795 | |3;mootools.html;1568.6784209237107;1582.6992871354441;1793.1392931392922;1813.791413987391;1924.7594050743658;7227.9277207227915;7893.763187104396;8017.639206235719;8165.34677225822;8199.549024803633;7993.080795708495;8029.959850200756;8061.274485296322;8073.11195768465;8092.91907080929;2399.328188107324;2423.127674037345;2424.5150969806023;2425.223928342931;2428.5264373447185;2360.704911886014;2409.6024156014237;2445.9266222013366;2447.68180136582;2449.1672831237374;2417.613181890898;2425.0663494554638;2434.087217293515;2445.4742230420457;2462.926112216627;2316.4324740438615;2332.1371092695726;2345.741968383468;2396.2332053742807;2464.6549483072386;2388.3432056184515;2391.8564886106715;2395.6885604871254;2400.291913885408;2405.1341517053847;8211.95894020532;8281.130481299437;8292.958535207346;8297.502149871027;8299;5061.848144555669;5159.406668233164;5173.379194496684;5179.456157103487;5193.272941788153;3201.8719251229923;3232.3858466891215;3280.327532855759;3317.286783341593;3317.552130462405;1040.5993692428394;1089.5641743302663;1089.7493576477455;1119.121489630636;1128.4752590045587;11585.478653460614;11623.360715160663;11643.767124657545;11657.650270491898;11661.24201926872;4536.705114167568;4616.030633566988;4620.491745907947;4621.2837010263465;4642.814287428465;9907.752306192258;9910.405375677483;9919.801603968024;9926.156276716416;9936.950315248378;5166.147585648326;5167.121589329823;5206.817761378334;5216.087184742655;5221.451747566527;4083.3466645336603;4506.3916371290115;4529.365888775574;4545.272756358967;4702.6473014524045;3887.3197190492115;3887.5140607424073;3931.7051221158526;3955.2287303976022;3974.1455587048345;1223.920445171061;1230.347915604713;1237.8762123787728;1239.5165885304739;1251.499400239893;1164.1792536261914;1185.7924863148914;1188.44737197202;1196.234409977615;1216.7809794237123;7600.695972161052;7630.046244219473;7688.923110768933;7721.266479684421;7751.418643601753;1203.7171264752776;1206.6561030106377;1226.3561630144245;1228.9446974886152;1245.7446223524155;6179.3202747697715;6211.720472578745;6236.844078898064;6290.779822706183;6304.211973503312;9623.855642165374;9962.651307204213;10002.549885255181;10071.34536255141;10124.291299609104;9804.166645835041;9958.50207489637;9978.201743860474;9995.350302230332;10141.391516508886;7905.762827115311;7964.123946365895;7977.3219276361;7984.281414672707;8024.876517287585;7558.735444259424;7660.693572257047;7678.155402905788;7680.155182929985;7776.066871975399;8757.868631970652;8810.515421651871;8974.14745599167;8978.281737460857;9010.954945225232;8664.090270521505;8836.734897953073;9109.22571581423;9214.2628589714;9339.813203736023;6858.5199036067;6929.821930271765;6943.9652801735665;7133.251008644018;7251.637418129178;7885.684572617031;7889.881651775113;7895.802604934923;7918.881216781638;7922.445428819928;7074.221835597978;7082.114735658043;7153.856922861618;7253.746118885813;7277.636118194175;6852.109225800813;6895.4138898194215;6897.241303456716;6965.024896514391;7025.473089518205;7064.4048876751895;7384.815379615553;7448.813779655552;7459.142198647008;7465.141508726349;7045.330693584101;7047.224805271314;7081.964590177016;7095.574265544084;7105.2894710528535;7086.681099350645;7096.361327480551;7155.105611798525;7158.713651453883;7175.964120179366 03:48:38 INFO - PROCESS | 28795 | |4;prototype.html;355.5378008588834;356.75918754840507;357.9767315124517;360.57092060448065;361.47405524961187;6331.588446750958;6352.078948552463;6441.484681225503;6490.091387205795;6511.706973186207;6291.465225455841;6304;6307.463865571421;6307.558470907038;6311.684415779216;4695.859124226278;4791.209450440673;4851;4872.147374209517;4888.608911287106;4854.247591623304;4859.489753575876;4860.829870954517;4862.100511405383;4870.537298956593;4798.0643774464;4803.423589169304;4809.422869255694;4817.22924332107;4823.614110871122;4813.037392521493;4828.975855120737;4831.516848315158;4837.274408838667;4841.515848415165;4187.539370669255;4200.915981680349;4210.578942105765;4215.114825886568;4220.324748040299;5888.5289176865745;6000.579959402844;6019.668918209497;6033.5173186145;6033.637981721111;5599.244102046212;5649.576281778842;5650.3219613646215;5660.179274005246;5663.801766938137;6633.701483433257;6743.426808721216;6760.729570817161;6761.290064543201;6763.323667633246;4649.232876575361;4654.115718013567;4654.441467023945;4654.627629789608;4656.627469802408;6980.581165130057;7019.122609673791;7058.011878336985;7069.116360454943;7077.07997960267;4578.496365399803;4748.358971538798;4758.500357462417;4767.713937163781;4779.713217206979;4707.03505781314;4752.952470475251;4767.928481072787;4768.332433459318;4770.737609431515;5594.216809646653;5603.187537806995;5607.4112218217315;5607.607467477237;5613.522850557748;6743.460523158135;6764.086848275519;6766.966165169143;6774.8645027100165;6784.423324017514;1686.148495010012;1703.5485596316985;1704.4375356132446;1707.1805533344063;1710.2133018811237;1107.9778404431866;1127.3292391027326;1132.8300754886832;1136.7499150186945;1160.3212120909193;6533.575317604341;6544.247411547733;6554.63949482783;6556.967215163893;6573.934260657428;6986.056882320923;6986.336298051677;6996.090508233999;7001.334873187039;7019.262977387403;6357.491400688026;6541.542092053511;6634.336566343423;6634.701438435282;6641.169853768279;3784.243151369737;3792.089898424358;3808.2383523295453;3813.9618603813606;3814.6185381461632;7327.780166594904;7356.96321518389;7374.373178279799;7376.262373762581;7410.258974102654;7243.89134162988;7245.384142347854;7249.673764680602;7252.311030452099;7257.201707812136;7129.679164437613;7338.376238019828;7421.257874212643;7423.925760742323;7428.182899881009;6999.405050570758;7029.3673569379;7035.859282814213;7051.189113252041;7072.186698529735;6952.409045231212;6961.8955715665315;6962.094927659372;6967.756128535477;6971.965140174267;7388.741394051182;7400.40796736249;7413.628478731452;7417;7422.480426370103;4559.817607295804;4679.2045352289515;4680.672352935262;4697.177993850994;4725.267583524559;6913.75801846933;6979;7002.684879180347;7015.894761578683;7023.648817559204;6736.32636736342;6764.425023872829;6771.45828333742;6791;6797.150356205474;6687.130673012477;6728.629925354153;6793.830154246183;6795.592264464148;6796.524243303119;6487.837804054936;6681.799546013627;6774.119364482585;6794.966025169842;6797.218319893275;6836.38472537474;6870.553414028072;6896.103506544117;6901.1718593769065;6919.238883722685;6656.001599760075;6664.866702666017;6712.885441086042;6713;6729.596224226562 03:48:38 INFO - PROCESS | 28795 | |5;yui.html;773.8877862709905;776.7708525984834;792.1880072925252;859.7034023261976;924.2328867040353;15865.286062127203;15897.1256580888;15913.204339783008;15936.203189840491;15945;14877.553673389788;15674.764878526803;16168.676626467493;16177.83822161778;16247.106409147493;903.0743487924881;917.5779141594875;919.3932004876783;919.995400022999;921.9861702074475;856.8286342731448;925.5788616179622;929.7722058095742;930.7068273493861;931.1293940165966;932.6782260120248;945.4610871803075;948.6300342866288;951.4386511957944;952.5142177489496;932.4824722279133;943.2218419803621;948.6679662118307;950.9444516586583;954.9474778887159;690.7582346178797;698.4482259015372;701.7228194863052;703.8873780195196;710.1797423975316;15519.224038798127;15747.842521574752;15885.92057039719;15917.602059948595;16018.5995350116;13807.240601766898;13860.306984650828;13895.861041389659;13980.860191398058;14004.089734167246;11480.827787583194;11749.471273792615;11851.88148118525;11896.524139034429;11939.34333611651;3889.0666240102455;3921.509811273591;3932.7443716158646;3940.9014774630577;3965.5637879833193;53531;54147.45852541503;54348.72825635886;54396.18405723957;54450;11214;11305.943470282597;11382.54469821198;11397.886021139848;11508.769824603462;19813.405597832087;19816;19870.205191792167;19895.403137905887;19916.103775330146;8139.552324622085;8227.053888802864;8273.296769774517;8320.334373250125;8617.052124266325;4311.849085282063;4448.55514448559;4613.446386433649;4783.856484305476;4852.563269305709;3372.1906742381652;3443.9311213775586;3460.048486666137;3466.0814884055744;3468.2369878627164;659.953803233769;666.9333066693292;677.8169894128557;679.67035987546;687.3779229797042;657.3951964192954;672.6166085331412;685.869684759894;775.7711475114854;781.6873250699765;9271.490068046322;9347.345685801929;9499.43003419797;9564.282678799118;9681.51592420376;608.7291155435788;671.2817285504464;724.1274264511251;730.087390761548;751.744406901656;4544.454665440168;4568.543145685471;4595.425571803525;4633.305004249322;4667.206574882278;63676.68161659162;63703.6814815923;64055.35944640494;64066.6796666023;67642;53624.19563706547;54912.176317354475;55226.72386638122;55273.44726552683;55773;48697.756511217216;48968.5103148964;49570;49579.50420495821;50597;8922.910770892207;8957.417767845069;8979.32655050887;9113.954430227806;9208.677696280598;37465.43801843029;38070.61929380671;38122.046948825395;38262.42606360962;39131.21737565176;43372;43616;45882.311765324215;46823.29765053595;47182.76408617935;10928.453577321261;11262.605808796652;11399;11476.770464590829;11485.310881347146;13050;13413.195208287534;13492.662683432993;13858.584242472742;14099.295035248402;12129.21160124589;12255;12296.938515307365;12401.317927514074;13113.475460981454;10991.835122473329;11034.393108379116;11264.155188360743;11485.138614604106;11539.19225654196;11902.940485297864;11924.701882453008;11943.402829858645;11957.162998590014;12025.699357516132;10755.89812198608;10806.567737290734;10912;11095.278806877526;11138.498767555642;10167;10805;10811.405372704263;11008.614698485515;11377.374244416636 03:48:38 INFO - PROCESS | 28795 | __end_tp_report 03:48:38 INFO - PROCESS | 28795 | __start_cc_report 03:48:38 INFO - PROCESS | 28795 | _x_x_mozilla_cycle_collect,331 03:48:38 INFO - PROCESS | 28795 | __end_cc_report 03:48:38 INFO - PROCESS | 28795 | __startTimestamp1457524118223__endTimestamp 03:48:38 INFO - PROCESS | 28795 | 03:48:38 INFO - PROCESS | 28795 | ------- Summary: start ------- 03:48:38 INFO - PROCESS | 28795 | Number of tests: 6 03:48:38 INFO - PROCESS | 28795 | 03:48:38 INFO - PROCESS | 28795 | [#0] dojo.html Cycles:165 Average:5564.93 Median:5826.62 stddev:621.00 (10.7%) stddev-sans-first:597.87 03:48:38 INFO - PROCESS | 28795 | Values: 3339.9 3370.6 3391.7 3409.6 3430.1 5542.3 5561.1 5589.6 5602.8 5631.6 5564.6 5566.6 5584.6 5590.7 5598.1 5045.4 5119.3 5144.7 5150.7 5183.2 5012.2 5118.4 5186.6 5191.7 5204.8 5083.8 5141.3 5149.9 5202.6 5217.0 5108.1 5154.6 5161.5 5172.0 5201.6 4887.9 4931.8 5050.7 5082.5 5120.1 5293.7 5320.4 5325.4 5335.0 5358.9 5860.2 5898.9 5910.9 5914.3 5928.2 5833.4 5938.4 6001.1 6018.3 6018.8 5552.7 5623.9 5632.8 5634.4 5635.3 5952.9 6127.9 6138.7 6153.8 6158.7 5907.7 5956.5 5960.4 5965.6 5999.1 5992.0 5992.8 5993.6 6002.8 6015.1 5751.7 5916.3 5921.9 5927.2 5930.3 5931.9 5954.4 5984.1 5985.3 6019.2 4510.2 4541.2 4545.7 4547.6 4564.5 4022.8 4022.8 4027.8 4053.9 4111.7 5473.1 5643.4 5647.2 5727.1 5776.7 5975.1 5976.2 5979.3 5987.8 5991.4 5558.9 5643.8 5664.2 5684.3 5695.9 5093.2 5113.1 5170.0 5173.0 5173.2 6163.8 6253.8 6271.5 6271.6 6284.2 5858.6 6015.6 6042.6 6070.8 6078.2 6134.4 6170.6 6178.5 6223.7 6224.3 5896.0 5925.6 5979.6 5983.2 5994.0 5947.4 6006.2 6064.6 6069.8 6080.5 5886.7 5888.8 5890.1 5924.8 5952.7 5901.3 5903.9 5907.7 5909.9 5911.2 5635.8 5826.6 5831.6 5840.4 5866.5 5878.3 5899.0 5921.8 5929.3 5931.7 5737.6 5748.5 5767.2 5780.1 5786.5 03:48:38 INFO - PROCESS | 28795 | 03:48:38 INFO - PROCESS | 28795 | [#1] ext.html Cycles:180 Average:52546.00 Median:38698.52 stddev:96313.05 (248.9%) stddev-sans-first:96504.06 03:48:38 INFO - PROCESS | 28795 | Values: 532.1 567.9 577.8 585.9 587.6 31292.8 39242.8 39710.8 39947.2 40068.4 41727.0 41786.4 42130.2 42507.8 42568.0 8786.7 8962.9 8966.1 8972.5 9031.4 8722.8 8774.4 8837.2 8858.7 8869.4 8812.9 8956.4 8956.4 8964.8 8965.8 8890.8 8954.8 8957.5 9100.7 9154.1 8963.4 9113.1 9172.0 9179.8 9185.7 42311.2 42412.0 42585.8 42675.0 42781.8 3729.6 3791.1 3857.8 3950.1 4277.7 31731.7 31819.2 32017.2 32101.0 32936.2 4080.7 4129.5 4151.6 4168.0 4168.9 217623.0 222906.0 224328.0 225066.0 225505.0 63976.4 71999.0 72155.6 72708.3 72890.0 75745.2 76623.6 78233.6 78455.0 79120.2 16097.0 16294.4 16329.9 16388.6 16512.3 12823.7 12938.1 12965.9 13071.3 13166.4 22825.2 23081.1 23226.5 23285.9 23373.0 9047.6 9346.7 9525.2 9559.8 9636.6 1010.3 1081.6 1123.3 1131.2 1216.0 30048.2 30207.4 30225.4 30487.1 30582.7 1126.4 1142.1 1209.1 1214.6 1247.3 15490.5 15532.5 15605.5 15787.8 15977.7 355996.0 521175.0 521824.0 524673.0 525855.0 54700.2 55280.0 55702.0 55722.7 55745.7 1478.9 1511.2 1519.3 1523.6 1534.4 30161.7 30481.5 30882.5 31002.2 31246.4 48879.3 48975.5 49243.5 49480.5 49710.3 315321.0 318406.0 318995.0 319734.0 319777.0 34454.8 34537.0 35208.8 35314.3 35642.6 44226.0 44758.4 44990.6 44991.8 45250.5 38306.0 38404.0 38545.0 38738.4 39647.0 37771.2 37842.6 38602.2 38782.4 39157.0 37796.1 38219.0 38332.8 38513.6 38658.6 33246.0 34412.1 34507.0 34559.0 34739.3 25965.2 26509.9 26960.5 27108.1 27149.3 03:48:38 INFO - PROCESS | 28795 | 03:48:38 INFO - PROCESS | 28795 | [#2] jquery.html Cycles:180 Average:26356.02 Median:14771.01 stddev:66428.88 (449.7%) stddev-sans-first:66586.58 03:48:38 INFO - PROCESS | 28795 | Values: 371.9 373.3 373.7 374.9 380.7 17649.3 17930.6 18568.9 18571.9 18657.3 17379.9 17922.2 18033.6 18086.5 18102.8 5671.7 5884.5 5901.4 5908.4 5911.5 4209.8 5777.0 6243.6 6465.2 6503.9 6428.2 6456.4 6457.4 6461.5 6470.5 6696.1 6936.0 6940.7 6990.1 7007.3 6245.3 6431.5 6699.5 6729.3 6729.5 24491.9 24975.3 25059.9 25503.6 25592.1 2510.5 2529.8 2593.4 2618.0 2727.0 14023.2 14688.8 14878.3 14975.7 15355.6 1990.9 2099.7 2112.8 2118.8 2135.0 74655.0 76306.2 76337.0 76856.6 77605.0 15723.6 17122.1 17167.2 17194.4 17218.3 26924.1 26926.9 27138.0 27308.7 27324.2 9297.4 9612.6 9623.5 9635.5 9685.0 8240.6 8248.4 8413.7 8482.4 8513.9 8400.7 8471.7 8516.8 8563.5 8666.2 1967.2 1989.5 1991.8 2017.1 3227.5 955.6 1005.7 1008.9 1063.8 1104.8 16093.8 16621.9 17308.0 17424.5 17598.4 1016.0 1023.6 1042.7 1048.5 1095.8 9967.5 10041.4 10121.9 10137.5 10364.9 364125.0 365451.0 422070.0 428039.0 431052.0 78240.0 79156.0 80314.0 80494.0 82207.6 1023.3 1058.5 1068.3 1068.9 1075.5 16162.5 16328.8 16358.2 16396.2 16770.7 33688.3 34431.5 34933.5 35071.5 36004.0 48519.5 49125.3 49356.0 49393.5 49664.0 8278.1 8385.8 8445.7 8517.5 8558.4 10046.9 12826.3 12983.0 13101.0 13215.2 11050.9 11236.9 11403.8 11482.2 11509.7 11005.6 11006.8 11313.9 11376.1 11575.7 11118.5 11156.4 11349.5 11386.4 11873.9 8187.8 8249.4 8365.7 8482.0 8505.2 10475.4 10600.0 10913.5 11015.4 11106.3 03:48:38 INFO - PROCESS | 28795 | 03:48:38 INFO - PROCESS | 28795 | [#3] mootools.html Cycles:180 Average:5804.65 Median:6224.28 stddev:2997.81 (48.2%) stddev-sans-first:2989.32 03:48:38 INFO - PROCESS | 28795 | Values: 1568.7 1582.7 1793.1 1813.8 1924.8 7227.9 7893.8 8017.6 8165.3 8199.5 7993.1 8030.0 8061.3 8073.1 8092.9 2399.3 2423.1 2424.5 2425.2 2428.5 2360.7 2409.6 2445.9 2447.7 2449.2 2417.6 2425.1 2434.1 2445.5 2462.9 2316.4 2332.1 2345.7 2396.2 2464.7 2388.3 2391.9 2395.7 2400.3 2405.1 8212.0 8281.1 8293.0 8297.5 8299.0 5061.8 5159.4 5173.4 5179.5 5193.3 3201.9 3232.4 3280.3 3317.3 3317.6 1040.6 1089.6 1089.7 1119.1 1128.5 11585.5 11623.4 11643.8 11657.7 11661.2 4536.7 4616.0 4620.5 4621.3 4642.8 9907.8 9910.4 9919.8 9926.2 9937.0 5166.1 5167.1 5206.8 5216.1 5221.5 4083.3 4506.4 4529.4 4545.3 4702.6 3887.3 3887.5 3931.7 3955.2 3974.1 1223.9 1230.3 1237.9 1239.5 1251.5 1164.2 1185.8 1188.4 1196.2 1216.8 7600.7 7630.0 7688.9 7721.3 7751.4 1203.7 1206.7 1226.4 1228.9 1245.7 6179.3 6211.7 6236.8 6290.8 6304.2 9623.9 9962.7 10002.5 10071.3 10124.3 9804.2 9958.5 9978.2 9995.4 10141.4 7905.8 7964.1 7977.3 7984.3 8024.9 7558.7 7660.7 7678.2 7680.2 7776.1 8757.9 8810.5 8974.1 8978.3 9011.0 8664.1 8836.7 9109.2 9214.3 9339.8 6858.5 6929.8 6944.0 7133.3 7251.6 7885.7 7889.9 7895.8 7918.9 7922.4 7074.2 7082.1 7153.9 7253.7 7277.6 6852.1 6895.4 6897.2 6965.0 7025.5 7064.4 7384.8 7448.8 7459.1 7465.1 7045.3 7047.2 7082.0 7095.6 7105.3 7086.7 7096.4 7155.1 7158.7 7176.0 03:48:38 INFO - PROCESS | 28795 | 03:48:38 INFO - PROCESS | 28795 | [#4] prototype.html Cycles:180 Average:5670.49 Median:6500.90 stddev:1736.59 (26.7%) stddev-sans-first:1695.03 03:48:38 INFO - PROCESS | 28795 | Values: 355.5 356.8 358.0 360.6 361.5 6331.6 6352.1 6441.5 6490.1 6511.7 6291.5 6304.0 6307.5 6307.6 6311.7 4695.9 4791.2 4851.0 4872.1 4888.6 4854.2 4859.5 4860.8 4862.1 4870.5 4798.1 4803.4 4809.4 4817.2 4823.6 4813.0 4829.0 4831.5 4837.3 4841.5 4187.5 4200.9 4210.6 4215.1 4220.3 5888.5 6000.6 6019.7 6033.5 6033.6 5599.2 5649.6 5650.3 5660.2 5663.8 6633.7 6743.4 6760.7 6761.3 6763.3 4649.2 4654.1 4654.4 4654.6 4656.6 6980.6 7019.1 7058.0 7069.1 7077.1 4578.5 4748.4 4758.5 4767.7 4779.7 4707.0 4753.0 4767.9 4768.3 4770.7 5594.2 5603.2 5607.4 5607.6 5613.5 6743.5 6764.1 6767.0 6774.9 6784.4 1686.1 1703.5 1704.4 1707.2 1710.2 1108.0 1127.3 1132.8 1136.7 1160.3 6533.6 6544.2 6554.6 6557.0 6573.9 6986.1 6986.3 6996.1 7001.3 7019.3 6357.5 6541.5 6634.3 6634.7 6641.2 3784.2 3792.1 3808.2 3814.0 3814.6 7327.8 7357.0 7374.4 7376.3 7410.3 7243.9 7245.4 7249.7 7252.3 7257.2 7129.7 7338.4 7421.3 7423.9 7428.2 6999.4 7029.4 7035.9 7051.2 7072.2 6952.4 6961.9 6962.1 6967.8 6972.0 7388.7 7400.4 7413.6 7417.0 7422.5 4559.8 4679.2 4680.7 4697.2 4725.3 6913.8 6979.0 7002.7 7015.9 7023.6 6736.3 6764.4 6771.5 6791.0 6797.2 6687.1 6728.6 6793.8 6795.6 6796.5 6487.8 6681.8 6774.1 6795.0 6797.2 6836.4 6870.6 6896.1 6901.2 6919.2 6656.0 6664.9 6712.9 6713.0 6729.6 03:48:38 INFO - PROCESS | 28795 | 03:48:38 INFO - PROCESS | 28795 | [#5] yui.html Cycles:180 Average:15121.32 Median:25225.43 stddev:17349.32 (68.8%) stddev-sans-first:17364.53 03:48:38 INFO - PROCESS | 28795 | Values: 773.9 776.8 792.2 859.7 924.2 15865.3 15897.1 15913.2 15936.2 15945.0 14877.6 15674.8 16168.7 16177.8 16247.1 903.1 917.6 919.4 920.0 922.0 856.8 925.6 929.8 930.7 931.1 932.7 945.5 948.6 951.4 952.5 932.5 943.2 948.7 950.9 954.9 690.8 698.4 701.7 703.9 710.2 15519.2 15747.8 15885.9 15917.6 16018.6 13807.2 13860.3 13895.9 13980.9 14004.1 11480.8 11749.5 11851.9 11896.5 11939.3 3889.1 3921.5 3932.7 3940.9 3965.6 53531.0 54147.5 54348.7 54396.2 54450.0 11214.0 11305.9 11382.5 11397.9 11508.8 19813.4 19816.0 19870.2 19895.4 19916.1 8139.6 8227.1 8273.3 8320.3 8617.1 4311.8 4448.6 4613.4 4783.9 4852.6 3372.2 3443.9 3460.0 3466.1 3468.2 660.0 666.9 677.8 679.7 687.4 657.4 672.6 685.9 775.8 781.7 9271.5 9347.3 9499.4 9564.3 9681.5 608.7 671.3 724.1 730.1 751.7 4544.5 4568.5 4595.4 4633.3 4667.2 63676.7 63703.7 64055.4 64066.7 67642.0 53624.2 54912.2 55226.7 55273.4 55773.0 48697.8 48968.5 49570.0 49579.5 50597.0 8922.9 8957.4 8979.3 9114.0 9208.7 37465.4 38070.6 38122.0 38262.4 39131.2 43372.0 43616.0 45882.3 46823.3 47182.8 10928.5 11262.6 11399.0 11476.8 11485.3 13050.0 13413.2 13492.7 13858.6 14099.3 12129.2 12255.0 12296.9 12401.3 13113.5 10991.8 11034.4 11264.2 11485.1 11539.2 11902.9 11924.7 11943.4 11957.2 12025.7 10755.9 10806.6 10912.0 11095.3 11138.5 10167.0 10805.0 10811.4 11008.6 11377.4 03:48:38 INFO - PROCESS | 28795 | -------- Summary: end -------- 03:48:38 INFO - PROCESS | 28795 | 03:48:38 INFO - TEST-INFO | 28795: exit 0 03:48:38 INFO - TEST-OK | dromaeo_css | took 1110478ms 03:48:38 INFO - TEST-START | kraken 03:48:38 INFO - operating with platform_type : linux_ 03:48:38 INFO - Initialising browser for kraken test... 03:48:38 INFO - TEST-INFO | started process 29039 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyDQ0LG/profile http://localhost:59723/getInfo.html) 03:48:42 INFO - PROCESS | 29039 | 03:48:42 INFO - PROCESS | 29039 | (process:29113): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:48:43 INFO - PROCESS | 29039 | __metrics Screen width/height:1600/1200 03:48:43 INFO - PROCESS | 29039 | colorDepth:24 03:48:43 INFO - PROCESS | 29039 | Browser inner width/height: 1024/697 03:48:43 INFO - PROCESS | 29039 | __metrics 03:48:44 ERROR - PROCESS | 29039 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:48:45 INFO - TEST-INFO | 29039: exit 0 03:48:45 INFO - Browser initialized. 03:48:45 INFO - Running cycle 1/1 for kraken test... 03:48:45 INFO - TEST-INFO | started process 29165 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyDQ0LG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:47 INFO - PROCESS | 29165 | 03:48:47 INFO - PROCESS | 29165 | (process:29233): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:48:57 INFO - PROCESS | 29165 | RSS: Main: 154357760 03:48:57 INFO - PROCESS | 29165 | 03:48:59 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59723/tests/kraken/driver.html?testName=audio-beat-detection) 03:49:00 INFO - PROCESS | 29165 | RSS: Main: 158605312 03:49:00 INFO - PROCESS | 29165 | 03:49:03 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59723/tests/kraken/driver.html?testName=audio-dft) 03:49:03 INFO - PROCESS | 29165 | RSS: Main: 157614080 03:49:03 INFO - PROCESS | 29165 | 03:49:06 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59723/tests/kraken/driver.html?testName=audio-fft) 03:49:07 INFO - PROCESS | 29165 | RSS: Main: 158191616 03:49:07 INFO - PROCESS | 29165 | 03:49:09 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59723/tests/kraken/driver.html?testName=audio-oscillator) 03:49:09 INFO - PROCESS | 29165 | RSS: Main: 157790208 03:49:09 INFO - PROCESS | 29165 | 03:49:11 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59723/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:49:12 INFO - PROCESS | 29165 | RSS: Main: 159178752 03:49:12 INFO - PROCESS | 29165 | 03:49:15 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59723/tests/kraken/driver.html?testName=imaging-darkroom) 03:49:16 INFO - PROCESS | 29165 | RSS: Main: 158289920 03:49:16 INFO - PROCESS | 29165 | 03:49:19 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59723/tests/kraken/driver.html?testName=imaging-desaturate) 03:49:20 INFO - PROCESS | 29165 | RSS: Main: 158740480 03:49:20 INFO - PROCESS | 29165 | 03:49:22 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59723/tests/kraken/driver.html?testName=json-parse-financial) 03:49:23 INFO - PROCESS | 29165 | RSS: Main: 158429184 03:49:23 INFO - PROCESS | 29165 | 03:49:25 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59723/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:49:25 INFO - PROCESS | 29165 | RSS: Main: 158539776 03:49:25 INFO - PROCESS | 29165 | 03:49:27 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59723/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:49:27 INFO - PROCESS | 29165 | RSS: Main: 159535104 03:49:27 INFO - PROCESS | 29165 | 03:49:29 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59723/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:49:30 INFO - PROCESS | 29165 | RSS: Main: 159559680 03:49:30 INFO - PROCESS | 29165 | 03:49:32 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59723/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:49:33 INFO - PROCESS | 29165 | RSS: Main: 158257152 03:49:33 INFO - PROCESS | 29165 | 03:49:36 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59723/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:49:36 INFO - PROCESS | 29165 | RSS: Main: 159240192 03:49:36 INFO - PROCESS | 29165 | 03:49:38 INFO - PROCESS | 29165 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59723/tests/kraken/driver.html?testName=ai-astar) 03:49:38 INFO - PROCESS | 29165 | RSS: Main: 159809536 03:49:38 INFO - PROCESS | 29165 | 03:49:38 INFO - PROCESS | 29165 | __start_tp_report 03:49:38 INFO - PROCESS | 29165 | _x_x_mozilla_page_load 03:49:38 INFO - PROCESS | 29165 | _x_x_mozilla_page_load_details 03:49:38 INFO - PROCESS | 29165 | |i|pagename|runs| 03:49:38 INFO - PROCESS | 29165 | |0;ai-astar;112;104;112;110;111;123;110;111;112;111 03:49:38 INFO - PROCESS | 29165 | |1;audio-beat-detection;148;125;145;162;126;157;159;127;182;129 03:49:38 INFO - PROCESS | 29165 | |2;audio-dft;165;161;160;159;161;161;163;175;164;162 03:49:38 INFO - PROCESS | 29165 | |3;audio-fft;76;76;73;162;76;76;75;73;168;76 03:49:38 INFO - PROCESS | 29165 | |4;audio-oscillator;93;93;150;93;93;93;139;93;93;138 03:49:38 INFO - PROCESS | 29165 | |5;imaging-gaussian-blur;118;118;117;118;117;118;117;117;117;117 03:49:38 INFO - PROCESS | 29165 | |6;imaging-darkroom;147;146;147;147;148;146;147;147;148;146 03:49:38 INFO - PROCESS | 29165 | |7;imaging-desaturate;96;96;97;98;95;96;97;97;97;96 03:49:38 INFO - PROCESS | 29165 | |8;json-parse-financial;57;55;61;55;59;56;60;62;55;54 03:49:38 INFO - PROCESS | 29165 | |9;json-stringify-tinderbox;64;64;64;67;64;64;65;64;64;64 03:49:38 INFO - PROCESS | 29165 | |10;stanford-crypto-aes;77;79;78;77;79;79;79;78;79;85 03:49:38 INFO - PROCESS | 29165 | |11;stanford-crypto-ccm;111;126;121;114;123;112;126;119;113;118 03:49:38 INFO - PROCESS | 29165 | |12;stanford-crypto-pbkdf2;145;146;154;148;139;144;147;148;145;146 03:49:38 INFO - PROCESS | 29165 | |13;stanford-crypto-sha256-iterative;67;67;68;69;67;65;66;67;70;66 03:49:38 INFO - PROCESS | 29165 | __end_tp_report 03:49:38 INFO - PROCESS | 29165 | __start_cc_report 03:49:38 INFO - PROCESS | 29165 | _x_x_mozilla_cycle_collect,824 03:49:38 INFO - PROCESS | 29165 | __end_cc_report 03:49:38 INFO - PROCESS | 29165 | __startTimestamp1457524178659__endTimestamp 03:49:38 INFO - PROCESS | 29165 | 03:49:38 INFO - PROCESS | 29165 | ------- Summary: start ------- 03:49:38 INFO - PROCESS | 29165 | Number of tests: 14 03:49:38 INFO - PROCESS | 29165 | 03:49:38 INFO - PROCESS | 29165 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.50 stddev:4.65 (4.2%) stddev-sans-first:4.93 03:49:38 INFO - PROCESS | 29165 | Values: 112.0 104.0 112.0 110.0 111.0 123.0 110.0 111.0 112.0 111.0 03:49:38 INFO - PROCESS | 29165 | 03:49:38 INFO - PROCESS | 29165 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:152.50 stddev:19.26 (12.6%) stddev-sans-first:20.41 03:49:38 INFO - PROCESS | 29165 | Values: 148.0 125.0 145.0 162.0 126.0 157.0 159.0 127.0 182.0 129.0 03:49:38 INFO - PROCESS | 29165 | 03:49:38 INFO - PROCESS | 29165 | [#2] audio-dft Cycles:10 Average:163.10 Median:162.50 stddev:4.56 (2.8%) stddev-sans-first:4.78 03:49:38 INFO - PROCESS | 29165 | Values: 165.0 161.0 160.0 159.0 161.0 161.0 163.0 175.0 164.0 162.0 03:49:38 INFO - PROCESS | 29165 | 03:49:38 INFO - PROCESS | 29165 | [#3] audio-fft Cycles:10 Average:93.10 Median:76.00 stddev:37.94 (49.9%) stddev-sans-first:39.73 03:49:38 INFO - PROCESS | 29165 | Values: 76.0 76.0 73.0 162.0 76.0 76.0 75.0 73.0 168.0 76.0 03:49:38 INFO - PROCESS | 29165 | 03:49:38 INFO - PROCESS | 29165 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:93.00 stddev:24.04 (25.8%) stddev-sans-first:24.89 03:49:38 INFO - PROCESS | 29165 | Values: 93.0 93.0 150.0 93.0 93.0 93.0 139.0 93.0 93.0 138.0 03:49:38 INFO - PROCESS | 29165 | 03:49:38 INFO - PROCESS | 29165 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 03:49:38 INFO - PROCESS | 29165 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 03:49:38 INFO - PROCESS | 29165 | 03:49:38 INFO - PROCESS | 29165 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 03:49:38 INFO - PROCESS | 29165 | Values: 147.0 146.0 147.0 147.0 148.0 146.0 147.0 147.0 148.0 146.0 03:49:38 INFO - PROCESS | 29165 | 03:49:38 INFO - PROCESS | 29165 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 03:49:38 INFO - PROCESS | 29165 | Values: 96.0 96.0 97.0 98.0 95.0 96.0 97.0 97.0 97.0 96.0 03:49:38 INFO - PROCESS | 29165 | 03:49:38 INFO - PROCESS | 29165 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:58.00 stddev:2.88 (5.0%) stddev-sans-first:3.05 03:49:38 INFO - PROCESS | 29165 | Values: 57.0 55.0 61.0 55.0 59.0 56.0 60.0 62.0 55.0 54.0 03:49:38 INFO - PROCESS | 29165 | 03:49:38 INFO - PROCESS | 29165 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 03:49:38 INFO - PROCESS | 29165 | Values: 64.0 64.0 64.0 67.0 64.0 64.0 65.0 64.0 64.0 64.0 03:49:38 INFO - PROCESS | 29165 | 03:49:38 INFO - PROCESS | 29165 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:2.26 (2.9%) stddev-sans-first:2.28 03:49:38 INFO - PROCESS | 29165 | Values: 77.0 79.0 78.0 77.0 79.0 79.0 79.0 78.0 79.0 85.0 03:49:38 INFO - PROCESS | 29165 | 03:49:38 INFO - PROCESS | 29165 | [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:120.00 stddev:5.66 (4.7%) stddev-sans-first:5.35 03:49:38 INFO - PROCESS | 29165 | Values: 111.0 126.0 121.0 114.0 123.0 112.0 126.0 119.0 113.0 118.0 03:49:38 INFO - PROCESS | 29165 | 03:49:38 INFO - PROCESS | 29165 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.20 Median:146.50 stddev:3.77 (2.6%) stddev-sans-first:3.97 03:49:38 INFO - PROCESS | 29165 | Values: 145.0 146.0 154.0 148.0 139.0 144.0 147.0 148.0 145.0 146.0 03:49:38 INFO - PROCESS | 29165 | 03:49:38 INFO - PROCESS | 29165 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.48 (2.2%) stddev-sans-first:1.56 03:49:38 INFO - PROCESS | 29165 | Values: 67.0 67.0 68.0 69.0 67.0 65.0 66.0 67.0 70.0 66.0 03:49:38 INFO - PROCESS | 29165 | -------- Summary: end -------- 03:49:38 INFO - PROCESS | 29165 | 03:49:39 INFO - TEST-INFO | 29165: exit 0 03:49:39 INFO - TEST-OK | kraken | took 60679ms 03:49:39 INFO - SUITE-END | took 1171s 03:49:39 INFO - Completed test suite (00:19:31) 03:49:39 INFO - javascript benchmark 03:49:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3339.883104091357, 3370.6123795763488, 3391.677790609894, 3409.624941256461, 3430.0738800523845, 5542.251796007537, 5561.082421400469, 5589.608727389079, 5602.7758889644465, 5631.633943793656, 5564.638298510604, 5566.610337276392, 5584.581156413265, 5590.720463976805, 5598.076317407633, 5045.445001049881, 5119.257707632391, 5144.717040562768, 5150.665206761549, 5183.17069268917, 5012.198048312271, 5118.360204974379, 5186.636935414523, 5191.714455704935, 5204.791808327663, 5083.84748457545, 5141.331626888518, 5149.922751158736, 5202.635815492917, 5217.0, 5108.080545501808, 5154.639175257734, 5161.458046905059, 5171.974140129294, 5201.609879259033, 4887.902241955141, 4931.80272789088, 5050.747462626854, 5082.4663410341755, 5120.1039818031695, 5293.735313234323, 5320.414754377015, 5325.4142044375085, 5334.959682861843, 5358.866028349284, 5860.208871802295, 5898.852528686817, 5910.8817823643285, 5914.260717410324, 5928.170056192136, 5833.387494313079, 5938.435848594377, 6001.06983417571, 6018.337982821886, 6018.8194354169445, 5552.7223638817895, 5623.943760562423, 5632.774689012475, 5634.408387119375, 5635.295588051494, 5952.851178720567, 6127.938720612737, 6138.693065346715, 6153.815385538441, 6158.7228574714245, 5907.734151963086, 5956.52347812174, 5960.37416071315, 5965.582409231312, 5999.130126131774, 5991.951408503494, 5992.820215393545, 5993.550483713739, 6002.819915402458, 6015.127806468037, 5751.712414379264, 5916.319623243296, 5921.940780592225, 5927.199828023248, 5930.318013428425, 5931.940680593225, 5954.374790647006, 5984.072468767348, 5985.25184351956, 6019.157317975487, 4510.233260345749, 4541.182587134282, 4545.727256364563, 4547.590716835434, 4564.543545645475, 4022.7586344819406, 4022.7988600569856, 4027.81874815634, 4053.8783836484363, 4111.732737372061, 5473.06957817172, 5643.435656434406, 5647.1529270609735, 5727.05503591911, 5776.653400795965, 5975.103734439782, 5976.223090998143, 5979.312379076375, 5987.820365389045, 5991.400859913973, 5558.944410555923, 5643.80246691372, 5664.235328230719, 5684.289463817023, 5695.914561281584, 5093.2360145977655, 5113.105206588906, 5170.0, 5172.991266702957, 5173.224016397495, 6163.8150855474405, 6253.843653908689, 6271.529635277281, 6271.62370257786, 6284.245890493079, 5858.619189752652, 6015.578909476295, 6042.607230530001, 6070.848228794315, 6078.209832721718, 6134.375358695336, 6170.568060235741, 6178.474829639351, 6223.688815559294, 6224.284207316216, 5896.0, 5925.564878320551, 5979.641221526722, 5983.192269043623, 5994.0, 5947.405259474018, 6006.189164462741, 6064.605800622945, 6069.757209711562, 6080.543959202989, 5886.735096920564, 5888.793892213752, 5890.087036509348, 5924.7926322578505, 5952.732127054206, 5901.262342207224, 5903.91144132847, 5907.704614769158, 5909.940900590939, 5911.201987731602, 5635.774569017357, 5826.621269617462, 5831.562632802472, 5840.415958404295, 5866.472017518444, 5878.3239927408895, 5898.970505147447, 5921.822345329647, 5929.318128415115, 5931.733072011683, 5737.627054241461, 5748.45389687979, 5767.163761254678, 5780.132980053026, 5786.537077033743], "unit": "score", "name": "dojo.html", "value": 5524.4860666227205}, {"lowerIsBetter": false, "replicates": [532.1034057612923, 567.8580354911271, 577.7515668262647, 585.9209006784083, 587.6297932302649, 31292.84353578232, 39242.803785981065, 39710.8014459928, 39947.20105597886, 40068.39897401534, 41727.0, 41786.373204401956, 42130.15739685212, 42507.787461062726, 42568.0, 8786.6924657637, 8962.910370896305, 8966.103389661046, 8972.461652300883, 9031.367804253705, 8722.825543489158, 8774.385792994493, 8837.204651581356, 8858.689945851896, 8869.423487473327, 8812.911870881273, 8956.373053886231, 8956.417832840845, 8964.820703585925, 8965.775855603597, 8890.777730556756, 8954.820903581956, 8957.462552246854, 9100.681476148304, 9154.084591540859, 8963.372563920528, 9113.0886911309, 9172.036936121745, 9179.81640367189, 9185.724428267162, 42311.1537769246, 42412.0, 42585.787071064755, 42675.0, 42781.786091069655, 3729.589745128034, 3791.109089363997, 3857.787821669807, 3950.111224974358, 4277.657787377002, 31731.682683173105, 31819.204519886956, 32017.199570010704, 32101.0, 32936.176595585064, 4080.6939479538855, 4129.545749967501, 4151.584841515854, 4167.979160104211, 4168.874933751992, 217623.0, 222906.0, 224328.0, 225066.0, 225505.0, 63976.36023639704, 71999.0, 72155.63922180461, 72708.27291727121, 72890.0, 75745.24254757381, 76623.61688191524, 78233.60883195662, 78455.0, 79120.20879791243, 16097.0, 16294.42969496062, 16329.918350408172, 16388.590285242724, 16512.25694843735, 12823.679408014874, 12938.09433339676, 12965.870341296655, 13071.346432678329, 13166.407511661999, 22825.20111796079, 23081.07675692987, 23226.53546929052, 23285.883570582377, 23373.0, 9047.638094476279, 9346.719598412059, 9525.190358819578, 9559.808803824024, 9636.566354514063, 1010.2524132142162, 1081.551156270139, 1123.2811000959393, 1131.1572878205789, 1216.0028776403265, 30048.248793779894, 30207.395852083275, 30225.395492090036, 30487.085387438412, 30582.69417305843, 1126.380490730095, 1142.114860982745, 1209.0810983652486, 1214.6356093172012, 1247.289045244202, 15490.535283941499, 15532.534023979299, 15605.453809116854, 15787.763183552255, 15977.680446391007, 355996.0, 521175.0, 521824.0, 524673.0, 525855.0, 54700.179497307574, 55280.0, 55702.0, 55722.72138639362, 55745.721271393384, 1478.9334479948427, 1511.1613054754496, 1519.270750039965, 1523.5886310696271, 1534.4245907784805, 30161.69838301589, 30481.54277685881, 30882.53676194904, 31002.224944376572, 31246.37507249797, 48879.266810998575, 48975.510244897094, 49243.50756492533, 49480.50519494903, 49710.25434618556, 315321.0, 318406.0, 318995.0, 319734.0, 319777.0, 34454.82772586121, 34537.0, 35208.823955880056, 35314.293714126085, 35642.64357356393, 44226.0, 44758.36801834437, 44990.550094499944, 44991.77504112459, 45250.54749452595, 38306.0, 38404.0, 38545.0, 38738.41892371673, 39647.0, 37771.2445751078, 37842.621573785014, 38602.227955440176, 38782.41826372663, 39157.0, 37796.055098621655, 38219.0, 38332.80833595926, 38513.614863851006, 38658.613413866624, 33246.00261992144, 34412.13969650779, 34507.0, 34559.0, 34739.305213896085, 25965.22104336873, 26509.867450662623, 26960.460790783683, 27108.051218207267, 27149.321266968484], "unit": "score", "name": "ext.html", "value": 19997.27994289341}, {"lowerIsBetter": false, "replicates": [371.8902923637527, 373.25908072476113, 373.74211793862236, 374.880038387716, 380.708757800283, 17649.29402823887, 17930.641387172247, 18568.907155464236, 18571.90714046428, 18657.34699285525, 17379.91310043448, 17922.19350129244, 18033.63932721345, 18086.5478363041, 18102.81897181031, 5671.7164141793055, 5884.529237660977, 5901.4098590141075, 5908.438698323653, 5911.46796788289, 4209.810558524874, 5776.971115144418, 6243.56295059346, 6465.159529261189, 6503.869922601545, 6428.164338635971, 6456.35436456353, 6457.418832305091, 6461.450776683988, 6470.450011749007, 6696.062551242806, 6936.028955946172, 6940.687669054904, 6990.056342393788, 7007.299270072952, 6245.281792593864, 6431.517636177258, 6699.5310328276555, 6729.32706729328, 6729.495287853381, 24491.87754061236, 24975.250742477754, 25059.87470062638, 25503.617445738328, 25592.104276350237, 2510.4602510460154, 2529.848209107441, 2593.351662084479, 2617.9607305890427, 2726.9590956135676, 14023.228722420263, 14688.779668304984, 14878.256087195598, 14975.715056664829, 15355.616109597238, 1990.9004549772453, 2099.653557163066, 2112.7781582933876, 2118.8199003084756, 2135.0178917697876, 74655.0, 76306.23693763102, 76337.0, 76856.61571692162, 77605.0, 15723.606909827346, 17122.14389280531, 17167.227474763415, 17194.39819606333, 17218.31126754941, 26924.057657981877, 26926.92292308325, 27138.0, 27308.726912731017, 27324.180274591796, 9297.442153470813, 9612.615495380247, 9623.470709110927, 9635.518224088768, 9684.95157524208, 8240.62917168729, 8248.381371397169, 8413.747587572383, 8482.406231563855, 8513.914860851311, 8400.663973441116, 8471.703490377808, 8516.787080323042, 8563.529005904735, 8666.176713212235, 1967.1836187982112, 1989.4529004523583, 1991.830694390993, 2017.0519855667812, 3227.499737540685, 955.6273053509137, 1005.7385079879137, 1008.9142422893989, 1063.7819247054335, 1104.779567560568, 16093.839061609468, 16621.91957522757, 17308.048057356966, 17424.47726568205, 17598.416778960695, 1015.9796804064025, 1023.5701005577675, 1042.744527590745, 1048.5438834107188, 1095.808233559124, 9967.501624918725, 10041.397516149054, 10121.898781012243, 10137.543810528545, 10364.896351036394, 364125.0, 365451.0, 422070.0, 428039.0, 431052.0, 78240.0, 79156.0, 80314.0, 80494.0, 82207.58896205481, 1023.3348323589578, 1058.4760543530847, 1068.273573969708, 1068.9358638481715, 1075.5267682219642, 16162.515124546282, 16328.755068674218, 16358.182090895645, 16396.180190990643, 16770.664586707953, 33688.326233474705, 34431.483527746605, 34933.47599786056, 35071.47392789161, 36004.0, 48519.51480485291, 49125.263121053926, 49356.0, 49393.50606494033, 49664.0, 8278.130796266305, 8385.83228335442, 8445.746627601182, 8517.531535765593, 8558.443701159405, 10046.949765251127, 12826.294553799631, 12983.0, 13101.0, 13215.207087574776, 11050.889491105308, 11236.94381528087, 11403.828942566033, 11482.196246262682, 11509.712257193638, 11005.559777609125, 11006.779864402828, 11313.943430282796, 11376.089912807121, 11575.652730418102, 11118.49966751482, 11156.44217789091, 11349.54601815918, 11386.43067846621, 11873.881261187624, 8187.754367368989, 8249.381296402673, 8365.749027529184, 8482.024567174607, 8505.23452889243, 10475.413424608272, 10599.993000664925, 10913.508892099715, 11015.449227538431, 11106.333619982826], "unit": "score", "name": "jquery.html", "value": 9693.498179069478}, {"lowerIsBetter": false, "replicates": [1568.6784209237107, 1582.6992871354441, 1793.1392931392922, 1813.791413987391, 1924.7594050743658, 7227.9277207227915, 7893.763187104396, 8017.639206235719, 8165.34677225822, 8199.549024803633, 7993.080795708495, 8029.959850200756, 8061.274485296322, 8073.11195768465, 8092.91907080929, 2399.328188107324, 2423.127674037345, 2424.5150969806023, 2425.223928342931, 2428.5264373447185, 2360.704911886014, 2409.6024156014237, 2445.9266222013366, 2447.68180136582, 2449.1672831237374, 2417.613181890898, 2425.0663494554638, 2434.087217293515, 2445.4742230420457, 2462.926112216627, 2316.4324740438615, 2332.1371092695726, 2345.741968383468, 2396.2332053742807, 2464.6549483072386, 2388.3432056184515, 2391.8564886106715, 2395.6885604871254, 2400.291913885408, 2405.1341517053847, 8211.95894020532, 8281.130481299437, 8292.958535207346, 8297.502149871027, 8299.0, 5061.848144555669, 5159.406668233164, 5173.379194496684, 5179.456157103487, 5193.272941788153, 3201.8719251229923, 3232.3858466891215, 3280.327532855759, 3317.286783341593, 3317.552130462405, 1040.5993692428394, 1089.5641743302663, 1089.7493576477455, 1119.121489630636, 1128.4752590045587, 11585.478653460614, 11623.360715160663, 11643.767124657545, 11657.650270491898, 11661.24201926872, 4536.705114167568, 4616.030633566988, 4620.491745907947, 4621.2837010263465, 4642.814287428465, 9907.752306192258, 9910.405375677483, 9919.801603968024, 9926.156276716416, 9936.950315248378, 5166.147585648326, 5167.121589329823, 5206.817761378334, 5216.087184742655, 5221.451747566527, 4083.3466645336603, 4506.3916371290115, 4529.365888775574, 4545.272756358967, 4702.6473014524045, 3887.3197190492115, 3887.5140607424073, 3931.7051221158526, 3955.2287303976022, 3974.1455587048345, 1223.920445171061, 1230.347915604713, 1237.8762123787728, 1239.5165885304739, 1251.499400239893, 1164.1792536261914, 1185.7924863148914, 1188.44737197202, 1196.234409977615, 1216.7809794237123, 7600.695972161052, 7630.046244219473, 7688.923110768933, 7721.266479684421, 7751.418643601753, 1203.7171264752776, 1206.6561030106377, 1226.3561630144245, 1228.9446974886152, 1245.7446223524155, 6179.3202747697715, 6211.720472578745, 6236.844078898064, 6290.779822706183, 6304.211973503312, 9623.855642165374, 9962.651307204213, 10002.549885255181, 10071.34536255141, 10124.291299609104, 9804.166645835041, 9958.50207489637, 9978.201743860474, 9995.350302230332, 10141.391516508886, 7905.762827115311, 7964.123946365895, 7977.3219276361, 7984.281414672707, 8024.876517287585, 7558.735444259424, 7660.693572257047, 7678.155402905788, 7680.155182929985, 7776.066871975399, 8757.868631970652, 8810.515421651871, 8974.14745599167, 8978.281737460857, 9010.954945225232, 8664.090270521505, 8836.734897953073, 9109.22571581423, 9214.2628589714, 9339.813203736023, 6858.5199036067, 6929.821930271765, 6943.9652801735665, 7133.251008644018, 7251.637418129178, 7885.684572617031, 7889.881651775113, 7895.802604934923, 7918.881216781638, 7922.445428819928, 7074.221835597978, 7082.114735658043, 7153.856922861618, 7253.746118885813, 7277.636118194175, 6852.109225800813, 6895.4138898194215, 6897.241303456716, 6965.024896514391, 7025.473089518205, 7064.4048876751895, 7384.815379615553, 7448.813779655552, 7459.142198647008, 7465.141508726349, 7045.330693584101, 7047.224805271314, 7081.964590177016, 7095.574265544084, 7105.2894710528535, 7086.681099350645, 7096.361327480551, 7155.105611798525, 7158.713651453883, 7175.964120179366], "unit": "score", "name": "mootools.html", "value": 4779.680454433395}, {"lowerIsBetter": false, "replicates": [355.5378008588834, 356.75918754840507, 357.9767315124517, 360.57092060448065, 361.47405524961187, 6331.588446750958, 6352.078948552463, 6441.484681225503, 6490.091387205795, 6511.706973186207, 6291.465225455841, 6304.0, 6307.463865571421, 6307.558470907038, 6311.684415779216, 4695.859124226278, 4791.209450440673, 4851.0, 4872.147374209517, 4888.608911287106, 4854.247591623304, 4859.489753575876, 4860.829870954517, 4862.100511405383, 4870.537298956593, 4798.0643774464, 4803.423589169304, 4809.422869255694, 4817.22924332107, 4823.614110871122, 4813.037392521493, 4828.975855120737, 4831.516848315158, 4837.274408838667, 4841.515848415165, 4187.539370669255, 4200.915981680349, 4210.578942105765, 4215.114825886568, 4220.324748040299, 5888.5289176865745, 6000.579959402844, 6019.668918209497, 6033.5173186145, 6033.637981721111, 5599.244102046212, 5649.576281778842, 5650.3219613646215, 5660.179274005246, 5663.801766938137, 6633.701483433257, 6743.426808721216, 6760.729570817161, 6761.290064543201, 6763.323667633246, 4649.232876575361, 4654.115718013567, 4654.441467023945, 4654.627629789608, 4656.627469802408, 6980.581165130057, 7019.122609673791, 7058.011878336985, 7069.116360454943, 7077.07997960267, 4578.496365399803, 4748.358971538798, 4758.500357462417, 4767.713937163781, 4779.713217206979, 4707.03505781314, 4752.952470475251, 4767.928481072787, 4768.332433459318, 4770.737609431515, 5594.216809646653, 5603.187537806995, 5607.4112218217315, 5607.607467477237, 5613.522850557748, 6743.460523158135, 6764.086848275519, 6766.966165169143, 6774.8645027100165, 6784.423324017514, 1686.148495010012, 1703.5485596316985, 1704.4375356132446, 1707.1805533344063, 1710.2133018811237, 1107.9778404431866, 1127.3292391027326, 1132.8300754886832, 1136.7499150186945, 1160.3212120909193, 6533.575317604341, 6544.247411547733, 6554.63949482783, 6556.967215163893, 6573.934260657428, 6986.056882320923, 6986.336298051677, 6996.090508233999, 7001.334873187039, 7019.262977387403, 6357.491400688026, 6541.542092053511, 6634.336566343423, 6634.701438435282, 6641.169853768279, 3784.243151369737, 3792.089898424358, 3808.2383523295453, 3813.9618603813606, 3814.6185381461632, 7327.780166594904, 7356.96321518389, 7374.373178279799, 7376.262373762581, 7410.258974102654, 7243.89134162988, 7245.384142347854, 7249.673764680602, 7252.311030452099, 7257.201707812136, 7129.679164437613, 7338.376238019828, 7421.257874212643, 7423.925760742323, 7428.182899881009, 6999.405050570758, 7029.3673569379, 7035.859282814213, 7051.189113252041, 7072.186698529735, 6952.409045231212, 6961.8955715665315, 6962.094927659372, 6967.756128535477, 6971.965140174267, 7388.741394051182, 7400.40796736249, 7413.628478731452, 7417.0, 7422.480426370103, 4559.817607295804, 4679.2045352289515, 4680.672352935262, 4697.177993850994, 4725.267583524559, 6913.75801846933, 6979.0, 7002.684879180347, 7015.894761578683, 7023.648817559204, 6736.32636736342, 6764.425023872829, 6771.45828333742, 6791.0, 6797.150356205474, 6687.130673012477, 6728.629925354153, 6793.830154246183, 6795.592264464148, 6796.524243303119, 6487.837804054936, 6681.799546013627, 6774.119364482585, 6794.966025169842, 6797.218319893275, 6836.38472537474, 6870.553414028072, 6896.103506544117, 6901.1718593769065, 6919.238883722685, 6656.001599760075, 6664.866702666017, 6712.885441086042, 6713.0, 6729.596224226562], "unit": "score", "name": "prototype.html", "value": 5105.2785825245655}, {"lowerIsBetter": false, "replicates": [773.8877862709905, 776.7708525984834, 792.1880072925252, 859.7034023261976, 924.2328867040353, 15865.286062127203, 15897.1256580888, 15913.204339783008, 15936.203189840491, 15945.0, 14877.553673389788, 15674.764878526803, 16168.676626467493, 16177.83822161778, 16247.106409147493, 903.0743487924881, 917.5779141594875, 919.3932004876783, 919.995400022999, 921.9861702074475, 856.8286342731448, 925.5788616179622, 929.7722058095742, 930.7068273493861, 931.1293940165966, 932.6782260120248, 945.4610871803075, 948.6300342866288, 951.4386511957944, 952.5142177489496, 932.4824722279133, 943.2218419803621, 948.6679662118307, 950.9444516586583, 954.9474778887159, 690.7582346178797, 698.4482259015372, 701.7228194863052, 703.8873780195196, 710.1797423975316, 15519.224038798127, 15747.842521574752, 15885.92057039719, 15917.602059948595, 16018.5995350116, 13807.240601766898, 13860.306984650828, 13895.861041389659, 13980.860191398058, 14004.089734167246, 11480.827787583194, 11749.471273792615, 11851.88148118525, 11896.524139034429, 11939.34333611651, 3889.0666240102455, 3921.509811273591, 3932.7443716158646, 3940.9014774630577, 3965.5637879833193, 53531.0, 54147.45852541503, 54348.72825635886, 54396.18405723957, 54450.0, 11214.0, 11305.943470282597, 11382.54469821198, 11397.886021139848, 11508.769824603462, 19813.405597832087, 19816.0, 19870.205191792167, 19895.403137905887, 19916.103775330146, 8139.552324622085, 8227.053888802864, 8273.296769774517, 8320.334373250125, 8617.052124266325, 4311.849085282063, 4448.55514448559, 4613.446386433649, 4783.856484305476, 4852.563269305709, 3372.1906742381652, 3443.9311213775586, 3460.048486666137, 3466.0814884055744, 3468.2369878627164, 659.953803233769, 666.9333066693292, 677.8169894128557, 679.67035987546, 687.3779229797042, 657.3951964192954, 672.6166085331412, 685.869684759894, 775.7711475114854, 781.6873250699765, 9271.490068046322, 9347.345685801929, 9499.43003419797, 9564.282678799118, 9681.51592420376, 608.7291155435788, 671.2817285504464, 724.1274264511251, 730.087390761548, 751.744406901656, 4544.454665440168, 4568.543145685471, 4595.425571803525, 4633.305004249322, 4667.206574882278, 63676.68161659162, 63703.6814815923, 64055.35944640494, 64066.6796666023, 67642.0, 53624.19563706547, 54912.176317354475, 55226.72386638122, 55273.44726552683, 55773.0, 48697.756511217216, 48968.5103148964, 49570.0, 49579.50420495821, 50597.0, 8922.910770892207, 8957.417767845069, 8979.32655050887, 9113.954430227806, 9208.677696280598, 37465.43801843029, 38070.61929380671, 38122.046948825395, 38262.42606360962, 39131.21737565176, 43372.0, 43616.0, 45882.311765324215, 46823.29765053595, 47182.76408617935, 10928.453577321261, 11262.605808796652, 11399.0, 11476.770464590829, 11485.310881347146, 13050.0, 13413.195208287534, 13492.662683432993, 13858.584242472742, 14099.295035248402, 12129.21160124589, 12255.0, 12296.938515307365, 12401.317927514074, 13113.475460981454, 10991.835122473329, 11034.393108379116, 11264.155188360743, 11485.138614604106, 11539.19225654196, 11902.940485297864, 11924.701882453008, 11943.402829858645, 11957.162998590014, 12025.699357516132, 10755.89812198608, 10806.567737290734, 10912.0, 11095.278806877526, 11138.498767555642, 10167.0, 10805.0, 10811.405372704263, 11008.614698485515, 11377.374244416636], "unit": "score", "name": "yui.html", "value": 6966.030210074789}], "name": "dromaeo_css", "value": 7528.308002596829}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 104.0, 112.0, 110.0, 111.0, 123.0, 110.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [148.0, 125.0, 145.0, 162.0, 126.0, 157.0, 159.0, 127.0, 182.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 146.0}, {"lowerIsBetter": true, "replicates": [165.0, 161.0, 160.0, 159.0, 161.0, 161.0, 163.0, 175.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 73.0, 162.0, 76.0, 76.0, 75.0, 73.0, 168.0, 76.0], "unit": "score", "name": "audio-fft", "value": 93.1}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 150.0, 93.0, 93.0, 93.0, 139.0, 93.0, 93.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.4}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 148.0, 146.0, 147.0, 147.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 98.0, 95.0, 96.0, 97.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 61.0, 55.0, 59.0, 56.0, 60.0, 62.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 67.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.4}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 78.0, 77.0, 79.0, 79.0, 79.0, 78.0, 79.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.0}, {"lowerIsBetter": true, "replicates": [111.0, 126.0, 121.0, 114.0, 123.0, 112.0, 126.0, 119.0, 113.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.3}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 154.0, 148.0, 139.0, 144.0, 147.0, 148.0, 145.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 69.0, 67.0, 65.0, 66.0, 67.0, 70.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1514.9}]} 03:49:39 INFO - Return code: 0 03:49:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:49:39 ERROR - # TBPL SUCCESS # 03:49:39 INFO - Running post-action listener: _resource_record_post_action 03:49:39 INFO - Running post-run listener: _resource_record_post_run 03:49:41 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 495681536; Read time: 28; Write time: 887396 03:49:41 INFO - install - Wall time: 15s; CPU: 18.0%; Read bytes: 0; Write bytes: 244006912; Read time: 0; Write time: 647456 03:49:41 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 244883456; Read time: 28; Write time: 239076 03:49:41 INFO - Running post-run listener: _upload_blobber_files 03:49:41 INFO - Blob upload gear active. 03:49:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 03:49:41 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 03:49:41 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-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 03:49:41 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-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 03:49:41 INFO - (blobuploader) - INFO - Open directory for files ... 03:49:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:49:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:49:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:42 INFO - (blobuploader) - INFO - Done attempting. 03:49:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:49:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:49:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:43 INFO - (blobuploader) - INFO - Done attempting. 03:49:43 INFO - (blobuploader) - INFO - Iteration through files over. 03:49:43 INFO - Return code: 0 03:49:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 03:49:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 03:49:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d30e4fbc9d2e0b0f7b21a761038fab6a7566f151108661e661655f096c404a5f062de9130a2fd55e7528046f4e5f10e1109b59990d34959ee2bc58af23720b1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0475bffd77c044d9b65023e734ae3b4957bb017bc22c98dec4d1fcfb36dd2fecca57fb0bdb4cb53a4a605c755fbe0991fc30604758ce44e2c35a15401c4e1fb3"} 03:49:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 03:49:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 03:49:43 INFO - Contents: 03:49:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d30e4fbc9d2e0b0f7b21a761038fab6a7566f151108661e661655f096c404a5f062de9130a2fd55e7528046f4e5f10e1109b59990d34959ee2bc58af23720b1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0475bffd77c044d9b65023e734ae3b4957bb017bc22c98dec4d1fcfb36dd2fecca57fb0bdb4cb53a4a605c755fbe0991fc30604758ce44e2c35a15401c4e1fb3"} 03:49:43 INFO - Running post-run listener: copy_logs_to_upload_dir 03:49:43 INFO - Copying logs to upload dir... 03:49:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 03:49:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.114095 ========= master_lag: 246.22 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 34 secs) (at 2016-03-09 03:53:49.153876) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 mins, 52 secs) (at 2016-03-09 03:53:49.155255) ========= 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=745a4373a2a16df560f216e000000264-1457522952.410600-539033305 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-Aurora/sha512/d30e4fbc9d2e0b0f7b21a761038fab6a7566f151108661e661655f096c404a5f062de9130a2fd55e7528046f4e5f10e1109b59990d34959ee2bc58af23720b1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0475bffd77c044d9b65023e734ae3b4957bb017bc22c98dec4d1fcfb36dd2fecca57fb0bdb4cb53a4a605c755fbe0991fc30604758ce44e2c35a15401c4e1fb3"} build_url:https://queue.taskcluster.net/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011452 build_url: 'https://queue.taskcluster.net/v1/task/eCy-xiHQTKyY5VwyqDXXcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d30e4fbc9d2e0b0f7b21a761038fab6a7566f151108661e661655f096c404a5f062de9130a2fd55e7528046f4e5f10e1109b59990d34959ee2bc58af23720b1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0475bffd77c044d9b65023e734ae3b4957bb017bc22c98dec4d1fcfb36dd2fecca57fb0bdb4cb53a4a605c755fbe0991fc30604758ce44e2c35a15401c4e1fb3"}' ========= master_lag: 172.65 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 mins, 52 secs) (at 2016-03-09 03:56:41.819850) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 6 mins, 16 secs) (at 2016-03-09 03:56:41.820223) ========= 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=745a4373a2a16df560f216e000000264-1457522952.410600-539033305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004734 ========= master_lag: 376.77 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 6 mins, 16 secs) (at 2016-03-09 04:02:58.593842) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-03-09 04:02:58.594157) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-03-09 04:02:59.766422) ========= ========= Total master_lag: 795.82 =========