builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1453510385.6 results: success (0) buildid: 20160122143630 builduid: 1d52b401dee44679bd1c28b512ed59b0 revision: 23056818e2a5759d863da75aa6e7c9fd104d9350 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:05.599337) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:05.599960) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:05.600249) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1453509829.459466-1953999587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006333 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.35 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:05.960556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:05.960878) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:06.171714) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-01-22 16:53:06.172026) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1453509829.459466-1953999587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 1.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-01-22 16:53:07.260324) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:07.263724) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:07.264108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:07.264460) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1453509829.459466-1953999587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 16:53:07-- 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% 43.4M=0s 2016-01-22 16:53:07 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156606 ========= master_lag: 0.31 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:07.732097) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:07.732378) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1453509829.459466-1953999587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016367 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:07.790133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:07.790483) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 23056818e2a5759d863da75aa6e7c9fd104d9350 --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 23056818e2a5759d863da75aa6e7c9fd104d9350 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1453509829.459466-1953999587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 16:53:08,060 truncating revision to first 12 chars 2016-01-22 16:53:08,060 Setting DEBUG logging. 2016-01-22 16:53:08,060 attempt 1/10 2016-01-22 16:53:08,060 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/23056818e2a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 16:53:08,304 unpacking tar archive at: mozilla-aurora-23056818e2a5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532130 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:08.349859) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:08.350189) ========= echo 23056818e2a5759d863da75aa6e7c9fd104d9350 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'23056818e2a5759d863da75aa6e7c9fd104d9350'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1453509829.459466-1953999587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23056818e2a5759d863da75aa6e7c9fd104d9350 program finished with exit code 0 elapsedTime=0.004650 script_repo_revision: '23056818e2a5759d863da75aa6e7c9fd104d9350' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:08.403958) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:08.404283) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:08.419474) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-22 16:53:08.419807) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1453509829.459466-1953999587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:53:08 INFO - MultiFileLogger online at 20160122 16:53:08 in /builds/slave/test-pgo 16:53:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:53:08 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:53:08 INFO - {'append_to_log': False, 16:53:08 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:53:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:53:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:53:08 INFO - 'branch': 'Mozilla-Aurora', 16:53:08 INFO - 'buildbot_json_path': 'buildprops.json', 16:53:08 INFO - 'config_files': ('talos/linux_config.py',), 16:53:08 INFO - 'default_actions': ('clobber', 16:53:08 INFO - 'read-buildbot-config', 16:53:08 INFO - 'download-and-extract', 16:53:08 INFO - 'populate-webroot', 16:53:08 INFO - 'create-virtualenv', 16:53:08 INFO - 'install', 16:53:08 INFO - 'run-tests'), 16:53:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:53:08 INFO - 'download_minidump_stackwalk': True, 16:53:08 INFO - 'download_symbols': 'ondemand', 16:53:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:53:08 INFO - 'tooltool.py': '/tools/tooltool.py', 16:53:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:53:08 INFO - '/tools/misc-python/virtualenv.py')}, 16:53:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:53:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:53:08 INFO - 'installer_path': 'installer.exe', 16:53:08 INFO - 'log_level': 'info', 16:53:08 INFO - 'log_name': 'talos', 16:53:08 INFO - 'log_to_console': True, 16:53:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:53:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:53:08 INFO - 'opt_config_files': (), 16:53:08 INFO - 'pip_index': False, 16:53:08 INFO - 'sps_profile': False, 16:53:08 INFO - 'sps_profile_interval': 0, 16:53:08 INFO - 'suite': 'dromaeojs', 16:53:08 INFO - 'system_bits': '32', 16:53:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:53:08 INFO - 'title': 'talos-linux64-ix-032', 16:53:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:53:08 INFO - 'use_talos_json': True, 16:53:08 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:53:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:53:08 INFO - 'work_dir': 'build'} 16:53:08 INFO - ##### 16:53:08 INFO - ##### Running clobber step. 16:53:08 INFO - ##### 16:53:08 INFO - Running pre-action listener: _resource_record_pre_action 16:53:08 INFO - Running main action method: clobber 16:53:08 INFO - rmtree: /builds/slave/test-pgo/build 16:53:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:53:09 INFO - Running post-action listener: _resource_record_post_action 16:53:09 INFO - ##### 16:53:09 INFO - ##### Running read-buildbot-config step. 16:53:09 INFO - ##### 16:53:09 INFO - Running pre-action listener: _resource_record_pre_action 16:53:09 INFO - Running main action method: read_buildbot_config 16:53:09 INFO - Using buildbot properties: 16:53:09 INFO - { 16:53:09 INFO - "properties": { 16:53:09 INFO - "buildnumber": 215, 16:53:09 INFO - "product": "firefox", 16:53:09 INFO - "script_repo_revision": "production", 16:53:09 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 16:53:09 INFO - "repository": "", 16:53:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 16:53:09 INFO - "buildid": "20160122143630", 16:53:09 INFO - "slavename": "talos-linux64-ix-032", 16:53:09 INFO - "pgo_build": "True", 16:53:09 INFO - "basedir": "/builds/slave/test-pgo", 16:53:09 INFO - "project": "", 16:53:09 INFO - "platform": "ubuntu64_hw", 16:53:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:53:09 INFO - "slavebuilddir": "test", 16:53:09 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:53:09 INFO - "branch": "mozilla-aurora", 16:53:09 INFO - "repo_path": "releases/mozilla-aurora", 16:53:09 INFO - "stage_platform": "linux64-pgo", 16:53:09 INFO - "builduid": "1d52b401dee44679bd1c28b512ed59b0", 16:53:09 INFO - "revision": "23056818e2a5759d863da75aa6e7c9fd104d9350" 16:53:09 INFO - }, 16:53:09 INFO - "sourcestamp": { 16:53:09 INFO - "repository": "", 16:53:09 INFO - "hasPatch": false, 16:53:09 INFO - "project": "", 16:53:09 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 16:53:09 INFO - "changes": [ 16:53:09 INFO - { 16:53:09 INFO - "category": null, 16:53:09 INFO - "files": [ 16:53:09 INFO - { 16:53:09 INFO - "url": null, 16:53:09 INFO - "name": "https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 16:53:09 INFO - } 16:53:09 INFO - ], 16:53:09 INFO - "repository": "", 16:53:09 INFO - "rev": "23056818e2a5759d863da75aa6e7c9fd104d9350", 16:53:09 INFO - "who": "kwierso@gmail.com", 16:53:09 INFO - "when": 1453510365, 16:53:09 INFO - "number": 7503817, 16:53:09 INFO - "comments": "Backout changeset 8bbed05c1661 r=bz a=lizzard", 16:53:09 INFO - "project": "", 16:53:09 INFO - "at": "Fri 22 Jan 2016 16:52:45", 16:53:09 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 16:53:09 INFO - "revlink": "", 16:53:09 INFO - "properties": [ 16:53:09 INFO - [ 16:53:09 INFO - "buildid", 16:53:09 INFO - "20160122143630", 16:53:09 INFO - "Change" 16:53:09 INFO - ], 16:53:09 INFO - [ 16:53:09 INFO - "builduid", 16:53:09 INFO - "1d52b401dee44679bd1c28b512ed59b0", 16:53:09 INFO - "Change" 16:53:09 INFO - ], 16:53:09 INFO - [ 16:53:09 INFO - "pgo_build", 16:53:09 INFO - "True", 16:53:09 INFO - "Change" 16:53:09 INFO - ] 16:53:09 INFO - ], 16:53:09 INFO - "revision": "23056818e2a5759d863da75aa6e7c9fd104d9350" 16:53:09 INFO - } 16:53:09 INFO - ], 16:53:09 INFO - "revision": "23056818e2a5759d863da75aa6e7c9fd104d9350" 16:53:09 INFO - } 16:53:09 INFO - } 16:53:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 16:53:09 INFO - Running post-action listener: _resource_record_post_action 16:53:09 INFO - ##### 16:53:09 INFO - ##### Running download-and-extract step. 16:53:09 INFO - ##### 16:53:09 INFO - Running pre-action listener: _resource_record_pre_action 16:53:09 INFO - Running main action method: download_and_extract 16:53:09 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:53: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')]} 16:53:09 INFO - https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:53:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/test_packages.json 16:53:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/test_packages.json 16:53:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:53:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:53:13 INFO - Downloaded 1302 bytes. 16:53:13 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:53:13 INFO - Using the following test package requirements: 16:53:13 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:53:13 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:53:13 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:53:13 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:53:13 INFO - u'jsshell-linux-x86_64.zip'], 16:53:13 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:53:13 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:53:13 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:53:13 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:53:13 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:53:13 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:53:13 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:53:13 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:53:13 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:53:13 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:53:13 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:53:13 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:53:13 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:53: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')]} 16:53:13 INFO - https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:53:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:53:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:53:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/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 16:53:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/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 16:53:15 INFO - Downloaded 23158855 bytes. 16:53:15 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 16:53:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:53:15 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 16:53:16 INFO - Return code: 0 16:53:16 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 16:53: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')]} 16:53:16 INFO - https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:53:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:53:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:53:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/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 16:53:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/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 16:53:21 INFO - Downloaded 23158855 bytes. 16:53:21 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 16:53:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:53:21 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 16:53:22 INFO - Return code: 0 16:53:22 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')]} 16:53:22 INFO - https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:53:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:53:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:53:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/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 16:53:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/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 16:53:23 INFO - Downloaded 11132038 bytes. 16:53:23 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 16:53:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:53:23 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 16:53:23 INFO - Return code: 0 16:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:23 INFO - https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:53:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:53:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:53:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/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 16:53:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/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 16:53:25 INFO - Downloaded 58014398 bytes. 16:53:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:53:25 INFO - mkdir: /builds/slave/test-pgo/properties 16:53:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:53:25 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:53:25 INFO - Contents: 16:53:25 INFO - build_url:https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:53:25 INFO - Running post-action listener: _resource_record_post_action 16:53:25 INFO - Running post-action listener: set_extra_try_arguments 16:53:25 INFO - ##### 16:53:25 INFO - ##### Running populate-webroot step. 16:53:25 INFO - ##### 16:53:25 INFO - Running pre-action listener: _resource_record_pre_action 16:53:25 INFO - Running main action method: populate_webroot 16:53:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:53:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:53:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:53:25 INFO - '--tppagecycles', 16:53:25 INFO - '7'], 16:53:25 INFO - 'tests': ['tsvgm']}}, 16:53:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:53:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:53:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:53:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:53:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:53:25 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:53:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:25 INFO - 'talos_options': ['--e10s'], 16:53:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:25 INFO - 'tests': ['damp', 'tps']}, 16:53:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:25 INFO - 'talos_options': ['--e10s'], 16:53:25 INFO - 'tests': ['damp', 'tps']}, 16:53:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:53:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:53:25 INFO - 'other': {'tests': ['a11yr', 16:53:25 INFO - 'ts_paint', 16:53:25 INFO - 'tpaint', 16:53:25 INFO - 'sessionrestore', 16:53:25 INFO - 'sessionrestore_no_auto_restore']}, 16:53:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:53:25 INFO - 'tests': ['a11yr', 16:53:25 INFO - 'ts_paint', 16:53:25 INFO - 'tpaint', 16:53:25 INFO - 'sessionrestore', 16:53:25 INFO - 'sessionrestore_no_auto_restore']}, 16:53:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:53:25 INFO - 'tests': ['a11yr', 16:53:25 INFO - 'ts_paint', 16:53:25 INFO - 'tpaint', 16:53:25 INFO - 'sessionrestore', 16:53:25 INFO - 'sessionrestore_no_auto_restore']}, 16:53:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:53:25 INFO - 'tests': ['a11yr', 16:53:25 INFO - 'ts_paint', 16:53:25 INFO - 'tpaint', 16:53:25 INFO - 'sessionrestore', 16:53:25 INFO - 'sessionrestore_no_auto_restore']}, 16:53:25 INFO - 'other_l64': {'tests': ['a11yr', 16:53:25 INFO - 'ts_paint', 16:53:25 INFO - 'tpaint', 16:53:25 INFO - 'sessionrestore', 16:53:25 INFO - 'sessionrestore_no_auto_restore']}, 16:53:25 INFO - 'other_nol64': {'tests': ['a11yr', 16:53:25 INFO - 'ts_paint', 16:53:25 INFO - 'tpaint', 16:53:25 INFO - 'sessionrestore', 16:53:25 INFO - 'sessionrestore_no_auto_restore']}, 16:53:25 INFO - 'svgr': {'tests': ['tsvgx', 16:53:25 INFO - 'tsvgr_opacity', 16:53:25 INFO - 'tart', 16:53:25 INFO - 'tscrollx', 16:53:25 INFO - 'cart']}, 16:53:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:53:25 INFO - 'tests': ['tsvgx', 16:53:25 INFO - 'tsvgr_opacity', 16:53:25 INFO - 'tart', 16:53:25 INFO - 'tscrollx', 16:53:25 INFO - 'cart']}, 16:53:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:25 INFO - 'tests': ['tp5o']}, 16:53:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:25 INFO - 'talos_options': ['--e10s'], 16:53:25 INFO - 'tests': ['tp5o']}, 16:53:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:25 INFO - 'talos_options': ['--xperf_path', 16:53:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:25 INFO - 'tests': ['tp5n']}, 16:53:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:25 INFO - 'talos_options': ['--e10s', 16:53:25 INFO - '--xperf_path', 16:53:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:25 INFO - 'tests': ['tp5n']}}, 16:53:25 INFO - 'talos.zip': {'path': '', 16:53:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:53:25 INFO - Running post-action listener: _resource_record_post_action 16:53:25 INFO - ##### 16:53:25 INFO - ##### Running create-virtualenv step. 16:53:25 INFO - ##### 16:53:25 INFO - Running pre-action listener: _resource_record_pre_action 16:53:25 INFO - Running main action method: create_virtualenv 16:53:25 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:53:25 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 16:53:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:53:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:53:25 INFO - Using real prefix '/usr' 16:53:25 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:53:26 INFO - Installing distribute.............................................................................................................................................................................................done. 16:53:28 INFO - Installing pip.................done. 16:53:28 INFO - Return code: 0 16:53:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:53:28 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')]} 16:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:28 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')]} 16:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc197895f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2658350>, '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 0x2659250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26596e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453509829.459466-1953999587', '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 16:53:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:53:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:53:28 INFO - Using env: {'DISPLAY': ':0', 16:53:28 INFO - 'HOME': '/home/cltbld', 16:53:28 INFO - 'LANG': 'en_US.UTF-8', 16:53:28 INFO - 'LANGUAGE': 'en_US:en', 16:53:28 INFO - 'LOGNAME': 'cltbld', 16:53:28 INFO - 'MAIL': '/var/mail/cltbld', 16:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:28 INFO - 'MOZ_NO_REMOTE': '1', 16:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:28 INFO - 'NO_EM_RESTART': '1', 16:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:28 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:28 INFO - 'SHELL': '/bin/bash', 16:53:28 INFO - 'SHLVL': '1', 16:53:28 INFO - 'TERM': 'linux', 16:53:28 INFO - 'TMOUT': '86400', 16:53:28 INFO - 'USER': 'cltbld', 16:53:28 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453509829.459466-1953999587', 16:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:28 INFO - '_': '/tools/buildbot/bin/python'} 16:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:28 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 16:53:28 INFO - Cleaning up... 16:53:28 INFO - Return code: 0 16:53:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:53:28 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')]} 16:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:28 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')]} 16:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc197895f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2658350>, '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 0x2659250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26596e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453509829.459466-1953999587', '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 16:53:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:53:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:53:28 INFO - Using env: {'DISPLAY': ':0', 16:53:28 INFO - 'HOME': '/home/cltbld', 16:53:28 INFO - 'LANG': 'en_US.UTF-8', 16:53:28 INFO - 'LANGUAGE': 'en_US:en', 16:53:28 INFO - 'LOGNAME': 'cltbld', 16:53:28 INFO - 'MAIL': '/var/mail/cltbld', 16:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:28 INFO - 'MOZ_NO_REMOTE': '1', 16:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:28 INFO - 'NO_EM_RESTART': '1', 16:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:28 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:28 INFO - 'SHELL': '/bin/bash', 16:53:28 INFO - 'SHLVL': '1', 16:53:28 INFO - 'TERM': 'linux', 16:53:28 INFO - 'TMOUT': '86400', 16:53:28 INFO - 'USER': 'cltbld', 16:53:28 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453509829.459466-1953999587', 16:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:28 INFO - '_': '/tools/buildbot/bin/python'} 16:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:29 INFO - Downloading/unpacking psutil>=0.7.1 16:53:29 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 16:53:29 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 16:53:29 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 16:53:29 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 16:53:29 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 16:53:29 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 16:53:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:53:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:30 INFO - Installing collected packages: psutil 16:53:30 INFO - Running setup.py install for psutil 16:53:30 INFO - building 'psutil._psutil_linux' extension 16:53:30 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 16:53:31 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 16:53:31 INFO - building 'psutil._psutil_posix' extension 16:53:31 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 16:53:31 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 16:53:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:31 INFO - Successfully installed psutil 16:53:31 INFO - Cleaning up... 16:53:31 INFO - Return code: 0 16:53:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:53:31 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')]} 16:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:31 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')]} 16:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc197895f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2658350>, '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 0x2659250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26596e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453509829.459466-1953999587', '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 16:53:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:53:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:53:31 INFO - Using env: {'DISPLAY': ':0', 16:53:31 INFO - 'HOME': '/home/cltbld', 16:53:31 INFO - 'LANG': 'en_US.UTF-8', 16:53:31 INFO - 'LANGUAGE': 'en_US:en', 16:53:31 INFO - 'LOGNAME': 'cltbld', 16:53:31 INFO - 'MAIL': '/var/mail/cltbld', 16:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:31 INFO - 'MOZ_NO_REMOTE': '1', 16:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:31 INFO - 'NO_EM_RESTART': '1', 16:53:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:31 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:31 INFO - 'SHELL': '/bin/bash', 16:53:31 INFO - 'SHLVL': '1', 16:53:31 INFO - 'TERM': 'linux', 16:53:31 INFO - 'TMOUT': '86400', 16:53:31 INFO - 'USER': 'cltbld', 16:53:31 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453509829.459466-1953999587', 16:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:31 INFO - '_': '/tools/buildbot/bin/python'} 16:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:53:31 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 16:53:31 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 16:53:31 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 16:53:31 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 16:53:31 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 16:53:31 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 16:53:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:53:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:53:33 INFO - Installing collected packages: mozsystemmonitor 16:53:33 INFO - Running setup.py install for mozsystemmonitor 16:53:33 INFO - Successfully installed mozsystemmonitor 16:53:33 INFO - Cleaning up... 16:53:33 INFO - Return code: 0 16:53:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc197895f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2658350>, '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 0x2659250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26596e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453509829.459466-1953999587', '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 16:53:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:53:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:53:33 INFO - Using env: {'DISPLAY': ':0', 16:53:33 INFO - 'HOME': '/home/cltbld', 16:53:33 INFO - 'LANG': 'en_US.UTF-8', 16:53:33 INFO - 'LANGUAGE': 'en_US:en', 16:53:33 INFO - 'LOGNAME': 'cltbld', 16:53:33 INFO - 'MAIL': '/var/mail/cltbld', 16:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:33 INFO - 'MOZ_NO_REMOTE': '1', 16:53:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:33 INFO - 'NO_EM_RESTART': '1', 16:53:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:33 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:33 INFO - 'SHELL': '/bin/bash', 16:53:33 INFO - 'SHLVL': '1', 16:53:33 INFO - 'TERM': 'linux', 16:53:33 INFO - 'TMOUT': '86400', 16:53:33 INFO - 'USER': 'cltbld', 16:53:33 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453509829.459466-1953999587', 16:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:33 INFO - '_': '/tools/buildbot/bin/python'} 16:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:33 INFO - Downloading/unpacking blobuploader==1.2.4 16:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:35 INFO - Downloading blobuploader-1.2.4.tar.gz 16:53:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:53:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:53:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:53:36 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 16:53:36 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 16:53:36 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 16:53:36 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 16:53:36 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 16:53:36 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 16:53:36 INFO - Downloading docopt-0.6.1.tar.gz 16:53:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:53:36 INFO - Installing collected packages: blobuploader, requests, docopt 16:53:36 INFO - Running setup.py install for blobuploader 16:53:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:53:36 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:53:36 INFO - Running setup.py install for requests 16:53:36 INFO - Running setup.py install for docopt 16:53:36 INFO - Successfully installed blobuploader requests docopt 16:53:36 INFO - Cleaning up... 16:53:36 INFO - Return code: 0 16:53:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:53:36 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')]} 16:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:36 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')]} 16:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc197895f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2658350>, '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 0x2659250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26596e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453509829.459466-1953999587', '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 16:53:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:53:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:53:36 INFO - Using env: {'DISPLAY': ':0', 16:53:36 INFO - 'HOME': '/home/cltbld', 16:53:36 INFO - 'LANG': 'en_US.UTF-8', 16:53:36 INFO - 'LANGUAGE': 'en_US:en', 16:53:36 INFO - 'LOGNAME': 'cltbld', 16:53:36 INFO - 'MAIL': '/var/mail/cltbld', 16:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:36 INFO - 'MOZ_NO_REMOTE': '1', 16:53:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:36 INFO - 'NO_EM_RESTART': '1', 16:53:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:36 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:36 INFO - 'SHELL': '/bin/bash', 16:53:36 INFO - 'SHLVL': '1', 16:53:36 INFO - 'TERM': 'linux', 16:53:36 INFO - 'TMOUT': '86400', 16:53:36 INFO - 'USER': 'cltbld', 16:53:36 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453509829.459466-1953999587', 16:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:36 INFO - '_': '/tools/buildbot/bin/python'} 16:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:53:37 INFO - Running setup.py (path:/tmp/pip-4tLDw4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:53:37 INFO - Running setup.py (path:/tmp/pip-UmjKp_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:53:37 INFO - Running setup.py (path:/tmp/pip-1z0tKe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:53:37 INFO - Running setup.py (path:/tmp/pip-7l8hvQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:53:37 INFO - Running setup.py (path:/tmp/pip-kJu2eU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:53:37 INFO - Running setup.py (path:/tmp/pip-lRMmbb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:53:37 INFO - Running setup.py (path:/tmp/pip-uMeJ9d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:53:37 INFO - Running setup.py (path:/tmp/pip-dLPfRN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:53:37 INFO - Running setup.py (path:/tmp/pip-6LqqQ3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:53:37 INFO - Running setup.py (path:/tmp/pip-Xaxjyw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:53:37 INFO - Running setup.py (path:/tmp/pip-o3Fs2h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:53:37 INFO - Running setup.py (path:/tmp/pip-FbuLFK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:53:37 INFO - Running setup.py (path:/tmp/pip-rVwqrv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:53:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:53:38 INFO - Running setup.py (path:/tmp/pip-Hl91PF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:53:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:53:38 INFO - Running setup.py (path:/tmp/pip-XTx2Jz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:53:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:53:38 INFO - Running setup.py (path:/tmp/pip-Ns68Dp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:53:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:53:38 INFO - Running setup.py (path:/tmp/pip-FDnD0z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:53:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:53:38 INFO - Running setup.py install for manifestparser 16:53:38 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:53:38 INFO - Running setup.py install for mozcrash 16:53:38 INFO - Running setup.py install for mozdebug 16:53:38 INFO - Running setup.py install for mozdevice 16:53:38 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:53:38 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:53:38 INFO - Running setup.py install for mozfile 16:53:38 INFO - Running setup.py install for mozhttpd 16:53:38 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:53:38 INFO - Running setup.py install for mozinfo 16:53:39 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:53:39 INFO - Running setup.py install for mozInstall 16:53:39 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:53:39 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:53:39 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:53:39 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:53:39 INFO - Running setup.py install for mozleak 16:53:39 INFO - Running setup.py install for mozlog 16:53:39 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:53:39 INFO - Running setup.py install for moznetwork 16:53:39 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:53:39 INFO - Running setup.py install for mozprocess 16:53:39 INFO - Running setup.py install for mozprofile 16:53:39 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:53:39 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:53:39 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:53:39 INFO - Running setup.py install for mozrunner 16:53:39 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:53:39 INFO - Running setup.py install for mozscreenshot 16:53:39 INFO - Running setup.py install for moztest 16:53:39 INFO - Running setup.py install for mozversion 16:53:40 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:53:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:53:40 INFO - Cleaning up... 16:53:40 INFO - Return code: 0 16:53:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:53:40 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')]} 16:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:40 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')]} 16:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc197895f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2658350>, '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 0x2659250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26596e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453509829.459466-1953999587', '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 16:53:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:53:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:53:40 INFO - Using env: {'DISPLAY': ':0', 16:53:40 INFO - 'HOME': '/home/cltbld', 16:53:40 INFO - 'LANG': 'en_US.UTF-8', 16:53:40 INFO - 'LANGUAGE': 'en_US:en', 16:53:40 INFO - 'LOGNAME': 'cltbld', 16:53:40 INFO - 'MAIL': '/var/mail/cltbld', 16:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:40 INFO - 'MOZ_NO_REMOTE': '1', 16:53:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:40 INFO - 'NO_EM_RESTART': '1', 16:53:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:40 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:40 INFO - 'SHELL': '/bin/bash', 16:53:40 INFO - 'SHLVL': '1', 16:53:40 INFO - 'TERM': 'linux', 16:53:40 INFO - 'TMOUT': '86400', 16:53:40 INFO - 'USER': 'cltbld', 16:53:40 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453509829.459466-1953999587', 16:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:40 INFO - '_': '/tools/buildbot/bin/python'} 16:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:53:40 INFO - Running setup.py (path:/tmp/pip-40jQcd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:53:40 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)) 16:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:53:40 INFO - Running setup.py (path:/tmp/pip-uUQ8Kc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:53:40 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)) 16:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:53:40 INFO - Running setup.py (path:/tmp/pip-2KSCfr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:53:40 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)) 16:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:53:40 INFO - Running setup.py (path:/tmp/pip-dWIOFb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:53:40 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)) 16:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:53:40 INFO - Running setup.py (path:/tmp/pip-nEOPng-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:53:40 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)) 16:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:53:40 INFO - Running setup.py (path:/tmp/pip-3VtTjv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:53:40 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)) 16:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:53:40 INFO - Running setup.py (path:/tmp/pip-UkmjIn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:53:40 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)) 16:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:53:40 INFO - Running setup.py (path:/tmp/pip-3qKfwR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:53:40 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)) 16:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:53:40 INFO - Running setup.py (path:/tmp/pip-uKSipP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:53:40 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)) 16:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:53:40 INFO - Running setup.py (path:/tmp/pip-6iX0sJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:53:41 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)) 16:53:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:53:41 INFO - Running setup.py (path:/tmp/pip-YccC6B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:53:41 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)) 16:53:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:53:41 INFO - Running setup.py (path:/tmp/pip-RAeqwl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:53:41 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)) 16:53:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:53:41 INFO - Running setup.py (path:/tmp/pip-dTm5jC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:53:41 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)) 16:53:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:53:41 INFO - Running setup.py (path:/tmp/pip-VJRXHh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:53:41 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)) 16:53:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:53:41 INFO - Running setup.py (path:/tmp/pip-8BCc8a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:53:41 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)) 16:53:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:53:41 INFO - Running setup.py (path:/tmp/pip-oUUkOG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:53:41 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)) 16:53:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:53:41 INFO - Running setup.py (path:/tmp/pip-f2svgN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:53:41 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)) 16:53:41 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)) 16:53:41 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)) 16:53:41 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)) 16:53:41 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)) 16:53:41 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)) 16:53:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:43 INFO - Downloading blessings-1.6.tar.gz 16:53:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:53:43 INFO - Installing collected packages: blessings 16:53:43 INFO - Running setup.py install for blessings 16:53:43 INFO - Successfully installed blessings 16:53:43 INFO - Cleaning up... 16:53:43 INFO - Return code: 0 16:53:43 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:53:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:53:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:53:43 INFO - Reading from file tmpfile_stdout 16:53:43 INFO - Current package versions: 16:53:43 INFO - argparse == 1.2.1 16:53:43 INFO - blessings == 1.6 16:53:43 INFO - blobuploader == 1.2.4 16:53:43 INFO - docopt == 0.6.1 16:53:43 INFO - manifestparser == 1.1 16:53:43 INFO - mozInstall == 1.12 16:53:43 INFO - mozcrash == 0.16 16:53:43 INFO - mozdebug == 0.1 16:53:43 INFO - mozdevice == 0.47 16:53:43 INFO - mozfile == 1.2 16:53:43 INFO - mozhttpd == 0.7 16:53:43 INFO - mozinfo == 0.9 16:53:43 INFO - mozleak == 0.1 16:53:43 INFO - mozlog == 3.1 16:53:43 INFO - moznetwork == 0.27 16:53:43 INFO - mozprocess == 0.22 16:53:43 INFO - mozprofile == 0.27 16:53:43 INFO - mozrunner == 6.11 16:53:43 INFO - mozscreenshot == 0.1 16:53:43 INFO - mozsystemmonitor == 0.0 16:53:43 INFO - moztest == 0.7 16:53:43 INFO - mozversion == 1.4 16:53:43 INFO - psutil == 3.1.1 16:53:43 INFO - requests == 1.2.3 16:53:43 INFO - wsgiref == 0.1.2 16:53:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:53: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')]} 16:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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')]} 16:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc197895f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2658350>, '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 0x2659250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26596e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453509829.459466-1953999587', '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 16:53:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 16:53:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:53:43 INFO - Using env: {'DISPLAY': ':0', 16:53:43 INFO - 'HOME': '/home/cltbld', 16:53:43 INFO - 'LANG': 'en_US.UTF-8', 16:53:43 INFO - 'LANGUAGE': 'en_US:en', 16:53:43 INFO - 'LOGNAME': 'cltbld', 16:53:43 INFO - 'MAIL': '/var/mail/cltbld', 16:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:43 INFO - 'MOZ_NO_REMOTE': '1', 16:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:43 INFO - 'NO_EM_RESTART': '1', 16:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:43 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:43 INFO - 'SHELL': '/bin/bash', 16:53:43 INFO - 'SHLVL': '1', 16:53:43 INFO - 'TERM': 'linux', 16:53:43 INFO - 'TMOUT': '86400', 16:53:43 INFO - 'USER': 'cltbld', 16:53:43 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453509829.459466-1953999587', 16:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:43 INFO - '_': '/tools/buildbot/bin/python'} 16:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:43 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)) 16:53:43 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)) 16:53:43 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)) 16:53:43 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)) 16:53:43 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)) 16:53:43 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)) 16:53:43 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)) 16:53:43 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)) 16:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 16:53:43 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)) 16:53:43 INFO - Cleaning up... 16:53:43 INFO - Return code: 0 16:53:43 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:53: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')]} 16:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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')]} 16:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc197895f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2658350>, '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 0x2659250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26596e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453509829.459466-1953999587', '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 16:53:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 16:53:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:53:44 INFO - Using env: {'DISPLAY': ':0', 16:53:44 INFO - 'HOME': '/home/cltbld', 16:53:44 INFO - 'LANG': 'en_US.UTF-8', 16:53:44 INFO - 'LANGUAGE': 'en_US:en', 16:53:44 INFO - 'LOGNAME': 'cltbld', 16:53:44 INFO - 'MAIL': '/var/mail/cltbld', 16:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:44 INFO - 'MOZ_NO_REMOTE': '1', 16:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:44 INFO - 'NO_EM_RESTART': '1', 16:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:44 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:44 INFO - 'SHELL': '/bin/bash', 16:53:44 INFO - 'SHLVL': '1', 16:53:44 INFO - 'TERM': 'linux', 16:53:44 INFO - 'TMOUT': '86400', 16:53:44 INFO - 'USER': 'cltbld', 16:53:44 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453509829.459466-1953999587', 16:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:44 INFO - '_': '/tools/buildbot/bin/python'} 16:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:44 INFO - Downloading/unpacking jsonschema 16:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:53:45 INFO - Downloading/unpacking functools32 (from jsonschema) 16:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:46 INFO - Downloading functools32-3.2.3-2.tar.gz 16:53:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:53:46 INFO - warning: no files found matching '*.txt' 16:53:46 INFO - no previously-included directories found matching 'build' 16:53:46 INFO - no previously-included directories found matching 'dist' 16:53:46 INFO - no previously-included directories found matching '.git*' 16:53:46 INFO - Installing collected packages: jsonschema, functools32 16:53:46 INFO - Running setup.py install for functools32 16:53:46 INFO - warning: no files found matching '*.txt' 16:53:46 INFO - no previously-included directories found matching 'build' 16:53:46 INFO - no previously-included directories found matching 'dist' 16:53:46 INFO - no previously-included directories found matching '.git*' 16:53:46 INFO - Successfully installed jsonschema functools32 16:53:46 INFO - Cleaning up... 16:53:46 INFO - Return code: 0 16:53:46 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc197895f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2658350>, '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 0x2659250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26596e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453509829.459466-1953999587', '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 16:53:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 16:53:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:53:46 INFO - Using env: {'DISPLAY': ':0', 16:53:46 INFO - 'HOME': '/home/cltbld', 16:53:46 INFO - 'LANG': 'en_US.UTF-8', 16:53:46 INFO - 'LANGUAGE': 'en_US:en', 16:53:46 INFO - 'LOGNAME': 'cltbld', 16:53:46 INFO - 'MAIL': '/var/mail/cltbld', 16:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:46 INFO - 'MOZ_NO_REMOTE': '1', 16:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:46 INFO - 'NO_EM_RESTART': '1', 16:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:46 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:46 INFO - 'SHELL': '/bin/bash', 16:53:46 INFO - 'SHLVL': '1', 16:53:46 INFO - 'TERM': 'linux', 16:53:46 INFO - 'TMOUT': '86400', 16:53:46 INFO - 'USER': 'cltbld', 16:53:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453509829.459466-1953999587', 16:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:46 INFO - '_': '/tools/buildbot/bin/python'} 16:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:46 INFO - Downloading/unpacking flake8 16:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:53:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:53:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:53:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:53:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:53:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:53:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:53:49 INFO - no previously-included directories found matching 'docs/_build' 16:53:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:53:49 INFO - Running setup.py install for pep8 16:53:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:53:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:53:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:53:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:53:49 INFO - no previously-included directories found matching 'docs/_build' 16:53:49 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:53:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:53:49 INFO - Cleaning up... 16:53:49 INFO - Return code: 0 16:53:49 INFO - Running post-action listener: _resource_record_post_action 16:53:49 INFO - Running post-action listener: _start_resource_monitoring 16:53:49 INFO - Starting resource monitoring. 16:53:49 INFO - ##### 16:53:49 INFO - ##### Running install step. 16:53:49 INFO - ##### 16:53:49 INFO - Running pre-action listener: _resource_record_pre_action 16:53:49 INFO - Running main action method: install 16:53:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:53:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:53:49 INFO - Reading from file tmpfile_stdout 16:53:49 INFO - Detecting whether we're running mozinstall >=1.0... 16:53:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:53:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:53:49 INFO - Reading from file tmpfile_stdout 16:53:49 INFO - Output received: 16:53:49 INFO - Usage: mozinstall [options] installer 16:53:49 INFO - Options: 16:53:49 INFO - -h, --help show this help message and exit 16:53:49 INFO - -d DEST, --destination=DEST 16:53:49 INFO - Directory to install application into. [default: 16:53:49 INFO - "/builds/slave/test-pgo"] 16:53:49 INFO - --app=APP Application being installed. [default: firefox] 16:53:49 INFO - mkdir: /builds/slave/test-pgo/build/application 16:53:49 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'] 16:53:49 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 16:54:04 INFO - Reading from file tmpfile_stdout 16:54:04 INFO - Output received: 16:54:04 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:54:04 INFO - Running post-action listener: _resource_record_post_action 16:54:04 INFO - ##### 16:54:04 INFO - ##### Running run-tests step. 16:54:04 INFO - ##### 16:54:04 INFO - Running pre-action listener: _resource_record_pre_action 16:54:04 INFO - Running main action method: run_tests 16:54:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:54:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:54:04 INFO - Python 2.7.3 16:54:04 INFO - Return code: 0 16:54:04 INFO - grabbing minidump binary from tooltool 16:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:04 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 0x2658350>, '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 0x2659250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26596e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:54:04 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 16:54:04 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 16:54:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:54:04 INFO - Return code: 0 16:54:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:54:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:54:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:54:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:54:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:54:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:54:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:54:05 INFO - Return code: 0 16:54:05 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 16:54:05 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost 16:54:05 INFO - Using env: {'DISPLAY': ':0', 16:54:05 INFO - 'HOME': '/home/cltbld', 16:54:05 INFO - 'LANG': 'en_US.UTF-8', 16:54:05 INFO - 'LANGUAGE': 'en_US:en', 16:54:05 INFO - 'LOGNAME': 'cltbld', 16:54:05 INFO - 'MAIL': '/var/mail/cltbld', 16:54:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:54:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:05 INFO - 'MOZ_NO_REMOTE': '1', 16:54:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:05 INFO - 'NO_EM_RESTART': '1', 16:54:05 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:54:05 INFO - 'PWD': '/builds/slave/test-pgo', 16:54:05 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:54:05 INFO - 'SHELL': '/bin/bash', 16:54:05 INFO - 'SHLVL': '1', 16:54:05 INFO - 'TERM': 'linux', 16:54:05 INFO - 'TMOUT': '86400', 16:54:05 INFO - 'USER': 'cltbld', 16:54:05 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453509829.459466-1953999587', 16:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:05 INFO - '_': '/tools/buildbot/bin/python'} 16:54:05 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost'] with output_timeout 3600 16:54:05 INFO - mozversion INFO | application_buildid: 20160122143630 16:54:05 INFO - mozversion INFO | application_changeset: 23056818e2a5759d863da75aa6e7c9fd104d9350 16:54:05 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 16:54:05 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:54:05 INFO - mozversion INFO | application_name: Firefox 16:54:05 INFO - mozversion INFO | application_remotingname: firefox-dev 16:54:05 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:54:05 INFO - mozversion INFO | application_vendor: Mozilla 16:54:05 INFO - mozversion INFO | application_version: 45.0a2 16:54:05 INFO - mozversion INFO | platform_buildid: 20160122143630 16:54:05 INFO - mozversion INFO | platform_changeset: 23056818e2a5759d863da75aa6e7c9fd104d9350 16:54:05 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:54:05 INFO - mozversion INFO | platform_version: 45.0a2 16:54:05 INFO - 2016-01-22 16:54:05,881 DEBUG : using testdate: 1453510445 16:54:05 INFO - 2016-01-22 16:54:05,881 DEBUG : actual date: 1453510445 16:54:05 INFO - 2016-01-22 16:54:05,929 INFO : starting webserver on 'localhost:47641' 16:54:05 INFO - 2016-01-22 16:54:05,930 INFO : Starting test suite talos-linux64-ix-032 16:54:05 INFO - 2016-01-22 16:54:05,930 INFO : Starting test dromaeo_css 16:54:05 INFO - 2016-01-22 16:54:05,931 DEBUG : operating with platform_type : linux_ 16:54:05 INFO - 2016-01-22 16:54:05,933 INFO : Initialising browser for dromaeo_css test... 16:54:05 INFO - 2016-01-22 16:54:05,942 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpB3uvVZ/profile http://localhost:47641/getInfo.html 16:54:11 INFO - 2016-01-22 16:54:11,053 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:54:11 INFO - 2016-01-22 16:54:11,053 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:54:11 INFO - 2016-01-22 16:54:11,053 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:54:11 INFO - 2016-01-22 16:54:11,053 DEBUG : BROWSER_OUTPUT: __metrics 16:54:11 INFO - 2016-01-22 16:54:11,231 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:54:12 INFO - 2016-01-22 16:54:12,613 INFO : Browser initialized. 16:54:12 INFO - 2016-01-22 16:54:12,613 INFO : Running cycle 1/1 for dromaeo_css test... 16:54:12 INFO - 2016-01-22 16:54:12,614 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpB3uvVZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:54:24 INFO - 2016-01-22 16:54:24,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 137175040 16:54:24 INFO - 2016-01-22 16:54:24,370 DEBUG : BROWSER_OUTPUT: 16:55:15 INFO - 2016-01-22 16:55:15,875 DEBUG : BROWSER_OUTPUT: 1453510515873 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] 16:57:23 INFO - 2016-01-22 16:57:23,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47641/tests/dromaeo/cssquery-ext.html) 16:57:24 INFO - 2016-01-22 16:57:24,232 DEBUG : BROWSER_OUTPUT: RSS: Main: 232611840 16:57:24 INFO - 2016-01-22 16:57:24,232 DEBUG : BROWSER_OUTPUT: 17:00:26 INFO - 2016-01-22 17:00:26,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/dromaeo/cssquery-ext.html (next: http://localhost:47641/tests/dromaeo/cssquery-jquery.html) 17:00:26 INFO - 2016-01-22 17:00:26,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 217079808 17:00:26 INFO - 2016-01-22 17:00:26,922 DEBUG : BROWSER_OUTPUT: 17:03:28 INFO - 2016-01-22 17:03:28,729 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47641/tests/dromaeo/cssquery-mootools.html) 17:03:29 INFO - 2016-01-22 17:03:29,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 216616960 17:03:29 INFO - 2016-01-22 17:03:29,311 DEBUG : BROWSER_OUTPUT: 17:06:31 INFO - 2016-01-22 17:06:31,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47641/tests/dromaeo/cssquery-prototype.html) 17:06:31 INFO - 2016-01-22 17:06:31,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 201650176 17:06:31 INFO - 2016-01-22 17:06:31,614 DEBUG : BROWSER_OUTPUT: 17:09:33 INFO - 2016-01-22 17:09:33,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47641/tests/dromaeo/cssquery-yui.html) 17:09:34 INFO - 2016-01-22 17:09:34,542 DEBUG : BROWSER_OUTPUT: RSS: Main: 200728576 17:09:34 INFO - 2016-01-22 17:09:34,542 DEBUG : BROWSER_OUTPUT: 17:12:36 INFO - 2016-01-22 17:12:36,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/dromaeo/cssquery-yui.html (next: http://localhost:47641/tests/dromaeo/cssquery-dojo.html) 17:12:37 INFO - 2016-01-22 17:12:37,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 232423424 17:12:37 INFO - 2016-01-22 17:12:37,080 DEBUG : BROWSER_OUTPUT: 17:12:37 INFO - 2016-01-22 17:12:37,080 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:12:37 INFO - 2016-01-22 17:12:37,080 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:12:37 INFO - 2016-01-22 17:12:37,080 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:12:37 INFO - 2016-01-22 17:12:37,080 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:12:37 INFO - 2016-01-22 17:12:37,084 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3107.130003598992;3145.9842700786494;3178.189561661777;3179.4912813949772;3197.6322722886866;5168.250603662472;5202.687838729669;5213.1919552469335;5213.817516386923;5235.633505654606;5231.712255825928;5253.711045892474;5293.761780719868;5295.391030031547;5318.361796584406;4714.764261786897;4825.420949486067;4839.4434640016325;4884.242942343943;4921.80312787488;4908.484609116045;4918.213085906255;4934.309196712463;4939.3084968104495;4950.331705219804;4802.447718512381;4806.975965120169;4878.804847806101;4888.315635810989;4888.633352498559;4898.191798353268;4914.213725803854;4916.778744956486;4922.21244600864;4951.331570238044;4751.263554149113;4839.080574690797;4872.171730805771;4873.951260487385;4897.3878265216845;5082.974585127087;5133.101707201225;5140.023395554833;5152.896942061176;5155.252488389163;5589.636673616243;5605.887882242373;5624.072028115356;5625.38120806711;5633;5510.6418082824885;5617.32592088952;5617.354004289518;5683.8010669626365;5715.2855893013375;5298.92051619226;5349.51854333108;5376.112941364631;5378.435264297271;5403.405625381205;5730.914036289459;5748.741306641211;5770.826875193751;5782.421757824184;5783.045797443375;5487.5884308677005;5524.475174858382;5568.49883510486;5578.219049333096;5586.1062230043;5663.716814159276;5686.004949133885;5708.743106560215;5717.942820571824;5718.771249150071;5684.63049901755;5687.573431992617;5688.402717714663;5691.573132015115;5700.059490184156;5489.066858634042;5588.189712491747;5614.438556144353;5677.602567820296;5720.771169153188;4339.652827773771;4399.956000439955;4410.404595379647;4459.576340247671;4484.035932274512;3951.9012024699614;3963.227170701743;3989.900252493711;4007.318755811519;4023.5775243599587;5274.340707411574;5322.38792538863;5350.91973620396;5453.563714902798;5477.3427188737605;5740.339860916049;5770.2498675171955;5809.970950145223;5816.970915145482;5819.272590926134;5499.560035197174;5504;5510.6969116698165;5515.172724091419;5520.447955204528;4928.186849169847;4934.654574179773;5000.399952005782;5039.496050394931;5042;5775.855603609859;5790.783935373619;5796.47831695141;5805.36141024487;5844.649321040666;5565.30433695788;5661.603687741901;5672.319321681424;5735.0537161369575;5754.19441278213;5775.7400916957995;5821.738021789114;5918.053111502139;5919.881602368015;5927.2590926134235;5613.663180209201;5674.2623458950075;5686.09022556389;5696.20253164549;5699.430056994267;5513.448655134454;5637.46444087811;5682.034054210877;5691.146328050825;5693.914591281217;5386.245925570345;5476.123820188751;5477.3427188737605;5478.424765399735;5497.422770609029;5608.355039170548;5620.4660557247;5660.349059858169;5667.433256674464;5680.943190568041;5315.893682126259;5391.973040134774;5429.891402171856;5582.385937546947;5588.469095435927;5641.40765219646;5647.88704225905;5669.31968163823;5670.971645141748;5675.233843431084;5528;5571.554275657856;5575.470330318613;5577.051901176891;5586.832395028156 17:12:37 INFO - 2016-01-22 17:12:37,084 DEBUG : BROWSER_OUTPUT: |1;ext.html;587.8500982249526;628.1112226199928;633.3444884544498;637.9170707807984;646.951478639102;31026.2243443914;31805.68194318056;41317;41707.37438938418;41805;46693;47006.529934700644;47165;47238.291425628646;47267.76366118173;7892.131865494791;9022.50376229307;9213.940396854381;9219;9220.07799220076;8063.193680631919;8175.468594541366;10919.235653504258;11182.049525790277;11190.272632278917;10693.893061069406;10788.51451684672;10789.244752867302;10800.081993030602;10822;8139.389545784031;8351.20663536963;10629.096526795232;10712.303700259497;10736.141108711285;7997;10573.73565660857;10812.621558245502;10828.458577071193;10843.67468975932;39340.60659393398;39750;39788.80105599482;39847.40228896569;39955.800220999;3425.8629654813776;3552.1297282166033;3593.3352329819068;3787.4886890269736;3828.947039564142;32551.837240813882;32604.18489537757;32700;32887.17782055468;33286.6671333286;4275.786210689453;4395.714278571914;4460.197164510387;4469.620082293009;4471.932921006188;283236;283525;284035;284435;285646;59909;60886;65183.67408163023;71434.2856571438;74411.62794186102;63685.68157159184;63782;63994.36005639884;64017.67991160014;64150.35849641537;18051;18190.090495475175;18236.270549177883;18269;18300.81699183018;13198.07613467048;13273;13288.06983511145;13299;13309.93345033288;21489.46276343104;21787.12851485923;21968;21982.032425622336;22092.116315347204;7417.962910185523;7727.845443091107;7739.729109481141;7813.257740514642;7843.6470358833985;1062.8458873463305;1094.6661268313082;1128.4752590045505;1136.85177970249;1159.3855256713955;30211.69788302089;30523.8473807634;30827.0751877444;30969.8451507741;31282.843585781924;1114.5597488991802;1144.9656510304703;1148.4085695866636;1174.7767924094567;1245.2404033539533;13915.512957046454;15877.52367428979;15969;16101;16590.004599724056;360814;366299;367248;368696;368819;49300.75349623229;49370.75314623404;49633;49749.253761192886;49907.750461248186;1426.627387058662;1442.444658806346;1454.2655958740768;1471.595311289404;1474.6165996840684;27757.306067348476;28013.57979630348;28593.857030714713;29002.27494312659;30229.546556802106;47881;48359.27461088157;48396.75801620969;48416;48459.27311090407;273043;273646;274596;275051;307540;27886.581701274903;48210.517894822005;48270;48881;51696.741516292175;48087.75956120337;48335.5166448331;48368.75815620899;49518;49677.751611241714;39770.13099739611;40795.38806917839;40823.38764918588;41515.58484415117;41751.37372939469;36949.44575831311;41086.589134108275;42194.36708449314;43958.340624891294;46414.76792616015;40605.796971014955;41221;41260.58739412567;41607.79196104;41655.7917210412;35049;37662.81168594139;37810;38088.23823523459;38939;28415.857920710263;28456;28892.277693057;29060.7093929058;29097.127086187447 17:12:37 INFO - 2016-01-22 17:12:37,088 DEBUG : BROWSER_OUTPUT: |2;jquery.html;374.3729253500386;375.47996025504705;375.8834761224021;379.11287587046314;380.05745750538665;14392.49626263081;15609.375624974988;17309.134543272834;18048.729269060957;18136.54658633533;17552.12239388032;17669.851459655114;17753.28986840528;18352.724709129372;18357.632847343044;4095.6109169628985;5470.425605311445;5587.245721827542;5601.551875849943;5602.579806514507;4158;5998.25021872266;6081.756729730805;6121.510279177677;6123.724432400552;5573;5606.411326810688;6009.549283803711;6026.578139530235;6039.094135879609;6078.422549857756;6082.513398928075;6093.207882975207;6110.541709371792;6117.66352850593;5270.209468579706;5364.517193452608;5367.409584945653;5394.811181608664;5403.2165336026055;21662.675059874113;21941;21955.890220548794;22013.779862201332;22048.33854984353;2193.4954960359046;2250.22367283287;2302.6661134135625;2368.336865677613;2454.1901172613175;13725.519606813814;13780.310984450838;13864.168149911038;13949.930250348785;14162.221077840715;1847.2333981397703;1869.813018698133;1884.745559349484;1916.7412399326051;1967.5769709512524;59582;61511.38488615146;61654.99999999955;62437.37562624361;62549.68725156345;9697.757556061155;9839.458829764288;9961.501924903725;9988.950055249677;10028.147607453448;12992.025598080181;13030.80453793194;13042.217466952014;13092.607221783363;13097;7700.961495192488;7801.570913599807;7967.203279671987;8014.635682473684;8055.677772889136;8178.282560662208;8191.426600138052;8194.05768336637;8222.301104406073;8257.339412846957;5463.890722185534;5713.428657134254;6056.091586262096;6076.908846367308;6115.6330620162935;1729.184221941911;1762.8765986381086;1764.1620230390463;1766.6378392429522;1789.677857985549;1055.229682331902;1061.5647584490323;1075.3279200499687;1096.4408151842458;1157.0685598093448;15280.770788438182;16248;17326.480205593853;17605.7359139613;17781.644367112585;982.415462799633;1016.7305663999047;1020.8672872526524;1029.4904022508756;1069.0325255643654;9948.950255248677;10379.740506487398;10673.286991062561;10683.358998459962;10685.934969478012;434362;438037;619067;621544;621732;72933;74330.62834685792;84961.99999999876;85387.5730621343;86638.56680716557;1189.4409627475072;1195.2888031621171;1199.8080307150815;1209.2079687804503;1223.3699644682995;16139.435119770751;16206.351745930502;16220.270087846311;16287.837121628632;16554.503364899072;35047;35551.11122221965;36128.27743445064;37039;37725.81137094297;45959.31061034154;47549.28676069931;48202.517974819806;48535.82740692136;49124;9416.10546998034;9585.856212156683;9692.951535242279;9798.80402391934;9862.802743944938;17917.19372628261;17985.640287194445;18080.276788928295;18114.818851811313;18222.81551699135;14487.782683259971;14783.260836957894;14815.481458149345;14863.702725945204;15310.081395116329;11987.160898737005;12121.393930303273;14652.853471465149;15171.696566068838;15325.386984520494;15396.230188490754;15663.295151718428;15680.92159539195;15834.208289585706;15979.440719574759;9698.418094914328;9698.563564639468;9805.215582753506;9815.901840981784;9835.409875407498;10559.63041293551;12837.42231599599;15181.544553663407;15414.92292538575;15652.37390504367 17:12:37 INFO - 2016-01-22 17:12:37,089 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1529.4799768078851;1530.8469153084693;1649.2990479046402;1830.3410772122036;1831.185122620434;7135.429165666747;7618.12391574969;7787.22127787221;7787.7274295399675;7788.571628560427;7511.924880751191;7659.885101723465;7670.846583068335;7673.961630191855;7680.846383072335;1967.5868067705799;2007.8795272283637;2221.7889300516504;2270.2735124760084;2310.722713274409;2290.6793048973072;2294.139697613395;2296.7588403217674;2297.93146187023;2299.3217000984664;2213.7786221377896;2279.658051292303;2280.395695140789;2282.349530383841;2283.5432913417385;2259.152817693365;2275.6245219538837;2276.943076423094;2284.554511870186;2289.6565515172692;2291.9770802291932;2294.7016887804643;2324.6048171810835;2335.334429687548;2336.100601268524;7824.452288339819;7837.804054898616;7885.96057019717;7907.090684571291;7918.4061195409995;4584.770761461914;4671.929921051187;4706.576408123286;4710.175719249118;4712.740799256039;3109.409212249688;3118.5322201669705;3149.055283414966;3172.4289627866974;3201.4237437261286;953.0755167487526;961.4087336288133;976.7899901521207;991.1575161113068;995.1044060345674;10760.677179684622;10761.62334318303;10792.5682972681;10802.243842930999;10808.945955270174;4101.179764047202;4120.958790412057;4134.64855487281;4147.751134931914;4171.853985110507;9264.166225039779;9278.304127190488;9283.58223879927;9284.907150928539;9285.396449230779;4690.015096829636;4715.339852420664;4718.834840780556;4723.126221649006;4726.432828060655;4317.611414972667;4317.784110794448;4320.200762858881;4321.308590625485;4323.654107671442;3243.918902027421;3329.1344250495044;3567.7502574819514;3592.568891733009;3653.725970552219;1126.932384056959;1155.5031336525208;1156.6819124740596;1157.6353448663644;1158.0214718562802;1121.3440137519478;1128.3455595754442;1129.1362107987395;1331.633800704814;1415.9008869379045;7271.563706177646;7321.890171647429;7323.7436689715605;7499.287567681062;7732.033495813023;1193.2303664136757;1202.741410596726;1206.3124019309084;1206.9818952715716;1216.9878301217052;5902.114682797529;5936.257967754031;5947.1079338099635;5952.583319167703;5955.464008239279;9097.1812536872;9407.764805879771;9408.200302974325;9420.34057615974;9539.952300238594;9301.348905576544;9416.435013899189;9419.387739796892;9424.952875235716;9431.151196392357;7250.3112204340505;7483.064616922885;7546.169921308651;7552.055993000875;7562.205968373351;7241.094863142107;7275;7314.743983960536;7317.341439270278;7317.890231646423;8311.542865142233;8363.540005299767;8364.790880228044;8436.45163064399;8562.443441176303;8584.65661373538;8676.305895528469;8846.911530884867;8849.513276769581;8850.291976641724;6676.532642714963;6719.26088130315;6719.932800671931;6721.327867213239;6725.932740672531;6534.967325163344;6966.721331146698;7384.150822655463;7575.734849280248;7586.886196706943;6805.285445028201;7149.356557909813;7214;7238.6380680966795;7328.963355183403;7137.750178743719;7186.640667966476;7200.135983681992;7224.963875180591;7225.169105552929;6823.692933817891;6905.723771049303;7013.438924885895;7026.367626913602;7041.436685065285;6733.663316834237;6772.627505487246;6772.932270677427;6779.254282029072;6796.320367963164;6500.707468164039;6523.445507131947;6530.9020364693615;6532.608043517404;6538.084668146368 17:12:37 INFO - 2016-01-22 17:12:37,090 DEBUG : BROWSER_OUTPUT: |4;prototype.html;357.412057165962;362.6156274349191;363.5437525904989;368.8874893157586;370.527577338893;5992.460678538931;6049.183360246366;6138.907916381252;6141.692915354231;6186.443220110189;5903;6053.848653783658;6099.7865074722395;6111.205543279379;6120.663363515005;4724.338592597039;4733.81064757411;4734.5265473452555;4735.573798358147;4751.643626727992;4503.594676479116;4568.0407114506;4624.699394539361;4745.050989802036;4755.239161734124;4685.062987402516;4689.624830013608;4698.31874378215;4708.058388322332;4728.078024785168;4695;4695.60087392572;4696.319033740106;4705.670603057787;4711.811527538895;4167.270727622684;4169.6455801256625;4176.0603864130635;4179.853705120337;4184.058586817972;5694.886102277973;5815.970920145414;5828;5830.125481177814;5831.4168583141345;5451.400345961941;5452.6183167178315;5454.563634909197;5460.972695136538;5461.989531936604;6441.935580644181;6444.709988050549;6457.1282876811965;6468.547201695883;6470.38531339522;4508.188526065307;4590.609798167126;4601.654875884322;4602.148602508547;4605.125026245037;6695.531312808105;6708.429783468411;6708.932910670928;6711.765088221889;6714.429273511757;4721;4727.527247275314;4729.6689231754135;4730.053989202173;4733.715977041388;4786.521347865186;4790.616750659939;4795.112904112751;4795.400574928134;4796.688215265996;5351.57187425005;5424.077906755861;5438.45615438453;5456.890862182734;5467.261919640877;6490.967545162244;6520.869582608321;6522.21733391996;6529.967350163219;6540.4767618590395;1674.9078800665836;1698.8131305556378;1700.4643537285715;1700.4643537285715;1702.6594681063837;1145.478807142748;1150.1373969522858;1156.7628636129741;1156.785375355873;1182.763447310524;6345.650989195547;6362.745490180433;6366.427021568081;6374.426301632875;6374.74501019954;6489.578177418547;6650.86698266032;6709.4296984755865;6713.295104014008;6730.427913627299;6255.593386429868;6400.199975003125;6408.166938297992;6413.070104834773;6420.133282006963;3624.619414961444;3658.213484100931;3661.761985470936;3667.0465678923674;3671.7613355132366;6821.556598821061;6957.234704182536;6969.23338432772;6973.442124630017;6989.301069893072;6885.51801373899;6960.79117626472;6969.1985421677155;6972;6974.197967233732;6947.687354069079;6959.095317608679;6962;6964.4428445724225;6964.895526567106;6637.70130344126;6701.497387696039;6744.662766861539;6789.524733268624;6790.185177778698;6690.966545167243;6692.297308782702;6695.263521012782;6698.83252918681;6700.49746269022;6955.200151982587;6968.163820341591;6971.128608923885;6972.477064220102;6976.093107895941;4565.201089809337;4639.30410438437;4643.164230438419;4664.997025639368;4666.696664716783;6766.323367663194;6775.457963363017;6776.15298087739;6784.3215678433735;6785.491088168308;6602.306757790555;6604.735810567716;6610.933890661224;6611;6611.933880661132;6468.126802881551;6588.505862060269;6589.242237142598;6600.405963463311;6604.438622717123;6461.2892581816905;6484.254310754323;6493.7727179550375;6498.545101843015;6503.187101612299;6620.470362371095;6625.734970601315;6638.502112341497;6639.236487803964;6639.734410623521;6211.844703882259;6383.616982981036;6473.611583305017;6476.967615161894;6485.221773387224 17:12:37 INFO - 2016-01-22 17:12:37,090 DEBUG : BROWSER_OUTPUT: |5;yui.html;928.6842473558988;933.4912472702376;939.8026414452964;941.9246460283182;946.394307643108;14430.494932677346;14836.332365043572;14843.257837108142;14846.331915063822;14865.479708210214;13688.794668079987;14175.43298268068;14367;14369.35337909794;14419.062760920533;779.4193325972159;787.0830482487895;932.2914584915462;946.7869729310919;947.2422062350126;913.8492148795441;926.8517037274038;934.5981228071927;935.3078721745893;935.9110884465965;973.3235401396032;978.4569563892037;979.5004547680663;979.7844474215661;980.9068138526865;799.1329407592768;810.7891948093479;811.2333844516963;950.919171870385;971.946542940138;722.2488611843677;722.8807246804271;723.0491903147345;723.2731105239201;723.7249845058897;13554.796678049837;13567.728645427134;13595;13622.318884055758;13673.384697688627;12398.690032749164;12612.117151799377;13114.409851556702;13262.82749727607;13582.59252222435;10259.076683098558;10936.890631093667;11357.318560886373;11443.370614616193;11846;3922.882313530599;3932.075962148893;3954.209158168378;3971.940420893689;3995.300822356076;51073.489265107615;51087.489125109016;51238.48761512412;51462.74268628633;51470.742646286904;10409.635662751767;10677.9466102669;11113.333200007864;11136.443177841076;11153.219274650859;18919.43241702751;18948.336808211923;18957.336493222672;18959.14683839203;18969.336073237646;8154.8776768348525;8159.388045896581;8179.182081791773;8192.098869124391;8503.787405314917;4742.264948932921;4749.421896180534;4821.132196204647;4823.710577365299;4855.5387238212315;3224;3258.169166862435;3269.6566860479306;3272.9181770455452;3274.574305340338;587.8736071744595;588.9381614930371;596.4989408896548;598.4823127994254;606.7118118893491;693.143967200507;726.2374506767873;744.2706147975015;744.4863044499278;780.9531428114332;9320.20778233844;9614.90385096154;9692.369995950241;9790.21678265737;9792.902070979342;698.179638924262;717.6304203335286;733.6331834082958;737.3953358246293;754.1937060739498;4245;4440.444944381952;4553.998120413504;4581.404417425713;4592.6555508337005;60619.39380606137;60665.69667151636;61102.69448652728;61272;63075.684621577515;54453.45546544563;55076.449235507935;55470.16794748082;55907;56629.15056274159;47310.76344618186;50377.24434133491;50716.23925641119;50730.6878915289;51198;8761.430507017023;9127.680531181377;9460.290478214023;9868.50657467138;9881.407115572802;37456.2508749818;37514.437283441315;37568.81215593904;37852;39151.804240978614;44463;44715.32927006033;47287.290690638976;49368.25947610717;49642.25536617026;12113.212641178296;12127;12133.150679452354;12257.87742122603;12433.689157771129;12228.633141005785;12608.873911261137;12709.93645031769;12993.220406775623;13777.448902043807;11978.281303121841;12075.456604452997;12331.568395106127;12443.813342799684;13165.868341316847;11698.649040528799;12253.264804111783;12284;12524.874751252371;12955.5465558705;9370;11355.772884542097;11791.88208117908;12886.67783305425;12954;9857.260705447263;9973.950130249303;10072.647457338959;10092.091711745978;10262.692119236435;9882.209423246266;10046.045625665842;10111.775409409918;10133.935936726537;10197.84703229467 17:12:37 INFO - 2016-01-22 17:12:37,091 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:12:37 INFO - 2016-01-22 17:12:37,091 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:12:37 INFO - 2016-01-22 17:12:37,091 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,734 17:12:37 INFO - 2016-01-22 17:12:37,091 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:12:37 INFO - 2016-01-22 17:12:37,091 DEBUG : BROWSER_OUTPUT: __startTimestamp1453511557079__endTimestamp 17:12:37 INFO - 2016-01-22 17:12:37,091 DEBUG : BROWSER_OUTPUT: 17:12:37 INFO - 2016-01-22 17:12:37,091 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:12:37 INFO - 2016-01-22 17:12:37,091 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:12:37 INFO - 2016-01-22 17:12:37,091 DEBUG : BROWSER_OUTPUT: 17:12:37 INFO - 2016-01-22 17:12:37,093 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5292.01 Median:5510.64 stddev:571.76 (10.4%) stddev-sans-first:547.22 17:12:37 INFO - 2016-01-22 17:12:37,093 DEBUG : BROWSER_OUTPUT: Values: 3107.1 3146.0 3178.2 3179.5 3197.6 5168.3 5202.7 5213.2 5213.8 5235.6 5231.7 5253.7 5293.8 5295.4 5318.4 4714.8 4825.4 4839.4 4884.2 4921.8 4908.5 4918.2 4934.3 4939.3 4950.3 4802.4 4807.0 4878.8 4888.3 4888.6 4898.2 4914.2 4916.8 4922.2 4951.3 4751.3 4839.1 4872.2 4874.0 4897.4 5083.0 5133.1 5140.0 5152.9 5155.3 5589.6 5605.9 5624.1 5625.4 5633.0 5510.6 5617.3 5617.4 5683.8 5715.3 5298.9 5349.5 5376.1 5378.4 5403.4 5730.9 5748.7 5770.8 5782.4 5783.0 5487.6 5524.5 5568.5 5578.2 5586.1 5663.7 5686.0 5708.7 5717.9 5718.8 5684.6 5687.6 5688.4 5691.6 5700.1 5489.1 5588.2 5614.4 5677.6 5720.8 4339.7 4400.0 4410.4 4459.6 4484.0 3951.9 3963.2 3989.9 4007.3 4023.6 5274.3 5322.4 5350.9 5453.6 5477.3 5740.3 5770.2 5810.0 5817.0 5819.3 5499.6 5504.0 5510.7 5515.2 5520.4 4928.2 4934.7 5000.4 5039.5 5042.0 5775.9 5790.8 5796.5 5805.4 5844.6 5565.3 5661.6 5672.3 5735.1 5754.2 5775.7 5821.7 5918.1 5919.9 5927.3 5613.7 5674.3 5686.1 5696.2 5699.4 5513.4 5637.5 5682.0 5691.1 5693.9 5386.2 5476.1 5477.3 5478.4 5497.4 5608.4 5620.5 5660.3 5667.4 5680.9 5315.9 5392.0 5429.9 5582.4 5588.5 5641.4 5647.9 5669.3 5671.0 5675.2 5528.0 5571.6 5575.5 5577.1 5586.8 17:12:37 INFO - 2016-01-22 17:12:37,093 DEBUG : BROWSER_OUTPUT: 17:12:37 INFO - 2016-01-22 17:12:37,093 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49978.60 Median:368757.50 stddev:81738.97 (22.2%) stddev-sans-first:81884.15 17:12:37 INFO - 2016-01-22 17:12:37,093 DEBUG : BROWSER_OUTPUT: Values: 587.9 628.1 633.3 637.9 647.0 31026.2 31805.7 41317.0 41707.4 41805.0 46693.0 47006.5 47165.0 47238.3 47267.8 7892.1 9022.5 9213.9 9219.0 9220.1 8063.2 8175.5 10919.2 11182.0 11190.3 10693.9 10788.5 10789.2 10800.1 10822.0 8139.4 8351.2 10629.1 10712.3 10736.1 7997.0 10573.7 10812.6 10828.5 10843.7 39340.6 39750.0 39788.8 39847.4 39955.8 3425.9 3552.1 3593.3 3787.5 3828.9 32551.8 32604.2 32700.0 32887.2 33286.7 4275.8 4395.7 4460.2 4469.6 4471.9 283236.0 283525.0 284035.0 284435.0 285646.0 59909.0 60886.0 65183.7 71434.3 74411.6 63685.7 63782.0 63994.4 64017.7 64150.4 18051.0 18190.1 18236.3 18269.0 18300.8 13198.1 13273.0 13288.1 13299.0 13309.9 21489.5 21787.1 21968.0 21982.0 22092.1 7418.0 7727.8 7739.7 7813.3 7843.6 1062.8 1094.7 1128.5 1136.9 1159.4 30211.7 30523.8 30827.1 30969.8 31282.8 1114.6 1145.0 1148.4 1174.8 1245.2 13915.5 15877.5 15969.0 16101.0 16590.0 360814.0 366299.0 367248.0 368696.0 368819.0 49300.8 49370.8 49633.0 49749.3 49907.8 1426.6 1442.4 1454.3 1471.6 1474.6 27757.3 28013.6 28593.9 29002.3 30229.5 47881.0 48359.3 48396.8 48416.0 48459.3 273043.0 273646.0 274596.0 275051.0 307540.0 27886.6 48210.5 48270.0 48881.0 51696.7 48087.8 48335.5 48368.8 49518.0 49677.8 39770.1 40795.4 40823.4 41515.6 41751.4 36949.4 41086.6 42194.4 43958.3 46414.8 40605.8 41221.0 41260.6 41607.8 41655.8 35049.0 37662.8 37810.0 38088.2 38939.0 28415.9 28456.0 28892.3 29060.7 29097.1 17:12:37 INFO - 2016-01-22 17:12:37,093 DEBUG : BROWSER_OUTPUT: 17:12:37 INFO - 2016-01-22 17:12:37,093 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29620.22 Median:2276.44 stddev:90566.36 (3978.4%) stddev-sans-first:90793.80 17:12:37 INFO - 2016-01-22 17:12:37,095 DEBUG : BROWSER_OUTPUT: Values: 374.4 375.5 375.9 379.1 380.1 14392.5 15609.4 17309.1 18048.7 18136.5 17552.1 17669.9 17753.3 18352.7 18357.6 4095.6 5470.4 5587.2 5601.6 5602.6 4158.0 5998.3 6081.8 6121.5 6123.7 5573.0 5606.4 6009.5 6026.6 6039.1 6078.4 6082.5 6093.2 6110.5 6117.7 5270.2 5364.5 5367.4 5394.8 5403.2 21662.7 21941.0 21955.9 22013.8 22048.3 2193.5 2250.2 2302.7 2368.3 2454.2 13725.5 13780.3 13864.2 13949.9 14162.2 1847.2 1869.8 1884.7 1916.7 1967.6 59582.0 61511.4 61655.0 62437.4 62549.7 9697.8 9839.5 9961.5 9989.0 10028.1 12992.0 13030.8 13042.2 13092.6 13097.0 7701.0 7801.6 7967.2 8014.6 8055.7 8178.3 8191.4 8194.1 8222.3 8257.3 5463.9 5713.4 6056.1 6076.9 6115.6 1729.2 1762.9 1764.2 1766.6 1789.7 1055.2 1061.6 1075.3 1096.4 1157.1 15280.8 16248.0 17326.5 17605.7 17781.6 982.4 1016.7 1020.9 1029.5 1069.0 9949.0 10379.7 10673.3 10683.4 10685.9 434362.0 438037.0 619067.0 621544.0 621732.0 72933.0 74330.6 84962.0 85387.6 86638.6 1189.4 1195.3 1199.8 1209.2 1223.4 16139.4 16206.4 16220.3 16287.8 16554.5 35047.0 35551.1 36128.3 37039.0 37725.8 45959.3 47549.3 48202.5 48535.8 49124.0 9416.1 9585.9 9693.0 9798.8 9862.8 17917.2 17985.6 18080.3 18114.8 18222.8 14487.8 14783.3 14815.5 14863.7 15310.1 11987.2 12121.4 14652.9 15171.7 15325.4 15396.2 15663.3 15680.9 15834.2 15979.4 9698.4 9698.6 9805.2 9815.9 9835.4 10559.6 12837.4 15181.5 15414.9 15652.4 17:12:37 INFO - 2016-01-22 17:12:37,095 DEBUG : BROWSER_OUTPUT: 17:12:37 INFO - 2016-01-22 17:12:37,095 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5495.20 Median:6607.31 stddev:2845.39 (43.1%) stddev-sans-first:2837.76 17:12:37 INFO - 2016-01-22 17:12:37,095 DEBUG : BROWSER_OUTPUT: Values: 1529.5 1530.8 1649.3 1830.3 1831.2 7135.4 7618.1 7787.2 7787.7 7788.6 7511.9 7659.9 7670.8 7674.0 7680.8 1967.6 2007.9 2221.8 2270.3 2310.7 2290.7 2294.1 2296.8 2297.9 2299.3 2213.8 2279.7 2280.4 2282.3 2283.5 2259.2 2275.6 2276.9 2284.6 2289.7 2292.0 2294.7 2324.6 2335.3 2336.1 7824.5 7837.8 7886.0 7907.1 7918.4 4584.8 4671.9 4706.6 4710.2 4712.7 3109.4 3118.5 3149.1 3172.4 3201.4 953.1 961.4 976.8 991.2 995.1 10760.7 10761.6 10792.6 10802.2 10808.9 4101.2 4121.0 4134.6 4147.8 4171.9 9264.2 9278.3 9283.6 9284.9 9285.4 4690.0 4715.3 4718.8 4723.1 4726.4 4317.6 4317.8 4320.2 4321.3 4323.7 3243.9 3329.1 3567.8 3592.6 3653.7 1126.9 1155.5 1156.7 1157.6 1158.0 1121.3 1128.3 1129.1 1331.6 1415.9 7271.6 7321.9 7323.7 7499.3 7732.0 1193.2 1202.7 1206.3 1207.0 1217.0 5902.1 5936.3 5947.1 5952.6 5955.5 9097.2 9407.8 9408.2 9420.3 9540.0 9301.3 9416.4 9419.4 9425.0 9431.2 7250.3 7483.1 7546.2 7552.1 7562.2 7241.1 7275.0 7314.7 7317.3 7317.9 8311.5 8363.5 8364.8 8436.5 8562.4 8584.7 8676.3 8846.9 8849.5 8850.3 6676.5 6719.3 6719.9 6721.3 6725.9 6535.0 6966.7 7384.2 7575.7 7586.9 6805.3 7149.4 7214.0 7238.6 7329.0 7137.8 7186.6 7200.1 7225.0 7225.2 6823.7 6905.7 7013.4 7026.4 7041.4 6733.7 6772.6 6772.9 6779.3 6796.3 6500.7 6523.4 6530.9 6532.6 6538.1 17:12:37 INFO - 2016-01-22 17:12:37,095 DEBUG : BROWSER_OUTPUT: 17:12:37 INFO - 2016-01-22 17:12:37,095 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5478.69 Median:6233.72 stddev:1635.37 (26.2%) stddev-sans-first:1594.14 17:12:37 INFO - 2016-01-22 17:12:37,095 DEBUG : BROWSER_OUTPUT: Values: 357.4 362.6 363.5 368.9 370.5 5992.5 6049.2 6138.9 6141.7 6186.4 5903.0 6053.8 6099.8 6111.2 6120.7 4724.3 4733.8 4734.5 4735.6 4751.6 4503.6 4568.0 4624.7 4745.1 4755.2 4685.1 4689.6 4698.3 4708.1 4728.1 4695.0 4695.6 4696.3 4705.7 4711.8 4167.3 4169.6 4176.1 4179.9 4184.1 5694.9 5816.0 5828.0 5830.1 5831.4 5451.4 5452.6 5454.6 5461.0 5462.0 6441.9 6444.7 6457.1 6468.5 6470.4 4508.2 4590.6 4601.7 4602.1 4605.1 6695.5 6708.4 6708.9 6711.8 6714.4 4721.0 4727.5 4729.7 4730.1 4733.7 4786.5 4790.6 4795.1 4795.4 4796.7 5351.6 5424.1 5438.5 5456.9 5467.3 6491.0 6520.9 6522.2 6530.0 6540.5 1674.9 1698.8 1700.5 1700.5 1702.7 1145.5 1150.1 1156.8 1156.8 1182.8 6345.7 6362.7 6366.4 6374.4 6374.7 6489.6 6650.9 6709.4 6713.3 6730.4 6255.6 6400.2 6408.2 6413.1 6420.1 3624.6 3658.2 3661.8 3667.0 3671.8 6821.6 6957.2 6969.2 6973.4 6989.3 6885.5 6960.8 6969.2 6972.0 6974.2 6947.7 6959.1 6962.0 6964.4 6964.9 6637.7 6701.5 6744.7 6789.5 6790.2 6691.0 6692.3 6695.3 6698.8 6700.5 6955.2 6968.2 6971.1 6972.5 6976.1 4565.2 4639.3 4643.2 4665.0 4666.7 6766.3 6775.5 6776.2 6784.3 6785.5 6602.3 6604.7 6610.9 6611.0 6611.9 6468.1 6588.5 6589.2 6600.4 6604.4 6461.3 6484.3 6493.8 6498.5 6503.2 6620.5 6625.7 6638.5 6639.2 6639.7 6211.8 6383.6 6473.6 6477.0 6485.2 17:12:37 INFO - 2016-01-22 17:12:37,095 DEBUG : BROWSER_OUTPUT: 17:12:37 INFO - 2016-01-22 17:12:37,095 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14793.46 Median:4745.84 stddev:17067.71 (359.6%) stddev-sans-first:17083.83 17:12:37 INFO - 2016-01-22 17:12:37,096 DEBUG : BROWSER_OUTPUT: Values: 928.7 933.5 939.8 941.9 946.4 14430.5 14836.3 14843.3 14846.3 14865.5 13688.8 14175.4 14367.0 14369.4 14419.1 779.4 787.1 932.3 946.8 947.2 913.8 926.9 934.6 935.3 935.9 973.3 978.5 979.5 979.8 980.9 799.1 810.8 811.2 950.9 971.9 722.2 722.9 723.0 723.3 723.7 13554.8 13567.7 13595.0 13622.3 13673.4 12398.7 12612.1 13114.4 13262.8 13582.6 10259.1 10936.9 11357.3 11443.4 11846.0 3922.9 3932.1 3954.2 3971.9 3995.3 51073.5 51087.5 51238.5 51462.7 51470.7 10409.6 10677.9 11113.3 11136.4 11153.2 18919.4 18948.3 18957.3 18959.1 18969.3 8154.9 8159.4 8179.2 8192.1 8503.8 4742.3 4749.4 4821.1 4823.7 4855.5 3224.0 3258.2 3269.7 3272.9 3274.6 587.9 588.9 596.5 598.5 606.7 693.1 726.2 744.3 744.5 781.0 9320.2 9614.9 9692.4 9790.2 9792.9 698.2 717.6 733.6 737.4 754.2 4245.0 4440.4 4554.0 4581.4 4592.7 60619.4 60665.7 61102.7 61272.0 63075.7 54453.5 55076.4 55470.2 55907.0 56629.2 47310.8 50377.2 50716.2 50730.7 51198.0 8761.4 9127.7 9460.3 9868.5 9881.4 37456.3 37514.4 37568.8 37852.0 39151.8 44463.0 44715.3 47287.3 49368.3 49642.3 12113.2 12127.0 12133.2 12257.9 12433.7 12228.6 12608.9 12709.9 12993.2 13777.4 11978.3 12075.5 12331.6 12443.8 13165.9 11698.6 12253.3 12284.0 12524.9 12955.5 9370.0 11355.8 11791.9 12886.7 12954.0 9857.3 9974.0 10072.6 10092.1 10262.7 9882.2 10046.0 10111.8 10133.9 10197.8 17:12:37 INFO - 2016-01-22 17:12:37,096 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:12:37 INFO - 2016-01-22 17:12:37,096 DEBUG : BROWSER_OUTPUT: 17:12:37 INFO - 2016-01-22 17:12:37,821 INFO : Browser exited with error code: 0 17:12:37 INFO - 2016-01-22 17:12:37,840 INFO : Completed test dromaeo_css (00:18:31) 17:12:37 INFO - 2016-01-22 17:12:37,840 INFO : Starting test kraken 17:12:37 INFO - 2016-01-22 17:12:37,840 DEBUG : operating with platform_type : linux_ 17:12:37 INFO - 2016-01-22 17:12:37,840 INFO : Initialising browser for kraken test... 17:12:37 INFO - 2016-01-22 17:12:37,846 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzDcNEw/profile http://localhost:47641/getInfo.html 17:12:42 INFO - 2016-01-22 17:12:42,315 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:12:42 INFO - 2016-01-22 17:12:42,315 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:12:42 INFO - 2016-01-22 17:12:42,315 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:12:42 INFO - 2016-01-22 17:12:42,315 DEBUG : BROWSER_OUTPUT: __metrics 17:12:42 INFO - 2016-01-22 17:12:42,573 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:12:43 INFO - 2016-01-22 17:12:43,965 INFO : Browser initialized. 17:12:43 INFO - 2016-01-22 17:12:43,966 INFO : Running cycle 1/1 for kraken test... 17:12:43 INFO - 2016-01-22 17:12:43,966 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzDcNEw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:12:55 INFO - 2016-01-22 17:12:55,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 137117696 17:12:55 INFO - 2016-01-22 17:12:55,714 DEBUG : BROWSER_OUTPUT: 17:12:58 INFO - 2016-01-22 17:12:58,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47641/tests/kraken/driver.html?testName=audio-beat-detection) 17:12:58 INFO - 2016-01-22 17:12:58,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 169902080 17:12:58 INFO - 2016-01-22 17:12:58,744 DEBUG : BROWSER_OUTPUT: 17:13:01 INFO - 2016-01-22 17:13:01,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47641/tests/kraken/driver.html?testName=audio-dft) 17:13:01 INFO - 2016-01-22 17:13:01,866 DEBUG : BROWSER_OUTPUT: RSS: Main: 168841216 17:13:01 INFO - 2016-01-22 17:13:01,867 DEBUG : BROWSER_OUTPUT: 17:13:04 INFO - 2016-01-22 17:13:04,645 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47641/tests/kraken/driver.html?testName=audio-fft) 17:13:05 INFO - 2016-01-22 17:13:05,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 165445632 17:13:05 INFO - 2016-01-22 17:13:05,210 DEBUG : BROWSER_OUTPUT: 17:13:07 INFO - 2016-01-22 17:13:07,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47641/tests/kraken/driver.html?testName=audio-oscillator) 17:13:07 INFO - 2016-01-22 17:13:07,761 DEBUG : BROWSER_OUTPUT: RSS: Main: 166486016 17:13:07 INFO - 2016-01-22 17:13:07,761 DEBUG : BROWSER_OUTPUT: 17:13:09 INFO - 2016-01-22 17:13:09,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47641/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:13:10 INFO - 2016-01-22 17:13:10,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 164671488 17:13:10 INFO - 2016-01-22 17:13:10,488 DEBUG : BROWSER_OUTPUT: 17:13:13 INFO - 2016-01-22 17:13:13,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47641/tests/kraken/driver.html?testName=imaging-darkroom) 17:13:13 INFO - 2016-01-22 17:13:13,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 165220352 17:13:13 INFO - 2016-01-22 17:13:13,989 DEBUG : BROWSER_OUTPUT: 17:13:17 INFO - 2016-01-22 17:13:17,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47641/tests/kraken/driver.html?testName=imaging-desaturate) 17:13:17 INFO - 2016-01-22 17:13:17,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 167116800 17:13:17 INFO - 2016-01-22 17:13:17,959 DEBUG : BROWSER_OUTPUT: 17:13:20 INFO - 2016-01-22 17:13:20,661 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47641/tests/kraken/driver.html?testName=json-parse-financial) 17:13:21 INFO - 2016-01-22 17:13:21,227 DEBUG : BROWSER_OUTPUT: RSS: Main: 165511168 17:13:21 INFO - 2016-01-22 17:13:21,227 DEBUG : BROWSER_OUTPUT: 17:13:22 INFO - 2016-01-22 17:13:22,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47641/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:13:23 INFO - 2016-01-22 17:13:23,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 171520000 17:13:23 INFO - 2016-01-22 17:13:23,343 DEBUG : BROWSER_OUTPUT: 17:13:25 INFO - 2016-01-22 17:13:25,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47641/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:13:25 INFO - 2016-01-22 17:13:25,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 167444480 17:13:25 INFO - 2016-01-22 17:13:25,713 DEBUG : BROWSER_OUTPUT: 17:13:27 INFO - 2016-01-22 17:13:27,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47641/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:13:28 INFO - 2016-01-22 17:13:28,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 177942528 17:13:28 INFO - 2016-01-22 17:13:28,317 DEBUG : BROWSER_OUTPUT: 17:13:30 INFO - 2016-01-22 17:13:30,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:13:31 INFO - 2016-01-22 17:13:31,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 182513664 17:13:31 INFO - 2016-01-22 17:13:31,264 DEBUG : BROWSER_OUTPUT: 17:13:33 INFO - 2016-01-22 17:13:33,764 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:13:34 INFO - 2016-01-22 17:13:34,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 180760576 17:13:34 INFO - 2016-01-22 17:13:34,339 DEBUG : BROWSER_OUTPUT: 17:13:35 INFO - 2016-01-22 17:13:35,993 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47641/tests/kraken/driver.html?testName=ai-astar) 17:13:36 INFO - 2016-01-22 17:13:36,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 240541696 17:13:36 INFO - 2016-01-22 17:13:36,240 DEBUG : BROWSER_OUTPUT: 17:13:36 INFO - 2016-01-22 17:13:36,243 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:13:36 INFO - 2016-01-22 17:13:36,243 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:13:36 INFO - 2016-01-22 17:13:36,243 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:13:36 INFO - 2016-01-22 17:13:36,244 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:13:36 INFO - 2016-01-22 17:13:36,244 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;104;110;111;111;99;109;108;110 17:13:36 INFO - 2016-01-22 17:13:36,244 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;121;145;158;128;149;147;125;162;122 17:13:36 INFO - 2016-01-22 17:13:36,244 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;161;160;160;161;161;160;162;160;161 17:13:36 INFO - 2016-01-22 17:13:36,244 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;74;71;149;72;71;70;72;145;72 17:13:36 INFO - 2016-01-22 17:13:36,244 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;134;92;93;93;138;91;93;132 17:13:36 INFO - 2016-01-22 17:13:36,244 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;109;109;109;110;109;109 17:13:36 INFO - 2016-01-22 17:13:36,245 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;145;146;145;145;146;145;146;145 17:13:36 INFO - 2016-01-22 17:13:36,245 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;96;95;96;97 17:13:36 INFO - 2016-01-22 17:13:36,245 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;59;58;58;57;57;58;57;55;56 17:13:36 INFO - 2016-01-22 17:13:36,245 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;66;65;65;66;66;67;65;66;67 17:13:36 INFO - 2016-01-22 17:13:36,245 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;80;82;83;81;83;82;83;81;82 17:13:36 INFO - 2016-01-22 17:13:36,245 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;118;128;112;125;110;111;114;112;117 17:13:36 INFO - 2016-01-22 17:13:36,245 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;135;142;143;143;133;145;146;142;142 17:13:36 INFO - 2016-01-22 17:13:36,245 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;66;66;66;65;65;66;64;69 17:13:36 INFO - 2016-01-22 17:13:36,246 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:13:36 INFO - 2016-01-22 17:13:36,246 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:13:36 INFO - 2016-01-22 17:13:36,246 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,909 17:13:36 INFO - 2016-01-22 17:13:36,246 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:13:36 INFO - 2016-01-22 17:13:36,246 DEBUG : BROWSER_OUTPUT: __startTimestamp1453511616242__endTimestamp 17:13:36 INFO - 2016-01-22 17:13:36,246 DEBUG : BROWSER_OUTPUT: 17:13:36 INFO - 2016-01-22 17:13:36,250 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:13:36 INFO - 2016-01-22 17:13:36,250 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:13:36 INFO - 2016-01-22 17:13:36,250 DEBUG : BROWSER_OUTPUT: 17:13:36 INFO - 2016-01-22 17:13:36,250 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:3.78 (3.4%) stddev-sans-first:4.00 17:13:36 INFO - 2016-01-22 17:13:36,250 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 104.0 110.0 111.0 111.0 99.0 109.0 108.0 110.0 17:13:36 INFO - 2016-01-22 17:13:36,250 DEBUG : BROWSER_OUTPUT: 17:13:36 INFO - 2016-01-22 17:13:36,250 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.30 Median:146.50 stddev:15.10 (10.3%) stddev-sans-first:15.87 17:13:36 INFO - 2016-01-22 17:13:36,250 DEBUG : BROWSER_OUTPUT: Values: 146.0 121.0 145.0 158.0 128.0 149.0 147.0 125.0 162.0 122.0 17:13:36 INFO - 2016-01-22 17:13:36,250 DEBUG : BROWSER_OUTPUT: 17:13:36 INFO - 2016-01-22 17:13:36,250 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.71 17:13:36 INFO - 2016-01-22 17:13:36,250 DEBUG : BROWSER_OUTPUT: Values: 159.0 161.0 160.0 160.0 161.0 161.0 160.0 162.0 160.0 161.0 17:13:36 INFO - 2016-01-22 17:13:36,251 DEBUG : BROWSER_OUTPUT: 17:13:36 INFO - 2016-01-22 17:13:36,251 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.10 Median:72.00 stddev:31.62 (43.9%) stddev-sans-first:33.23 17:13:36 INFO - 2016-01-22 17:13:36,251 DEBUG : BROWSER_OUTPUT: Values: 75.0 74.0 71.0 149.0 72.0 71.0 70.0 72.0 145.0 72.0 17:13:36 INFO - 2016-01-22 17:13:36,251 DEBUG : BROWSER_OUTPUT: 17:13:36 INFO - 2016-01-22 17:13:36,251 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.20 Median:93.00 stddev:20.39 (21.9%) stddev-sans-first:21.15 17:13:36 INFO - 2016-01-22 17:13:36,251 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 134.0 92.0 93.0 93.0 138.0 91.0 93.0 132.0 17:13:36 INFO - 2016-01-22 17:13:36,251 DEBUG : BROWSER_OUTPUT: 17:13:36 INFO - 2016-01-22 17:13:36,251 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:13:36 INFO - 2016-01-22 17:13:36,251 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 17:13:36 INFO - 2016-01-22 17:13:36,251 DEBUG : BROWSER_OUTPUT: 17:13:36 INFO - 2016-01-22 17:13:36,251 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 17:13:36 INFO - 2016-01-22 17:13:36,251 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 146.0 145.0 17:13:36 INFO - 2016-01-22 17:13:36,251 DEBUG : BROWSER_OUTPUT: 17:13:36 INFO - 2016-01-22 17:13:36,251 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 17:13:36 INFO - 2016-01-22 17:13:36,251 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 97.0 17:13:36 INFO - 2016-01-22 17:13:36,251 DEBUG : BROWSER_OUTPUT: 17:13:36 INFO - 2016-01-22 17:13:36,252 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.50 stddev:1.33 (2.3%) stddev-sans-first:1.20 17:13:36 INFO - 2016-01-22 17:13:36,252 DEBUG : BROWSER_OUTPUT: Values: 55.0 59.0 58.0 58.0 57.0 57.0 58.0 57.0 55.0 56.0 17:13:36 INFO - 2016-01-22 17:13:36,252 DEBUG : BROWSER_OUTPUT: 17:13:36 INFO - 2016-01-22 17:13:36,252 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.95 (1.4%) stddev-sans-first:0.78 17:13:36 INFO - 2016-01-22 17:13:36,252 DEBUG : BROWSER_OUTPUT: Values: 64.0 66.0 65.0 65.0 66.0 66.0 67.0 65.0 66.0 67.0 17:13:36 INFO - 2016-01-22 17:13:36,252 DEBUG : BROWSER_OUTPUT: 17:13:36 INFO - 2016-01-22 17:13:36,252 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.50 stddev:1.05 (1.3%) stddev-sans-first:1.05 17:13:36 INFO - 2016-01-22 17:13:36,252 DEBUG : BROWSER_OUTPUT: Values: 83.0 80.0 82.0 83.0 81.0 83.0 82.0 83.0 81.0 82.0 17:13:36 INFO - 2016-01-22 17:13:36,252 DEBUG : BROWSER_OUTPUT: 17:13:36 INFO - 2016-01-22 17:13:36,252 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.00 Median:115.50 stddev:6.11 (5.3%) stddev-sans-first:6.38 17:13:36 INFO - 2016-01-22 17:13:36,252 DEBUG : BROWSER_OUTPUT: Values: 113.0 118.0 128.0 112.0 125.0 110.0 111.0 114.0 112.0 117.0 17:13:36 INFO - 2016-01-22 17:13:36,252 DEBUG : BROWSER_OUTPUT: 17:13:36 INFO - 2016-01-22 17:13:36,252 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.60 Median:143.00 stddev:4.27 (3.0%) stddev-sans-first:4.35 17:13:36 INFO - 2016-01-22 17:13:36,252 DEBUG : BROWSER_OUTPUT: Values: 145.0 135.0 142.0 143.0 143.0 133.0 145.0 146.0 142.0 142.0 17:13:36 INFO - 2016-01-22 17:13:36,252 DEBUG : BROWSER_OUTPUT: 17:13:36 INFO - 2016-01-22 17:13:36,252 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.37 (2.1%) stddev-sans-first:1.41 17:13:36 INFO - 2016-01-22 17:13:36,253 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 66.0 66.0 66.0 65.0 65.0 66.0 64.0 69.0 17:13:36 INFO - 2016-01-22 17:13:36,253 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:13:36 INFO - 2016-01-22 17:13:36,253 DEBUG : BROWSER_OUTPUT: 17:13:37 INFO - 2016-01-22 17:13:37,122 INFO : Browser exited with error code: 0 17:13:37 INFO - 2016-01-22 17:13:37,239 INFO : Completed test kraken (00:00:59) 17:13:37 INFO - 2016-01-22 17:13:37,239 INFO : Starting test v8_7 17:13:37 INFO - 2016-01-22 17:13:37,239 DEBUG : operating with platform_type : linux_ 17:13:37 INFO - 2016-01-22 17:13:37,240 INFO : Initialising browser for v8_7 test... 17:13:37 INFO - 2016-01-22 17:13:37,246 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8jRtJ2/profile http://localhost:47641/getInfo.html 17:13:41 INFO - 2016-01-22 17:13:41,793 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:13:41 INFO - 2016-01-22 17:13:41,793 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:13:41 INFO - 2016-01-22 17:13:41,793 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:13:41 INFO - 2016-01-22 17:13:41,794 DEBUG : BROWSER_OUTPUT: __metrics 17:13:42 INFO - 2016-01-22 17:13:42,153 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:13:43 INFO - 2016-01-22 17:13:43,365 INFO : Browser initialized. 17:13:43 INFO - 2016-01-22 17:13:43,366 INFO : Running cycle 1/1 for v8_7 test... 17:13:43 INFO - 2016-01-22 17:13:43,366 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8jRtJ2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:13:55 INFO - 2016-01-22 17:13:55,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 137625600 17:13:55 INFO - 2016-01-22 17:13:55,122 DEBUG : BROWSER_OUTPUT: 17:14:16 INFO - 2016-01-22 17:14:16,503 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47641/tests/v8_7/run.html (next: http://localhost:47641/tests/v8_7/run.html) 17:14:16 INFO - 2016-01-22 17:14:16,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 433360896 17:14:16 INFO - 2016-01-22 17:14:16,754 DEBUG : BROWSER_OUTPUT: 17:14:16 INFO - 2016-01-22 17:14:16,754 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:14:16 INFO - 2016-01-22 17:14:16,755 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:14:16 INFO - 2016-01-22 17:14:16,755 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:14:16 INFO - 2016-01-22 17:14:16,755 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:14:16 INFO - 2016-01-22 17:14:16,755 DEBUG : BROWSER_OUTPUT: |0;Richards;164.79894528675015 17:14:16 INFO - 2016-01-22 17:14:16,755 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.22016282695307 17:14:16 INFO - 2016-01-22 17:14:16,755 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.6420581655481 17:14:16 INFO - 2016-01-22 17:14:16,756 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5128.205128205128 17:14:16 INFO - 2016-01-22 17:14:16,756 DEBUG : BROWSER_OUTPUT: |4;RayTrace;958.7727708533077 17:14:16 INFO - 2016-01-22 17:14:16,756 DEBUG : BROWSER_OUTPUT: |5;Earley;553.4034311012729 17:14:16 INFO - 2016-01-22 17:14:16,756 DEBUG : BROWSER_OUTPUT: |6;Boyer;10989.010989010989 17:14:16 INFO - 2016-01-22 17:14:16,757 DEBUG : BROWSER_OUTPUT: |7;RegExp;24439.024390243903 17:14:16 INFO - 2016-01-22 17:14:16,757 DEBUG : BROWSER_OUTPUT: |8;Splay;518.6721991701245 17:14:16 INFO - 2016-01-22 17:14:16,757 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 17:14:16 INFO - 2016-01-22 17:14:16,757 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:14:16 INFO - 2016-01-22 17:14:16,757 DEBUG : BROWSER_OUTPUT: __startTimestamp1453511656752__endTimestamp 17:14:16 INFO - 2016-01-22 17:14:16,758 DEBUG : BROWSER_OUTPUT: 17:14:16 INFO - 2016-01-22 17:14:16,758 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:14:16 INFO - 2016-01-22 17:14:16,758 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:14:16 INFO - 2016-01-22 17:14:16,758 DEBUG : BROWSER_OUTPUT: 17:14:16 INFO - 2016-01-22 17:14:16,758 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.80 Median:164.80 stddev:0.00 (0.0%) 17:14:16 INFO - 2016-01-22 17:14:16,758 DEBUG : BROWSER_OUTPUT: Values: 164.8 17:14:16 INFO - 2016-01-22 17:14:16,759 DEBUG : BROWSER_OUTPUT: 17:14:16 INFO - 2016-01-22 17:14:16,759 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.22 Median:173.22 stddev:0.00 (0.0%) 17:14:16 INFO - 2016-01-22 17:14:16,759 DEBUG : BROWSER_OUTPUT: Values: 173.2 17:14:16 INFO - 2016-01-22 17:14:16,759 DEBUG : BROWSER_OUTPUT: 17:14:16 INFO - 2016-01-22 17:14:16,759 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 17:14:16 INFO - 2016-01-22 17:14:16,760 DEBUG : BROWSER_OUTPUT: Values: 279.6 17:14:16 INFO - 2016-01-22 17:14:16,760 DEBUG : BROWSER_OUTPUT: 17:14:16 INFO - 2016-01-22 17:14:16,760 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 17:14:16 INFO - 2016-01-22 17:14:16,760 DEBUG : BROWSER_OUTPUT: Values: 5128.2 17:14:16 INFO - 2016-01-22 17:14:16,760 DEBUG : BROWSER_OUTPUT: 17:14:16 INFO - 2016-01-22 17:14:16,760 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:958.77 Median:958.77 stddev:0.00 (0.0%) 17:14:16 INFO - 2016-01-22 17:14:16,761 DEBUG : BROWSER_OUTPUT: Values: 958.8 17:14:16 INFO - 2016-01-22 17:14:16,761 DEBUG : BROWSER_OUTPUT: 17:14:16 INFO - 2016-01-22 17:14:16,761 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:553.40 Median:553.40 stddev:0.00 (0.0%) 17:14:16 INFO - 2016-01-22 17:14:16,761 DEBUG : BROWSER_OUTPUT: Values: 553.4 17:14:16 INFO - 2016-01-22 17:14:16,761 DEBUG : BROWSER_OUTPUT: 17:14:16 INFO - 2016-01-22 17:14:16,761 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10989.01 Median:10989.01 stddev:0.00 (0.0%) 17:14:16 INFO - 2016-01-22 17:14:16,761 DEBUG : BROWSER_OUTPUT: Values: 10989.0 17:14:16 INFO - 2016-01-22 17:14:16,761 DEBUG : BROWSER_OUTPUT: 17:14:16 INFO - 2016-01-22 17:14:16,761 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24439.02 Median:24439.02 stddev:0.00 (0.0%) 17:14:16 INFO - 2016-01-22 17:14:16,762 DEBUG : BROWSER_OUTPUT: Values: 24439.0 17:14:16 INFO - 2016-01-22 17:14:16,762 DEBUG : BROWSER_OUTPUT: 17:14:16 INFO - 2016-01-22 17:14:16,762 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:518.67 Median:518.67 stddev:0.00 (0.0%) 17:14:16 INFO - 2016-01-22 17:14:16,762 DEBUG : BROWSER_OUTPUT: Values: 518.7 17:14:16 INFO - 2016-01-22 17:14:16,762 DEBUG : BROWSER_OUTPUT: 17:14:16 INFO - 2016-01-22 17:14:16,762 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 17:14:16 INFO - 2016-01-22 17:14:16,762 DEBUG : BROWSER_OUTPUT: Values: 4835.7 17:14:16 INFO - 2016-01-22 17:14:16,762 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:14:16 INFO - 2016-01-22 17:14:16,762 DEBUG : BROWSER_OUTPUT: 17:14:17 INFO - 2016-01-22 17:14:17,705 INFO : Browser exited with error code: 0 17:14:17 INFO - 2016-01-22 17:14:17,722 INFO : Completed test v8_7 (00:00:40) 17:14:17 INFO - 2016-01-22 17:14:17,800 INFO : Completed test suite (00:20:11) 17:14:17 INFO - 2016-01-22 17:14:17,800 DEBUG : Working with test: dromaeo_css 17:14:17 INFO - 2016-01-22 17:14:17,800 DEBUG : Generating results file: dromaeo_css 17:14:17 INFO - 2016-01-22 17:14:17,802 DEBUG : Working with test: kraken 17:14:17 INFO - 2016-01-22 17:14:17,802 DEBUG : Generating results file: kraken 17:14:17 INFO - 2016-01-22 17:14:17,802 INFO : javascript benchmark 17:14:17 INFO - 2016-01-22 17:14:17,802 DEBUG : Working with test: v8_7 17:14:17 INFO - 2016-01-22 17:14:17,802 DEBUG : Generating results file: v8_7 17:14:17 INFO - 2016-01-22 17:14:17,803 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:14:17 INFO - 2016-01-22 17:14:17,852 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 17:14:17 INFO - 2016-01-22 17:14:17,852 DEBUG : process_Request line: dromaeo_css 7320.17 graph.html#tests=[[72,52,35]] 17:14:17 INFO - 2016-01-22 17:14:17,852 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:14:17 INFO - 2016-01-22 17:14:17,880 DEBUG : process_Request line: kraken 1479.90 graph.html#tests=[[232,52,35]] 17:14:17 INFO - 2016-01-22 17:14:17,880 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:14:17 INFO - 2016-01-22 17:14:17,909 DEBUG : process_Request line: v8_7 23061.26 graph.html#tests=[[230,52,35]] 17:14:17 INFO - 2016-01-22 17:14:17,910 INFO : javascript benchmark 17:14:17 INFO - 2016-01-22 17:14:17,914 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3107.130003598992, 3145.9842700786494, 3178.189561661777, 3179.4912813949772, 3197.6322722886866, 5168.250603662472, 5202.687838729669, 5213.1919552469335, 5213.817516386923, 5235.633505654606, 5231.712255825928, 5253.711045892474, 5293.761780719868, 5295.391030031547, 5318.361796584406, 4714.764261786897, 4825.420949486067, 4839.4434640016325, 4884.242942343943, 4921.80312787488, 4908.484609116045, 4918.213085906255, 4934.309196712463, 4939.3084968104495, 4950.331705219804, 4802.447718512381, 4806.975965120169, 4878.804847806101, 4888.315635810989, 4888.633352498559, 4898.191798353268, 4914.213725803854, 4916.778744956486, 4922.21244600864, 4951.331570238044, 4751.263554149113, 4839.080574690797, 4872.171730805771, 4873.951260487385, 4897.3878265216845, 5082.974585127087, 5133.101707201225, 5140.023395554833, 5152.896942061176, 5155.252488389163, 5589.636673616243, 5605.887882242373, 5624.072028115356, 5625.38120806711, 5633.0, 5510.6418082824885, 5617.32592088952, 5617.354004289518, 5683.8010669626365, 5715.2855893013375, 5298.92051619226, 5349.51854333108, 5376.112941364631, 5378.435264297271, 5403.405625381205, 5730.914036289459, 5748.741306641211, 5770.826875193751, 5782.421757824184, 5783.045797443375, 5487.5884308677005, 5524.475174858382, 5568.49883510486, 5578.219049333096, 5586.1062230043, 5663.716814159276, 5686.004949133885, 5708.743106560215, 5717.942820571824, 5718.771249150071, 5684.63049901755, 5687.573431992617, 5688.402717714663, 5691.573132015115, 5700.059490184156, 5489.066858634042, 5588.189712491747, 5614.438556144353, 5677.602567820296, 5720.771169153188, 4339.652827773771, 4399.956000439955, 4410.404595379647, 4459.576340247671, 4484.035932274512, 3951.9012024699614, 3963.227170701743, 3989.900252493711, 4007.318755811519, 4023.5775243599587, 5274.340707411574, 5322.38792538863, 5350.91973620396, 5453.563714902798, 5477.3427188737605, 5740.339860916049, 5770.2498675171955, 5809.970950145223, 5816.970915145482, 5819.272590926134, 5499.560035197174, 5504.0, 5510.6969116698165, 5515.172724091419, 5520.447955204528, 4928.186849169847, 4934.654574179773, 5000.399952005782, 5039.496050394931, 5042.0, 5775.855603609859, 5790.783935373619, 5796.47831695141, 5805.36141024487, 5844.649321040666, 5565.30433695788, 5661.603687741901, 5672.319321681424, 5735.0537161369575, 5754.19441278213, 5775.7400916957995, 5821.738021789114, 5918.053111502139, 5919.881602368015, 5927.2590926134235, 5613.663180209201, 5674.2623458950075, 5686.09022556389, 5696.20253164549, 5699.430056994267, 5513.448655134454, 5637.46444087811, 5682.034054210877, 5691.146328050825, 5693.914591281217, 5386.245925570345, 5476.123820188751, 5477.3427188737605, 5478.424765399735, 5497.422770609029, 5608.355039170548, 5620.4660557247, 5660.349059858169, 5667.433256674464, 5680.943190568041, 5315.893682126259, 5391.973040134774, 5429.891402171856, 5582.385937546947, 5588.469095435927, 5641.40765219646, 5647.88704225905, 5669.31968163823, 5670.971645141748, 5675.233843431084, 5528.0, 5571.554275657856, 5575.470330318613, 5577.051901176891, 5586.832395028156], "unit": "ms", "name": "dojo.html", "value": 5255.550446832087}, {"lowerIsBetter": false, "replicates": [587.8500982249526, 628.1112226199928, 633.3444884544498, 637.9170707807984, 646.951478639102, 31026.2243443914, 31805.68194318056, 41317.0, 41707.37438938418, 41805.0, 46693.0, 47006.529934700644, 47165.0, 47238.291425628646, 47267.76366118173, 7892.131865494791, 9022.50376229307, 9213.940396854381, 9219.0, 9220.07799220076, 8063.193680631919, 8175.468594541366, 10919.235653504258, 11182.049525790277, 11190.272632278917, 10693.893061069406, 10788.51451684672, 10789.244752867302, 10800.081993030602, 10822.0, 8139.389545784031, 8351.20663536963, 10629.096526795232, 10712.303700259497, 10736.141108711285, 7997.0, 10573.73565660857, 10812.621558245502, 10828.458577071193, 10843.67468975932, 39340.60659393398, 39750.0, 39788.80105599482, 39847.40228896569, 39955.800220999, 3425.8629654813776, 3552.1297282166033, 3593.3352329819068, 3787.4886890269736, 3828.947039564142, 32551.837240813882, 32604.18489537757, 32700.0, 32887.17782055468, 33286.6671333286, 4275.786210689453, 4395.714278571914, 4460.197164510387, 4469.620082293009, 4471.932921006188, 283236.0, 283525.0, 284035.0, 284435.0, 285646.0, 59909.0, 60886.0, 65183.67408163023, 71434.2856571438, 74411.62794186102, 63685.68157159184, 63782.0, 63994.36005639884, 64017.67991160014, 64150.35849641537, 18051.0, 18190.090495475175, 18236.270549177883, 18269.0, 18300.81699183018, 13198.07613467048, 13273.0, 13288.06983511145, 13299.0, 13309.93345033288, 21489.46276343104, 21787.12851485923, 21968.0, 21982.032425622336, 22092.116315347204, 7417.962910185523, 7727.845443091107, 7739.729109481141, 7813.257740514642, 7843.6470358833985, 1062.8458873463305, 1094.6661268313082, 1128.4752590045505, 1136.85177970249, 1159.3855256713955, 30211.69788302089, 30523.8473807634, 30827.0751877444, 30969.8451507741, 31282.843585781924, 1114.5597488991802, 1144.9656510304703, 1148.4085695866636, 1174.7767924094567, 1245.2404033539533, 13915.512957046454, 15877.52367428979, 15969.0, 16101.0, 16590.004599724056, 360814.0, 366299.0, 367248.0, 368696.0, 368819.0, 49300.75349623229, 49370.75314623404, 49633.0, 49749.253761192886, 49907.750461248186, 1426.627387058662, 1442.444658806346, 1454.2655958740768, 1471.595311289404, 1474.6165996840684, 27757.306067348476, 28013.57979630348, 28593.857030714713, 29002.27494312659, 30229.546556802106, 47881.0, 48359.27461088157, 48396.75801620969, 48416.0, 48459.27311090407, 273043.0, 273646.0, 274596.0, 275051.0, 307540.0, 27886.581701274903, 48210.517894822005, 48270.0, 48881.0, 51696.741516292175, 48087.75956120337, 48335.5166448331, 48368.75815620899, 49518.0, 49677.751611241714, 39770.13099739611, 40795.38806917839, 40823.38764918588, 41515.58484415117, 41751.37372939469, 36949.44575831311, 41086.589134108275, 42194.36708449314, 43958.340624891294, 46414.76792616015, 40605.796971014955, 41221.0, 41260.58739412567, 41607.79196104, 41655.7917210412, 35049.0, 37662.81168594139, 37810.0, 38088.23823523459, 38939.0, 28415.857920710263, 28456.0, 28892.277693057, 29060.7093929058, 29097.127086187447], "unit": "ms", "name": "ext.html", "value": 20300.878714113358}, {"lowerIsBetter": false, "replicates": [374.3729253500386, 375.47996025504705, 375.8834761224021, 379.11287587046314, 380.05745750538665, 14392.49626263081, 15609.375624974988, 17309.134543272834, 18048.729269060957, 18136.54658633533, 17552.12239388032, 17669.851459655114, 17753.28986840528, 18352.724709129372, 18357.632847343044, 4095.6109169628985, 5470.425605311445, 5587.245721827542, 5601.551875849943, 5602.579806514507, 4158.0, 5998.25021872266, 6081.756729730805, 6121.510279177677, 6123.724432400552, 5573.0, 5606.411326810688, 6009.549283803711, 6026.578139530235, 6039.094135879609, 6078.422549857756, 6082.513398928075, 6093.207882975207, 6110.541709371792, 6117.66352850593, 5270.209468579706, 5364.517193452608, 5367.409584945653, 5394.811181608664, 5403.2165336026055, 21662.675059874113, 21941.0, 21955.890220548794, 22013.779862201332, 22048.33854984353, 2193.4954960359046, 2250.22367283287, 2302.6661134135625, 2368.336865677613, 2454.1901172613175, 13725.519606813814, 13780.310984450838, 13864.168149911038, 13949.930250348785, 14162.221077840715, 1847.2333981397703, 1869.813018698133, 1884.745559349484, 1916.7412399326051, 1967.5769709512524, 59582.0, 61511.38488615146, 61654.99999999955, 62437.37562624361, 62549.68725156345, 9697.757556061155, 9839.458829764288, 9961.501924903725, 9988.950055249677, 10028.147607453448, 12992.025598080181, 13030.80453793194, 13042.217466952014, 13092.607221783363, 13097.0, 7700.961495192488, 7801.570913599807, 7967.203279671987, 8014.635682473684, 8055.677772889136, 8178.282560662208, 8191.426600138052, 8194.05768336637, 8222.301104406073, 8257.339412846957, 5463.890722185534, 5713.428657134254, 6056.091586262096, 6076.908846367308, 6115.6330620162935, 1729.184221941911, 1762.8765986381086, 1764.1620230390463, 1766.6378392429522, 1789.677857985549, 1055.229682331902, 1061.5647584490323, 1075.3279200499687, 1096.4408151842458, 1157.0685598093448, 15280.770788438182, 16248.0, 17326.480205593853, 17605.7359139613, 17781.644367112585, 982.415462799633, 1016.7305663999047, 1020.8672872526524, 1029.4904022508756, 1069.0325255643654, 9948.950255248677, 10379.740506487398, 10673.286991062561, 10683.358998459962, 10685.934969478012, 434362.0, 438037.0, 619067.0, 621544.0, 621732.0, 72933.0, 74330.62834685792, 84961.99999999876, 85387.5730621343, 86638.56680716557, 1189.4409627475072, 1195.2888031621171, 1199.8080307150815, 1209.2079687804503, 1223.3699644682995, 16139.435119770751, 16206.351745930502, 16220.270087846311, 16287.837121628632, 16554.503364899072, 35047.0, 35551.11122221965, 36128.27743445064, 37039.0, 37725.81137094297, 45959.31061034154, 47549.28676069931, 48202.517974819806, 48535.82740692136, 49124.0, 9416.10546998034, 9585.856212156683, 9692.951535242279, 9798.80402391934, 9862.802743944938, 17917.19372628261, 17985.640287194445, 18080.276788928295, 18114.818851811313, 18222.81551699135, 14487.782683259971, 14783.260836957894, 14815.481458149345, 14863.702725945204, 15310.081395116329, 11987.160898737005, 12121.393930303273, 14652.853471465149, 15171.696566068838, 15325.386984520494, 15396.230188490754, 15663.295151718428, 15680.92159539195, 15834.208289585706, 15979.440719574759, 9698.418094914328, 9698.563564639468, 9805.215582753506, 9815.901840981784, 9835.409875407498, 10559.63041293551, 12837.42231599599, 15181.544553663407, 15414.92292538575, 15652.37390504367], "unit": "ms", "name": "jquery.html", "value": 9396.434525293294}, {"lowerIsBetter": false, "replicates": [1529.4799768078851, 1530.8469153084693, 1649.2990479046402, 1830.3410772122036, 1831.185122620434, 7135.429165666747, 7618.12391574969, 7787.22127787221, 7787.7274295399675, 7788.571628560427, 7511.924880751191, 7659.885101723465, 7670.846583068335, 7673.961630191855, 7680.846383072335, 1967.5868067705799, 2007.8795272283637, 2221.7889300516504, 2270.2735124760084, 2310.722713274409, 2290.6793048973072, 2294.139697613395, 2296.7588403217674, 2297.93146187023, 2299.3217000984664, 2213.7786221377896, 2279.658051292303, 2280.395695140789, 2282.349530383841, 2283.5432913417385, 2259.152817693365, 2275.6245219538837, 2276.943076423094, 2284.554511870186, 2289.6565515172692, 2291.9770802291932, 2294.7016887804643, 2324.6048171810835, 2335.334429687548, 2336.100601268524, 7824.452288339819, 7837.804054898616, 7885.96057019717, 7907.090684571291, 7918.4061195409995, 4584.770761461914, 4671.929921051187, 4706.576408123286, 4710.175719249118, 4712.740799256039, 3109.409212249688, 3118.5322201669705, 3149.055283414966, 3172.4289627866974, 3201.4237437261286, 953.0755167487526, 961.4087336288133, 976.7899901521207, 991.1575161113068, 995.1044060345674, 10760.677179684622, 10761.62334318303, 10792.5682972681, 10802.243842930999, 10808.945955270174, 4101.179764047202, 4120.958790412057, 4134.64855487281, 4147.751134931914, 4171.853985110507, 9264.166225039779, 9278.304127190488, 9283.58223879927, 9284.907150928539, 9285.396449230779, 4690.015096829636, 4715.339852420664, 4718.834840780556, 4723.126221649006, 4726.432828060655, 4317.611414972667, 4317.784110794448, 4320.200762858881, 4321.308590625485, 4323.654107671442, 3243.918902027421, 3329.1344250495044, 3567.7502574819514, 3592.568891733009, 3653.725970552219, 1126.932384056959, 1155.5031336525208, 1156.6819124740596, 1157.6353448663644, 1158.0214718562802, 1121.3440137519478, 1128.3455595754442, 1129.1362107987395, 1331.633800704814, 1415.9008869379045, 7271.563706177646, 7321.890171647429, 7323.7436689715605, 7499.287567681062, 7732.033495813023, 1193.2303664136757, 1202.741410596726, 1206.3124019309084, 1206.9818952715716, 1216.9878301217052, 5902.114682797529, 5936.257967754031, 5947.1079338099635, 5952.583319167703, 5955.464008239279, 9097.1812536872, 9407.764805879771, 9408.200302974325, 9420.34057615974, 9539.952300238594, 9301.348905576544, 9416.435013899189, 9419.387739796892, 9424.952875235716, 9431.151196392357, 7250.3112204340505, 7483.064616922885, 7546.169921308651, 7552.055993000875, 7562.205968373351, 7241.094863142107, 7275.0, 7314.743983960536, 7317.341439270278, 7317.890231646423, 8311.542865142233, 8363.540005299767, 8364.790880228044, 8436.45163064399, 8562.443441176303, 8584.65661373538, 8676.305895528469, 8846.911530884867, 8849.513276769581, 8850.291976641724, 6676.532642714963, 6719.26088130315, 6719.932800671931, 6721.327867213239, 6725.932740672531, 6534.967325163344, 6966.721331146698, 7384.150822655463, 7575.734849280248, 7586.886196706943, 6805.285445028201, 7149.356557909813, 7214.0, 7238.6380680966795, 7328.963355183403, 7137.750178743719, 7186.640667966476, 7200.135983681992, 7224.963875180591, 7225.169105552929, 6823.692933817891, 6905.723771049303, 7013.438924885895, 7026.367626913602, 7041.436685065285, 6733.663316834237, 6772.627505487246, 6772.932270677427, 6779.254282029072, 6796.320367963164, 6500.707468164039, 6523.445507131947, 6530.9020364693615, 6532.608043517404, 6538.084668146368], "unit": "ms", "name": "mootools.html", "value": 4521.845007101294}, {"lowerIsBetter": false, "replicates": [357.412057165962, 362.6156274349191, 363.5437525904989, 368.8874893157586, 370.527577338893, 5992.460678538931, 6049.183360246366, 6138.907916381252, 6141.692915354231, 6186.443220110189, 5903.0, 6053.848653783658, 6099.7865074722395, 6111.205543279379, 6120.663363515005, 4724.338592597039, 4733.81064757411, 4734.5265473452555, 4735.573798358147, 4751.643626727992, 4503.594676479116, 4568.0407114506, 4624.699394539361, 4745.050989802036, 4755.239161734124, 4685.062987402516, 4689.624830013608, 4698.31874378215, 4708.058388322332, 4728.078024785168, 4695.0, 4695.60087392572, 4696.319033740106, 4705.670603057787, 4711.811527538895, 4167.270727622684, 4169.6455801256625, 4176.0603864130635, 4179.853705120337, 4184.058586817972, 5694.886102277973, 5815.970920145414, 5828.0, 5830.125481177814, 5831.4168583141345, 5451.400345961941, 5452.6183167178315, 5454.563634909197, 5460.972695136538, 5461.989531936604, 6441.935580644181, 6444.709988050549, 6457.1282876811965, 6468.547201695883, 6470.38531339522, 4508.188526065307, 4590.609798167126, 4601.654875884322, 4602.148602508547, 4605.125026245037, 6695.531312808105, 6708.429783468411, 6708.932910670928, 6711.765088221889, 6714.429273511757, 4721.0, 4727.527247275314, 4729.6689231754135, 4730.053989202173, 4733.715977041388, 4786.521347865186, 4790.616750659939, 4795.112904112751, 4795.400574928134, 4796.688215265996, 5351.57187425005, 5424.077906755861, 5438.45615438453, 5456.890862182734, 5467.261919640877, 6490.967545162244, 6520.869582608321, 6522.21733391996, 6529.967350163219, 6540.4767618590395, 1674.9078800665836, 1698.8131305556378, 1700.4643537285715, 1700.4643537285715, 1702.6594681063837, 1145.478807142748, 1150.1373969522858, 1156.7628636129741, 1156.785375355873, 1182.763447310524, 6345.650989195547, 6362.745490180433, 6366.427021568081, 6374.426301632875, 6374.74501019954, 6489.578177418547, 6650.86698266032, 6709.4296984755865, 6713.295104014008, 6730.427913627299, 6255.593386429868, 6400.199975003125, 6408.166938297992, 6413.070104834773, 6420.133282006963, 3624.619414961444, 3658.213484100931, 3661.761985470936, 3667.0465678923674, 3671.7613355132366, 6821.556598821061, 6957.234704182536, 6969.23338432772, 6973.442124630017, 6989.301069893072, 6885.51801373899, 6960.79117626472, 6969.1985421677155, 6972.0, 6974.197967233732, 6947.687354069079, 6959.095317608679, 6962.0, 6964.4428445724225, 6964.895526567106, 6637.70130344126, 6701.497387696039, 6744.662766861539, 6789.524733268624, 6790.185177778698, 6690.966545167243, 6692.297308782702, 6695.263521012782, 6698.83252918681, 6700.49746269022, 6955.200151982587, 6968.163820341591, 6971.128608923885, 6972.477064220102, 6976.093107895941, 4565.201089809337, 4639.30410438437, 4643.164230438419, 4664.997025639368, 4666.696664716783, 6766.323367663194, 6775.457963363017, 6776.15298087739, 6784.3215678433735, 6785.491088168308, 6602.306757790555, 6604.735810567716, 6610.933890661224, 6611.0, 6611.933880661132, 6468.126802881551, 6588.505862060269, 6589.242237142598, 6600.405963463311, 6604.438622717123, 6461.2892581816905, 6484.254310754323, 6493.7727179550375, 6498.545101843015, 6503.187101612299, 6620.470362371095, 6625.734970601315, 6638.502112341497, 6639.236487803964, 6639.734410623521, 6211.844703882259, 6383.616982981036, 6473.611583305017, 6476.967615161894, 6485.221773387224], "unit": "ms", "name": "prototype.html", "value": 4956.632524288671}, {"lowerIsBetter": false, "replicates": [928.6842473558988, 933.4912472702376, 939.8026414452964, 941.9246460283182, 946.394307643108, 14430.494932677346, 14836.332365043572, 14843.257837108142, 14846.331915063822, 14865.479708210214, 13688.794668079987, 14175.43298268068, 14367.0, 14369.35337909794, 14419.062760920533, 779.4193325972159, 787.0830482487895, 932.2914584915462, 946.7869729310919, 947.2422062350126, 913.8492148795441, 926.8517037274038, 934.5981228071927, 935.3078721745893, 935.9110884465965, 973.3235401396032, 978.4569563892037, 979.5004547680663, 979.7844474215661, 980.9068138526865, 799.1329407592768, 810.7891948093479, 811.2333844516963, 950.919171870385, 971.946542940138, 722.2488611843677, 722.8807246804271, 723.0491903147345, 723.2731105239201, 723.7249845058897, 13554.796678049837, 13567.728645427134, 13595.0, 13622.318884055758, 13673.384697688627, 12398.690032749164, 12612.117151799377, 13114.409851556702, 13262.82749727607, 13582.59252222435, 10259.076683098558, 10936.890631093667, 11357.318560886373, 11443.370614616193, 11846.0, 3922.882313530599, 3932.075962148893, 3954.209158168378, 3971.940420893689, 3995.300822356076, 51073.489265107615, 51087.489125109016, 51238.48761512412, 51462.74268628633, 51470.742646286904, 10409.635662751767, 10677.9466102669, 11113.333200007864, 11136.443177841076, 11153.219274650859, 18919.43241702751, 18948.336808211923, 18957.336493222672, 18959.14683839203, 18969.336073237646, 8154.8776768348525, 8159.388045896581, 8179.182081791773, 8192.098869124391, 8503.787405314917, 4742.264948932921, 4749.421896180534, 4821.132196204647, 4823.710577365299, 4855.5387238212315, 3224.0, 3258.169166862435, 3269.6566860479306, 3272.9181770455452, 3274.574305340338, 587.8736071744595, 588.9381614930371, 596.4989408896548, 598.4823127994254, 606.7118118893491, 693.143967200507, 726.2374506767873, 744.2706147975015, 744.4863044499278, 780.9531428114332, 9320.20778233844, 9614.90385096154, 9692.369995950241, 9790.21678265737, 9792.902070979342, 698.179638924262, 717.6304203335286, 733.6331834082958, 737.3953358246293, 754.1937060739498, 4245.0, 4440.444944381952, 4553.998120413504, 4581.404417425713, 4592.6555508337005, 60619.39380606137, 60665.69667151636, 61102.69448652728, 61272.0, 63075.684621577515, 54453.45546544563, 55076.449235507935, 55470.16794748082, 55907.0, 56629.15056274159, 47310.76344618186, 50377.24434133491, 50716.23925641119, 50730.6878915289, 51198.0, 8761.430507017023, 9127.680531181377, 9460.290478214023, 9868.50657467138, 9881.407115572802, 37456.2508749818, 37514.437283441315, 37568.81215593904, 37852.0, 39151.804240978614, 44463.0, 44715.32927006033, 47287.290690638976, 49368.25947610717, 49642.25536617026, 12113.212641178296, 12127.0, 12133.150679452354, 12257.87742122603, 12433.689157771129, 12228.633141005785, 12608.873911261137, 12709.93645031769, 12993.220406775623, 13777.448902043807, 11978.281303121841, 12075.456604452997, 12331.568395106127, 12443.813342799684, 13165.868341316847, 11698.649040528799, 12253.264804111783, 12284.0, 12524.874751252371, 12955.5465558705, 9370.0, 11355.772884542097, 11791.88208117908, 12886.67783305425, 12954.0, 9857.260705447263, 9973.950130249303, 10072.647457338959, 10092.091711745978, 10262.692119236435, 9882.209423246266, 10046.045625665842, 10111.775409409918, 10133.935936726537, 10197.84703229467], "unit": "ms", "name": "yui.html", "value": 6846.798187321548}], "name": "dromaeo_css", "value": 7320.171168080854}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 110.0, 111.0, 111.0, 99.0, 109.0, 108.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [146.0, 121.0, 145.0, 158.0, 128.0, 149.0, 147.0, 125.0, 162.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.3}, {"lowerIsBetter": true, "replicates": [159.0, 161.0, 160.0, 160.0, 161.0, 161.0, 160.0, 162.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 71.0, 149.0, 72.0, 71.0, 70.0, 72.0, 145.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 87.1}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 134.0, 92.0, 93.0, 93.0, 138.0, 91.0, 93.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 105.2}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [55.0, 59.0, 58.0, 58.0, 57.0, 57.0, 58.0, 57.0, 55.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 65.0, 65.0, 66.0, 66.0, 67.0, 65.0, 66.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.7}, {"lowerIsBetter": true, "replicates": [83.0, 80.0, 82.0, 83.0, 81.0, 83.0, 82.0, 83.0, 81.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.0}, {"lowerIsBetter": true, "replicates": [113.0, 118.0, 128.0, 112.0, 125.0, 110.0, 111.0, 114.0, 112.0, 117.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.0}, {"lowerIsBetter": true, "replicates": [145.0, 135.0, 142.0, 143.0, 143.0, 133.0, 145.0, 146.0, 142.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.6}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 64.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1479.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.79894528675015], "unit": "score", "name": "Richards", "value": 214.21253599999997}, {"lowerIsBetter": false, "replicates": [173.22016282695307], "unit": "score", "name": "DeltaBlue", "value": 381.69921399999987}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [958.7727708533077], "unit": "score", "name": "RayTrace", "value": 771.8085270000001}, {"lowerIsBetter": false, "replicates": [553.4034311012729], "unit": "score", "name": "Earley", "value": 1204.2986409999994}, {"lowerIsBetter": false, "replicates": [10989.010989010989], "unit": "score", "name": "Boyer", "value": 60.64813299999995}, {"lowerIsBetter": false, "replicates": [24439.024390243903], "unit": "score", "name": "RegExp", "value": 37.27583333333335}, {"lowerIsBetter": false, "replicates": [518.6721991701245], "unit": "score", "name": "Splay", "value": 157.114648}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23061.25656000697}]} 17:14:17 INFO - RETURN: dromaeo_css: 7320.17 17:14:17 INFO - RETURN: kraken: 1479.90 17:14:17 INFO - RETURN: v8_7: 23061.26 17:14:17 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23061.26"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1479.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7320.17"}}} 17:14:17 INFO - Return code: 0 17:14:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:14:18 INFO - # TBPL SUCCESS # 17:14:18 INFO - Running post-action listener: _resource_record_post_action 17:14:18 INFO - Running post-run listener: _resource_record_post_run 17:14:19 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 511721472; Read time: 0; Write time: 1340508 17:14:19 INFO - install - Wall time: 15s; CPU: 20.0%; Read bytes: 0; Write bytes: 237158400; Read time: 0; Write time: 908524 17:14:19 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 274563072; Read time: 0; Write time: 431984 17:14:19 INFO - Running post-run listener: _upload_blobber_files 17:14:19 INFO - Blob upload gear active. 17:14:19 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:14:19 INFO - Copying logs to upload dir... 17:14:19 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.524651 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-22 17:14:18.968246) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 17:14:18.972177) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1453509829.459466-1953999587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010070 build_url: 'https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 17:14:19.026131) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 17:14:19.026851) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1453509829.459466-1953999587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 17:14:19.077838) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 17:14:19.078185) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 17:14:19.078505) ========= ========= Total master_lag: 1.98 =========