builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1451992121.0 results: success (0) buildid: 20160105004008 builduid: 9b9817cf62f74e039a2711621c9b5239 revision: 45faafefe2f8416b8d286d20c94ce9b2ddef03c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:41.002639) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:41.003121) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:41.003425) ========= 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=337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006410 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:41.035243) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:41.035592) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:41.502318) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:41.502670) ========= 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=337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020170 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:41.559248) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:41.559653) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:41.560082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:41.573407) ========= 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=337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 03:08:41-- 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% 46.6M=0s 2016-01-05 03:08:41 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094412 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:41.699084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:41.699449) ========= 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=337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.052742 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:41.772137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:41.775547) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 45faafefe2f8416b8d286d20c94ce9b2ddef03c3 --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 45faafefe2f8416b8d286d20c94ce9b2ddef03c3 --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=337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 03:08:42,040 truncating revision to first 12 chars 2016-01-05 03:08:42,040 Setting DEBUG logging. 2016-01-05 03:08:42,041 attempt 1/10 2016-01-05 03:08:42,041 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/45faafefe2f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 03:08:42,288 unpacking tar archive at: mozilla-aurora-45faafefe2f8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549433 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:42.336377) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:42.339655) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:42.349635) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:42.349990) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 03:08:42.350419) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-01-05 03:08:42.350754) ========= /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=337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:08:42 INFO - MultiFileLogger online at 20160105 03:08:42 in /builds/slave/test-pgo 03:08:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:08:42 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:08:42 INFO - {'append_to_log': False, 03:08:42 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:08:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:08:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:08:42 INFO - 'branch': 'Mozilla-Aurora', 03:08:42 INFO - 'buildbot_json_path': 'buildprops.json', 03:08:42 INFO - 'config_files': ('talos/linux_config.py',), 03:08:42 INFO - 'default_actions': ('clobber', 03:08:42 INFO - 'read-buildbot-config', 03:08:42 INFO - 'download-and-extract', 03:08:42 INFO - 'populate-webroot', 03:08:42 INFO - 'create-virtualenv', 03:08:42 INFO - 'install', 03:08:42 INFO - 'run-tests'), 03:08:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:08:42 INFO - 'download_minidump_stackwalk': True, 03:08:42 INFO - 'download_symbols': 'ondemand', 03:08:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:08:42 INFO - 'tooltool.py': '/tools/tooltool.py', 03:08:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:08:42 INFO - '/tools/misc-python/virtualenv.py')}, 03:08:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:08:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:08:42 INFO - 'installer_path': 'installer.exe', 03:08:42 INFO - 'log_level': 'info', 03:08:42 INFO - 'log_name': 'talos', 03:08:42 INFO - 'log_to_console': True, 03:08:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:08:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:08:42 INFO - 'opt_config_files': (), 03:08:42 INFO - 'pip_index': False, 03:08:42 INFO - 'sps_profile': False, 03:08:42 INFO - 'sps_profile_interval': 0, 03:08:42 INFO - 'suite': 'dromaeojs-e10s', 03:08:42 INFO - 'system_bits': '32', 03:08:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:08:42 INFO - 'title': 'talos-linux64-ix-060', 03:08:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:08:42 INFO - 'use_talos_json': True, 03:08:42 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:08:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:08:42 INFO - 'work_dir': 'build'} 03:08:42 INFO - ##### 03:08:42 INFO - ##### Running clobber step. 03:08:42 INFO - ##### 03:08:42 INFO - Running pre-action listener: _resource_record_pre_action 03:08:42 INFO - Running main action method: clobber 03:08:42 INFO - rmtree: /builds/slave/test-pgo/build 03:08:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:08:43 INFO - Running post-action listener: _resource_record_post_action 03:08:43 INFO - ##### 03:08:43 INFO - ##### Running read-buildbot-config step. 03:08:43 INFO - ##### 03:08:43 INFO - Running pre-action listener: _resource_record_pre_action 03:08:43 INFO - Running main action method: read_buildbot_config 03:08:43 INFO - Using buildbot properties: 03:08:43 INFO - { 03:08:43 INFO - "properties": { 03:08:43 INFO - "buildnumber": 32, 03:08:43 INFO - "product": "firefox", 03:08:43 INFO - "script_repo_revision": "production", 03:08:43 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:08:43 INFO - "repository": "", 03:08:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:08:43 INFO - "buildid": "20160105004008", 03:08:43 INFO - "slavename": "talos-linux64-ix-060", 03:08:43 INFO - "stage_platform": "linux64-pgo", 03:08:43 INFO - "basedir": "/builds/slave/test-pgo", 03:08:43 INFO - "nightly_build": "True", 03:08:43 INFO - "project": "", 03:08:43 INFO - "platform": "ubuntu64_hw", 03:08:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:08:43 INFO - "slavebuilddir": "test", 03:08:43 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:08:43 INFO - "branch": "mozilla-aurora", 03:08:43 INFO - "repo_path": "releases/mozilla-aurora", 03:08:43 INFO - "pgo_build": "True", 03:08:43 INFO - "builduid": "9b9817cf62f74e039a2711621c9b5239", 03:08:43 INFO - "revision": "45faafefe2f8416b8d286d20c94ce9b2ddef03c3" 03:08:43 INFO - }, 03:08:43 INFO - "sourcestamp": { 03:08:43 INFO - "repository": "", 03:08:43 INFO - "hasPatch": false, 03:08:43 INFO - "project": "", 03:08:43 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:08:43 INFO - "changes": [ 03:08:43 INFO - { 03:08:43 INFO - "category": null, 03:08:43 INFO - "files": [ 03:08:43 INFO - { 03:08:43 INFO - "url": null, 03:08:43 INFO - "name": "https://queue.taskcluster.net/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 03:08:43 INFO - } 03:08:43 INFO - ], 03:08:43 INFO - "repository": "", 03:08:43 INFO - "rev": "45faafefe2f8416b8d286d20c94ce9b2ddef03c3", 03:08:43 INFO - "who": "sendchange", 03:08:43 INFO - "when": 1451992096, 03:08:43 INFO - "number": 7417308, 03:08:43 INFO - "comments": "", 03:08:43 INFO - "project": "", 03:08:43 INFO - "at": "Tue 05 Jan 2016 03:08:16", 03:08:43 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:08:43 INFO - "revlink": "", 03:08:43 INFO - "properties": [ 03:08:43 INFO - [ 03:08:43 INFO - "buildid", 03:08:43 INFO - "20160105004008", 03:08:43 INFO - "Change" 03:08:43 INFO - ], 03:08:43 INFO - [ 03:08:43 INFO - "builduid", 03:08:43 INFO - "9b9817cf62f74e039a2711621c9b5239", 03:08:43 INFO - "Change" 03:08:43 INFO - ], 03:08:43 INFO - [ 03:08:43 INFO - "nightly_build", 03:08:43 INFO - "True", 03:08:43 INFO - "Change" 03:08:43 INFO - ], 03:08:43 INFO - [ 03:08:43 INFO - "pgo_build", 03:08:43 INFO - "True", 03:08:43 INFO - "Change" 03:08:43 INFO - ] 03:08:43 INFO - ], 03:08:43 INFO - "revision": "45faafefe2f8416b8d286d20c94ce9b2ddef03c3" 03:08:43 INFO - } 03:08:43 INFO - ], 03:08:43 INFO - "revision": "45faafefe2f8416b8d286d20c94ce9b2ddef03c3" 03:08:43 INFO - } 03:08:43 INFO - } 03:08:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 03:08:43 INFO - Running post-action listener: _resource_record_post_action 03:08:43 INFO - ##### 03:08:43 INFO - ##### Running download-and-extract step. 03:08:43 INFO - ##### 03:08:43 INFO - Running pre-action listener: _resource_record_pre_action 03:08:43 INFO - Running main action method: download_and_extract 03:08:43 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:43 INFO - https://queue.taskcluster.net/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/test_packages.json 03:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/test_packages.json 03:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:08:45 INFO - Downloaded 1302 bytes. 03:08:45 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:08:45 INFO - Using the following test package requirements: 03:08:45 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:08:45 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:45 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:08:45 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:45 INFO - u'jsshell-linux-x86_64.zip'], 03:08:45 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:45 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:08:45 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:08:45 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:45 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:08:45 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:45 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:08:45 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:45 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:08:45 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:08:45 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:45 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:08:45 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:45 INFO - https://queue.taskcluster.net/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:08:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/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 03:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/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 03:08:47 INFO - Downloaded 23024169 bytes. 03:08:47 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 03:08:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:47 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 03:08:49 INFO - Return code: 0 03:08:49 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 03:08: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')]} 03:08:49 INFO - https://queue.taskcluster.net/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:08:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/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 03:08:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/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 03:08:51 INFO - Downloaded 23024169 bytes. 03:08:51 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 03:08:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:51 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 03:08:52 INFO - Return code: 0 03:08: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')]} 03:08:52 INFO - https://queue.taskcluster.net/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:08:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:08:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:08:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/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 03:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/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 03:08:54 INFO - Downloaded 11132038 bytes. 03:08:54 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 03:08:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:08:54 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 03:08:54 INFO - Return code: 0 03:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:54 INFO - https://queue.taskcluster.net/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:08:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:08:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:08:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/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 03:08:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QGJXR7EcTbKHhe2WIEJijQ/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 03:08:56 INFO - Downloaded 58086427 bytes. 03:08:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:08:56 INFO - mkdir: /builds/slave/test-pgo/properties 03:08:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:08:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:08:56 INFO - Contents: 03:08:56 INFO - build_url:https://queue.taskcluster.net/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:08:56 INFO - Running post-action listener: _resource_record_post_action 03:08:56 INFO - Running post-action listener: set_extra_try_arguments 03:08:56 INFO - ##### 03:08:56 INFO - ##### Running populate-webroot step. 03:08:56 INFO - ##### 03:08:56 INFO - Running pre-action listener: _resource_record_pre_action 03:08:56 INFO - Running main action method: populate_webroot 03:08:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:08:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:08:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:08:56 INFO - '--tppagecycles', 03:08:56 INFO - '7'], 03:08:56 INFO - 'tests': ['tsvgm']}}, 03:08:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:08:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:08:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:08:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:08:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:08:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:08:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:08:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:56 INFO - 'talos_options': ['--e10s'], 03:08:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:08:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:56 INFO - 'tests': ['damp', 'tps']}, 03:08:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:56 INFO - 'talos_options': ['--e10s'], 03:08:56 INFO - 'tests': ['damp', 'tps']}, 03:08:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:08:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:08:56 INFO - 'other': {'tests': ['a11yr', 03:08:56 INFO - 'ts_paint', 03:08:56 INFO - 'tpaint', 03:08:56 INFO - 'sessionrestore', 03:08:56 INFO - 'sessionrestore_no_auto_restore']}, 03:08:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:08:56 INFO - 'tests': ['a11yr', 03:08:56 INFO - 'ts_paint', 03:08:56 INFO - 'tpaint', 03:08:56 INFO - 'sessionrestore', 03:08:56 INFO - 'sessionrestore_no_auto_restore']}, 03:08:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:08:56 INFO - 'tests': ['a11yr', 03:08:56 INFO - 'ts_paint', 03:08:56 INFO - 'tpaint', 03:08:56 INFO - 'sessionrestore', 03:08:56 INFO - 'sessionrestore_no_auto_restore']}, 03:08:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:08:56 INFO - 'tests': ['a11yr', 03:08:56 INFO - 'ts_paint', 03:08:56 INFO - 'tpaint', 03:08:56 INFO - 'sessionrestore', 03:08:56 INFO - 'sessionrestore_no_auto_restore']}, 03:08:56 INFO - 'other_l64': {'tests': ['a11yr', 03:08:56 INFO - 'ts_paint', 03:08:56 INFO - 'tpaint', 03:08:56 INFO - 'sessionrestore', 03:08:56 INFO - 'sessionrestore_no_auto_restore']}, 03:08:56 INFO - 'other_nol64': {'tests': ['a11yr', 03:08:56 INFO - 'ts_paint', 03:08:56 INFO - 'tpaint', 03:08:56 INFO - 'sessionrestore', 03:08:56 INFO - 'sessionrestore_no_auto_restore']}, 03:08:56 INFO - 'svgr': {'tests': ['tsvgx', 03:08:56 INFO - 'tsvgr_opacity', 03:08:56 INFO - 'tart', 03:08:56 INFO - 'tscrollx', 03:08:56 INFO - 'cart']}, 03:08:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:08:56 INFO - 'tests': ['tsvgx', 03:08:56 INFO - 'tsvgr_opacity', 03:08:56 INFO - 'tart', 03:08:56 INFO - 'tscrollx', 03:08:56 INFO - 'cart']}, 03:08:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:56 INFO - 'tests': ['tp5o']}, 03:08:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:56 INFO - 'talos_options': ['--e10s'], 03:08:56 INFO - 'tests': ['tp5o']}, 03:08:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:56 INFO - 'talos_options': ['--xperf_path', 03:08:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:08:56 INFO - 'tests': ['tp5n']}, 03:08:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:56 INFO - 'talos_options': ['--e10s', 03:08:56 INFO - '--xperf_path', 03:08:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:08:56 INFO - 'tests': ['tp5n']}}, 03:08:56 INFO - 'talos.zip': {'path': '', 03:08:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:08:56 INFO - Running post-action listener: _resource_record_post_action 03:08:56 INFO - ##### 03:08:56 INFO - ##### Running create-virtualenv step. 03:08:56 INFO - ##### 03:08:56 INFO - Running pre-action listener: _resource_record_pre_action 03:08:56 INFO - Running main action method: create_virtualenv 03:08:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:08:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 03:08:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:08:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:08:56 INFO - Using real prefix '/usr' 03:08:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:08:56 INFO - Installing distribute.............................................................................................................................................................................................done. 03:08:58 INFO - Installing pip.................done. 03:08:58 INFO - Return code: 0 03:08:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:08: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')]} 03:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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')]} 03:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc16086bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e57450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9a50>, '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 0x1e55550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e559e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:08: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 03:08: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 pip>=1.5 03:08:58 INFO - Using env: {'DISPLAY': ':0', 03:08:58 INFO - 'HOME': '/home/cltbld', 03:08:58 INFO - 'LANG': 'en_US.UTF-8', 03:08:58 INFO - 'LANGUAGE': 'en_US:en', 03:08:58 INFO - 'LOGNAME': 'cltbld', 03:08:58 INFO - 'MAIL': '/var/mail/cltbld', 03:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:58 INFO - 'MOZ_NO_REMOTE': '1', 03:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:58 INFO - 'NO_EM_RESTART': '1', 03:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:58 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:58 INFO - 'SHELL': '/bin/bash', 03:08:58 INFO - 'SHLVL': '1', 03:08:58 INFO - 'TERM': 'linux', 03:08:58 INFO - 'TMOUT': '86400', 03:08:58 INFO - 'USER': 'cltbld', 03:08:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173', 03:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:58 INFO - '_': '/tools/buildbot/bin/python'} 03:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:08:58 INFO - Cleaning up... 03:08:58 INFO - Return code: 0 03:08:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:08: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')]} 03:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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')]} 03:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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', '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 0x7fc16086bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e57450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9a50>, '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 0x1e55550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e559e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:08: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 03:08: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 psutil>=0.7.1 03:08:58 INFO - Using env: {'DISPLAY': ':0', 03:08:58 INFO - 'HOME': '/home/cltbld', 03:08:58 INFO - 'LANG': 'en_US.UTF-8', 03:08:58 INFO - 'LANGUAGE': 'en_US:en', 03:08:58 INFO - 'LOGNAME': 'cltbld', 03:08:58 INFO - 'MAIL': '/var/mail/cltbld', 03:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:58 INFO - 'MOZ_NO_REMOTE': '1', 03:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:58 INFO - 'NO_EM_RESTART': '1', 03:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:58 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:58 INFO - 'SHELL': '/bin/bash', 03:08:58 INFO - 'SHLVL': '1', 03:08:58 INFO - 'TERM': 'linux', 03:08:58 INFO - 'TMOUT': '86400', 03:08:58 INFO - 'USER': 'cltbld', 03:08:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173', 03:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:58 INFO - '_': '/tools/buildbot/bin/python'} 03:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:59 INFO - Downloading/unpacking psutil>=0.7.1 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:09:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:09:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:09:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:09:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:09:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:09:00 INFO - Installing collected packages: psutil 03:09:00 INFO - Running setup.py install for psutil 03:09:00 INFO - building 'psutil._psutil_linux' extension 03:09:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:09:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:09:01 INFO - building 'psutil._psutil_posix' extension 03:09:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:09:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:09:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:09:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:09:01 INFO - Successfully installed psutil 03:09:01 INFO - Cleaning up... 03:09:01 INFO - Return code: 0 03:09:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:01 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 0x7fc16086bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e57450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9a50>, '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 0x1e55550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e559e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:09:01 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 03:09:01 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 03:09:01 INFO - Using env: {'DISPLAY': ':0', 03:09:01 INFO - 'HOME': '/home/cltbld', 03:09:01 INFO - 'LANG': 'en_US.UTF-8', 03:09:01 INFO - 'LANGUAGE': 'en_US:en', 03:09:01 INFO - 'LOGNAME': 'cltbld', 03:09:01 INFO - 'MAIL': '/var/mail/cltbld', 03:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:01 INFO - 'MOZ_NO_REMOTE': '1', 03:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:01 INFO - 'NO_EM_RESTART': '1', 03:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:09:01 INFO - 'PWD': '/builds/slave/test-pgo', 03:09:01 INFO - 'SHELL': '/bin/bash', 03:09:01 INFO - 'SHLVL': '1', 03:09:01 INFO - 'TERM': 'linux', 03:09:01 INFO - 'TMOUT': '86400', 03:09:01 INFO - 'USER': 'cltbld', 03:09:01 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173', 03:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:01 INFO - '_': '/tools/buildbot/bin/python'} 03:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:09:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:09:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:09:03 INFO - Installing collected packages: mozsystemmonitor 03:09:03 INFO - Running setup.py install for mozsystemmonitor 03:09:03 INFO - Successfully installed mozsystemmonitor 03:09:03 INFO - Cleaning up... 03:09:03 INFO - Return code: 0 03:09:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:03 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 0x7fc16086bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e57450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9a50>, '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 0x1e55550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e559e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:09:03 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 03:09:03 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 03:09:03 INFO - Using env: {'DISPLAY': ':0', 03:09:03 INFO - 'HOME': '/home/cltbld', 03:09:03 INFO - 'LANG': 'en_US.UTF-8', 03:09:03 INFO - 'LANGUAGE': 'en_US:en', 03:09:03 INFO - 'LOGNAME': 'cltbld', 03:09:03 INFO - 'MAIL': '/var/mail/cltbld', 03:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:03 INFO - 'MOZ_NO_REMOTE': '1', 03:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:03 INFO - 'NO_EM_RESTART': '1', 03:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:09:03 INFO - 'PWD': '/builds/slave/test-pgo', 03:09:03 INFO - 'SHELL': '/bin/bash', 03:09:03 INFO - 'SHLVL': '1', 03:09:03 INFO - 'TERM': 'linux', 03:09:03 INFO - 'TMOUT': '86400', 03:09:03 INFO - 'USER': 'cltbld', 03:09:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173', 03:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:03 INFO - '_': '/tools/buildbot/bin/python'} 03:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:05 INFO - Downloading blobuploader-1.2.4.tar.gz 03:09:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:09:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:09:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:09:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:09:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:06 INFO - Downloading docopt-0.6.1.tar.gz 03:09:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:09:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:09:06 INFO - Installing collected packages: blobuploader, requests, docopt 03:09:06 INFO - Running setup.py install for blobuploader 03:09:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:09:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:09:06 INFO - Running setup.py install for requests 03:09:06 INFO - Running setup.py install for docopt 03:09:06 INFO - Successfully installed blobuploader requests docopt 03:09:06 INFO - Cleaning up... 03:09:06 INFO - Return code: 0 03:09:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:06 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 0x7fc16086bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e57450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9a50>, '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 0x1e55550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e559e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:09:06 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 03:09:06 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 03:09:06 INFO - Using env: {'DISPLAY': ':0', 03:09:06 INFO - 'HOME': '/home/cltbld', 03:09:06 INFO - 'LANG': 'en_US.UTF-8', 03:09:06 INFO - 'LANGUAGE': 'en_US:en', 03:09:06 INFO - 'LOGNAME': 'cltbld', 03:09:06 INFO - 'MAIL': '/var/mail/cltbld', 03:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:06 INFO - 'MOZ_NO_REMOTE': '1', 03:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:06 INFO - 'NO_EM_RESTART': '1', 03:09:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:09:06 INFO - 'PWD': '/builds/slave/test-pgo', 03:09:06 INFO - 'SHELL': '/bin/bash', 03:09:06 INFO - 'SHLVL': '1', 03:09:06 INFO - 'TERM': 'linux', 03:09:06 INFO - 'TMOUT': '86400', 03:09:06 INFO - 'USER': 'cltbld', 03:09:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173', 03:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:06 INFO - '_': '/tools/buildbot/bin/python'} 03:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:09:06 INFO - Running setup.py (path:/tmp/pip-FZQZnF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:09:07 INFO - Running setup.py (path:/tmp/pip-SljI0o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:09:07 INFO - Running setup.py (path:/tmp/pip-DnCp6P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:09:07 INFO - Running setup.py (path:/tmp/pip-pdVbhg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:09:07 INFO - Running setup.py (path:/tmp/pip-qq06le-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:09:07 INFO - Running setup.py (path:/tmp/pip-dezLxu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:09:07 INFO - Running setup.py (path:/tmp/pip-kyx1bb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:09:07 INFO - Running setup.py (path:/tmp/pip-8EfQvl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:09:07 INFO - Running setup.py (path:/tmp/pip-nm2ery-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:09:07 INFO - Running setup.py (path:/tmp/pip-fXIYy8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:09:07 INFO - Running setup.py (path:/tmp/pip-V5Ntl2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:09:07 INFO - Running setup.py (path:/tmp/pip-WEo2jS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:09:07 INFO - Running setup.py (path:/tmp/pip-UIHw0H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:09:07 INFO - Running setup.py (path:/tmp/pip-fENV5_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:09:07 INFO - Running setup.py (path:/tmp/pip-yRsemP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:09:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:09:08 INFO - Running setup.py (path:/tmp/pip-P3uW71-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:09:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:09:08 INFO - Running setup.py (path:/tmp/pip-QdH5R2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:09:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:09:08 INFO - Running setup.py install for manifestparser 03:09:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:09:08 INFO - Running setup.py install for mozcrash 03:09:08 INFO - Running setup.py install for mozdebug 03:09:08 INFO - Running setup.py install for mozdevice 03:09:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:09:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:09:08 INFO - Running setup.py install for mozfile 03:09:08 INFO - Running setup.py install for mozhttpd 03:09:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:09:08 INFO - Running setup.py install for mozinfo 03:09:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:09:08 INFO - Running setup.py install for mozInstall 03:09:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:09:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:09:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:09:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:09:08 INFO - Running setup.py install for mozleak 03:09:09 INFO - Running setup.py install for mozlog 03:09:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:09:09 INFO - Running setup.py install for moznetwork 03:09:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:09:09 INFO - Running setup.py install for mozprocess 03:09:09 INFO - Running setup.py install for mozprofile 03:09:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:09:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:09:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:09:09 INFO - Running setup.py install for mozrunner 03:09:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:09:09 INFO - Running setup.py install for mozscreenshot 03:09:09 INFO - Running setup.py install for moztest 03:09:09 INFO - Running setup.py install for mozversion 03:09:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:09:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:09:09 INFO - Cleaning up... 03:09:09 INFO - Return code: 0 03:09:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:09 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 0x7fc16086bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e57450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9a50>, '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 0x1e55550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e559e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:09:09 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 03:09:09 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 03:09:09 INFO - Using env: {'DISPLAY': ':0', 03:09:09 INFO - 'HOME': '/home/cltbld', 03:09:09 INFO - 'LANG': 'en_US.UTF-8', 03:09:09 INFO - 'LANGUAGE': 'en_US:en', 03:09:09 INFO - 'LOGNAME': 'cltbld', 03:09:09 INFO - 'MAIL': '/var/mail/cltbld', 03:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:09 INFO - 'MOZ_NO_REMOTE': '1', 03:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:09 INFO - 'NO_EM_RESTART': '1', 03:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:09:09 INFO - 'PWD': '/builds/slave/test-pgo', 03:09:09 INFO - 'SHELL': '/bin/bash', 03:09:09 INFO - 'SHLVL': '1', 03:09:09 INFO - 'TERM': 'linux', 03:09:09 INFO - 'TMOUT': '86400', 03:09:09 INFO - 'USER': 'cltbld', 03:09:09 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173', 03:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:09 INFO - '_': '/tools/buildbot/bin/python'} 03:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:09:10 INFO - Running setup.py (path:/tmp/pip-mxJ6OZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 03:09:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:09:10 INFO - Running setup.py (path:/tmp/pip-oplMyG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:09:10 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)) 03:09:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:09:10 INFO - Running setup.py (path:/tmp/pip-f8OADD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:09:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:09:10 INFO - Running setup.py (path:/tmp/pip-w6KG6b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:09:10 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)) 03:09:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:09:10 INFO - Running setup.py (path:/tmp/pip-dyaO35-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 03:09:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:09:10 INFO - Running setup.py (path:/tmp/pip-7dQPjG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 03:09:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:09:10 INFO - Running setup.py (path:/tmp/pip-oCTNxO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 03:09:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:09:10 INFO - Running setup.py (path:/tmp/pip-2LvRCj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 03:09:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:09:10 INFO - Running setup.py (path:/tmp/pip-GKhDNs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 03:09:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:09:10 INFO - Running setup.py (path:/tmp/pip-pWRUPs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:09:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:09:10 INFO - Running setup.py (path:/tmp/pip-KLwoTK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 03:09:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:09:10 INFO - Running setup.py (path:/tmp/pip-URTmMU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 03:09:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:09:11 INFO - Running setup.py (path:/tmp/pip-B3rnA7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:09:11 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)) 03:09:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:09:11 INFO - Running setup.py (path:/tmp/pip-WG0SKa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 03:09:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:09:11 INFO - Running setup.py (path:/tmp/pip-M6L4vQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 03:09:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:09:11 INFO - Running setup.py (path:/tmp/pip-_Hcv1e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 03:09:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:09:11 INFO - Running setup.py (path:/tmp/pip-xe2vkG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 03:09:11 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)) 03:09:11 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)) 03:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:09:11 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)) 03:09:11 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)) 03:09:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:13 INFO - Downloading blessings-1.5.1.tar.gz 03:09:13 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 03:09:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:09:13 INFO - Installing collected packages: blessings 03:09:13 INFO - Running setup.py install for blessings 03:09:13 INFO - Successfully installed blessings 03:09:13 INFO - Cleaning up... 03:09:13 INFO - Return code: 0 03:09:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:09:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:09:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:09:13 INFO - Reading from file tmpfile_stdout 03:09:13 INFO - Current package versions: 03:09:13 INFO - argparse == 1.2.1 03:09:13 INFO - blessings == 1.5.1 03:09:13 INFO - blobuploader == 1.2.4 03:09:13 INFO - docopt == 0.6.1 03:09:13 INFO - manifestparser == 1.1 03:09:13 INFO - mozInstall == 1.12 03:09:13 INFO - mozcrash == 0.16 03:09:13 INFO - mozdebug == 0.1 03:09:13 INFO - mozdevice == 0.47 03:09:13 INFO - mozfile == 1.2 03:09:13 INFO - mozhttpd == 0.7 03:09:13 INFO - mozinfo == 0.9 03:09:13 INFO - mozleak == 0.1 03:09:13 INFO - mozlog == 3.1 03:09:13 INFO - moznetwork == 0.27 03:09:13 INFO - mozprocess == 0.22 03:09:13 INFO - mozprofile == 0.27 03:09:13 INFO - mozrunner == 6.11 03:09:13 INFO - mozscreenshot == 0.1 03:09:13 INFO - mozsystemmonitor == 0.0 03:09:13 INFO - moztest == 0.7 03:09:13 INFO - mozversion == 1.4 03:09:13 INFO - psutil == 3.1.1 03:09:13 INFO - requests == 1.2.3 03:09:13 INFO - wsgiref == 0.1.2 03:09:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:13 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 0x7fc16086bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e57450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9a50>, '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 0x1e55550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e559e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:09:13 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 03:09:13 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 03:09:13 INFO - Using env: {'DISPLAY': ':0', 03:09:13 INFO - 'HOME': '/home/cltbld', 03:09:13 INFO - 'LANG': 'en_US.UTF-8', 03:09:13 INFO - 'LANGUAGE': 'en_US:en', 03:09:13 INFO - 'LOGNAME': 'cltbld', 03:09:13 INFO - 'MAIL': '/var/mail/cltbld', 03:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:13 INFO - 'MOZ_NO_REMOTE': '1', 03:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:13 INFO - 'NO_EM_RESTART': '1', 03:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:09:13 INFO - 'PWD': '/builds/slave/test-pgo', 03:09:13 INFO - 'SHELL': '/bin/bash', 03:09:13 INFO - 'SHLVL': '1', 03:09:13 INFO - 'TERM': 'linux', 03:09:13 INFO - 'TMOUT': '86400', 03:09:13 INFO - 'USER': 'cltbld', 03:09:13 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173', 03:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:13 INFO - '_': '/tools/buildbot/bin/python'} 03:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:13 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)) 03:09:13 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)) 03:09:13 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)) 03:09:13 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)) 03:09:13 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)) 03:09:13 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)) 03:09:13 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)) 03:09:13 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)) 03:09:13 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)) 03:09:13 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)) 03:09:13 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)) 03:09:13 INFO - Cleaning up... 03:09:13 INFO - Return code: 0 03:09:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:13 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 0x7fc16086bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e57450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9a50>, '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 0x1e55550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e559e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:09:13 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 03:09:13 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 03:09:13 INFO - Using env: {'DISPLAY': ':0', 03:09:13 INFO - 'HOME': '/home/cltbld', 03:09:13 INFO - 'LANG': 'en_US.UTF-8', 03:09:13 INFO - 'LANGUAGE': 'en_US:en', 03:09:13 INFO - 'LOGNAME': 'cltbld', 03:09:13 INFO - 'MAIL': '/var/mail/cltbld', 03:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:13 INFO - 'MOZ_NO_REMOTE': '1', 03:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:13 INFO - 'NO_EM_RESTART': '1', 03:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:09:13 INFO - 'PWD': '/builds/slave/test-pgo', 03:09:13 INFO - 'SHELL': '/bin/bash', 03:09:13 INFO - 'SHLVL': '1', 03:09:13 INFO - 'TERM': 'linux', 03:09:13 INFO - 'TMOUT': '86400', 03:09:13 INFO - 'USER': 'cltbld', 03:09:13 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173', 03:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:13 INFO - '_': '/tools/buildbot/bin/python'} 03:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:14 INFO - Downloading/unpacking jsonschema 03:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:09:15 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 03:09:15 INFO - Downloading/unpacking functools32 (from jsonschema) 03:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:15 INFO - Downloading functools32-3.2.3-2.tar.gz 03:09:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:09:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:09:15 INFO - warning: no files found matching '*.txt' 03:09:15 INFO - no previously-included directories found matching 'build' 03:09:15 INFO - no previously-included directories found matching 'dist' 03:09:15 INFO - no previously-included directories found matching '.git*' 03:09:15 INFO - Installing collected packages: jsonschema, functools32 03:09:16 INFO - Running setup.py install for functools32 03:09:16 INFO - warning: no files found matching '*.txt' 03:09:16 INFO - no previously-included directories found matching 'build' 03:09:16 INFO - no previously-included directories found matching 'dist' 03:09:16 INFO - no previously-included directories found matching '.git*' 03:09:16 INFO - Successfully installed jsonschema functools32 03:09:16 INFO - Cleaning up... 03:09:16 INFO - Return code: 0 03:09:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:16 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 0x7fc16086bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e57450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9a50>, '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 0x1e55550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e559e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:09:16 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 03:09:16 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 03:09:16 INFO - Using env: {'DISPLAY': ':0', 03:09:16 INFO - 'HOME': '/home/cltbld', 03:09:16 INFO - 'LANG': 'en_US.UTF-8', 03:09:16 INFO - 'LANGUAGE': 'en_US:en', 03:09:16 INFO - 'LOGNAME': 'cltbld', 03:09:16 INFO - 'MAIL': '/var/mail/cltbld', 03:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:16 INFO - 'MOZ_NO_REMOTE': '1', 03:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:16 INFO - 'NO_EM_RESTART': '1', 03:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:09:16 INFO - 'PWD': '/builds/slave/test-pgo', 03:09:16 INFO - 'SHELL': '/bin/bash', 03:09:16 INFO - 'SHLVL': '1', 03:09:16 INFO - 'TERM': 'linux', 03:09:16 INFO - 'TMOUT': '86400', 03:09:16 INFO - 'USER': 'cltbld', 03:09:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173', 03:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:16 INFO - '_': '/tools/buildbot/bin/python'} 03:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:16 INFO - Downloading/unpacking flake8 03:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:09:18 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 03:09:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:09:18 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 03:09:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:18 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 03:09:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:09:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:09:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:09:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:09:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:09:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:09:18 INFO - no previously-included directories found matching 'docs/_build' 03:09:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:09:18 INFO - Running setup.py install for pep8 03:09:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:09:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:09:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:09:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:09:18 INFO - no previously-included directories found matching 'docs/_build' 03:09:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:09:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:09:18 INFO - Cleaning up... 03:09:18 INFO - Return code: 0 03:09:18 INFO - Running post-action listener: _resource_record_post_action 03:09:18 INFO - Running post-action listener: _start_resource_monitoring 03:09:18 INFO - Starting resource monitoring. 03:09:19 INFO - ##### 03:09:19 INFO - ##### Running install step. 03:09:19 INFO - ##### 03:09:19 INFO - Running pre-action listener: _resource_record_pre_action 03:09:19 INFO - Running main action method: install 03:09:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:09:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:09:19 INFO - Reading from file tmpfile_stdout 03:09:19 INFO - Detecting whether we're running mozinstall >=1.0... 03:09:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:09:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:09:19 INFO - Reading from file tmpfile_stdout 03:09:19 INFO - Output received: 03:09:19 INFO - Usage: mozinstall [options] installer 03:09:19 INFO - Options: 03:09:19 INFO - -h, --help show this help message and exit 03:09:19 INFO - -d DEST, --destination=DEST 03:09:19 INFO - Directory to install application into. [default: 03:09:19 INFO - "/builds/slave/test-pgo"] 03:09:19 INFO - --app=APP Application being installed. [default: firefox] 03:09:19 INFO - mkdir: /builds/slave/test-pgo/build/application 03:09:19 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'] 03:09:19 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 03:09:34 INFO - Reading from file tmpfile_stdout 03:09:34 INFO - Output received: 03:09:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:09:34 INFO - Running post-action listener: _resource_record_post_action 03:09:34 INFO - ##### 03:09:34 INFO - ##### Running run-tests step. 03:09:34 INFO - ##### 03:09:34 INFO - Running pre-action listener: _resource_record_pre_action 03:09:34 INFO - Running main action method: run_tests 03:09:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:09:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:09:34 INFO - Python 2.7.3 03:09:34 INFO - Return code: 0 03:09:34 INFO - grabbing minidump binary from tooltool 03:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9a50>, '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 0x1e55550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e559e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:09:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 03:09:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:09:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:09:34 INFO - Return code: 0 03:09:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:09:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:09:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:09:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:09:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:09:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:09:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:09:35 INFO - Return code: 0 03:09:35 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/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:09:35 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/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost 03:09:35 INFO - Using env: {'DISPLAY': ':0', 03:09:35 INFO - 'HOME': '/home/cltbld', 03:09:35 INFO - 'LANG': 'en_US.UTF-8', 03:09:35 INFO - 'LANGUAGE': 'en_US:en', 03:09:35 INFO - 'LOGNAME': 'cltbld', 03:09:35 INFO - 'MAIL': '/var/mail/cltbld', 03:09:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:09:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:35 INFO - 'MOZ_NO_REMOTE': '1', 03:09:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:35 INFO - 'NO_EM_RESTART': '1', 03:09:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:09:35 INFO - 'PWD': '/builds/slave/test-pgo', 03:09:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:09:35 INFO - 'SHELL': '/bin/bash', 03:09:35 INFO - 'SHLVL': '1', 03:09:35 INFO - 'TERM': 'linux', 03:09:35 INFO - 'TMOUT': '86400', 03:09:35 INFO - 'USER': 'cltbld', 03:09:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173', 03:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:35 INFO - '_': '/tools/buildbot/bin/python'} 03:09:35 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/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] with output_timeout 3600 03:09:35 INFO - mozversion INFO | application_buildid: 20160105004008 03:09:35 INFO - mozversion INFO | application_changeset: 45faafefe2f8416b8d286d20c94ce9b2ddef03c3 03:09:35 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:09:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:09:35 INFO - mozversion INFO | application_name: Firefox 03:09:35 INFO - mozversion INFO | application_remotingname: firefox-dev 03:09:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:09:35 INFO - mozversion INFO | application_vendor: Mozilla 03:09:35 INFO - mozversion INFO | application_version: 45.0a2 03:09:35 INFO - mozversion INFO | platform_buildid: 20160105004008 03:09:35 INFO - mozversion INFO | platform_changeset: 45faafefe2f8416b8d286d20c94ce9b2ddef03c3 03:09:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:09:35 INFO - mozversion INFO | platform_version: 45.0a2 03:09:35 INFO - 2016-01-05 03:09:35,520 DEBUG : using testdate: 1451992175 03:09:35 INFO - 2016-01-05 03:09:35,520 DEBUG : actual date: 1451992175 03:09:35 INFO - 2016-01-05 03:09:35,529 INFO : starting webserver on 'localhost:47976' 03:09:35 INFO - 2016-01-05 03:09:35,530 INFO : Starting test suite talos-linux64-ix-060.e 03:09:35 INFO - 2016-01-05 03:09:35,530 INFO : Starting test dromaeo_css 03:09:35 INFO - 2016-01-05 03:09:35,530 DEBUG : operating with platform_type : linux_ 03:09:35 INFO - 2016-01-05 03:09:35,531 INFO : Initialising browser for dromaeo_css test... 03:09:35 INFO - 2016-01-05 03:09:35,547 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3bLcCm/profile http://localhost:47976/getInfo.html 03:09:40 INFO - 2016-01-05 03:09:40,035 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:09:40 INFO - 2016-01-05 03:09:40,035 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:09:40 INFO - 2016-01-05 03:09:40,035 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/670 03:09:40 INFO - 2016-01-05 03:09:40,035 DEBUG : BROWSER_OUTPUT: __metrics 03:09:40 INFO - 2016-01-05 03:09:40,924 INFO : Browser initialized. 03:09:40 INFO - 2016-01-05 03:09:40,925 INFO : Running cycle 1/1 for dromaeo_css test... 03:09:40 INFO - 2016-01-05 03:09:40,925 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3bLcCm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:09:52 INFO - 2016-01-05 03:09:52,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 136687616 03:09:52 INFO - 2016-01-05 03:09:52,683 DEBUG : BROWSER_OUTPUT: 03:10:42 INFO - 2016-01-05 03:10:42,290 DEBUG : BROWSER_OUTPUT: 1451992242289 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:12:50 INFO - 2016-01-05 03:12:50,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47976/tests/dromaeo/cssquery-ext.html) 03:12:51 INFO - 2016-01-05 03:12:51,353 DEBUG : BROWSER_OUTPUT: RSS: Main: 141545472 03:12:51 INFO - 2016-01-05 03:12:51,353 DEBUG : BROWSER_OUTPUT: 03:15:53 INFO - 2016-01-05 03:15:53,141 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/dromaeo/cssquery-ext.html (next: http://localhost:47976/tests/dromaeo/cssquery-jquery.html) 03:15:53 INFO - 2016-01-05 03:15:53,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 139010048 03:15:53 INFO - 2016-01-05 03:15:53,727 DEBUG : BROWSER_OUTPUT: 03:18:55 INFO - 2016-01-05 03:18:55,278 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47976/tests/dromaeo/cssquery-mootools.html) 03:18:55 INFO - 2016-01-05 03:18:55,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 138555392 03:18:55 INFO - 2016-01-05 03:18:55,865 DEBUG : BROWSER_OUTPUT: 03:21:57 INFO - 2016-01-05 03:21:57,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47976/tests/dromaeo/cssquery-prototype.html) 03:21:58 INFO - 2016-01-05 03:21:58,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 138797056 03:21:58 INFO - 2016-01-05 03:21:58,036 DEBUG : BROWSER_OUTPUT: 03:25:00 INFO - 2016-01-05 03:25:00,339 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47976/tests/dromaeo/cssquery-yui.html) 03:25:00 INFO - 2016-01-05 03:25:00,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 139599872 03:25:00 INFO - 2016-01-05 03:25:00,925 DEBUG : BROWSER_OUTPUT: 03:28:02 INFO - 2016-01-05 03:28:02,999 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/dromaeo/cssquery-yui.html (next: http://localhost:47976/tests/dromaeo/cssquery-dojo.html) 03:28:03 INFO - 2016-01-05 03:28:03,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 142237696 03:28:03 INFO - 2016-01-05 03:28:03,250 DEBUG : BROWSER_OUTPUT: 03:28:03 INFO - 2016-01-05 03:28:03,251 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:28:03 INFO - 2016-01-05 03:28:03,251 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:28:03 INFO - 2016-01-05 03:28:03,251 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:28:03 INFO - 2016-01-05 03:28:03,251 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:28:03 INFO - 2016-01-05 03:28:03,252 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3332.5167850661646;3410.8976730698073;3418.72650187985;3448.8620455181804;3449.068751437112;5629.971850140754;5643.8589035274135;5665.3484849242295;5666.348369937458;5676.262085928829;5623.240862483563;5706.857328566788;5707.400722924095;5713.200151978716;5730.169125476814;5193.454687257849;5223.921641175385;5252.159654455288;5269.8946021079555;5321.920171197435;5027.899442011158;5124.0776660201145;5149.588032957355;5156.793728250885;5234.450382709818;5175.327207463025;5227.032998895197;5252.658577192489;5257.921131183035;5262.236975638531;5233.345831771009;5267.051930652481;5278.894422111574;5281.313429254211;5321.680699158024;4938.851834444937;4982.77577509013;4986.152354099775;5167.379914410295;5178.508041736029;5386.542143917772;5430.8913821723345;5437.13005919055;5484.506394424521;5503.064479038533;6049.485793707496;6071.908921366183;6093.360197179277;6110.3889611038985;6112.969435152841;5950.404959504058;6112.777056696867;6127.4791642710425;6140.478059364959;6156.353582873823;5653.406392328788;5736.942630573724;5748.45389687979;5756.33802112754;5787.189793428924;6169.81490555284;6181.629102253789;6197.845053873689;6197.938020619736;6232.750689972441;5799.6230245034785;5873.911891321633;5974.970125149433;6026.758929642853;6036.63780173191;6027.698615069229;6052.182955300978;6060.33336333003;6068.059450785136;6086.786962456293;6027.095935609606;6033.849153771191;6042.4561789438285;6046.758129674852;6055.455009049207;5810.1575271586225;5836.591438599257;5931.288245410492;6007.429294217042;6096.329403765582;4642.442906851199;4646.62826973848;4658.860234192912;4666.463356714022;4685.4143232095985;4146.875593732193;4155.4182414462;4159.812808423628;4162.583741625813;4167.166566686675;5546.805861794818;5640.125780504029;5649.604527683105;5669.376368599451;5751.741171647286;6026.668533230714;6141.969290153521;6175.258968923668;6192.81421557354;6207.16203312547;5631.915521267184;5723.542116630742;5788.652680839079;5846.801405711819;5858.443447872445;5159.1229490986625;5181.4300426953005;5212.270282160501;5232.869178270497;5240.0567897778765;6233.158523599347;6261;6261.499080073674;6272.2473303203;6279.7802076928;5859.20900678403;5887.146363777314;6096.908546371897;6107.54193435503;6128.203333566607;6120.538559592075;6193.628382297076;6204.937950620436;6245.344238854855;6253.437190652681;6015.819525414245;6035.124906888389;6063.211782468251;6079.817605471843;6134.294556125924;5799.333076696234;5903.881922361443;6124.448799608057;6165.167702360124;6185.876282474415;5914.497267732118;5930.28836539618;5941.613795103304;5966.612170208922;5983.820485385445;5877.35349111606;5912.911306330495;5926.525877929842;5929;5937.228160339128;5528.557715382679;5634.577406694432;5709.22925405065;5819.098039803837;5832.12518122285;5925.4370834770625;5956.195913551615;5968.4926781224085;6007.249093863267;6019.909701354396;5827.970860145672;5847.26909136358;5849.795257165979;5865.120231965239;5885.3820348862755 03:28:03 INFO - 2016-01-05 03:28:03,253 DEBUG : BROWSER_OUTPUT: |1;ext.html;567.5431277821355;604.1903848842551;608.8721368512615;614.9538784591156;647.4173244080324;32659;40901.795491022574;41501;41598.16803663925;41600;46415.30377044347;46966;46996;47142.52857471433;47202.76398618011;8925.732228033154;9004.909950900505;9025.503597302146;9052.094790520961;9103.817923641524;8944.8658270126;8985.595648195815;8995.370324077317;8997.550122493882;9046.547672616376;8909.866352004692;9058.139476749731;9095.499747513884;9103.54482275887;9104.36269461138;9024.819503609924;9054.139856713602;9061.320400969953;9151.084891510862;9153.81692366149;8959.417637853583;8990.460572365679;9071.863922041175;9098.63605455781;9099.408538445046;42963.14073718508;43272.35091473631;43516.3472547912;43557.12885742299;43792.78103609494;3641.708663306929;3745.213505163919;4230.51349094855;4320.870373888788;4381.3208952612395;31514.52728209079;31636.525452118236;31670.366592668248;31989.52015719766;32303.676963230537;4148.751074935513;4175.561566035583;4190.559991200941;4232.068944832132;4234.661227101825;283906;286346;286508.9999999979;287726;288341;57312.42687573071;58120.709396452745;64829;64860;65129.348706512326;57707.42292577105;58015.129773053435;58182.7090864543;58329.4167058324;58516.414835851094;15639.218039098227;15648.139352335731;15673.529794106194;15720.29258683362;15763.133027683587;12301.692457688629;12382.5666101686;12392.876071239352;12445.75108497843;12449.315287659265;20333.288334908208;20578.691319630216;20621.793782062286;20662.58674826525;20735;8165.918340816635;8424.789380265542;8478.321734261244;8534.231919127309;8580.14198580137;1026.6663334416344;1078.417654466595;1104.1442881766534;1123.5619601130404;1172.3259126002583;29219;29663.703362966527;29771.702282976894;29857.253568660522;29924;1102.7904698107334;1179.9056075513938;1182.2197349749297;1245.875412458765;1275.4961790092862;15205.771913421308;15313.23433828304;15378.231088445533;15651.373945042298;15717.607059823597;521637;532344;534613;537618;723332;61976;62561;62714.686426567576;62780;62851.68574157191;1474.108164560447;1481.488886334213;1486.776983452469;1513.4551561438093;1529.6405344743976;31825;32315;32434.35131297408;32614.51078233781;32720.836395817867;49494.75252623714;49876.50123498718;49988.00023999427;50334.244986324506;50349.74825125851;308501;312661;314020;314692;314989;34526.48210276898;34849.47725784166;34986.300273994886;35215.82392088023;35398;46643.766781165876;46993.765031174626;47074.29388559243;47186.764066180825;47534.28698569594;39620.2075958485;39835;41108;41166.58833411747;43507;39991.80004100077;43658.781706091264;44822.551774481835;44895.87760306019;45705;39616.60383396129;39640.2071958565;39730.60269397269;41821;42695.3595696071;33004.33991320208;33943.66056339504;34082;34276;34734.47898281477;26037.8150420729;26777.33056673599;26797.33006674771;26934.191974240803;27016.594751078355 03:28:03 INFO - 2016-01-05 03:28:03,254 DEBUG : BROWSER_OUTPUT: |2;jquery.html;389.830423765662;389.9415087736839;393.1135289921227;395.2628348130737;395.43255428460157;15520.844791552096;15600;16498.670026599477;16925.153742312898;19716.901415492903;11292.04017658498;12664.556740514085;12784;15298;18702;4616.861494155164;5232.92150617741;5366.785328586851;5369.62412631116;5414.133738601825;4702.553257440538;5387.595930305243;5532.474414930575;5536.280283563131;5772.971135144339;5400.837974860741;5452.890942181154;5478.671279723209;5504.4495550444835;5609.214709940612;5549.250851135105;5593.105103183491;5607.4672906074065;5626.578006649477;5637.182608521783;5401.70290634015;5408.432114627947;5412.675239485643;5440.129579267338;5585.078462053756;13666.385012674453;13923.094998825043;13964;14008.369623366973;14560.344784484723;2239.8656080635214;2339.9181028663916;2365.3377054424786;2400.087966572709;2455.6193789962585;10596.947015264952;10622.840657390145;10655.467226638637;11727.237729547553;14414.495492657707;1915.2626238898124;1982.385460507233;1990.910409031597;2004.4788355027797;2039.9796002039939;64292.35707642911;64495.355046449404;65895.67052164709;66021.66989165024;66548;11019.669409917715;11274.098072154373;11307.151963602599;11387.829182562267;11409.315441073562;14827.40690372373;14832.406703731729;14895.404183832741;14964.775528367083;14977.850221497863;7943.086545047394;8022.3983201260135;8093.676252949934;8099.230573095547;8152.714654987047;7710.807229819299;7768.300852923264;7789.182135875765;7789.33790627803;7817.491863028885;4701.459332176843;4878.121938051185;4956.182229932021;4972;4997.925031124536;1980.395979226321;1980.653385657533;1981.2570286142698;2014.6675798493377;2017.788132246093;932.3380399916135;940.1820416237916;970.6554173268529;998.0468652436905;1022.539857064324;17015.91492042532;17883.73174402385;18063.458096257134;18405.171767270505;18448.446546603624;1005.4771518810323;1042.854000439939;1061.936283822973;1071.0788721699332;1119.1550379463454;9428.622855085858;9699;9754.658586949565;9836.852447213298;9933.50332483373;656843;658001;658697;663767.6811615911;691005;85109.57445212734;85997;86544;87265.12734872696;87344.12655873488;1222.8043513037871;1231.2797013746879;1235.8331625230837;1235.932023738685;1236.6413740015296;15164;15599.610009749847;15658.295376707847;15707.450239241572;15852.286647100678;34546.481802772476;35987.820060899525;36148.81925590355;37407.06482337963;37469.625303746616;43931;45645.771771140935;46205.30692039689;47497.28754068761;47920;10691.770446398763;10844.40355780408;10862.02241798242;10876.728081798019;10972.122230221403;17923;18394.26422943067;18525.536861578028;18827.246910123442;19209.615807684047;15138.470153544573;15272.694546108793;15334.693306133591;15412.922935385252;15880.126593037032;14740.778888316898;14759.066070541481;15163.545093647208;15250.389984400499;15686.607834804221;15848.683026339639;16087.919560402122;16225;16407.753883691516;16609;10386.792264154827;10727.892721073002;10834.133269338276;10836.078933290759;10849;15725.292361843973;15752.448664297153;15918.442854500037;16227.918860405622;16235.350585976428 03:28:03 INFO - 2016-01-05 03:28:03,255 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1585.5164174926647;1624.407091411635;1639.573710835183;1830.8901465912047;1909.8949557774317;8027.357811375091;8253.339732821374;8260.050094239165;8263.545504997222;8405.075441701409;8288.254057134856;8334.791630209247;8431.873521897176;8465.746027619165;8489.066202717697;2457.3979375053136;2493.0900221419142;2495.7504249574986;2496.151308555091;2497.063601149569;2463;2464.088287333689;2470.8641024743633;2474.64117702933;2478.10788116278;2373.5490256851144;2399.2802159352213;2411.1801987324307;2419.370963549481;2456.533258680854;2355.811535077207;2385.49904520051;2451.8651474168914;2465.4822487277693;2469.9753002470106;2452.865092419916;2461.1755062054053;2486.7140278867982;2491.539065272912;2492.4765799182014;8357.247847693738;8472;8478.491290522588;8492;8493.787655308604;4858.854234372974;4890.413150421937;4901.1177987962155;4920.483349248313;4944.678595891256;3185.378851124032;3220.420324341641;3224.774265801395;3242.2866969266724;3256.446404111307;1049.5329578337644;1049.5801679328254;1062.9255952083358;1118.9384583847884;1119.5969450997634;11509.712257193554;11536.134789890708;11575.884241157564;11577.842215778439;11620.477078531487;4345.869623911224;4374.103308821684;4390.47314322277;4415.183191109655;4460.1525710114975;9417.811643767087;9434.622615095457;9440.29197810167;9442.291828112919;9475.90524094764;4942.530459606403;4958.330625365602;4975.179095449211;4993.151164302078;5023.246513023003;4540.318952157137;4565.132624801277;4588.7246765194195;4598.149342371672;4604.861854144381;3681.77909325436;3697.9815100924325;3748.6626203641804;3752.962470375316;3782.3569993101237;1150.8849115088424;1157.6642773595731;1159.9536018559163;1166.2186335155297;1173.0908545877014;1159.5941420502925;1164.016406136813;1182.4324324324373;1194.0924897078282;1210.745743393897;7393.704251829974;7418.332350088518;7437.702491900372;7454.515456495311;7512.32389084985;1224.0574757436902;1234.7530493901256;1239.4174737873186;1239.504198320679;1241.5592464675092;6218.968905155445;6219.346968568326;6298.086777417248;6342.270638876496;6343.492520598341;10048.648297309559;10237.48812559369;10272.743181420376;10294.897051029393;10314.123299519475;9182.265418766483;10010.599576017023;10075.899241007643;10083.042110999444;10102.595896164217;7703.268189521987;7752.9612351939;7756.728514502078;7762.728304509315;7803.7268695595385;7549.7357592483995;7568.621568921642;7618.238176182559;7653.808654783675;7790.065192176975;8967.551622418983;9060.864087038832;9103.271738260792;9113.635454581743;9243.907560924574;9194;9424.57589408492;9486.525673716149;9520.143187113194;9610.95194524023;7255.165655949422;7358.705651773869;7364.742234021784;7372.926270737438;7392.519486233377;7867;7898.091719452336;7943.563104029334;7974.242446967529;7997.960010199912;7482;7608.733694320672;7631.465797394129;7648.196939321514;7736.535807851547;7311.232320606472;7430.665620047002;7665.540067595962;7739.496932699357;7779.066512018594;7561.4706970513735;7572.129205141479;7590.924090759243;7605.049368828896;7608.087029556488;6997.825054373681;7044;7087;7093.1488221413765;7108.289171082851;7125.5368401053765;7164.713411463483;7196.172440169447;7234.312740289664;7244.818879528054 03:28:03 INFO - 2016-01-05 03:28:03,256 DEBUG : BROWSER_OUTPUT: |4;prototype.html;364.16424306217226;365.7220512410567;372.26106179234216;372.6217888842825;381.46404301955755;6368.617882927016;6423.64669943153;6458.935410645898;6488.318726533711;6502.447291980176;6149.13912052313;6377.8405539861415;6380.808575742735;6394.104825324458;6394.968025159879;4929.8521044368545;4977.05435967166;4980.078685443186;4984.925226121593;4992.326035985132;4971.975140124295;4980.402351717799;4990.87522811929;4995.700257984515;4997.950020499803;4726.550977657134;4855.660103792736;4861.975690121562;4885.755712214393;4918.163912134945;4846.200376937801;4858.659893807435;4859.684120532172;4867.075255701423;4876.122297986361;4207.51613564441;4210.915781684349;4248.702590818644;4262.488501379854;4285.914281714379;5972.552058595579;6037.426444487766;6047.004488518778;6049.15311856336;6080.574359794816;5677.716114194315;5679.971600141973;5686.090225563931;5694.117411801178;5698.373178950312;6713.597184168917;6749.898751518731;6774.8306292342595;6776.898346524806;6786.524943253974;4724.574788269072;4726.83456079039;4729.834455794065;4743.952560474386;4745.715257084586;6866.793996180073;6918.446524278046;6986.650667466606;7007.054047703597;7013.754518591825;4849.854504364875;4851.248056551241;4858.198397264482;4859.416869975555;4859.586935110555;4908.558229759339;4914.70511769295;4916.06594746997;4918.286848406961;4934.062528119646;5564.33228012641;5678.176664383641;5689.516391106802;5691.658500489983;5694.800681976111;6850.931490685129;6868;6868.690908909111;6879.862402751917;6901.482388820858;1685.9747103793452;1737.8175291594453;1746.2229307958091;1747.7203647416352;1749.3090229359332;1165.5221359242669;1166.8249762535518;1176.4823477669797;1186.9762604747857;1192.7674103549898;6470.611763294218;6474.579152355176;6475.611463312216;6477.931141361622;6490.740370385226;6877.965610171917;6887.104676392137;6902.102726645504;6908.758193463204;6922.480813938874;6367.777127800505;6382.585131966407;6432.35676432353;6437.935620643733;6441.774537891151;3797.962020379761;3814.752041117374;3822.751521151172;3829.291581057513;3862.787546684903;7286.635668216568;7288.380487658503;7346.375558077516;7348.926510734825;7365.631718414058;7185.389241914391;7309;7325.4872158948365;7325.816854578678;7333.816654583678;7292.744753933481;7339.412846972229;7350.08123984502;7355.080614923135;7357.190709022003;7034.824129396806;7089.574625522485;7093.467989900675;7095.822604434724;7096.219415864354;6831.69257383409;7021.648917554204;7029.683664235224;7042;7046.929530704628;7309.744158954411;7314.634268286458;7314.707411703473;7331.633418329169;7360.227176146427;4752.786124624331;4782.187028205144;4784.330193772805;4784.904301914012;4789.281607758725;6870.31296870309;6910.896336555056;7054.929450705427;7081.07945967021;7092.148942126978;6833;6895.6207408591;6913.10129683138;6913.51605387618;6934.826629334307;6882.174139103339;6894.345037221456;6901.551399159039;6909.447244220551;6912.861742765217;6659;6792.320767923168;6803.047573339637;6811.318868113149;6818.863622727418;6883.036374907617;6907.516473846783;6944.791656250321;6954.895676564956;6959.1996920352785;6775.796726098225;6776.356246156607;6779.457643388419;6796.286389928986;6797.354251346114 03:28:03 INFO - 2016-01-05 03:28:03,256 DEBUG : BROWSER_OUTPUT: |5;yui.html;857.524074138853;921.272194965976;927.7263207353831;937.578089859563;948.7580666929932;16471.423500177498;17035.318587256494;17193.140342982864;17222.91388543057;17262.309507619713;15638.218089095528;15737.134457604827;15782.21088945551;15786.210689465539;15791.28939197736;921.2123634292684;925.2644147902417;943.3679434778714;945.9716208513721;951.0869565217365;926.2497377124517;934.850423932171;939.0797018921461;944.7024187380987;946.1153821177221;982.2780256511459;986.1469828598283;986.6300137448457;988.9258305627071;991.0683957080357;965.8164948659733;967.2165545907767;975.4829940131706;978.021978021978;981.5632043740538;713.254648891904;717.1931576975902;719.0723966083746;722.4004076616396;726.6911562585933;13999.370028348647;14004.369803358772;14045.78931316031;14063.578092657237;14092.647683807885;12730.427130779137;12803;13246.602601921957;13321.134126281857;13392.397342119628;11329.43352832355;11489.540418383338;11507;11566.65300041;11759.47082381295;3678.5585729712607;3727.329080765461;3734.402495600691;3742.9438558421643;3747.1006958330076;49474.25788613174;49620;50352;50598.49401505975;50826.49173508291;10588.153710509812;10701.464926753632;10764.13886889047;10793.29843560166;10886.455677216107;19034;19108.713369299472;19148.329808456638;19205.423837284903;19233.422997309823;7909.644066017043;7987.201279871966;8054.194580541899;8116.6347514362;8393.748187554384;4641.791119399568;4822.083804077284;4823.3729615150505;4870.245112007574;4918.680285781413;3259.788113772597;3301.900942971715;3304.93390132196;3305.9504107438406;3308.7353011759;569.2684899903604;591.6213623281103;593.9584229103921;594.7264258441079;598.933897662162;586.3989410853909;637.7225906730587;692.1555702043499;693.1231991530718;700.1423256510835;9949.303548751663;9957.751056223507;10109.595616175418;10112.646057387956;10319.948400258101;710.2471380336859;737.6169681846537;738.6934422214828;738.9113306403266;774.5701135869534;4201.957980420218;4250.3836943643;4266.1254442839145;4299.462567179103;4723.811047558059;60111;63527.36472635214;63815.680921596024;63901.36098638954;64032;53247.20129198065;53346.73326633342;53547.732261338446;54774.53514591773;55207.72396138074;48484.27273590899;48512;48694;49657.75171124194;50782.49217507778;9254.25965922738;9455.763605909908;9461.858072128785;9521.809563808823;9803.411795292306;36824.63175368319;37398.252034959696;37738;37770.81114594409;38468;46366;47227.52772472231;47516;47638.76180619213;47913.281300781215;11957.581484647995;12025.699357515781;12143.878561214628;12175.573854915036;12325.322107284186;12689.555865544662;13269.402876870758;13313.933430333174;13717.314134293445;13760.65598360049;11840.644780656594;12030.939845300718;12122.878771212176;12125.696857578278;12408.75182496363;11926.940365298118;11980;12083.939580302042;12184.51261949512;12339.321337326173;10322.535485903303;11361.772764544829;11449.48477318506;12152.088593355356;12205.633830985085;9591.088846559565;9940.314380705975;10020.799584008133;10265.589376425158;10497.10774584169;9438.433693978383;9855.35940163887;10246.180305575685;10284.691459256233;10317.845232321371 03:28:03 INFO - 2016-01-05 03:28:03,256 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:28:03 INFO - 2016-01-05 03:28:03,256 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:28:03 INFO - 2016-01-05 03:28:03,258 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,300 03:28:03 INFO - 2016-01-05 03:28:03,258 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:28:03 INFO - 2016-01-05 03:28:03,258 DEBUG : BROWSER_OUTPUT: __startTimestamp1451993283249__endTimestamp 03:28:03 INFO - 2016-01-05 03:28:03,258 DEBUG : BROWSER_OUTPUT: 03:28:03 INFO - 2016-01-05 03:28:03,258 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:28:03 INFO - 2016-01-05 03:28:03,258 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:28:03 INFO - 2016-01-05 03:28:03,258 DEBUG : BROWSER_OUTPUT: 03:28:03 INFO - 2016-01-05 03:28:03,259 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5631.45 Median:5836.59 stddev:618.69 (10.6%) stddev-sans-first:593.72 03:28:03 INFO - 2016-01-05 03:28:03,259 DEBUG : BROWSER_OUTPUT: Values: 3332.5 3410.9 3418.7 3448.9 3449.1 5630.0 5643.9 5665.3 5666.3 5676.3 5623.2 5706.9 5707.4 5713.2 5730.2 5193.5 5223.9 5252.2 5269.9 5321.9 5027.9 5124.1 5149.6 5156.8 5234.5 5175.3 5227.0 5252.7 5257.9 5262.2 5233.3 5267.1 5278.9 5281.3 5321.7 4938.9 4982.8 4986.2 5167.4 5178.5 5386.5 5430.9 5437.1 5484.5 5503.1 6049.5 6071.9 6093.4 6110.4 6113.0 5950.4 6112.8 6127.5 6140.5 6156.4 5653.4 5736.9 5748.5 5756.3 5787.2 6169.8 6181.6 6197.8 6197.9 6232.8 5799.6 5873.9 5975.0 6026.8 6036.6 6027.7 6052.2 6060.3 6068.1 6086.8 6027.1 6033.8 6042.5 6046.8 6055.5 5810.2 5836.6 5931.3 6007.4 6096.3 4642.4 4646.6 4658.9 4666.5 4685.4 4146.9 4155.4 4159.8 4162.6 4167.2 5546.8 5640.1 5649.6 5669.4 5751.7 6026.7 6142.0 6175.3 6192.8 6207.2 5631.9 5723.5 5788.7 5846.8 5858.4 5159.1 5181.4 5212.3 5232.9 5240.1 6233.2 6261.0 6261.5 6272.2 6279.8 5859.2 5887.1 6096.9 6107.5 6128.2 6120.5 6193.6 6204.9 6245.3 6253.4 6015.8 6035.1 6063.2 6079.8 6134.3 5799.3 5903.9 6124.4 6165.2 6185.9 5914.5 5930.3 5941.6 5966.6 5983.8 5877.4 5912.9 5926.5 5929.0 5937.2 5528.6 5634.6 5709.2 5819.1 5832.1 5925.4 5956.2 5968.5 6007.2 6019.9 5828.0 5847.3 5849.8 5865.1 5885.4 03:28:03 INFO - 2016-01-05 03:28:03,259 DEBUG : BROWSER_OUTPUT: 03:28:03 INFO - 2016-01-05 03:28:03,259 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:56248.18 Median:22887.78 stddev:109765.07 (479.6%) stddev-sans-first:109993.38 03:28:03 INFO - 2016-01-05 03:28:03,259 DEBUG : BROWSER_OUTPUT: Values: 567.5 604.2 608.9 615.0 647.4 32659.0 40901.8 41501.0 41598.2 41600.0 46415.3 46966.0 46996.0 47142.5 47202.8 8925.7 9004.9 9025.5 9052.1 9103.8 8944.9 8985.6 8995.4 8997.6 9046.5 8909.9 9058.1 9095.5 9103.5 9104.4 9024.8 9054.1 9061.3 9151.1 9153.8 8959.4 8990.5 9071.9 9098.6 9099.4 42963.1 43272.4 43516.3 43557.1 43792.8 3641.7 3745.2 4230.5 4320.9 4381.3 31514.5 31636.5 31670.4 31989.5 32303.7 4148.8 4175.6 4190.6 4232.1 4234.7 283906.0 286346.0 286509.0 287726.0 288341.0 57312.4 58120.7 64829.0 64860.0 65129.3 57707.4 58015.1 58182.7 58329.4 58516.4 15639.2 15648.1 15673.5 15720.3 15763.1 12301.7 12382.6 12392.9 12445.8 12449.3 20333.3 20578.7 20621.8 20662.6 20735.0 8165.9 8424.8 8478.3 8534.2 8580.1 1026.7 1078.4 1104.1 1123.6 1172.3 29219.0 29663.7 29771.7 29857.3 29924.0 1102.8 1179.9 1182.2 1245.9 1275.5 15205.8 15313.2 15378.2 15651.4 15717.6 521637.0 532344.0 534613.0 537618.0 723332.0 61976.0 62561.0 62714.7 62780.0 62851.7 1474.1 1481.5 1486.8 1513.5 1529.6 31825.0 32315.0 32434.4 32614.5 32720.8 49494.8 49876.5 49988.0 50334.2 50349.7 308501.0 312661.0 314020.0 314692.0 314989.0 34526.5 34849.5 34986.3 35215.8 35398.0 46643.8 46993.8 47074.3 47186.8 47534.3 39620.2 39835.0 41108.0 41166.6 43507.0 39991.8 43658.8 44822.6 44895.9 45705.0 39616.6 39640.2 39730.6 41821.0 42695.4 33004.3 33943.7 34082.0 34276.0 34734.5 26037.8 26777.3 26797.3 26934.2 27016.6 03:28:03 INFO - 2016-01-05 03:28:03,260 DEBUG : BROWSER_OUTPUT: 03:28:03 INFO - 2016-01-05 03:28:03,260 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32971.35 Median:1986.65 stddev:108708.86 (5472.0%) stddev-sans-first:108986.28 03:28:03 INFO - 2016-01-05 03:28:03,260 DEBUG : BROWSER_OUTPUT: Values: 389.8 389.9 393.1 395.3 395.4 15520.8 15600.0 16498.7 16925.2 19716.9 11292.0 12664.6 12784.0 15298.0 18702.0 4616.9 5232.9 5366.8 5369.6 5414.1 4702.6 5387.6 5532.5 5536.3 5773.0 5400.8 5452.9 5478.7 5504.4 5609.2 5549.3 5593.1 5607.5 5626.6 5637.2 5401.7 5408.4 5412.7 5440.1 5585.1 13666.4 13923.1 13964.0 14008.4 14560.3 2239.9 2339.9 2365.3 2400.1 2455.6 10596.9 10622.8 10655.5 11727.2 14414.5 1915.3 1982.4 1990.9 2004.5 2040.0 64292.4 64495.4 65895.7 66021.7 66548.0 11019.7 11274.1 11307.2 11387.8 11409.3 14827.4 14832.4 14895.4 14964.8 14977.9 7943.1 8022.4 8093.7 8099.2 8152.7 7710.8 7768.3 7789.2 7789.3 7817.5 4701.5 4878.1 4956.2 4972.0 4997.9 1980.4 1980.7 1981.3 2014.7 2017.8 932.3 940.2 970.7 998.0 1022.5 17015.9 17883.7 18063.5 18405.2 18448.4 1005.5 1042.9 1061.9 1071.1 1119.2 9428.6 9699.0 9754.7 9836.9 9933.5 656843.0 658001.0 658697.0 663767.7 691005.0 85109.6 85997.0 86544.0 87265.1 87344.1 1222.8 1231.3 1235.8 1235.9 1236.6 15164.0 15599.6 15658.3 15707.5 15852.3 34546.5 35987.8 36148.8 37407.1 37469.6 43931.0 45645.8 46205.3 47497.3 47920.0 10691.8 10844.4 10862.0 10876.7 10972.1 17923.0 18394.3 18525.5 18827.2 19209.6 15138.5 15272.7 15334.7 15412.9 15880.1 14740.8 14759.1 15163.5 15250.4 15686.6 15848.7 16087.9 16225.0 16407.8 16609.0 10386.8 10727.9 10834.1 10836.1 10849.0 15725.3 15752.4 15918.4 16227.9 16235.4 03:28:03 INFO - 2016-01-05 03:28:03,260 DEBUG : BROWSER_OUTPUT: 03:28:03 INFO - 2016-01-05 03:28:03,261 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5852.88 Median:4966.75 stddev:3044.30 (61.3%) stddev-sans-first:3035.95 03:28:03 INFO - 2016-01-05 03:28:03,262 DEBUG : BROWSER_OUTPUT: Values: 1585.5 1624.4 1639.6 1830.9 1909.9 8027.4 8253.3 8260.1 8263.5 8405.1 8288.3 8334.8 8431.9 8465.7 8489.1 2457.4 2493.1 2495.8 2496.2 2497.1 2463.0 2464.1 2470.9 2474.6 2478.1 2373.5 2399.3 2411.2 2419.4 2456.5 2355.8 2385.5 2451.9 2465.5 2470.0 2452.9 2461.2 2486.7 2491.5 2492.5 8357.2 8472.0 8478.5 8492.0 8493.8 4858.9 4890.4 4901.1 4920.5 4944.7 3185.4 3220.4 3224.8 3242.3 3256.4 1049.5 1049.6 1062.9 1118.9 1119.6 11509.7 11536.1 11575.9 11577.8 11620.5 4345.9 4374.1 4390.5 4415.2 4460.2 9417.8 9434.6 9440.3 9442.3 9475.9 4942.5 4958.3 4975.2 4993.2 5023.2 4540.3 4565.1 4588.7 4598.1 4604.9 3681.8 3698.0 3748.7 3753.0 3782.4 1150.9 1157.7 1160.0 1166.2 1173.1 1159.6 1164.0 1182.4 1194.1 1210.7 7393.7 7418.3 7437.7 7454.5 7512.3 1224.1 1234.8 1239.4 1239.5 1241.6 6219.0 6219.3 6298.1 6342.3 6343.5 10048.6 10237.5 10272.7 10294.9 10314.1 9182.3 10010.6 10075.9 10083.0 10102.6 7703.3 7753.0 7756.7 7762.7 7803.7 7549.7 7568.6 7618.2 7653.8 7790.1 8967.6 9060.9 9103.3 9113.6 9243.9 9194.0 9424.6 9486.5 9520.1 9611.0 7255.2 7358.7 7364.7 7372.9 7392.5 7867.0 7898.1 7943.6 7974.2 7998.0 7482.0 7608.7 7631.5 7648.2 7736.5 7311.2 7430.7 7665.5 7739.5 7779.1 7561.5 7572.1 7590.9 7605.0 7608.1 6997.8 7044.0 7087.0 7093.1 7108.3 7125.5 7164.7 7196.2 7234.3 7244.8 03:28:03 INFO - 2016-01-05 03:28:03,262 DEBUG : BROWSER_OUTPUT: 03:28:03 INFO - 2016-01-05 03:28:03,263 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5709.01 Median:6439.86 stddev:1721.45 (26.7%) stddev-sans-first:1678.89 03:28:03 INFO - 2016-01-05 03:28:03,264 DEBUG : BROWSER_OUTPUT: Values: 364.2 365.7 372.3 372.6 381.5 6368.6 6423.6 6458.9 6488.3 6502.4 6149.1 6377.8 6380.8 6394.1 6395.0 4929.9 4977.1 4980.1 4984.9 4992.3 4972.0 4980.4 4990.9 4995.7 4998.0 4726.6 4855.7 4862.0 4885.8 4918.2 4846.2 4858.7 4859.7 4867.1 4876.1 4207.5 4210.9 4248.7 4262.5 4285.9 5972.6 6037.4 6047.0 6049.2 6080.6 5677.7 5680.0 5686.1 5694.1 5698.4 6713.6 6749.9 6774.8 6776.9 6786.5 4724.6 4726.8 4729.8 4744.0 4745.7 6866.8 6918.4 6986.7 7007.1 7013.8 4849.9 4851.2 4858.2 4859.4 4859.6 4908.6 4914.7 4916.1 4918.3 4934.1 5564.3 5678.2 5689.5 5691.7 5694.8 6850.9 6868.0 6868.7 6879.9 6901.5 1686.0 1737.8 1746.2 1747.7 1749.3 1165.5 1166.8 1176.5 1187.0 1192.8 6470.6 6474.6 6475.6 6477.9 6490.7 6878.0 6887.1 6902.1 6908.8 6922.5 6367.8 6382.6 6432.4 6437.9 6441.8 3798.0 3814.8 3822.8 3829.3 3862.8 7286.6 7288.4 7346.4 7348.9 7365.6 7185.4 7309.0 7325.5 7325.8 7333.8 7292.7 7339.4 7350.1 7355.1 7357.2 7034.8 7089.6 7093.5 7095.8 7096.2 6831.7 7021.6 7029.7 7042.0 7046.9 7309.7 7314.6 7314.7 7331.6 7360.2 4752.8 4782.2 4784.3 4784.9 4789.3 6870.3 6910.9 7054.9 7081.1 7092.1 6833.0 6895.6 6913.1 6913.5 6934.8 6882.2 6894.3 6901.6 6909.4 6912.9 6659.0 6792.3 6803.0 6811.3 6818.9 6883.0 6907.5 6944.8 6954.9 6959.2 6775.8 6776.4 6779.5 6796.3 6797.4 03:28:03 INFO - 2016-01-05 03:28:03,264 DEBUG : BROWSER_OUTPUT: 03:28:03 INFO - 2016-01-05 03:28:03,264 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14873.05 Median:25975.67 stddev:16997.00 (65.4%) stddev-sans-first:17012.09 03:28:03 INFO - 2016-01-05 03:28:03,264 DEBUG : BROWSER_OUTPUT: Values: 857.5 921.3 927.7 937.6 948.8 16471.4 17035.3 17193.1 17222.9 17262.3 15638.2 15737.1 15782.2 15786.2 15791.3 921.2 925.3 943.4 946.0 951.1 926.2 934.9 939.1 944.7 946.1 982.3 986.1 986.6 988.9 991.1 965.8 967.2 975.5 978.0 981.6 713.3 717.2 719.1 722.4 726.7 13999.4 14004.4 14045.8 14063.6 14092.6 12730.4 12803.0 13246.6 13321.1 13392.4 11329.4 11489.5 11507.0 11566.7 11759.5 3678.6 3727.3 3734.4 3742.9 3747.1 49474.3 49620.0 50352.0 50598.5 50826.5 10588.2 10701.5 10764.1 10793.3 10886.5 19034.0 19108.7 19148.3 19205.4 19233.4 7909.6 7987.2 8054.2 8116.6 8393.7 4641.8 4822.1 4823.4 4870.2 4918.7 3259.8 3301.9 3304.9 3306.0 3308.7 569.3 591.6 594.0 594.7 598.9 586.4 637.7 692.2 693.1 700.1 9949.3 9957.8 10109.6 10112.6 10319.9 710.2 737.6 738.7 738.9 774.6 4202.0 4250.4 4266.1 4299.5 4723.8 60111.0 63527.4 63815.7 63901.4 64032.0 53247.2 53346.7 53547.7 54774.5 55207.7 48484.3 48512.0 48694.0 49657.8 50782.5 9254.3 9455.8 9461.9 9521.8 9803.4 36824.6 37398.3 37738.0 37770.8 38468.0 46366.0 47227.5 47516.0 47638.8 47913.3 11957.6 12025.7 12143.9 12175.6 12325.3 12689.6 13269.4 13313.9 13717.3 13760.7 11840.6 12030.9 12122.9 12125.7 12408.8 11926.9 11980.0 12083.9 12184.5 12339.3 10322.5 11361.8 11449.5 12152.1 12205.6 9591.1 9940.3 10020.8 10265.6 10497.1 9438.4 9855.4 10246.2 10284.7 10317.8 03:28:03 INFO - 2016-01-05 03:28:03,264 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:28:03 INFO - 2016-01-05 03:28:03,264 DEBUG : BROWSER_OUTPUT: 03:28:03 INFO - 2016-01-05 03:28:03,928 INFO : Browser exited with error code: 0 03:28:03 INFO - 2016-01-05 03:28:03,944 INFO : Completed test dromaeo_css (00:18:28) 03:28:03 INFO - 2016-01-05 03:28:03,945 INFO : Starting test kraken 03:28:03 INFO - 2016-01-05 03:28:03,945 DEBUG : operating with platform_type : linux_ 03:28:03 INFO - 2016-01-05 03:28:03,945 INFO : Initialising browser for kraken test... 03:28:03 INFO - 2016-01-05 03:28:03,951 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPgQun4/profile http://localhost:47976/getInfo.html 03:28:08 INFO - 2016-01-05 03:28:08,194 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:28:08 INFO - 2016-01-05 03:28:08,194 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:28:08 INFO - 2016-01-05 03:28:08,195 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/670 03:28:08 INFO - 2016-01-05 03:28:08,195 DEBUG : BROWSER_OUTPUT: __metrics 03:28:09 INFO - 2016-01-05 03:28:09,068 INFO : Browser initialized. 03:28:09 INFO - 2016-01-05 03:28:09,069 INFO : Running cycle 1/1 for kraken test... 03:28:09 INFO - 2016-01-05 03:28:09,069 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPgQun4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:28:20 INFO - 2016-01-05 03:28:20,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 136847360 03:28:20 INFO - 2016-01-05 03:28:20,878 DEBUG : BROWSER_OUTPUT: 03:28:23 INFO - 2016-01-05 03:28:23,354 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47976/tests/kraken/driver.html?testName=audio-beat-detection) 03:28:23 INFO - 2016-01-05 03:28:23,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 139075584 03:28:23 INFO - 2016-01-05 03:28:23,956 DEBUG : BROWSER_OUTPUT: 03:28:26 INFO - 2016-01-05 03:28:26,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47976/tests/kraken/driver.html?testName=audio-dft) 03:28:27 INFO - 2016-01-05 03:28:27,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 138346496 03:28:27 INFO - 2016-01-05 03:28:27,135 DEBUG : BROWSER_OUTPUT: 03:28:29 INFO - 2016-01-05 03:28:29,966 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47976/tests/kraken/driver.html?testName=audio-fft) 03:28:30 INFO - 2016-01-05 03:28:30,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 138178560 03:28:30 INFO - 2016-01-05 03:28:30,547 DEBUG : BROWSER_OUTPUT: 03:28:32 INFO - 2016-01-05 03:28:32,544 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47976/tests/kraken/driver.html?testName=audio-oscillator) 03:28:33 INFO - 2016-01-05 03:28:33,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 139866112 03:28:33 INFO - 2016-01-05 03:28:33,131 DEBUG : BROWSER_OUTPUT: 03:28:35 INFO - 2016-01-05 03:28:35,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47976/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:28:35 INFO - 2016-01-05 03:28:35,886 DEBUG : BROWSER_OUTPUT: RSS: Main: 139157504 03:28:35 INFO - 2016-01-05 03:28:35,886 DEBUG : BROWSER_OUTPUT: 03:28:38 INFO - 2016-01-05 03:28:38,818 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47976/tests/kraken/driver.html?testName=imaging-darkroom) 03:28:39 INFO - 2016-01-05 03:28:39,404 DEBUG : BROWSER_OUTPUT: RSS: Main: 137904128 03:28:39 INFO - 2016-01-05 03:28:39,404 DEBUG : BROWSER_OUTPUT: 03:28:42 INFO - 2016-01-05 03:28:42,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47976/tests/kraken/driver.html?testName=imaging-desaturate) 03:28:43 INFO - 2016-01-05 03:28:43,332 DEBUG : BROWSER_OUTPUT: RSS: Main: 138166272 03:28:43 INFO - 2016-01-05 03:28:43,333 DEBUG : BROWSER_OUTPUT: 03:28:46 INFO - 2016-01-05 03:28:46,103 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47976/tests/kraken/driver.html?testName=json-parse-financial) 03:28:46 INFO - 2016-01-05 03:28:46,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 138752000 03:28:46 INFO - 2016-01-05 03:28:46,697 DEBUG : BROWSER_OUTPUT: 03:28:48 INFO - 2016-01-05 03:28:48,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47976/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:28:48 INFO - 2016-01-05 03:28:48,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 137756672 03:28:48 INFO - 2016-01-05 03:28:48,839 DEBUG : BROWSER_OUTPUT: 03:28:50 INFO - 2016-01-05 03:28:50,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47976/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:28:51 INFO - 2016-01-05 03:28:51,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 138354688 03:28:51 INFO - 2016-01-05 03:28:51,216 DEBUG : BROWSER_OUTPUT: 03:28:53 INFO - 2016-01-05 03:28:53,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47976/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:28:53 INFO - 2016-01-05 03:28:53,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 138375168 03:28:53 INFO - 2016-01-05 03:28:53,830 DEBUG : BROWSER_OUTPUT: 03:28:56 INFO - 2016-01-05 03:28:56,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:28:56 INFO - 2016-01-05 03:28:56,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 138772480 03:28:56 INFO - 2016-01-05 03:28:56,803 DEBUG : BROWSER_OUTPUT: 03:28:59 INFO - 2016-01-05 03:28:59,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:28:59 INFO - 2016-01-05 03:28:59,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 139849728 03:28:59 INFO - 2016-01-05 03:28:59,900 DEBUG : BROWSER_OUTPUT: 03:29:01 INFO - 2016-01-05 03:29:01,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47976/tests/kraken/driver.html?testName=ai-astar) 03:29:01 INFO - 2016-01-05 03:29:01,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 138506240 03:29:01 INFO - 2016-01-05 03:29:01,820 DEBUG : BROWSER_OUTPUT: 03:29:01 INFO - 2016-01-05 03:29:01,821 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:29:01 INFO - 2016-01-05 03:29:01,821 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:29:01 INFO - 2016-01-05 03:29:01,821 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:29:01 INFO - 2016-01-05 03:29:01,821 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:29:01 INFO - 2016-01-05 03:29:01,823 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;106;113;110;113;120;111;110;110;111 03:29:01 INFO - 2016-01-05 03:29:01,823 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;144;129;146;156;122;155;153;127;161;124 03:29:01 INFO - 2016-01-05 03:29:01,823 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;160;161;163;160;161;163;163;160 03:29:01 INFO - 2016-01-05 03:29:01,823 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;72;159;74;71;71;72;152;71 03:29:01 INFO - 2016-01-05 03:29:01,823 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;133;91;93;93;142;92;93;137 03:29:01 INFO - 2016-01-05 03:29:01,823 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;110;110;110;110;112;114 03:29:01 INFO - 2016-01-05 03:29:01,824 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;148;146;147;147;148;146;145;148;151 03:29:01 INFO - 2016-01-05 03:29:01,824 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;95;97;96;96;95;96;97 03:29:01 INFO - 2016-01-05 03:29:01,824 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;63;62;58;59;60;60;60;61;57 03:29:01 INFO - 2016-01-05 03:29:01,824 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;63;64;65;63;63;65;62;63 03:29:01 INFO - 2016-01-05 03:29:01,824 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;89;88;81;81;84;80;82;81;82;81 03:29:01 INFO - 2016-01-05 03:29:01,824 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;121;112;120;128;121;112;114;112;110 03:29:01 INFO - 2016-01-05 03:29:01,824 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;156;141;148;146;146;144;147;143;145 03:29:01 INFO - 2016-01-05 03:29:01,824 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;65;65;68;63;67;66;64;69 03:29:01 INFO - 2016-01-05 03:29:01,824 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:29:01 INFO - 2016-01-05 03:29:01,824 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:29:01 INFO - 2016-01-05 03:29:01,824 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,712 03:29:01 INFO - 2016-01-05 03:29:01,824 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:29:01 INFO - 2016-01-05 03:29:01,825 DEBUG : BROWSER_OUTPUT: __startTimestamp1451993341821__endTimestamp 03:29:01 INFO - 2016-01-05 03:29:01,825 DEBUG : BROWSER_OUTPUT: 03:29:01 INFO - 2016-01-05 03:29:01,826 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:29:01 INFO - 2016-01-05 03:29:01,826 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:29:01 INFO - 2016-01-05 03:29:01,826 DEBUG : BROWSER_OUTPUT: 03:29:01 INFO - 2016-01-05 03:29:01,826 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.60 Median:111.50 stddev:3.57 (3.2%) stddev-sans-first:3.78 03:29:01 INFO - 2016-01-05 03:29:01,826 DEBUG : BROWSER_OUTPUT: Values: 112.0 106.0 113.0 110.0 113.0 120.0 111.0 110.0 110.0 111.0 03:29:01 INFO - 2016-01-05 03:29:01,826 DEBUG : BROWSER_OUTPUT: 03:29:01 INFO - 2016-01-05 03:29:01,826 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.70 Median:149.50 stddev:14.85 (9.9%) stddev-sans-first:15.73 03:29:01 INFO - 2016-01-05 03:29:01,826 DEBUG : BROWSER_OUTPUT: Values: 144.0 129.0 146.0 156.0 122.0 155.0 153.0 127.0 161.0 124.0 03:29:01 INFO - 2016-01-05 03:29:01,826 DEBUG : BROWSER_OUTPUT: 03:29:01 INFO - 2016-01-05 03:29:01,826 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.26 (0.8%) stddev-sans-first:1.32 03:29:01 INFO - 2016-01-05 03:29:01,827 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 160.0 161.0 163.0 160.0 161.0 163.0 163.0 160.0 03:29:01 INFO - 2016-01-05 03:29:01,827 DEBUG : BROWSER_OUTPUT: 03:29:01 INFO - 2016-01-05 03:29:01,827 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.90 Median:72.00 stddev:35.16 (48.8%) stddev-sans-first:36.82 03:29:01 INFO - 2016-01-05 03:29:01,828 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 72.0 159.0 74.0 71.0 71.0 72.0 152.0 71.0 03:29:01 INFO - 2016-01-05 03:29:01,828 DEBUG : BROWSER_OUTPUT: 03:29:01 INFO - 2016-01-05 03:29:01,828 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:93.00 stddev:21.74 (23.4%) stddev-sans-first:22.54 03:29:01 INFO - 2016-01-05 03:29:01,828 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 133.0 91.0 93.0 93.0 142.0 92.0 93.0 137.0 03:29:01 INFO - 2016-01-05 03:29:01,828 DEBUG : BROWSER_OUTPUT: 03:29:01 INFO - 2016-01-05 03:29:01,828 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:110.00 stddev:1.43 (1.3%) stddev-sans-first:1.51 03:29:01 INFO - 2016-01-05 03:29:01,828 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 110.0 110.0 110.0 110.0 112.0 114.0 03:29:01 INFO - 2016-01-05 03:29:01,828 DEBUG : BROWSER_OUTPUT: 03:29:01 INFO - 2016-01-05 03:29:01,828 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:1.69 (1.1%) stddev-sans-first:1.73 03:29:01 INFO - 2016-01-05 03:29:01,829 DEBUG : BROWSER_OUTPUT: Values: 146.0 148.0 146.0 147.0 147.0 148.0 146.0 145.0 148.0 151.0 03:29:01 INFO - 2016-01-05 03:29:01,829 DEBUG : BROWSER_OUTPUT: 03:29:01 INFO - 2016-01-05 03:29:01,829 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 03:29:01 INFO - 2016-01-05 03:29:01,829 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 95.0 97.0 96.0 96.0 95.0 96.0 97.0 03:29:01 INFO - 2016-01-05 03:29:01,829 DEBUG : BROWSER_OUTPUT: 03:29:01 INFO - 2016-01-05 03:29:01,829 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.00 Median:60.00 stddev:1.76 (2.9%) stddev-sans-first:1.87 03:29:01 INFO - 2016-01-05 03:29:01,829 DEBUG : BROWSER_OUTPUT: Values: 60.0 63.0 62.0 58.0 59.0 60.0 60.0 60.0 61.0 57.0 03:29:01 INFO - 2016-01-05 03:29:01,830 DEBUG : BROWSER_OUTPUT: 03:29:01 INFO - 2016-01-05 03:29:01,830 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 03:29:01 INFO - 2016-01-05 03:29:01,830 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 63.0 64.0 65.0 63.0 63.0 65.0 62.0 63.0 03:29:01 INFO - 2016-01-05 03:29:01,830 DEBUG : BROWSER_OUTPUT: 03:29:01 INFO - 2016-01-05 03:29:01,830 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.00 stddev:3.14 (3.8%) stddev-sans-first:2.44 03:29:01 INFO - 2016-01-05 03:29:01,830 DEBUG : BROWSER_OUTPUT: Values: 89.0 88.0 81.0 81.0 84.0 80.0 82.0 81.0 82.0 81.0 03:29:01 INFO - 2016-01-05 03:29:01,830 DEBUG : BROWSER_OUTPUT: 03:29:01 INFO - 2016-01-05 03:29:01,830 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.40 Median:117.00 stddev:5.78 (4.9%) stddev-sans-first:6.06 03:29:01 INFO - 2016-01-05 03:29:01,830 DEBUG : BROWSER_OUTPUT: Values: 114.0 121.0 112.0 120.0 128.0 121.0 112.0 114.0 112.0 110.0 03:29:01 INFO - 2016-01-05 03:29:01,830 DEBUG : BROWSER_OUTPUT: 03:29:01 INFO - 2016-01-05 03:29:01,830 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.30 Median:146.50 stddev:4.00 (2.7%) stddev-sans-first:4.24 03:29:01 INFO - 2016-01-05 03:29:01,830 DEBUG : BROWSER_OUTPUT: Values: 147.0 156.0 141.0 148.0 146.0 146.0 144.0 147.0 143.0 145.0 03:29:01 INFO - 2016-01-05 03:29:01,830 DEBUG : BROWSER_OUTPUT: 03:29:01 INFO - 2016-01-05 03:29:01,830 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:67.00 stddev:1.85 (2.8%) stddev-sans-first:1.94 03:29:01 INFO - 2016-01-05 03:29:01,830 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 65.0 65.0 68.0 63.0 67.0 66.0 64.0 69.0 03:29:01 INFO - 2016-01-05 03:29:01,830 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:29:01 INFO - 2016-01-05 03:29:01,831 DEBUG : BROWSER_OUTPUT: 03:29:02 INFO - 2016-01-05 03:29:02,648 INFO : Browser exited with error code: 0 03:29:02 INFO - 2016-01-05 03:29:02,702 INFO : Completed test kraken (00:00:58) 03:29:02 INFO - 2016-01-05 03:29:02,702 INFO : Starting test v8_7 03:29:02 INFO - 2016-01-05 03:29:02,702 DEBUG : operating with platform_type : linux_ 03:29:02 INFO - 2016-01-05 03:29:02,702 INFO : Initialising browser for v8_7 test... 03:29:02 INFO - 2016-01-05 03:29:02,708 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprIZvuf/profile http://localhost:47976/getInfo.html 03:29:07 INFO - 2016-01-05 03:29:07,059 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:29:07 INFO - 2016-01-05 03:29:07,059 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:29:07 INFO - 2016-01-05 03:29:07,059 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/670 03:29:07 INFO - 2016-01-05 03:29:07,059 DEBUG : BROWSER_OUTPUT: __metrics 03:29:07 INFO - 2016-01-05 03:29:07,980 INFO : Browser initialized. 03:29:07 INFO - 2016-01-05 03:29:07,981 INFO : Running cycle 1/1 for v8_7 test... 03:29:07 INFO - 2016-01-05 03:29:07,981 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprIZvuf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:29:19 INFO - 2016-01-05 03:29:19,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 136003584 03:29:19 INFO - 2016-01-05 03:29:19,741 DEBUG : BROWSER_OUTPUT: 03:29:41 INFO - 2016-01-05 03:29:41,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47976/tests/v8_7/run.html (next: http://localhost:47976/tests/v8_7/run.html) 03:29:41 INFO - 2016-01-05 03:29:41,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 135434240 03:29:41 INFO - 2016-01-05 03:29:41,333 DEBUG : BROWSER_OUTPUT: 03:29:41 INFO - 2016-01-05 03:29:41,333 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:29:41 INFO - 2016-01-05 03:29:41,334 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:29:41 INFO - 2016-01-05 03:29:41,334 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:29:41 INFO - 2016-01-05 03:29:41,334 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:29:41 INFO - 2016-01-05 03:29:41,334 DEBUG : BROWSER_OUTPUT: |0;Richards;165.59032952475576 03:29:41 INFO - 2016-01-05 03:29:41,334 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;172.77125086385627 03:29:41 INFO - 2016-01-05 03:29:41,334 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.8622420524261 03:29:41 INFO - 2016-01-05 03:29:41,334 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 03:29:41 INFO - 2016-01-05 03:29:41,335 DEBUG : BROWSER_OUTPUT: |4;RayTrace;925.925925925926 03:29:41 INFO - 2016-01-05 03:29:41,335 DEBUG : BROWSER_OUTPUT: |5;Earley;550.05500550055 03:29:41 INFO - 2016-01-05 03:29:41,335 DEBUG : BROWSER_OUTPUT: |6;Boyer;11131.868131868132 03:29:41 INFO - 2016-01-05 03:29:41,335 DEBUG : BROWSER_OUTPUT: |7;RegExp;26552.63157894737 03:29:41 INFO - 2016-01-05 03:29:41,335 DEBUG : BROWSER_OUTPUT: |8;Splay;520.6825232678386 03:29:41 INFO - 2016-01-05 03:29:41,335 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 03:29:41 INFO - 2016-01-05 03:29:41,336 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:29:41 INFO - 2016-01-05 03:29:41,336 DEBUG : BROWSER_OUTPUT: __startTimestamp1451993381332__endTimestamp 03:29:41 INFO - 2016-01-05 03:29:41,336 DEBUG : BROWSER_OUTPUT: 03:29:41 INFO - 2016-01-05 03:29:41,336 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:29:41 INFO - 2016-01-05 03:29:41,336 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:29:41 INFO - 2016-01-05 03:29:41,337 DEBUG : BROWSER_OUTPUT: 03:29:41 INFO - 2016-01-05 03:29:41,337 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.59 Median:165.59 stddev:0.00 (0.0%) 03:29:41 INFO - 2016-01-05 03:29:41,337 DEBUG : BROWSER_OUTPUT: Values: 165.6 03:29:41 INFO - 2016-01-05 03:29:41,337 DEBUG : BROWSER_OUTPUT: 03:29:41 INFO - 2016-01-05 03:29:41,337 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:172.77 Median:172.77 stddev:0.00 (0.0%) 03:29:41 INFO - 2016-01-05 03:29:41,337 DEBUG : BROWSER_OUTPUT: Values: 172.8 03:29:41 INFO - 2016-01-05 03:29:41,338 DEBUG : BROWSER_OUTPUT: 03:29:41 INFO - 2016-01-05 03:29:41,338 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 03:29:41 INFO - 2016-01-05 03:29:41,339 DEBUG : BROWSER_OUTPUT: Values: 278.9 03:29:41 INFO - 2016-01-05 03:29:41,339 DEBUG : BROWSER_OUTPUT: 03:29:41 INFO - 2016-01-05 03:29:41,339 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 03:29:41 INFO - 2016-01-05 03:29:41,339 DEBUG : BROWSER_OUTPUT: Values: 5196.9 03:29:41 INFO - 2016-01-05 03:29:41,340 DEBUG : BROWSER_OUTPUT: 03:29:41 INFO - 2016-01-05 03:29:41,340 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:925.93 Median:925.93 stddev:0.00 (0.0%) 03:29:41 INFO - 2016-01-05 03:29:41,340 DEBUG : BROWSER_OUTPUT: Values: 925.9 03:29:41 INFO - 2016-01-05 03:29:41,340 DEBUG : BROWSER_OUTPUT: 03:29:41 INFO - 2016-01-05 03:29:41,340 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:550.06 Median:550.06 stddev:0.00 (0.0%) 03:29:41 INFO - 2016-01-05 03:29:41,340 DEBUG : BROWSER_OUTPUT: Values: 550.1 03:29:41 INFO - 2016-01-05 03:29:41,340 DEBUG : BROWSER_OUTPUT: 03:29:41 INFO - 2016-01-05 03:29:41,340 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11131.87 Median:11131.87 stddev:0.00 (0.0%) 03:29:41 INFO - 2016-01-05 03:29:41,340 DEBUG : BROWSER_OUTPUT: Values: 11131.9 03:29:41 INFO - 2016-01-05 03:29:41,340 DEBUG : BROWSER_OUTPUT: 03:29:41 INFO - 2016-01-05 03:29:41,340 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26552.63 Median:26552.63 stddev:0.00 (0.0%) 03:29:41 INFO - 2016-01-05 03:29:41,340 DEBUG : BROWSER_OUTPUT: Values: 26552.6 03:29:41 INFO - 2016-01-05 03:29:41,340 DEBUG : BROWSER_OUTPUT: 03:29:41 INFO - 2016-01-05 03:29:41,341 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:520.68 Median:520.68 stddev:0.00 (0.0%) 03:29:41 INFO - 2016-01-05 03:29:41,341 DEBUG : BROWSER_OUTPUT: Values: 520.7 03:29:41 INFO - 2016-01-05 03:29:41,341 DEBUG : BROWSER_OUTPUT: 03:29:41 INFO - 2016-01-05 03:29:41,341 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 03:29:41 INFO - 2016-01-05 03:29:41,341 DEBUG : BROWSER_OUTPUT: Values: 4817.3 03:29:41 INFO - 2016-01-05 03:29:41,341 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:29:41 INFO - 2016-01-05 03:29:41,341 DEBUG : BROWSER_OUTPUT: 03:29:42 INFO - 2016-01-05 03:29:42,120 INFO : Browser exited with error code: 0 03:29:42 INFO - 2016-01-05 03:29:42,135 INFO : Completed test v8_7 (00:00:39) 03:29:42 INFO - 2016-01-05 03:29:42,394 INFO : Completed test suite (00:20:06) 03:29:42 INFO - 2016-01-05 03:29:42,394 DEBUG : Working with test: dromaeo_css 03:29:42 INFO - 2016-01-05 03:29:42,395 DEBUG : Generating results file: dromaeo_css 03:29:42 INFO - 2016-01-05 03:29:42,396 DEBUG : Working with test: kraken 03:29:42 INFO - 2016-01-05 03:29:42,396 DEBUG : Generating results file: kraken 03:29:42 INFO - 2016-01-05 03:29:42,396 INFO : javascript benchmark 03:29:42 INFO - 2016-01-05 03:29:42,396 DEBUG : Working with test: v8_7 03:29:42 INFO - 2016-01-05 03:29:42,396 DEBUG : Generating results file: v8_7 03:29:42 INFO - 2016-01-05 03:29:42,397 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:29:42 INFO - 2016-01-05 03:29:42,460 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 03:29:42 INFO - 2016-01-05 03:29:42,460 DEBUG : process_Request line: dromaeo_css 7520.78 graph.html#tests=[[72,52,43]] 03:29:42 INFO - 2016-01-05 03:29:42,460 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:29:42 INFO - 2016-01-05 03:29:42,498 DEBUG : process_Request line: kraken 1498.70 graph.html#tests=[[232,52,43]] 03:29:42 INFO - 2016-01-05 03:29:42,498 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:29:42 INFO - 2016-01-05 03:29:42,533 DEBUG : process_Request line: v8_7 22911.21 graph.html#tests=[[230,52,43]] 03:29:42 INFO - 2016-01-05 03:29:42,534 INFO : javascript benchmark 03:29:42 INFO - 2016-01-05 03:29:42,538 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3332.5167850661646, 3410.8976730698073, 3418.72650187985, 3448.8620455181804, 3449.068751437112, 5629.971850140754, 5643.8589035274135, 5665.3484849242295, 5666.348369937458, 5676.262085928829, 5623.240862483563, 5706.857328566788, 5707.400722924095, 5713.200151978716, 5730.169125476814, 5193.454687257849, 5223.921641175385, 5252.159654455288, 5269.8946021079555, 5321.920171197435, 5027.899442011158, 5124.0776660201145, 5149.588032957355, 5156.793728250885, 5234.450382709818, 5175.327207463025, 5227.032998895197, 5252.658577192489, 5257.921131183035, 5262.236975638531, 5233.345831771009, 5267.051930652481, 5278.894422111574, 5281.313429254211, 5321.680699158024, 4938.851834444937, 4982.77577509013, 4986.152354099775, 5167.379914410295, 5178.508041736029, 5386.542143917772, 5430.8913821723345, 5437.13005919055, 5484.506394424521, 5503.064479038533, 6049.485793707496, 6071.908921366183, 6093.360197179277, 6110.3889611038985, 6112.969435152841, 5950.404959504058, 6112.777056696867, 6127.4791642710425, 6140.478059364959, 6156.353582873823, 5653.406392328788, 5736.942630573724, 5748.45389687979, 5756.33802112754, 5787.189793428924, 6169.81490555284, 6181.629102253789, 6197.845053873689, 6197.938020619736, 6232.750689972441, 5799.6230245034785, 5873.911891321633, 5974.970125149433, 6026.758929642853, 6036.63780173191, 6027.698615069229, 6052.182955300978, 6060.33336333003, 6068.059450785136, 6086.786962456293, 6027.095935609606, 6033.849153771191, 6042.4561789438285, 6046.758129674852, 6055.455009049207, 5810.1575271586225, 5836.591438599257, 5931.288245410492, 6007.429294217042, 6096.329403765582, 4642.442906851199, 4646.62826973848, 4658.860234192912, 4666.463356714022, 4685.4143232095985, 4146.875593732193, 4155.4182414462, 4159.812808423628, 4162.583741625813, 4167.166566686675, 5546.805861794818, 5640.125780504029, 5649.604527683105, 5669.376368599451, 5751.741171647286, 6026.668533230714, 6141.969290153521, 6175.258968923668, 6192.81421557354, 6207.16203312547, 5631.915521267184, 5723.542116630742, 5788.652680839079, 5846.801405711819, 5858.443447872445, 5159.1229490986625, 5181.4300426953005, 5212.270282160501, 5232.869178270497, 5240.0567897778765, 6233.158523599347, 6261.0, 6261.499080073674, 6272.2473303203, 6279.7802076928, 5859.20900678403, 5887.146363777314, 6096.908546371897, 6107.54193435503, 6128.203333566607, 6120.538559592075, 6193.628382297076, 6204.937950620436, 6245.344238854855, 6253.437190652681, 6015.819525414245, 6035.124906888389, 6063.211782468251, 6079.817605471843, 6134.294556125924, 5799.333076696234, 5903.881922361443, 6124.448799608057, 6165.167702360124, 6185.876282474415, 5914.497267732118, 5930.28836539618, 5941.613795103304, 5966.612170208922, 5983.820485385445, 5877.35349111606, 5912.911306330495, 5926.525877929842, 5929.0, 5937.228160339128, 5528.557715382679, 5634.577406694432, 5709.22925405065, 5819.098039803837, 5832.12518122285, 5925.4370834770625, 5956.195913551615, 5968.4926781224085, 6007.249093863267, 6019.909701354396, 5827.970860145672, 5847.26909136358, 5849.795257165979, 5865.120231965239, 5885.3820348862755], "unit": "ms", "name": "dojo.html", "value": 5591.800935934632}, {"lowerIsBetter": false, "replicates": [567.5431277821355, 604.1903848842551, 608.8721368512615, 614.9538784591156, 647.4173244080324, 32659.0, 40901.795491022574, 41501.0, 41598.16803663925, 41600.0, 46415.30377044347, 46966.0, 46996.0, 47142.52857471433, 47202.76398618011, 8925.732228033154, 9004.909950900505, 9025.503597302146, 9052.094790520961, 9103.817923641524, 8944.8658270126, 8985.595648195815, 8995.370324077317, 8997.550122493882, 9046.547672616376, 8909.866352004692, 9058.139476749731, 9095.499747513884, 9103.54482275887, 9104.36269461138, 9024.819503609924, 9054.139856713602, 9061.320400969953, 9151.084891510862, 9153.81692366149, 8959.417637853583, 8990.460572365679, 9071.863922041175, 9098.63605455781, 9099.408538445046, 42963.14073718508, 43272.35091473631, 43516.3472547912, 43557.12885742299, 43792.78103609494, 3641.708663306929, 3745.213505163919, 4230.51349094855, 4320.870373888788, 4381.3208952612395, 31514.52728209079, 31636.525452118236, 31670.366592668248, 31989.52015719766, 32303.676963230537, 4148.751074935513, 4175.561566035583, 4190.559991200941, 4232.068944832132, 4234.661227101825, 283906.0, 286346.0, 286508.9999999979, 287726.0, 288341.0, 57312.42687573071, 58120.709396452745, 64829.0, 64860.0, 65129.348706512326, 57707.42292577105, 58015.129773053435, 58182.7090864543, 58329.4167058324, 58516.414835851094, 15639.218039098227, 15648.139352335731, 15673.529794106194, 15720.29258683362, 15763.133027683587, 12301.692457688629, 12382.5666101686, 12392.876071239352, 12445.75108497843, 12449.315287659265, 20333.288334908208, 20578.691319630216, 20621.793782062286, 20662.58674826525, 20735.0, 8165.918340816635, 8424.789380265542, 8478.321734261244, 8534.231919127309, 8580.14198580137, 1026.6663334416344, 1078.417654466595, 1104.1442881766534, 1123.5619601130404, 1172.3259126002583, 29219.0, 29663.703362966527, 29771.702282976894, 29857.253568660522, 29924.0, 1102.7904698107334, 1179.9056075513938, 1182.2197349749297, 1245.875412458765, 1275.4961790092862, 15205.771913421308, 15313.23433828304, 15378.231088445533, 15651.373945042298, 15717.607059823597, 521637.0, 532344.0, 534613.0, 537618.0, 723332.0, 61976.0, 62561.0, 62714.686426567576, 62780.0, 62851.68574157191, 1474.108164560447, 1481.488886334213, 1486.776983452469, 1513.4551561438093, 1529.6405344743976, 31825.0, 32315.0, 32434.35131297408, 32614.51078233781, 32720.836395817867, 49494.75252623714, 49876.50123498718, 49988.00023999427, 50334.244986324506, 50349.74825125851, 308501.0, 312661.0, 314020.0, 314692.0, 314989.0, 34526.48210276898, 34849.47725784166, 34986.300273994886, 35215.82392088023, 35398.0, 46643.766781165876, 46993.765031174626, 47074.29388559243, 47186.764066180825, 47534.28698569594, 39620.2075958485, 39835.0, 41108.0, 41166.58833411747, 43507.0, 39991.80004100077, 43658.781706091264, 44822.551774481835, 44895.87760306019, 45705.0, 39616.60383396129, 39640.2071958565, 39730.60269397269, 41821.0, 42695.3595696071, 33004.33991320208, 33943.66056339504, 34082.0, 34276.0, 34734.47898281477, 26037.8150420729, 26777.33056673599, 26797.33006674771, 26934.191974240803, 27016.594751078355], "unit": "ms", "name": "ext.html", "value": 20217.144387920904}, {"lowerIsBetter": false, "replicates": [389.830423765662, 389.9415087736839, 393.1135289921227, 395.2628348130737, 395.43255428460157, 15520.844791552096, 15600.0, 16498.670026599477, 16925.153742312898, 19716.901415492903, 11292.04017658498, 12664.556740514085, 12784.0, 15298.0, 18702.0, 4616.861494155164, 5232.92150617741, 5366.785328586851, 5369.62412631116, 5414.133738601825, 4702.553257440538, 5387.595930305243, 5532.474414930575, 5536.280283563131, 5772.971135144339, 5400.837974860741, 5452.890942181154, 5478.671279723209, 5504.4495550444835, 5609.214709940612, 5549.250851135105, 5593.105103183491, 5607.4672906074065, 5626.578006649477, 5637.182608521783, 5401.70290634015, 5408.432114627947, 5412.675239485643, 5440.129579267338, 5585.078462053756, 13666.385012674453, 13923.094998825043, 13964.0, 14008.369623366973, 14560.344784484723, 2239.8656080635214, 2339.9181028663916, 2365.3377054424786, 2400.087966572709, 2455.6193789962585, 10596.947015264952, 10622.840657390145, 10655.467226638637, 11727.237729547553, 14414.495492657707, 1915.2626238898124, 1982.385460507233, 1990.910409031597, 2004.4788355027797, 2039.9796002039939, 64292.35707642911, 64495.355046449404, 65895.67052164709, 66021.66989165024, 66548.0, 11019.669409917715, 11274.098072154373, 11307.151963602599, 11387.829182562267, 11409.315441073562, 14827.40690372373, 14832.406703731729, 14895.404183832741, 14964.775528367083, 14977.850221497863, 7943.086545047394, 8022.3983201260135, 8093.676252949934, 8099.230573095547, 8152.714654987047, 7710.807229819299, 7768.300852923264, 7789.182135875765, 7789.33790627803, 7817.491863028885, 4701.459332176843, 4878.121938051185, 4956.182229932021, 4972.0, 4997.925031124536, 1980.395979226321, 1980.653385657533, 1981.2570286142698, 2014.6675798493377, 2017.788132246093, 932.3380399916135, 940.1820416237916, 970.6554173268529, 998.0468652436905, 1022.539857064324, 17015.91492042532, 17883.73174402385, 18063.458096257134, 18405.171767270505, 18448.446546603624, 1005.4771518810323, 1042.854000439939, 1061.936283822973, 1071.0788721699332, 1119.1550379463454, 9428.622855085858, 9699.0, 9754.658586949565, 9836.852447213298, 9933.50332483373, 656843.0, 658001.0, 658697.0, 663767.6811615911, 691005.0, 85109.57445212734, 85997.0, 86544.0, 87265.12734872696, 87344.12655873488, 1222.8043513037871, 1231.2797013746879, 1235.8331625230837, 1235.932023738685, 1236.6413740015296, 15164.0, 15599.610009749847, 15658.295376707847, 15707.450239241572, 15852.286647100678, 34546.481802772476, 35987.820060899525, 36148.81925590355, 37407.06482337963, 37469.625303746616, 43931.0, 45645.771771140935, 46205.30692039689, 47497.28754068761, 47920.0, 10691.770446398763, 10844.40355780408, 10862.02241798242, 10876.728081798019, 10972.122230221403, 17923.0, 18394.26422943067, 18525.536861578028, 18827.246910123442, 19209.615807684047, 15138.470153544573, 15272.694546108793, 15334.693306133591, 15412.922935385252, 15880.126593037032, 14740.778888316898, 14759.066070541481, 15163.545093647208, 15250.389984400499, 15686.607834804221, 15848.683026339639, 16087.919560402122, 16225.0, 16407.753883691516, 16609.0, 10386.792264154827, 10727.892721073002, 10834.133269338276, 10836.078933290759, 10849.0, 15725.292361843973, 15752.448664297153, 15918.442854500037, 16227.918860405622, 16235.350585976428], "unit": "ms", "name": "jquery.html", "value": 9378.879036710285}, {"lowerIsBetter": false, "replicates": [1585.5164174926647, 1624.407091411635, 1639.573710835183, 1830.8901465912047, 1909.8949557774317, 8027.357811375091, 8253.339732821374, 8260.050094239165, 8263.545504997222, 8405.075441701409, 8288.254057134856, 8334.791630209247, 8431.873521897176, 8465.746027619165, 8489.066202717697, 2457.3979375053136, 2493.0900221419142, 2495.7504249574986, 2496.151308555091, 2497.063601149569, 2463.0, 2464.088287333689, 2470.8641024743633, 2474.64117702933, 2478.10788116278, 2373.5490256851144, 2399.2802159352213, 2411.1801987324307, 2419.370963549481, 2456.533258680854, 2355.811535077207, 2385.49904520051, 2451.8651474168914, 2465.4822487277693, 2469.9753002470106, 2452.865092419916, 2461.1755062054053, 2486.7140278867982, 2491.539065272912, 2492.4765799182014, 8357.247847693738, 8472.0, 8478.491290522588, 8492.0, 8493.787655308604, 4858.854234372974, 4890.413150421937, 4901.1177987962155, 4920.483349248313, 4944.678595891256, 3185.378851124032, 3220.420324341641, 3224.774265801395, 3242.2866969266724, 3256.446404111307, 1049.5329578337644, 1049.5801679328254, 1062.9255952083358, 1118.9384583847884, 1119.5969450997634, 11509.712257193554, 11536.134789890708, 11575.884241157564, 11577.842215778439, 11620.477078531487, 4345.869623911224, 4374.103308821684, 4390.47314322277, 4415.183191109655, 4460.1525710114975, 9417.811643767087, 9434.622615095457, 9440.29197810167, 9442.291828112919, 9475.90524094764, 4942.530459606403, 4958.330625365602, 4975.179095449211, 4993.151164302078, 5023.246513023003, 4540.318952157137, 4565.132624801277, 4588.7246765194195, 4598.149342371672, 4604.861854144381, 3681.77909325436, 3697.9815100924325, 3748.6626203641804, 3752.962470375316, 3782.3569993101237, 1150.8849115088424, 1157.6642773595731, 1159.9536018559163, 1166.2186335155297, 1173.0908545877014, 1159.5941420502925, 1164.016406136813, 1182.4324324324373, 1194.0924897078282, 1210.745743393897, 7393.704251829974, 7418.332350088518, 7437.702491900372, 7454.515456495311, 7512.32389084985, 1224.0574757436902, 1234.7530493901256, 1239.4174737873186, 1239.504198320679, 1241.5592464675092, 6218.968905155445, 6219.346968568326, 6298.086777417248, 6342.270638876496, 6343.492520598341, 10048.648297309559, 10237.48812559369, 10272.743181420376, 10294.897051029393, 10314.123299519475, 9182.265418766483, 10010.599576017023, 10075.899241007643, 10083.042110999444, 10102.595896164217, 7703.268189521987, 7752.9612351939, 7756.728514502078, 7762.728304509315, 7803.7268695595385, 7549.7357592483995, 7568.621568921642, 7618.238176182559, 7653.808654783675, 7790.065192176975, 8967.551622418983, 9060.864087038832, 9103.271738260792, 9113.635454581743, 9243.907560924574, 9194.0, 9424.57589408492, 9486.525673716149, 9520.143187113194, 9610.95194524023, 7255.165655949422, 7358.705651773869, 7364.742234021784, 7372.926270737438, 7392.519486233377, 7867.0, 7898.091719452336, 7943.563104029334, 7974.242446967529, 7997.960010199912, 7482.0, 7608.733694320672, 7631.465797394129, 7648.196939321514, 7736.535807851547, 7311.232320606472, 7430.665620047002, 7665.540067595962, 7739.496932699357, 7779.066512018594, 7561.4706970513735, 7572.129205141479, 7590.924090759243, 7605.049368828896, 7608.087029556488, 6997.825054373681, 7044.0, 7087.0, 7093.1488221413765, 7108.289171082851, 7125.5368401053765, 7164.713411463483, 7196.172440169447, 7234.312740289664, 7244.818879528054], "unit": "ms", "name": "mootools.html", "value": 4799.523272914035}, {"lowerIsBetter": false, "replicates": [364.16424306217226, 365.7220512410567, 372.26106179234216, 372.6217888842825, 381.46404301955755, 6368.617882927016, 6423.64669943153, 6458.935410645898, 6488.318726533711, 6502.447291980176, 6149.13912052313, 6377.8405539861415, 6380.808575742735, 6394.104825324458, 6394.968025159879, 4929.8521044368545, 4977.05435967166, 4980.078685443186, 4984.925226121593, 4992.326035985132, 4971.975140124295, 4980.402351717799, 4990.87522811929, 4995.700257984515, 4997.950020499803, 4726.550977657134, 4855.660103792736, 4861.975690121562, 4885.755712214393, 4918.163912134945, 4846.200376937801, 4858.659893807435, 4859.684120532172, 4867.075255701423, 4876.122297986361, 4207.51613564441, 4210.915781684349, 4248.702590818644, 4262.488501379854, 4285.914281714379, 5972.552058595579, 6037.426444487766, 6047.004488518778, 6049.15311856336, 6080.574359794816, 5677.716114194315, 5679.971600141973, 5686.090225563931, 5694.117411801178, 5698.373178950312, 6713.597184168917, 6749.898751518731, 6774.8306292342595, 6776.898346524806, 6786.524943253974, 4724.574788269072, 4726.83456079039, 4729.834455794065, 4743.952560474386, 4745.715257084586, 6866.793996180073, 6918.446524278046, 6986.650667466606, 7007.054047703597, 7013.754518591825, 4849.854504364875, 4851.248056551241, 4858.198397264482, 4859.416869975555, 4859.586935110555, 4908.558229759339, 4914.70511769295, 4916.06594746997, 4918.286848406961, 4934.062528119646, 5564.33228012641, 5678.176664383641, 5689.516391106802, 5691.658500489983, 5694.800681976111, 6850.931490685129, 6868.0, 6868.690908909111, 6879.862402751917, 6901.482388820858, 1685.9747103793452, 1737.8175291594453, 1746.2229307958091, 1747.7203647416352, 1749.3090229359332, 1165.5221359242669, 1166.8249762535518, 1176.4823477669797, 1186.9762604747857, 1192.7674103549898, 6470.611763294218, 6474.579152355176, 6475.611463312216, 6477.931141361622, 6490.740370385226, 6877.965610171917, 6887.104676392137, 6902.102726645504, 6908.758193463204, 6922.480813938874, 6367.777127800505, 6382.585131966407, 6432.35676432353, 6437.935620643733, 6441.774537891151, 3797.962020379761, 3814.752041117374, 3822.751521151172, 3829.291581057513, 3862.787546684903, 7286.635668216568, 7288.380487658503, 7346.375558077516, 7348.926510734825, 7365.631718414058, 7185.389241914391, 7309.0, 7325.4872158948365, 7325.816854578678, 7333.816654583678, 7292.744753933481, 7339.412846972229, 7350.08123984502, 7355.080614923135, 7357.190709022003, 7034.824129396806, 7089.574625522485, 7093.467989900675, 7095.822604434724, 7096.219415864354, 6831.69257383409, 7021.648917554204, 7029.683664235224, 7042.0, 7046.929530704628, 7309.744158954411, 7314.634268286458, 7314.707411703473, 7331.633418329169, 7360.227176146427, 4752.786124624331, 4782.187028205144, 4784.330193772805, 4784.904301914012, 4789.281607758725, 6870.31296870309, 6910.896336555056, 7054.929450705427, 7081.07945967021, 7092.148942126978, 6833.0, 6895.6207408591, 6913.10129683138, 6913.51605387618, 6934.826629334307, 6882.174139103339, 6894.345037221456, 6901.551399159039, 6909.447244220551, 6912.861742765217, 6659.0, 6792.320767923168, 6803.047573339637, 6811.318868113149, 6818.863622727418, 6883.036374907617, 6907.516473846783, 6944.791656250321, 6954.895676564956, 6959.1996920352785, 6775.796726098225, 6776.356246156607, 6779.457643388419, 6796.286389928986, 6797.354251346114], "unit": "ms", "name": "prototype.html", "value": 5154.126339437329}, {"lowerIsBetter": false, "replicates": [857.524074138853, 921.272194965976, 927.7263207353831, 937.578089859563, 948.7580666929932, 16471.423500177498, 17035.318587256494, 17193.140342982864, 17222.91388543057, 17262.309507619713, 15638.218089095528, 15737.134457604827, 15782.21088945551, 15786.210689465539, 15791.28939197736, 921.2123634292684, 925.2644147902417, 943.3679434778714, 945.9716208513721, 951.0869565217365, 926.2497377124517, 934.850423932171, 939.0797018921461, 944.7024187380987, 946.1153821177221, 982.2780256511459, 986.1469828598283, 986.6300137448457, 988.9258305627071, 991.0683957080357, 965.8164948659733, 967.2165545907767, 975.4829940131706, 978.021978021978, 981.5632043740538, 713.254648891904, 717.1931576975902, 719.0723966083746, 722.4004076616396, 726.6911562585933, 13999.370028348647, 14004.369803358772, 14045.78931316031, 14063.578092657237, 14092.647683807885, 12730.427130779137, 12803.0, 13246.602601921957, 13321.134126281857, 13392.397342119628, 11329.43352832355, 11489.540418383338, 11507.0, 11566.65300041, 11759.47082381295, 3678.5585729712607, 3727.329080765461, 3734.402495600691, 3742.9438558421643, 3747.1006958330076, 49474.25788613174, 49620.0, 50352.0, 50598.49401505975, 50826.49173508291, 10588.153710509812, 10701.464926753632, 10764.13886889047, 10793.29843560166, 10886.455677216107, 19034.0, 19108.713369299472, 19148.329808456638, 19205.423837284903, 19233.422997309823, 7909.644066017043, 7987.201279871966, 8054.194580541899, 8116.6347514362, 8393.748187554384, 4641.791119399568, 4822.083804077284, 4823.3729615150505, 4870.245112007574, 4918.680285781413, 3259.788113772597, 3301.900942971715, 3304.93390132196, 3305.9504107438406, 3308.7353011759, 569.2684899903604, 591.6213623281103, 593.9584229103921, 594.7264258441079, 598.933897662162, 586.3989410853909, 637.7225906730587, 692.1555702043499, 693.1231991530718, 700.1423256510835, 9949.303548751663, 9957.751056223507, 10109.595616175418, 10112.646057387956, 10319.948400258101, 710.2471380336859, 737.6169681846537, 738.6934422214828, 738.9113306403266, 774.5701135869534, 4201.957980420218, 4250.3836943643, 4266.1254442839145, 4299.462567179103, 4723.811047558059, 60111.0, 63527.36472635214, 63815.680921596024, 63901.36098638954, 64032.0, 53247.20129198065, 53346.73326633342, 53547.732261338446, 54774.53514591773, 55207.72396138074, 48484.27273590899, 48512.0, 48694.0, 49657.75171124194, 50782.49217507778, 9254.25965922738, 9455.763605909908, 9461.858072128785, 9521.809563808823, 9803.411795292306, 36824.63175368319, 37398.252034959696, 37738.0, 37770.81114594409, 38468.0, 46366.0, 47227.52772472231, 47516.0, 47638.76180619213, 47913.281300781215, 11957.581484647995, 12025.699357515781, 12143.878561214628, 12175.573854915036, 12325.322107284186, 12689.555865544662, 13269.402876870758, 13313.933430333174, 13717.314134293445, 13760.65598360049, 11840.644780656594, 12030.939845300718, 12122.878771212176, 12125.696857578278, 12408.75182496363, 11926.940365298118, 11980.0, 12083.939580302042, 12184.51261949512, 12339.321337326173, 10322.535485903303, 11361.772764544829, 11449.48477318506, 12152.088593355356, 12205.633830985085, 9591.088846559565, 9940.314380705975, 10020.799584008133, 10265.589376425158, 10497.10774584169, 9438.433693978383, 9855.35940163887, 10246.180305575685, 10284.691459256233, 10317.845232321371], "unit": "ms", "name": "yui.html", "value": 6898.642490572599}], "name": "dromaeo_css", "value": 7520.775996121038}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 113.0, 110.0, 113.0, 120.0, 111.0, 110.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [144.0, 129.0, 146.0, 156.0, 122.0, 155.0, 153.0, 127.0, 161.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.7}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 161.0, 163.0, 160.0, 161.0, 163.0, 163.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 72.0, 159.0, 74.0, 71.0, 71.0, 72.0, 152.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 88.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 133.0, 91.0, 93.0, 93.0, 142.0, 92.0, 93.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 112.0, 114.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.5}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 146.0, 147.0, 147.0, 148.0, 146.0, 145.0, 148.0, 151.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 95.0, 97.0, 96.0, 96.0, 95.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [60.0, 63.0, 62.0, 58.0, 59.0, 60.0, 60.0, 60.0, 61.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 60.0}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 63.0, 64.0, 65.0, 63.0, 63.0, 65.0, 62.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.6}, {"lowerIsBetter": true, "replicates": [89.0, 88.0, 81.0, 81.0, 84.0, 80.0, 82.0, 81.0, 82.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [114.0, 121.0, 112.0, 120.0, 128.0, 121.0, 112.0, 114.0, 112.0, 110.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.4}, {"lowerIsBetter": true, "replicates": [147.0, 156.0, 141.0, 148.0, 146.0, 146.0, 144.0, 147.0, 143.0, 145.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.3}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 65.0, 65.0, 68.0, 63.0, 67.0, 66.0, 64.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1498.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.59032952475576], "unit": "score", "name": "Richards", "value": 213.18877800000007}, {"lowerIsBetter": false, "replicates": [172.77125086385627], "unit": "score", "name": "DeltaBlue", "value": 382.690984}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [925.925925925926], "unit": "score", "name": "RayTrace", "value": 799.1881199999998}, {"lowerIsBetter": false, "replicates": [550.05500550055], "unit": "score", "name": "Earley", "value": 1211.629734}, {"lowerIsBetter": false, "replicates": [11131.868131868132], "unit": "score", "name": "Boyer", "value": 59.869825271470894}, {"lowerIsBetter": false, "replicates": [26552.63157894737], "unit": "score", "name": "RegExp", "value": 34.3086521308226}, {"lowerIsBetter": false, "replicates": [520.6825232678386], "unit": "score", "name": "Splay", "value": 156.50803773584906}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 22911.209591138897}]} 03:29:42 INFO - RETURN: dromaeo_css: 7520.78 03:29:42 INFO - RETURN: kraken: 1498.70 03:29:42 INFO - RETURN: v8_7: 22911.21 03:29:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22911.21"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1498.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7520.78"}}} 03:29:42 INFO - Return code: 0 03:29:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:29:42 INFO - # TBPL SUCCESS # 03:29:42 INFO - Running post-action listener: _resource_record_post_action 03:29:42 INFO - Running post-run listener: _resource_record_post_run 03:29:43 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 299008; Write bytes: 511197184; Read time: 76; Write time: 475424 03:29:43 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 245424128; Read time: 0; Write time: 269084 03:29:43 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 299008; Write bytes: 265482240; Read time: 76; Write time: 206316 03:29:43 INFO - Running post-run listener: _upload_blobber_files 03:29:43 INFO - Blob upload gear active. 03:29:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:29:43 INFO - Copying logs to upload dir... 03:29:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1261.218536 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-01-05 03:29:43.603024) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-05 03:29:43.608049) ========= 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=337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010002 build_url: 'https://queue.taskcluster.net/v1/task/QGJXR7EcTbKHhe2WIEJijQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-05 03:29:43.666385) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 03:29:43.666731) ========= 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=337fe3f4b1febe37b85fccc40000019e-1451992083.178550-130494173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004616 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 03:29:43.716352) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 03:29:43.719145) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 03:29:43.719498) ========= ========= Total master_lag: 0.25 =========