builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1447358016.07 results: success (0) buildid: 20151112103103 builduid: 62f8a67f96b54bb7b8478f375308fa14 revision: 335c2779216be1186d937a95f29d082d8a4045d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:36.074835) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:36.075254) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:36.075538) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006433 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:36.103121) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:36.103388) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:36.126799) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:36.127194) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.026139 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:36.176337) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:36.176630) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:36.176993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:36.177275) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-12 11:53:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2015-11-12 11:53:36 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136523 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:36.326283) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:36.326591) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.131452 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:36.469529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:36.469893) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 335c2779216be1186d937a95f29d082d8a4045d6 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 335c2779216be1186d937a95f29d082d8a4045d6 --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=e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-12 11:53:36,635 truncating revision to first 12 chars 2015-11-12 11:53:36,636 Setting DEBUG logging. 2015-11-12 11:53:36,636 attempt 1/10 2015-11-12 11:53:36,636 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/335c2779216b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 11:53:36,883 unpacking tar archive at: mozilla-inbound-335c2779216b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558962 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:37.041225) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:37.041542) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:37.051297) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:37.051684) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 11:53:37.052277) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-12 11:53:37.052600) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:53:37 INFO - MultiFileLogger online at 20151112 11:53:37 in /builds/slave/test-pgo 11:53:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 11:53:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:53:37 INFO - {'append_to_log': False, 11:53:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:53:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:53:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:53:37 INFO - 'branch': 'Mozilla-Inbound', 11:53:37 INFO - 'buildbot_json_path': 'buildprops.json', 11:53:37 INFO - 'config_files': ('talos/linux_config.py',), 11:53:37 INFO - 'default_actions': ('clobber', 11:53:37 INFO - 'read-buildbot-config', 11:53:37 INFO - 'download-and-extract', 11:53:37 INFO - 'populate-webroot', 11:53:37 INFO - 'create-virtualenv', 11:53:37 INFO - 'install', 11:53:37 INFO - 'run-tests'), 11:53:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:53:37 INFO - 'download_minidump_stackwalk': True, 11:53:37 INFO - 'download_symbols': 'ondemand', 11:53:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:53:37 INFO - 'tooltool.py': '/tools/tooltool.py', 11:53:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:53:37 INFO - '/tools/misc-python/virtualenv.py')}, 11:53:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:53:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:53:37 INFO - 'installer_path': 'installer.exe', 11:53:37 INFO - 'log_level': 'info', 11:53:37 INFO - 'log_name': 'talos', 11:53:37 INFO - 'log_to_console': True, 11:53:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:53:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:53:37 INFO - 'opt_config_files': (), 11:53:37 INFO - 'pip_index': False, 11:53:37 INFO - 'sps_profile': False, 11:53:37 INFO - 'sps_profile_interval': 0, 11:53:37 INFO - 'suite': 'dromaeojs-e10s', 11:53:37 INFO - 'system_bits': '64', 11:53:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:53:37 INFO - 'title': 'talos-linux64-ix-058', 11:53:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:53:37 INFO - 'use_talos_json': True, 11:53:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:53:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:53:37 INFO - 'work_dir': 'build'} 11:53:37 INFO - ##### 11:53:37 INFO - ##### Running clobber step. 11:53:37 INFO - ##### 11:53:37 INFO - Running pre-action listener: _resource_record_pre_action 11:53:37 INFO - Running main action method: clobber 11:53:37 INFO - rmtree: /builds/slave/test-pgo/build 11:53:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:53:42 INFO - Running post-action listener: _resource_record_post_action 11:53:42 INFO - ##### 11:53:42 INFO - ##### Running read-buildbot-config step. 11:53:42 INFO - ##### 11:53:42 INFO - Running pre-action listener: _resource_record_pre_action 11:53:42 INFO - Running main action method: read_buildbot_config 11:53:42 INFO - Using buildbot properties: 11:53:42 INFO - { 11:53:42 INFO - "properties": { 11:53:42 INFO - "buildnumber": 418, 11:53:42 INFO - "product": "firefox", 11:53:42 INFO - "script_repo_revision": "production", 11:53:42 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 11:53:42 INFO - "repository": "", 11:53:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 11:53:42 INFO - "buildid": "20151112103103", 11:53:42 INFO - "slavename": "talos-linux64-ix-058", 11:53:42 INFO - "pgo_build": "True", 11:53:42 INFO - "basedir": "/builds/slave/test-pgo", 11:53:42 INFO - "project": "", 11:53:42 INFO - "platform": "ubuntu64_hw", 11:53:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:53:42 INFO - "slavebuilddir": "test", 11:53:42 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 11:53:42 INFO - "branch": "mozilla-inbound", 11:53:42 INFO - "repo_path": "integration/mozilla-inbound", 11:53:42 INFO - "stage_platform": "linux64-pgo", 11:53:42 INFO - "builduid": "62f8a67f96b54bb7b8478f375308fa14", 11:53:42 INFO - "revision": "335c2779216be1186d937a95f29d082d8a4045d6" 11:53:42 INFO - }, 11:53:42 INFO - "sourcestamp": { 11:53:42 INFO - "repository": "", 11:53:42 INFO - "hasPatch": false, 11:53:42 INFO - "project": "", 11:53:42 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 11:53:42 INFO - "changes": [ 11:53:42 INFO - { 11:53:42 INFO - "category": null, 11:53:42 INFO - "files": [ 11:53:42 INFO - { 11:53:42 INFO - "url": null, 11:53:42 INFO - "name": "https://queue.taskcluster.net/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 11:53:42 INFO - } 11:53:42 INFO - ], 11:53:42 INFO - "repository": "", 11:53:42 INFO - "rev": "335c2779216be1186d937a95f29d082d8a4045d6", 11:53:42 INFO - "who": "sendchange", 11:53:42 INFO - "when": 1447357939, 11:53:42 INFO - "number": 6654515, 11:53:42 INFO - "comments": "", 11:53:42 INFO - "project": "", 11:53:42 INFO - "at": "Thu 12 Nov 2015 11:52:19", 11:53:42 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 11:53:42 INFO - "revlink": "", 11:53:42 INFO - "properties": [ 11:53:42 INFO - [ 11:53:42 INFO - "buildid", 11:53:42 INFO - "20151112103103", 11:53:42 INFO - "Change" 11:53:42 INFO - ], 11:53:42 INFO - [ 11:53:42 INFO - "builduid", 11:53:42 INFO - "62f8a67f96b54bb7b8478f375308fa14", 11:53:42 INFO - "Change" 11:53:42 INFO - ], 11:53:42 INFO - [ 11:53:42 INFO - "pgo_build", 11:53:42 INFO - "True", 11:53:42 INFO - "Change" 11:53:42 INFO - ] 11:53:42 INFO - ], 11:53:42 INFO - "revision": "335c2779216be1186d937a95f29d082d8a4045d6" 11:53:42 INFO - } 11:53:42 INFO - ], 11:53:42 INFO - "revision": "335c2779216be1186d937a95f29d082d8a4045d6" 11:53:42 INFO - } 11:53:42 INFO - } 11:53:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 11:53:42 INFO - Running post-action listener: _resource_record_post_action 11:53:42 INFO - ##### 11:53:42 INFO - ##### Running download-and-extract step. 11:53:42 INFO - ##### 11:53:42 INFO - Running pre-action listener: _resource_record_pre_action 11:53:42 INFO - Running main action method: download_and_extract 11:53:42 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:53: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')]} 11:53:42 INFO - https://queue.taskcluster.net/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:53:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/test_packages.json 11:53:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/test_packages.json 11:53:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:53:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:53:44 INFO - Downloaded 1302 bytes. 11:53:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:53:44 INFO - Using the following test package requirements: 11:53:44 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:53:44 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:53:44 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:44 INFO - u'jsshell-linux-x86_64.zip'], 11:53:44 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:53:44 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:53:44 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:53:44 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:53:44 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:53:44 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:53:44 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:53:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:44 INFO - https://queue.taskcluster.net/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:53:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:53:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:53:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:53:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:53:55 INFO - Downloaded 22443847 bytes. 11:53:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:53:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:53:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:53:56 INFO - Return code: 0 11:53:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:56 INFO - https://queue.taskcluster.net/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:53:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:53:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:53:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:53:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:53:57 INFO - Downloaded 22443847 bytes. 11:53:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:53:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:53:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:53:58 INFO - Return code: 0 11:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:58 INFO - https://queue.taskcluster.net/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:53:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:53:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:53:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:53:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:54:00 INFO - Downloaded 11131693 bytes. 11:54:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 11:54:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:54:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:54:00 INFO - Return code: 0 11:54:00 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')]} 11:54:00 INFO - https://queue.taskcluster.net/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:54:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:54:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:54:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:54:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:54:01 INFO - Downloaded 57172229 bytes. 11:54:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:54:01 INFO - mkdir: /builds/slave/test-pgo/properties 11:54:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:54:01 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:54:01 INFO - Contents: 11:54:01 INFO - build_url:https://queue.taskcluster.net/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:54:01 INFO - Running post-action listener: _resource_record_post_action 11:54:01 INFO - Running post-action listener: set_extra_try_arguments 11:54:01 INFO - ##### 11:54:01 INFO - ##### Running populate-webroot step. 11:54:01 INFO - ##### 11:54:01 INFO - Running pre-action listener: _resource_record_pre_action 11:54:01 INFO - Running main action method: populate_webroot 11:54:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:54:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:54:01 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:54:01 INFO - '../fennec_ids.txt'], 11:54:01 INFO - 'tests': ['tcheck2']}, 11:54:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:54:01 INFO - '--tppagecycles', 11:54:01 INFO - '7'], 11:54:01 INFO - 'tests': ['tsvgm']}}, 11:54:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:54:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:54:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:54:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:54:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:54:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:54:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:54:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:01 INFO - 'talos_options': ['--e10s'], 11:54:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:54:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:01 INFO - 'tests': ['damp', 'tps']}, 11:54:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:01 INFO - 'talos_options': ['--e10s'], 11:54:01 INFO - 'tests': ['damp', 'tps']}, 11:54:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:54:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:54:01 INFO - 'other': {'tests': ['a11yr', 11:54:01 INFO - 'ts_paint', 11:54:01 INFO - 'tpaint', 11:54:01 INFO - 'sessionrestore', 11:54:01 INFO - 'sessionrestore_no_auto_restore']}, 11:54:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:54:01 INFO - 'tests': ['a11yr', 11:54:01 INFO - 'ts_paint', 11:54:01 INFO - 'tpaint', 11:54:01 INFO - 'sessionrestore', 11:54:01 INFO - 'sessionrestore_no_auto_restore']}, 11:54:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:54:01 INFO - 'tests': ['a11yr', 11:54:01 INFO - 'ts_paint', 11:54:01 INFO - 'tpaint', 11:54:01 INFO - 'sessionrestore', 11:54:01 INFO - 'sessionrestore_no_auto_restore']}, 11:54:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:54:01 INFO - 'tests': ['a11yr', 11:54:01 INFO - 'ts_paint', 11:54:01 INFO - 'tpaint', 11:54:01 INFO - 'sessionrestore', 11:54:01 INFO - 'sessionrestore_no_auto_restore']}, 11:54:01 INFO - 'other_l64': {'tests': ['a11yr', 11:54:01 INFO - 'ts_paint', 11:54:01 INFO - 'tpaint', 11:54:01 INFO - 'sessionrestore', 11:54:01 INFO - 'sessionrestore_no_auto_restore']}, 11:54:01 INFO - 'other_nol64': {'tests': ['a11yr', 11:54:01 INFO - 'ts_paint', 11:54:01 INFO - 'tpaint', 11:54:01 INFO - 'sessionrestore', 11:54:01 INFO - 'sessionrestore_no_auto_restore']}, 11:54:01 INFO - 'svgr': {'tests': ['tsvgx', 11:54:01 INFO - 'tsvgr_opacity', 11:54:01 INFO - 'tart', 11:54:01 INFO - 'tscrollx', 11:54:01 INFO - 'cart']}, 11:54:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:54:01 INFO - 'tests': ['tsvgx', 11:54:01 INFO - 'tsvgr_opacity', 11:54:01 INFO - 'tart', 11:54:01 INFO - 'tscrollx', 11:54:01 INFO - 'cart']}, 11:54:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:01 INFO - 'tests': ['tp5o']}, 11:54:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:01 INFO - 'talos_options': ['--e10s'], 11:54:01 INFO - 'tests': ['tp5o']}, 11:54:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:01 INFO - 'talos_options': ['--xperf_path', 11:54:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:54:01 INFO - 'tests': ['tp5n']}, 11:54:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:01 INFO - 'talos_options': ['--e10s', 11:54:01 INFO - '--xperf_path', 11:54:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:54:01 INFO - 'tests': ['tp5n']}}, 11:54:01 INFO - 'talos.zip': {'path': '', 11:54:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:54:01 INFO - Running post-action listener: _resource_record_post_action 11:54:01 INFO - ##### 11:54:01 INFO - ##### Running create-virtualenv step. 11:54:01 INFO - ##### 11:54:01 INFO - Running pre-action listener: _resource_record_pre_action 11:54:01 INFO - Running main action method: create_virtualenv 11:54:01 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:54:01 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 11:54:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:54:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:54:01 INFO - Using real prefix '/usr' 11:54:01 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:54:02 INFO - Installing distribute.............................................................................................................................................................................................done. 11:54:04 INFO - Installing pip.................done. 11:54:04 INFO - Return code: 0 11:54:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:54:04 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')]} 11:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:04 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')]} 11:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fd7081b5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc48c0>, '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 0xf71420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf718b0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906', '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 11:54:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 11:54:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 11:54:04 INFO - Using env: {'DISPLAY': ':0', 11:54:04 INFO - 'HOME': '/home/cltbld', 11:54:04 INFO - 'LANG': 'en_US.UTF-8', 11:54:04 INFO - 'LANGUAGE': 'en_US:en', 11:54:04 INFO - 'LOGNAME': 'cltbld', 11:54:04 INFO - 'MAIL': '/var/mail/cltbld', 11:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:04 INFO - 'MOZ_NO_REMOTE': '1', 11:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:04 INFO - 'NO_EM_RESTART': '1', 11:54:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:54:04 INFO - 'PWD': '/builds/slave/test-pgo', 11:54:04 INFO - 'SHELL': '/bin/bash', 11:54:04 INFO - 'SHLVL': '1', 11:54:04 INFO - 'TERM': 'linux', 11:54:04 INFO - 'TMOUT': '86400', 11:54:04 INFO - 'USER': 'cltbld', 11:54:04 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906', 11:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:04 INFO - '_': '/tools/buildbot/bin/python'} 11:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:04 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 11:54:04 INFO - Cleaning up... 11:54:04 INFO - Return code: 0 11:54:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:54:04 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')]} 11:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:04 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')]} 11:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fd7081b5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc48c0>, '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 0xf71420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf718b0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906', '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 11:54:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 11:54:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 11:54:04 INFO - Using env: {'DISPLAY': ':0', 11:54:04 INFO - 'HOME': '/home/cltbld', 11:54:04 INFO - 'LANG': 'en_US.UTF-8', 11:54:04 INFO - 'LANGUAGE': 'en_US:en', 11:54:04 INFO - 'LOGNAME': 'cltbld', 11:54:04 INFO - 'MAIL': '/var/mail/cltbld', 11:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:04 INFO - 'MOZ_NO_REMOTE': '1', 11:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:04 INFO - 'NO_EM_RESTART': '1', 11:54:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:54:04 INFO - 'PWD': '/builds/slave/test-pgo', 11:54:04 INFO - 'SHELL': '/bin/bash', 11:54:04 INFO - 'SHLVL': '1', 11:54:04 INFO - 'TERM': 'linux', 11:54:04 INFO - 'TMOUT': '86400', 11:54:04 INFO - 'USER': 'cltbld', 11:54:04 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906', 11:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:04 INFO - '_': '/tools/buildbot/bin/python'} 11:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:04 INFO - Downloading/unpacking psutil>=0.7.1 11:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:06 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 11:54:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:54:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:54:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:54:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:54:06 INFO - Installing collected packages: psutil 11:54:06 INFO - Running setup.py install for psutil 11:54:06 INFO - building 'psutil._psutil_linux' extension 11:54:06 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 11:54:06 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 11:54:06 INFO - building 'psutil._psutil_posix' extension 11:54:06 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 11:54:06 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 11:54:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:54:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:54:06 INFO - Successfully installed psutil 11:54:06 INFO - Cleaning up... 11:54:06 INFO - Return code: 0 11:54:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:54:06 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')]} 11:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:06 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')]} 11:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fd7081b5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc48c0>, '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 0xf71420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf718b0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906', '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 11:54:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 11:54:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 11:54:06 INFO - Using env: {'DISPLAY': ':0', 11:54:06 INFO - 'HOME': '/home/cltbld', 11:54:06 INFO - 'LANG': 'en_US.UTF-8', 11:54:06 INFO - 'LANGUAGE': 'en_US:en', 11:54:06 INFO - 'LOGNAME': 'cltbld', 11:54:06 INFO - 'MAIL': '/var/mail/cltbld', 11:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:06 INFO - 'MOZ_NO_REMOTE': '1', 11:54:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:06 INFO - 'NO_EM_RESTART': '1', 11:54:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:54:06 INFO - 'PWD': '/builds/slave/test-pgo', 11:54:06 INFO - 'SHELL': '/bin/bash', 11:54:06 INFO - 'SHLVL': '1', 11:54:06 INFO - 'TERM': 'linux', 11:54:06 INFO - 'TMOUT': '86400', 11:54:06 INFO - 'USER': 'cltbld', 11:54:06 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906', 11:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:06 INFO - '_': '/tools/buildbot/bin/python'} 11:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:54:07 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 11:54:07 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 11:54:07 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 11:54:07 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 11:54:07 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 11:54:07 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 11:54:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:54:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:54:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:54:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:54:08 INFO - Installing collected packages: mozsystemmonitor 11:54:08 INFO - Running setup.py install for mozsystemmonitor 11:54:08 INFO - Successfully installed mozsystemmonitor 11:54:08 INFO - Cleaning up... 11:54:08 INFO - Return code: 0 11:54:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fd7081b5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc48c0>, '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 0xf71420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf718b0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906', '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 11:54:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 11:54:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 11:54:08 INFO - Using env: {'DISPLAY': ':0', 11:54:08 INFO - 'HOME': '/home/cltbld', 11:54:08 INFO - 'LANG': 'en_US.UTF-8', 11:54:08 INFO - 'LANGUAGE': 'en_US:en', 11:54:08 INFO - 'LOGNAME': 'cltbld', 11:54:08 INFO - 'MAIL': '/var/mail/cltbld', 11:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:08 INFO - 'MOZ_NO_REMOTE': '1', 11:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:08 INFO - 'NO_EM_RESTART': '1', 11:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:54:08 INFO - 'PWD': '/builds/slave/test-pgo', 11:54:08 INFO - 'SHELL': '/bin/bash', 11:54:08 INFO - 'SHLVL': '1', 11:54:08 INFO - 'TERM': 'linux', 11:54:08 INFO - 'TMOUT': '86400', 11:54:08 INFO - 'USER': 'cltbld', 11:54:08 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906', 11:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:08 INFO - '_': '/tools/buildbot/bin/python'} 11:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:09 INFO - Downloading/unpacking blobuploader==1.2.4 11:54:09 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 11:54:09 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 11:54:09 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 11:54:09 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 11:54:09 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 11:54:09 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 11:54:10 INFO - Downloading blobuploader-1.2.4.tar.gz 11:54:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:54:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:54:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:54:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:54:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:54:11 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 11:54:11 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 11:54:11 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 11:54:11 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 11:54:11 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 11:54:11 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 11:54:11 INFO - Downloading docopt-0.6.1.tar.gz 11:54:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:54:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:54:11 INFO - Installing collected packages: blobuploader, requests, docopt 11:54:11 INFO - Running setup.py install for blobuploader 11:54:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:54:11 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:54:11 INFO - Running setup.py install for requests 11:54:11 INFO - Running setup.py install for docopt 11:54:12 INFO - Successfully installed blobuploader requests docopt 11:54:12 INFO - Cleaning up... 11:54:12 INFO - Return code: 0 11:54:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fd7081b5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc48c0>, '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 0xf71420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf718b0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906', '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 11:54:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 11:54:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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 11:54:12 INFO - Using env: {'DISPLAY': ':0', 11:54:12 INFO - 'HOME': '/home/cltbld', 11:54:12 INFO - 'LANG': 'en_US.UTF-8', 11:54:12 INFO - 'LANGUAGE': 'en_US:en', 11:54:12 INFO - 'LOGNAME': 'cltbld', 11:54:12 INFO - 'MAIL': '/var/mail/cltbld', 11:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:12 INFO - 'MOZ_NO_REMOTE': '1', 11:54:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:12 INFO - 'NO_EM_RESTART': '1', 11:54:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:54:12 INFO - 'PWD': '/builds/slave/test-pgo', 11:54:12 INFO - 'SHELL': '/bin/bash', 11:54:12 INFO - 'SHLVL': '1', 11:54:12 INFO - 'TERM': 'linux', 11:54:12 INFO - 'TMOUT': '86400', 11:54:12 INFO - 'USER': 'cltbld', 11:54:12 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906', 11:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:12 INFO - '_': '/tools/buildbot/bin/python'} 11:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:54:12 INFO - Running setup.py (path:/tmp/pip-54cZON-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:54:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:54:12 INFO - Running setup.py (path:/tmp/pip-gZF3Vr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:54:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:54:12 INFO - Running setup.py (path:/tmp/pip-qbqLsX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:54:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:54:12 INFO - Running setup.py (path:/tmp/pip-z8xnWk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:54:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:54:12 INFO - Running setup.py (path:/tmp/pip-JvG8VV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:54:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:54:12 INFO - Running setup.py (path:/tmp/pip-TypDpz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:54:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:54:12 INFO - Running setup.py (path:/tmp/pip-4zJz1a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:54:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:54:12 INFO - Running setup.py (path:/tmp/pip-ERswRf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:54:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:54:12 INFO - Running setup.py (path:/tmp/pip-WH5BPL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:54:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:54:12 INFO - Running setup.py (path:/tmp/pip-sHGzW7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:54:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:54:13 INFO - Running setup.py (path:/tmp/pip-Wce2Qv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:54:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:54:13 INFO - Running setup.py (path:/tmp/pip-gVMMuL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:54:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:54:13 INFO - Running setup.py (path:/tmp/pip-CzgtOa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:54:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:54:13 INFO - Running setup.py (path:/tmp/pip-AnRfB2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:54:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:54:13 INFO - Running setup.py (path:/tmp/pip-feFPUi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:54:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:54:13 INFO - Running setup.py (path:/tmp/pip-O1HOjQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:54:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:54:13 INFO - Running setup.py (path:/tmp/pip-3YbMox-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:54:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:54:13 INFO - Running setup.py install for manifestparser 11:54:13 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:54:13 INFO - Running setup.py install for mozcrash 11:54:13 INFO - Running setup.py install for mozdebug 11:54:13 INFO - Running setup.py install for mozdevice 11:54:13 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:54:13 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:54:13 INFO - Running setup.py install for mozfile 11:54:14 INFO - Running setup.py install for mozhttpd 11:54:14 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:54:14 INFO - Running setup.py install for mozinfo 11:54:14 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:54:14 INFO - Running setup.py install for mozInstall 11:54:14 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:54:14 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:54:14 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:54:14 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:54:14 INFO - Running setup.py install for mozleak 11:54:14 INFO - Running setup.py install for mozlog 11:54:14 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:54:14 INFO - Running setup.py install for moznetwork 11:54:14 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:54:14 INFO - Running setup.py install for mozprocess 11:54:14 INFO - Running setup.py install for mozprofile 11:54:14 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:54:14 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:54:14 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:54:14 INFO - Running setup.py install for mozrunner 11:54:14 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:54:15 INFO - Running setup.py install for mozscreenshot 11:54:15 INFO - Running setup.py install for moztest 11:54:15 INFO - Running setup.py install for mozversion 11:54:15 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:54:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:54:15 INFO - Cleaning up... 11:54:15 INFO - Return code: 0 11:54:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:54: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')]} 11:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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')]} 11:54:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fd7081b5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc48c0>, '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 0xf71420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf718b0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906', '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 11:54:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 11:54:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 11:54:15 INFO - Using env: {'DISPLAY': ':0', 11:54:15 INFO - 'HOME': '/home/cltbld', 11:54:15 INFO - 'LANG': 'en_US.UTF-8', 11:54:15 INFO - 'LANGUAGE': 'en_US:en', 11:54:15 INFO - 'LOGNAME': 'cltbld', 11:54:15 INFO - 'MAIL': '/var/mail/cltbld', 11:54:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:15 INFO - 'MOZ_NO_REMOTE': '1', 11:54:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:15 INFO - 'NO_EM_RESTART': '1', 11:54:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:54:15 INFO - 'PWD': '/builds/slave/test-pgo', 11:54:15 INFO - 'SHELL': '/bin/bash', 11:54:15 INFO - 'SHLVL': '1', 11:54:15 INFO - 'TERM': 'linux', 11:54:15 INFO - 'TMOUT': '86400', 11:54:15 INFO - 'USER': 'cltbld', 11:54:15 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906', 11:54:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:15 INFO - '_': '/tools/buildbot/bin/python'} 11:54:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:54:15 INFO - Running setup.py (path:/tmp/pip-w_kloR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:54:15 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)) 11:54:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:54:15 INFO - Running setup.py (path:/tmp/pip-DjKAi8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:54:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:54:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:54:15 INFO - Running setup.py (path:/tmp/pip-V4Z0rj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:54:15 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)) 11:54:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:54:15 INFO - Running setup.py (path:/tmp/pip-XJAyFz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:54:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 11:54:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:54:15 INFO - Running setup.py (path:/tmp/pip-toFVAo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:54:15 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)) 11:54:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:54:15 INFO - Running setup.py (path:/tmp/pip-BzqYyp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:54:15 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)) 11:54:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:54:15 INFO - Running setup.py (path:/tmp/pip-qVPRUb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:54:16 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)) 11:54:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:54:16 INFO - Running setup.py (path:/tmp/pip-nF448h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:54:16 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)) 11:54:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:54:16 INFO - Running setup.py (path:/tmp/pip-ZSDj6V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:54:16 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)) 11:54:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:54:16 INFO - Running setup.py (path:/tmp/pip-WukDW5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 11:54:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:54:16 INFO - Running setup.py (path:/tmp/pip-m5ZRhW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:54:16 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)) 11:54:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:54:16 INFO - Running setup.py (path:/tmp/pip-ObXPya-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:54:16 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)) 11:54:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:54:16 INFO - Running setup.py (path:/tmp/pip-oRSUTw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 11:54:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:54:16 INFO - Running setup.py (path:/tmp/pip-HRh4gB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:54:16 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)) 11:54:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:54:16 INFO - Running setup.py (path:/tmp/pip-HtcEXB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:54:16 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)) 11:54:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:54:16 INFO - Running setup.py (path:/tmp/pip-8B791V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:54:16 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)) 11:54:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:54:16 INFO - Running setup.py (path:/tmp/pip-7Kjw0v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:54:16 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)) 11:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:54:16 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)) 11:54:16 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:54:16 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:54:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:18 INFO - Downloading blessings-1.5.1.tar.gz 11:54:18 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 11:54:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:54:18 INFO - Installing collected packages: blessings 11:54:18 INFO - Running setup.py install for blessings 11:54:18 INFO - Successfully installed blessings 11:54:18 INFO - Cleaning up... 11:54:18 INFO - Return code: 0 11:54:18 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:54:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:54:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:54:19 INFO - Reading from file tmpfile_stdout 11:54:19 INFO - Current package versions: 11:54:19 INFO - argparse == 1.2.1 11:54:19 INFO - blessings == 1.5.1 11:54:19 INFO - blobuploader == 1.2.4 11:54:19 INFO - docopt == 0.6.1 11:54:19 INFO - manifestparser == 1.1 11:54:19 INFO - mozInstall == 1.12 11:54:19 INFO - mozcrash == 0.16 11:54:19 INFO - mozdebug == 0.1 11:54:19 INFO - mozdevice == 0.47 11:54:19 INFO - mozfile == 1.2 11:54:19 INFO - mozhttpd == 0.7 11:54:19 INFO - mozinfo == 0.9 11:54:19 INFO - mozleak == 0.1 11:54:19 INFO - mozlog == 3.0 11:54:19 INFO - moznetwork == 0.27 11:54:19 INFO - mozprocess == 0.22 11:54:19 INFO - mozprofile == 0.27 11:54:19 INFO - mozrunner == 6.11 11:54:19 INFO - mozscreenshot == 0.1 11:54:19 INFO - mozsystemmonitor == 0.0 11:54:19 INFO - moztest == 0.7 11:54:19 INFO - mozversion == 1.4 11:54:19 INFO - psutil == 3.1.1 11:54:19 INFO - requests == 1.2.3 11:54:19 INFO - wsgiref == 0.1.2 11:54:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fd7081b5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc48c0>, '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 0xf71420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf718b0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906', '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 11:54:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 11:54:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 11:54:19 INFO - Using env: {'DISPLAY': ':0', 11:54:19 INFO - 'HOME': '/home/cltbld', 11:54:19 INFO - 'LANG': 'en_US.UTF-8', 11:54:19 INFO - 'LANGUAGE': 'en_US:en', 11:54:19 INFO - 'LOGNAME': 'cltbld', 11:54:19 INFO - 'MAIL': '/var/mail/cltbld', 11:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:19 INFO - 'MOZ_NO_REMOTE': '1', 11:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:19 INFO - 'NO_EM_RESTART': '1', 11:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:54:19 INFO - 'PWD': '/builds/slave/test-pgo', 11:54:19 INFO - 'SHELL': '/bin/bash', 11:54:19 INFO - 'SHLVL': '1', 11:54:19 INFO - 'TERM': 'linux', 11:54:19 INFO - 'TMOUT': '86400', 11:54:19 INFO - 'USER': 'cltbld', 11:54:19 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906', 11:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:19 INFO - '_': '/tools/buildbot/bin/python'} 11:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:19 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 1)) 11:54:19 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 2)) 11:54:19 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 3)) 11:54:19 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 4)) 11:54:19 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 5)) 11:54:19 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 6)) 11:54:19 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 7)) 11:54:19 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 8)) 11:54:19 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:54:19 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 3)) 11:54:19 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:54:19 INFO - Cleaning up... 11:54:19 INFO - Return code: 0 11:54:19 INFO - Running post-action listener: _resource_record_post_action 11:54:19 INFO - Running post-action listener: _start_resource_monitoring 11:54:19 INFO - Starting resource monitoring. 11:54:19 INFO - ##### 11:54:19 INFO - ##### Running install step. 11:54:19 INFO - ##### 11:54:19 INFO - Running pre-action listener: _resource_record_pre_action 11:54:19 INFO - Running main action method: install 11:54:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:54:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:54:19 INFO - Reading from file tmpfile_stdout 11:54:19 INFO - Detecting whether we're running mozinstall >=1.0... 11:54:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:54:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:54:19 INFO - Reading from file tmpfile_stdout 11:54:19 INFO - Output received: 11:54:19 INFO - Usage: mozinstall [options] installer 11:54:19 INFO - Options: 11:54:19 INFO - -h, --help show this help message and exit 11:54:19 INFO - -d DEST, --destination=DEST 11:54:19 INFO - Directory to install application into. [default: 11:54:19 INFO - "/builds/slave/test-pgo"] 11:54:19 INFO - --app=APP Application being installed. [default: firefox] 11:54:19 INFO - mkdir: /builds/slave/test-pgo/build/application 11:54:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:54:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:54:34 INFO - Reading from file tmpfile_stdout 11:54:34 INFO - Output received: 11:54:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:54:34 INFO - Running post-action listener: _resource_record_post_action 11:54:34 INFO - ##### 11:54:34 INFO - ##### Running run-tests step. 11:54:34 INFO - ##### 11:54:34 INFO - Running pre-action listener: _resource_record_pre_action 11:54:34 INFO - Running main action method: run_tests 11:54:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:54:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:54:34 INFO - Python 2.7.3 11:54:34 INFO - Return code: 0 11:54:34 INFO - grabbing minidump binary from tooltool 11:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:34 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 0xfc48c0>, '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 0xf71420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf718b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:54:34 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 11:54:34 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 11:54:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:54:34 INFO - Return code: 0 11:54:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:54:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:54:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:54:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:54:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:54:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 11:54:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost 11:54:34 INFO - Using env: {'DISPLAY': ':0', 11:54:34 INFO - 'HOME': '/home/cltbld', 11:54:34 INFO - 'LANG': 'en_US.UTF-8', 11:54:34 INFO - 'LANGUAGE': 'en_US:en', 11:54:34 INFO - 'LOGNAME': 'cltbld', 11:54:34 INFO - 'MAIL': '/var/mail/cltbld', 11:54:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:54:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:34 INFO - 'MOZ_NO_REMOTE': '1', 11:54:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:34 INFO - 'NO_EM_RESTART': '1', 11:54:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:54:34 INFO - 'PWD': '/builds/slave/test-pgo', 11:54:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:54:34 INFO - 'SHELL': '/bin/bash', 11:54:34 INFO - 'SHLVL': '1', 11:54:34 INFO - 'TERM': 'linux', 11:54:34 INFO - 'TMOUT': '86400', 11:54:34 INFO - 'USER': 'cltbld', 11:54:34 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906', 11:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:34 INFO - '_': '/tools/buildbot/bin/python'} 11:54:34 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] with output_timeout 3600 11:54:34 INFO - mozversion INFO | application_buildid: 20151112103103 11:54:34 INFO - mozversion INFO | application_changeset: 335c2779216be1186d937a95f29d082d8a4045d6 11:54:34 INFO - mozversion INFO | application_display_name: Nightly 11:54:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:54:34 INFO - mozversion INFO | application_name: Firefox 11:54:34 INFO - mozversion INFO | application_remotingname: firefox 11:54:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:54:34 INFO - mozversion INFO | application_vendor: Mozilla 11:54:34 INFO - mozversion INFO | application_version: 45.0a1 11:54:34 INFO - mozversion INFO | platform_buildid: 20151112103103 11:54:34 INFO - mozversion INFO | platform_changeset: 335c2779216be1186d937a95f29d082d8a4045d6 11:54:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:54:34 INFO - mozversion INFO | platform_version: 45.0a1 11:54:34 INFO - 2015-11-12 11:54:34,304 DEBUG : using testdate: 1447358074 11:54:34 INFO - 2015-11-12 11:54:34,304 DEBUG : actual date: 1447358074 11:54:34 INFO - 2015-11-12 11:54:34,313 INFO : starting webserver on 'localhost:36684' 11:54:34 INFO - 2015-11-12 11:54:34,314 INFO : Starting test suite talos-linux64-ix-058.e 11:54:34 INFO - 2015-11-12 11:54:34,314 INFO : Starting test dromaeo_css 11:54:34 INFO - 2015-11-12 11:54:34,314 DEBUG : operating with platform_type : linux_ 11:54:34 INFO - 2015-11-12 11:54:34,315 INFO : Initialising browser for dromaeo_css test... 11:54:34 INFO - 2015-11-12 11:54:34,327 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTpUh89/profile http://localhost:36684/getInfo.html 11:54:39 INFO - 2015-11-12 11:54:39,273 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:54:39 INFO - 2015-11-12 11:54:39,273 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:54:39 INFO - 2015-11-12 11:54:39,273 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:54:39 INFO - 2015-11-12 11:54:39,274 DEBUG : BROWSER_OUTPUT: __metrics 11:54:40 INFO - 2015-11-12 11:54:40,269 INFO : Browser initialized. 11:54:40 INFO - 2015-11-12 11:54:40,269 INFO : Running cycle 1/1 for dromaeo_css test... 11:54:40 INFO - 2015-11-12 11:54:40,270 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTpUh89/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:54:51 INFO - 2015-11-12 11:54:51,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 138612736 11:54:51 INFO - 2015-11-12 11:54:51,992 DEBUG : BROWSER_OUTPUT: 11:55:41 INFO - 2015-11-12 11:55:41,619 DEBUG : BROWSER_OUTPUT: 1447358141617 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] 11:57:50 INFO - 2015-11-12 11:57:50,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36684/tests/dromaeo/cssquery-ext.html) 11:57:51 INFO - 2015-11-12 11:57:51,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 146702336 11:57:51 INFO - 2015-11-12 11:57:51,452 DEBUG : BROWSER_OUTPUT: 12:00:53 INFO - 2015-11-12 12:00:53,346 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/dromaeo/cssquery-ext.html (next: http://localhost:36684/tests/dromaeo/cssquery-jquery.html) 12:00:53 INFO - 2015-11-12 12:00:53,932 DEBUG : BROWSER_OUTPUT: RSS: Main: 141185024 12:00:53 INFO - 2015-11-12 12:00:53,933 DEBUG : BROWSER_OUTPUT: 12:03:55 INFO - 2015-11-12 12:03:55,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36684/tests/dromaeo/cssquery-mootools.html) 12:03:56 INFO - 2015-11-12 12:03:56,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 142266368 12:03:56 INFO - 2015-11-12 12:03:56,118 DEBUG : BROWSER_OUTPUT: 12:06:57 INFO - 2015-11-12 12:06:57,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36684/tests/dromaeo/cssquery-prototype.html) 12:06:58 INFO - 2015-11-12 12:06:58,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 140529664 12:06:58 INFO - 2015-11-12 12:06:58,370 DEBUG : BROWSER_OUTPUT: 12:10:00 INFO - 2015-11-12 12:10:00,657 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36684/tests/dromaeo/cssquery-yui.html) 12:10:01 INFO - 2015-11-12 12:10:01,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 140427264 12:10:01 INFO - 2015-11-12 12:10:01,271 DEBUG : BROWSER_OUTPUT: 12:13:03 INFO - 2015-11-12 12:13:03,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/dromaeo/cssquery-yui.html (next: http://localhost:36684/tests/dromaeo/cssquery-dojo.html) 12:13:03 INFO - 2015-11-12 12:13:03,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 143302656 12:13:03 INFO - 2015-11-12 12:13:03,810 DEBUG : BROWSER_OUTPUT: 12:13:03 INFO - 2015-11-12 12:13:03,812 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:13:03 INFO - 2015-11-12 12:13:03,812 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:13:03 INFO - 2015-11-12 12:13:03,812 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:13:03 INFO - 2015-11-12 12:13:03,812 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:13:03 INFO - 2015-11-12 12:13:03,813 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3257.527658489519;3312.6356100828903;3322.2857085726564;3337.8331083445823;3355.731541476682;5438.7280635968245;5481.424450432702;5544.1960915667205;5566.109422492402;5567.582431317647;5451.936872309891;5509.862253443666;5542.168674698797;5550.306211723535;5587.720613969295;5066.1387564114;5149.176131818891;5208.609354298424;5236.502532259429;5238.371395432553;4983.651144419892;5003.799848006075;5059.6458247922665;5137.075326441239;5276.393214780311;4938.827141050082;4956.231784073474;5030.346055012861;5104.464031276718;5109.284700141983;5063.645544811865;5083.415407228142;5090.745462726886;5095.643304968654;5165.66423182492;5092.821751238689;5118.155504341817;5129.102407078746;5131.692098474104;5138.4347721750955;5314.548263397616;5324.1215199492035;5413.431589683105;5472.2338872557875;5480.561555075585;6050.818475445743;6089.847753806146;6100.176476175704;6108.938910610881;6109.266887973427;6150.538709596798;6153.784617538365;6155.261368635747;6158.84602884927;6163.845903852395;5556.972215138939;5636.71816409182;5666.065099258659;5716.914246286309;5761.769529218826;6150.569460137837;6192.938070619236;6195.101710252078;6204.410580994799;6206.782762603287;5902.468777810018;6037.607555508878;6044.425779550936;6046.27444706638;6048.395160484004;5958.225430694069;6028.909566356509;6033.125196846433;6044;6048.758049678052;6027.698615069229;6057.818265451955;6065.272167339859;6067.757289708362;6069.119977603223;5851.32709738377;5979.850503737442;6047.971844786397;6069.605475644069;6070.605410648293;4616.3306320584;4644.883877903079;4707.693999889996;4714.434267887876;4738.881527961759;4104.979475102606;4113.8971525711495;4115.8971025723995;4136.710430269853;4163.687723420756;5603.635763675429;5720.971395143081;5746.310442746813;5752.654840709571;5760.3951585083805;6103.031058999626;6120.908186377208;6144.463884028993;6168.19813424252;6177.4749146322165;5784.21913041734;5794.956907756644;5795.507381872588;5811.622244554175;5843.678597677169;5036.244563315532;5086.109930762102;5146.459621739738;5247.291615631841;5263.289455923401;6399.712012959335;6412.038194270804;6412.038194270896;6412.422881940648;6414.390632889868;6109.236345456818;6145.9692701536205;6146.877062458815;6155.2921414037955;6164.907526387197;6017.368176341596;6179.073139029002;6183.443490085914;6217.564770466024;6384.968075159594;6002.759889604367;6008.188894499187;6015.48868346178;6025.668588227514;6091;6050.697465126814;6060.393960603904;6103;6105.877882442415;6112.99135642614;5787.710614469175;5841.737121829613;5946.07835785454;5947.672877991752;5960.850978725566;5947.762089516371;5988.221531200916;5997.730102145327;6005.549583781147;6009.038553831366;5791.53667706574;5828.562857785599;5865.794697185578;5884.529237661062;5892.234009578728;5737.368889422077;5854.882902341844;5934.287885453773;5945.881082378415;6004.949133901462;5784.913226301693;5812.389699081705;5827.708614569339;5848;5852.970735146297 12:13:03 INFO - 2015-11-12 12:13:03,817 DEBUG : BROWSER_OUTPUT: |1;ext.html;586.1881294407248;610.5787006965196;611.8806832667626;613.7023543581364;614.1892701633842;38809.41785873211;39638.801805991;39824.60175398245;40115.79942100293;40366.79816600917;41196.794016029955;41826.7908660457;41872.58127418725;42017;42063.36904946428;8761.86857197141;8899.065598112169;8913.153250441197;8913.331500137483;8917.509536975464;8629.137086291383;8710;8719.782005449852;8739.4756314621;8765.991910930228;8782.25350845179;8805.427647202943;8844.159804818531;8847.33644976626;8868.645254189856;8687.782805429852;8750.606222719993;8753.737387878375;8754.518501482416;8772.517511536864;8598.87101693475;8716.171963663443;8728.825423491558;8750.34372422071;8760.167784060504;38680.22639547193;38748.41877371842;38806.80596596999;39148.41277380813;39325.41011884824;2830.1368082734757;2871.3252385689348;2889.1477014280836;2912.388398436331;2978.300099476621;29046.564301535494;29083;29543.409131817243;29600.407991840257;30941.22646933822;3567.9108022299392;3599.4240921452442;3619.3847046002243;3643.7267204959735;3655.9268814623824;277000;277267;277556;277971;279045.6047719769;40460.59539404627;41060.79469602633;41180.38229426561;54819.45180548223;55042.72478637661;41488;41667.7916610415;41752.791236043624;41817.79091104525;41882;12937.223766574036;13057.738845223043;13060.869391306156;13073.542426015043;13078.346082695827;11358.94320528392;11482.770344593062;11487.942560287145;11493.310401375944;11557.479913403917;13871.791923121162;14084.366203520865;14185.716285674229;14186.219757913208;14255.21596312192;5737.340205876294;5867.530597552186;5891;5892.970535147382;5911.172435858897;913.7030465098869;935.9766005849772;942.7313215733483;966.4587830814767;1013.5894962540183;27734.861325693244;27923.136141410127;28277.43445131127;28299.575506367422;28319;1027.814993301213;1051.731808388856;1071.1591400750374;1126.1666366888444;1186.104491109207;14313.427462901576;14537.418503259963;14578.781318280235;14799.482018129314;14821;343341;345524;346761;347499;347551;50911.7454412733;50987.490125099015;51057;51129.23306150411;51209.743951280005;1277.4251586785983;1283.2492991600018;1301.576987479092;1304.6281809684194;1329.0829327763813;25670.22989310324;26287.342816429744;26578;26691.19926402211;27029.864850676408;45745.77127114476;45776.771116144206;46304.53695463002;46373;46423.51823613175;333660;333978;334907;336387;336522;31945.520817188226;44431.33352999643;44450;44503.55496444994;45203.095938081715;42065.369019464124;42250;42583.148337032464;42892.57107429011;43200.56799432091;36463.63536364709;36510.269794604494;36655.81672091623;37147.442788358734;37296;37254.44118338281;37303.44044839275;40239.79880100581;40972.72218222475;41500;35586.46620300749;36114.09714757152;36115.097122572144;39806.40290395589;40372.1925561493;31188.220294492818;33073.33853322968;33301;33573.16067098342;33654;25721.871390642926;25810.741892581584;25900.22299331023;26147.39662143695;26158 12:13:03 INFO - 2015-11-12 12:13:03,817 DEBUG : BROWSER_OUTPUT: |2;jquery.html;346.2192755336715;352.82711471379014;353.54745925215724;354.62764097697413;355.49342187382973;12441;12937.935310323459;16662.666746665076;16769.490745832874;17589.120543972782;11388.430578471085;11490.195686301962;11601.65195044148;12126.45430955607;12259.203151795127;4569.657275704327;4693.436787585478;4703.882402939919;4707.576318131368;4709.481956984729;4412.426384570017;4546.795394207252;4561.1105834362315;4574.83988060418;4580.748058856761;4549.408576885;4581.725096494204;4819.421669399677;4927.014597080581;4953.281774142747;4845.2247640377545;4854.368932038848;4863.8540843774745;4865.635077369211;4881.975590122062;4423.955760442386;4425.358323043173;4427.845025424127;4434.445694288214;4435.268180750172;13332.533361332404;13352.799708004388;13503.729925401536;13728.45086196551;13733.313334333243;1977.9604407911904;2007.0065317667702;2030.715699802029;2050.3848845346483;2118.1739121742535;9923.90076099237;9991.200703943667;10034.598616055422;10225.539850706737;10331.328463649914;1617.1105891759485;1651.9587010324717;1678.3957775200918;1683.889395684093;1685.384834535398;57584.424155758745;58009;61771;64667.353326466604;65327.3467265326;6892.276310987374;6986.091808065021;7070.1515818101125;7119.181294151239;7119.252478489788;8381.874271885805;8402.78993025167;8423.410361274651;8433.114522975122;8444.704435344733;5697.059985102412;5720.456556627114;5737;5750.6262092963825;5769.798057067983;5908;5948;5993.101034844808;5998.970005149947;6005.459508644243;3298.2578919743346;3318.8672453101603;3326.6839650233187;3351.463765797461;3364.7308215342714;1172.513406936112;1183.6981569699844;1186.7567148734488;1190.6785168004762;1248.2385744695728;389.47809934687655;408.7594151749426;412.65337116822013;416.41909536196835;422.42128284250157;10103.141232995278;10586.894131058745;10642.787144257072;10753.892461075446;10801.24391292602;408.19178027505114;410.7083970381003;413.02938095475395;413.10768739523087;424.82369816525795;5701.116326969326;5758.62568933018;5782.479576838021;5872.530197584183;5901.996660567714;532749;533959;547122;550201;555725;71843.88371256056;72611;77940;79594;80547.59726201331;533.8345113014977;547.9205515200274;550.5540512185063;551.3466542147568;551.8813455107171;10538.57845686164;11000.394978276272;11212.55149793999;11247.212695111264;11294.830577541508;35240.471392928615;35568.46647300344;35959.64040359563;36346.63653363432;37385.2522949534;45087.54912450965;46153.69231538477;46892.29661555011;47493.287600685326;47650.76174619105;6894.482913781587;6939.132608423947;6989.161300643956;7011.404030657452;7015.438764898694;12206.75586488283;12539.373031348214;12544.874551254736;12679.366031698562;12800.935995319964;10493.685189444328;10814.45927703596;10858.891411085788;11039.889601103887;11045.447727613426;10514.158867290751;10518.631847885288;10728.302660327054;10756.46217689128;10895.073918716998;10724.8927510727;11023.61417350389;11122.332660040423;11176.27354221973;11207;6857.622830744357;6865.965670171618;6951.652417379009;6966.442684585322;6971.337722916315;10426.791464170827;10482.475876206312;10594.417307047877;10603.151747860307;11217.60738374153 12:13:03 INFO - 2015-11-12 12:13:03,818 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1402.726468338674;1403.7052219034003;1531.4792970390065;1732.896026238425;1734.262938251243;6278.403551662596;6386.0420936859555;6394.744210231591;7543.585102819343;7957.32362749167;7682.769516914487;7685.462017658766;7732;7733.265339792725;7753.302202801747;2225.5215128747354;2275.0103704888343;2275.7951784339407;2277.567262220181;2277.6128058230142;2290.610596198642;2330.2310237621627;2334.953300933989;2337.0651739304244;2337.1586228957563;2223.4774827915508;2262.3778460923213;2267.6258417361114;2282.657601359793;2282.8744419056943;2238.373255488466;2290.164090107099;2294.908203671851;2311.237291693737;2319.988400058006;2136.583366243583;2180.9127634894585;2191.123550579765;2204.922827701023;2205.878676672782;7588.658510366991;7694.615269236516;7715.382769378436;7724.845503089963;7731.7680469586;4281.743095414286;4317.589828966243;4381.298992161271;4382.693211475198;4392.450943632046;3124.218945263684;3132.232603012254;3208.679132086796;3236.401265765841;3246.8863589774483;1007.89417111203;1008.5159123620704;1794.2733193056833;1803.9458816235403;1805.0884303426817;10619.097376722988;10675.893241067646;10689.679309620724;10693.358398496037;10703;3988.262171498282;3998.5001874765653;4064.9796751016056;4088.7137900347284;4120.835166593302;8568.785780355416;8594.742157735152;8601.526916019679;8611.95694021526;8621.396502244783;4375.256206444912;4394.1651086293505;4395.340698895127;4401.779911004437;4419.138268037702;4002.659773919191;4009.8195581198916;4037.37420699792;4043;4050.918981620351;3390.983045084759;3392.1350055736125;3408.880689175867;3410.8635654574036;3446.3968805458944;1041.5417216424748;1051.8948105189572;1058.343826827372;1066.402814423925;1077.6605369308643;993.0913214408735;997.002997002997;1100.4497751124438;1113.7549739057395;1234.8456442944632;7137.250588688113;7231.819204519824;7275.236100209508;7283;7283.890741638879;1109.4896347680158;1118.7315044389288;1134.4554613785429;1137.4653912661202;1157.0801213035656;5440.102383106743;5457.181422786613;5461.01701693691;5472.425395333512;5491.203775452537;9139.223166030963;9175.954120229357;9266.907330926739;9347.392419492711;9585.089416505421;9276;9331.766705832273;9336.673216437392;9349.532523373804;9359.344845860724;7029.367356937798;7162.391196748231;7219.350258476762;7225.096862892138;7362.300581444754;6949.791506254821;7004.4046256068805;7041.788746337618;7043.964780176067;7078.115235595551;8096.109427962801;8298;8308.459950103224;8398.95800521018;8447.070822209675;8522;8565.48607083577;8566.400351975302;8583.570821459027;8612;6648.6343251119715;6706.5640733352175;6871.725130994704;6880.69036893331;6896.517243793087;7419.109706835215;7483.064616922885;7491;7528;7539.623018849145;6204.224471941007;6756.560823546453;6958.234594194533;7044.295570442915;7241.058662373857;6631.436327912182;6848.1097457330225;6972.302769722987;7043;7151.2133665297815;6900.93099069023;7009;7074.257202993817;7089.113860767404;7102.18324892644;6383.585066970632;6392.360763923571;6419.582727122722;6424.967875160594;6425.5502114851515;6074.3318234994995;6266.843328916813;6272.278687950944;6495.935040649533;6550.050242714875 12:13:03 INFO - 2015-11-12 12:13:03,819 DEBUG : BROWSER_OUTPUT: |4;prototype.html;311.1055714819893;311.79250903602497;311.94073126106025;312.51092040955916;316.0817824220639;6216.285127210373;6311.842203944898;6318.178636777213;6364.522660800441;6372.840678983022;6061.696915154247;6251.4998800096;6259.436650701447;6273.9686301568545;6299.1496148020005;4681.859544213679;4699.765011749416;4714.127886341021;4735.242361222188;4736;4719.69321994071;4727.078219747151;4731.1720448921305;4735.337052812609;4735.526447355254;4630;4664.463586687523;4668.393108895839;4700.576948074672;4704.129735998834;4626.21354369758;4666.043461090469;4675.532446755331;4675.953240467603;4681.953180468203;4034.253663072341;4042.8180731867137;4044.5753195914594;4057.046594050396;4074.979625101885;5829.47534721877;5868.853278668024;5890.381509941437;5890.9410905891245;5921.940780592182;5195.974020129913;5311.840644780663;5321.680699158062;5329.813456529042;5434.347878254634;6526.086347911296;6544.836379090513;6546.639934803584;6554.442872355856;6558.704858281341;4319.67602429819;4328.156009578133;4333.58830911063;4338.826446942118;4340.782960851976;6696.129503164558;6819.863602727918;6850.21222559407;6866.862662746717;6904.378605925441;4403.3174857897075;4461.442319710036;4480.641548676098;4487.551244875486;4498.235299999008;4513.977430112828;4519.231730605805;4525.456945166601;4535.501094879561;4557.612602928722;5376.973115134478;5378.058839703036;5380.300560927054;5385.569154467633;5388.407275199725;6598.37315455031;6680.432163266079;6704.497162712719;6714.597124172467;6721.630310332978;1570.3012159588873;1590.2366863905158;1607.1883698732065;1609.8470645288678;1611.250768392703;1032.4063663393579;1035.3994683083793;1042.5204405973336;1043.0351924469835;1052.3002203534718;6309.684515774193;6391.58454700443;6394.840128996812;6396.552241343062;6414.069959855888;6808.11494505721;6809.931900681029;6819.283975182633;6819.5908245505425;6840.760573379908;6215.12988181655;6346.619202847844;6355.618662880242;6389.3291204423795;6394.168758061515;3706.4440333950124;3728.683061939711;3730.8880733577494;3732.9813350933073;3735.43968404736;7095.184053833772;7120.893186602205;7144.714211431588;7146.571205727673;7152.821179470451;6938.930610693828;6966.303369662993;7002.964985175042;7013.2986701329455;7028.664553734876;7251.963740181371;7320.707171713072;7324.121105467378;7327.74352897646;7349.485536012535;6887.862242755217;6914.101166848479;6917.654117294216;6943.618101004291;6962.259435141214;6773.89839152423;6837.829054273683;6839.281875403011;6909.7581584646305;6910.481713871581;7217.819554511179;7228.710851565878;7255.310745479171;7263.4915555910575;7269.382102521345;4499.1451624191295;4501.594856462934;4506.954930450654;4521.367008618862;4530.886727831698;6795;6948.166220053626;6954.652267386711;6973.930260697328;7001;6721.966390168018;6747.865042699217;6758.189017317954;6776.830579235559;6782;6716.429103526059;6729.495287853332;6741.797746067626;6763.966180169265;6782.525223234326;6428.164338635947;6578.8355291118105;6580.177477815273;6586.407223349922;6598.10925525048;6683.43190828785;6764.627945463047;6768.729250830109;6770.661466926733;6787.966060169668;6585.80242592723;6589.604623722592;6593.9120045192;6596.175478065242;6601.50488713358 12:13:03 INFO - 2015-11-12 12:13:03,821 DEBUG : BROWSER_OUTPUT: |5;yui.html;734.2363941500839;767.3745897093868;773.2460850670593;813.2518083363309;886.366248132585;13499.39252733627;13732.24472654005;13777.380017899193;14651.194184319886;14688.559343219693;12850.871491285085;12927.547535836247;12940.48238070476;12945.741085178292;12972.870271297284;776.0803447914211;779.0806847919453;785.0383280481421;785.505131766986;791.6714563456159;796.040770871099;803.7307501986842;804.2359758229705;806.1656185847648;808.3129340060931;831.2477208126655;835.5905606252953;836.5984327522792;840.865461526156;841.2512863551444;827.2182787266036;828.6768160417442;831.9417640765089;833.5790425834945;835.173178553234;598;599.2389665125266;602.7076867719153;604.7611193578556;609.4332270987979;13497.865021349857;13528.864711352859;13598.660033499144;13625.18248905059;13693;9809.607615695364;9842.507874606312;10344.689659310232;10364.170866330676;10722.142228621691;9890.505474726235;9996.750081247954;10010.749731256705;10054.648087316982;10185.439800810953;3144.7326977206967;3172.2228054126654;3189.3142974260413;3203.7276831469353;3284.310294838087;47700;47925.76037119827;48118.27822582664;48172;48199.5180048202;7078.539894906815;7190.1731300901065;7230.132384113835;7366.447516436181;7451;12326.50693972249;12348.691282718004;12401.379931003414;12423.31671758062;12430.192037517532;6657.251363638675;6815.7614483493835;6920.688569014406;6973.965130174317;7059.082319298561;4073.51117865858;4116.361963895601;4171.687123465752;4198.6641068714425;4219.641330486943;2645.7751091157083;2665.3736371952577;2672.0514217452915;2675.54515732326;2680.8927642894064;444.6398417282012;449.29236452587304;460.39228218751595;461.87529367070704;462.6275847942439;581.1892410087988;633.6008314761671;653.5229282623616;655.8524332025352;680.2347359220877;8494.660213591511;8870.467771933705;9036.367454278268;9372.67195648149;9638.710838674851;532.1060618161448;581.9854503637358;601.3655593349059;602.6672501069095;622.2470810319473;3908.4115597253713;3984.2828290907337;4039.111395492987;4167.770772607475;4176.979115104466;61609;62410.68794655998;62503.37496624976;62596.374036259964;62597.37402625915;53951.46048539543;54119;54549.72725136349;55006.44993550013;55376.723116384965;49733.25400119001;49771;49787.50212497901;50463.74768126136;50767;8318.542480163407;8323.583820809057;8520.914790852012;8742.737717868475;8828.117188281121;34117.658823411446;34353.312933740686;34696.653033469345;34810.65189348176;34954.30091398107;42291.788541057096;42467;45577.088458231316;46498.30252546147;47709.76145119252;7711.074671039287;7797.535586351254;7909.485883417559;7938.556925055069;7940.22040751622;11534.192606517463;11614.656163381662;11726.296422214695;11756.23584467007;11927.880721192678;10980.121590272918;11021.504032318404;11267.887321126684;11324.660260192208;11652.766944661229;10730.248882578144;10846;11166.274192177483;11187.21689481761;11643.825342620037;10072.546735396778;10376.792464150825;11798.997085247507;12181.756364872475;12187.451564679788;9407.764805879908;9452.763680908032;9454.669086581936;9619.326647134634;9865.802683946424;9084.227840633355;9389.530523473662;9588.37675551087;10006.549705263134;10040.849387259052 12:13:03 INFO - 2015-11-12 12:13:03,821 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:13:03 INFO - 2015-11-12 12:13:03,821 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:13:03 INFO - 2015-11-12 12:13:03,821 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,295 12:13:03 INFO - 2015-11-12 12:13:03,821 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:13:03 INFO - 2015-11-12 12:13:03,821 DEBUG : BROWSER_OUTPUT: __startTimestamp1447359183811__endTimestamp 12:13:03 INFO - 2015-11-12 12:13:03,821 DEBUG : BROWSER_OUTPUT: 12:13:03 INFO - 2015-11-12 12:13:03,821 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:13:03 INFO - 2015-11-12 12:13:03,821 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:13:03 INFO - 2015-11-12 12:13:03,822 DEBUG : BROWSER_OUTPUT: 12:13:03 INFO - 2015-11-12 12:13:03,822 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5619.77 Median:5843.68 stddev:651.96 (11.2%) stddev-sans-first:627.07 12:13:03 INFO - 2015-11-12 12:13:03,822 DEBUG : BROWSER_OUTPUT: Values: 3257.5 3312.6 3322.3 3337.8 3355.7 5438.7 5481.4 5544.2 5566.1 5567.6 5451.9 5509.9 5542.2 5550.3 5587.7 5066.1 5149.2 5208.6 5236.5 5238.4 4983.7 5003.8 5059.6 5137.1 5276.4 4938.8 4956.2 5030.3 5104.5 5109.3 5063.6 5083.4 5090.7 5095.6 5165.7 5092.8 5118.2 5129.1 5131.7 5138.4 5314.5 5324.1 5413.4 5472.2 5480.6 6050.8 6089.8 6100.2 6108.9 6109.3 6150.5 6153.8 6155.3 6158.8 6163.8 5557.0 5636.7 5666.1 5716.9 5761.8 6150.6 6192.9 6195.1 6204.4 6206.8 5902.5 6037.6 6044.4 6046.3 6048.4 5958.2 6028.9 6033.1 6044.0 6048.8 6027.7 6057.8 6065.3 6067.8 6069.1 5851.3 5979.9 6048.0 6069.6 6070.6 4616.3 4644.9 4707.7 4714.4 4738.9 4105.0 4113.9 4115.9 4136.7 4163.7 5603.6 5721.0 5746.3 5752.7 5760.4 6103.0 6120.9 6144.5 6168.2 6177.5 5784.2 5795.0 5795.5 5811.6 5843.7 5036.2 5086.1 5146.5 5247.3 5263.3 6399.7 6412.0 6412.0 6412.4 6414.4 6109.2 6146.0 6146.9 6155.3 6164.9 6017.4 6179.1 6183.4 6217.6 6385.0 6002.8 6008.2 6015.5 6025.7 6091.0 6050.7 6060.4 6103.0 6105.9 6113.0 5787.7 5841.7 5946.1 5947.7 5960.9 5947.8 5988.2 5997.7 6005.5 6009.0 5791.5 5828.6 5865.8 5884.5 5892.2 5737.4 5854.9 5934.3 5945.9 6004.9 5784.9 5812.4 5827.7 5848.0 5853.0 12:13:03 INFO - 2015-11-12 12:13:03,822 DEBUG : BROWSER_OUTPUT: 12:13:03 INFO - 2015-11-12 12:13:03,822 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47778.70 Median:37299.72 stddev:84205.15 (225.8%) stddev-sans-first:84366.81 12:13:03 INFO - 2015-11-12 12:13:03,824 DEBUG : BROWSER_OUTPUT: Values: 586.2 610.6 611.9 613.7 614.2 38809.4 39638.8 39824.6 40115.8 40366.8 41196.8 41826.8 41872.6 42017.0 42063.4 8761.9 8899.1 8913.2 8913.3 8917.5 8629.1 8710.0 8719.8 8739.5 8766.0 8782.3 8805.4 8844.2 8847.3 8868.6 8687.8 8750.6 8753.7 8754.5 8772.5 8598.9 8716.2 8728.8 8750.3 8760.2 38680.2 38748.4 38806.8 39148.4 39325.4 2830.1 2871.3 2889.1 2912.4 2978.3 29046.6 29083.0 29543.4 29600.4 30941.2 3567.9 3599.4 3619.4 3643.7 3655.9 277000.0 277267.0 277556.0 277971.0 279045.6 40460.6 41060.8 41180.4 54819.5 55042.7 41488.0 41667.8 41752.8 41817.8 41882.0 12937.2 13057.7 13060.9 13073.5 13078.3 11358.9 11482.8 11487.9 11493.3 11557.5 13871.8 14084.4 14185.7 14186.2 14255.2 5737.3 5867.5 5891.0 5893.0 5911.2 913.7 936.0 942.7 966.5 1013.6 27734.9 27923.1 28277.4 28299.6 28319.0 1027.8 1051.7 1071.2 1126.2 1186.1 14313.4 14537.4 14578.8 14799.5 14821.0 343341.0 345524.0 346761.0 347499.0 347551.0 50911.7 50987.5 51057.0 51129.2 51209.7 1277.4 1283.2 1301.6 1304.6 1329.1 25670.2 26287.3 26578.0 26691.2 27029.9 45745.8 45776.8 46304.5 46373.0 46423.5 333660.0 333978.0 334907.0 336387.0 336522.0 31945.5 44431.3 44450.0 44503.6 45203.1 42065.4 42250.0 42583.1 42892.6 43200.6 36463.6 36510.3 36655.8 37147.4 37296.0 37254.4 37303.4 40239.8 40972.7 41500.0 35586.5 36114.1 36115.1 39806.4 40372.2 31188.2 33073.3 33301.0 33573.2 33654.0 25721.9 25810.7 25900.2 26147.4 26158.0 12:13:03 INFO - 2015-11-12 12:13:03,824 DEBUG : BROWSER_OUTPUT: 12:13:03 INFO - 2015-11-12 12:13:03,824 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27024.67 Median:419.42 stddev:89189.42 (21264.9%) stddev-sans-first:89417.12 12:13:03 INFO - 2015-11-12 12:13:03,824 DEBUG : BROWSER_OUTPUT: Values: 346.2 352.8 353.5 354.6 355.5 12441.0 12937.9 16662.7 16769.5 17589.1 11388.4 11490.2 11601.7 12126.5 12259.2 4569.7 4693.4 4703.9 4707.6 4709.5 4412.4 4546.8 4561.1 4574.8 4580.7 4549.4 4581.7 4819.4 4927.0 4953.3 4845.2 4854.4 4863.9 4865.6 4882.0 4424.0 4425.4 4427.8 4434.4 4435.3 13332.5 13352.8 13503.7 13728.5 13733.3 1978.0 2007.0 2030.7 2050.4 2118.2 9923.9 9991.2 10034.6 10225.5 10331.3 1617.1 1652.0 1678.4 1683.9 1685.4 57584.4 58009.0 61771.0 64667.4 65327.3 6892.3 6986.1 7070.2 7119.2 7119.3 8381.9 8402.8 8423.4 8433.1 8444.7 5697.1 5720.5 5737.0 5750.6 5769.8 5908.0 5948.0 5993.1 5999.0 6005.5 3298.3 3318.9 3326.7 3351.5 3364.7 1172.5 1183.7 1186.8 1190.7 1248.2 389.5 408.8 412.7 416.4 422.4 10103.1 10586.9 10642.8 10753.9 10801.2 408.2 410.7 413.0 413.1 424.8 5701.1 5758.6 5782.5 5872.5 5902.0 532749.0 533959.0 547122.0 550201.0 555725.0 71843.9 72611.0 77940.0 79594.0 80547.6 533.8 547.9 550.6 551.3 551.9 10538.6 11000.4 11212.6 11247.2 11294.8 35240.5 35568.5 35959.6 36346.6 37385.3 45087.5 46153.7 46892.3 47493.3 47650.8 6894.5 6939.1 6989.2 7011.4 7015.4 12206.8 12539.4 12544.9 12679.4 12800.9 10493.7 10814.5 10858.9 11039.9 11045.4 10514.2 10518.6 10728.3 10756.5 10895.1 10724.9 11023.6 11122.3 11176.3 11207.0 6857.6 6866.0 6951.7 6966.4 6971.3 10426.8 10482.5 10594.4 10603.2 11217.6 12:13:03 INFO - 2015-11-12 12:13:03,824 DEBUG : BROWSER_OUTPUT: 12:13:03 INFO - 2015-11-12 12:13:03,824 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5360.05 Median:6269.56 stddev:2772.33 (44.2%) stddev-sans-first:2764.15 12:13:03 INFO - 2015-11-12 12:13:03,826 DEBUG : BROWSER_OUTPUT: Values: 1402.7 1403.7 1531.5 1732.9 1734.3 6278.4 6386.0 6394.7 7543.6 7957.3 7682.8 7685.5 7732.0 7733.3 7753.3 2225.5 2275.0 2275.8 2277.6 2277.6 2290.6 2330.2 2335.0 2337.1 2337.2 2223.5 2262.4 2267.6 2282.7 2282.9 2238.4 2290.2 2294.9 2311.2 2320.0 2136.6 2180.9 2191.1 2204.9 2205.9 7588.7 7694.6 7715.4 7724.8 7731.8 4281.7 4317.6 4381.3 4382.7 4392.5 3124.2 3132.2 3208.7 3236.4 3246.9 1007.9 1008.5 1794.3 1803.9 1805.1 10619.1 10675.9 10689.7 10693.4 10703.0 3988.3 3998.5 4065.0 4088.7 4120.8 8568.8 8594.7 8601.5 8612.0 8621.4 4375.3 4394.2 4395.3 4401.8 4419.1 4002.7 4009.8 4037.4 4043.0 4050.9 3391.0 3392.1 3408.9 3410.9 3446.4 1041.5 1051.9 1058.3 1066.4 1077.7 993.1 997.0 1100.4 1113.8 1234.8 7137.3 7231.8 7275.2 7283.0 7283.9 1109.5 1118.7 1134.5 1137.5 1157.1 5440.1 5457.2 5461.0 5472.4 5491.2 9139.2 9176.0 9266.9 9347.4 9585.1 9276.0 9331.8 9336.7 9349.5 9359.3 7029.4 7162.4 7219.4 7225.1 7362.3 6949.8 7004.4 7041.8 7044.0 7078.1 8096.1 8298.0 8308.5 8399.0 8447.1 8522.0 8565.5 8566.4 8583.6 8612.0 6648.6 6706.6 6871.7 6880.7 6896.5 7419.1 7483.1 7491.0 7528.0 7539.6 6204.2 6756.6 6958.2 7044.3 7241.1 6631.4 6848.1 6972.3 7043.0 7151.2 6900.9 7009.0 7074.3 7089.1 7102.2 6383.6 6392.4 6419.6 6425.0 6425.6 6074.3 6266.8 6272.3 6495.9 6550.1 12:13:03 INFO - 2015-11-12 12:13:03,826 DEBUG : BROWSER_OUTPUT: 12:13:03 INFO - 2015-11-12 12:13:03,826 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5524.50 Median:6351.12 stddev:1731.04 (27.3%) stddev-sans-first:1691.09 12:13:03 INFO - 2015-11-12 12:13:03,826 DEBUG : BROWSER_OUTPUT: Values: 311.1 311.8 311.9 312.5 316.1 6216.3 6311.8 6318.2 6364.5 6372.8 6061.7 6251.5 6259.4 6274.0 6299.1 4681.9 4699.8 4714.1 4735.2 4736.0 4719.7 4727.1 4731.2 4735.3 4735.5 4630.0 4664.5 4668.4 4700.6 4704.1 4626.2 4666.0 4675.5 4676.0 4682.0 4034.3 4042.8 4044.6 4057.0 4075.0 5829.5 5868.9 5890.4 5890.9 5921.9 5196.0 5311.8 5321.7 5329.8 5434.3 6526.1 6544.8 6546.6 6554.4 6558.7 4319.7 4328.2 4333.6 4338.8 4340.8 6696.1 6819.9 6850.2 6866.9 6904.4 4403.3 4461.4 4480.6 4487.6 4498.2 4514.0 4519.2 4525.5 4535.5 4557.6 5377.0 5378.1 5380.3 5385.6 5388.4 6598.4 6680.4 6704.5 6714.6 6721.6 1570.3 1590.2 1607.2 1609.8 1611.3 1032.4 1035.4 1042.5 1043.0 1052.3 6309.7 6391.6 6394.8 6396.6 6414.1 6808.1 6809.9 6819.3 6819.6 6840.8 6215.1 6346.6 6355.6 6389.3 6394.2 3706.4 3728.7 3730.9 3733.0 3735.4 7095.2 7120.9 7144.7 7146.6 7152.8 6938.9 6966.3 7003.0 7013.3 7028.7 7252.0 7320.7 7324.1 7327.7 7349.5 6887.9 6914.1 6917.7 6943.6 6962.3 6773.9 6837.8 6839.3 6909.8 6910.5 7217.8 7228.7 7255.3 7263.5 7269.4 4499.1 4501.6 4507.0 4521.4 4530.9 6795.0 6948.2 6954.7 6973.9 7001.0 6722.0 6747.9 6758.2 6776.8 6782.0 6716.4 6729.5 6741.8 6764.0 6782.5 6428.2 6578.8 6580.2 6586.4 6598.1 6683.4 6764.6 6768.7 6770.7 6788.0 6585.8 6589.6 6593.9 6596.2 6601.5 12:13:03 INFO - 2015-11-12 12:13:03,826 DEBUG : BROWSER_OUTPUT: 12:13:03 INFO - 2015-11-12 12:13:03,826 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13678.28 Median:50125.62 stddev:16838.18 (33.6%) stddev-sans-first:16857.36 12:13:03 INFO - 2015-11-12 12:13:03,826 DEBUG : BROWSER_OUTPUT: Values: 734.2 767.4 773.2 813.3 886.4 13499.4 13732.2 13777.4 14651.2 14688.6 12850.9 12927.5 12940.5 12945.7 12972.9 776.1 779.1 785.0 785.5 791.7 796.0 803.7 804.2 806.2 808.3 831.2 835.6 836.6 840.9 841.3 827.2 828.7 831.9 833.6 835.2 598.0 599.2 602.7 604.8 609.4 13497.9 13528.9 13598.7 13625.2 13693.0 9809.6 9842.5 10344.7 10364.2 10722.1 9890.5 9996.8 10010.7 10054.6 10185.4 3144.7 3172.2 3189.3 3203.7 3284.3 47700.0 47925.8 48118.3 48172.0 48199.5 7078.5 7190.2 7230.1 7366.4 7451.0 12326.5 12348.7 12401.4 12423.3 12430.2 6657.3 6815.8 6920.7 6974.0 7059.1 4073.5 4116.4 4171.7 4198.7 4219.6 2645.8 2665.4 2672.1 2675.5 2680.9 444.6 449.3 460.4 461.9 462.6 581.2 633.6 653.5 655.9 680.2 8494.7 8870.5 9036.4 9372.7 9638.7 532.1 582.0 601.4 602.7 622.2 3908.4 3984.3 4039.1 4167.8 4177.0 61609.0 62410.7 62503.4 62596.4 62597.4 53951.5 54119.0 54549.7 55006.4 55376.7 49733.3 49771.0 49787.5 50463.7 50767.0 8318.5 8323.6 8520.9 8742.7 8828.1 34117.7 34353.3 34696.7 34810.7 34954.3 42291.8 42467.0 45577.1 46498.3 47709.8 7711.1 7797.5 7909.5 7938.6 7940.2 11534.2 11614.7 11726.3 11756.2 11927.9 10980.1 11021.5 11267.9 11324.7 11652.8 10730.2 10846.0 11166.3 11187.2 11643.8 10072.5 10376.8 11799.0 12181.8 12187.5 9407.8 9452.8 9454.7 9619.3 9865.8 9084.2 9389.5 9588.4 10006.5 10040.8 12:13:03 INFO - 2015-11-12 12:13:03,826 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:13:03 INFO - 2015-11-12 12:13:03,826 DEBUG : BROWSER_OUTPUT: 12:13:04 INFO - 2015-11-12 12:13:04,449 INFO : Browser exited with error code: 0 12:13:04 INFO - 2015-11-12 12:13:04,470 INFO : Completed test dromaeo_css (00:18:30) 12:13:04 INFO - 2015-11-12 12:13:04,470 INFO : Starting test kraken 12:13:04 INFO - 2015-11-12 12:13:04,470 DEBUG : operating with platform_type : linux_ 12:13:04 INFO - 2015-11-12 12:13:04,470 INFO : Initialising browser for kraken test... 12:13:04 INFO - 2015-11-12 12:13:04,476 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjMFx13/profile http://localhost:36684/getInfo.html 12:13:08 INFO - 2015-11-12 12:13:08,822 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:13:08 INFO - 2015-11-12 12:13:08,823 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:13:08 INFO - 2015-11-12 12:13:08,823 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:13:08 INFO - 2015-11-12 12:13:08,823 DEBUG : BROWSER_OUTPUT: __metrics 12:13:09 INFO - 2015-11-12 12:13:09,857 INFO : Browser initialized. 12:13:09 INFO - 2015-11-12 12:13:09,857 INFO : Running cycle 1/1 for kraken test... 12:13:09 INFO - 2015-11-12 12:13:09,858 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjMFx13/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:13:21 INFO - 2015-11-12 12:13:21,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 141352960 12:13:21 INFO - 2015-11-12 12:13:21,658 DEBUG : BROWSER_OUTPUT: 12:13:24 INFO - 2015-11-12 12:13:24,113 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36684/tests/kraken/driver.html?testName=audio-beat-detection) 12:13:24 INFO - 2015-11-12 12:13:24,720 DEBUG : BROWSER_OUTPUT: RSS: Main: 140955648 12:13:24 INFO - 2015-11-12 12:13:24,720 DEBUG : BROWSER_OUTPUT: 12:13:27 INFO - 2015-11-12 12:13:27,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36684/tests/kraken/driver.html?testName=audio-dft) 12:13:27 INFO - 2015-11-12 12:13:27,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 141500416 12:13:27 INFO - 2015-11-12 12:13:27,937 DEBUG : BROWSER_OUTPUT: 12:13:30 INFO - 2015-11-12 12:13:30,796 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36684/tests/kraken/driver.html?testName=audio-fft) 12:13:31 INFO - 2015-11-12 12:13:31,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 136900608 12:13:31 INFO - 2015-11-12 12:13:31,377 DEBUG : BROWSER_OUTPUT: 12:13:33 INFO - 2015-11-12 12:13:33,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36684/tests/kraken/driver.html?testName=audio-oscillator) 12:13:33 INFO - 2015-11-12 12:13:33,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 137433088 12:13:33 INFO - 2015-11-12 12:13:33,942 DEBUG : BROWSER_OUTPUT: 12:13:36 INFO - 2015-11-12 12:13:36,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36684/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:13:36 INFO - 2015-11-12 12:13:36,709 DEBUG : BROWSER_OUTPUT: RSS: Main: 137699328 12:13:36 INFO - 2015-11-12 12:13:36,709 DEBUG : BROWSER_OUTPUT: 12:13:39 INFO - 2015-11-12 12:13:39,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36684/tests/kraken/driver.html?testName=imaging-darkroom) 12:13:40 INFO - 2015-11-12 12:13:40,270 DEBUG : BROWSER_OUTPUT: RSS: Main: 137572352 12:13:40 INFO - 2015-11-12 12:13:40,270 DEBUG : BROWSER_OUTPUT: 12:13:43 INFO - 2015-11-12 12:13:43,652 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36684/tests/kraken/driver.html?testName=imaging-desaturate) 12:13:44 INFO - 2015-11-12 12:13:44,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 138379264 12:13:44 INFO - 2015-11-12 12:13:44,233 DEBUG : BROWSER_OUTPUT: 12:13:47 INFO - 2015-11-12 12:13:47,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36684/tests/kraken/driver.html?testName=json-parse-financial) 12:13:47 INFO - 2015-11-12 12:13:47,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 139104256 12:13:47 INFO - 2015-11-12 12:13:47,653 DEBUG : BROWSER_OUTPUT: 12:13:49 INFO - 2015-11-12 12:13:49,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36684/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:13:49 INFO - 2015-11-12 12:13:49,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 138125312 12:13:49 INFO - 2015-11-12 12:13:49,810 DEBUG : BROWSER_OUTPUT: 12:13:51 INFO - 2015-11-12 12:13:51,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36684/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:13:52 INFO - 2015-11-12 12:13:52,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 139444224 12:13:52 INFO - 2015-11-12 12:13:52,250 DEBUG : BROWSER_OUTPUT: 12:13:54 INFO - 2015-11-12 12:13:54,354 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36684/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:13:54 INFO - 2015-11-12 12:13:54,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 139751424 12:13:54 INFO - 2015-11-12 12:13:54,947 DEBUG : BROWSER_OUTPUT: 12:13:57 INFO - 2015-11-12 12:13:57,410 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36684/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:13:58 INFO - 2015-11-12 12:13:58,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 140029952 12:13:58 INFO - 2015-11-12 12:13:58,004 DEBUG : BROWSER_OUTPUT: 12:14:00 INFO - 2015-11-12 12:14:00,543 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36684/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:14:01 INFO - 2015-11-12 12:14:01,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 138747904 12:14:01 INFO - 2015-11-12 12:14:01,131 DEBUG : BROWSER_OUTPUT: 12:14:02 INFO - 2015-11-12 12:14:02,814 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36684/tests/kraken/driver.html?testName=ai-astar) 12:14:03 INFO - 2015-11-12 12:14:03,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 138772480 12:14:03 INFO - 2015-11-12 12:14:03,064 DEBUG : BROWSER_OUTPUT: 12:14:03 INFO - 2015-11-12 12:14:03,065 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:14:03 INFO - 2015-11-12 12:14:03,066 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:14:03 INFO - 2015-11-12 12:14:03,066 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:14:03 INFO - 2015-11-12 12:14:03,066 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:14:03 INFO - 2015-11-12 12:14:03,066 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;103;112;111;110;119;109;110;111;110 12:14:03 INFO - 2015-11-12 12:14:03,066 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;123;147;160;127;148;155;127;166;126 12:14:03 INFO - 2015-11-12 12:14:03,067 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;164;163;162;163;163;163;174;162 12:14:03 INFO - 2015-11-12 12:14:03,067 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;72;71;72;72;132;72;75;72 12:14:03 INFO - 2015-11-12 12:14:03,067 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;93;137;89;90;90;133;93;90;140 12:14:03 INFO - 2015-11-12 12:14:03,067 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;111;110;110;110;111;110 12:14:03 INFO - 2015-11-12 12:14:03,067 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;148;147;147;146;147;147;146;147 12:14:03 INFO - 2015-11-12 12:14:03,068 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;96;96;95;96;98;95;96;97 12:14:03 INFO - 2015-11-12 12:14:03,068 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;62;61;61;61;62;60;66;58;58 12:14:03 INFO - 2015-11-12 12:14:03,068 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;68;68;68;73;68;68;67;68 12:14:03 INFO - 2015-11-12 12:14:03,068 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;84;84;85;84;92;83;91;85 12:14:03 INFO - 2015-11-12 12:14:03,068 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;124;125;123;123;123;121;121;121;129 12:14:03 INFO - 2015-11-12 12:14:03,068 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;148;150;152;150;150;149;141;149;139 12:14:03 INFO - 2015-11-12 12:14:03,069 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;69;67;66;68;65;67;67;69;66 12:14:03 INFO - 2015-11-12 12:14:03,069 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:14:03 INFO - 2015-11-12 12:14:03,069 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:14:03 INFO - 2015-11-12 12:14:03,069 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,708 12:14:03 INFO - 2015-11-12 12:14:03,069 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:14:03 INFO - 2015-11-12 12:14:03,071 DEBUG : BROWSER_OUTPUT: __startTimestamp1447359243065__endTimestamp 12:14:03 INFO - 2015-11-12 12:14:03,071 DEBUG : BROWSER_OUTPUT: 12:14:03 INFO - 2015-11-12 12:14:03,074 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:14:03 INFO - 2015-11-12 12:14:03,074 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:14:03 INFO - 2015-11-12 12:14:03,074 DEBUG : BROWSER_OUTPUT: 12:14:03 INFO - 2015-11-12 12:14:03,074 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:3.89 (3.5%) stddev-sans-first:4.10 12:14:03 INFO - 2015-11-12 12:14:03,074 DEBUG : BROWSER_OUTPUT: Values: 112.0 103.0 112.0 111.0 110.0 119.0 109.0 110.0 111.0 110.0 12:14:03 INFO - 2015-11-12 12:14:03,075 DEBUG : BROWSER_OUTPUT: 12:14:03 INFO - 2015-11-12 12:14:03,075 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.60 Median:147.50 stddev:15.70 (10.6%) stddev-sans-first:16.57 12:14:03 INFO - 2015-11-12 12:14:03,075 DEBUG : BROWSER_OUTPUT: Values: 147.0 123.0 147.0 160.0 127.0 148.0 155.0 127.0 166.0 126.0 12:14:03 INFO - 2015-11-12 12:14:03,075 DEBUG : BROWSER_OUTPUT: 12:14:03 INFO - 2015-11-12 12:14:03,075 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:3.60 (2.2%) stddev-sans-first:3.76 12:14:03 INFO - 2015-11-12 12:14:03,075 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 164.0 163.0 162.0 163.0 163.0 163.0 174.0 162.0 12:14:03 INFO - 2015-11-12 12:14:03,075 DEBUG : BROWSER_OUTPUT: 12:14:03 INFO - 2015-11-12 12:14:03,075 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.30 Median:72.00 stddev:18.90 (26.2%) stddev-sans-first:19.95 12:14:03 INFO - 2015-11-12 12:14:03,075 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 72.0 71.0 72.0 72.0 132.0 72.0 75.0 72.0 12:14:03 INFO - 2015-11-12 12:14:03,075 DEBUG : BROWSER_OUTPUT: 12:14:03 INFO - 2015-11-12 12:14:03,075 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.40 Median:90.00 stddev:22.37 (24.9%) stddev-sans-first:23.02 12:14:03 INFO - 2015-11-12 12:14:03,075 DEBUG : BROWSER_OUTPUT: Values: 89.0 93.0 137.0 89.0 90.0 90.0 133.0 93.0 90.0 140.0 12:14:03 INFO - 2015-11-12 12:14:03,076 DEBUG : BROWSER_OUTPUT: 12:14:03 INFO - 2015-11-12 12:14:03,076 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:14:03 INFO - 2015-11-12 12:14:03,076 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 111.0 110.0 110.0 110.0 111.0 110.0 12:14:03 INFO - 2015-11-12 12:14:03,076 DEBUG : BROWSER_OUTPUT: 12:14:03 INFO - 2015-11-12 12:14:03,076 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 12:14:03 INFO - 2015-11-12 12:14:03,076 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 148.0 147.0 147.0 146.0 147.0 147.0 146.0 147.0 12:14:03 INFO - 2015-11-12 12:14:03,076 DEBUG : BROWSER_OUTPUT: 12:14:03 INFO - 2015-11-12 12:14:03,076 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.95 (1.0%) stddev-sans-first:0.97 12:14:03 INFO - 2015-11-12 12:14:03,076 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 96.0 96.0 95.0 96.0 98.0 95.0 96.0 97.0 12:14:03 INFO - 2015-11-12 12:14:03,076 DEBUG : BROWSER_OUTPUT: 12:14:03 INFO - 2015-11-12 12:14:03,076 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.10 Median:61.50 stddev:2.28 (3.7%) stddev-sans-first:2.40 12:14:03 INFO - 2015-11-12 12:14:03,076 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 61.0 61.0 61.0 62.0 60.0 66.0 58.0 58.0 12:14:03 INFO - 2015-11-12 12:14:03,076 DEBUG : BROWSER_OUTPUT: 12:14:03 INFO - 2015-11-12 12:14:03,076 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.00 stddev:1.65 (2.4%) stddev-sans-first:1.74 12:14:03 INFO - 2015-11-12 12:14:03,077 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 68.0 68.0 68.0 73.0 68.0 68.0 67.0 68.0 12:14:03 INFO - 2015-11-12 12:14:03,077 DEBUG : BROWSER_OUTPUT: 12:14:03 INFO - 2015-11-12 12:14:03,077 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:84.50 stddev:3.31 (3.9%) stddev-sans-first:3.39 12:14:03 INFO - 2015-11-12 12:14:03,077 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 84.0 84.0 85.0 84.0 92.0 83.0 91.0 85.0 12:14:03 INFO - 2015-11-12 12:14:03,077 DEBUG : BROWSER_OUTPUT: 12:14:03 INFO - 2015-11-12 12:14:03,077 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:123.50 stddev:2.67 (2.2%) stddev-sans-first:2.55 12:14:03 INFO - 2015-11-12 12:14:03,077 DEBUG : BROWSER_OUTPUT: Values: 127.0 124.0 125.0 123.0 123.0 123.0 121.0 121.0 121.0 129.0 12:14:03 INFO - 2015-11-12 12:14:03,077 DEBUG : BROWSER_OUTPUT: 12:14:03 INFO - 2015-11-12 12:14:03,077 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:149.50 stddev:4.99 (3.3%) stddev-sans-first:4.45 12:14:03 INFO - 2015-11-12 12:14:03,077 DEBUG : BROWSER_OUTPUT: Values: 139.0 148.0 150.0 152.0 150.0 150.0 149.0 141.0 149.0 139.0 12:14:03 INFO - 2015-11-12 12:14:03,077 DEBUG : BROWSER_OUTPUT: 12:14:03 INFO - 2015-11-12 12:14:03,077 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.33 (2.0%) stddev-sans-first:1.36 12:14:03 INFO - 2015-11-12 12:14:03,077 DEBUG : BROWSER_OUTPUT: Values: 66.0 69.0 67.0 66.0 68.0 65.0 67.0 67.0 69.0 66.0 12:14:03 INFO - 2015-11-12 12:14:03,077 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:14:03 INFO - 2015-11-12 12:14:03,078 DEBUG : BROWSER_OUTPUT: 12:14:03 INFO - 2015-11-12 12:14:03,937 INFO : Browser exited with error code: 0 12:14:03 INFO - 2015-11-12 12:14:03,988 INFO : Completed test kraken (00:00:59) 12:14:03 INFO - 2015-11-12 12:14:03,988 INFO : Starting test v8_7 12:14:03 INFO - 2015-11-12 12:14:03,988 DEBUG : operating with platform_type : linux_ 12:14:03 INFO - 2015-11-12 12:14:03,988 INFO : Initialising browser for v8_7 test... 12:14:03 INFO - 2015-11-12 12:14:03,994 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplC7wUI/profile http://localhost:36684/getInfo.html 12:14:08 INFO - 2015-11-12 12:14:08,479 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:14:08 INFO - 2015-11-12 12:14:08,479 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:14:08 INFO - 2015-11-12 12:14:08,479 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:14:08 INFO - 2015-11-12 12:14:08,479 DEBUG : BROWSER_OUTPUT: __metrics 12:14:09 INFO - 2015-11-12 12:14:09,553 INFO : Browser initialized. 12:14:09 INFO - 2015-11-12 12:14:09,553 INFO : Running cycle 1/1 for v8_7 test... 12:14:09 INFO - 2015-11-12 12:14:09,554 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplC7wUI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:14:21 INFO - 2015-11-12 12:14:21,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 141000704 12:14:21 INFO - 2015-11-12 12:14:21,288 DEBUG : BROWSER_OUTPUT: 12:14:42 INFO - 2015-11-12 12:14:42,633 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36684/tests/v8_7/run.html (next: http://localhost:36684/tests/v8_7/run.html) 12:14:42 INFO - 2015-11-12 12:14:42,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 137834496 12:14:42 INFO - 2015-11-12 12:14:42,883 DEBUG : BROWSER_OUTPUT: 12:14:42 INFO - 2015-11-12 12:14:42,884 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:14:42 INFO - 2015-11-12 12:14:42,884 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:14:42 INFO - 2015-11-12 12:14:42,884 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:14:42 INFO - 2015-11-12 12:14:42,884 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:14:42 INFO - 2015-11-12 12:14:42,884 DEBUG : BROWSER_OUTPUT: |0;Richards;162.94606485253382 12:14:42 INFO - 2015-11-12 12:14:42,884 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.34880123743233 12:14:42 INFO - 2015-11-12 12:14:42,884 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.135788585887 12:14:42 INFO - 2015-11-12 12:14:42,884 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 12:14:42 INFO - 2015-11-12 12:14:42,884 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1055.9662090813094 12:14:42 INFO - 2015-11-12 12:14:42,884 DEBUG : BROWSER_OUTPUT: |5;Earley;720.9805335255949 12:14:42 INFO - 2015-11-12 12:14:42,884 DEBUG : BROWSER_OUTPUT: |6;Boyer;11639.53488372093 12:14:42 INFO - 2015-11-12 12:14:42,884 DEBUG : BROWSER_OUTPUT: |7;RegExp;25000 12:14:42 INFO - 2015-11-12 12:14:42,885 DEBUG : BROWSER_OUTPUT: |8;Splay;569.1519635742743 12:14:42 INFO - 2015-11-12 12:14:42,885 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 12:14:42 INFO - 2015-11-12 12:14:42,885 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:14:42 INFO - 2015-11-12 12:14:42,885 DEBUG : BROWSER_OUTPUT: __startTimestamp1447359282881__endTimestamp 12:14:42 INFO - 2015-11-12 12:14:42,885 DEBUG : BROWSER_OUTPUT: 12:14:42 INFO - 2015-11-12 12:14:42,886 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:14:42 INFO - 2015-11-12 12:14:42,886 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:14:42 INFO - 2015-11-12 12:14:42,886 DEBUG : BROWSER_OUTPUT: 12:14:42 INFO - 2015-11-12 12:14:42,886 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.95 Median:162.95 stddev:0.00 (0.0%) 12:14:42 INFO - 2015-11-12 12:14:42,886 DEBUG : BROWSER_OUTPUT: Values: 162.9 12:14:42 INFO - 2015-11-12 12:14:42,886 DEBUG : BROWSER_OUTPUT: 12:14:42 INFO - 2015-11-12 12:14:42,886 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.35 Median:193.35 stddev:0.00 (0.0%) 12:14:42 INFO - 2015-11-12 12:14:42,887 DEBUG : BROWSER_OUTPUT: Values: 193.3 12:14:42 INFO - 2015-11-12 12:14:42,887 DEBUG : BROWSER_OUTPUT: 12:14:42 INFO - 2015-11-12 12:14:42,887 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.14 Median:281.14 stddev:0.00 (0.0%) 12:14:42 INFO - 2015-11-12 12:14:42,887 DEBUG : BROWSER_OUTPUT: Values: 281.1 12:14:42 INFO - 2015-11-12 12:14:42,887 DEBUG : BROWSER_OUTPUT: 12:14:42 INFO - 2015-11-12 12:14:42,887 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 12:14:42 INFO - 2015-11-12 12:14:42,888 DEBUG : BROWSER_OUTPUT: Values: 5040.2 12:14:42 INFO - 2015-11-12 12:14:42,888 DEBUG : BROWSER_OUTPUT: 12:14:42 INFO - 2015-11-12 12:14:42,888 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1055.97 Median:1055.97 stddev:0.00 (0.0%) 12:14:42 INFO - 2015-11-12 12:14:42,889 DEBUG : BROWSER_OUTPUT: Values: 1056.0 12:14:42 INFO - 2015-11-12 12:14:42,889 DEBUG : BROWSER_OUTPUT: 12:14:42 INFO - 2015-11-12 12:14:42,889 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:720.98 Median:720.98 stddev:0.00 (0.0%) 12:14:42 INFO - 2015-11-12 12:14:42,889 DEBUG : BROWSER_OUTPUT: Values: 721.0 12:14:42 INFO - 2015-11-12 12:14:42,889 DEBUG : BROWSER_OUTPUT: 12:14:42 INFO - 2015-11-12 12:14:42,889 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11639.53 Median:11639.53 stddev:0.00 (0.0%) 12:14:42 INFO - 2015-11-12 12:14:42,889 DEBUG : BROWSER_OUTPUT: Values: 11639.5 12:14:42 INFO - 2015-11-12 12:14:42,889 DEBUG : BROWSER_OUTPUT: 12:14:42 INFO - 2015-11-12 12:14:42,889 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25000.00 Median:25000.00 stddev:0.00 (0.0%) 12:14:42 INFO - 2015-11-12 12:14:42,889 DEBUG : BROWSER_OUTPUT: Values: 25000.0 12:14:42 INFO - 2015-11-12 12:14:42,889 DEBUG : BROWSER_OUTPUT: 12:14:42 INFO - 2015-11-12 12:14:42,889 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:569.15 Median:569.15 stddev:0.00 (0.0%) 12:14:42 INFO - 2015-11-12 12:14:42,890 DEBUG : BROWSER_OUTPUT: Values: 569.2 12:14:42 INFO - 2015-11-12 12:14:42,890 DEBUG : BROWSER_OUTPUT: 12:14:42 INFO - 2015-11-12 12:14:42,890 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 12:14:42 INFO - 2015-11-12 12:14:42,890 DEBUG : BROWSER_OUTPUT: Values: 4826.9 12:14:42 INFO - 2015-11-12 12:14:42,890 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:14:42 INFO - 2015-11-12 12:14:42,890 DEBUG : BROWSER_OUTPUT: 12:14:43 INFO - 2015-11-12 12:14:43,725 INFO : Browser exited with error code: 0 12:14:43 INFO - 2015-11-12 12:14:43,742 INFO : Completed test v8_7 (00:00:39) 12:14:43 INFO - 2015-11-12 12:14:43,941 INFO : Completed test suite (00:20:09) 12:14:43 INFO - 2015-11-12 12:14:43,941 DEBUG : Working with test: dromaeo_css 12:14:43 INFO - 2015-11-12 12:14:43,942 DEBUG : Generating results file: dromaeo_css 12:14:43 INFO - 2015-11-12 12:14:43,943 DEBUG : Working with test: kraken 12:14:43 INFO - 2015-11-12 12:14:43,943 DEBUG : Generating results file: kraken 12:14:43 INFO - 2015-11-12 12:14:43,943 INFO : javascript benchmark 12:14:43 INFO - 2015-11-12 12:14:43,943 DEBUG : Working with test: v8_7 12:14:43 INFO - 2015-11-12 12:14:43,943 DEBUG : Generating results file: v8_7 12:14:43 INFO - 2015-11-12 12:14:43,944 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:14:44 INFO - 2015-11-12 12:14:44,007 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 12:14:44 INFO - 2015-11-12 12:14:44,007 DEBUG : process_Request line: dromaeo_css 6694.69 graph.html#tests=[[72,63,43]] 12:14:44 INFO - 2015-11-12 12:14:44,007 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:14:44 INFO - 2015-11-12 12:14:44,057 DEBUG : process_Request line: kraken 1505.70 graph.html#tests=[[232,63,43]] 12:14:44 INFO - 2015-11-12 12:14:44,058 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:14:44 INFO - 2015-11-12 12:14:44,090 DEBUG : process_Request line: v8_7 21676.50 graph.html#tests=[[230,63,43]] 12:14:44 INFO - 2015-11-12 12:14:44,091 INFO : javascript benchmark 12:14:44 INFO - 2015-11-12 12:14:44,095 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [346.2192755336715, 352.82711471379014, 353.54745925215724, 354.62764097697413, 355.49342187382973, 12441.0, 12937.935310323459, 16662.666746665076, 16769.490745832874, 17589.120543972782, 11388.430578471085, 11490.195686301962, 11601.65195044148, 12126.45430955607, 12259.203151795127, 4569.657275704327, 4693.436787585478, 4703.882402939919, 4707.576318131368, 4709.481956984729, 4412.426384570017, 4546.795394207252, 4561.1105834362315, 4574.83988060418, 4580.748058856761, 4549.408576885, 4581.725096494204, 4819.421669399677, 4927.014597080581, 4953.281774142747, 4845.2247640377545, 4854.368932038848, 4863.8540843774745, 4865.635077369211, 4881.975590122062, 4423.955760442386, 4425.358323043173, 4427.845025424127, 4434.445694288214, 4435.268180750172, 13332.533361332404, 13352.799708004388, 13503.729925401536, 13728.45086196551, 13733.313334333243, 1977.9604407911904, 2007.0065317667702, 2030.715699802029, 2050.3848845346483, 2118.1739121742535, 9923.90076099237, 9991.200703943667, 10034.598616055422, 10225.539850706737, 10331.328463649914, 1617.1105891759485, 1651.9587010324717, 1678.3957775200918, 1683.889395684093, 1685.384834535398, 57584.424155758745, 58009.0, 61771.0, 64667.353326466604, 65327.3467265326, 6892.276310987374, 6986.091808065021, 7070.1515818101125, 7119.181294151239, 7119.252478489788, 8381.874271885805, 8402.78993025167, 8423.410361274651, 8433.114522975122, 8444.704435344733, 5697.059985102412, 5720.456556627114, 5737.0, 5750.6262092963825, 5769.798057067983, 5908.0, 5948.0, 5993.101034844808, 5998.970005149947, 6005.459508644243, 3298.2578919743346, 3318.8672453101603, 3326.6839650233187, 3351.463765797461, 3364.7308215342714, 1172.513406936112, 1183.6981569699844, 1186.7567148734488, 1190.6785168004762, 1248.2385744695728, 389.47809934687655, 408.7594151749426, 412.65337116822013, 416.41909536196835, 422.42128284250157, 10103.141232995278, 10586.894131058745, 10642.787144257072, 10753.892461075446, 10801.24391292602, 408.19178027505114, 410.7083970381003, 413.02938095475395, 413.10768739523087, 424.82369816525795, 5701.116326969326, 5758.62568933018, 5782.479576838021, 5872.530197584183, 5901.996660567714, 532749.0, 533959.0, 547122.0, 550201.0, 555725.0, 71843.88371256056, 72611.0, 77940.0, 79594.0, 80547.59726201331, 533.8345113014977, 547.9205515200274, 550.5540512185063, 551.3466542147568, 551.8813455107171, 10538.57845686164, 11000.394978276272, 11212.55149793999, 11247.212695111264, 11294.830577541508, 35240.471392928615, 35568.46647300344, 35959.64040359563, 36346.63653363432, 37385.2522949534, 45087.54912450965, 46153.69231538477, 46892.29661555011, 47493.287600685326, 47650.76174619105, 6894.482913781587, 6939.132608423947, 6989.161300643956, 7011.404030657452, 7015.438764898694, 12206.75586488283, 12539.373031348214, 12544.874551254736, 12679.366031698562, 12800.935995319964, 10493.685189444328, 10814.45927703596, 10858.891411085788, 11039.889601103887, 11045.447727613426, 10514.158867290751, 10518.631847885288, 10728.302660327054, 10756.46217689128, 10895.073918716998, 10724.8927510727, 11023.61417350389, 11122.332660040423, 11176.27354221973, 11207.0, 6857.622830744357, 6865.965670171618, 6951.652417379009, 6966.442684585322, 6971.337722916315, 10426.791464170827, 10482.475876206312, 10594.417307047877, 10603.151747860307, 11217.60738374153], "dojo.html": [3257.527658489519, 3312.6356100828903, 3322.2857085726564, 3337.8331083445823, 3355.731541476682, 5438.7280635968245, 5481.424450432702, 5544.1960915667205, 5566.109422492402, 5567.582431317647, 5451.936872309891, 5509.862253443666, 5542.168674698797, 5550.306211723535, 5587.720613969295, 5066.1387564114, 5149.176131818891, 5208.609354298424, 5236.502532259429, 5238.371395432553, 4983.651144419892, 5003.799848006075, 5059.6458247922665, 5137.075326441239, 5276.393214780311, 4938.827141050082, 4956.231784073474, 5030.346055012861, 5104.464031276718, 5109.284700141983, 5063.645544811865, 5083.415407228142, 5090.745462726886, 5095.643304968654, 5165.66423182492, 5092.821751238689, 5118.155504341817, 5129.102407078746, 5131.692098474104, 5138.4347721750955, 5314.548263397616, 5324.1215199492035, 5413.431589683105, 5472.2338872557875, 5480.561555075585, 6050.818475445743, 6089.847753806146, 6100.176476175704, 6108.938910610881, 6109.266887973427, 6150.538709596798, 6153.784617538365, 6155.261368635747, 6158.84602884927, 6163.845903852395, 5556.972215138939, 5636.71816409182, 5666.065099258659, 5716.914246286309, 5761.769529218826, 6150.569460137837, 6192.938070619236, 6195.101710252078, 6204.410580994799, 6206.782762603287, 5902.468777810018, 6037.607555508878, 6044.425779550936, 6046.27444706638, 6048.395160484004, 5958.225430694069, 6028.909566356509, 6033.125196846433, 6044.0, 6048.758049678052, 6027.698615069229, 6057.818265451955, 6065.272167339859, 6067.757289708362, 6069.119977603223, 5851.32709738377, 5979.850503737442, 6047.971844786397, 6069.605475644069, 6070.605410648293, 4616.3306320584, 4644.883877903079, 4707.693999889996, 4714.434267887876, 4738.881527961759, 4104.979475102606, 4113.8971525711495, 4115.8971025723995, 4136.710430269853, 4163.687723420756, 5603.635763675429, 5720.971395143081, 5746.310442746813, 5752.654840709571, 5760.3951585083805, 6103.031058999626, 6120.908186377208, 6144.463884028993, 6168.19813424252, 6177.4749146322165, 5784.21913041734, 5794.956907756644, 5795.507381872588, 5811.622244554175, 5843.678597677169, 5036.244563315532, 5086.109930762102, 5146.459621739738, 5247.291615631841, 5263.289455923401, 6399.712012959335, 6412.038194270804, 6412.038194270896, 6412.422881940648, 6414.390632889868, 6109.236345456818, 6145.9692701536205, 6146.877062458815, 6155.2921414037955, 6164.907526387197, 6017.368176341596, 6179.073139029002, 6183.443490085914, 6217.564770466024, 6384.968075159594, 6002.759889604367, 6008.188894499187, 6015.48868346178, 6025.668588227514, 6091.0, 6050.697465126814, 6060.393960603904, 6103.0, 6105.877882442415, 6112.99135642614, 5787.710614469175, 5841.737121829613, 5946.07835785454, 5947.672877991752, 5960.850978725566, 5947.762089516371, 5988.221531200916, 5997.730102145327, 6005.549583781147, 6009.038553831366, 5791.53667706574, 5828.562857785599, 5865.794697185578, 5884.529237661062, 5892.234009578728, 5737.368889422077, 5854.882902341844, 5934.287885453773, 5945.881082378415, 6004.949133901462, 5784.913226301693, 5812.389699081705, 5827.708614569339, 5848.0, 5852.970735146297], "mootools.html": [1402.726468338674, 1403.7052219034003, 1531.4792970390065, 1732.896026238425, 1734.262938251243, 6278.403551662596, 6386.0420936859555, 6394.744210231591, 7543.585102819343, 7957.32362749167, 7682.769516914487, 7685.462017658766, 7732.0, 7733.265339792725, 7753.302202801747, 2225.5215128747354, 2275.0103704888343, 2275.7951784339407, 2277.567262220181, 2277.6128058230142, 2290.610596198642, 2330.2310237621627, 2334.953300933989, 2337.0651739304244, 2337.1586228957563, 2223.4774827915508, 2262.3778460923213, 2267.6258417361114, 2282.657601359793, 2282.8744419056943, 2238.373255488466, 2290.164090107099, 2294.908203671851, 2311.237291693737, 2319.988400058006, 2136.583366243583, 2180.9127634894585, 2191.123550579765, 2204.922827701023, 2205.878676672782, 7588.658510366991, 7694.615269236516, 7715.382769378436, 7724.845503089963, 7731.7680469586, 4281.743095414286, 4317.589828966243, 4381.298992161271, 4382.693211475198, 4392.450943632046, 3124.218945263684, 3132.232603012254, 3208.679132086796, 3236.401265765841, 3246.8863589774483, 1007.89417111203, 1008.5159123620704, 1794.2733193056833, 1803.9458816235403, 1805.0884303426817, 10619.097376722988, 10675.893241067646, 10689.679309620724, 10693.358398496037, 10703.0, 3988.262171498282, 3998.5001874765653, 4064.9796751016056, 4088.7137900347284, 4120.835166593302, 8568.785780355416, 8594.742157735152, 8601.526916019679, 8611.95694021526, 8621.396502244783, 4375.256206444912, 4394.1651086293505, 4395.340698895127, 4401.779911004437, 4419.138268037702, 4002.659773919191, 4009.8195581198916, 4037.37420699792, 4043.0, 4050.918981620351, 3390.983045084759, 3392.1350055736125, 3408.880689175867, 3410.8635654574036, 3446.3968805458944, 1041.5417216424748, 1051.8948105189572, 1058.343826827372, 1066.402814423925, 1077.6605369308643, 993.0913214408735, 997.002997002997, 1100.4497751124438, 1113.7549739057395, 1234.8456442944632, 7137.250588688113, 7231.819204519824, 7275.236100209508, 7283.0, 7283.890741638879, 1109.4896347680158, 1118.7315044389288, 1134.4554613785429, 1137.4653912661202, 1157.0801213035656, 5440.102383106743, 5457.181422786613, 5461.01701693691, 5472.425395333512, 5491.203775452537, 9139.223166030963, 9175.954120229357, 9266.907330926739, 9347.392419492711, 9585.089416505421, 9276.0, 9331.766705832273, 9336.673216437392, 9349.532523373804, 9359.344845860724, 7029.367356937798, 7162.391196748231, 7219.350258476762, 7225.096862892138, 7362.300581444754, 6949.791506254821, 7004.4046256068805, 7041.788746337618, 7043.964780176067, 7078.115235595551, 8096.109427962801, 8298.0, 8308.459950103224, 8398.95800521018, 8447.070822209675, 8522.0, 8565.48607083577, 8566.400351975302, 8583.570821459027, 8612.0, 6648.6343251119715, 6706.5640733352175, 6871.725130994704, 6880.69036893331, 6896.517243793087, 7419.109706835215, 7483.064616922885, 7491.0, 7528.0, 7539.623018849145, 6204.224471941007, 6756.560823546453, 6958.234594194533, 7044.295570442915, 7241.058662373857, 6631.436327912182, 6848.1097457330225, 6972.302769722987, 7043.0, 7151.2133665297815, 6900.93099069023, 7009.0, 7074.257202993817, 7089.113860767404, 7102.18324892644, 6383.585066970632, 6392.360763923571, 6419.582727122722, 6424.967875160594, 6425.5502114851515, 6074.3318234994995, 6266.843328916813, 6272.278687950944, 6495.935040649533, 6550.050242714875], "ext.html": [586.1881294407248, 610.5787006965196, 611.8806832667626, 613.7023543581364, 614.1892701633842, 38809.41785873211, 39638.801805991, 39824.60175398245, 40115.79942100293, 40366.79816600917, 41196.794016029955, 41826.7908660457, 41872.58127418725, 42017.0, 42063.36904946428, 8761.86857197141, 8899.065598112169, 8913.153250441197, 8913.331500137483, 8917.509536975464, 8629.137086291383, 8710.0, 8719.782005449852, 8739.4756314621, 8765.991910930228, 8782.25350845179, 8805.427647202943, 8844.159804818531, 8847.33644976626, 8868.645254189856, 8687.782805429852, 8750.606222719993, 8753.737387878375, 8754.518501482416, 8772.517511536864, 8598.87101693475, 8716.171963663443, 8728.825423491558, 8750.34372422071, 8760.167784060504, 38680.22639547193, 38748.41877371842, 38806.80596596999, 39148.41277380813, 39325.41011884824, 2830.1368082734757, 2871.3252385689348, 2889.1477014280836, 2912.388398436331, 2978.300099476621, 29046.564301535494, 29083.0, 29543.409131817243, 29600.407991840257, 30941.22646933822, 3567.9108022299392, 3599.4240921452442, 3619.3847046002243, 3643.7267204959735, 3655.9268814623824, 277000.0, 277267.0, 277556.0, 277971.0, 279045.6047719769, 40460.59539404627, 41060.79469602633, 41180.38229426561, 54819.45180548223, 55042.72478637661, 41488.0, 41667.7916610415, 41752.791236043624, 41817.79091104525, 41882.0, 12937.223766574036, 13057.738845223043, 13060.869391306156, 13073.542426015043, 13078.346082695827, 11358.94320528392, 11482.770344593062, 11487.942560287145, 11493.310401375944, 11557.479913403917, 13871.791923121162, 14084.366203520865, 14185.716285674229, 14186.219757913208, 14255.21596312192, 5737.340205876294, 5867.530597552186, 5891.0, 5892.970535147382, 5911.172435858897, 913.7030465098869, 935.9766005849772, 942.7313215733483, 966.4587830814767, 1013.5894962540183, 27734.861325693244, 27923.136141410127, 28277.43445131127, 28299.575506367422, 28319.0, 1027.814993301213, 1051.731808388856, 1071.1591400750374, 1126.1666366888444, 1186.104491109207, 14313.427462901576, 14537.418503259963, 14578.781318280235, 14799.482018129314, 14821.0, 343341.0, 345524.0, 346761.0, 347499.0, 347551.0, 50911.7454412733, 50987.490125099015, 51057.0, 51129.23306150411, 51209.743951280005, 1277.4251586785983, 1283.2492991600018, 1301.576987479092, 1304.6281809684194, 1329.0829327763813, 25670.22989310324, 26287.342816429744, 26578.0, 26691.19926402211, 27029.864850676408, 45745.77127114476, 45776.771116144206, 46304.53695463002, 46373.0, 46423.51823613175, 333660.0, 333978.0, 334907.0, 336387.0, 336522.0, 31945.520817188226, 44431.33352999643, 44450.0, 44503.55496444994, 45203.095938081715, 42065.369019464124, 42250.0, 42583.148337032464, 42892.57107429011, 43200.56799432091, 36463.63536364709, 36510.269794604494, 36655.81672091623, 37147.442788358734, 37296.0, 37254.44118338281, 37303.44044839275, 40239.79880100581, 40972.72218222475, 41500.0, 35586.46620300749, 36114.09714757152, 36115.097122572144, 39806.40290395589, 40372.1925561493, 31188.220294492818, 33073.33853322968, 33301.0, 33573.16067098342, 33654.0, 25721.871390642926, 25810.741892581584, 25900.22299331023, 26147.39662143695, 26158.0], "prototype.html": [311.1055714819893, 311.79250903602497, 311.94073126106025, 312.51092040955916, 316.0817824220639, 6216.285127210373, 6311.842203944898, 6318.178636777213, 6364.522660800441, 6372.840678983022, 6061.696915154247, 6251.4998800096, 6259.436650701447, 6273.9686301568545, 6299.1496148020005, 4681.859544213679, 4699.765011749416, 4714.127886341021, 4735.242361222188, 4736.0, 4719.69321994071, 4727.078219747151, 4731.1720448921305, 4735.337052812609, 4735.526447355254, 4630.0, 4664.463586687523, 4668.393108895839, 4700.576948074672, 4704.129735998834, 4626.21354369758, 4666.043461090469, 4675.532446755331, 4675.953240467603, 4681.953180468203, 4034.253663072341, 4042.8180731867137, 4044.5753195914594, 4057.046594050396, 4074.979625101885, 5829.47534721877, 5868.853278668024, 5890.381509941437, 5890.9410905891245, 5921.940780592182, 5195.974020129913, 5311.840644780663, 5321.680699158062, 5329.813456529042, 5434.347878254634, 6526.086347911296, 6544.836379090513, 6546.639934803584, 6554.442872355856, 6558.704858281341, 4319.67602429819, 4328.156009578133, 4333.58830911063, 4338.826446942118, 4340.782960851976, 6696.129503164558, 6819.863602727918, 6850.21222559407, 6866.862662746717, 6904.378605925441, 4403.3174857897075, 4461.442319710036, 4480.641548676098, 4487.551244875486, 4498.235299999008, 4513.977430112828, 4519.231730605805, 4525.456945166601, 4535.501094879561, 4557.612602928722, 5376.973115134478, 5378.058839703036, 5380.300560927054, 5385.569154467633, 5388.407275199725, 6598.37315455031, 6680.432163266079, 6704.497162712719, 6714.597124172467, 6721.630310332978, 1570.3012159588873, 1590.2366863905158, 1607.1883698732065, 1609.8470645288678, 1611.250768392703, 1032.4063663393579, 1035.3994683083793, 1042.5204405973336, 1043.0351924469835, 1052.3002203534718, 6309.684515774193, 6391.58454700443, 6394.840128996812, 6396.552241343062, 6414.069959855888, 6808.11494505721, 6809.931900681029, 6819.283975182633, 6819.5908245505425, 6840.760573379908, 6215.12988181655, 6346.619202847844, 6355.618662880242, 6389.3291204423795, 6394.168758061515, 3706.4440333950124, 3728.683061939711, 3730.8880733577494, 3732.9813350933073, 3735.43968404736, 7095.184053833772, 7120.893186602205, 7144.714211431588, 7146.571205727673, 7152.821179470451, 6938.930610693828, 6966.303369662993, 7002.964985175042, 7013.2986701329455, 7028.664553734876, 7251.963740181371, 7320.707171713072, 7324.121105467378, 7327.74352897646, 7349.485536012535, 6887.862242755217, 6914.101166848479, 6917.654117294216, 6943.618101004291, 6962.259435141214, 6773.89839152423, 6837.829054273683, 6839.281875403011, 6909.7581584646305, 6910.481713871581, 7217.819554511179, 7228.710851565878, 7255.310745479171, 7263.4915555910575, 7269.382102521345, 4499.1451624191295, 4501.594856462934, 4506.954930450654, 4521.367008618862, 4530.886727831698, 6795.0, 6948.166220053626, 6954.652267386711, 6973.930260697328, 7001.0, 6721.966390168018, 6747.865042699217, 6758.189017317954, 6776.830579235559, 6782.0, 6716.429103526059, 6729.495287853332, 6741.797746067626, 6763.966180169265, 6782.525223234326, 6428.164338635947, 6578.8355291118105, 6580.177477815273, 6586.407223349922, 6598.10925525048, 6683.43190828785, 6764.627945463047, 6768.729250830109, 6770.661466926733, 6787.966060169668, 6585.80242592723, 6589.604623722592, 6593.9120045192, 6596.175478065242, 6601.50488713358], "yui.html": [734.2363941500839, 767.3745897093868, 773.2460850670593, 813.2518083363309, 886.366248132585, 13499.39252733627, 13732.24472654005, 13777.380017899193, 14651.194184319886, 14688.559343219693, 12850.871491285085, 12927.547535836247, 12940.48238070476, 12945.741085178292, 12972.870271297284, 776.0803447914211, 779.0806847919453, 785.0383280481421, 785.505131766986, 791.6714563456159, 796.040770871099, 803.7307501986842, 804.2359758229705, 806.1656185847648, 808.3129340060931, 831.2477208126655, 835.5905606252953, 836.5984327522792, 840.865461526156, 841.2512863551444, 827.2182787266036, 828.6768160417442, 831.9417640765089, 833.5790425834945, 835.173178553234, 598.0, 599.2389665125266, 602.7076867719153, 604.7611193578556, 609.4332270987979, 13497.865021349857, 13528.864711352859, 13598.660033499144, 13625.18248905059, 13693.0, 9809.607615695364, 9842.507874606312, 10344.689659310232, 10364.170866330676, 10722.142228621691, 9890.505474726235, 9996.750081247954, 10010.749731256705, 10054.648087316982, 10185.439800810953, 3144.7326977206967, 3172.2228054126654, 3189.3142974260413, 3203.7276831469353, 3284.310294838087, 47700.0, 47925.76037119827, 48118.27822582664, 48172.0, 48199.5180048202, 7078.539894906815, 7190.1731300901065, 7230.132384113835, 7366.447516436181, 7451.0, 12326.50693972249, 12348.691282718004, 12401.379931003414, 12423.31671758062, 12430.192037517532, 6657.251363638675, 6815.7614483493835, 6920.688569014406, 6973.965130174317, 7059.082319298561, 4073.51117865858, 4116.361963895601, 4171.687123465752, 4198.6641068714425, 4219.641330486943, 2645.7751091157083, 2665.3736371952577, 2672.0514217452915, 2675.54515732326, 2680.8927642894064, 444.6398417282012, 449.29236452587304, 460.39228218751595, 461.87529367070704, 462.6275847942439, 581.1892410087988, 633.6008314761671, 653.5229282623616, 655.8524332025352, 680.2347359220877, 8494.660213591511, 8870.467771933705, 9036.367454278268, 9372.67195648149, 9638.710838674851, 532.1060618161448, 581.9854503637358, 601.3655593349059, 602.6672501069095, 622.2470810319473, 3908.4115597253713, 3984.2828290907337, 4039.111395492987, 4167.770772607475, 4176.979115104466, 61609.0, 62410.68794655998, 62503.37496624976, 62596.374036259964, 62597.37402625915, 53951.46048539543, 54119.0, 54549.72725136349, 55006.44993550013, 55376.723116384965, 49733.25400119001, 49771.0, 49787.50212497901, 50463.74768126136, 50767.0, 8318.542480163407, 8323.583820809057, 8520.914790852012, 8742.737717868475, 8828.117188281121, 34117.658823411446, 34353.312933740686, 34696.653033469345, 34810.65189348176, 34954.30091398107, 42291.788541057096, 42467.0, 45577.088458231316, 46498.30252546147, 47709.76145119252, 7711.074671039287, 7797.535586351254, 7909.485883417559, 7938.556925055069, 7940.22040751622, 11534.192606517463, 11614.656163381662, 11726.296422214695, 11756.23584467007, 11927.880721192678, 10980.121590272918, 11021.504032318404, 11267.887321126684, 11324.660260192208, 11652.766944661229, 10730.248882578144, 10846.0, 11166.274192177483, 11187.21689481761, 11643.825342620037, 10072.546735396778, 10376.792464150825, 11798.997085247507, 12181.756364872475, 12187.451564679788, 9407.764805879908, 9452.763680908032, 9454.669086581936, 9619.326647134634, 9865.802683946424, 9084.227840633355, 9389.530523473662, 9588.37675551087, 10006.549705263134, 10040.849387259052]}, "summary": {"lowerIsBetter": false, "suite": 6694.690413161877, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6843.185029584821, "unit": "ms", "value": 6843.185029584821}, "dojo.html": {"lowerIsBetter": false, "filtered": 5575.597534696166, "unit": "ms", "value": 5575.597534696166}, "mootools.html": {"lowerIsBetter": false, "filtered": 4436.959500803925, "unit": "ms", "value": 4436.959500803925}, "ext.html": {"lowerIsBetter": false, "filtered": 17961.66339034185, "unit": "ms", "value": 17961.66339034185}, "prototype.html": {"lowerIsBetter": false, "filtered": 4942.149430110912, "unit": "ms", "value": 4942.149430110912}, "yui.html": {"lowerIsBetter": false, "filtered": 5990.331374279741, "unit": "ms", "value": 5990.331374279741}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-058.e"}, "testrun": {"date": 1447358074, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112103103", "branch": "Mozilla-Inbound", "revision": "335c2779216be1186d937a95f29d082d8a4045d6"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 163.0, 164.0, 163.0, 162.0, 163.0, 163.0, 163.0, 174.0, 162.0], "ai-astar": [112.0, 103.0, 112.0, 111.0, 110.0, 119.0, 109.0, 110.0, 111.0, 110.0], "imaging-gaussian-blur": [110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0, 110.0], "audio-beat-detection": [147.0, 123.0, 147.0, 160.0, 127.0, 148.0, 155.0, 127.0, 166.0, 126.0], "json-stringify-tinderbox": [69.0, 68.0, 68.0, 68.0, 68.0, 73.0, 68.0, 68.0, 67.0, 68.0], "stanford-crypto-pbkdf2": [139.0, 148.0, 150.0, 152.0, 150.0, 150.0, 149.0, 141.0, 149.0, 139.0], "json-parse-financial": [62.0, 62.0, 61.0, 61.0, 61.0, 62.0, 60.0, 66.0, 58.0, 58.0], "stanford-crypto-sha256-iterative": [66.0, 69.0, 67.0, 66.0, 68.0, 65.0, 67.0, 67.0, 69.0, 66.0], "audio-fft": [73.0, 72.0, 72.0, 71.0, 72.0, 72.0, 132.0, 72.0, 75.0, 72.0], "imaging-darkroom": [148.0, 146.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0], "stanford-crypto-ccm": [127.0, 124.0, 125.0, 123.0, 123.0, 123.0, 121.0, 121.0, 121.0, 129.0], "audio-oscillator": [89.0, 93.0, 137.0, 89.0, 90.0, 90.0, 133.0, 93.0, 90.0, 140.0], "stanford-crypto-aes": [83.0, 83.0, 84.0, 84.0, 85.0, 84.0, 92.0, 83.0, 91.0, 85.0], "imaging-desaturate": [97.0, 97.0, 96.0, 96.0, 95.0, 96.0, 98.0, 95.0, 96.0, 97.0]}, "summary": {"lowerIsBetter": true, "suite": 1505.7000000000003, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 78.3, "unit": "ms", "value": 78.3}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 146.7, "unit": "ms", "value": 146.7}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 142.6, "unit": "ms", "value": 142.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 123.7, "unit": "ms", "value": 123.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.9, "unit": "ms", "value": 146.9}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 61.1, "unit": "ms", "value": 61.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.4, "unit": "ms", "value": 104.4}, "ai-astar": {"lowerIsBetter": true, "filtered": 110.7, "unit": "ms", "value": 110.7}, "audio-dft": {"lowerIsBetter": true, "filtered": 163.9, "unit": "ms", "value": 163.9}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.0, "unit": "ms", "value": 67.0}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 68.5, "unit": "ms", "value": 68.5}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.2, "unit": "ms", "value": 110.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.4, "unit": "ms", "value": 85.4}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.3, "unit": "ms", "value": 96.3}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-058.e"}, "testrun": {"date": 1447358074, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112103103", "branch": "Mozilla-Inbound", "revision": "335c2779216be1186d937a95f29d082d8a4045d6"}}, {"talos_counters": {}, "results": {"DeltaBlue": [193.34880123743233], "Encrypt": [281.135788585887], "NavierStokes": [4826.923076923077], "Decrypt": [5040.201005025126], "Splay": [569.1519635742743], "Richards": [162.94606485253382], "RegExp": [25000.0], "Earley": [720.9805335255949], "Boyer": [11639.53488372093], "RayTrace": [1055.9662090813094]}, "summary": {"lowerIsBetter": false, "suite": 21676.496512876354, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 341.96229600000015, "unit": "score", "value": 341.96229600000015}, "Encrypt": {"lowerIsBetter": false, "filtered": 946.8058169999996, "unit": "score", "value": 946.8058169999996}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.4422310756973, "unit": "score", "value": 307.4422310756973}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.81158424725827, "unit": "score", "value": 52.81158424725827}, "Splay": {"lowerIsBetter": false, "filtered": 143.17968699999997, "unit": "score", "value": 143.17968699999997}, "RegExp": {"lowerIsBetter": false, "filtered": 36.43939999999999, "unit": "score", "value": 36.43939999999999}, "Richards": {"lowerIsBetter": false, "filtered": 216.64837400000005, "unit": "score", "value": 216.64837400000005}, "Earley": {"lowerIsBetter": false, "filtered": 924.3841810000001, "unit": "score", "value": 924.3841810000001}, "Boyer": {"lowerIsBetter": false, "filtered": 57.25855944055944, "unit": "score", "value": 57.25855944055944}, "RayTrace": {"lowerIsBetter": false, "filtered": 700.7695829999997, "unit": "score", "value": 700.7695829999997}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-058.e"}, "testrun": {"date": 1447358074, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112103103", "branch": "Mozilla-Inbound", "revision": "335c2779216be1186d937a95f29d082d8a4045d6"}}] 12:14:44 INFO - RETURN: dromaeo_css: 6694.69 12:14:44 INFO - RETURN: kraken: 1505.70 12:14:44 INFO - RETURN: v8_7: 21676.50 12:14:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21676.50"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1505.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6694.69"}}} 12:14:44 INFO - Return code: 0 12:14:44 INFO - # TBPL SUCCESS # 12:14:44 INFO - Running post-action listener: _resource_record_post_action 12:14:44 INFO - Running post-run listener: _resource_record_post_run 12:14:45 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 28672; Write bytes: 508219392; Read time: 316; Write time: 461820 12:14:45 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 115597312; Read time: 0; Write time: 199008 12:14:45 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 24576; Write bytes: 276144128; Read time: 256; Write time: 123024 12:14:45 INFO - Running post-run listener: _upload_blobber_files 12:14:45 INFO - Blob upload gear active. 12:14:45 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:14:45 INFO - Copying logs to upload dir... 12:14:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.118524 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-12 12:14:45.187411) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 12:14:45.191396) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009919 build_url: 'https://queue.taskcluster.net/v1/task/Ygzfy1mWTrirQvolzJAB1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 12:14:45.244017) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 12:14:45.244338) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1447355040.201387-504584906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 12:14:45.295165) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 12:14:45.295635) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 12:14:45.296213) ========= ========= Total master_lag: 0.19 =========