builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1452034883.35 results: success (0) buildid: 20160105123603 builduid: 96f535dd0370414685380530b51bd6d1 revision: ac8bea1130743a5243ec5c172ea1f6276c8f0bf8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 15:01:23.354683) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 15:01:23.355157) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 15:01:23.355443) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1452034882.880837-616452706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006174 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 15:01:23.379137) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 15:01:23.379441) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 15:01:23.403529) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 15:01:23.403867) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1452034882.880837-616452706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 15:01:23.458693) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 15:01:23.459032) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 15:01:23.459755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 15:01:23.460054) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1452034882.880837-616452706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 15:01:23-- 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% 69.5M=0s 2016-01-05 15:01:23 (69.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100869 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 15:01:23.576241) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 15:01:23.576587) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1452034882.880837-616452706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020013 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 15:01:23.640659) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-05 15:01:23.641188) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ac8bea1130743a5243ec5c172ea1f6276c8f0bf8 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ac8bea1130743a5243ec5c172ea1f6276c8f0bf8 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1452034882.880837-616452706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 15:01:23,979 truncating revision to first 12 chars 2016-01-05 15:01:23,979 Setting DEBUG logging. 2016-01-05 15:01:23,979 attempt 1/10 2016-01-05 15:01:23,979 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ac8bea113074?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 15:01:25,019 unpacking tar archive at: mozilla-aurora-ac8bea113074/testing/mozharness/ program finished with exit code 0 elapsedTime=1.324349 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-05 15:01:24.980466) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 15:01:24.980827) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 15:01:24.990773) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 15:01:24.991165) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 15:01:24.991605) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-01-05 15:01:24.991975) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1452034882.880837-616452706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:01:25 INFO - MultiFileLogger online at 20160105 15:01:25 in /builds/slave/test-pgo 15:01:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:01:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:01:25 INFO - {'append_to_log': False, 15:01:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:01:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:01:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:01:25 INFO - 'branch': 'Mozilla-Aurora', 15:01:25 INFO - 'buildbot_json_path': 'buildprops.json', 15:01:25 INFO - 'config_files': ('talos/linux_config.py',), 15:01:25 INFO - 'default_actions': ('clobber', 15:01:25 INFO - 'read-buildbot-config', 15:01:25 INFO - 'download-and-extract', 15:01:25 INFO - 'populate-webroot', 15:01:25 INFO - 'create-virtualenv', 15:01:25 INFO - 'install', 15:01:25 INFO - 'run-tests'), 15:01:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:01:25 INFO - 'download_minidump_stackwalk': True, 15:01:25 INFO - 'download_symbols': 'ondemand', 15:01:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:01:25 INFO - 'tooltool.py': '/tools/tooltool.py', 15:01:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:01:25 INFO - '/tools/misc-python/virtualenv.py')}, 15:01:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:01:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:01:25 INFO - 'installer_path': 'installer.exe', 15:01:25 INFO - 'log_level': 'info', 15:01:25 INFO - 'log_name': 'talos', 15:01:25 INFO - 'log_to_console': True, 15:01:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:01:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:01:25 INFO - 'opt_config_files': (), 15:01:25 INFO - 'pip_index': False, 15:01:25 INFO - 'sps_profile': False, 15:01:25 INFO - 'sps_profile_interval': 0, 15:01:25 INFO - 'suite': 'dromaeojs-e10s', 15:01:25 INFO - 'system_bits': '32', 15:01:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:01:25 INFO - 'title': 'talos-linux64-ix-025', 15:01:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:01:25 INFO - 'use_talos_json': True, 15:01:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:01:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:01:25 INFO - 'work_dir': 'build'} 15:01:25 INFO - ##### 15:01:25 INFO - ##### Running clobber step. 15:01:25 INFO - ##### 15:01:25 INFO - Running pre-action listener: _resource_record_pre_action 15:01:25 INFO - Running main action method: clobber 15:01:25 INFO - rmtree: /builds/slave/test-pgo/build 15:01:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:01:26 INFO - Running post-action listener: _resource_record_post_action 15:01:26 INFO - ##### 15:01:26 INFO - ##### Running read-buildbot-config step. 15:01:26 INFO - ##### 15:01:26 INFO - Running pre-action listener: _resource_record_pre_action 15:01:26 INFO - Running main action method: read_buildbot_config 15:01:26 INFO - Using buildbot properties: 15:01:26 INFO - { 15:01:26 INFO - "properties": { 15:01:26 INFO - "buildnumber": 66, 15:01:26 INFO - "product": "firefox", 15:01:26 INFO - "script_repo_revision": "production", 15:01:26 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:01:26 INFO - "repository": "", 15:01:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:01:26 INFO - "buildid": "20160105123603", 15:01:26 INFO - "slavename": "talos-linux64-ix-025", 15:01:26 INFO - "pgo_build": "True", 15:01:26 INFO - "basedir": "/builds/slave/test-pgo", 15:01:26 INFO - "project": "", 15:01:26 INFO - "platform": "ubuntu64_hw", 15:01:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:01:26 INFO - "slavebuilddir": "test", 15:01:26 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:01:26 INFO - "branch": "mozilla-aurora", 15:01:26 INFO - "repo_path": "releases/mozilla-aurora", 15:01:26 INFO - "stage_platform": "linux64-pgo", 15:01:26 INFO - "builduid": "96f535dd0370414685380530b51bd6d1", 15:01:26 INFO - "revision": "ac8bea1130743a5243ec5c172ea1f6276c8f0bf8" 15:01:26 INFO - }, 15:01:26 INFO - "sourcestamp": { 15:01:26 INFO - "repository": "", 15:01:26 INFO - "hasPatch": false, 15:01:26 INFO - "project": "", 15:01:26 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 15:01:26 INFO - "changes": [ 15:01:26 INFO - { 15:01:26 INFO - "category": null, 15:01:26 INFO - "files": [ 15:01:26 INFO - { 15:01:26 INFO - "url": null, 15:01:26 INFO - "name": "https://queue.taskcluster.net/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 15:01:26 INFO - } 15:01:26 INFO - ], 15:01:26 INFO - "repository": "", 15:01:26 INFO - "rev": "ac8bea1130743a5243ec5c172ea1f6276c8f0bf8", 15:01:26 INFO - "who": "kwierso@gmail.com", 15:01:26 INFO - "when": 1452034858, 15:01:26 INFO - "number": 7420585, 15:01:26 INFO - "comments": "Backed out changeset 18eec0849a1f (Bug 1195295) for leaking. a=sylvestre\n\nThis changeset is causing shutdown leaks (bug 1234697 and bug 1220517).", 15:01:26 INFO - "project": "", 15:01:26 INFO - "at": "Tue 05 Jan 2016 15:00:58", 15:01:26 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 15:01:26 INFO - "revlink": "", 15:01:26 INFO - "properties": [ 15:01:26 INFO - [ 15:01:26 INFO - "buildid", 15:01:26 INFO - "20160105123603", 15:01:26 INFO - "Change" 15:01:26 INFO - ], 15:01:26 INFO - [ 15:01:26 INFO - "builduid", 15:01:26 INFO - "96f535dd0370414685380530b51bd6d1", 15:01:26 INFO - "Change" 15:01:26 INFO - ], 15:01:26 INFO - [ 15:01:26 INFO - "pgo_build", 15:01:26 INFO - "True", 15:01:26 INFO - "Change" 15:01:26 INFO - ] 15:01:26 INFO - ], 15:01:26 INFO - "revision": "ac8bea1130743a5243ec5c172ea1f6276c8f0bf8" 15:01:26 INFO - } 15:01:26 INFO - ], 15:01:26 INFO - "revision": "ac8bea1130743a5243ec5c172ea1f6276c8f0bf8" 15:01:26 INFO - } 15:01:26 INFO - } 15:01:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 15:01:26 INFO - Running post-action listener: _resource_record_post_action 15:01:26 INFO - ##### 15:01:26 INFO - ##### Running download-and-extract step. 15:01:26 INFO - ##### 15:01:26 INFO - Running pre-action listener: _resource_record_pre_action 15:01:26 INFO - Running main action method: download_and_extract 15:01:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:26 INFO - https://queue.taskcluster.net/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:01:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/test_packages.json 15:01:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/test_packages.json 15:01:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:01:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:01:30 INFO - Downloaded 1302 bytes. 15:01:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:01:30 INFO - Using the following test package requirements: 15:01:30 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 15:01:30 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 15:01:30 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:01:30 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 15:01:30 INFO - u'jsshell-linux-x86_64.zip'], 15:01:30 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 15:01:30 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:01:30 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 15:01:30 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 15:01:30 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:01:30 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 15:01:30 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:01:30 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 15:01:30 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:01:30 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 15:01:30 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 15:01:30 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:01:30 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:30 INFO - https://queue.taskcluster.net/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:01:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 15:01:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 15:01:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 15:01:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:01:32 INFO - Downloaded 23024112 bytes. 15:01:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:01:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 15:01:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:01:33 INFO - Return code: 0 15:01:33 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:33 INFO - https://queue.taskcluster.net/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:01:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 15:01:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 15:01:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 15:01:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:01:34 INFO - Downloaded 23024112 bytes. 15:01:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:01:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 15:01:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:01:35 INFO - Return code: 0 15:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:35 INFO - https://queue.taskcluster.net/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:01:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 15:01:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 15:01:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 15:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:01:37 INFO - Downloaded 11132038 bytes. 15:01:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 15:01:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 15:01:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 15:01:37 INFO - Return code: 0 15:01:37 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')]} 15:01:37 INFO - https://queue.taskcluster.net/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:01:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 15:01:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 15:01:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 15:01:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:01:38 INFO - Downloaded 58096080 bytes. 15:01:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 15:01:38 INFO - mkdir: /builds/slave/test-pgo/properties 15:01:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:01:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:01:38 INFO - Contents: 15:01:38 INFO - build_url:https://queue.taskcluster.net/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 15:01:38 INFO - Running post-action listener: _resource_record_post_action 15:01:38 INFO - Running post-action listener: set_extra_try_arguments 15:01:38 INFO - ##### 15:01:38 INFO - ##### Running populate-webroot step. 15:01:38 INFO - ##### 15:01:38 INFO - Running pre-action listener: _resource_record_pre_action 15:01:38 INFO - Running main action method: populate_webroot 15:01:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:01:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:01:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:01:38 INFO - '--tppagecycles', 15:01:38 INFO - '7'], 15:01:38 INFO - 'tests': ['tsvgm']}}, 15:01:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:01:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:01:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:01:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:01:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:01:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:01:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:38 INFO - 'talos_options': ['--e10s'], 15:01:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:38 INFO - 'tests': ['damp', 'tps']}, 15:01:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:38 INFO - 'talos_options': ['--e10s'], 15:01:38 INFO - 'tests': ['damp', 'tps']}, 15:01:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:01:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:01:38 INFO - 'other': {'tests': ['a11yr', 15:01:38 INFO - 'ts_paint', 15:01:38 INFO - 'tpaint', 15:01:38 INFO - 'sessionrestore', 15:01:38 INFO - 'sessionrestore_no_auto_restore']}, 15:01:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:01:38 INFO - 'tests': ['a11yr', 15:01:38 INFO - 'ts_paint', 15:01:38 INFO - 'tpaint', 15:01:38 INFO - 'sessionrestore', 15:01:38 INFO - 'sessionrestore_no_auto_restore']}, 15:01:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:01:38 INFO - 'tests': ['a11yr', 15:01:38 INFO - 'ts_paint', 15:01:38 INFO - 'tpaint', 15:01:38 INFO - 'sessionrestore', 15:01:38 INFO - 'sessionrestore_no_auto_restore']}, 15:01:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:01:38 INFO - 'tests': ['a11yr', 15:01:38 INFO - 'ts_paint', 15:01:38 INFO - 'tpaint', 15:01:38 INFO - 'sessionrestore', 15:01:38 INFO - 'sessionrestore_no_auto_restore']}, 15:01:38 INFO - 'other_l64': {'tests': ['a11yr', 15:01:38 INFO - 'ts_paint', 15:01:38 INFO - 'tpaint', 15:01:38 INFO - 'sessionrestore', 15:01:38 INFO - 'sessionrestore_no_auto_restore']}, 15:01:38 INFO - 'other_nol64': {'tests': ['a11yr', 15:01:38 INFO - 'ts_paint', 15:01:38 INFO - 'tpaint', 15:01:38 INFO - 'sessionrestore', 15:01:38 INFO - 'sessionrestore_no_auto_restore']}, 15:01:38 INFO - 'svgr': {'tests': ['tsvgx', 15:01:38 INFO - 'tsvgr_opacity', 15:01:38 INFO - 'tart', 15:01:38 INFO - 'tscrollx', 15:01:38 INFO - 'cart']}, 15:01:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:01:38 INFO - 'tests': ['tsvgx', 15:01:38 INFO - 'tsvgr_opacity', 15:01:38 INFO - 'tart', 15:01:38 INFO - 'tscrollx', 15:01:38 INFO - 'cart']}, 15:01:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:38 INFO - 'tests': ['tp5o']}, 15:01:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:38 INFO - 'talos_options': ['--e10s'], 15:01:38 INFO - 'tests': ['tp5o']}, 15:01:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:38 INFO - 'talos_options': ['--xperf_path', 15:01:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:38 INFO - 'tests': ['tp5n']}, 15:01:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:38 INFO - 'talos_options': ['--e10s', 15:01:38 INFO - '--xperf_path', 15:01:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:38 INFO - 'tests': ['tp5n']}}, 15:01:38 INFO - 'talos.zip': {'path': '', 15:01:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:01:38 INFO - Running post-action listener: _resource_record_post_action 15:01:38 INFO - ##### 15:01:38 INFO - ##### Running create-virtualenv step. 15:01:38 INFO - ##### 15:01:38 INFO - Running pre-action listener: _resource_record_pre_action 15:01:38 INFO - Running main action method: create_virtualenv 15:01:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:01:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 15:01:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:01:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:01:38 INFO - Using real prefix '/usr' 15:01:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:01:39 INFO - Installing distribute.............................................................................................................................................................................................done. 15:01:41 INFO - Installing pip.................done. 15:01:41 INFO - Return code: 0 15:01:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:41 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 0x7f39a426ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf82a50>, '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 0xeee550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeee9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452034882.880837-616452706', '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 15:01:41 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 15:01:41 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 15:01:41 INFO - Using env: {'DISPLAY': ':0', 15:01:41 INFO - 'HOME': '/home/cltbld', 15:01:41 INFO - 'LANG': 'en_US.UTF-8', 15:01:41 INFO - 'LANGUAGE': 'en_US:en', 15:01:41 INFO - 'LOGNAME': 'cltbld', 15:01:41 INFO - 'MAIL': '/var/mail/cltbld', 15:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:41 INFO - 'MOZ_NO_REMOTE': '1', 15:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:41 INFO - 'NO_EM_RESTART': '1', 15:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:01:41 INFO - 'PWD': '/builds/slave/test-pgo', 15:01:41 INFO - 'SHELL': '/bin/bash', 15:01:41 INFO - 'SHLVL': '1', 15:01:41 INFO - 'TERM': 'linux', 15:01:41 INFO - 'TMOUT': '86400', 15:01:41 INFO - 'USER': 'cltbld', 15:01:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452034882.880837-616452706', 15:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:41 INFO - '_': '/tools/buildbot/bin/python'} 15:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:01:41 INFO - Cleaning up... 15:01:41 INFO - Return code: 0 15:01:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:41 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 0x7f39a426ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf82a50>, '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 0xeee550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeee9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452034882.880837-616452706', '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 15:01:41 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 15:01:41 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 15:01:41 INFO - Using env: {'DISPLAY': ':0', 15:01:41 INFO - 'HOME': '/home/cltbld', 15:01:41 INFO - 'LANG': 'en_US.UTF-8', 15:01:41 INFO - 'LANGUAGE': 'en_US:en', 15:01:41 INFO - 'LOGNAME': 'cltbld', 15:01:41 INFO - 'MAIL': '/var/mail/cltbld', 15:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:41 INFO - 'MOZ_NO_REMOTE': '1', 15:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:41 INFO - 'NO_EM_RESTART': '1', 15:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:01:41 INFO - 'PWD': '/builds/slave/test-pgo', 15:01:41 INFO - 'SHELL': '/bin/bash', 15:01:41 INFO - 'SHLVL': '1', 15:01:41 INFO - 'TERM': 'linux', 15:01:41 INFO - 'TMOUT': '86400', 15:01:41 INFO - 'USER': 'cltbld', 15:01:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452034882.880837-616452706', 15:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:41 INFO - '_': '/tools/buildbot/bin/python'} 15:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:41 INFO - Downloading/unpacking psutil>=0.7.1 15:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:43 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:01:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:01:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:01:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:43 INFO - Installing collected packages: psutil 15:01:43 INFO - Running setup.py install for psutil 15:01:43 INFO - building 'psutil._psutil_linux' extension 15:01:43 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 15:01:43 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 15:01:43 INFO - building 'psutil._psutil_posix' extension 15:01:43 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 15:01:43 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 15:01:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:44 INFO - Successfully installed psutil 15:01:44 INFO - Cleaning up... 15:01:44 INFO - Return code: 0 15:01:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:01: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')]} 15:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:44 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 0x7f39a426ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf82a50>, '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 0xeee550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeee9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452034882.880837-616452706', '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 15:01:44 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 15:01:44 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 15:01:44 INFO - Using env: {'DISPLAY': ':0', 15:01:44 INFO - 'HOME': '/home/cltbld', 15:01:44 INFO - 'LANG': 'en_US.UTF-8', 15:01:44 INFO - 'LANGUAGE': 'en_US:en', 15:01:44 INFO - 'LOGNAME': 'cltbld', 15:01:44 INFO - 'MAIL': '/var/mail/cltbld', 15:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:44 INFO - 'MOZ_NO_REMOTE': '1', 15:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:44 INFO - 'NO_EM_RESTART': '1', 15:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:01:44 INFO - 'PWD': '/builds/slave/test-pgo', 15:01:44 INFO - 'SHELL': '/bin/bash', 15:01:44 INFO - 'SHLVL': '1', 15:01:44 INFO - 'TERM': 'linux', 15:01:44 INFO - 'TMOUT': '86400', 15:01:44 INFO - 'USER': 'cltbld', 15:01:44 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452034882.880837-616452706', 15:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:44 INFO - '_': '/tools/buildbot/bin/python'} 15:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:01:44 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 15:01:44 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 15:01:44 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 15:01:44 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 15:01:44 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 15:01:44 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 15:01:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:01:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:01:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:01:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:01:46 INFO - Installing collected packages: mozsystemmonitor 15:01:46 INFO - Running setup.py install for mozsystemmonitor 15:01:46 INFO - Successfully installed mozsystemmonitor 15:01:46 INFO - Cleaning up... 15:01:46 INFO - Return code: 0 15:01:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:46 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 0x7f39a426ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf82a50>, '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 0xeee550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeee9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452034882.880837-616452706', '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 15:01:46 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 15:01:46 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 15:01:46 INFO - Using env: {'DISPLAY': ':0', 15:01:46 INFO - 'HOME': '/home/cltbld', 15:01:46 INFO - 'LANG': 'en_US.UTF-8', 15:01:46 INFO - 'LANGUAGE': 'en_US:en', 15:01:46 INFO - 'LOGNAME': 'cltbld', 15:01:46 INFO - 'MAIL': '/var/mail/cltbld', 15:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:46 INFO - 'MOZ_NO_REMOTE': '1', 15:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:46 INFO - 'NO_EM_RESTART': '1', 15:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:01:46 INFO - 'PWD': '/builds/slave/test-pgo', 15:01:46 INFO - 'SHELL': '/bin/bash', 15:01:46 INFO - 'SHLVL': '1', 15:01:46 INFO - 'TERM': 'linux', 15:01:46 INFO - 'TMOUT': '86400', 15:01:46 INFO - 'USER': 'cltbld', 15:01:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452034882.880837-616452706', 15:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:46 INFO - '_': '/tools/buildbot/bin/python'} 15:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:46 INFO - Downloading/unpacking blobuploader==1.2.4 15:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:48 INFO - Downloading blobuploader-1.2.4.tar.gz 15:01:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:01:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:01:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:01:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:01:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:48 INFO - Downloading docopt-0.6.1.tar.gz 15:01:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:01:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:01:48 INFO - Installing collected packages: blobuploader, requests, docopt 15:01:48 INFO - Running setup.py install for blobuploader 15:01:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:01:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:01:49 INFO - Running setup.py install for requests 15:01:49 INFO - Running setup.py install for docopt 15:01:49 INFO - Successfully installed blobuploader requests docopt 15:01:49 INFO - Cleaning up... 15:01:49 INFO - Return code: 0 15:01:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:01:49 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')]} 15:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:49 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')]} 15:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:49 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 0x7f39a426ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf82a50>, '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 0xeee550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeee9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452034882.880837-616452706', '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 15:01:49 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 15:01:49 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 15:01:49 INFO - Using env: {'DISPLAY': ':0', 15:01:49 INFO - 'HOME': '/home/cltbld', 15:01:49 INFO - 'LANG': 'en_US.UTF-8', 15:01:49 INFO - 'LANGUAGE': 'en_US:en', 15:01:49 INFO - 'LOGNAME': 'cltbld', 15:01:49 INFO - 'MAIL': '/var/mail/cltbld', 15:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:49 INFO - 'MOZ_NO_REMOTE': '1', 15:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:49 INFO - 'NO_EM_RESTART': '1', 15:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:01:49 INFO - 'PWD': '/builds/slave/test-pgo', 15:01:49 INFO - 'SHELL': '/bin/bash', 15:01:49 INFO - 'SHLVL': '1', 15:01:49 INFO - 'TERM': 'linux', 15:01:49 INFO - 'TMOUT': '86400', 15:01:49 INFO - 'USER': 'cltbld', 15:01:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452034882.880837-616452706', 15:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:49 INFO - '_': '/tools/buildbot/bin/python'} 15:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:01:49 INFO - Running setup.py (path:/tmp/pip-ePLaCU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:01:49 INFO - Running setup.py (path:/tmp/pip-Ws6uJn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:01:49 INFO - Running setup.py (path:/tmp/pip-LKvZyJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:01:49 INFO - Running setup.py (path:/tmp/pip-JNiEYG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:01:50 INFO - Running setup.py (path:/tmp/pip-O6OtJx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:01:50 INFO - Running setup.py (path:/tmp/pip-fZbw_w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:01:50 INFO - Running setup.py (path:/tmp/pip-x8gkib-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:01:50 INFO - Running setup.py (path:/tmp/pip-650xvk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:01:50 INFO - Running setup.py (path:/tmp/pip-f7tRBo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:01:50 INFO - Running setup.py (path:/tmp/pip-JFW1pm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:01:50 INFO - Running setup.py (path:/tmp/pip-mPrUXR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:01:50 INFO - Running setup.py (path:/tmp/pip-R2Unwm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:01:50 INFO - Running setup.py (path:/tmp/pip-JHnK49-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:01:50 INFO - Running setup.py (path:/tmp/pip-Eaekg5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:01:50 INFO - Running setup.py (path:/tmp/pip-Ii0MsQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:01:50 INFO - Running setup.py (path:/tmp/pip-3Ue9UY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:01:50 INFO - Running setup.py (path:/tmp/pip-APyQc0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:01:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:01:50 INFO - Running setup.py install for manifestparser 15:01:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:01:51 INFO - Running setup.py install for mozcrash 15:01:51 INFO - Running setup.py install for mozdebug 15:01:51 INFO - Running setup.py install for mozdevice 15:01:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:01:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:01:51 INFO - Running setup.py install for mozfile 15:01:51 INFO - Running setup.py install for mozhttpd 15:01:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:01:51 INFO - Running setup.py install for mozinfo 15:01:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:01:51 INFO - Running setup.py install for mozInstall 15:01:51 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:01:51 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:01:51 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:01:51 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:01:51 INFO - Running setup.py install for mozleak 15:01:51 INFO - Running setup.py install for mozlog 15:01:51 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:01:52 INFO - Running setup.py install for moznetwork 15:01:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:01:52 INFO - Running setup.py install for mozprocess 15:01:52 INFO - Running setup.py install for mozprofile 15:01:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:01:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:01:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:01:52 INFO - Running setup.py install for mozrunner 15:01:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:01:52 INFO - Running setup.py install for mozscreenshot 15:01:52 INFO - Running setup.py install for moztest 15:01:52 INFO - Running setup.py install for mozversion 15:01:52 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:01:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:01:52 INFO - Cleaning up... 15:01:52 INFO - Return code: 0 15:01:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:01:52 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')]} 15:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:52 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')]} 15:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:52 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 0x7f39a426ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf82a50>, '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 0xeee550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeee9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452034882.880837-616452706', '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 15:01:52 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 15:01:52 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 15:01:52 INFO - Using env: {'DISPLAY': ':0', 15:01:52 INFO - 'HOME': '/home/cltbld', 15:01:52 INFO - 'LANG': 'en_US.UTF-8', 15:01:52 INFO - 'LANGUAGE': 'en_US:en', 15:01:52 INFO - 'LOGNAME': 'cltbld', 15:01:52 INFO - 'MAIL': '/var/mail/cltbld', 15:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:52 INFO - 'MOZ_NO_REMOTE': '1', 15:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:52 INFO - 'NO_EM_RESTART': '1', 15:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:01:52 INFO - 'PWD': '/builds/slave/test-pgo', 15:01:52 INFO - 'SHELL': '/bin/bash', 15:01:52 INFO - 'SHLVL': '1', 15:01:52 INFO - 'TERM': 'linux', 15:01:52 INFO - 'TMOUT': '86400', 15:01:52 INFO - 'USER': 'cltbld', 15:01:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452034882.880837-616452706', 15:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:52 INFO - '_': '/tools/buildbot/bin/python'} 15:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:01:52 INFO - Running setup.py (path:/tmp/pip-tHeHRi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:01:53 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)) 15:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:01:53 INFO - Running setup.py (path:/tmp/pip-RYMIbw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:01:53 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)) 15:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:01:53 INFO - Running setup.py (path:/tmp/pip-vwSZIa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:01:53 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)) 15:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:01:53 INFO - Running setup.py (path:/tmp/pip-q_gcrB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:01:53 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)) 15:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:01:53 INFO - Running setup.py (path:/tmp/pip-3jocWE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:01:53 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)) 15:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:01:53 INFO - Running setup.py (path:/tmp/pip-MBANv0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:01:53 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)) 15:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:01:53 INFO - Running setup.py (path:/tmp/pip-2diOVP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:01:53 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)) 15:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:01:53 INFO - Running setup.py (path:/tmp/pip-Hh3Bmc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:01:53 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)) 15:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:01:53 INFO - Running setup.py (path:/tmp/pip-drLKZO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:01:53 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)) 15:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:01:53 INFO - Running setup.py (path:/tmp/pip-4VmQQQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:01:53 INFO - Running setup.py (path:/tmp/pip-kUux4v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:01:53 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)) 15:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:01:53 INFO - Running setup.py (path:/tmp/pip-KbKB1Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:01:53 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)) 15:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:01:53 INFO - Running setup.py (path:/tmp/pip-0p1TAh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:01:53 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)) 15:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:01:53 INFO - Running setup.py (path:/tmp/pip-zXHpec-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:01:53 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)) 15:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:01:53 INFO - Running setup.py (path:/tmp/pip-1nboKA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:01:54 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)) 15:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:01:54 INFO - Running setup.py (path:/tmp/pip-rsST4L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:01:54 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)) 15:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:01:54 INFO - Running setup.py (path:/tmp/pip-tcINdP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:01:54 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)) 15:01:54 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)) 15:01:54 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)) 15:01:54 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)) 15:01:54 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)) 15:01:54 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)) 15:01:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:01:54 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 15:01:54 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 15:01:54 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 15:01:54 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 15:01:54 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 15:01:54 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 15:01:55 INFO - Downloading blessings-1.5.1.tar.gz 15:01:55 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 15:01:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:01:55 INFO - Installing collected packages: blessings 15:01:55 INFO - Running setup.py install for blessings 15:01:56 INFO - Successfully installed blessings 15:01:56 INFO - Cleaning up... 15:01:56 INFO - Return code: 0 15:01:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:01:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:01:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:01:56 INFO - Reading from file tmpfile_stdout 15:01:56 INFO - Current package versions: 15:01:56 INFO - argparse == 1.2.1 15:01:56 INFO - blessings == 1.5.1 15:01:56 INFO - blobuploader == 1.2.4 15:01:56 INFO - docopt == 0.6.1 15:01:56 INFO - manifestparser == 1.1 15:01:56 INFO - mozInstall == 1.12 15:01:56 INFO - mozcrash == 0.16 15:01:56 INFO - mozdebug == 0.1 15:01:56 INFO - mozdevice == 0.47 15:01:56 INFO - mozfile == 1.2 15:01:56 INFO - mozhttpd == 0.7 15:01:56 INFO - mozinfo == 0.9 15:01:56 INFO - mozleak == 0.1 15:01:56 INFO - mozlog == 3.1 15:01:56 INFO - moznetwork == 0.27 15:01:56 INFO - mozprocess == 0.22 15:01:56 INFO - mozprofile == 0.27 15:01:56 INFO - mozrunner == 6.11 15:01:56 INFO - mozscreenshot == 0.1 15:01:56 INFO - mozsystemmonitor == 0.0 15:01:56 INFO - moztest == 0.7 15:01:56 INFO - mozversion == 1.4 15:01:56 INFO - psutil == 3.1.1 15:01:56 INFO - requests == 1.2.3 15:01:56 INFO - wsgiref == 0.1.2 15:01:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:01: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')]} 15:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:56 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 0x7f39a426ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf82a50>, '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 0xeee550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeee9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452034882.880837-616452706', '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 15:01:56 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 15:01:56 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 15:01:56 INFO - Using env: {'DISPLAY': ':0', 15:01:56 INFO - 'HOME': '/home/cltbld', 15:01:56 INFO - 'LANG': 'en_US.UTF-8', 15:01:56 INFO - 'LANGUAGE': 'en_US:en', 15:01:56 INFO - 'LOGNAME': 'cltbld', 15:01:56 INFO - 'MAIL': '/var/mail/cltbld', 15:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:56 INFO - 'MOZ_NO_REMOTE': '1', 15:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:56 INFO - 'NO_EM_RESTART': '1', 15:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:01:56 INFO - 'PWD': '/builds/slave/test-pgo', 15:01:56 INFO - 'SHELL': '/bin/bash', 15:01:56 INFO - 'SHLVL': '1', 15:01:56 INFO - 'TERM': 'linux', 15:01:56 INFO - 'TMOUT': '86400', 15:01:56 INFO - 'USER': 'cltbld', 15:01:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452034882.880837-616452706', 15:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:56 INFO - '_': '/tools/buildbot/bin/python'} 15:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:56 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)) 15:01:56 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)) 15:01:56 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)) 15:01:56 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)) 15:01:56 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)) 15:01:56 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)) 15:01:56 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)) 15:01:56 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)) 15:01:56 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)) 15:01:56 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)) 15:01:56 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)) 15:01:56 INFO - Cleaning up... 15:01:56 INFO - Return code: 0 15:01:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:01: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')]} 15:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:56 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39a426ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf82a50>, '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 0xeee550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeee9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452034882.880837-616452706', '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 15:01:56 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', 'jsonschema'] in /builds/slave/test-pgo/build 15:01:56 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 jsonschema 15:01:56 INFO - Using env: {'DISPLAY': ':0', 15:01:56 INFO - 'HOME': '/home/cltbld', 15:01:56 INFO - 'LANG': 'en_US.UTF-8', 15:01:56 INFO - 'LANGUAGE': 'en_US:en', 15:01:56 INFO - 'LOGNAME': 'cltbld', 15:01:56 INFO - 'MAIL': '/var/mail/cltbld', 15:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:56 INFO - 'MOZ_NO_REMOTE': '1', 15:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:56 INFO - 'NO_EM_RESTART': '1', 15:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:01:56 INFO - 'PWD': '/builds/slave/test-pgo', 15:01:56 INFO - 'SHELL': '/bin/bash', 15:01:56 INFO - 'SHLVL': '1', 15:01:56 INFO - 'TERM': 'linux', 15:01:56 INFO - 'TMOUT': '86400', 15:01:56 INFO - 'USER': 'cltbld', 15:01:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452034882.880837-616452706', 15:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:56 INFO - '_': '/tools/buildbot/bin/python'} 15:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:56 INFO - Downloading/unpacking jsonschema 15:01:56 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 15:01:56 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 15:01:56 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 15:01:56 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 15:01:56 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 15:01:56 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 15:01:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:01:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 15:01:58 INFO - Downloading/unpacking functools32 (from jsonschema) 15:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:58 INFO - Downloading functools32-3.2.3-2.tar.gz 15:01:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:01:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:01:58 INFO - warning: no files found matching '*.txt' 15:01:58 INFO - no previously-included directories found matching 'build' 15:01:58 INFO - no previously-included directories found matching 'dist' 15:01:58 INFO - no previously-included directories found matching '.git*' 15:01:58 INFO - Installing collected packages: jsonschema, functools32 15:01:58 INFO - Running setup.py install for functools32 15:01:58 INFO - warning: no files found matching '*.txt' 15:01:58 INFO - no previously-included directories found matching 'build' 15:01:58 INFO - no previously-included directories found matching 'dist' 15:01:58 INFO - no previously-included directories found matching '.git*' 15:01:58 INFO - Successfully installed jsonschema functools32 15:01:58 INFO - Cleaning up... 15:01:58 INFO - Return code: 0 15:01:58 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:01: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')]} 15:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:58 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39a426ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf82a50>, '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 0xeee550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeee9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452034882.880837-616452706', '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 15:01:58 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', 'flake8'] in /builds/slave/test-pgo/build 15:01:58 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 flake8 15:01:58 INFO - Using env: {'DISPLAY': ':0', 15:01:58 INFO - 'HOME': '/home/cltbld', 15:01:58 INFO - 'LANG': 'en_US.UTF-8', 15:01:58 INFO - 'LANGUAGE': 'en_US:en', 15:01:58 INFO - 'LOGNAME': 'cltbld', 15:01:58 INFO - 'MAIL': '/var/mail/cltbld', 15:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:58 INFO - 'MOZ_NO_REMOTE': '1', 15:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:58 INFO - 'NO_EM_RESTART': '1', 15:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:01:58 INFO - 'PWD': '/builds/slave/test-pgo', 15:01:58 INFO - 'SHELL': '/bin/bash', 15:01:58 INFO - 'SHLVL': '1', 15:01:58 INFO - 'TERM': 'linux', 15:01:58 INFO - 'TMOUT': '86400', 15:01:58 INFO - 'USER': 'cltbld', 15:01:58 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452034882.880837-616452706', 15:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:58 INFO - '_': '/tools/buildbot/bin/python'} 15:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:59 INFO - Downloading/unpacking flake8 15:01:59 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 15:01:59 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 15:01:59 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 15:01:59 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 15:01:59 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 15:01:59 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 15:02:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:02:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 15:02:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 15:02:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:02:01 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 15:02:01 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 15:02:01 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 15:02:01 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 15:02:01 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 15:02:01 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 15:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 15:02:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:02:01 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 15:02:01 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 15:02:01 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 15:02:01 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 15:02:01 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 15:02:01 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 15:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:02:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:02:01 INFO - no previously-included directories found matching 'docs/_build' 15:02:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:02:01 INFO - Running setup.py install for pep8 15:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:02:01 INFO - no previously-included directories found matching 'docs/_build' 15:02:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:02:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:02:01 INFO - Cleaning up... 15:02:01 INFO - Return code: 0 15:02:01 INFO - Running post-action listener: _resource_record_post_action 15:02:01 INFO - Running post-action listener: _start_resource_monitoring 15:02:01 INFO - Starting resource monitoring. 15:02:01 INFO - ##### 15:02:01 INFO - ##### Running install step. 15:02:01 INFO - ##### 15:02:01 INFO - Running pre-action listener: _resource_record_pre_action 15:02:01 INFO - Running main action method: install 15:02:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:02:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:02:01 INFO - Reading from file tmpfile_stdout 15:02:01 INFO - Detecting whether we're running mozinstall >=1.0... 15:02:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:02:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:02:02 INFO - Reading from file tmpfile_stdout 15:02:02 INFO - Output received: 15:02:02 INFO - Usage: mozinstall [options] installer 15:02:02 INFO - Options: 15:02:02 INFO - -h, --help show this help message and exit 15:02:02 INFO - -d DEST, --destination=DEST 15:02:02 INFO - Directory to install application into. [default: 15:02:02 INFO - "/builds/slave/test-pgo"] 15:02:02 INFO - --app=APP Application being installed. [default: firefox] 15:02:02 INFO - mkdir: /builds/slave/test-pgo/build/application 15:02:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 15:02:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 15:02:16 INFO - Reading from file tmpfile_stdout 15:02:16 INFO - Output received: 15:02:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:02:16 INFO - Running post-action listener: _resource_record_post_action 15:02:16 INFO - ##### 15:02:16 INFO - ##### Running run-tests step. 15:02:16 INFO - ##### 15:02:16 INFO - Running pre-action listener: _resource_record_pre_action 15:02:16 INFO - Running main action method: run_tests 15:02:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:02:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:02:16 INFO - Python 2.7.3 15:02:16 INFO - Return code: 0 15:02:16 INFO - grabbing minidump binary from tooltool 15:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:16 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 0xf82a50>, '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 0xeee550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeee9e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:02:16 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 15:02:16 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 15:02:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:02:16 INFO - Return code: 0 15:02:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:02:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:02:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:02:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:02:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:02:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:02:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:02:17 INFO - Return code: 0 15:02:17 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-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 15:02:17 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-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost 15:02:17 INFO - Using env: {'DISPLAY': ':0', 15:02:17 INFO - 'HOME': '/home/cltbld', 15:02:17 INFO - 'LANG': 'en_US.UTF-8', 15:02:17 INFO - 'LANGUAGE': 'en_US:en', 15:02:17 INFO - 'LOGNAME': 'cltbld', 15:02:17 INFO - 'MAIL': '/var/mail/cltbld', 15:02:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:02:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:17 INFO - 'MOZ_NO_REMOTE': '1', 15:02:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:17 INFO - 'NO_EM_RESTART': '1', 15:02:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:02:17 INFO - 'PWD': '/builds/slave/test-pgo', 15:02:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:02:17 INFO - 'SHELL': '/bin/bash', 15:02:17 INFO - 'SHLVL': '1', 15:02:17 INFO - 'TERM': 'linux', 15:02:17 INFO - 'TMOUT': '86400', 15:02:17 INFO - 'USER': 'cltbld', 15:02:17 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452034882.880837-616452706', 15:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:17 INFO - '_': '/tools/buildbot/bin/python'} 15:02:17 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] with output_timeout 3600 15:02:17 INFO - mozversion INFO | application_buildid: 20160105123603 15:02:17 INFO - mozversion INFO | application_changeset: ac8bea1130743a5243ec5c172ea1f6276c8f0bf8 15:02:17 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 15:02:17 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:02:17 INFO - mozversion INFO | application_name: Firefox 15:02:17 INFO - mozversion INFO | application_remotingname: firefox-dev 15:02:17 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:02:17 INFO - mozversion INFO | application_vendor: Mozilla 15:02:17 INFO - mozversion INFO | application_version: 45.0a2 15:02:17 INFO - mozversion INFO | platform_buildid: 20160105123603 15:02:17 INFO - mozversion INFO | platform_changeset: ac8bea1130743a5243ec5c172ea1f6276c8f0bf8 15:02:17 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:02:17 INFO - mozversion INFO | platform_version: 45.0a2 15:02:17 INFO - 2016-01-05 15:02:17,853 DEBUG : using testdate: 1452034937 15:02:17 INFO - 2016-01-05 15:02:17,853 DEBUG : actual date: 1452034937 15:02:17 INFO - 2016-01-05 15:02:17,901 INFO : starting webserver on 'localhost:59787' 15:02:17 INFO - 2016-01-05 15:02:17,902 INFO : Starting test suite talos-linux64-ix-025.e 15:02:17 INFO - 2016-01-05 15:02:17,902 INFO : Starting test dromaeo_css 15:02:17 INFO - 2016-01-05 15:02:17,902 DEBUG : operating with platform_type : linux_ 15:02:17 INFO - 2016-01-05 15:02:17,903 INFO : Initialising browser for dromaeo_css test... 15:02:17 INFO - 2016-01-05 15:02:17,915 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0cdRFm/profile http://localhost:59787/getInfo.html 15:02:22 INFO - 2016-01-05 15:02:22,064 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:02:22 INFO - 2016-01-05 15:02:22,065 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:02:22 INFO - 2016-01-05 15:02:22,065 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:02:22 INFO - 2016-01-05 15:02:22,065 DEBUG : BROWSER_OUTPUT: __metrics 15:02:23 INFO - 2016-01-05 15:02:23,113 INFO : Browser initialized. 15:02:23 INFO - 2016-01-05 15:02:23,113 INFO : Running cycle 1/1 for dromaeo_css test... 15:02:23 INFO - 2016-01-05 15:02:23,113 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0cdRFm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:02:34 INFO - 2016-01-05 15:02:34,866 DEBUG : BROWSER_OUTPUT: RSS: Main: 136011776 15:02:34 INFO - 2016-01-05 15:02:34,866 DEBUG : BROWSER_OUTPUT: 15:03:24 INFO - 2016-01-05 15:03:24,465 DEBUG : BROWSER_OUTPUT: 1452035004458 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] 15:05:32 INFO - 2016-01-05 15:05:32,521 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59787/tests/dromaeo/cssquery-ext.html) 15:05:33 INFO - 2016-01-05 15:05:33,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 140693504 15:05:33 INFO - 2016-01-05 15:05:33,539 DEBUG : BROWSER_OUTPUT: 15:08:35 INFO - 2016-01-05 15:08:35,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/dromaeo/cssquery-ext.html (next: http://localhost:59787/tests/dromaeo/cssquery-jquery.html) 15:08:35 INFO - 2016-01-05 15:08:35,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 140025856 15:08:35 INFO - 2016-01-05 15:08:35,919 DEBUG : BROWSER_OUTPUT: 15:11:37 INFO - 2016-01-05 15:11:37,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59787/tests/dromaeo/cssquery-mootools.html) 15:11:38 INFO - 2016-01-05 15:11:38,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 137793536 15:11:38 INFO - 2016-01-05 15:11:38,093 DEBUG : BROWSER_OUTPUT: 15:14:39 INFO - 2016-01-05 15:14:39,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59787/tests/dromaeo/cssquery-prototype.html) 15:14:40 INFO - 2016-01-05 15:14:40,232 DEBUG : BROWSER_OUTPUT: RSS: Main: 139280384 15:14:40 INFO - 2016-01-05 15:14:40,232 DEBUG : BROWSER_OUTPUT: 15:17:42 INFO - 2016-01-05 15:17:42,461 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59787/tests/dromaeo/cssquery-yui.html) 15:17:43 INFO - 2016-01-05 15:17:43,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 139833344 15:17:43 INFO - 2016-01-05 15:17:43,083 DEBUG : BROWSER_OUTPUT: 15:20:45 INFO - 2016-01-05 15:20:45,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/dromaeo/cssquery-yui.html (next: http://localhost:59787/tests/dromaeo/cssquery-dojo.html) 15:20:45 INFO - 2016-01-05 15:20:45,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 141471744 15:20:45 INFO - 2016-01-05 15:20:45,384 DEBUG : BROWSER_OUTPUT: 15:20:45 INFO - 2016-01-05 15:20:45,384 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:20:45 INFO - 2016-01-05 15:20:45,384 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:20:45 INFO - 2016-01-05 15:20:45,384 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:20:45 INFO - 2016-01-05 15:20:45,384 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:20:45 INFO - 2016-01-05 15:20:45,384 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3305.520699498571;3314.204590898185;3344.197392625769;3347.949780753289;3365.158710322419;5503.394626591077;5540.030494663428;5579.358373787016;5584;5592.161175823629;5537.169424586314;5541.390447050821;5601.579881508893;5607.7476513556885;5642.15367694846;5050.974745126269;5107.310513080743;5165.974170129163;5170.767315470794;5216.191490319006;4959;5071.137906555876;5120.257562653413;5124.256982737501;5191.792328306863;5020.297158397827;5065.037642847848;5084.949150508503;5107.923381149286;5215.40022897366;5175;5189.325387699575;5195.350581177353;5198.714070726109;5215.40022897366;4894.755262236909;4941.332920055783;5035.446100928895;5112.667676601009;5118.0019896120275;5283.656562323436;5356.946430535722;5393.83818485446;5397.2443857859935;5412.512873841334;6013.609115407485;6032.426919442646;6047.12316714074;6074.362191969868;6081.300650425169;5809.738561764731;5893.410658934115;5956.612820166719;6075.908861367083;6095.329513753483;5582.134769110794;5643.746031428595;5648.322201335866;5651.660900345952;5659.773609055674;6122.295935967331;6128.78549250783;6129.448349648553;6134.754609815646;6137.877242455215;5728.684922329228;5787.045137552257;5815.505682017076;5853.9414605854245;5894.970525147432;5912.320083190488;6027.397260274025;6040.758369665252;6040.939590604038;6046.606970546901;5808.564357673192;5946.197263369476;6015.849603759941;6020.668863212565;6022.247219097613;5868.354481007086;5899.321578018583;5937.228160339128;5938.673372964528;5962.552808539377;4592.265237561974;4594.95405045952;4609.60818330439;4612.215923293048;4621.907561848744;4079.97960010204;4129.339305711132;4153.210889930903;4153.273177193979;4160;5631.6902570359025;5640.943590564124;5681.289838770153;5706.942930570641;5731.684757338303;5987.042073268256;6085.908711369333;6094.939050609526;6106.114613381035;6118.174046503754;5594.328680558359;5664.348599911063;5666.688332141689;5763.538916886639;5770.682612456355;5206.193040078794;5262.079136151158;5266.973665131726;5268.051750684914;5269.920951185735;6142.416470435302;6218.595791273553;6224.37756224374;6238.781642642486;6242.15730876335;5830.970845145747;5911.3201981772645;6030.819075427744;6085.726142323695;6137.438273608381;6190.876182476415;6211.472024877936;6212.565120441525;6217.502599792097;6226.813195604139;5814.622049566765;5833.212516310244;5915.58590898633;5915.911261330997;5965.522758179249;5941.881162376815;6015.1278064681255;6043.667598282137;6078.696065196634;6123.83172914054;5940.732667030081;5949.732262048305;5957.672328021827;5968.343482217039;5978.432048955342;5913.231279933581;5930.466258036798;5936.703164841654;5941.613795103304;5959.612625179349;5568.944310557004;5643.463870932255;5694.658320500783;5800.071988481823;5814.505767009851;5763.567732420169;5856.59003869725;5920.970395148169;5944.167816505779;5993.880122397615;5513.5037846594;5747.3103227612955;5815.738291776965;5827.446392592697;5835.153902684172 15:20:45 INFO - 2016-01-05 15:20:45,386 DEBUG : BROWSER_OUTPUT: |1;ext.html;561.4021067563045;623.7972658885861;625.7340630232151;625.9202875040555;688.208560155821;33422.331553368946;40017.1996560069;40315.79842100793;40495.59504404955;40611;46405.767971160094;47463.288050679264;47485.76257118718;47642.523574764244;47716.045679086485;9069.773255668611;9195.172434480895;9210.125038121401;9218.76953076175;9233.261339092856;9019;9020.368574199809;9029.503377314246;9110.043445438232;9126.087391260853;9017.233535149488;9052.954735226314;9080.636774529044;9097.090290970917;9103.226225770784;9071.818563628723;9137.725868223964;9142.268618510536;9158.450492970376;9172;8921.955390223073;8981.281497480186;9054.411463254934;9063.50150741709;9075.13786190311;43985.56014439846;44296.3355549667;44368.55631443676;44479.33281000787;44522.33216501755;3595.6224596417524;3632.237230181665;3636.2000359920776;3658.2866341063504;3702.4816525686424;33298.83350583256;33446.33107337864;33658.49512257294;33885.15287117817;33978;3852.0177354774632;3861.401482770147;3998.0804414984427;4064.959350406488;4112.8149233284275;299397;300937;301372;301406.9999999978;301791;45757.31364029542;46341;46495.76752116285;69407;69860;43996;44131.11737765291;44289.33565996512;44296.55703442989;44413.55586444094;17153;17297.56756081083;17338.653226935392;17382.826171738372;17407.564810879576;13205.20768753878;13235.27206003679;13270.800937985938;13293.734125317633;13362.064655474023;15372.461963831212;15429.919905606499;15490.07059576429;15540.300686469136;15673.216339182994;6067.423594758491;6174.228221472316;6249.437550620466;6303.495720342362;6342.080398342215;1003.2525768302515;1009.5961615353917;1019.2406657040552;1054.488573042074;1099.1866019145934;29659.110226693232;29769.851150744107;30651.386972260876;30718.232044199074;30832.69167308343;1089.2647462962468;1134.2230572058168;1137.5790957345835;1149.620625193684;1224.5591587028662;15247.161406122548;15303.846961530466;15518.844811551966;15536.533903982898;15548.76676849848;553533;559144;560526;561543;790390;63427.36572634215;64301.67849160818;64523;64569.03146452807;64659.67670161713;1482.6515768794325;1484.4581727669322;1492.0749135536037;1496.1920562895914;1516.7118247532933;32354.83822580872;32733.836330818194;33109.83445082759;33580.496292555144;33849.15377115493;52985.47014529805;53611;53702.46297537131;53706.46293537171;53776.73111634417;313130;314381;315102;315232;316648;35405;35699.64300356963;36158;36393.636063640086;36599;47609.523904761896;48404.75797620989;48556.2716559259;48899.26651100165;49639.26984015914;41725.37411938763;41966;47656;49362.75318623384;49382.25926611175;40695.796521017204;40740;40799;40952.795236024824;41278.38082428706;40923.18153636851;40968.975775605846;41158.382624261256;41184;41551.168976619694;35570.28859422745;35716.24814550225;35760.463593045606;36499.81750091232;36790.26419471542;28078.71921280761;28277.71722282833;28385.716142838308;28415.147545573665;28510.42979140447 15:20:45 INFO - 2016-01-05 15:20:45,389 DEBUG : BROWSER_OUTPUT: |2;jquery.html;385.26414548212915;387.05751495109394;390.27019473584403;390.35786131813165;391.75319548684325;16239.431619893307;17420.825791742078;18024.369147079855;18578.349757758482;18641.25434982601;17628.647427051485;17988.370407035756;18465.538361540966;18731.063446827673;18851.52871178221;5155.097857874875;5260.447652996438;5273.604479664022;5283.709395983219;5293.735313234342;5206.947930520703;5415.756290966916;5585.972070139644;5593.300837395325;5598.888022239553;5493.176023596453;5521.503064724174;5521.917171242435;5810.651360918338;5820.38885916979;5699.544036477072;5744.396838331999;5752.597318187729;5767.019606666877;5768.394318596529;5474.2609747683955;5560.082586373243;5570.610057295991;5578.107502799533;5626.971865140689;13337.73324533504;13658.248796316198;13707.45170193191;22061.669074963887;22062.11751529953;2347.225415612844;2400.195934361991;2404.386881345263;2412.4078108448516;2478;10447.268691191619;10471.947640261826;10480.266381353309;10518.474076296154;10777.407242601654;1940.2239104358227;1977.6440240756658;2021.9494512637154;2036.134642776814;2067.080149333547;61718.69140654313;64505.354946450876;66500;69918;70310.64844675796;10605.151587872951;10875.184361172944;10893.727656808644;11023.338599684044;11055.557777688964;14206.218657973704;14231.359588818528;14233.28833558318;14359.425622975174;14364.784528232085;8584.527850968258;8590.656373745105;8595.44129631572;8613.78465538354;8638;8140.3950735765175;8391.538465384463;8589.098144694843;8615.61229744663;8712.085231050774;4388.539203383662;4503.166914120898;4589.632829373642;4675.509071547439;4762.238041913347;1916.0036780873868;1980.7127966444784;1980.9504762381055;1988.2544045982756;1990.2337600024096;919.4758987377131;989.1098011789447;1006.8288390973552;1076.5908954597203;1085.3270971997254;17511.64976700459;17876.374326898494;17956.371526996492;18177.636447271245;18194.272229110687;997.5860018092555;1011.0294117647142;1016.5527168046036;1030.9742256443499;1079.7462596289865;9386;9625.807483850424;9825.557849896772;10008.299419040597;10532.789344213073;668631;683051;685909;724943;736187;86575.99289771933;86695.69956450658;86846.56576717076;87610;90625;1198.9580364687195;1231.1935682128221;1237.3813093453273;1253;1258.4211262819206;16028.919855400649;16334.836651633332;16710.164491775606;16739.91630041842;16904.830951690325;37970.81014594909;38041.809790950865;38228.04429889275;38315;38553.614463855;44741.328880066176;45956.31065533953;46541;46646;47117;9977.900220997697;10583.894161058292;10619.734506637396;10637.255392122786;10643.94678026605;17476.82523174752;17760.644787103927;17835.73246401279;18467;18651.440456786317;15038.323275452412;15280;15343.616409589404;15479.5356139316;16089.275982581046;14539;14739.705205896036;15091.849081509483;15092.471763488225;15651.686966260839;15139.54581362561;15199.696006080037;15500.147491888054;15819.129947852978;15853.841461585236;9679.225661947168;10072.597096116366;10171.694849154537;10186.847197292194;10208;10825.512851921525;12102.878971210175;14165.645858853612;14358.641033974234;14364.35360408805 15:20:45 INFO - 2016-01-05 15:20:45,391 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1582.5173322136748;1599.0645472398646;1629.6985057764311;1865.664180447519;1944.0862794486586;7316.195218525958;7458.515196512237;8255.793605159874;8391.832163356728;8399.664013439471;7939.960300198505;8031.116577176521;8044.517328960266;8074.9596252018655;8115.391345649085;2362.1614326913955;2413.2760171948435;2417.903283868652;2425.16331865507;2431.0032886516533;2335.4628435459854;2359.846609970355;2367.9881600592057;2370.383700237933;2374.4063984004;2318.107528601492;2331.172433786007;2339.742628310893;2344.1678204237505;2347.108098922407;2309.203324852923;2310.5147918936877;2324.0703718512646;2333.6266197408418;2360.3980984848754;2374.7150341959077;2383.165891937808;2411.0958390603523;2421.6004359280696;2421.6004359280696;8160.3471722262075;8212.46618969771;8232.711855085043;8243.340532757426;8244.628991695388;4723;4803.7357945313;4803.7357945313;4807.567318941312;4840.467548569654;3100.906887850714;3135.8432078396218;3136.184592006072;3160.7945483543494;3162.6362968258486;1013.2299452416144;1029.7322696098993;1033.5090831854884;1045.1847558904067;1050.5640159333868;10930.945345273301;11028.558857645685;11052.834207486894;11092.500837462334;11113.110951123972;4200.831966721297;4226.57734226581;4270.935935960963;4272.957270427318;4299.204647140289;9572.808543829224;9578.137967582812;9581.856272155923;9585.568649410794;9586.472743999147;4865.9756701216265;4869.63477739171;4871;4876.975615121902;4887.706737595756;4234.6823988201;4277.422547955986;4306.461692288464;4324.935125973113;4433.46798384196;3649.087728067983;3707.258548290353;3716.925661486755;3729.1422972716427;3734.066483379155;1056.9048785609332;1058.0213302694976;1063.0538820449806;1064.8509208710786;1074.1997212077054;1451.267110109388;1452.6077958951023;1460.773580095087;1477.4828809916444;1488.761798112297;7991.760247192594;7997.960010200029;8010.959945200237;8015.118336982927;8026.27763501276;504.389688476947;505.80779303864296;508.5016683650044;510.3900838498034;521.2181727408887;6194.473469755031;6197.5351848611535;6242.063690446378;6274.623522588659;6285.842853928597;9876.308658393844;9877.456739879231;9913.80172396548;9958.751031224278;10038.749031274276;9723;9740.512974351253;9819.950900245452;9833.557489912972;9854.063863932915;7796;7826.295633392908;7846.5292082475235;7849.411294152961;7893.565853878092;7534.849303014019;7548.811279717831;7558;7559.3196612305155;7674.040744906887;8667.393282470166;8752.168543988311;8844.380893337404;8912.643494260157;8988;8894.644214231359;8936.821263574822;9166.633334666538;9177.265818734351;9237.676681316121;6116.724747386289;6238.4073513018;6803.93196068033;6956.686949087202;7021.648917554204;7570.05374328209;7779.260970207822;7780.961095194488;7828.84342313162;7839.960800195962;7492.063492063492;7604.087509498895;7621.1997740236475;7707.15221325665;7718;7159.64201789898;7401.666924988496;7444.962775186089;7531.623418828927;7600.619969001638;7341.15576708664;7415.406767458699;7434.516756410816;7437.590932498764;7437.739679111205;6753.290904455158;6793;6807.863842723217;6817.454603631599;6936.098307220029;6961.582305061713;7007.859842803014;7009.12385951756;7010.334018268256;7010.75462358815 15:20:45 INFO - 2016-01-05 15:20:45,394 DEBUG : BROWSER_OUTPUT: |4;prototype.html;363.9872604458844;367.2764653632344;373.43611147167803;376.44098513707155;380.5015429786979;6195.070739389094;6274.498040156788;6318.684065796709;6356.396142366473;6357.2371315442215;6086.878262434749;6244.438000579947;6259.342769009257;6280.4661603763625;6302.212223472066;4902.828401005965;4904.877378065541;4906.239532872411;4909.729964851932;4915.8525244242555;4906.31311616374;4906.650671065468;4916.58209052231;4922.926156107661;4928.211486162215;4803.591694705937;4867.367242258501;4876.609871210295;4878.682885612441;4886.926696099544;4857.9757101214445;4863.9513604864205;4873.707577545341;4883.609311255091;4889.657723959324;4315.136972605492;4318.071614602844;4320.567943205654;4327.32926396409;4335.1979883721615;5869.178315035856;5920.437558431985;5961.970190149065;5965.433283838029;5967.61210521319;5621.269234999424;5726.198332233491;5728.513076388512;5735.627184233012;5749.281339832521;6634.568753031038;6653.234877989044;6656.933430665728;6661.3005634408655;6663.800085997428;4794.616430685572;4802.4237091548885;4811.037792441491;4812.085703716282;4818.71087734737;6837.897431538531;6880.311968803129;6963.6866341014775;6965.129358830146;6973.267806880255;4932.136876046678;4940.654154209171;4942.332785074041;4945.9258111128365;4962.6774259673;4995.075910956412;5009.924851127236;5013.89972200554;5017.297578339036;5029.245613157982;5600.383957764642;5700.458456446631;5701.743421546041;5712.228849105318;5716.828495145152;6704.765333213411;6713.966430167916;6746.932530674729;6747.730090796314;6765.560238584476;1686.1316422042657;1721.6212433264661;1723.9827601724073;1723.9913800430918;1744.834240747127;1139.6011396011495;1156.9305841649527;1182.261086820737;1183.5029287699188;1192.48723049088;6367.172267605274;6371.108044873721;6374.235091789015;6375.6174629522375;6404.935950640434;6851.417629501449;6895.241523432418;6896.551724137915;6900.03399524067;6910.827229319308;6369.394907483875;6415.615063096229;6431.292557818636;6445.774397896145;6464.25661048976;3707.5180226570915;3743.5882052974152;3745.8127093645753;3750.2312026034597;3750.849966001384;7026.648667566601;7042.154941407064;7045.612491313027;7055.2944705529035;7090.468214883801;6824.931750682529;7027.262137475594;7029.121359830021;7029.191642961023;7033.824154396181;7034.2262351141335;7055.6824942876665;7080.256573059857;7102.254263302382;7105.253948335454;6827.897581536182;6847.726090956306;6881.243063263138;6890.20762612306;6910.689018994057;6681.76613818514;6720.529562930744;6773.424258938046;6801.897971530332;6804.863902721819;6974.337437943387;7046.506744527834;7059.117610298713;7067.71729130829;7074.151101867808;4766.571008609242;4767.880802979953;4801.759912004456;4806.351142595705;4811.615070794258;6817.693203805939;6826.464045589702;6848;6886;6901.965490172718;6615.6030638161865;6617.900731489128;6659.53383263167;6660.167479065117;6663.833404164935;6631.436327912182;6673.5328527004585;6677.699503522256;6684.532082754355;6692.464602831859;6454.451371633464;6487.18910136233;6518.706658200297;6567.211934567691;6572.737090516517;6686.933130668631;6691.866162676816;6696.397324240842;6715.764948226789;6730.966345168243;6544.738210471528;6551.148350714377;6557;6558.278589355072;6568.244651864906 15:20:45 INFO - 2016-01-05 15:20:45,394 DEBUG : BROWSER_OUTPUT: |5;yui.html;941.2658126661204;949.5088232659523;951.9952400237997;956.6795123633582;965.5317171171985;14175.503857364994;14348;14386.280685965712;14400.279986000698;14400.49598264061;11836.28982261065;11876.940615296911;11927.880721192785;11932;12005.939970300136;898.4833720610642;906.1527471813843;923.995380023099;924.3021518753332;925.6528801699362;893.2675206330812;909.522500687138;911.5624500239888;911.7538264668535;912.0195789526252;959.4579062829514;967.042627798478;968.9612415503371;971.8153550825356;976.3751199232497;950.2018304624114;957.8180145772316;962.1004360922525;962.2830990911746;962.6486332488661;715.613568672916;721.3471808013755;721.9422446204344;723.1755798389839;725.0936329588015;12955.48178072876;12974.935125324408;13024.934875325658;13072.803907941388;13078.346082695922;12810;12915.806262906064;13305;13453.461861525528;13537.864621353858;11322.773544529146;11345;11423.94288028563;11614.128940329425;11631.302121872715;3866.941995870064;3868.12967082407;3868.8065596720335;3899.941500877489;3905.258000979805;51387.22919156215;52049;52359.21461178085;52398.99999999962;52462.475375246526;8842.646294148291;8870.955645221733;8956.955215223883;9039.954800226089;9062.501562413998;18894.149763260688;18919;18940.147693353832;18966;19028.80971190298;7183.89224161638;7264.527805692613;7332.058509449404;7707.190744971697;7811.882821757678;4266.722663026955;4298.76356800379;4348;4391.297392417262;4426.44669416323;3248.0580631616567;3258.6741325867224;3260.7065364117343;3266.6406695263504;3275.1157187559224;563.4365634365635;582.3070546050271;584.3426145586216;589.7699897040158;593.4925638579039;547.9479399552868;737.6311844077961;738.8854727517244;757.9090509138829;769.6190385759085;9010.59452324647;9358.766030849147;9399.750413905287;9466.810663786686;9499.857502137473;684.2678334182377;697.4524997876642;772.7102336623766;774.9418793590503;804.8511025460308;4211.831526738957;4241.830326786956;4301.376300436482;4332.805023773938;4337.457817772778;59383;60102.398976010554;60851.695741521005;64509.35490645033;64681;57190.42809571851;58649;58772.706136469045;59625.701871491234;60998.39001609927;54481;55335.446645533026;55476.16785748217;55833;55852.16221756677;9256.213221875947;9502.524873756423;9780.168685661514;9911.157551608194;10026.548805303924;36250.8187459061;36585;37236.81381593183;37375;37598.43602345912;45541.54458455506;46759.29861052019;46859.297110542684;46942;47105;11272.267302625303;11398.430078495876;11723.472443740222;12868.871311286768;13548.119372240773;11991.940040299743;11993.280403175837;12093.334866582423;12949.676258093623;13212.141210821266;13127.277999710108;13168.73662526725;13258.933705331412;13330.600081997556;13500.5274815381;11159.091584378913;11677.357745324089;11812.82280765772;12590.559330423392;13760.243186624431;13064.934675326562;13071.934640326737;13226.933865330997;13238.139520931109;13436.261005644783;10670.57317707283;10762.515686793957;10876.673699788702;11258.7748245033;11379.772404551697;10289.3311934724;10463.94768026155;10473.842892356774;10510.632127875488;10539.367637941748 15:20:45 INFO - 2016-01-05 15:20:45,394 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:20:45 INFO - 2016-01-05 15:20:45,394 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:20:45 INFO - 2016-01-05 15:20:45,394 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,306 15:20:45 INFO - 2016-01-05 15:20:45,394 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:20:45 INFO - 2016-01-05 15:20:45,395 DEBUG : BROWSER_OUTPUT: __startTimestamp1452036045382__endTimestamp 15:20:45 INFO - 2016-01-05 15:20:45,395 DEBUG : BROWSER_OUTPUT: 15:20:45 INFO - 2016-01-05 15:20:45,395 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:20:45 INFO - 2016-01-05 15:20:45,395 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:20:45 INFO - 2016-01-05 15:20:45,395 DEBUG : BROWSER_OUTPUT: 15:20:45 INFO - 2016-01-05 15:20:45,395 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5573.91 Median:5787.05 stddev:620.08 (10.7%) stddev-sans-first:595.90 15:20:45 INFO - 2016-01-05 15:20:45,395 DEBUG : BROWSER_OUTPUT: Values: 3305.5 3314.2 3344.2 3347.9 3365.2 5503.4 5540.0 5579.4 5584.0 5592.2 5537.2 5541.4 5601.6 5607.7 5642.2 5051.0 5107.3 5166.0 5170.8 5216.2 4959.0 5071.1 5120.3 5124.3 5191.8 5020.3 5065.0 5084.9 5107.9 5215.4 5175.0 5189.3 5195.4 5198.7 5215.4 4894.8 4941.3 5035.4 5112.7 5118.0 5283.7 5356.9 5393.8 5397.2 5412.5 6013.6 6032.4 6047.1 6074.4 6081.3 5809.7 5893.4 5956.6 6075.9 6095.3 5582.1 5643.7 5648.3 5651.7 5659.8 6122.3 6128.8 6129.4 6134.8 6137.9 5728.7 5787.0 5815.5 5853.9 5895.0 5912.3 6027.4 6040.8 6040.9 6046.6 5808.6 5946.2 6015.8 6020.7 6022.2 5868.4 5899.3 5937.2 5938.7 5962.6 4592.3 4595.0 4609.6 4612.2 4621.9 4080.0 4129.3 4153.2 4153.3 4160.0 5631.7 5640.9 5681.3 5706.9 5731.7 5987.0 6085.9 6094.9 6106.1 6118.2 5594.3 5664.3 5666.7 5763.5 5770.7 5206.2 5262.1 5267.0 5268.1 5269.9 6142.4 6218.6 6224.4 6238.8 6242.2 5831.0 5911.3 6030.8 6085.7 6137.4 6190.9 6211.5 6212.6 6217.5 6226.8 5814.6 5833.2 5915.6 5915.9 5965.5 5941.9 6015.1 6043.7 6078.7 6123.8 5940.7 5949.7 5957.7 5968.3 5978.4 5913.2 5930.5 5936.7 5941.6 5959.6 5568.9 5643.5 5694.7 5800.1 5814.5 5763.6 5856.6 5921.0 5944.2 5993.9 5513.5 5747.3 5815.7 5827.4 5835.2 15:20:45 INFO - 2016-01-05 15:20:45,395 DEBUG : BROWSER_OUTPUT: 15:20:45 INFO - 2016-01-05 15:20:45,395 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:57461.05 Median:40769.50 stddev:115709.08 (283.8%) stddev-sans-first:115954.81 15:20:45 INFO - 2016-01-05 15:20:45,395 DEBUG : BROWSER_OUTPUT: Values: 561.4 623.8 625.7 625.9 688.2 33422.3 40017.2 40315.8 40495.6 40611.0 46405.8 47463.3 47485.8 47642.5 47716.0 9069.8 9195.2 9210.1 9218.8 9233.3 9019.0 9020.4 9029.5 9110.0 9126.1 9017.2 9053.0 9080.6 9097.1 9103.2 9071.8 9137.7 9142.3 9158.5 9172.0 8922.0 8981.3 9054.4 9063.5 9075.1 43985.6 44296.3 44368.6 44479.3 44522.3 3595.6 3632.2 3636.2 3658.3 3702.5 33298.8 33446.3 33658.5 33885.2 33978.0 3852.0 3861.4 3998.1 4065.0 4112.8 299397.0 300937.0 301372.0 301407.0 301791.0 45757.3 46341.0 46495.8 69407.0 69860.0 43996.0 44131.1 44289.3 44296.6 44413.6 17153.0 17297.6 17338.7 17382.8 17407.6 13205.2 13235.3 13270.8 13293.7 13362.1 15372.5 15429.9 15490.1 15540.3 15673.2 6067.4 6174.2 6249.4 6303.5 6342.1 1003.3 1009.6 1019.2 1054.5 1099.2 29659.1 29769.9 30651.4 30718.2 30832.7 1089.3 1134.2 1137.6 1149.6 1224.6 15247.2 15303.8 15518.8 15536.5 15548.8 553533.0 559144.0 560526.0 561543.0 790390.0 63427.4 64301.7 64523.0 64569.0 64659.7 1482.7 1484.5 1492.1 1496.2 1516.7 32354.8 32733.8 33109.8 33580.5 33849.2 52985.5 53611.0 53702.5 53706.5 53776.7 313130.0 314381.0 315102.0 315232.0 316648.0 35405.0 35699.6 36158.0 36393.6 36599.0 47609.5 48404.8 48556.3 48899.3 49639.3 41725.4 41966.0 47656.0 49362.8 49382.3 40695.8 40740.0 40799.0 40952.8 41278.4 40923.2 40969.0 41158.4 41184.0 41551.2 35570.3 35716.2 35760.5 36499.8 36790.3 28078.7 28277.7 28385.7 28415.1 28510.4 15:20:45 INFO - 2016-01-05 15:20:45,395 DEBUG : BROWSER_OUTPUT: 15:20:45 INFO - 2016-01-05 15:20:45,395 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:34131.02 Median:1989.24 stddev:114330.11 (5747.4%) stddev-sans-first:114622.76 15:20:45 INFO - 2016-01-05 15:20:45,395 DEBUG : BROWSER_OUTPUT: Values: 385.3 387.1 390.3 390.4 391.8 16239.4 17420.8 18024.4 18578.3 18641.3 17628.6 17988.4 18465.5 18731.1 18851.5 5155.1 5260.4 5273.6 5283.7 5293.7 5206.9 5415.8 5586.0 5593.3 5598.9 5493.2 5521.5 5521.9 5810.7 5820.4 5699.5 5744.4 5752.6 5767.0 5768.4 5474.3 5560.1 5570.6 5578.1 5627.0 13337.7 13658.2 13707.5 22061.7 22062.1 2347.2 2400.2 2404.4 2412.4 2478.0 10447.3 10471.9 10480.3 10518.5 10777.4 1940.2 1977.6 2021.9 2036.1 2067.1 61718.7 64505.4 66500.0 69918.0 70310.6 10605.2 10875.2 10893.7 11023.3 11055.6 14206.2 14231.4 14233.3 14359.4 14364.8 8584.5 8590.7 8595.4 8613.8 8638.0 8140.4 8391.5 8589.1 8615.6 8712.1 4388.5 4503.2 4589.6 4675.5 4762.2 1916.0 1980.7 1981.0 1988.3 1990.2 919.5 989.1 1006.8 1076.6 1085.3 17511.6 17876.4 17956.4 18177.6 18194.3 997.6 1011.0 1016.6 1031.0 1079.7 9386.0 9625.8 9825.6 10008.3 10532.8 668631.0 683051.0 685909.0 724943.0 736187.0 86576.0 86695.7 86846.6 87610.0 90625.0 1199.0 1231.2 1237.4 1253.0 1258.4 16028.9 16334.8 16710.2 16739.9 16904.8 37970.8 38041.8 38228.0 38315.0 38553.6 44741.3 45956.3 46541.0 46646.0 47117.0 9977.9 10583.9 10619.7 10637.3 10643.9 17476.8 17760.6 17835.7 18467.0 18651.4 15038.3 15280.0 15343.6 15479.5 16089.3 14539.0 14739.7 15091.8 15092.5 15651.7 15139.5 15199.7 15500.1 15819.1 15853.8 9679.2 10072.6 10171.7 10186.8 10208.0 10825.5 12102.9 14165.6 14358.6 14364.4 15:20:45 INFO - 2016-01-05 15:20:45,396 DEBUG : BROWSER_OUTPUT: 15:20:45 INFO - 2016-01-05 15:20:45,397 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5709.90 Median:6258.34 stddev:3007.99 (48.1%) stddev-sans-first:3000.43 15:20:45 INFO - 2016-01-05 15:20:45,397 DEBUG : BROWSER_OUTPUT: Values: 1582.5 1599.1 1629.7 1865.7 1944.1 7316.2 7458.5 8255.8 8391.8 8399.7 7940.0 8031.1 8044.5 8075.0 8115.4 2362.2 2413.3 2417.9 2425.2 2431.0 2335.5 2359.8 2368.0 2370.4 2374.4 2318.1 2331.2 2339.7 2344.2 2347.1 2309.2 2310.5 2324.1 2333.6 2360.4 2374.7 2383.2 2411.1 2421.6 2421.6 8160.3 8212.5 8232.7 8243.3 8244.6 4723.0 4803.7 4803.7 4807.6 4840.5 3100.9 3135.8 3136.2 3160.8 3162.6 1013.2 1029.7 1033.5 1045.2 1050.6 10930.9 11028.6 11052.8 11092.5 11113.1 4200.8 4226.6 4270.9 4273.0 4299.2 9572.8 9578.1 9581.9 9585.6 9586.5 4866.0 4869.6 4871.0 4877.0 4887.7 4234.7 4277.4 4306.5 4324.9 4433.5 3649.1 3707.3 3716.9 3729.1 3734.1 1056.9 1058.0 1063.1 1064.9 1074.2 1451.3 1452.6 1460.8 1477.5 1488.8 7991.8 7998.0 8011.0 8015.1 8026.3 504.4 505.8 508.5 510.4 521.2 6194.5 6197.5 6242.1 6274.6 6285.8 9876.3 9877.5 9913.8 9958.8 10038.7 9723.0 9740.5 9820.0 9833.6 9854.1 7796.0 7826.3 7846.5 7849.4 7893.6 7534.8 7548.8 7558.0 7559.3 7674.0 8667.4 8752.2 8844.4 8912.6 8988.0 8894.6 8936.8 9166.6 9177.3 9237.7 6116.7 6238.4 6803.9 6956.7 7021.6 7570.1 7779.3 7781.0 7828.8 7840.0 7492.1 7604.1 7621.2 7707.2 7718.0 7159.6 7401.7 7445.0 7531.6 7600.6 7341.2 7415.4 7434.5 7437.6 7437.7 6753.3 6793.0 6807.9 6817.5 6936.1 6961.6 7007.9 7009.1 7010.3 7010.8 15:20:45 INFO - 2016-01-05 15:20:45,397 DEBUG : BROWSER_OUTPUT: 15:20:45 INFO - 2016-01-05 15:20:45,397 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5612.85 Median:6368.28 stddev:1649.30 (25.9%) stddev-sans-first:1606.18 15:20:45 INFO - 2016-01-05 15:20:45,398 DEBUG : BROWSER_OUTPUT: Values: 364.0 367.3 373.4 376.4 380.5 6195.1 6274.5 6318.7 6356.4 6357.2 6086.9 6244.4 6259.3 6280.5 6302.2 4902.8 4904.9 4906.2 4909.7 4915.9 4906.3 4906.7 4916.6 4922.9 4928.2 4803.6 4867.4 4876.6 4878.7 4886.9 4858.0 4864.0 4873.7 4883.6 4889.7 4315.1 4318.1 4320.6 4327.3 4335.2 5869.2 5920.4 5962.0 5965.4 5967.6 5621.3 5726.2 5728.5 5735.6 5749.3 6634.6 6653.2 6656.9 6661.3 6663.8 4794.6 4802.4 4811.0 4812.1 4818.7 6837.9 6880.3 6963.7 6965.1 6973.3 4932.1 4940.7 4942.3 4945.9 4962.7 4995.1 5009.9 5013.9 5017.3 5029.2 5600.4 5700.5 5701.7 5712.2 5716.8 6704.8 6714.0 6746.9 6747.7 6765.6 1686.1 1721.6 1724.0 1724.0 1744.8 1139.6 1156.9 1182.3 1183.5 1192.5 6367.2 6371.1 6374.2 6375.6 6404.9 6851.4 6895.2 6896.6 6900.0 6910.8 6369.4 6415.6 6431.3 6445.8 6464.3 3707.5 3743.6 3745.8 3750.2 3750.8 7026.6 7042.2 7045.6 7055.3 7090.5 6824.9 7027.3 7029.1 7029.2 7033.8 7034.2 7055.7 7080.3 7102.3 7105.3 6827.9 6847.7 6881.2 6890.2 6910.7 6681.8 6720.5 6773.4 6801.9 6804.9 6974.3 7046.5 7059.1 7067.7 7074.2 4766.6 4767.9 4801.8 4806.4 4811.6 6817.7 6826.5 6848.0 6886.0 6902.0 6615.6 6617.9 6659.5 6660.2 6663.8 6631.4 6673.5 6677.7 6684.5 6692.5 6454.5 6487.2 6518.7 6567.2 6572.7 6686.9 6691.9 6696.4 6715.8 6731.0 6544.7 6551.1 6557.0 6558.3 6568.2 15:20:45 INFO - 2016-01-05 15:20:45,399 DEBUG : BROWSER_OUTPUT: 15:20:45 INFO - 2016-01-05 15:20:45,399 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14957.46 Median:24984.00 stddev:17693.33 (70.8%) stddev-sans-first:17711.66 15:20:45 INFO - 2016-01-05 15:20:45,399 DEBUG : BROWSER_OUTPUT: Values: 941.3 949.5 952.0 956.7 965.5 14175.5 14348.0 14386.3 14400.3 14400.5 11836.3 11876.9 11927.9 11932.0 12005.9 898.5 906.2 924.0 924.3 925.7 893.3 909.5 911.6 911.8 912.0 959.5 967.0 969.0 971.8 976.4 950.2 957.8 962.1 962.3 962.6 715.6 721.3 721.9 723.2 725.1 12955.5 12974.9 13024.9 13072.8 13078.3 12810.0 12915.8 13305.0 13453.5 13537.9 11322.8 11345.0 11423.9 11614.1 11631.3 3866.9 3868.1 3868.8 3899.9 3905.3 51387.2 52049.0 52359.2 52399.0 52462.5 8842.6 8871.0 8957.0 9040.0 9062.5 18894.1 18919.0 18940.1 18966.0 19028.8 7183.9 7264.5 7332.1 7707.2 7811.9 4266.7 4298.8 4348.0 4391.3 4426.4 3248.1 3258.7 3260.7 3266.6 3275.1 563.4 582.3 584.3 589.8 593.5 547.9 737.6 738.9 757.9 769.6 9010.6 9358.8 9399.8 9466.8 9499.9 684.3 697.5 772.7 774.9 804.9 4211.8 4241.8 4301.4 4332.8 4337.5 59383.0 60102.4 60851.7 64509.4 64681.0 57190.4 58649.0 58772.7 59625.7 60998.4 54481.0 55335.4 55476.2 55833.0 55852.2 9256.2 9502.5 9780.2 9911.2 10026.5 36250.8 36585.0 37236.8 37375.0 37598.4 45541.5 46759.3 46859.3 46942.0 47105.0 11272.3 11398.4 11723.5 12868.9 13548.1 11991.9 11993.3 12093.3 12949.7 13212.1 13127.3 13168.7 13258.9 13330.6 13500.5 11159.1 11677.4 11812.8 12590.6 13760.2 13064.9 13071.9 13226.9 13238.1 13436.3 10670.6 10762.5 10876.7 11258.8 11379.8 10289.3 10463.9 10473.8 10510.6 10539.4 15:20:45 INFO - 2016-01-05 15:20:45,399 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:20:45 INFO - 2016-01-05 15:20:45,399 DEBUG : BROWSER_OUTPUT: 15:20:46 INFO - 2016-01-05 15:20:46,085 INFO : Browser exited with error code: 0 15:20:46 INFO - 2016-01-05 15:20:46,106 INFO : Completed test dromaeo_css (00:18:28) 15:20:46 INFO - 2016-01-05 15:20:46,106 INFO : Starting test kraken 15:20:46 INFO - 2016-01-05 15:20:46,106 DEBUG : operating with platform_type : linux_ 15:20:46 INFO - 2016-01-05 15:20:46,106 INFO : Initialising browser for kraken test... 15:20:46 INFO - 2016-01-05 15:20:46,112 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuKU9F1/profile http://localhost:59787/getInfo.html 15:20:50 INFO - 2016-01-05 15:20:50,369 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:20:50 INFO - 2016-01-05 15:20:50,369 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:20:50 INFO - 2016-01-05 15:20:50,369 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:20:50 INFO - 2016-01-05 15:20:50,369 DEBUG : BROWSER_OUTPUT: __metrics 15:20:51 INFO - 2016-01-05 15:20:51,305 INFO : Browser initialized. 15:20:51 INFO - 2016-01-05 15:20:51,305 INFO : Running cycle 1/1 for kraken test... 15:20:51 INFO - 2016-01-05 15:20:51,305 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuKU9F1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:21:03 INFO - 2016-01-05 15:21:03,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 136781824 15:21:03 INFO - 2016-01-05 15:21:03,120 DEBUG : BROWSER_OUTPUT: 15:21:05 INFO - 2016-01-05 15:21:05,595 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59787/tests/kraken/driver.html?testName=audio-beat-detection) 15:21:06 INFO - 2016-01-05 15:21:06,197 DEBUG : BROWSER_OUTPUT: RSS: Main: 138100736 15:21:06 INFO - 2016-01-05 15:21:06,197 DEBUG : BROWSER_OUTPUT: 15:21:08 INFO - 2016-01-05 15:21:08,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59787/tests/kraken/driver.html?testName=audio-dft) 15:21:09 INFO - 2016-01-05 15:21:09,381 DEBUG : BROWSER_OUTPUT: RSS: Main: 138903552 15:21:09 INFO - 2016-01-05 15:21:09,382 DEBUG : BROWSER_OUTPUT: 15:21:12 INFO - 2016-01-05 15:21:12,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59787/tests/kraken/driver.html?testName=audio-fft) 15:21:12 INFO - 2016-01-05 15:21:12,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 138919936 15:21:12 INFO - 2016-01-05 15:21:12,768 DEBUG : BROWSER_OUTPUT: 15:21:14 INFO - 2016-01-05 15:21:14,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59787/tests/kraken/driver.html?testName=audio-oscillator) 15:21:15 INFO - 2016-01-05 15:21:15,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 139112448 15:21:15 INFO - 2016-01-05 15:21:15,375 DEBUG : BROWSER_OUTPUT: 15:21:17 INFO - 2016-01-05 15:21:17,577 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59787/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:21:18 INFO - 2016-01-05 15:21:18,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 139157504 15:21:18 INFO - 2016-01-05 15:21:18,164 DEBUG : BROWSER_OUTPUT: 15:21:21 INFO - 2016-01-05 15:21:21,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59787/tests/kraken/driver.html?testName=imaging-darkroom) 15:21:21 INFO - 2016-01-05 15:21:21,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 138723328 15:21:21 INFO - 2016-01-05 15:21:21,669 DEBUG : BROWSER_OUTPUT: 15:21:25 INFO - 2016-01-05 15:21:25,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59787/tests/kraken/driver.html?testName=imaging-desaturate) 15:21:25 INFO - 2016-01-05 15:21:25,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 139059200 15:21:25 INFO - 2016-01-05 15:21:25,614 DEBUG : BROWSER_OUTPUT: 15:21:28 INFO - 2016-01-05 15:21:28,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59787/tests/kraken/driver.html?testName=json-parse-financial) 15:21:28 INFO - 2016-01-05 15:21:28,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 138551296 15:21:28 INFO - 2016-01-05 15:21:28,935 DEBUG : BROWSER_OUTPUT: 15:21:30 INFO - 2016-01-05 15:21:30,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59787/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:21:31 INFO - 2016-01-05 15:21:31,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 138784768 15:21:31 INFO - 2016-01-05 15:21:31,102 DEBUG : BROWSER_OUTPUT: 15:21:32 INFO - 2016-01-05 15:21:32,904 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59787/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:21:33 INFO - 2016-01-05 15:21:33,518 DEBUG : BROWSER_OUTPUT: RSS: Main: 138678272 15:21:33 INFO - 2016-01-05 15:21:33,518 DEBUG : BROWSER_OUTPUT: 15:21:35 INFO - 2016-01-05 15:21:35,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59787/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:21:36 INFO - 2016-01-05 15:21:36,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 139350016 15:21:36 INFO - 2016-01-05 15:21:36,133 DEBUG : BROWSER_OUTPUT: 15:21:38 INFO - 2016-01-05 15:21:38,527 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59787/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:21:39 INFO - 2016-01-05 15:21:39,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 139468800 15:21:39 INFO - 2016-01-05 15:21:39,122 DEBUG : BROWSER_OUTPUT: 15:21:41 INFO - 2016-01-05 15:21:41,666 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59787/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:21:42 INFO - 2016-01-05 15:21:42,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 139575296 15:21:42 INFO - 2016-01-05 15:21:42,247 DEBUG : BROWSER_OUTPUT: 15:21:43 INFO - 2016-01-05 15:21:43,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59787/tests/kraken/driver.html?testName=ai-astar) 15:21:44 INFO - 2016-01-05 15:21:44,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 138153984 15:21:44 INFO - 2016-01-05 15:21:44,186 DEBUG : BROWSER_OUTPUT: 15:21:44 INFO - 2016-01-05 15:21:44,188 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:21:44 INFO - 2016-01-05 15:21:44,188 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:21:44 INFO - 2016-01-05 15:21:44,188 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:21:44 INFO - 2016-01-05 15:21:44,188 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:21:44 INFO - 2016-01-05 15:21:44,188 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;104;111;111;110;121;110;112;111;110 15:21:44 INFO - 2016-01-05 15:21:44,189 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;121;143;157;124;145;156;124;166;130 15:21:44 INFO - 2016-01-05 15:21:44,189 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;161;161;162;160;162;161;163;162 15:21:44 INFO - 2016-01-05 15:21:44,189 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;71;71;157;73;71;71;73;152;71 15:21:44 INFO - 2016-01-05 15:21:44,189 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;134;92;94;92;139;92;92;141 15:21:44 INFO - 2016-01-05 15:21:44,189 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;109;110;110;109;109;110 15:21:44 INFO - 2016-01-05 15:21:44,189 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;147;146;147;147;146;146;148;147 15:21:44 INFO - 2016-01-05 15:21:44,189 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;97;96;96;96;96;96;96;96 15:21:44 INFO - 2016-01-05 15:21:44,190 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;63;61;62;61;61;63;62;58;60 15:21:44 INFO - 2016-01-05 15:21:44,190 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;64;64;65;64;63;64;63;64 15:21:44 INFO - 2016-01-05 15:21:44,190 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;81;90;83;83;81;81;82;82;80 15:21:44 INFO - 2016-01-05 15:21:44,190 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;115;117;113;113;122;113;121;113;122 15:21:44 INFO - 2016-01-05 15:21:44,190 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;153;144;149;148;136;155;148;150;137 15:21:44 INFO - 2016-01-05 15:21:44,190 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;69;72;67;66;69;67;78;69 15:21:44 INFO - 2016-01-05 15:21:44,190 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:21:44 INFO - 2016-01-05 15:21:44,190 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:21:44 INFO - 2016-01-05 15:21:44,191 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,715 15:21:44 INFO - 2016-01-05 15:21:44,191 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:21:44 INFO - 2016-01-05 15:21:44,191 DEBUG : BROWSER_OUTPUT: __startTimestamp1452036104186__endTimestamp 15:21:44 INFO - 2016-01-05 15:21:44,191 DEBUG : BROWSER_OUTPUT: 15:21:44 INFO - 2016-01-05 15:21:44,194 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:21:44 INFO - 2016-01-05 15:21:44,194 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:21:44 INFO - 2016-01-05 15:21:44,195 DEBUG : BROWSER_OUTPUT: 15:21:44 INFO - 2016-01-05 15:21:44,195 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:4.12 (3.7%) stddev-sans-first:4.37 15:21:44 INFO - 2016-01-05 15:21:44,195 DEBUG : BROWSER_OUTPUT: Values: 111.0 104.0 111.0 111.0 110.0 121.0 110.0 112.0 111.0 110.0 15:21:44 INFO - 2016-01-05 15:21:44,195 DEBUG : BROWSER_OUTPUT: 15:21:44 INFO - 2016-01-05 15:21:44,195 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.70 Median:148.00 stddev:16.06 (10.8%) stddev-sans-first:16.67 15:21:44 INFO - 2016-01-05 15:21:44,195 DEBUG : BROWSER_OUTPUT: Values: 151.0 121.0 143.0 157.0 124.0 145.0 156.0 124.0 166.0 130.0 15:21:44 INFO - 2016-01-05 15:21:44,195 DEBUG : BROWSER_OUTPUT: 15:21:44 INFO - 2016-01-05 15:21:44,195 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 15:21:44 INFO - 2016-01-05 15:21:44,195 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 161.0 161.0 162.0 160.0 162.0 161.0 163.0 162.0 15:21:44 INFO - 2016-01-05 15:21:44,195 DEBUG : BROWSER_OUTPUT: 15:21:44 INFO - 2016-01-05 15:21:44,195 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.80 Median:71.00 stddev:34.71 (48.9%) stddev-sans-first:36.60 15:21:44 INFO - 2016-01-05 15:21:44,195 DEBUG : BROWSER_OUTPUT: Values: 78.0 71.0 71.0 157.0 73.0 71.0 71.0 73.0 152.0 71.0 15:21:44 INFO - 2016-01-05 15:21:44,195 DEBUG : BROWSER_OUTPUT: 15:21:44 INFO - 2016-01-05 15:21:44,195 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:92.00 stddev:22.16 (24.1%) stddev-sans-first:22.91 15:21:44 INFO - 2016-01-05 15:21:44,195 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 134.0 92.0 94.0 92.0 139.0 92.0 92.0 141.0 15:21:44 INFO - 2016-01-05 15:21:44,195 DEBUG : BROWSER_OUTPUT: 15:21:44 INFO - 2016-01-05 15:21:44,196 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 15:21:44 INFO - 2016-01-05 15:21:44,196 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 109.0 110.0 110.0 109.0 109.0 110.0 15:21:44 INFO - 2016-01-05 15:21:44,196 DEBUG : BROWSER_OUTPUT: 15:21:44 INFO - 2016-01-05 15:21:44,196 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 15:21:44 INFO - 2016-01-05 15:21:44,196 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 147.0 146.0 147.0 147.0 146.0 146.0 148.0 147.0 15:21:44 INFO - 2016-01-05 15:21:44,196 DEBUG : BROWSER_OUTPUT: 15:21:44 INFO - 2016-01-05 15:21:44,196 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 15:21:44 INFO - 2016-01-05 15:21:44,196 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 15:21:44 INFO - 2016-01-05 15:21:44,196 DEBUG : BROWSER_OUTPUT: 15:21:44 INFO - 2016-01-05 15:21:44,196 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.10 Median:61.50 stddev:1.52 (2.5%) stddev-sans-first:1.56 15:21:44 INFO - 2016-01-05 15:21:44,196 DEBUG : BROWSER_OUTPUT: Values: 60.0 63.0 61.0 62.0 61.0 61.0 63.0 62.0 58.0 60.0 15:21:44 INFO - 2016-01-05 15:21:44,196 DEBUG : BROWSER_OUTPUT: 15:21:44 INFO - 2016-01-05 15:21:44,196 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 15:21:44 INFO - 2016-01-05 15:21:44,196 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 64.0 64.0 65.0 64.0 63.0 64.0 63.0 64.0 15:21:44 INFO - 2016-01-05 15:21:44,196 DEBUG : BROWSER_OUTPUT: 15:21:44 INFO - 2016-01-05 15:21:44,197 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:2.84 (3.5%) stddev-sans-first:2.96 15:21:44 INFO - 2016-01-05 15:21:44,197 DEBUG : BROWSER_OUTPUT: Values: 81.0 81.0 90.0 83.0 83.0 81.0 81.0 82.0 82.0 80.0 15:21:44 INFO - 2016-01-05 15:21:44,197 DEBUG : BROWSER_OUTPUT: 15:21:44 INFO - 2016-01-05 15:21:44,197 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.20 Median:119.00 stddev:4.34 (3.6%) stddev-sans-first:4.07 15:21:44 INFO - 2016-01-05 15:21:44,197 DEBUG : BROWSER_OUTPUT: Values: 123.0 115.0 117.0 113.0 113.0 122.0 113.0 121.0 113.0 122.0 15:21:44 INFO - 2016-01-05 15:21:44,197 DEBUG : BROWSER_OUTPUT: 15:21:44 INFO - 2016-01-05 15:21:44,197 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.60 Median:148.50 stddev:6.19 (4.2%) stddev-sans-first:6.56 15:21:44 INFO - 2016-01-05 15:21:44,197 DEBUG : BROWSER_OUTPUT: Values: 146.0 153.0 144.0 149.0 148.0 136.0 155.0 148.0 150.0 137.0 15:21:44 INFO - 2016-01-05 15:21:44,197 DEBUG : BROWSER_OUTPUT: 15:21:44 INFO - 2016-01-05 15:21:44,197 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:3.47 (5.0%) stddev-sans-first:3.64 15:21:44 INFO - 2016-01-05 15:21:44,197 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 72.0 67.0 66.0 69.0 67.0 78.0 69.0 15:21:44 INFO - 2016-01-05 15:21:44,197 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:21:44 INFO - 2016-01-05 15:21:44,197 DEBUG : BROWSER_OUTPUT: 15:21:45 INFO - 2016-01-05 15:21:45,057 INFO : Browser exited with error code: 0 15:21:45 INFO - 2016-01-05 15:21:45,107 INFO : Completed test kraken (00:00:59) 15:21:45 INFO - 2016-01-05 15:21:45,107 INFO : Starting test v8_7 15:21:45 INFO - 2016-01-05 15:21:45,107 DEBUG : operating with platform_type : linux_ 15:21:45 INFO - 2016-01-05 15:21:45,107 INFO : Initialising browser for v8_7 test... 15:21:45 INFO - 2016-01-05 15:21:45,113 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6z5HLT/profile http://localhost:59787/getInfo.html 15:21:49 INFO - 2016-01-05 15:21:49,394 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:21:49 INFO - 2016-01-05 15:21:49,394 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:21:49 INFO - 2016-01-05 15:21:49,395 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:21:49 INFO - 2016-01-05 15:21:49,395 DEBUG : BROWSER_OUTPUT: __metrics 15:21:50 INFO - 2016-01-05 15:21:50,321 INFO : Browser initialized. 15:21:50 INFO - 2016-01-05 15:21:50,321 INFO : Running cycle 1/1 for v8_7 test... 15:21:50 INFO - 2016-01-05 15:21:50,321 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6z5HLT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:22:02 INFO - 2016-01-05 15:22:02,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 136425472 15:22:02 INFO - 2016-01-05 15:22:02,120 DEBUG : BROWSER_OUTPUT: 15:22:23 INFO - 2016-01-05 15:22:23,468 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59787/tests/v8_7/run.html (next: http://localhost:59787/tests/v8_7/run.html) 15:22:23 INFO - 2016-01-05 15:22:23,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 136470528 15:22:23 INFO - 2016-01-05 15:22:23,719 DEBUG : BROWSER_OUTPUT: 15:22:23 INFO - 2016-01-05 15:22:23,719 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:22:23 INFO - 2016-01-05 15:22:23,719 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:22:23 INFO - 2016-01-05 15:22:23,720 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:22:23 INFO - 2016-01-05 15:22:23,720 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:22:23 INFO - 2016-01-05 15:22:23,720 DEBUG : BROWSER_OUTPUT: |0;Richards;165.78249336870027 15:22:23 INFO - 2016-01-05 15:22:23,720 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.50418760469012 15:22:23 INFO - 2016-01-05 15:22:23,721 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.31895352073474 15:22:23 INFO - 2016-01-05 15:22:23,721 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5208.333333333333 15:22:23 INFO - 2016-01-05 15:22:23,721 DEBUG : BROWSER_OUTPUT: |4;RayTrace;915.7509157509157 15:22:23 INFO - 2016-01-05 15:22:23,721 DEBUG : BROWSER_OUTPUT: |5;Earley;544.9591280653951 15:22:23 INFO - 2016-01-05 15:22:23,721 DEBUG : BROWSER_OUTPUT: |6;Boyer;11032.967032967033 15:22:23 INFO - 2016-01-05 15:22:23,722 DEBUG : BROWSER_OUTPUT: |7;RegExp;23809.52380952381 15:22:23 INFO - 2016-01-05 15:22:23,722 DEBUG : BROWSER_OUTPUT: |8;Splay;519.7505197505197 15:22:23 INFO - 2016-01-05 15:22:23,723 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4882.926829268293 15:22:23 INFO - 2016-01-05 15:22:23,723 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:22:23 INFO - 2016-01-05 15:22:23,723 DEBUG : BROWSER_OUTPUT: __startTimestamp1452036143718__endTimestamp 15:22:23 INFO - 2016-01-05 15:22:23,724 DEBUG : BROWSER_OUTPUT: 15:22:23 INFO - 2016-01-05 15:22:23,724 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:22:23 INFO - 2016-01-05 15:22:23,724 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:22:23 INFO - 2016-01-05 15:22:23,724 DEBUG : BROWSER_OUTPUT: 15:22:23 INFO - 2016-01-05 15:22:23,724 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.78 Median:165.78 stddev:0.00 (0.0%) 15:22:23 INFO - 2016-01-05 15:22:23,724 DEBUG : BROWSER_OUTPUT: Values: 165.8 15:22:23 INFO - 2016-01-05 15:22:23,724 DEBUG : BROWSER_OUTPUT: 15:22:23 INFO - 2016-01-05 15:22:23,724 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.50 Median:167.50 stddev:0.00 (0.0%) 15:22:23 INFO - 2016-01-05 15:22:23,725 DEBUG : BROWSER_OUTPUT: Values: 167.5 15:22:23 INFO - 2016-01-05 15:22:23,725 DEBUG : BROWSER_OUTPUT: 15:22:23 INFO - 2016-01-05 15:22:23,725 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 15:22:23 INFO - 2016-01-05 15:22:23,725 DEBUG : BROWSER_OUTPUT: Values: 278.3 15:22:23 INFO - 2016-01-05 15:22:23,725 DEBUG : BROWSER_OUTPUT: 15:22:23 INFO - 2016-01-05 15:22:23,725 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 15:22:23 INFO - 2016-01-05 15:22:23,725 DEBUG : BROWSER_OUTPUT: Values: 5208.3 15:22:23 INFO - 2016-01-05 15:22:23,726 DEBUG : BROWSER_OUTPUT: 15:22:23 INFO - 2016-01-05 15:22:23,726 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:915.75 Median:915.75 stddev:0.00 (0.0%) 15:22:23 INFO - 2016-01-05 15:22:23,726 DEBUG : BROWSER_OUTPUT: Values: 915.8 15:22:23 INFO - 2016-01-05 15:22:23,726 DEBUG : BROWSER_OUTPUT: 15:22:23 INFO - 2016-01-05 15:22:23,726 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:544.96 Median:544.96 stddev:0.00 (0.0%) 15:22:23 INFO - 2016-01-05 15:22:23,726 DEBUG : BROWSER_OUTPUT: Values: 545.0 15:22:23 INFO - 2016-01-05 15:22:23,726 DEBUG : BROWSER_OUTPUT: 15:22:23 INFO - 2016-01-05 15:22:23,726 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11032.97 Median:11032.97 stddev:0.00 (0.0%) 15:22:23 INFO - 2016-01-05 15:22:23,727 DEBUG : BROWSER_OUTPUT: Values: 11033.0 15:22:23 INFO - 2016-01-05 15:22:23,727 DEBUG : BROWSER_OUTPUT: 15:22:23 INFO - 2016-01-05 15:22:23,727 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23809.52 Median:23809.52 stddev:0.00 (0.0%) 15:22:23 INFO - 2016-01-05 15:22:23,727 DEBUG : BROWSER_OUTPUT: Values: 23809.5 15:22:23 INFO - 2016-01-05 15:22:23,727 DEBUG : BROWSER_OUTPUT: 15:22:23 INFO - 2016-01-05 15:22:23,727 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:519.75 Median:519.75 stddev:0.00 (0.0%) 15:22:23 INFO - 2016-01-05 15:22:23,727 DEBUG : BROWSER_OUTPUT: Values: 519.8 15:22:23 INFO - 2016-01-05 15:22:23,728 DEBUG : BROWSER_OUTPUT: 15:22:23 INFO - 2016-01-05 15:22:23,728 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4882.93 Median:4882.93 stddev:0.00 (0.0%) 15:22:23 INFO - 2016-01-05 15:22:23,728 DEBUG : BROWSER_OUTPUT: Values: 4882.9 15:22:23 INFO - 2016-01-05 15:22:23,728 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:22:23 INFO - 2016-01-05 15:22:23,728 DEBUG : BROWSER_OUTPUT: 15:22:24 INFO - 2016-01-05 15:22:24,577 INFO : Browser exited with error code: 0 15:22:24 INFO - 2016-01-05 15:22:24,589 INFO : Completed test v8_7 (00:00:39) 15:22:24 INFO - 2016-01-05 15:22:24,809 INFO : Completed test suite (00:20:06) 15:22:24 INFO - 2016-01-05 15:22:24,809 DEBUG : Working with test: dromaeo_css 15:22:24 INFO - 2016-01-05 15:22:24,809 DEBUG : Generating results file: dromaeo_css 15:22:24 INFO - 2016-01-05 15:22:24,811 DEBUG : Working with test: kraken 15:22:24 INFO - 2016-01-05 15:22:24,811 DEBUG : Generating results file: kraken 15:22:24 INFO - 2016-01-05 15:22:24,811 INFO : javascript benchmark 15:22:24 INFO - 2016-01-05 15:22:24,811 DEBUG : Working with test: v8_7 15:22:24 INFO - 2016-01-05 15:22:24,811 DEBUG : Generating results file: v8_7 15:22:24 INFO - 2016-01-05 15:22:24,812 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:22:24 INFO - 2016-01-05 15:22:24,863 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 15:22:24 INFO - 2016-01-05 15:22:24,863 DEBUG : process_Request line: dromaeo_css 7418.69 graph.html#tests=[[72,52,43]] 15:22:24 INFO - 2016-01-05 15:22:24,863 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:22:24 INFO - 2016-01-05 15:22:24,894 DEBUG : process_Request line: kraken 1502.40 graph.html#tests=[[232,52,43]] 15:22:24 INFO - 2016-01-05 15:22:24,894 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:22:24 INFO - 2016-01-05 15:22:24,922 DEBUG : process_Request line: v8_7 23266.08 graph.html#tests=[[230,52,43]] 15:22:24 INFO - 2016-01-05 15:22:24,923 INFO : javascript benchmark 15:22:24 INFO - 2016-01-05 15:22:24,927 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3305.520699498571, 3314.204590898185, 3344.197392625769, 3347.949780753289, 3365.158710322419, 5503.394626591077, 5540.030494663428, 5579.358373787016, 5584.0, 5592.161175823629, 5537.169424586314, 5541.390447050821, 5601.579881508893, 5607.7476513556885, 5642.15367694846, 5050.974745126269, 5107.310513080743, 5165.974170129163, 5170.767315470794, 5216.191490319006, 4959.0, 5071.137906555876, 5120.257562653413, 5124.256982737501, 5191.792328306863, 5020.297158397827, 5065.037642847848, 5084.949150508503, 5107.923381149286, 5215.40022897366, 5175.0, 5189.325387699575, 5195.350581177353, 5198.714070726109, 5215.40022897366, 4894.755262236909, 4941.332920055783, 5035.446100928895, 5112.667676601009, 5118.0019896120275, 5283.656562323436, 5356.946430535722, 5393.83818485446, 5397.2443857859935, 5412.512873841334, 6013.609115407485, 6032.426919442646, 6047.12316714074, 6074.362191969868, 6081.300650425169, 5809.738561764731, 5893.410658934115, 5956.612820166719, 6075.908861367083, 6095.329513753483, 5582.134769110794, 5643.746031428595, 5648.322201335866, 5651.660900345952, 5659.773609055674, 6122.295935967331, 6128.78549250783, 6129.448349648553, 6134.754609815646, 6137.877242455215, 5728.684922329228, 5787.045137552257, 5815.505682017076, 5853.9414605854245, 5894.970525147432, 5912.320083190488, 6027.397260274025, 6040.758369665252, 6040.939590604038, 6046.606970546901, 5808.564357673192, 5946.197263369476, 6015.849603759941, 6020.668863212565, 6022.247219097613, 5868.354481007086, 5899.321578018583, 5937.228160339128, 5938.673372964528, 5962.552808539377, 4592.265237561974, 4594.95405045952, 4609.60818330439, 4612.215923293048, 4621.907561848744, 4079.97960010204, 4129.339305711132, 4153.210889930903, 4153.273177193979, 4160.0, 5631.6902570359025, 5640.943590564124, 5681.289838770153, 5706.942930570641, 5731.684757338303, 5987.042073268256, 6085.908711369333, 6094.939050609526, 6106.114613381035, 6118.174046503754, 5594.328680558359, 5664.348599911063, 5666.688332141689, 5763.538916886639, 5770.682612456355, 5206.193040078794, 5262.079136151158, 5266.973665131726, 5268.051750684914, 5269.920951185735, 6142.416470435302, 6218.595791273553, 6224.37756224374, 6238.781642642486, 6242.15730876335, 5830.970845145747, 5911.3201981772645, 6030.819075427744, 6085.726142323695, 6137.438273608381, 6190.876182476415, 6211.472024877936, 6212.565120441525, 6217.502599792097, 6226.813195604139, 5814.622049566765, 5833.212516310244, 5915.58590898633, 5915.911261330997, 5965.522758179249, 5941.881162376815, 6015.1278064681255, 6043.667598282137, 6078.696065196634, 6123.83172914054, 5940.732667030081, 5949.732262048305, 5957.672328021827, 5968.343482217039, 5978.432048955342, 5913.231279933581, 5930.466258036798, 5936.703164841654, 5941.613795103304, 5959.612625179349, 5568.944310557004, 5643.463870932255, 5694.658320500783, 5800.071988481823, 5814.505767009851, 5763.567732420169, 5856.59003869725, 5920.970395148169, 5944.167816505779, 5993.880122397615, 5513.5037846594, 5747.3103227612955, 5815.738291776965, 5827.446392592697, 5835.153902684172], "unit": "ms", "name": "dojo.html", "value": 5533.544973446023}, {"lowerIsBetter": false, "replicates": [561.4021067563045, 623.7972658885861, 625.7340630232151, 625.9202875040555, 688.208560155821, 33422.331553368946, 40017.1996560069, 40315.79842100793, 40495.59504404955, 40611.0, 46405.767971160094, 47463.288050679264, 47485.76257118718, 47642.523574764244, 47716.045679086485, 9069.773255668611, 9195.172434480895, 9210.125038121401, 9218.76953076175, 9233.261339092856, 9019.0, 9020.368574199809, 9029.503377314246, 9110.043445438232, 9126.087391260853, 9017.233535149488, 9052.954735226314, 9080.636774529044, 9097.090290970917, 9103.226225770784, 9071.818563628723, 9137.725868223964, 9142.268618510536, 9158.450492970376, 9172.0, 8921.955390223073, 8981.281497480186, 9054.411463254934, 9063.50150741709, 9075.13786190311, 43985.56014439846, 44296.3355549667, 44368.55631443676, 44479.33281000787, 44522.33216501755, 3595.6224596417524, 3632.237230181665, 3636.2000359920776, 3658.2866341063504, 3702.4816525686424, 33298.83350583256, 33446.33107337864, 33658.49512257294, 33885.15287117817, 33978.0, 3852.0177354774632, 3861.401482770147, 3998.0804414984427, 4064.959350406488, 4112.8149233284275, 299397.0, 300937.0, 301372.0, 301406.9999999978, 301791.0, 45757.31364029542, 46341.0, 46495.76752116285, 69407.0, 69860.0, 43996.0, 44131.11737765291, 44289.33565996512, 44296.55703442989, 44413.55586444094, 17153.0, 17297.56756081083, 17338.653226935392, 17382.826171738372, 17407.564810879576, 13205.20768753878, 13235.27206003679, 13270.800937985938, 13293.734125317633, 13362.064655474023, 15372.461963831212, 15429.919905606499, 15490.07059576429, 15540.300686469136, 15673.216339182994, 6067.423594758491, 6174.228221472316, 6249.437550620466, 6303.495720342362, 6342.080398342215, 1003.2525768302515, 1009.5961615353917, 1019.2406657040552, 1054.488573042074, 1099.1866019145934, 29659.110226693232, 29769.851150744107, 30651.386972260876, 30718.232044199074, 30832.69167308343, 1089.2647462962468, 1134.2230572058168, 1137.5790957345835, 1149.620625193684, 1224.5591587028662, 15247.161406122548, 15303.846961530466, 15518.844811551966, 15536.533903982898, 15548.76676849848, 553533.0, 559144.0, 560526.0, 561543.0, 790390.0, 63427.36572634215, 64301.67849160818, 64523.0, 64569.03146452807, 64659.67670161713, 1482.6515768794325, 1484.4581727669322, 1492.0749135536037, 1496.1920562895914, 1516.7118247532933, 32354.83822580872, 32733.836330818194, 33109.83445082759, 33580.496292555144, 33849.15377115493, 52985.47014529805, 53611.0, 53702.46297537131, 53706.46293537171, 53776.73111634417, 313130.0, 314381.0, 315102.0, 315232.0, 316648.0, 35405.0, 35699.64300356963, 36158.0, 36393.636063640086, 36599.0, 47609.523904761896, 48404.75797620989, 48556.2716559259, 48899.26651100165, 49639.26984015914, 41725.37411938763, 41966.0, 47656.0, 49362.75318623384, 49382.25926611175, 40695.796521017204, 40740.0, 40799.0, 40952.795236024824, 41278.38082428706, 40923.18153636851, 40968.975775605846, 41158.382624261256, 41184.0, 41551.168976619694, 35570.28859422745, 35716.24814550225, 35760.463593045606, 36499.81750091232, 36790.26419471542, 28078.71921280761, 28277.71722282833, 28385.716142838308, 28415.147545573665, 28510.42979140447], "unit": "ms", "name": "ext.html", "value": 19961.84109039194}, {"lowerIsBetter": false, "replicates": [385.26414548212915, 387.05751495109394, 390.27019473584403, 390.35786131813165, 391.75319548684325, 16239.431619893307, 17420.825791742078, 18024.369147079855, 18578.349757758482, 18641.25434982601, 17628.647427051485, 17988.370407035756, 18465.538361540966, 18731.063446827673, 18851.52871178221, 5155.097857874875, 5260.447652996438, 5273.604479664022, 5283.709395983219, 5293.735313234342, 5206.947930520703, 5415.756290966916, 5585.972070139644, 5593.300837395325, 5598.888022239553, 5493.176023596453, 5521.503064724174, 5521.917171242435, 5810.651360918338, 5820.38885916979, 5699.544036477072, 5744.396838331999, 5752.597318187729, 5767.019606666877, 5768.394318596529, 5474.2609747683955, 5560.082586373243, 5570.610057295991, 5578.107502799533, 5626.971865140689, 13337.73324533504, 13658.248796316198, 13707.45170193191, 22061.669074963887, 22062.11751529953, 2347.225415612844, 2400.195934361991, 2404.386881345263, 2412.4078108448516, 2478.0, 10447.268691191619, 10471.947640261826, 10480.266381353309, 10518.474076296154, 10777.407242601654, 1940.2239104358227, 1977.6440240756658, 2021.9494512637154, 2036.134642776814, 2067.080149333547, 61718.69140654313, 64505.354946450876, 66500.0, 69918.0, 70310.64844675796, 10605.151587872951, 10875.184361172944, 10893.727656808644, 11023.338599684044, 11055.557777688964, 14206.218657973704, 14231.359588818528, 14233.28833558318, 14359.425622975174, 14364.784528232085, 8584.527850968258, 8590.656373745105, 8595.44129631572, 8613.78465538354, 8638.0, 8140.3950735765175, 8391.538465384463, 8589.098144694843, 8615.61229744663, 8712.085231050774, 4388.539203383662, 4503.166914120898, 4589.632829373642, 4675.509071547439, 4762.238041913347, 1916.0036780873868, 1980.7127966444784, 1980.9504762381055, 1988.2544045982756, 1990.2337600024096, 919.4758987377131, 989.1098011789447, 1006.8288390973552, 1076.5908954597203, 1085.3270971997254, 17511.64976700459, 17876.374326898494, 17956.371526996492, 18177.636447271245, 18194.272229110687, 997.5860018092555, 1011.0294117647142, 1016.5527168046036, 1030.9742256443499, 1079.7462596289865, 9386.0, 9625.807483850424, 9825.557849896772, 10008.299419040597, 10532.789344213073, 668631.0, 683051.0, 685909.0, 724943.0, 736187.0, 86575.99289771933, 86695.69956450658, 86846.56576717076, 87610.0, 90625.0, 1198.9580364687195, 1231.1935682128221, 1237.3813093453273, 1253.0, 1258.4211262819206, 16028.919855400649, 16334.836651633332, 16710.164491775606, 16739.91630041842, 16904.830951690325, 37970.81014594909, 38041.809790950865, 38228.04429889275, 38315.0, 38553.614463855, 44741.328880066176, 45956.31065533953, 46541.0, 46646.0, 47117.0, 9977.900220997697, 10583.894161058292, 10619.734506637396, 10637.255392122786, 10643.94678026605, 17476.82523174752, 17760.644787103927, 17835.73246401279, 18467.0, 18651.440456786317, 15038.323275452412, 15280.0, 15343.616409589404, 15479.5356139316, 16089.275982581046, 14539.0, 14739.705205896036, 15091.849081509483, 15092.471763488225, 15651.686966260839, 15139.54581362561, 15199.696006080037, 15500.147491888054, 15819.129947852978, 15853.841461585236, 9679.225661947168, 10072.597096116366, 10171.694849154537, 10186.847197292194, 10208.0, 10825.512851921525, 12102.878971210175, 14165.645858853612, 14358.641033974234, 14364.35360408805], "unit": "ms", "name": "jquery.html", "value": 9476.392311641506}, {"lowerIsBetter": false, "replicates": [1582.5173322136748, 1599.0645472398646, 1629.6985057764311, 1865.664180447519, 1944.0862794486586, 7316.195218525958, 7458.515196512237, 8255.793605159874, 8391.832163356728, 8399.664013439471, 7939.960300198505, 8031.116577176521, 8044.517328960266, 8074.9596252018655, 8115.391345649085, 2362.1614326913955, 2413.2760171948435, 2417.903283868652, 2425.16331865507, 2431.0032886516533, 2335.4628435459854, 2359.846609970355, 2367.9881600592057, 2370.383700237933, 2374.4063984004, 2318.107528601492, 2331.172433786007, 2339.742628310893, 2344.1678204237505, 2347.108098922407, 2309.203324852923, 2310.5147918936877, 2324.0703718512646, 2333.6266197408418, 2360.3980984848754, 2374.7150341959077, 2383.165891937808, 2411.0958390603523, 2421.6004359280696, 2421.6004359280696, 8160.3471722262075, 8212.46618969771, 8232.711855085043, 8243.340532757426, 8244.628991695388, 4723.0, 4803.7357945313, 4803.7357945313, 4807.567318941312, 4840.467548569654, 3100.906887850714, 3135.8432078396218, 3136.184592006072, 3160.7945483543494, 3162.6362968258486, 1013.2299452416144, 1029.7322696098993, 1033.5090831854884, 1045.1847558904067, 1050.5640159333868, 10930.945345273301, 11028.558857645685, 11052.834207486894, 11092.500837462334, 11113.110951123972, 4200.831966721297, 4226.57734226581, 4270.935935960963, 4272.957270427318, 4299.204647140289, 9572.808543829224, 9578.137967582812, 9581.856272155923, 9585.568649410794, 9586.472743999147, 4865.9756701216265, 4869.63477739171, 4871.0, 4876.975615121902, 4887.706737595756, 4234.6823988201, 4277.422547955986, 4306.461692288464, 4324.935125973113, 4433.46798384196, 3649.087728067983, 3707.258548290353, 3716.925661486755, 3729.1422972716427, 3734.066483379155, 1056.9048785609332, 1058.0213302694976, 1063.0538820449806, 1064.8509208710786, 1074.1997212077054, 1451.267110109388, 1452.6077958951023, 1460.773580095087, 1477.4828809916444, 1488.761798112297, 7991.760247192594, 7997.960010200029, 8010.959945200237, 8015.118336982927, 8026.27763501276, 504.389688476947, 505.80779303864296, 508.5016683650044, 510.3900838498034, 521.2181727408887, 6194.473469755031, 6197.5351848611535, 6242.063690446378, 6274.623522588659, 6285.842853928597, 9876.308658393844, 9877.456739879231, 9913.80172396548, 9958.751031224278, 10038.749031274276, 9723.0, 9740.512974351253, 9819.950900245452, 9833.557489912972, 9854.063863932915, 7796.0, 7826.295633392908, 7846.5292082475235, 7849.411294152961, 7893.565853878092, 7534.849303014019, 7548.811279717831, 7558.0, 7559.3196612305155, 7674.040744906887, 8667.393282470166, 8752.168543988311, 8844.380893337404, 8912.643494260157, 8988.0, 8894.644214231359, 8936.821263574822, 9166.633334666538, 9177.265818734351, 9237.676681316121, 6116.724747386289, 6238.4073513018, 6803.93196068033, 6956.686949087202, 7021.648917554204, 7570.05374328209, 7779.260970207822, 7780.961095194488, 7828.84342313162, 7839.960800195962, 7492.063492063492, 7604.087509498895, 7621.1997740236475, 7707.15221325665, 7718.0, 7159.64201789898, 7401.666924988496, 7444.962775186089, 7531.623418828927, 7600.619969001638, 7341.15576708664, 7415.406767458699, 7434.516756410816, 7437.590932498764, 7437.739679111205, 6753.290904455158, 6793.0, 6807.863842723217, 6817.454603631599, 6936.098307220029, 6961.582305061713, 7007.859842803014, 7009.12385951756, 7010.334018268256, 7010.75462358815], "unit": "ms", "name": "mootools.html", "value": 4596.423652801177}, {"lowerIsBetter": false, "replicates": [363.9872604458844, 367.2764653632344, 373.43611147167803, 376.44098513707155, 380.5015429786979, 6195.070739389094, 6274.498040156788, 6318.684065796709, 6356.396142366473, 6357.2371315442215, 6086.878262434749, 6244.438000579947, 6259.342769009257, 6280.4661603763625, 6302.212223472066, 4902.828401005965, 4904.877378065541, 4906.239532872411, 4909.729964851932, 4915.8525244242555, 4906.31311616374, 4906.650671065468, 4916.58209052231, 4922.926156107661, 4928.211486162215, 4803.591694705937, 4867.367242258501, 4876.609871210295, 4878.682885612441, 4886.926696099544, 4857.9757101214445, 4863.9513604864205, 4873.707577545341, 4883.609311255091, 4889.657723959324, 4315.136972605492, 4318.071614602844, 4320.567943205654, 4327.32926396409, 4335.1979883721615, 5869.178315035856, 5920.437558431985, 5961.970190149065, 5965.433283838029, 5967.61210521319, 5621.269234999424, 5726.198332233491, 5728.513076388512, 5735.627184233012, 5749.281339832521, 6634.568753031038, 6653.234877989044, 6656.933430665728, 6661.3005634408655, 6663.800085997428, 4794.616430685572, 4802.4237091548885, 4811.037792441491, 4812.085703716282, 4818.71087734737, 6837.897431538531, 6880.311968803129, 6963.6866341014775, 6965.129358830146, 6973.267806880255, 4932.136876046678, 4940.654154209171, 4942.332785074041, 4945.9258111128365, 4962.6774259673, 4995.075910956412, 5009.924851127236, 5013.89972200554, 5017.297578339036, 5029.245613157982, 5600.383957764642, 5700.458456446631, 5701.743421546041, 5712.228849105318, 5716.828495145152, 6704.765333213411, 6713.966430167916, 6746.932530674729, 6747.730090796314, 6765.560238584476, 1686.1316422042657, 1721.6212433264661, 1723.9827601724073, 1723.9913800430918, 1744.834240747127, 1139.6011396011495, 1156.9305841649527, 1182.261086820737, 1183.5029287699188, 1192.48723049088, 6367.172267605274, 6371.108044873721, 6374.235091789015, 6375.6174629522375, 6404.935950640434, 6851.417629501449, 6895.241523432418, 6896.551724137915, 6900.03399524067, 6910.827229319308, 6369.394907483875, 6415.615063096229, 6431.292557818636, 6445.774397896145, 6464.25661048976, 3707.5180226570915, 3743.5882052974152, 3745.8127093645753, 3750.2312026034597, 3750.849966001384, 7026.648667566601, 7042.154941407064, 7045.612491313027, 7055.2944705529035, 7090.468214883801, 6824.931750682529, 7027.262137475594, 7029.121359830021, 7029.191642961023, 7033.824154396181, 7034.2262351141335, 7055.6824942876665, 7080.256573059857, 7102.254263302382, 7105.253948335454, 6827.897581536182, 6847.726090956306, 6881.243063263138, 6890.20762612306, 6910.689018994057, 6681.76613818514, 6720.529562930744, 6773.424258938046, 6801.897971530332, 6804.863902721819, 6974.337437943387, 7046.506744527834, 7059.117610298713, 7067.71729130829, 7074.151101867808, 4766.571008609242, 4767.880802979953, 4801.759912004456, 4806.351142595705, 4811.615070794258, 6817.693203805939, 6826.464045589702, 6848.0, 6886.0, 6901.965490172718, 6615.6030638161865, 6617.900731489128, 6659.53383263167, 6660.167479065117, 6663.833404164935, 6631.436327912182, 6673.5328527004585, 6677.699503522256, 6684.532082754355, 6692.464602831859, 6454.451371633464, 6487.18910136233, 6518.706658200297, 6567.211934567691, 6572.737090516517, 6686.933130668631, 6691.866162676816, 6696.397324240842, 6715.764948226789, 6730.966345168243, 6544.738210471528, 6551.148350714377, 6557.0, 6558.278589355072, 6568.244651864906], "unit": "ms", "name": "prototype.html", "value": 5082.189784816566}, {"lowerIsBetter": false, "replicates": [941.2658126661204, 949.5088232659523, 951.9952400237997, 956.6795123633582, 965.5317171171985, 14175.503857364994, 14348.0, 14386.280685965712, 14400.279986000698, 14400.49598264061, 11836.28982261065, 11876.940615296911, 11927.880721192785, 11932.0, 12005.939970300136, 898.4833720610642, 906.1527471813843, 923.995380023099, 924.3021518753332, 925.6528801699362, 893.2675206330812, 909.522500687138, 911.5624500239888, 911.7538264668535, 912.0195789526252, 959.4579062829514, 967.042627798478, 968.9612415503371, 971.8153550825356, 976.3751199232497, 950.2018304624114, 957.8180145772316, 962.1004360922525, 962.2830990911746, 962.6486332488661, 715.613568672916, 721.3471808013755, 721.9422446204344, 723.1755798389839, 725.0936329588015, 12955.48178072876, 12974.935125324408, 13024.934875325658, 13072.803907941388, 13078.346082695922, 12810.0, 12915.806262906064, 13305.0, 13453.461861525528, 13537.864621353858, 11322.773544529146, 11345.0, 11423.94288028563, 11614.128940329425, 11631.302121872715, 3866.941995870064, 3868.12967082407, 3868.8065596720335, 3899.941500877489, 3905.258000979805, 51387.22919156215, 52049.0, 52359.21461178085, 52398.99999999962, 52462.475375246526, 8842.646294148291, 8870.955645221733, 8956.955215223883, 9039.954800226089, 9062.501562413998, 18894.149763260688, 18919.0, 18940.147693353832, 18966.0, 19028.80971190298, 7183.89224161638, 7264.527805692613, 7332.058509449404, 7707.190744971697, 7811.882821757678, 4266.722663026955, 4298.76356800379, 4348.0, 4391.297392417262, 4426.44669416323, 3248.0580631616567, 3258.6741325867224, 3260.7065364117343, 3266.6406695263504, 3275.1157187559224, 563.4365634365635, 582.3070546050271, 584.3426145586216, 589.7699897040158, 593.4925638579039, 547.9479399552868, 737.6311844077961, 738.8854727517244, 757.9090509138829, 769.6190385759085, 9010.59452324647, 9358.766030849147, 9399.750413905287, 9466.810663786686, 9499.857502137473, 684.2678334182377, 697.4524997876642, 772.7102336623766, 774.9418793590503, 804.8511025460308, 4211.831526738957, 4241.830326786956, 4301.376300436482, 4332.805023773938, 4337.457817772778, 59383.0, 60102.398976010554, 60851.695741521005, 64509.35490645033, 64681.0, 57190.42809571851, 58649.0, 58772.706136469045, 59625.701871491234, 60998.39001609927, 54481.0, 55335.446645533026, 55476.16785748217, 55833.0, 55852.16221756677, 9256.213221875947, 9502.524873756423, 9780.168685661514, 9911.157551608194, 10026.548805303924, 36250.8187459061, 36585.0, 37236.81381593183, 37375.0, 37598.43602345912, 45541.54458455506, 46759.29861052019, 46859.297110542684, 46942.0, 47105.0, 11272.267302625303, 11398.430078495876, 11723.472443740222, 12868.871311286768, 13548.119372240773, 11991.940040299743, 11993.280403175837, 12093.334866582423, 12949.676258093623, 13212.141210821266, 13127.277999710108, 13168.73662526725, 13258.933705331412, 13330.600081997556, 13500.5274815381, 11159.091584378913, 11677.357745324089, 11812.82280765772, 12590.559330423392, 13760.243186624431, 13064.934675326562, 13071.934640326737, 13226.933865330997, 13238.139520931109, 13436.261005644783, 10670.57317707283, 10762.515686793957, 10876.673699788702, 11258.7748245033, 11379.772404551697, 10289.3311934724, 10463.94768026155, 10473.842892356774, 10510.632127875488, 10539.367637941748], "unit": "ms", "name": "yui.html", "value": 6817.244486283188}], "name": "dromaeo_css", "value": 7418.695655882415}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 111.0, 111.0, 110.0, 121.0, 110.0, 112.0, 111.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [151.0, 121.0, 143.0, 157.0, 124.0, 145.0, 156.0, 124.0, 166.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.7}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 161.0, 162.0, 160.0, 162.0, 161.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [78.0, 71.0, 71.0, 157.0, 73.0, 71.0, 71.0, 73.0, 152.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 88.8}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 134.0, 92.0, 94.0, 92.0, 139.0, 92.0, 92.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [60.0, 63.0, 61.0, 62.0, 61.0, 61.0, 63.0, 62.0, 58.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 61.1}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 64.0, 65.0, 64.0, 63.0, 64.0, 63.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.7}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 90.0, 83.0, 83.0, 81.0, 81.0, 82.0, 82.0, 80.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [123.0, 115.0, 117.0, 113.0, 113.0, 122.0, 113.0, 121.0, 113.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.2}, {"lowerIsBetter": true, "replicates": [146.0, 153.0, 144.0, 149.0, 148.0, 136.0, 155.0, 148.0, 150.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 72.0, 67.0, 66.0, 69.0, 67.0, 78.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1502.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.78249336870027], "unit": "score", "name": "Richards", "value": 212.94166399999992}, {"lowerIsBetter": false, "replicates": [167.50418760469012], "unit": "score", "name": "DeltaBlue", "value": 394.72445999999985}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [915.7509157509157], "unit": "score", "name": "RayTrace", "value": 808.0679880000002}, {"lowerIsBetter": false, "replicates": [544.9591280653951], "unit": "score", "name": "Earley", "value": 1222.959605}, {"lowerIsBetter": false, "replicates": [11032.967032967033], "unit": "score", "name": "Boyer", "value": 60.40650697211158}, {"lowerIsBetter": false, "replicates": [23809.52380952381], "unit": "score", "name": "RegExp", "value": 38.26136999999999}, {"lowerIsBetter": false, "replicates": [519.7505197505197], "unit": "score", "name": "Splay", "value": 156.78868399999996}, {"lowerIsBetter": false, "replicates": [4882.926829268293], "unit": "score", "name": "NavierStokes", "value": 303.91608391608383}], "name": "v8_7", "value": 23266.079673487606}]} 15:22:24 INFO - RETURN: dromaeo_css: 7418.69 15:22:24 INFO - RETURN: kraken: 1502.40 15:22:24 INFO - RETURN: v8_7: 23266.08 15:22:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23266.08"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1502.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7418.69"}}} 15:22:25 INFO - Return code: 0 15:22:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 15:22:25 INFO - # TBPL SUCCESS # 15:22:25 INFO - Running post-action listener: _resource_record_post_action 15:22:25 INFO - Running post-run listener: _resource_record_post_run 15:22:26 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 262144; Write bytes: 502190080; Read time: 16; Write time: 498924 15:22:26 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 237293568; Read time: 0; Write time: 347976 15:22:26 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 262144; Write bytes: 264896512; Read time: 16; Write time: 150948 15:22:26 INFO - Running post-run listener: _upload_blobber_files 15:22:26 INFO - Blob upload gear active. 15:22:26 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:22:26 INFO - Copying logs to upload dir... 15:22:26 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1260.901289 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-01-05 15:22:25.897380) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-05 15:22:25.900452) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1452034882.880837-616452706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010199 build_url: 'https://queue.taskcluster.net/v1/task/KTgr9APOS3molNj8FumTAA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-05 15:22:25.951814) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 15:22:25.952165) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1452034882.880837-616452706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 15:22:26.002059) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 15:22:26.002368) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 15:22:26.002660) ========= ========= Total master_lag: 0.23 =========