builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1453406472.98 results: success (0) buildid: 20160121092933 builduid: 70011af1483b4c5eaccf5919b26223ee revision: c7ca88c57386a977631f0d873750cea51450dc14 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 12:01:12.976281) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 12:01:12.976833) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 12:01:12.977159) ========= 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=920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006352 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 12:01:13.012777) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 12:01:13.013060) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 12:01:13.064733) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 12:01:13.065004) ========= 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=920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 12:01:13.114336) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 12:01:13.114611) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 12:01:13.114933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 12:01:13.115201) ========= 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=920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 12:01:14-- 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% 78.2M=0s 2016-01-21 12:01:14 (78.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161597 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 12:01:13.290936) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 12:01:13.291325) ========= 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=920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020228 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 12:01:13.342993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-21 12:01:13.343305) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c7ca88c57386a977631f0d873750cea51450dc14 --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 c7ca88c57386a977631f0d873750cea51450dc14 --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=920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 12:01:14,448 truncating revision to first 12 chars 2016-01-21 12:01:14,448 Setting DEBUG logging. 2016-01-21 12:01:14,448 attempt 1/10 2016-01-21 12:01:14,449 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c7ca88c57386?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 12:01:15,205 unpacking tar archive at: mozilla-aurora-c7ca88c57386/testing/mozharness/ program finished with exit code 0 elapsedTime=1.080336 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-21 12:01:14.438457) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 12:01:14.438782) ========= echo c7ca88c57386a977631f0d873750cea51450dc14 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c7ca88c57386a977631f0d873750cea51450dc14'] 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=920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c7ca88c57386a977631f0d873750cea51450dc14 program finished with exit code 0 elapsedTime=0.004613 script_repo_revision: 'c7ca88c57386a977631f0d873750cea51450dc14' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 12:01:14.490350) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 12:01:14.490659) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 12:01:14.500612) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-21 12:01:14.500875) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:01:15 INFO - MultiFileLogger online at 20160121 12:01:15 in /builds/slave/test-pgo 12:01:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:01:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:01:15 INFO - {'append_to_log': False, 12:01:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:01:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:01:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:01:15 INFO - 'branch': 'Mozilla-Aurora', 12:01:15 INFO - 'buildbot_json_path': 'buildprops.json', 12:01:15 INFO - 'config_files': ('talos/linux_config.py',), 12:01:15 INFO - 'default_actions': ('clobber', 12:01:15 INFO - 'read-buildbot-config', 12:01:15 INFO - 'download-and-extract', 12:01:15 INFO - 'populate-webroot', 12:01:15 INFO - 'create-virtualenv', 12:01:15 INFO - 'install', 12:01:15 INFO - 'run-tests'), 12:01:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:01:15 INFO - 'download_minidump_stackwalk': True, 12:01:15 INFO - 'download_symbols': 'ondemand', 12:01:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:01:15 INFO - 'tooltool.py': '/tools/tooltool.py', 12:01:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:01:15 INFO - '/tools/misc-python/virtualenv.py')}, 12:01:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:01:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:01:15 INFO - 'installer_path': 'installer.exe', 12:01:15 INFO - 'log_level': 'info', 12:01:15 INFO - 'log_name': 'talos', 12:01:15 INFO - 'log_to_console': True, 12:01:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:01:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:01:15 INFO - 'opt_config_files': (), 12:01:15 INFO - 'pip_index': False, 12:01:15 INFO - 'sps_profile': False, 12:01:15 INFO - 'sps_profile_interval': 0, 12:01:15 INFO - 'suite': 'dromaeojs-e10s', 12:01:15 INFO - 'system_bits': '32', 12:01:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:01:15 INFO - 'title': 'talos-linux64-ix-053', 12:01:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:01:15 INFO - 'use_talos_json': True, 12:01:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:01:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:01:15 INFO - 'work_dir': 'build'} 12:01:15 INFO - ##### 12:01:15 INFO - ##### Running clobber step. 12:01:15 INFO - ##### 12:01:15 INFO - Running pre-action listener: _resource_record_pre_action 12:01:15 INFO - Running main action method: clobber 12:01:15 INFO - rmtree: /builds/slave/test-pgo/build 12:01:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:01:16 INFO - Running post-action listener: _resource_record_post_action 12:01:16 INFO - ##### 12:01:16 INFO - ##### Running read-buildbot-config step. 12:01:16 INFO - ##### 12:01:16 INFO - Running pre-action listener: _resource_record_pre_action 12:01:16 INFO - Running main action method: read_buildbot_config 12:01:16 INFO - Using buildbot properties: 12:01:16 INFO - { 12:01:16 INFO - "properties": { 12:01:16 INFO - "buildnumber": 67, 12:01:16 INFO - "product": "firefox", 12:01:16 INFO - "script_repo_revision": "production", 12:01:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 12:01:16 INFO - "repository": "", 12:01:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 12:01:16 INFO - "buildid": "20160121092933", 12:01:16 INFO - "slavename": "talos-linux64-ix-053", 12:01:16 INFO - "pgo_build": "True", 12:01:16 INFO - "basedir": "/builds/slave/test-pgo", 12:01:16 INFO - "project": "", 12:01:16 INFO - "platform": "ubuntu64_hw", 12:01:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:01:16 INFO - "slavebuilddir": "test", 12:01:16 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:01:16 INFO - "branch": "mozilla-aurora", 12:01:16 INFO - "repo_path": "releases/mozilla-aurora", 12:01:16 INFO - "stage_platform": "linux64-pgo", 12:01:16 INFO - "builduid": "70011af1483b4c5eaccf5919b26223ee", 12:01:16 INFO - "revision": "c7ca88c57386a977631f0d873750cea51450dc14" 12:01:16 INFO - }, 12:01:16 INFO - "sourcestamp": { 12:01:16 INFO - "repository": "", 12:01:16 INFO - "hasPatch": false, 12:01:16 INFO - "project": "", 12:01:16 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 12:01:16 INFO - "changes": [ 12:01:16 INFO - { 12:01:16 INFO - "category": null, 12:01:16 INFO - "files": [ 12:01:16 INFO - { 12:01:16 INFO - "url": null, 12:01:16 INFO - "name": "https://queue.taskcluster.net/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 12:01:16 INFO - } 12:01:16 INFO - ], 12:01:16 INFO - "repository": "", 12:01:16 INFO - "rev": "c7ca88c57386a977631f0d873750cea51450dc14", 12:01:16 INFO - "who": "dteller@mozilla.com", 12:01:16 INFO - "when": 1453406441, 12:01:16 INFO - "number": 7495062, 12:01:16 INFO - "comments": "Bug 1224374 - Profiler labels for the 100 top chrome hangs (Aurora uplift edition);r=benwa,a=sylvestre", 12:01:16 INFO - "project": "", 12:01:16 INFO - "at": "Thu 21 Jan 2016 12:00:41", 12:01:16 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 12:01:16 INFO - "revlink": "", 12:01:16 INFO - "properties": [ 12:01:16 INFO - [ 12:01:16 INFO - "buildid", 12:01:16 INFO - "20160121092933", 12:01:16 INFO - "Change" 12:01:16 INFO - ], 12:01:16 INFO - [ 12:01:16 INFO - "builduid", 12:01:16 INFO - "70011af1483b4c5eaccf5919b26223ee", 12:01:16 INFO - "Change" 12:01:16 INFO - ], 12:01:16 INFO - [ 12:01:16 INFO - "pgo_build", 12:01:16 INFO - "True", 12:01:16 INFO - "Change" 12:01:16 INFO - ] 12:01:16 INFO - ], 12:01:16 INFO - "revision": "c7ca88c57386a977631f0d873750cea51450dc14" 12:01:16 INFO - } 12:01:16 INFO - ], 12:01:16 INFO - "revision": "c7ca88c57386a977631f0d873750cea51450dc14" 12:01:16 INFO - } 12:01:16 INFO - } 12:01:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 12:01:16 INFO - Running post-action listener: _resource_record_post_action 12:01:16 INFO - ##### 12:01:16 INFO - ##### Running download-and-extract step. 12:01:16 INFO - ##### 12:01:16 INFO - Running pre-action listener: _resource_record_pre_action 12:01:16 INFO - Running main action method: download_and_extract 12:01:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:01: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')]} 12:01:16 INFO - https://queue.taskcluster.net/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:01:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/test_packages.json 12:01:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/test_packages.json 12:01:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:01:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:01:24 INFO - Downloaded 1302 bytes. 12:01:24 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:01:24 INFO - Using the following test package requirements: 12:01:24 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 12:01:24 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 12:01:24 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:01:24 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 12:01:24 INFO - u'jsshell-linux-x86_64.zip'], 12:01:24 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 12:01:24 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:01:24 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 12:01:24 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 12:01:24 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:01:24 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 12:01:24 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:01:24 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 12:01:24 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:01:24 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 12:01:24 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 12:01:24 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:01:24 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:01:24 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')]} 12:01:24 INFO - https://queue.taskcluster.net/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:01:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 12:01:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 12:01:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/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 12:01:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/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 12:01:28 INFO - Downloaded 23159405 bytes. 12:01:28 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 12:01:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 12:01:28 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 12:01:29 INFO - Return code: 0 12:01:29 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 12:01:29 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')]} 12:01:29 INFO - https://queue.taskcluster.net/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:01:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 12:01:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 12:01:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/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 12:01:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/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 12:01:32 INFO - Downloaded 23159405 bytes. 12:01:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:01:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 12:01:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:01:33 INFO - Return code: 0 12:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:33 INFO - https://queue.taskcluster.net/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:01:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 12:01:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 12:01:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/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 12:01:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/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 12:01:34 INFO - Downloaded 11132038 bytes. 12:01:34 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 12:01:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 12:01:34 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 12:01:34 INFO - Return code: 0 12:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:34 INFO - https://queue.taskcluster.net/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:01:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 12:01:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 12:01:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/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 12:01:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/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 12:01:36 INFO - Downloaded 58143188 bytes. 12:01:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 12:01:36 INFO - mkdir: /builds/slave/test-pgo/properties 12:01:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:01:36 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:01:36 INFO - Contents: 12:01:36 INFO - build_url:https://queue.taskcluster.net/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 12:01:36 INFO - Running post-action listener: _resource_record_post_action 12:01:36 INFO - Running post-action listener: set_extra_try_arguments 12:01:36 INFO - ##### 12:01:36 INFO - ##### Running populate-webroot step. 12:01:36 INFO - ##### 12:01:36 INFO - Running pre-action listener: _resource_record_pre_action 12:01:36 INFO - Running main action method: populate_webroot 12:01:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:01:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:01:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:01:36 INFO - '--tppagecycles', 12:01:36 INFO - '7'], 12:01:36 INFO - 'tests': ['tsvgm']}}, 12:01:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:01:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:01:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:01:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:01:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:01:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:01:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:01:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:36 INFO - 'talos_options': ['--e10s'], 12:01:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:01:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:36 INFO - 'tests': ['damp', 'tps']}, 12:01:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:36 INFO - 'talos_options': ['--e10s'], 12:01:36 INFO - 'tests': ['damp', 'tps']}, 12:01:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:01:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:01:36 INFO - 'other': {'tests': ['a11yr', 12:01:36 INFO - 'ts_paint', 12:01:36 INFO - 'tpaint', 12:01:36 INFO - 'sessionrestore', 12:01:36 INFO - 'sessionrestore_no_auto_restore']}, 12:01:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:01:36 INFO - 'tests': ['a11yr', 12:01:36 INFO - 'ts_paint', 12:01:36 INFO - 'tpaint', 12:01:36 INFO - 'sessionrestore', 12:01:36 INFO - 'sessionrestore_no_auto_restore']}, 12:01:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:01:36 INFO - 'tests': ['a11yr', 12:01:36 INFO - 'ts_paint', 12:01:36 INFO - 'tpaint', 12:01:36 INFO - 'sessionrestore', 12:01:36 INFO - 'sessionrestore_no_auto_restore']}, 12:01:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:01:36 INFO - 'tests': ['a11yr', 12:01:36 INFO - 'ts_paint', 12:01:36 INFO - 'tpaint', 12:01:36 INFO - 'sessionrestore', 12:01:36 INFO - 'sessionrestore_no_auto_restore']}, 12:01:36 INFO - 'other_l64': {'tests': ['a11yr', 12:01:36 INFO - 'ts_paint', 12:01:36 INFO - 'tpaint', 12:01:36 INFO - 'sessionrestore', 12:01:36 INFO - 'sessionrestore_no_auto_restore']}, 12:01:36 INFO - 'other_nol64': {'tests': ['a11yr', 12:01:36 INFO - 'ts_paint', 12:01:36 INFO - 'tpaint', 12:01:36 INFO - 'sessionrestore', 12:01:36 INFO - 'sessionrestore_no_auto_restore']}, 12:01:36 INFO - 'svgr': {'tests': ['tsvgx', 12:01:36 INFO - 'tsvgr_opacity', 12:01:36 INFO - 'tart', 12:01:36 INFO - 'tscrollx', 12:01:36 INFO - 'cart']}, 12:01:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:01:36 INFO - 'tests': ['tsvgx', 12:01:36 INFO - 'tsvgr_opacity', 12:01:36 INFO - 'tart', 12:01:36 INFO - 'tscrollx', 12:01:36 INFO - 'cart']}, 12:01:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:36 INFO - 'tests': ['tp5o']}, 12:01:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:36 INFO - 'talos_options': ['--e10s'], 12:01:36 INFO - 'tests': ['tp5o']}, 12:01:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:36 INFO - 'talos_options': ['--xperf_path', 12:01:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:01:36 INFO - 'tests': ['tp5n']}, 12:01:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:36 INFO - 'talos_options': ['--e10s', 12:01:36 INFO - '--xperf_path', 12:01:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:01:36 INFO - 'tests': ['tp5n']}}, 12:01:36 INFO - 'talos.zip': {'path': '', 12:01:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:01:36 INFO - Running post-action listener: _resource_record_post_action 12:01:36 INFO - ##### 12:01:36 INFO - ##### Running create-virtualenv step. 12:01:36 INFO - ##### 12:01:36 INFO - Running pre-action listener: _resource_record_pre_action 12:01:36 INFO - Running main action method: create_virtualenv 12:01:36 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:01:36 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 12:01:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:01:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:01:36 INFO - Using real prefix '/usr' 12:01:36 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:01:36 INFO - Installing distribute.............................................................................................................................................................................................done. 12:01:38 INFO - Installing pip.................done. 12:01:38 INFO - Return code: 0 12:01:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:01:38 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')]} 12:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:38 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')]} 12:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:38 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 0x7f22e277bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c5450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857a50>, '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 0x27c3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c39e0>, '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': '920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190', '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 12:01:38 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 12:01:38 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 12:01:38 INFO - Using env: {'DISPLAY': ':0', 12:01:38 INFO - 'HOME': '/home/cltbld', 12:01:38 INFO - 'LANG': 'en_US.UTF-8', 12:01:38 INFO - 'LANGUAGE': 'en_US:en', 12:01:38 INFO - 'LOGNAME': 'cltbld', 12:01:38 INFO - 'MAIL': '/var/mail/cltbld', 12:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:38 INFO - 'MOZ_NO_REMOTE': '1', 12:01:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:38 INFO - 'NO_EM_RESTART': '1', 12:01:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:01:38 INFO - 'PWD': '/builds/slave/test-pgo', 12:01:38 INFO - 'SHELL': '/bin/bash', 12:01:38 INFO - 'SHLVL': '1', 12:01:38 INFO - 'TERM': 'linux', 12:01:38 INFO - 'TMOUT': '86400', 12:01:38 INFO - 'USER': 'cltbld', 12:01:38 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190', 12:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:38 INFO - '_': '/tools/buildbot/bin/python'} 12:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:38 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 12:01:38 INFO - Cleaning up... 12:01:38 INFO - Return code: 0 12:01:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:01:38 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')]} 12:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:38 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')]} 12:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:38 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 0x7f22e277bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c5450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857a50>, '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 0x27c3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c39e0>, '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': '920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190', '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 12:01:38 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 12:01:38 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 12:01:38 INFO - Using env: {'DISPLAY': ':0', 12:01:38 INFO - 'HOME': '/home/cltbld', 12:01:38 INFO - 'LANG': 'en_US.UTF-8', 12:01:38 INFO - 'LANGUAGE': 'en_US:en', 12:01:38 INFO - 'LOGNAME': 'cltbld', 12:01:38 INFO - 'MAIL': '/var/mail/cltbld', 12:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:38 INFO - 'MOZ_NO_REMOTE': '1', 12:01:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:38 INFO - 'NO_EM_RESTART': '1', 12:01:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:01:38 INFO - 'PWD': '/builds/slave/test-pgo', 12:01:38 INFO - 'SHELL': '/bin/bash', 12:01:38 INFO - 'SHLVL': '1', 12:01:38 INFO - 'TERM': 'linux', 12:01:38 INFO - 'TMOUT': '86400', 12:01:38 INFO - 'USER': 'cltbld', 12:01:38 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190', 12:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:38 INFO - '_': '/tools/buildbot/bin/python'} 12:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:39 INFO - Downloading/unpacking psutil>=0.7.1 12:01:39 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 12:01:39 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 12:01:39 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 12:01:39 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 12:01:39 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 12:01:39 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 12:01:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:01:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:01:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:01:41 INFO - Installing collected packages: psutil 12:01:41 INFO - Running setup.py install for psutil 12:01:41 INFO - building 'psutil._psutil_linux' extension 12:01:41 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 12:01:41 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 12:01:41 INFO - building 'psutil._psutil_posix' extension 12:01:41 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 12:01:41 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 12:01:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:01:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:01:41 INFO - Successfully installed psutil 12:01:41 INFO - Cleaning up... 12:01:41 INFO - Return code: 0 12:01:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:41 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 0x7f22e277bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c5450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857a50>, '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 0x27c3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c39e0>, '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': '920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190', '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 12:01:41 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 12:01:41 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 12:01:41 INFO - Using env: {'DISPLAY': ':0', 12:01:41 INFO - 'HOME': '/home/cltbld', 12:01:41 INFO - 'LANG': 'en_US.UTF-8', 12:01:41 INFO - 'LANGUAGE': 'en_US:en', 12:01:41 INFO - 'LOGNAME': 'cltbld', 12:01:41 INFO - 'MAIL': '/var/mail/cltbld', 12:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:41 INFO - 'MOZ_NO_REMOTE': '1', 12:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:41 INFO - 'NO_EM_RESTART': '1', 12:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:01:41 INFO - 'PWD': '/builds/slave/test-pgo', 12:01:41 INFO - 'SHELL': '/bin/bash', 12:01:41 INFO - 'SHLVL': '1', 12:01:41 INFO - 'TERM': 'linux', 12:01:41 INFO - 'TMOUT': '86400', 12:01:41 INFO - 'USER': 'cltbld', 12:01:41 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190', 12:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:41 INFO - '_': '/tools/buildbot/bin/python'} 12:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:01:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:01:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:01:43 INFO - Installing collected packages: mozsystemmonitor 12:01:43 INFO - Running setup.py install for mozsystemmonitor 12:01:43 INFO - Successfully installed mozsystemmonitor 12:01:43 INFO - Cleaning up... 12:01:43 INFO - Return code: 0 12:01:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:01: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')]} 12:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01: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')]} 12:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01: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', '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 0x7f22e277bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c5450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857a50>, '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 0x27c3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c39e0>, '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': '920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190', '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 12:01: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 12:01: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 blobuploader==1.2.4 12:01:43 INFO - Using env: {'DISPLAY': ':0', 12:01:43 INFO - 'HOME': '/home/cltbld', 12:01:43 INFO - 'LANG': 'en_US.UTF-8', 12:01:43 INFO - 'LANGUAGE': 'en_US:en', 12:01:43 INFO - 'LOGNAME': 'cltbld', 12:01:43 INFO - 'MAIL': '/var/mail/cltbld', 12:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:43 INFO - 'MOZ_NO_REMOTE': '1', 12:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:43 INFO - 'NO_EM_RESTART': '1', 12:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:01:43 INFO - 'PWD': '/builds/slave/test-pgo', 12:01:43 INFO - 'SHELL': '/bin/bash', 12:01:43 INFO - 'SHLVL': '1', 12:01:43 INFO - 'TERM': 'linux', 12:01:43 INFO - 'TMOUT': '86400', 12:01:43 INFO - 'USER': 'cltbld', 12:01:43 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190', 12:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:43 INFO - '_': '/tools/buildbot/bin/python'} 12:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:43 INFO - Downloading/unpacking blobuploader==1.2.4 12:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:45 INFO - Downloading blobuploader-1.2.4.tar.gz 12:01:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:01:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:01:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:46 INFO - Downloading docopt-0.6.1.tar.gz 12:01:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:01:46 INFO - Installing collected packages: blobuploader, requests, docopt 12:01:46 INFO - Running setup.py install for blobuploader 12:01:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:01:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:01:46 INFO - Running setup.py install for requests 12:01:46 INFO - Running setup.py install for docopt 12:01:46 INFO - Successfully installed blobuploader requests docopt 12:01:46 INFO - Cleaning up... 12:01:47 INFO - Return code: 0 12:01:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:01:47 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')]} 12:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:47 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')]} 12:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:47 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 0x7f22e277bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c5450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857a50>, '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 0x27c3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c39e0>, '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': '920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190', '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 12:01:47 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 12:01:47 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 12:01:47 INFO - Using env: {'DISPLAY': ':0', 12:01:47 INFO - 'HOME': '/home/cltbld', 12:01:47 INFO - 'LANG': 'en_US.UTF-8', 12:01:47 INFO - 'LANGUAGE': 'en_US:en', 12:01:47 INFO - 'LOGNAME': 'cltbld', 12:01:47 INFO - 'MAIL': '/var/mail/cltbld', 12:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:47 INFO - 'MOZ_NO_REMOTE': '1', 12:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:47 INFO - 'NO_EM_RESTART': '1', 12:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:01:47 INFO - 'PWD': '/builds/slave/test-pgo', 12:01:47 INFO - 'SHELL': '/bin/bash', 12:01:47 INFO - 'SHLVL': '1', 12:01:47 INFO - 'TERM': 'linux', 12:01:47 INFO - 'TMOUT': '86400', 12:01:47 INFO - 'USER': 'cltbld', 12:01:47 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190', 12:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:47 INFO - '_': '/tools/buildbot/bin/python'} 12:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:01:47 INFO - Running setup.py (path:/tmp/pip-3s9PCs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:01:47 INFO - Running setup.py (path:/tmp/pip-YfdLfg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:01:47 INFO - Running setup.py (path:/tmp/pip-pnp9ko-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:01:47 INFO - Running setup.py (path:/tmp/pip-FvSazd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:01:47 INFO - Running setup.py (path:/tmp/pip-okPBTV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:01:47 INFO - Running setup.py (path:/tmp/pip-hum6Pg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:01:47 INFO - Running setup.py (path:/tmp/pip-ENlvO8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:01:47 INFO - Running setup.py (path:/tmp/pip-SZhdHg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:01:47 INFO - Running setup.py (path:/tmp/pip-u5Fjb8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:01:47 INFO - Running setup.py (path:/tmp/pip-G6mTMG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:01:47 INFO - Running setup.py (path:/tmp/pip-ZpHJAK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:01:48 INFO - Running setup.py (path:/tmp/pip-ZheH3F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:01:48 INFO - Running setup.py (path:/tmp/pip-8d7VM1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:01:48 INFO - Running setup.py (path:/tmp/pip-T1QTcq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:01:48 INFO - Running setup.py (path:/tmp/pip-YW8lo6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:01:48 INFO - Running setup.py (path:/tmp/pip-LJ008X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:01:48 INFO - Running setup.py (path:/tmp/pip-0bCoau-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:01:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:01:48 INFO - Running setup.py install for manifestparser 12:01:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:01:48 INFO - Running setup.py install for mozcrash 12:01:48 INFO - Running setup.py install for mozdebug 12:01:48 INFO - Running setup.py install for mozdevice 12:01:48 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:01:48 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:01:48 INFO - Running setup.py install for mozfile 12:01:48 INFO - Running setup.py install for mozhttpd 12:01:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:01:49 INFO - Running setup.py install for mozinfo 12:01:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:01:49 INFO - Running setup.py install for mozInstall 12:01:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:01:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:01:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:01:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:01:49 INFO - Running setup.py install for mozleak 12:01:49 INFO - Running setup.py install for mozlog 12:01:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:01:49 INFO - Running setup.py install for moznetwork 12:01:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:01:49 INFO - Running setup.py install for mozprocess 12:01:49 INFO - Running setup.py install for mozprofile 12:01:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:01:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:01:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:01:49 INFO - Running setup.py install for mozrunner 12:01:49 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:01:49 INFO - Running setup.py install for mozscreenshot 12:01:49 INFO - Running setup.py install for moztest 12:01:50 INFO - Running setup.py install for mozversion 12:01:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:01:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:01:50 INFO - Cleaning up... 12:01:50 INFO - Return code: 0 12:01:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:01:50 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')]} 12:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:50 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')]} 12:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:50 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 0x7f22e277bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c5450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857a50>, '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 0x27c3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c39e0>, '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': '920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190', '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 12:01:50 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 12:01:50 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 12:01:50 INFO - Using env: {'DISPLAY': ':0', 12:01:50 INFO - 'HOME': '/home/cltbld', 12:01:50 INFO - 'LANG': 'en_US.UTF-8', 12:01:50 INFO - 'LANGUAGE': 'en_US:en', 12:01:50 INFO - 'LOGNAME': 'cltbld', 12:01:50 INFO - 'MAIL': '/var/mail/cltbld', 12:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:50 INFO - 'MOZ_NO_REMOTE': '1', 12:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:50 INFO - 'NO_EM_RESTART': '1', 12:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:01:50 INFO - 'PWD': '/builds/slave/test-pgo', 12:01:50 INFO - 'SHELL': '/bin/bash', 12:01:50 INFO - 'SHLVL': '1', 12:01:50 INFO - 'TERM': 'linux', 12:01:50 INFO - 'TMOUT': '86400', 12:01:50 INFO - 'USER': 'cltbld', 12:01:50 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190', 12:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:50 INFO - '_': '/tools/buildbot/bin/python'} 12:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:01:50 INFO - Running setup.py (path:/tmp/pip-bvVQSF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:01:50 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)) 12:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:01:50 INFO - Running setup.py (path:/tmp/pip-VirENa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:01:50 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)) 12:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:01:50 INFO - Running setup.py (path:/tmp/pip-Jyui4K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:01:50 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)) 12:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:01:50 INFO - Running setup.py (path:/tmp/pip-J0lcLa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:01:50 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)) 12:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:01:50 INFO - Running setup.py (path:/tmp/pip-FaVL1g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:01:50 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)) 12:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:01:50 INFO - Running setup.py (path:/tmp/pip-vEHIOj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:01:50 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)) 12:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:01:50 INFO - Running setup.py (path:/tmp/pip-F3BNQK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:01:50 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)) 12:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:01:50 INFO - Running setup.py (path:/tmp/pip-33vBwi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:01:51 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)) 12:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:01:51 INFO - Running setup.py (path:/tmp/pip-EGG_c_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:01:51 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)) 12:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:01:51 INFO - Running setup.py (path:/tmp/pip-TlaWGS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:01:51 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)) 12:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:01:51 INFO - Running setup.py (path:/tmp/pip-mvjsSg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:01:51 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)) 12:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:01:51 INFO - Running setup.py (path:/tmp/pip-rDzZR_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:01:51 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)) 12:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:01:51 INFO - Running setup.py (path:/tmp/pip-6WAjT4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:01:51 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)) 12:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:01:51 INFO - Running setup.py (path:/tmp/pip-DjgXDT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:01:51 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)) 12:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:01:51 INFO - Running setup.py (path:/tmp/pip-nSNEtd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:01:51 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)) 12:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:01:51 INFO - Running setup.py (path:/tmp/pip-l7s7Iv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:01:51 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)) 12:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:01:51 INFO - Running setup.py (path:/tmp/pip-hfDCNY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:01:51 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)) 12:01:51 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)) 12:01:51 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)) 12:01:51 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)) 12:01:51 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)) 12:01:51 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)) 12:01:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:53 INFO - Downloading blessings-1.6.tar.gz 12:01:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:01:53 INFO - Installing collected packages: blessings 12:01:53 INFO - Running setup.py install for blessings 12:01:53 INFO - Successfully installed blessings 12:01:53 INFO - Cleaning up... 12:01:53 INFO - Return code: 0 12:01:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:01:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:01:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:01:53 INFO - Reading from file tmpfile_stdout 12:01:53 INFO - Current package versions: 12:01:53 INFO - argparse == 1.2.1 12:01:53 INFO - blessings == 1.6 12:01:53 INFO - blobuploader == 1.2.4 12:01:53 INFO - docopt == 0.6.1 12:01:53 INFO - manifestparser == 1.1 12:01:53 INFO - mozInstall == 1.12 12:01:53 INFO - mozcrash == 0.16 12:01:53 INFO - mozdebug == 0.1 12:01:53 INFO - mozdevice == 0.47 12:01:53 INFO - mozfile == 1.2 12:01:53 INFO - mozhttpd == 0.7 12:01:53 INFO - mozinfo == 0.9 12:01:53 INFO - mozleak == 0.1 12:01:53 INFO - mozlog == 3.1 12:01:53 INFO - moznetwork == 0.27 12:01:53 INFO - mozprocess == 0.22 12:01:53 INFO - mozprofile == 0.27 12:01:53 INFO - mozrunner == 6.11 12:01:53 INFO - mozscreenshot == 0.1 12:01:53 INFO - mozsystemmonitor == 0.0 12:01:53 INFO - moztest == 0.7 12:01:53 INFO - mozversion == 1.4 12:01:53 INFO - psutil == 3.1.1 12:01:53 INFO - requests == 1.2.3 12:01:53 INFO - wsgiref == 0.1.2 12:01:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:01:53 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')]} 12:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:53 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')]} 12:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:53 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 0x7f22e277bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c5450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857a50>, '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 0x27c3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c39e0>, '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': '920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190', '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 12:01:53 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 12:01:53 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 12:01:53 INFO - Using env: {'DISPLAY': ':0', 12:01:53 INFO - 'HOME': '/home/cltbld', 12:01:53 INFO - 'LANG': 'en_US.UTF-8', 12:01:53 INFO - 'LANGUAGE': 'en_US:en', 12:01:53 INFO - 'LOGNAME': 'cltbld', 12:01:53 INFO - 'MAIL': '/var/mail/cltbld', 12:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:53 INFO - 'MOZ_NO_REMOTE': '1', 12:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:53 INFO - 'NO_EM_RESTART': '1', 12:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:01:53 INFO - 'PWD': '/builds/slave/test-pgo', 12:01:53 INFO - 'SHELL': '/bin/bash', 12:01:53 INFO - 'SHLVL': '1', 12:01:53 INFO - 'TERM': 'linux', 12:01:53 INFO - 'TMOUT': '86400', 12:01:53 INFO - 'USER': 'cltbld', 12:01:53 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190', 12:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:53 INFO - '_': '/tools/buildbot/bin/python'} 12:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:54 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)) 12:01:54 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)) 12:01:54 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)) 12:01:54 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)) 12:01:54 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)) 12:01:54 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)) 12:01:54 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)) 12:01:54 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)) 12:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 12:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 12:01:54 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)) 12:01:54 INFO - Cleaning up... 12:01:54 INFO - Return code: 0 12:01:54 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:54 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 0x7f22e277bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c5450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857a50>, '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 0x27c3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c39e0>, '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': '920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190', '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 12:01:54 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 12:01:54 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 12:01:54 INFO - Using env: {'DISPLAY': ':0', 12:01:54 INFO - 'HOME': '/home/cltbld', 12:01:54 INFO - 'LANG': 'en_US.UTF-8', 12:01:54 INFO - 'LANGUAGE': 'en_US:en', 12:01:54 INFO - 'LOGNAME': 'cltbld', 12:01:54 INFO - 'MAIL': '/var/mail/cltbld', 12:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:54 INFO - 'MOZ_NO_REMOTE': '1', 12:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:54 INFO - 'NO_EM_RESTART': '1', 12:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:01:54 INFO - 'PWD': '/builds/slave/test-pgo', 12:01:54 INFO - 'SHELL': '/bin/bash', 12:01:54 INFO - 'SHLVL': '1', 12:01:54 INFO - 'TERM': 'linux', 12:01:54 INFO - 'TMOUT': '86400', 12:01:54 INFO - 'USER': 'cltbld', 12:01:54 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190', 12:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:54 INFO - '_': '/tools/buildbot/bin/python'} 12:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:54 INFO - Downloading/unpacking jsonschema 12:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:01:56 INFO - Downloading/unpacking functools32 (from jsonschema) 12:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:56 INFO - Downloading functools32-3.2.3-2.tar.gz 12:01:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:01:56 INFO - warning: no files found matching '*.txt' 12:01:56 INFO - no previously-included directories found matching 'build' 12:01:56 INFO - no previously-included directories found matching 'dist' 12:01:56 INFO - no previously-included directories found matching '.git*' 12:01:56 INFO - Installing collected packages: jsonschema, functools32 12:01:56 INFO - Running setup.py install for functools32 12:01:56 INFO - warning: no files found matching '*.txt' 12:01:56 INFO - no previously-included directories found matching 'build' 12:01:56 INFO - no previously-included directories found matching 'dist' 12:01:56 INFO - no previously-included directories found matching '.git*' 12:01:56 INFO - Successfully installed jsonschema functools32 12:01:56 INFO - Cleaning up... 12:01:56 INFO - Return code: 0 12:01:56 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:56 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 0x7f22e277bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c5450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857a50>, '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 0x27c3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c39e0>, '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': '920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190', '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 12:01:56 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 12:01:56 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 12:01:56 INFO - Using env: {'DISPLAY': ':0', 12:01:56 INFO - 'HOME': '/home/cltbld', 12:01:56 INFO - 'LANG': 'en_US.UTF-8', 12:01:56 INFO - 'LANGUAGE': 'en_US:en', 12:01:56 INFO - 'LOGNAME': 'cltbld', 12:01:56 INFO - 'MAIL': '/var/mail/cltbld', 12:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:56 INFO - 'MOZ_NO_REMOTE': '1', 12:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:56 INFO - 'NO_EM_RESTART': '1', 12:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:01:56 INFO - 'PWD': '/builds/slave/test-pgo', 12:01:56 INFO - 'SHELL': '/bin/bash', 12:01:56 INFO - 'SHLVL': '1', 12:01:56 INFO - 'TERM': 'linux', 12:01:56 INFO - 'TMOUT': '86400', 12:01:56 INFO - 'USER': 'cltbld', 12:01:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190', 12:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:56 INFO - '_': '/tools/buildbot/bin/python'} 12:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:56 INFO - Downloading/unpacking flake8 12:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:01:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:01:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:01:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:01:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:01:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:01:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:01:59 INFO - no previously-included directories found matching 'docs/_build' 12:01:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:01:59 INFO - Running setup.py install for pep8 12:01:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:01:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:01:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:01:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:01:59 INFO - no previously-included directories found matching 'docs/_build' 12:01:59 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:01:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:01:59 INFO - Cleaning up... 12:01:59 INFO - Return code: 0 12:01:59 INFO - Running post-action listener: _resource_record_post_action 12:01:59 INFO - Running post-action listener: _start_resource_monitoring 12:01:59 INFO - Starting resource monitoring. 12:01:59 INFO - ##### 12:01:59 INFO - ##### Running install step. 12:01:59 INFO - ##### 12:01:59 INFO - Running pre-action listener: _resource_record_pre_action 12:01:59 INFO - Running main action method: install 12:01:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:01:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:01:59 INFO - Reading from file tmpfile_stdout 12:01:59 INFO - Detecting whether we're running mozinstall >=1.0... 12:01:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:01:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:01:59 INFO - Reading from file tmpfile_stdout 12:01:59 INFO - Output received: 12:01:59 INFO - Usage: mozinstall [options] installer 12:01:59 INFO - Options: 12:01:59 INFO - -h, --help show this help message and exit 12:01:59 INFO - -d DEST, --destination=DEST 12:01:59 INFO - Directory to install application into. [default: 12:01:59 INFO - "/builds/slave/test-pgo"] 12:01:59 INFO - --app=APP Application being installed. [default: firefox] 12:01:59 INFO - mkdir: /builds/slave/test-pgo/build/application 12:01:59 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'] 12:01:59 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 12:02:14 INFO - Reading from file tmpfile_stdout 12:02:14 INFO - Output received: 12:02:14 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:02:14 INFO - Running post-action listener: _resource_record_post_action 12:02:14 INFO - ##### 12:02:14 INFO - ##### Running run-tests step. 12:02:14 INFO - ##### 12:02:14 INFO - Running pre-action listener: _resource_record_pre_action 12:02:14 INFO - Running main action method: run_tests 12:02:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:02:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:02:14 INFO - Python 2.7.3 12:02:14 INFO - Return code: 0 12:02:14 INFO - grabbing minidump binary from tooltool 12:02:14 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')]} 12:02:14 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 0x2857a50>, '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 0x27c3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c39e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:02:14 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 12:02:14 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 12:02:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:02:14 INFO - Return code: 0 12:02:14 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:02:14 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:02:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:02:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:02:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:02:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:02:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:02:15 INFO - Return code: 0 12:02:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 12:02:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost 12:02:15 INFO - Using env: {'DISPLAY': ':0', 12:02:15 INFO - 'HOME': '/home/cltbld', 12:02:15 INFO - 'LANG': 'en_US.UTF-8', 12:02:15 INFO - 'LANGUAGE': 'en_US:en', 12:02:15 INFO - 'LOGNAME': 'cltbld', 12:02:15 INFO - 'MAIL': '/var/mail/cltbld', 12:02:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:02:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:15 INFO - 'MOZ_NO_REMOTE': '1', 12:02:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:15 INFO - 'NO_EM_RESTART': '1', 12:02:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:02:15 INFO - 'PWD': '/builds/slave/test-pgo', 12:02:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:02:15 INFO - 'SHELL': '/bin/bash', 12:02:15 INFO - 'SHLVL': '1', 12:02:15 INFO - 'TERM': 'linux', 12:02:15 INFO - 'TMOUT': '86400', 12:02:15 INFO - 'USER': 'cltbld', 12:02:15 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190', 12:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:15 INFO - '_': '/tools/buildbot/bin/python'} 12:02:15 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] with output_timeout 3600 12:02:15 INFO - mozversion INFO | application_buildid: 20160121092933 12:02:15 INFO - mozversion INFO | application_changeset: c7ca88c57386a977631f0d873750cea51450dc14 12:02:15 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 12:02:15 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:02:15 INFO - mozversion INFO | application_name: Firefox 12:02:15 INFO - mozversion INFO | application_remotingname: firefox-dev 12:02:15 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:02:15 INFO - mozversion INFO | application_vendor: Mozilla 12:02:15 INFO - mozversion INFO | application_version: 45.0a2 12:02:15 INFO - mozversion INFO | platform_buildid: 20160121092933 12:02:15 INFO - mozversion INFO | platform_changeset: c7ca88c57386a977631f0d873750cea51450dc14 12:02:15 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:02:15 INFO - mozversion INFO | platform_version: 45.0a2 12:02:15 INFO - 2016-01-21 12:02:15,723 DEBUG : using testdate: 1453406535 12:02:15 INFO - 2016-01-21 12:02:15,723 DEBUG : actual date: 1453406535 12:02:15 INFO - 2016-01-21 12:02:15,771 INFO : starting webserver on 'localhost:39462' 12:02:15 INFO - 2016-01-21 12:02:15,772 INFO : Starting test suite talos-linux64-ix-053.e 12:02:15 INFO - 2016-01-21 12:02:15,772 INFO : Starting test dromaeo_css 12:02:15 INFO - 2016-01-21 12:02:15,772 DEBUG : operating with platform_type : linux_ 12:02:15 INFO - 2016-01-21 12:02:15,773 INFO : Initialising browser for dromaeo_css test... 12:02:15 INFO - 2016-01-21 12:02:15,784 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSHbbNi/profile http://localhost:39462/getInfo.html 12:02:19 INFO - 2016-01-21 12:02:19,467 DEBUG : BROWSER_OUTPUT: 12:02:19 INFO - 2016-01-21 12:02:19,467 DEBUG : BROWSER_OUTPUT: (process:14264): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:02:20 INFO - 2016-01-21 12:02:20,362 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:02:20 INFO - 2016-01-21 12:02:20,362 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:02:20 INFO - 2016-01-21 12:02:20,363 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:02:20 INFO - 2016-01-21 12:02:20,363 DEBUG : BROWSER_OUTPUT: __metrics 12:02:21 INFO - 2016-01-21 12:02:21,285 INFO : Browser initialized. 12:02:21 INFO - 2016-01-21 12:02:21,286 INFO : Running cycle 1/1 for dromaeo_css test... 12:02:21 INFO - 2016-01-21 12:02:21,286 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSHbbNi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:02:22 INFO - 2016-01-21 12:02:22,622 DEBUG : BROWSER_OUTPUT: 12:02:22 INFO - 2016-01-21 12:02:22,623 DEBUG : BROWSER_OUTPUT: (process:14377): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:02:33 INFO - 2016-01-21 12:02:33,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 137277440 12:02:33 INFO - 2016-01-21 12:02:33,131 DEBUG : BROWSER_OUTPUT: 12:03:22 INFO - 2016-01-21 12:03:22,733 DEBUG : BROWSER_OUTPUT: 1453406602732 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] 12:05:31 INFO - 2016-01-21 12:05:31,043 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39462/tests/dromaeo/cssquery-ext.html) 12:05:32 INFO - 2016-01-21 12:05:32,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 142417920 12:05:32 INFO - 2016-01-21 12:05:32,140 DEBUG : BROWSER_OUTPUT: 12:08:33 INFO - 2016-01-21 12:08:33,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/dromaeo/cssquery-ext.html (next: http://localhost:39462/tests/dromaeo/cssquery-jquery.html) 12:08:34 INFO - 2016-01-21 12:08:34,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 139821056 12:08:34 INFO - 2016-01-21 12:08:34,494 DEBUG : BROWSER_OUTPUT: 12:11:36 INFO - 2016-01-21 12:11:36,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39462/tests/dromaeo/cssquery-mootools.html) 12:11:36 INFO - 2016-01-21 12:11:36,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 139296768 12:11:36 INFO - 2016-01-21 12:11:36,660 DEBUG : BROWSER_OUTPUT: 12:14:38 INFO - 2016-01-21 12:14:38,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39462/tests/dromaeo/cssquery-prototype.html) 12:14:38 INFO - 2016-01-21 12:14:38,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 139821056 12:14:38 INFO - 2016-01-21 12:14:38,878 DEBUG : BROWSER_OUTPUT: 12:17:41 INFO - 2016-01-21 12:17:41,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39462/tests/dromaeo/cssquery-yui.html) 12:17:41 INFO - 2016-01-21 12:17:41,646 DEBUG : BROWSER_OUTPUT: RSS: Main: 140521472 12:17:41 INFO - 2016-01-21 12:17:41,646 DEBUG : BROWSER_OUTPUT: 12:20:43 INFO - 2016-01-21 12:20:43,801 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/dromaeo/cssquery-yui.html (next: http://localhost:39462/tests/dromaeo/cssquery-dojo.html) 12:20:44 INFO - 2016-01-21 12:20:44,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 141295616 12:20:44 INFO - 2016-01-21 12:20:44,051 DEBUG : BROWSER_OUTPUT: 12:20:44 INFO - 2016-01-21 12:20:44,052 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:20:44 INFO - 2016-01-21 12:20:44,052 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:20:44 INFO - 2016-01-21 12:20:44,052 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:20:44 INFO - 2016-01-21 12:20:44,052 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:20:44 INFO - 2016-01-21 12:20:44,052 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3372.6964573188416;3385.00142457975;3399.7620166588317;3427.3316703242876;3431;5444.782208711652;5473.28847249857;5496.670199788011;5513.365962914261;5517;5543.445655434454;5614.3543492498375;5625.493705566499;5632.26780518533;5641.407652196522;5099.872503187422;5129;5163.664361816489;5172.069027575054;5189.091908915924;4974.577160941324;5139.972005598876;5143.09995750744;5157.432682404951;5206.505381988705;5055.646104772667;5108.923366149511;5118.846434606968;5121.436641969381;5129.051125541768;5120.795168193268;5147.48525147486;5190.6107041972;5200.245964335188;5211;4877.317175595419;4927.1870141426625;4996.150654388726;5005.824796132118;5049.924251136236;5418.349798024223;5424.457554244584;5433.565314774809;5466;5470.753816078286;5953.226080609536;6021.6989150542295;6068.393160683941;6076.513878889722;6084.361142080063;5784.913226301609;5818.2436283282905;5978.282606087254;6067.2719273687;6075.939240607626;5701.287339082614;5711.62874413166;5718.513926316226;5731.627444216113;5744.540436765049;6043.8791224175275;6162.845928851725;6176.104464852661;6179.752809887555;6202.4417802398;5882.499987501024;5905.852353691193;5916.083007133901;5997.580169388189;6025.728842202024;5947.881042379128;5978.880422391615;5987.730552125165;5992.940070599238;6008.399160084044;5660.858478537987;5779.450952159538;5956.1065840123465;5976.073708575178;5976.641401515836;5979.671118088547;6079.179310792986;6098.664573448415;6120.265568131764;6128.724207410677;4626.444826620827;4650.86047418578;4662;4662.160811054043;4686.086213188463;4066.3290557058344;4091.0999580092925;4132.8140233689555;4136.524299705572;4205.074883525619;5786.07422812348;5798.449147331081;5810.273715785527;5810.912836307459;5826.621269617546;6163.907541386883;6185.938140618626;6186.257649082049;6186.566940314135;6192.040233763774;5531.529819965348;5645.294338207724;5712.514436272881;5804.970975145097;5820.30156381237;5300.840974770763;5320.17537281722;5321.441248668912;5324.733763311819;5336.332958380202;6281.026440901667;6282.560220784592;6284;6291.811245662638;6309;5894.38108998549;5984.371640977634;6032.849178770566;6092.8781424372155;6124.6325220486915;6201.179420458886;6247.31279559239;6256.562040657111;6300.873982520416;6302.873942521032;5893.145493903446;5997.5501837363245;6054.303755068047;6054.66699331541;6068.180795592715;6002.7298771554515;6041.305249896142;6110.133516259585;6113.111460343324;6118.710550942667;5922.052471604523;5923.28920529522;5939.673317967553;5948.702564871825;5959.702014899324;5690.3456102548735;5770.076787713946;5919.6152250103605;5926.614770039933;5930.28836539618;5782;5859.970700146472;5860.853478663067;5867.647941123546;5911.408859114054;5913;5978.760849565969;5979.3123790762875;6021.518278537619;6045.123457098608;5654.575906806924;5699.829005129853;5766.336871259691;5903.144044113494;5906 12:20:44 INFO - 2016-01-21 12:20:44,053 DEBUG : BROWSER_OUTPUT: |1;ext.html;608.4037643109752;650.8405440667036;657.828964469238;671.9395254427101;687.9543094496363;40666.39000414992;41424.17151656969;41562.16875662485;41570.792146039304;41588.960275993115;46725.29912051322;46859.29711054328;47224;47289;47393.763031184884;8934.821303573925;9178.678746243882;9191.770205744877;9192.264618830477;9196.540172991323;8896.421732587361;8948.881389826272;8964.148405901462;8991.595378207963;9010.819783604356;8932.508712020835;9062.909370906273;9070.86393704095;9079.18287354138;9114.635414583408;8998;9038.27693784499;9069.093090690943;9083.318751093695;9099.363044586882;8938.821223575493;9080.364374493787;9085.227755640779;9107.180353768194;9110.498922559256;41766;42167;42200.36699449511;42254.57745422537;42310.36534451955;3640.2355505343908;3815.465834783133;3815.4849095372324;4142.502899652061;4289.906073951153;32350.191245218823;32381.51427728586;32838.01485955425;32935.6706432935;33352;4255.127698821734;4292.871213863589;4315.072259464199;4339.045410009793;4347.391365208873;282854;284075;284226;286458;286830;45538.54461455343;46103;64923.35076649173;65135;65432;43902.560974390486;44259;44268.778656106515;44281;44291.11417771691;16776.412825551048;16923.661526769396;16972;16984.150792460576;17001.659966800595;12417.379131043412;12499.375031248583;12592.622221333375;12672.366381680878;12688.365581720876;15112;15528.844711552965;15671.216439178224;15721.68556628884;15743.13412762309;6187.412195841388;6272.247330320391;6279.510150242599;6312.779052733133;6446.226452825691;1025.4411345816548;1080.9891901081046;1110.5446766825723;1203.7652657731658;1205.3551350027692;29302.120936371943;29926.551101733057;30300.54549181764;30502.54246186309;30822.53766193509;1111;1118.9888101118884;1177.3995262416229;1194.5460724924474;1303.4069498378215;14940;15016.24918754058;15030.248487575578;15315.540533784004;15356.385744570316;759941;805786;807485;813053;814595;60949.69525152346;61038.38961610327;61362.38637613656;61707.38292617106;61763;1524.4435780939878;1540.499337715247;1542.637480192154;1550.29461594974;1559.688062387527;31498.52752208673;32018.67981320157;32386.83806580952;34642.13394665053;35512.289754204256;54107.18839217494;55071.72464137654;55083.72458137684;55123.72438137783;55247.17129243145;312051;315160;315979;316067;317113;44902.32646510239;45293.320600191684;45612;46048.309275361564;46188.53811461977;48765.268520971505;49774.25338619996;50070.749646251534;55556.444435555124;56882.7155864218;39943.60056399399;40605.1878962425;41043.38434923419;41148.1770364597;41825.58174418217;40163.79918100391;40743.59256407398;41036.58963410328;41176.1764764709;41281.380779288935;38422.423663644506;38699;39265;39596.2080758389;39806.80096599498;34792.652073479956;35069;35202.47196292109;35733.46399803953;36267.45598815967;28318.292042699097;29340.853295733385;29566;30982.690173098883;31149.844250778602 12:20:44 INFO - 2016-01-21 12:20:44,055 DEBUG : BROWSER_OUTPUT: |2;jquery.html;375.13157041449045;380.12760714161016;383.2067620026546;383.6017715427268;385.85337571722744;17354.652906941854;18490.44528664142;18650.533736656573;18696.532586685338;19625.901870490663;12078.214916030453;12204.755904881897;13736.931315343409;18692;18702.71945920812;5235.973820130904;5287.365516138049;5333.040052790496;5352.330958630171;5355.518003379695;3976.840926362942;4070.9592904071023;5272.683638981654;6898.48261380396;7175.42596592274;6949.617771022592;7058.470614703892;7064.576125432465;7105.7157713691395;7155.534890232144;6918.8962165567555;6930.61881596512;6931.653417329113;6949.061876646639;6977.965110174468;6485.513586481033;6608.0418339341;6623.403893649546;6630.834229144261;6675.232348279961;23971.640425393634;23973;24201.515969680684;24499.387515312083;24517.264482065388;2383.332666853284;2490.302715239736;2501.7123030851503;2524.469861329123;2705.945881082387;14948.252587370587;14985.32566034531;15103.47137850181;15287.312070956723;16108.597285067966;2098.244631932503;2166.945826354338;2167.3931299236237;2187.8796666183352;2195.923142690014;70421;77927.61036194839;79162.60418697927;80237;80528.59735701284;16692.24884880183;16985.320587176375;17000.744988825176;17021.57446063858;17077;26802.195934122006;27031.242969206938;27313.590296145572;27499.45001100007;27594.310142246606;8159.79600509992;8232.917670823335;8256.215659512336;8312.5428101455;10258.487075646188;7977.3618110551015;8199.180081991753;8294;8337.708180213664;8359.331253499706;4745.430548334222;4924.8276310328965;4959.454460009396;4966.379202599675;4968;1978.3273686946507;1988.2345297060735;2008.3874418302557;2016.5865997470482;2050.6001329740557;496.2308421945969;504.699703676312;906.4380084347747;1018.5772904244656;1144.9370284634424;11086.611968581223;11943.701407464883;12046.156769026084;12081.516739330329;12188.085893558018;509.3454910440067;510.2422901990541;517.3145582103728;518.9506996835295;536.0458384076351;6451.29035806061;6527.67361631926;6625.801225963229;6635.5023373247195;6681.298463661343;639255;642932;648197;651929;653228;77957;79771;80093.59953200197;86217.56891215504;88627;1155.607093588184;1180.7579446213506;1186.5669030803867;1201.6515210589007;1208.6434501821984;16100.355985760438;16332.836671633608;16448.177591120635;16989.235484402983;17040.82959170442;37971;38106.237875241786;38260.23479530338;38509.22981540298;38931.610683892795;46163;48286;48398.27402589034;48929.755351223015;50200;9586.808263834824;9844.852327214954;9848.753781155241;9916.900830991597;9934.155596774355;12997.295770705303;18038.819611803712;18042.819571804637;18090.366837160636;18189;15386.9230653846;15683.215839208222;15768.526944191693;15852.1281329528;16084.758728618846;15440.382384704486;15460.304286307368;15738;15916.363345466052;16001.439949601709;15776.684466310839;15952.122633255283;16306.592335191715;16530.338786448407;16583;10366.170706343324;10375.221858360503;10394.688159355232;10433.843492347469;10579.841302380624;15777.368905243662;15950.282237299582;15995.280212390702;16009.439669611507;16196.271167797242 12:20:44 INFO - 2016-01-21 12:20:44,056 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1460.2552698123957;1518.2939932931188;1742.2769550636488;1923.3845169545734;1934.8065193480663;7710.11333696625;7927.445078844476;8010;8032.879506807388;8143.063547692017;8217.137200593941;8224.383171262149;8287.875681864776;8306.875396869036;8307.833843323146;2340.508493216427;2379.179183181808;2379.298107058422;2385.689860318156;2388.474535602165;2409.2170044735444;2435.561598912204;2443.51129774045;2447.571674956884;2448.2288079255068;2336.264076815806;2339.368370539953;2374.691290132289;2389.7132344118645;2390.055927908475;2311.884405779721;2314.780095890896;2329;2334.8132149428175;2347.5891718949115;2303.504746479515;2317.4438134847683;2325.6627788970673;2326.6161083421216;2329.138218859016;8014.5591992440395;8016.318612917909;8066.072401673765;8067.314278286352;8083.717069902584;4815;4917.877053073666;4919.950800492021;4924.556789888891;4934.481879402683;3110.4090222857812;3144.528320751883;3144.889928852479;3154.29028468595;3164.857581408842;1001.2690735762934;1010.161565900301;1035.6271742172812;1037.1702637889734;1989.5523507210908;10810.67567972962;10962.835557466644;10986.121110311156;11020.173486988428;11026.779464410667;4234.407182994383;4279.828806847753;4318.1363727254675;4327.17783621111;4333.285007973649;8988.10118988096;8990.370674052885;9007.414518056305;9016.774580635536;9019.368644194843;4856.1016212000895;4859.2954021666665;4915.65590408668;4915.729634870045;4922.532359425849;4460.576245256695;4506.6169375602785;4521.095780843844;4525.886852828706;4530.728156310632;3444.380011597886;3477.930441391158;3518.2435776308216;3528.329617372742;3530.5763308403157;1065.0361422912276;1088.2056099047738;1090.2804149261449;1096.8848270931437;1145.5532342386475;1117.022605220432;1128.6219116595869;1187.2579637726421;1382.384838746748;1442.170751817709;7583.317501424898;7591.848163036709;7720.112187098443;7747.767566973;7754.418418618626;1098.5441041967654;1156.2773266708307;1195.9162858599814;1206.4872429217548;1223.4311045363947;6172.382761723881;6195.039768835838;6219.47134493564;6219.533534984895;6233.283172435228;9236.953815230881;9400.106989835955;9410.670626528039;9486.288528360263;9514.619415223313;9480.478573678514;9486.288528360401;9489.525523723787;9515;9613.03869613033;7050.365467107985;7287.963560182166;7295.6352182390665;7297.832346824483;7368.852622947511;7356.154042284991;7376.96311518439;7447.143578488326;7460.813479663052;7496.925030749622;7986.960065199637;8330.541820199947;8342.708005219789;8357.37319701037;8406.32749380036;8304.377171712025;8310.70912518059;8333.666653334041;8344.165583441607;8355.749327520183;7145.785626431008;7217.6030318333;7281.526700764433;7285.890711639436;7294.781156565312;7361.521501102411;7714.614269286625;7721.073471183269;7743.612819358897;7758.379329653727;6713.56361836479;7128.429725621834;7131.82170445743;7197;7216.7474138404905;6669.4664426844765;7202.315780000891;7260.346568808622;7344.192138864827;7350.338469537767;7230.566166030055;7292.614403263363;7339.77980660581;7355.485116041826;7361.4110871129105;6749.291324411062;6803.081583986099;6827.897581536182;6840.3501667341525;6847.657617119224;6453.451456626051;6479.870402591828;6493.253275873146;6792.93207067923;6812.659367031728 12:20:44 INFO - 2016-01-21 12:20:44,056 DEBUG : BROWSER_OUTPUT: |4;prototype.html;369.77258985723773;373.20321114420705;375.97932113733737;379.6014185105639;386.32393311704516;6275.623462592248;6323.715432805523;6423.325550817167;6444.516661250407;6458.128152699384;6192.195014648089;6299.370062993698;6315.778947736831;6316.621002739827;6351.872962540747;4894.119058569456;4895.55939965403;4903.705777653343;4912.410510738717;4927.433345165298;4932.506749325074;4933.087378834909;4933.40799104108;4941.135301322272;4950.331705219804;4717.834875779348;4811.639127065467;4817.445993710716;4826.058918510892;4842.46732859387;4824.155772739774;4825.131476334259;4830.855074347775;4831.03379324133;4831.22700367943;4244.766537840417;4245.9787701061605;4247.554006829269;4258.53156152823;4264.339027450719;5909.054551271776;5990.73041713124;5995.850103747398;6027.09593560965;6050.455459008666;5583.972080139614;5598.944010559923;5614.073677843151;5621.100623900156;5623.690697011662;6650.268470468244;6675.933240667579;6684.2647308795995;6695.832604184886;6700;4702.224133018048;4709.835155769566;4712.340272361872;4713.57577817998;4721.645876559238;6787.830304242384;6851.38337549618;6868.862622747517;6935.757248496328;6957.095577574883;4828.251620998751;4829.396325459317;4832.492588278251;4834.154023045953;4837.05677392912;4894.559489645878;4896;4898.926516102261;4899.167141585867;4900.656954013256;5473.67157970523;5623.746931388016;5626.240457538262;5628.212050312959;5629.211910332557;6700.2294736105;6712.127423434922;6722.831929201809;6735.865282694319;6740.325967403221;1695.1100672146974;1726.7237242041213;1729;1731.4199743085956;1731.9826801731822;1165.6211731187398;1175.382923964908;1177.5054477119459;1192.9045676345872;1195.36048214205;6430.549861509649;6431.839204019937;6435.549511534241;6443.677816109176;6461.450776683941;6900.068490753684;6900.137482814648;6904.827379315457;6912.101426814583;6924.965375173092;6316.147320111818;6379.043143528508;6399.7440102395385;6425.58233714807;6451.580647257913;3724.683401910868;3733.7386382953478;3763.2097259575794;3765.359888818907;3766.6045065267754;7097.112860892388;7119.110111236096;7123.7506687265695;7126.643667816588;7135.429165666838;6927.688254028581;7036.19083805369;7066.222715501291;7079.752208672672;7081.539699919489;7070.939359096176;7083.574985500886;7102.857942841114;7113.466490013269;7118.928810711826;6904;6910.274421185703;6910.619915904674;6912.205096413775;6912.55068420551;6676.666166691549;6799.11611490503;6802.489813263926;6814.522983391115;6817.488688348493;7085.893711594434;7091.60996145217;7114.822129446598;7116.146062472537;7117;4860.73265970375;4866.586340161126;4866.8053277868485;4868.561829435368;4869.4400143982475;6782.1861376635115;6900.413464855343;6928.653567321715;6941.444684425335;6941.687624056828;6635.502337324817;6658.0345849852465;6699.899501507579;6726.730930762715;6731.1922569292;6673.632950187592;6686.732530698912;6692.397684208445;6700.865982680417;6724.260331363448;6469.708863101077;6588.868222635616;6631.0716499689115;6640;6640.568363056386;6730.057791909235;6762.188537375547;6768.424683901923;6771.356721111487;6785.5250132490255;6541.378569035934;6575.868482630416;6582.736690532325;6587.209534855848;6610.900836487553 12:20:44 INFO - 2016-01-21 12:20:44,057 DEBUG : BROWSER_OUTPUT: |5;yui.html;817.1909809288805;839.9874001889968;941.7504361344243;955.9904400955993;988.8269552828262;15667.686646267068;16142.192890355465;16172.27224774885;16185.109818959952;16196.83803161968;15819.367225311002;15838.920805395986;15975.600609984756;15985.120818354986;16013.35946562139;892.4199270474179;921.3550514639745;923.745969858291;928.3826255540058;931.5621657820848;921.6774129054844;928.1600151862575;931.2131249094505;932.9160375566198;934.8737920380729;966.8888077871029;968.9612415503371;972.9367591106591;972.951352432379;974.7758015656403;957.4207604399343;962.1244667352711;962.8363178259713;963.0225321298888;967.5259123029665;706.8374273916977;709.3119673916293;709.8402859356603;710.3109983316175;712.3268511256864;14805.555833325017;14998.775018374734;15079.773803392958;15131.470398536;15136.167510786903;11582.594609188722;11917.702057448547;12590.874091259153;12611.873881261254;13165.583685863963;10429.843552346721;11036;11164;11238;11259;3939.428782826474;3969.4244334571326;3994.9201015979806;4005.539362973266;4030.8387664493384;49816;50207.497925020645;50309;50984.49015509872;51019;10469.267151299488;10637.840432393521;10675.83986240207;10742.677719668422;11006.119510439146;18830.246790128516;18838.71741923872;18868.15093320804;18879.43361699151;18899.244030238635;7977.122516523178;8003;8022.919770802334;8041.115477297492;8199.60606696863;4514.525974772667;4621.722696638212;4623.098495793288;4682.953170468251;4761;3148.874045038219;3178.6503484616674;3179.7774155809334;3203.19920019995;3213.7107660310685;591.1871177131444;595.0538643556765;595.5473839881721;596.0552524249027;600.1028462448667;611.7400104955376;624.7407325959675;678.4402867634221;711.2780527764323;724.1563578431069;8997.775055623531;9050.366474346733;9142.268618510503;9274.165325120772;9410.482423466638;644.8065580325883;677.549429629291;724;748.7716246544857;779.1273773373857;4077.673786097105;4318.892027699333;4371.759553224603;4388.188185185751;4459.866204013885;55638.44361556414;56650.43349566452;57481.42518574844;57515;57769.13346299809;49697.75151124221;50426.2436063452;50462.243066354036;50538.494615054115;50958.74520627373;43529;43681.815909204415;44008.559914401085;47267.05465890663;47531.5246847534;8774.473531588124;8838.734837954871;8841;9019;9222.769430764285;34400.48399274063;34812.9556113317;35965.46051809173;36295.81852090828;36813.44779828251;44110.55889441193;44135.77932110319;44250;44268;45072.323915140645;11704.122190835551;11740;12019.459124339252;12116.878831211576;12258.509659613515;12194.634160975185;12254.571090011807;12742.49030038788;12749.298788566717;13231;11891.167618266983;11998.820017699567;12059;12210.26738395699;12403.62789116328;11519.25124866881;11822.763544728885;12434.875651243372;12580.433880475584;12724.363781811058;11143.16426268017;11268.098552115647;11302.378369189773;11673;11903.940480297542;10043.548040338057;10398.376097434179;10522.631707890187;10788.676339709822;11092.833607495733;9858.901410985798;9991.200703943521;10165.440900750235;10172.74568135773;10318.226133039901 12:20:44 INFO - 2016-01-21 12:20:44,057 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:20:44 INFO - 2016-01-21 12:20:44,057 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:20:44 INFO - 2016-01-21 12:20:44,058 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,301 12:20:44 INFO - 2016-01-21 12:20:44,058 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:20:44 INFO - 2016-01-21 12:20:44,058 DEBUG : BROWSER_OUTPUT: __startTimestamp1453407644049__endTimestamp 12:20:44 INFO - 2016-01-21 12:20:44,058 DEBUG : BROWSER_OUTPUT: 12:20:44 INFO - 2016-01-21 12:20:44,058 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:20:44 INFO - 2016-01-21 12:20:44,058 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:20:44 INFO - 2016-01-21 12:20:44,058 DEBUG : BROWSER_OUTPUT: 12:20:44 INFO - 2016-01-21 12:20:44,058 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5608.92 Median:5818.24 stddev:626.57 (10.8%) stddev-sans-first:603.44 12:20:44 INFO - 2016-01-21 12:20:44,060 DEBUG : BROWSER_OUTPUT: Values: 3372.7 3385.0 3399.8 3427.3 3431.0 5444.8 5473.3 5496.7 5513.4 5517.0 5543.4 5614.4 5625.5 5632.3 5641.4 5099.9 5129.0 5163.7 5172.1 5189.1 4974.6 5140.0 5143.1 5157.4 5206.5 5055.6 5108.9 5118.8 5121.4 5129.1 5120.8 5147.5 5190.6 5200.2 5211.0 4877.3 4927.2 4996.2 5005.8 5049.9 5418.3 5424.5 5433.6 5466.0 5470.8 5953.2 6021.7 6068.4 6076.5 6084.4 5784.9 5818.2 5978.3 6067.3 6075.9 5701.3 5711.6 5718.5 5731.6 5744.5 6043.9 6162.8 6176.1 6179.8 6202.4 5882.5 5905.9 5916.1 5997.6 6025.7 5947.9 5978.9 5987.7 5992.9 6008.4 5660.9 5779.5 5956.1 5976.1 5976.6 5979.7 6079.2 6098.7 6120.3 6128.7 4626.4 4650.9 4662.0 4662.2 4686.1 4066.3 4091.1 4132.8 4136.5 4205.1 5786.1 5798.4 5810.3 5810.9 5826.6 6163.9 6185.9 6186.3 6186.6 6192.0 5531.5 5645.3 5712.5 5805.0 5820.3 5300.8 5320.2 5321.4 5324.7 5336.3 6281.0 6282.6 6284.0 6291.8 6309.0 5894.4 5984.4 6032.8 6092.9 6124.6 6201.2 6247.3 6256.6 6300.9 6302.9 5893.1 5997.6 6054.3 6054.7 6068.2 6002.7 6041.3 6110.1 6113.1 6118.7 5922.1 5923.3 5939.7 5948.7 5959.7 5690.3 5770.1 5919.6 5926.6 5930.3 5782.0 5860.0 5860.9 5867.6 5911.4 5913.0 5978.8 5979.3 6021.5 6045.1 5654.6 5699.8 5766.3 5903.1 5906.0 12:20:44 INFO - 2016-01-21 12:20:44,060 DEBUG : BROWSER_OUTPUT: 12:20:44 INFO - 2016-01-21 12:20:44,060 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:62599.58 Median:41566.48 stddev:141258.38 (339.8%) stddev-sans-first:141577.97 12:20:44 INFO - 2016-01-21 12:20:44,060 DEBUG : BROWSER_OUTPUT: Values: 608.4 650.8 657.8 671.9 688.0 40666.4 41424.2 41562.2 41570.8 41589.0 46725.3 46859.3 47224.0 47289.0 47393.8 8934.8 9178.7 9191.8 9192.3 9196.5 8896.4 8948.9 8964.1 8991.6 9010.8 8932.5 9062.9 9070.9 9079.2 9114.6 8998.0 9038.3 9069.1 9083.3 9099.4 8938.8 9080.4 9085.2 9107.2 9110.5 41766.0 42167.0 42200.4 42254.6 42310.4 3640.2 3815.5 3815.5 4142.5 4289.9 32350.2 32381.5 32838.0 32935.7 33352.0 4255.1 4292.9 4315.1 4339.0 4347.4 282854.0 284075.0 284226.0 286458.0 286830.0 45538.5 46103.0 64923.4 65135.0 65432.0 43902.6 44259.0 44268.8 44281.0 44291.1 16776.4 16923.7 16972.0 16984.2 17001.7 12417.4 12499.4 12592.6 12672.4 12688.4 15112.0 15528.8 15671.2 15721.7 15743.1 6187.4 6272.2 6279.5 6312.8 6446.2 1025.4 1081.0 1110.5 1203.8 1205.4 29302.1 29926.6 30300.5 30502.5 30822.5 1111.0 1119.0 1177.4 1194.5 1303.4 14940.0 15016.2 15030.2 15315.5 15356.4 759941.0 805786.0 807485.0 813053.0 814595.0 60949.7 61038.4 61362.4 61707.4 61763.0 1524.4 1540.5 1542.6 1550.3 1559.7 31498.5 32018.7 32386.8 34642.1 35512.3 54107.2 55071.7 55083.7 55123.7 55247.2 312051.0 315160.0 315979.0 316067.0 317113.0 44902.3 45293.3 45612.0 46048.3 46188.5 48765.3 49774.3 50070.7 55556.4 56882.7 39943.6 40605.2 41043.4 41148.2 41825.6 40163.8 40743.6 41036.6 41176.2 41281.4 38422.4 38699.0 39265.0 39596.2 39806.8 34792.7 35069.0 35202.5 35733.5 36267.5 28318.3 29340.9 29566.0 30982.7 31149.8 12:20:44 INFO - 2016-01-21 12:20:44,060 DEBUG : BROWSER_OUTPUT: 12:20:44 INFO - 2016-01-21 12:20:44,061 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33618.09 Median:27406.52 stddev:105646.90 (385.5%) stddev-sans-first:105913.78 12:20:44 INFO - 2016-01-21 12:20:44,062 DEBUG : BROWSER_OUTPUT: Values: 375.1 380.1 383.2 383.6 385.9 17354.7 18490.4 18650.5 18696.5 19625.9 12078.2 12204.8 13736.9 18692.0 18702.7 5236.0 5287.4 5333.0 5352.3 5355.5 3976.8 4071.0 5272.7 6898.5 7175.4 6949.6 7058.5 7064.6 7105.7 7155.5 6918.9 6930.6 6931.7 6949.1 6978.0 6485.5 6608.0 6623.4 6630.8 6675.2 23971.6 23973.0 24201.5 24499.4 24517.3 2383.3 2490.3 2501.7 2524.5 2705.9 14948.3 14985.3 15103.5 15287.3 16108.6 2098.2 2166.9 2167.4 2187.9 2195.9 70421.0 77927.6 79162.6 80237.0 80528.6 16692.2 16985.3 17000.7 17021.6 17077.0 26802.2 27031.2 27313.6 27499.5 27594.3 8159.8 8232.9 8256.2 8312.5 10258.5 7977.4 8199.2 8294.0 8337.7 8359.3 4745.4 4924.8 4959.5 4966.4 4968.0 1978.3 1988.2 2008.4 2016.6 2050.6 496.2 504.7 906.4 1018.6 1144.9 11086.6 11943.7 12046.2 12081.5 12188.1 509.3 510.2 517.3 519.0 536.0 6451.3 6527.7 6625.8 6635.5 6681.3 639255.0 642932.0 648197.0 651929.0 653228.0 77957.0 79771.0 80093.6 86217.6 88627.0 1155.6 1180.8 1186.6 1201.7 1208.6 16100.4 16332.8 16448.2 16989.2 17040.8 37971.0 38106.2 38260.2 38509.2 38931.6 46163.0 48286.0 48398.3 48929.8 50200.0 9586.8 9844.9 9848.8 9916.9 9934.2 12997.3 18038.8 18042.8 18090.4 18189.0 15386.9 15683.2 15768.5 15852.1 16084.8 15440.4 15460.3 15738.0 15916.4 16001.4 15776.7 15952.1 16306.6 16530.3 16583.0 10366.2 10375.2 10394.7 10433.8 10579.8 15777.4 15950.3 15995.3 16009.4 16196.3 12:20:44 INFO - 2016-01-21 12:20:44,062 DEBUG : BROWSER_OUTPUT: 12:20:44 INFO - 2016-01-21 12:20:44,062 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5604.93 Median:6466.66 stddev:2853.70 (44.1%) stddev-sans-first:2844.70 12:20:44 INFO - 2016-01-21 12:20:44,062 DEBUG : BROWSER_OUTPUT: Values: 1460.3 1518.3 1742.3 1923.4 1934.8 7710.1 7927.4 8010.0 8032.9 8143.1 8217.1 8224.4 8287.9 8306.9 8307.8 2340.5 2379.2 2379.3 2385.7 2388.5 2409.2 2435.6 2443.5 2447.6 2448.2 2336.3 2339.4 2374.7 2389.7 2390.1 2311.9 2314.8 2329.0 2334.8 2347.6 2303.5 2317.4 2325.7 2326.6 2329.1 8014.6 8016.3 8066.1 8067.3 8083.7 4815.0 4917.9 4920.0 4924.6 4934.5 3110.4 3144.5 3144.9 3154.3 3164.9 1001.3 1010.2 1035.6 1037.2 1989.6 10810.7 10962.8 10986.1 11020.2 11026.8 4234.4 4279.8 4318.1 4327.2 4333.3 8988.1 8990.4 9007.4 9016.8 9019.4 4856.1 4859.3 4915.7 4915.7 4922.5 4460.6 4506.6 4521.1 4525.9 4530.7 3444.4 3477.9 3518.2 3528.3 3530.6 1065.0 1088.2 1090.3 1096.9 1145.6 1117.0 1128.6 1187.3 1382.4 1442.2 7583.3 7591.8 7720.1 7747.8 7754.4 1098.5 1156.3 1195.9 1206.5 1223.4 6172.4 6195.0 6219.5 6219.5 6233.3 9237.0 9400.1 9410.7 9486.3 9514.6 9480.5 9486.3 9489.5 9515.0 9613.0 7050.4 7288.0 7295.6 7297.8 7368.9 7356.2 7377.0 7447.1 7460.8 7496.9 7987.0 8330.5 8342.7 8357.4 8406.3 8304.4 8310.7 8333.7 8344.2 8355.7 7145.8 7217.6 7281.5 7285.9 7294.8 7361.5 7714.6 7721.1 7743.6 7758.4 6713.6 7128.4 7131.8 7197.0 7216.7 6669.5 7202.3 7260.3 7344.2 7350.3 7230.6 7292.6 7339.8 7355.5 7361.4 6749.3 6803.1 6827.9 6840.4 6847.7 6453.5 6479.9 6493.3 6792.9 6812.7 12:20:44 INFO - 2016-01-21 12:20:44,062 DEBUG : BROWSER_OUTPUT: 12:20:44 INFO - 2016-01-21 12:20:44,063 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5618.09 Median:6424.45 stddev:1666.41 (25.9%) stddev-sans-first:1623.86 12:20:44 INFO - 2016-01-21 12:20:44,064 DEBUG : BROWSER_OUTPUT: Values: 369.8 373.2 376.0 379.6 386.3 6275.6 6323.7 6423.3 6444.5 6458.1 6192.2 6299.4 6315.8 6316.6 6351.9 4894.1 4895.6 4903.7 4912.4 4927.4 4932.5 4933.1 4933.4 4941.1 4950.3 4717.8 4811.6 4817.4 4826.1 4842.5 4824.2 4825.1 4830.9 4831.0 4831.2 4244.8 4246.0 4247.6 4258.5 4264.3 5909.1 5990.7 5995.9 6027.1 6050.5 5584.0 5598.9 5614.1 5621.1 5623.7 6650.3 6675.9 6684.3 6695.8 6700.0 4702.2 4709.8 4712.3 4713.6 4721.6 6787.8 6851.4 6868.9 6935.8 6957.1 4828.3 4829.4 4832.5 4834.2 4837.1 4894.6 4896.0 4898.9 4899.2 4900.7 5473.7 5623.7 5626.2 5628.2 5629.2 6700.2 6712.1 6722.8 6735.9 6740.3 1695.1 1726.7 1729.0 1731.4 1732.0 1165.6 1175.4 1177.5 1192.9 1195.4 6430.5 6431.8 6435.5 6443.7 6461.5 6900.1 6900.1 6904.8 6912.1 6925.0 6316.1 6379.0 6399.7 6425.6 6451.6 3724.7 3733.7 3763.2 3765.4 3766.6 7097.1 7119.1 7123.8 7126.6 7135.4 6927.7 7036.2 7066.2 7079.8 7081.5 7070.9 7083.6 7102.9 7113.5 7118.9 6904.0 6910.3 6910.6 6912.2 6912.6 6676.7 6799.1 6802.5 6814.5 6817.5 7085.9 7091.6 7114.8 7116.1 7117.0 4860.7 4866.6 4866.8 4868.6 4869.4 6782.2 6900.4 6928.7 6941.4 6941.7 6635.5 6658.0 6699.9 6726.7 6731.2 6673.6 6686.7 6692.4 6700.9 6724.3 6469.7 6588.9 6631.1 6640.0 6640.6 6730.1 6762.2 6768.4 6771.4 6785.5 6541.4 6575.9 6582.7 6587.2 6610.9 12:20:44 INFO - 2016-01-21 12:20:44,064 DEBUG : BROWSER_OUTPUT: 12:20:44 INFO - 2016-01-21 12:20:44,064 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14273.98 Median:44123.17 stddev:15874.97 (36.0%) stddev-sans-first:15887.34 12:20:44 INFO - 2016-01-21 12:20:44,064 DEBUG : BROWSER_OUTPUT: Values: 817.2 840.0 941.8 956.0 988.8 15667.7 16142.2 16172.3 16185.1 16196.8 15819.4 15838.9 15975.6 15985.1 16013.4 892.4 921.4 923.7 928.4 931.6 921.7 928.2 931.2 932.9 934.9 966.9 969.0 972.9 973.0 974.8 957.4 962.1 962.8 963.0 967.5 706.8 709.3 709.8 710.3 712.3 14805.6 14998.8 15079.8 15131.5 15136.2 11582.6 11917.7 12590.9 12611.9 13165.6 10429.8 11036.0 11164.0 11238.0 11259.0 3939.4 3969.4 3994.9 4005.5 4030.8 49816.0 50207.5 50309.0 50984.5 51019.0 10469.3 10637.8 10675.8 10742.7 11006.1 18830.2 18838.7 18868.2 18879.4 18899.2 7977.1 8003.0 8022.9 8041.1 8199.6 4514.5 4621.7 4623.1 4683.0 4761.0 3148.9 3178.7 3179.8 3203.2 3213.7 591.2 595.1 595.5 596.1 600.1 611.7 624.7 678.4 711.3 724.2 8997.8 9050.4 9142.3 9274.2 9410.5 644.8 677.5 724.0 748.8 779.1 4077.7 4318.9 4371.8 4388.2 4459.9 55638.4 56650.4 57481.4 57515.0 57769.1 49697.8 50426.2 50462.2 50538.5 50958.7 43529.0 43681.8 44008.6 47267.1 47531.5 8774.5 8838.7 8841.0 9019.0 9222.8 34400.5 34813.0 35965.5 36295.8 36813.4 44110.6 44135.8 44250.0 44268.0 45072.3 11704.1 11740.0 12019.5 12116.9 12258.5 12194.6 12254.6 12742.5 12749.3 13231.0 11891.2 11998.8 12059.0 12210.3 12403.6 11519.3 11822.8 12434.9 12580.4 12724.4 11143.2 11268.1 11302.4 11673.0 11903.9 10043.5 10398.4 10522.6 10788.7 11092.8 9858.9 9991.2 10165.4 10172.7 10318.2 12:20:44 INFO - 2016-01-21 12:20:44,064 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:20:44 INFO - 2016-01-21 12:20:44,064 DEBUG : BROWSER_OUTPUT: 12:20:44 INFO - 2016-01-21 12:20:44,669 INFO : Browser exited with error code: 0 12:20:44 INFO - 2016-01-21 12:20:44,686 INFO : Completed test dromaeo_css (00:18:28) 12:20:44 INFO - 2016-01-21 12:20:44,686 INFO : Starting test kraken 12:20:44 INFO - 2016-01-21 12:20:44,686 DEBUG : operating with platform_type : linux_ 12:20:44 INFO - 2016-01-21 12:20:44,686 INFO : Initialising browser for kraken test... 12:20:44 INFO - 2016-01-21 12:20:44,693 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGiAtT1/profile http://localhost:39462/getInfo.html 12:20:48 INFO - 2016-01-21 12:20:48,473 DEBUG : BROWSER_OUTPUT: 12:20:48 INFO - 2016-01-21 12:20:48,473 DEBUG : BROWSER_OUTPUT: (process:14640): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:20:49 INFO - 2016-01-21 12:20:49,376 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:20:49 INFO - 2016-01-21 12:20:49,376 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:20:49 INFO - 2016-01-21 12:20:49,376 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:20:49 INFO - 2016-01-21 12:20:49,376 DEBUG : BROWSER_OUTPUT: __metrics 12:20:50 INFO - 2016-01-21 12:20:50,301 INFO : Browser initialized. 12:20:50 INFO - 2016-01-21 12:20:50,302 INFO : Running cycle 1/1 for kraken test... 12:20:50 INFO - 2016-01-21 12:20:50,302 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGiAtT1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:20:51 INFO - 2016-01-21 12:20:51,605 DEBUG : BROWSER_OUTPUT: 12:20:51 INFO - 2016-01-21 12:20:51,605 DEBUG : BROWSER_OUTPUT: (process:14756): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:21:02 INFO - 2016-01-21 12:21:02,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 136572928 12:21:02 INFO - 2016-01-21 12:21:02,110 DEBUG : BROWSER_OUTPUT: 12:21:04 INFO - 2016-01-21 12:21:04,536 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39462/tests/kraken/driver.html?testName=audio-beat-detection) 12:21:05 INFO - 2016-01-21 12:21:05,142 DEBUG : BROWSER_OUTPUT: RSS: Main: 137588736 12:21:05 INFO - 2016-01-21 12:21:05,142 DEBUG : BROWSER_OUTPUT: 12:21:07 INFO - 2016-01-21 12:21:07,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39462/tests/kraken/driver.html?testName=audio-dft) 12:21:08 INFO - 2016-01-21 12:21:08,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 138878976 12:21:08 INFO - 2016-01-21 12:21:08,325 DEBUG : BROWSER_OUTPUT: 12:21:11 INFO - 2016-01-21 12:21:11,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39462/tests/kraken/driver.html?testName=audio-fft) 12:21:11 INFO - 2016-01-21 12:21:11,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 139608064 12:21:11 INFO - 2016-01-21 12:21:11,692 DEBUG : BROWSER_OUTPUT: 12:21:13 INFO - 2016-01-21 12:21:13,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39462/tests/kraken/driver.html?testName=audio-oscillator) 12:21:14 INFO - 2016-01-21 12:21:14,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 139067392 12:21:14 INFO - 2016-01-21 12:21:14,291 DEBUG : BROWSER_OUTPUT: 12:21:16 INFO - 2016-01-21 12:21:16,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39462/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:21:17 INFO - 2016-01-21 12:21:17,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 139497472 12:21:17 INFO - 2016-01-21 12:21:17,074 DEBUG : BROWSER_OUTPUT: 12:21:19 INFO - 2016-01-21 12:21:19,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39462/tests/kraken/driver.html?testName=imaging-darkroom) 12:21:20 INFO - 2016-01-21 12:21:20,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 137961472 12:21:20 INFO - 2016-01-21 12:21:20,567 DEBUG : BROWSER_OUTPUT: 12:21:23 INFO - 2016-01-21 12:21:23,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39462/tests/kraken/driver.html?testName=imaging-desaturate) 12:21:24 INFO - 2016-01-21 12:21:24,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 138215424 12:21:24 INFO - 2016-01-21 12:21:24,476 DEBUG : BROWSER_OUTPUT: 12:21:27 INFO - 2016-01-21 12:21:27,242 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39462/tests/kraken/driver.html?testName=json-parse-financial) 12:21:27 INFO - 2016-01-21 12:21:27,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 138420224 12:21:27 INFO - 2016-01-21 12:21:27,832 DEBUG : BROWSER_OUTPUT: 12:21:29 INFO - 2016-01-21 12:21:29,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39462/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:21:29 INFO - 2016-01-21 12:21:29,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 137506816 12:21:29 INFO - 2016-01-21 12:21:29,990 DEBUG : BROWSER_OUTPUT: 12:21:31 INFO - 2016-01-21 12:21:31,760 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39462/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:21:32 INFO - 2016-01-21 12:21:32,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 137936896 12:21:32 INFO - 2016-01-21 12:21:32,367 DEBUG : BROWSER_OUTPUT: 12:21:34 INFO - 2016-01-21 12:21:34,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39462/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:21:35 INFO - 2016-01-21 12:21:35,024 DEBUG : BROWSER_OUTPUT: RSS: Main: 139714560 12:21:35 INFO - 2016-01-21 12:21:35,024 DEBUG : BROWSER_OUTPUT: 12:21:37 INFO - 2016-01-21 12:21:37,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:21:38 INFO - 2016-01-21 12:21:38,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 138854400 12:21:38 INFO - 2016-01-21 12:21:38,023 DEBUG : BROWSER_OUTPUT: 12:21:40 INFO - 2016-01-21 12:21:40,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:21:41 INFO - 2016-01-21 12:21:41,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 137814016 12:21:41 INFO - 2016-01-21 12:21:41,141 DEBUG : BROWSER_OUTPUT: 12:21:42 INFO - 2016-01-21 12:21:42,809 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39462/tests/kraken/driver.html?testName=ai-astar) 12:21:43 INFO - 2016-01-21 12:21:43,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 138551296 12:21:43 INFO - 2016-01-21 12:21:43,060 DEBUG : BROWSER_OUTPUT: 12:21:43 INFO - 2016-01-21 12:21:43,060 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:21:43 INFO - 2016-01-21 12:21:43,060 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:21:43 INFO - 2016-01-21 12:21:43,061 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:21:43 INFO - 2016-01-21 12:21:43,062 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:21:43 INFO - 2016-01-21 12:21:43,062 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;103;112;109;112;121;111;110;109;110 12:21:43 INFO - 2016-01-21 12:21:43,062 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;122;147;158;129;144;157;131;170;127 12:21:43 INFO - 2016-01-21 12:21:43,062 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;162;162;161;160;162;163;164;164 12:21:43 INFO - 2016-01-21 12:21:43,062 DEBUG : BROWSER_OUTPUT: |3;audio-fft;76;71;71;153;72;73;72;72;164;71 12:21:43 INFO - 2016-01-21 12:21:43,062 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;92;144;91;93;94;143;92;95;132 12:21:43 INFO - 2016-01-21 12:21:43,062 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;110;109;110;110;110;109 12:21:43 INFO - 2016-01-21 12:21:43,063 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;149;146;146;146;146;146;146;146;146 12:21:43 INFO - 2016-01-21 12:21:43,063 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;96;96;95;97;95;95 12:21:43 INFO - 2016-01-21 12:21:43,063 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;64;61;61;61;61;61;61;59;59 12:21:43 INFO - 2016-01-21 12:21:43,063 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;63;63;62;63;62;62;64;62;62 12:21:43 INFO - 2016-01-21 12:21:43,063 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;88;81;84;90;83;91;97;84;82;91 12:21:43 INFO - 2016-01-21 12:21:43,063 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;120;121;115;116;119;121;121;118;131 12:21:43 INFO - 2016-01-21 12:21:43,063 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;149;146;143;149;146;147;149;145;148 12:21:43 INFO - 2016-01-21 12:21:43,064 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;69;66;66;68;67;66;67;67;69 12:21:43 INFO - 2016-01-21 12:21:43,064 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:21:43 INFO - 2016-01-21 12:21:43,064 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:21:43 INFO - 2016-01-21 12:21:43,064 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,707 12:21:43 INFO - 2016-01-21 12:21:43,064 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:21:43 INFO - 2016-01-21 12:21:43,064 DEBUG : BROWSER_OUTPUT: __startTimestamp1453407703059__endTimestamp 12:21:43 INFO - 2016-01-21 12:21:43,064 DEBUG : BROWSER_OUTPUT: 12:21:43 INFO - 2016-01-21 12:21:43,068 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:21:43 INFO - 2016-01-21 12:21:43,068 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:21:43 INFO - 2016-01-21 12:21:43,068 DEBUG : BROWSER_OUTPUT: 12:21:43 INFO - 2016-01-21 12:21:43,068 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:4.42 (4.0%) stddev-sans-first:4.68 12:21:43 INFO - 2016-01-21 12:21:43,069 DEBUG : BROWSER_OUTPUT: Values: 111.0 103.0 112.0 109.0 112.0 121.0 111.0 110.0 109.0 110.0 12:21:43 INFO - 2016-01-21 12:21:43,069 DEBUG : BROWSER_OUTPUT: 12:21:43 INFO - 2016-01-21 12:21:43,069 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.50 Median:148.50 stddev:15.81 (10.6%) stddev-sans-first:16.60 12:21:43 INFO - 2016-01-21 12:21:43,069 DEBUG : BROWSER_OUTPUT: Values: 150.0 122.0 147.0 158.0 129.0 144.0 157.0 131.0 170.0 127.0 12:21:43 INFO - 2016-01-21 12:21:43,069 DEBUG : BROWSER_OUTPUT: 12:21:43 INFO - 2016-01-21 12:21:43,069 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 12:21:43 INFO - 2016-01-21 12:21:43,070 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 162.0 162.0 161.0 160.0 162.0 163.0 164.0 164.0 12:21:43 INFO - 2016-01-21 12:21:43,070 DEBUG : BROWSER_OUTPUT: 12:21:43 INFO - 2016-01-21 12:21:43,070 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.50 Median:72.00 stddev:36.49 (50.7%) stddev-sans-first:38.37 12:21:43 INFO - 2016-01-21 12:21:43,070 DEBUG : BROWSER_OUTPUT: Values: 76.0 71.0 71.0 153.0 72.0 73.0 72.0 72.0 164.0 71.0 12:21:43 INFO - 2016-01-21 12:21:43,070 DEBUG : BROWSER_OUTPUT: 12:21:43 INFO - 2016-01-21 12:21:43,070 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.00 Median:92.50 stddev:22.79 (24.6%) stddev-sans-first:23.68 12:21:43 INFO - 2016-01-21 12:21:43,070 DEBUG : BROWSER_OUTPUT: Values: 94.0 92.0 144.0 91.0 93.0 94.0 143.0 92.0 95.0 132.0 12:21:43 INFO - 2016-01-21 12:21:43,070 DEBUG : BROWSER_OUTPUT: 12:21:43 INFO - 2016-01-21 12:21:43,070 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 12:21:43 INFO - 2016-01-21 12:21:43,071 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 12:21:43 INFO - 2016-01-21 12:21:43,071 DEBUG : BROWSER_OUTPUT: 12:21:43 INFO - 2016-01-21 12:21:43,071 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 12:21:43 INFO - 2016-01-21 12:21:43,071 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 12:21:43 INFO - 2016-01-21 12:21:43,071 DEBUG : BROWSER_OUTPUT: 12:21:43 INFO - 2016-01-21 12:21:43,071 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 12:21:43 INFO - 2016-01-21 12:21:43,071 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 96.0 96.0 95.0 97.0 95.0 95.0 12:21:43 INFO - 2016-01-21 12:21:43,071 DEBUG : BROWSER_OUTPUT: 12:21:43 INFO - 2016-01-21 12:21:43,071 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.00 stddev:1.37 (2.2%) stddev-sans-first:1.45 12:21:43 INFO - 2016-01-21 12:21:43,072 DEBUG : BROWSER_OUTPUT: Values: 61.0 64.0 61.0 61.0 61.0 61.0 61.0 61.0 59.0 59.0 12:21:43 INFO - 2016-01-21 12:21:43,072 DEBUG : BROWSER_OUTPUT: 12:21:43 INFO - 2016-01-21 12:21:43,072 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 12:21:43 INFO - 2016-01-21 12:21:43,072 DEBUG : BROWSER_OUTPUT: Values: 62.0 63.0 63.0 62.0 63.0 62.0 62.0 64.0 62.0 62.0 12:21:43 INFO - 2016-01-21 12:21:43,072 DEBUG : BROWSER_OUTPUT: 12:21:43 INFO - 2016-01-21 12:21:43,072 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:89.00 stddev:5.13 (5.8%) stddev-sans-first:5.43 12:21:43 INFO - 2016-01-21 12:21:43,072 DEBUG : BROWSER_OUTPUT: Values: 88.0 81.0 84.0 90.0 83.0 91.0 97.0 84.0 82.0 91.0 12:21:43 INFO - 2016-01-21 12:21:43,072 DEBUG : BROWSER_OUTPUT: 12:21:43 INFO - 2016-01-21 12:21:43,072 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:120.50 stddev:4.90 (4.1%) stddev-sans-first:4.60 12:21:43 INFO - 2016-01-21 12:21:43,072 DEBUG : BROWSER_OUTPUT: Values: 113.0 120.0 121.0 115.0 116.0 119.0 121.0 121.0 118.0 131.0 12:21:43 INFO - 2016-01-21 12:21:43,072 DEBUG : BROWSER_OUTPUT: 12:21:43 INFO - 2016-01-21 12:21:43,072 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.50 Median:147.50 stddev:2.32 (1.6%) stddev-sans-first:2.09 12:21:43 INFO - 2016-01-21 12:21:43,072 DEBUG : BROWSER_OUTPUT: Values: 143.0 149.0 146.0 143.0 149.0 146.0 147.0 149.0 145.0 148.0 12:21:43 INFO - 2016-01-21 12:21:43,072 DEBUG : BROWSER_OUTPUT: 12:21:43 INFO - 2016-01-21 12:21:43,073 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 12:21:43 INFO - 2016-01-21 12:21:43,073 DEBUG : BROWSER_OUTPUT: Values: 66.0 69.0 66.0 66.0 68.0 67.0 66.0 67.0 67.0 69.0 12:21:43 INFO - 2016-01-21 12:21:43,073 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:21:43 INFO - 2016-01-21 12:21:43,073 DEBUG : BROWSER_OUTPUT: 12:21:43 INFO - 2016-01-21 12:21:43,881 INFO : Browser exited with error code: 0 12:21:44 INFO - 2016-01-21 12:21:44,013 INFO : Completed test kraken (00:00:59) 12:21:44 INFO - 2016-01-21 12:21:44,013 INFO : Starting test v8_7 12:21:44 INFO - 2016-01-21 12:21:44,013 DEBUG : operating with platform_type : linux_ 12:21:44 INFO - 2016-01-21 12:21:44,013 INFO : Initialising browser for v8_7 test... 12:21:44 INFO - 2016-01-21 12:21:44,019 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7hWLP8/profile http://localhost:39462/getInfo.html 12:21:47 INFO - 2016-01-21 12:21:47,647 DEBUG : BROWSER_OUTPUT: 12:21:47 INFO - 2016-01-21 12:21:47,647 DEBUG : BROWSER_OUTPUT: (process:15064): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:21:48 INFO - 2016-01-21 12:21:48,557 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:21:48 INFO - 2016-01-21 12:21:48,557 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:21:48 INFO - 2016-01-21 12:21:48,557 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:21:48 INFO - 2016-01-21 12:21:48,557 DEBUG : BROWSER_OUTPUT: __metrics 12:21:49 INFO - 2016-01-21 12:21:49,501 INFO : Browser initialized. 12:21:49 INFO - 2016-01-21 12:21:49,502 INFO : Running cycle 1/1 for v8_7 test... 12:21:49 INFO - 2016-01-21 12:21:49,502 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7hWLP8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:21:50 INFO - 2016-01-21 12:21:50,827 DEBUG : BROWSER_OUTPUT: 12:21:50 INFO - 2016-01-21 12:21:50,827 DEBUG : BROWSER_OUTPUT: (process:15179): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:22:01 INFO - 2016-01-21 12:22:01,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 136388608 12:22:01 INFO - 2016-01-21 12:22:01,336 DEBUG : BROWSER_OUTPUT: 12:22:22 INFO - 2016-01-21 12:22:22,701 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39462/tests/v8_7/run.html (next: http://localhost:39462/tests/v8_7/run.html) 12:22:22 INFO - 2016-01-21 12:22:22,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 136142848 12:22:22 INFO - 2016-01-21 12:22:22,952 DEBUG : BROWSER_OUTPUT: 12:22:22 INFO - 2016-01-21 12:22:22,952 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:22:22 INFO - 2016-01-21 12:22:22,953 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:22:22 INFO - 2016-01-21 12:22:22,953 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:22:22 INFO - 2016-01-21 12:22:22,953 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:22:22 INFO - 2016-01-21 12:22:22,953 DEBUG : BROWSER_OUTPUT: |0;Richards;166.77785190126752 12:22:22 INFO - 2016-01-21 12:22:22,954 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.0564650851988 12:22:22 INFO - 2016-01-21 12:22:22,954 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.39643652561244 12:22:22 INFO - 2016-01-21 12:22:22,954 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5164.948453608247 12:22:22 INFO - 2016-01-21 12:22:22,955 DEBUG : BROWSER_OUTPUT: |4;RayTrace;913.2420091324201 12:22:22 INFO - 2016-01-21 12:22:22,955 DEBUG : BROWSER_OUTPUT: |5;Earley;552.4861878453039 12:22:22 INFO - 2016-01-21 12:22:22,955 DEBUG : BROWSER_OUTPUT: |6;Boyer;10923.91304347826 12:22:22 INFO - 2016-01-21 12:22:22,955 DEBUG : BROWSER_OUTPUT: |7;RegExp;24682.926829268294 12:22:22 INFO - 2016-01-21 12:22:22,956 DEBUG : BROWSER_OUTPUT: |8;Splay;521.6484089723526 12:22:22 INFO - 2016-01-21 12:22:22,956 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 12:22:22 INFO - 2016-01-21 12:22:22,956 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:22:22 INFO - 2016-01-21 12:22:22,956 DEBUG : BROWSER_OUTPUT: __startTimestamp1453407742949__endTimestamp 12:22:22 INFO - 2016-01-21 12:22:22,957 DEBUG : BROWSER_OUTPUT: 12:22:22 INFO - 2016-01-21 12:22:22,957 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:22:22 INFO - 2016-01-21 12:22:22,957 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:22:22 INFO - 2016-01-21 12:22:22,957 DEBUG : BROWSER_OUTPUT: 12:22:22 INFO - 2016-01-21 12:22:22,957 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.78 Median:166.78 stddev:0.00 (0.0%) 12:22:22 INFO - 2016-01-21 12:22:22,957 DEBUG : BROWSER_OUTPUT: Values: 166.8 12:22:22 INFO - 2016-01-21 12:22:22,957 DEBUG : BROWSER_OUTPUT: 12:22:22 INFO - 2016-01-21 12:22:22,958 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.06 Median:167.06 stddev:0.00 (0.0%) 12:22:22 INFO - 2016-01-21 12:22:22,958 DEBUG : BROWSER_OUTPUT: Values: 167.1 12:22:22 INFO - 2016-01-21 12:22:22,958 DEBUG : BROWSER_OUTPUT: 12:22:22 INFO - 2016-01-21 12:22:22,958 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 12:22:22 INFO - 2016-01-21 12:22:22,958 DEBUG : BROWSER_OUTPUT: Values: 278.4 12:22:22 INFO - 2016-01-21 12:22:22,958 DEBUG : BROWSER_OUTPUT: 12:22:22 INFO - 2016-01-21 12:22:22,958 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 12:22:22 INFO - 2016-01-21 12:22:22,958 DEBUG : BROWSER_OUTPUT: Values: 5164.9 12:22:22 INFO - 2016-01-21 12:22:22,958 DEBUG : BROWSER_OUTPUT: 12:22:22 INFO - 2016-01-21 12:22:22,959 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:913.24 Median:913.24 stddev:0.00 (0.0%) 12:22:22 INFO - 2016-01-21 12:22:22,959 DEBUG : BROWSER_OUTPUT: Values: 913.2 12:22:22 INFO - 2016-01-21 12:22:22,959 DEBUG : BROWSER_OUTPUT: 12:22:22 INFO - 2016-01-21 12:22:22,959 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:552.49 Median:552.49 stddev:0.00 (0.0%) 12:22:22 INFO - 2016-01-21 12:22:22,959 DEBUG : BROWSER_OUTPUT: Values: 552.5 12:22:22 INFO - 2016-01-21 12:22:22,959 DEBUG : BROWSER_OUTPUT: 12:22:22 INFO - 2016-01-21 12:22:22,959 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10923.91 Median:10923.91 stddev:0.00 (0.0%) 12:22:22 INFO - 2016-01-21 12:22:22,959 DEBUG : BROWSER_OUTPUT: Values: 10923.9 12:22:22 INFO - 2016-01-21 12:22:22,959 DEBUG : BROWSER_OUTPUT: 12:22:22 INFO - 2016-01-21 12:22:22,960 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24682.93 Median:24682.93 stddev:0.00 (0.0%) 12:22:22 INFO - 2016-01-21 12:22:22,960 DEBUG : BROWSER_OUTPUT: Values: 24682.9 12:22:22 INFO - 2016-01-21 12:22:22,960 DEBUG : BROWSER_OUTPUT: 12:22:22 INFO - 2016-01-21 12:22:22,960 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:521.65 Median:521.65 stddev:0.00 (0.0%) 12:22:22 INFO - 2016-01-21 12:22:22,960 DEBUG : BROWSER_OUTPUT: Values: 521.6 12:22:22 INFO - 2016-01-21 12:22:22,960 DEBUG : BROWSER_OUTPUT: 12:22:22 INFO - 2016-01-21 12:22:22,960 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 12:22:22 INFO - 2016-01-21 12:22:22,960 DEBUG : BROWSER_OUTPUT: Values: 4840.6 12:22:22 INFO - 2016-01-21 12:22:22,960 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:22:22 INFO - 2016-01-21 12:22:22,960 DEBUG : BROWSER_OUTPUT: 12:22:23 INFO - 2016-01-21 12:22:23,766 INFO : Browser exited with error code: 0 12:22:23 INFO - 2016-01-21 12:22:23,777 INFO : Completed test v8_7 (00:00:39) 12:22:23 INFO - 2016-01-21 12:22:23,986 INFO : Completed test suite (00:20:08) 12:22:23 INFO - 2016-01-21 12:22:23,986 DEBUG : Working with test: dromaeo_css 12:22:23 INFO - 2016-01-21 12:22:23,986 DEBUG : Generating results file: dromaeo_css 12:22:23 INFO - 2016-01-21 12:22:23,987 DEBUG : Working with test: kraken 12:22:23 INFO - 2016-01-21 12:22:23,988 DEBUG : Generating results file: kraken 12:22:23 INFO - 2016-01-21 12:22:23,988 INFO : javascript benchmark 12:22:23 INFO - 2016-01-21 12:22:23,988 DEBUG : Working with test: v8_7 12:22:23 INFO - 2016-01-21 12:22:23,988 DEBUG : Generating results file: v8_7 12:22:23 INFO - 2016-01-21 12:22:23,988 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:22:24 INFO - 2016-01-21 12:22:24,052 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 12:22:24 INFO - 2016-01-21 12:22:24,052 DEBUG : process_Request line: dromaeo_css 7482.62 graph.html#tests=[[72,52,43]] 12:22:24 INFO - 2016-01-21 12:22:24,052 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:22:24 INFO - 2016-01-21 12:22:24,230 DEBUG : process_Request line: kraken 1508.60 graph.html#tests=[[232,52,43]] 12:22:24 INFO - 2016-01-21 12:22:24,230 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:22:24 INFO - 2016-01-21 12:22:24,368 DEBUG : process_Request line: v8_7 23204.04 graph.html#tests=[[230,52,43]] 12:22:24 INFO - 2016-01-21 12:22:24,369 INFO : javascript benchmark 12:22:24 INFO - 2016-01-21 12:22:24,373 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3372.6964573188416, 3385.00142457975, 3399.7620166588317, 3427.3316703242876, 3431.0, 5444.782208711652, 5473.28847249857, 5496.670199788011, 5513.365962914261, 5517.0, 5543.445655434454, 5614.3543492498375, 5625.493705566499, 5632.26780518533, 5641.407652196522, 5099.872503187422, 5129.0, 5163.664361816489, 5172.069027575054, 5189.091908915924, 4974.577160941324, 5139.972005598876, 5143.09995750744, 5157.432682404951, 5206.505381988705, 5055.646104772667, 5108.923366149511, 5118.846434606968, 5121.436641969381, 5129.051125541768, 5120.795168193268, 5147.48525147486, 5190.6107041972, 5200.245964335188, 5211.0, 4877.317175595419, 4927.1870141426625, 4996.150654388726, 5005.824796132118, 5049.924251136236, 5418.349798024223, 5424.457554244584, 5433.565314774809, 5466.0, 5470.753816078286, 5953.226080609536, 6021.6989150542295, 6068.393160683941, 6076.513878889722, 6084.361142080063, 5784.913226301609, 5818.2436283282905, 5978.282606087254, 6067.2719273687, 6075.939240607626, 5701.287339082614, 5711.62874413166, 5718.513926316226, 5731.627444216113, 5744.540436765049, 6043.8791224175275, 6162.845928851725, 6176.104464852661, 6179.752809887555, 6202.4417802398, 5882.499987501024, 5905.852353691193, 5916.083007133901, 5997.580169388189, 6025.728842202024, 5947.881042379128, 5978.880422391615, 5987.730552125165, 5992.940070599238, 6008.399160084044, 5660.858478537987, 5779.450952159538, 5956.1065840123465, 5976.073708575178, 5976.641401515836, 5979.671118088547, 6079.179310792986, 6098.664573448415, 6120.265568131764, 6128.724207410677, 4626.444826620827, 4650.86047418578, 4662.0, 4662.160811054043, 4686.086213188463, 4066.3290557058344, 4091.0999580092925, 4132.8140233689555, 4136.524299705572, 4205.074883525619, 5786.07422812348, 5798.449147331081, 5810.273715785527, 5810.912836307459, 5826.621269617546, 6163.907541386883, 6185.938140618626, 6186.257649082049, 6186.566940314135, 6192.040233763774, 5531.529819965348, 5645.294338207724, 5712.514436272881, 5804.970975145097, 5820.30156381237, 5300.840974770763, 5320.17537281722, 5321.441248668912, 5324.733763311819, 5336.332958380202, 6281.026440901667, 6282.560220784592, 6284.0, 6291.811245662638, 6309.0, 5894.38108998549, 5984.371640977634, 6032.849178770566, 6092.8781424372155, 6124.6325220486915, 6201.179420458886, 6247.31279559239, 6256.562040657111, 6300.873982520416, 6302.873942521032, 5893.145493903446, 5997.5501837363245, 6054.303755068047, 6054.66699331541, 6068.180795592715, 6002.7298771554515, 6041.305249896142, 6110.133516259585, 6113.111460343324, 6118.710550942667, 5922.052471604523, 5923.28920529522, 5939.673317967553, 5948.702564871825, 5959.702014899324, 5690.3456102548735, 5770.076787713946, 5919.6152250103605, 5926.614770039933, 5930.28836539618, 5782.0, 5859.970700146472, 5860.853478663067, 5867.647941123546, 5911.408859114054, 5913.0, 5978.760849565969, 5979.3123790762875, 6021.518278537619, 6045.123457098608, 5654.575906806924, 5699.829005129853, 5766.336871259691, 5903.144044113494, 5906.0], "unit": "ms", "name": "dojo.html", "value": 5568.279991231993}, {"lowerIsBetter": false, "replicates": [608.4037643109752, 650.8405440667036, 657.828964469238, 671.9395254427101, 687.9543094496363, 40666.39000414992, 41424.17151656969, 41562.16875662485, 41570.792146039304, 41588.960275993115, 46725.29912051322, 46859.29711054328, 47224.0, 47289.0, 47393.763031184884, 8934.821303573925, 9178.678746243882, 9191.770205744877, 9192.264618830477, 9196.540172991323, 8896.421732587361, 8948.881389826272, 8964.148405901462, 8991.595378207963, 9010.819783604356, 8932.508712020835, 9062.909370906273, 9070.86393704095, 9079.18287354138, 9114.635414583408, 8998.0, 9038.27693784499, 9069.093090690943, 9083.318751093695, 9099.363044586882, 8938.821223575493, 9080.364374493787, 9085.227755640779, 9107.180353768194, 9110.498922559256, 41766.0, 42167.0, 42200.36699449511, 42254.57745422537, 42310.36534451955, 3640.2355505343908, 3815.465834783133, 3815.4849095372324, 4142.502899652061, 4289.906073951153, 32350.191245218823, 32381.51427728586, 32838.01485955425, 32935.6706432935, 33352.0, 4255.127698821734, 4292.871213863589, 4315.072259464199, 4339.045410009793, 4347.391365208873, 282854.0, 284075.0, 284226.0, 286458.0, 286830.0, 45538.54461455343, 46103.0, 64923.35076649173, 65135.0, 65432.0, 43902.560974390486, 44259.0, 44268.778656106515, 44281.0, 44291.11417771691, 16776.412825551048, 16923.661526769396, 16972.0, 16984.150792460576, 17001.659966800595, 12417.379131043412, 12499.375031248583, 12592.622221333375, 12672.366381680878, 12688.365581720876, 15112.0, 15528.844711552965, 15671.216439178224, 15721.68556628884, 15743.13412762309, 6187.412195841388, 6272.247330320391, 6279.510150242599, 6312.779052733133, 6446.226452825691, 1025.4411345816548, 1080.9891901081046, 1110.5446766825723, 1203.7652657731658, 1205.3551350027692, 29302.120936371943, 29926.551101733057, 30300.54549181764, 30502.54246186309, 30822.53766193509, 1111.0, 1118.9888101118884, 1177.3995262416229, 1194.5460724924474, 1303.4069498378215, 14940.0, 15016.24918754058, 15030.248487575578, 15315.540533784004, 15356.385744570316, 759941.0, 805786.0, 807485.0, 813053.0, 814595.0, 60949.69525152346, 61038.38961610327, 61362.38637613656, 61707.38292617106, 61763.0, 1524.4435780939878, 1540.499337715247, 1542.637480192154, 1550.29461594974, 1559.688062387527, 31498.52752208673, 32018.67981320157, 32386.83806580952, 34642.13394665053, 35512.289754204256, 54107.18839217494, 55071.72464137654, 55083.72458137684, 55123.72438137783, 55247.17129243145, 312051.0, 315160.0, 315979.0, 316067.0, 317113.0, 44902.32646510239, 45293.320600191684, 45612.0, 46048.309275361564, 46188.53811461977, 48765.268520971505, 49774.25338619996, 50070.749646251534, 55556.444435555124, 56882.7155864218, 39943.60056399399, 40605.1878962425, 41043.38434923419, 41148.1770364597, 41825.58174418217, 40163.79918100391, 40743.59256407398, 41036.58963410328, 41176.1764764709, 41281.380779288935, 38422.423663644506, 38699.0, 39265.0, 39596.2080758389, 39806.80096599498, 34792.652073479956, 35069.0, 35202.47196292109, 35733.46399803953, 36267.45598815967, 28318.292042699097, 29340.853295733385, 29566.0, 30982.690173098883, 31149.844250778602], "unit": "ms", "name": "ext.html", "value": 20314.292996775603}, {"lowerIsBetter": false, "replicates": [375.13157041449045, 380.12760714161016, 383.2067620026546, 383.6017715427268, 385.85337571722744, 17354.652906941854, 18490.44528664142, 18650.533736656573, 18696.532586685338, 19625.901870490663, 12078.214916030453, 12204.755904881897, 13736.931315343409, 18692.0, 18702.71945920812, 5235.973820130904, 5287.365516138049, 5333.040052790496, 5352.330958630171, 5355.518003379695, 3976.840926362942, 4070.9592904071023, 5272.683638981654, 6898.48261380396, 7175.42596592274, 6949.617771022592, 7058.470614703892, 7064.576125432465, 7105.7157713691395, 7155.534890232144, 6918.8962165567555, 6930.61881596512, 6931.653417329113, 6949.061876646639, 6977.965110174468, 6485.513586481033, 6608.0418339341, 6623.403893649546, 6630.834229144261, 6675.232348279961, 23971.640425393634, 23973.0, 24201.515969680684, 24499.387515312083, 24517.264482065388, 2383.332666853284, 2490.302715239736, 2501.7123030851503, 2524.469861329123, 2705.945881082387, 14948.252587370587, 14985.32566034531, 15103.47137850181, 15287.312070956723, 16108.597285067966, 2098.244631932503, 2166.945826354338, 2167.3931299236237, 2187.8796666183352, 2195.923142690014, 70421.0, 77927.61036194839, 79162.60418697927, 80237.0, 80528.59735701284, 16692.24884880183, 16985.320587176375, 17000.744988825176, 17021.57446063858, 17077.0, 26802.195934122006, 27031.242969206938, 27313.590296145572, 27499.45001100007, 27594.310142246606, 8159.79600509992, 8232.917670823335, 8256.215659512336, 8312.5428101455, 10258.487075646188, 7977.3618110551015, 8199.180081991753, 8294.0, 8337.708180213664, 8359.331253499706, 4745.430548334222, 4924.8276310328965, 4959.454460009396, 4966.379202599675, 4968.0, 1978.3273686946507, 1988.2345297060735, 2008.3874418302557, 2016.5865997470482, 2050.6001329740557, 496.2308421945969, 504.699703676312, 906.4380084347747, 1018.5772904244656, 1144.9370284634424, 11086.611968581223, 11943.701407464883, 12046.156769026084, 12081.516739330329, 12188.085893558018, 509.3454910440067, 510.2422901990541, 517.3145582103728, 518.9506996835295, 536.0458384076351, 6451.29035806061, 6527.67361631926, 6625.801225963229, 6635.5023373247195, 6681.298463661343, 639255.0, 642932.0, 648197.0, 651929.0, 653228.0, 77957.0, 79771.0, 80093.59953200197, 86217.56891215504, 88627.0, 1155.607093588184, 1180.7579446213506, 1186.5669030803867, 1201.6515210589007, 1208.6434501821984, 16100.355985760438, 16332.836671633608, 16448.177591120635, 16989.235484402983, 17040.82959170442, 37971.0, 38106.237875241786, 38260.23479530338, 38509.22981540298, 38931.610683892795, 46163.0, 48286.0, 48398.27402589034, 48929.755351223015, 50200.0, 9586.808263834824, 9844.852327214954, 9848.753781155241, 9916.900830991597, 9934.155596774355, 12997.295770705303, 18038.819611803712, 18042.819571804637, 18090.366837160636, 18189.0, 15386.9230653846, 15683.215839208222, 15768.526944191693, 15852.1281329528, 16084.758728618846, 15440.382384704486, 15460.304286307368, 15738.0, 15916.363345466052, 16001.439949601709, 15776.684466310839, 15952.122633255283, 16306.592335191715, 16530.338786448407, 16583.0, 10366.170706343324, 10375.221858360503, 10394.688159355232, 10433.843492347469, 10579.841302380624, 15777.368905243662, 15950.282237299582, 15995.280212390702, 16009.439669611507, 16196.271167797242], "unit": "ms", "name": "jquery.html", "value": 9729.998250527373}, {"lowerIsBetter": false, "replicates": [1460.2552698123957, 1518.2939932931188, 1742.2769550636488, 1923.3845169545734, 1934.8065193480663, 7710.11333696625, 7927.445078844476, 8010.0, 8032.879506807388, 8143.063547692017, 8217.137200593941, 8224.383171262149, 8287.875681864776, 8306.875396869036, 8307.833843323146, 2340.508493216427, 2379.179183181808, 2379.298107058422, 2385.689860318156, 2388.474535602165, 2409.2170044735444, 2435.561598912204, 2443.51129774045, 2447.571674956884, 2448.2288079255068, 2336.264076815806, 2339.368370539953, 2374.691290132289, 2389.7132344118645, 2390.055927908475, 2311.884405779721, 2314.780095890896, 2329.0, 2334.8132149428175, 2347.5891718949115, 2303.504746479515, 2317.4438134847683, 2325.6627788970673, 2326.6161083421216, 2329.138218859016, 8014.5591992440395, 8016.318612917909, 8066.072401673765, 8067.314278286352, 8083.717069902584, 4815.0, 4917.877053073666, 4919.950800492021, 4924.556789888891, 4934.481879402683, 3110.4090222857812, 3144.528320751883, 3144.889928852479, 3154.29028468595, 3164.857581408842, 1001.2690735762934, 1010.161565900301, 1035.6271742172812, 1037.1702637889734, 1989.5523507210908, 10810.67567972962, 10962.835557466644, 10986.121110311156, 11020.173486988428, 11026.779464410667, 4234.407182994383, 4279.828806847753, 4318.1363727254675, 4327.17783621111, 4333.285007973649, 8988.10118988096, 8990.370674052885, 9007.414518056305, 9016.774580635536, 9019.368644194843, 4856.1016212000895, 4859.2954021666665, 4915.65590408668, 4915.729634870045, 4922.532359425849, 4460.576245256695, 4506.6169375602785, 4521.095780843844, 4525.886852828706, 4530.728156310632, 3444.380011597886, 3477.930441391158, 3518.2435776308216, 3528.329617372742, 3530.5763308403157, 1065.0361422912276, 1088.2056099047738, 1090.2804149261449, 1096.8848270931437, 1145.5532342386475, 1117.022605220432, 1128.6219116595869, 1187.2579637726421, 1382.384838746748, 1442.170751817709, 7583.317501424898, 7591.848163036709, 7720.112187098443, 7747.767566973, 7754.418418618626, 1098.5441041967654, 1156.2773266708307, 1195.9162858599814, 1206.4872429217548, 1223.4311045363947, 6172.382761723881, 6195.039768835838, 6219.47134493564, 6219.533534984895, 6233.283172435228, 9236.953815230881, 9400.106989835955, 9410.670626528039, 9486.288528360263, 9514.619415223313, 9480.478573678514, 9486.288528360401, 9489.525523723787, 9515.0, 9613.03869613033, 7050.365467107985, 7287.963560182166, 7295.6352182390665, 7297.832346824483, 7368.852622947511, 7356.154042284991, 7376.96311518439, 7447.143578488326, 7460.813479663052, 7496.925030749622, 7986.960065199637, 8330.541820199947, 8342.708005219789, 8357.37319701037, 8406.32749380036, 8304.377171712025, 8310.70912518059, 8333.666653334041, 8344.165583441607, 8355.749327520183, 7145.785626431008, 7217.6030318333, 7281.526700764433, 7285.890711639436, 7294.781156565312, 7361.521501102411, 7714.614269286625, 7721.073471183269, 7743.612819358897, 7758.379329653727, 6713.56361836479, 7128.429725621834, 7131.82170445743, 7197.0, 7216.7474138404905, 6669.4664426844765, 7202.315780000891, 7260.346568808622, 7344.192138864827, 7350.338469537767, 7230.566166030055, 7292.614403263363, 7339.77980660581, 7355.485116041826, 7361.4110871129105, 6749.291324411062, 6803.081583986099, 6827.897581536182, 6840.3501667341525, 6847.657617119224, 6453.451456626051, 6479.870402591828, 6493.253275873146, 6792.93207067923, 6812.659367031728], "unit": "ms", "name": "mootools.html", "value": 4639.453046639373}, {"lowerIsBetter": false, "replicates": [369.77258985723773, 373.20321114420705, 375.97932113733737, 379.6014185105639, 386.32393311704516, 6275.623462592248, 6323.715432805523, 6423.325550817167, 6444.516661250407, 6458.128152699384, 6192.195014648089, 6299.370062993698, 6315.778947736831, 6316.621002739827, 6351.872962540747, 4894.119058569456, 4895.55939965403, 4903.705777653343, 4912.410510738717, 4927.433345165298, 4932.506749325074, 4933.087378834909, 4933.40799104108, 4941.135301322272, 4950.331705219804, 4717.834875779348, 4811.639127065467, 4817.445993710716, 4826.058918510892, 4842.46732859387, 4824.155772739774, 4825.131476334259, 4830.855074347775, 4831.03379324133, 4831.22700367943, 4244.766537840417, 4245.9787701061605, 4247.554006829269, 4258.53156152823, 4264.339027450719, 5909.054551271776, 5990.73041713124, 5995.850103747398, 6027.09593560965, 6050.455459008666, 5583.972080139614, 5598.944010559923, 5614.073677843151, 5621.100623900156, 5623.690697011662, 6650.268470468244, 6675.933240667579, 6684.2647308795995, 6695.832604184886, 6700.0, 4702.224133018048, 4709.835155769566, 4712.340272361872, 4713.57577817998, 4721.645876559238, 6787.830304242384, 6851.38337549618, 6868.862622747517, 6935.757248496328, 6957.095577574883, 4828.251620998751, 4829.396325459317, 4832.492588278251, 4834.154023045953, 4837.05677392912, 4894.559489645878, 4896.0, 4898.926516102261, 4899.167141585867, 4900.656954013256, 5473.67157970523, 5623.746931388016, 5626.240457538262, 5628.212050312959, 5629.211910332557, 6700.2294736105, 6712.127423434922, 6722.831929201809, 6735.865282694319, 6740.325967403221, 1695.1100672146974, 1726.7237242041213, 1729.0, 1731.4199743085956, 1731.9826801731822, 1165.6211731187398, 1175.382923964908, 1177.5054477119459, 1192.9045676345872, 1195.36048214205, 6430.549861509649, 6431.839204019937, 6435.549511534241, 6443.677816109176, 6461.450776683941, 6900.068490753684, 6900.137482814648, 6904.827379315457, 6912.101426814583, 6924.965375173092, 6316.147320111818, 6379.043143528508, 6399.7440102395385, 6425.58233714807, 6451.580647257913, 3724.683401910868, 3733.7386382953478, 3763.2097259575794, 3765.359888818907, 3766.6045065267754, 7097.112860892388, 7119.110111236096, 7123.7506687265695, 7126.643667816588, 7135.429165666838, 6927.688254028581, 7036.19083805369, 7066.222715501291, 7079.752208672672, 7081.539699919489, 7070.939359096176, 7083.574985500886, 7102.857942841114, 7113.466490013269, 7118.928810711826, 6904.0, 6910.274421185703, 6910.619915904674, 6912.205096413775, 6912.55068420551, 6676.666166691549, 6799.11611490503, 6802.489813263926, 6814.522983391115, 6817.488688348493, 7085.893711594434, 7091.60996145217, 7114.822129446598, 7116.146062472537, 7117.0, 4860.73265970375, 4866.586340161126, 4866.8053277868485, 4868.561829435368, 4869.4400143982475, 6782.1861376635115, 6900.413464855343, 6928.653567321715, 6941.444684425335, 6941.687624056828, 6635.502337324817, 6658.0345849852465, 6699.899501507579, 6726.730930762715, 6731.1922569292, 6673.632950187592, 6686.732530698912, 6692.397684208445, 6700.865982680417, 6724.260331363448, 6469.708863101077, 6588.868222635616, 6631.0716499689115, 6640.0, 6640.568363056386, 6730.057791909235, 6762.188537375547, 6768.424683901923, 6771.356721111487, 6785.5250132490255, 6541.378569035934, 6575.868482630416, 6582.736690532325, 6587.209534855848, 6610.900836487553], "unit": "ms", "name": "prototype.html", "value": 5085.122847526397}, {"lowerIsBetter": false, "replicates": [817.1909809288805, 839.9874001889968, 941.7504361344243, 955.9904400955993, 988.8269552828262, 15667.686646267068, 16142.192890355465, 16172.27224774885, 16185.109818959952, 16196.83803161968, 15819.367225311002, 15838.920805395986, 15975.600609984756, 15985.120818354986, 16013.35946562139, 892.4199270474179, 921.3550514639745, 923.745969858291, 928.3826255540058, 931.5621657820848, 921.6774129054844, 928.1600151862575, 931.2131249094505, 932.9160375566198, 934.8737920380729, 966.8888077871029, 968.9612415503371, 972.9367591106591, 972.951352432379, 974.7758015656403, 957.4207604399343, 962.1244667352711, 962.8363178259713, 963.0225321298888, 967.5259123029665, 706.8374273916977, 709.3119673916293, 709.8402859356603, 710.3109983316175, 712.3268511256864, 14805.555833325017, 14998.775018374734, 15079.773803392958, 15131.470398536, 15136.167510786903, 11582.594609188722, 11917.702057448547, 12590.874091259153, 12611.873881261254, 13165.583685863963, 10429.843552346721, 11036.0, 11164.0, 11238.0, 11259.0, 3939.428782826474, 3969.4244334571326, 3994.9201015979806, 4005.539362973266, 4030.8387664493384, 49816.0, 50207.497925020645, 50309.0, 50984.49015509872, 51019.0, 10469.267151299488, 10637.840432393521, 10675.83986240207, 10742.677719668422, 11006.119510439146, 18830.246790128516, 18838.71741923872, 18868.15093320804, 18879.43361699151, 18899.244030238635, 7977.122516523178, 8003.0, 8022.919770802334, 8041.115477297492, 8199.60606696863, 4514.525974772667, 4621.722696638212, 4623.098495793288, 4682.953170468251, 4761.0, 3148.874045038219, 3178.6503484616674, 3179.7774155809334, 3203.19920019995, 3213.7107660310685, 591.1871177131444, 595.0538643556765, 595.5473839881721, 596.0552524249027, 600.1028462448667, 611.7400104955376, 624.7407325959675, 678.4402867634221, 711.2780527764323, 724.1563578431069, 8997.775055623531, 9050.366474346733, 9142.268618510503, 9274.165325120772, 9410.482423466638, 644.8065580325883, 677.549429629291, 724.0, 748.7716246544857, 779.1273773373857, 4077.673786097105, 4318.892027699333, 4371.759553224603, 4388.188185185751, 4459.866204013885, 55638.44361556414, 56650.43349566452, 57481.42518574844, 57515.0, 57769.13346299809, 49697.75151124221, 50426.2436063452, 50462.243066354036, 50538.494615054115, 50958.74520627373, 43529.0, 43681.815909204415, 44008.559914401085, 47267.05465890663, 47531.5246847534, 8774.473531588124, 8838.734837954871, 8841.0, 9019.0, 9222.769430764285, 34400.48399274063, 34812.9556113317, 35965.46051809173, 36295.81852090828, 36813.44779828251, 44110.55889441193, 44135.77932110319, 44250.0, 44268.0, 45072.323915140645, 11704.122190835551, 11740.0, 12019.459124339252, 12116.878831211576, 12258.509659613515, 12194.634160975185, 12254.571090011807, 12742.49030038788, 12749.298788566717, 13231.0, 11891.167618266983, 11998.820017699567, 12059.0, 12210.26738395699, 12403.62789116328, 11519.25124866881, 11822.763544728885, 12434.875651243372, 12580.433880475584, 12724.363781811058, 11143.16426268017, 11268.098552115647, 11302.378369189773, 11673.0, 11903.940480297542, 10043.548040338057, 10398.376097434179, 10522.631707890187, 10788.676339709822, 11092.833607495733, 9858.901410985798, 9991.200703943521, 10165.440900750235, 10172.74568135773, 10318.226133039901], "unit": "ms", "name": "yui.html", "value": 6758.959630003222}], "name": "dromaeo_css", "value": 7482.621453187111}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 103.0, 112.0, 109.0, 112.0, 121.0, 111.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [150.0, 122.0, 147.0, 158.0, 129.0, 144.0, 157.0, 131.0, 170.0, 127.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.5}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 162.0, 161.0, 160.0, 162.0, 163.0, 164.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [76.0, 71.0, 71.0, 153.0, 72.0, 73.0, 72.0, 72.0, 164.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 89.5}, {"lowerIsBetter": true, "replicates": [94.0, 92.0, 144.0, 91.0, 93.0, 94.0, 143.0, 92.0, 95.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [61.0, 64.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 59.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 60.9}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0, 64.0, 62.0, 62.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 62.5}, {"lowerIsBetter": true, "replicates": [88.0, 81.0, 84.0, 90.0, 83.0, 91.0, 97.0, 84.0, 82.0, 91.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [113.0, 120.0, 121.0, 115.0, 116.0, 119.0, 121.0, 121.0, 118.0, 131.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.5}, {"lowerIsBetter": true, "replicates": [143.0, 149.0, 146.0, 143.0, 149.0, 146.0, 147.0, 149.0, 145.0, 148.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.5}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 66.0, 66.0, 68.0, 67.0, 66.0, 67.0, 67.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1508.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.77785190126752], "unit": "score", "name": "Richards", "value": 211.67079199999998}, {"lowerIsBetter": false, "replicates": [167.0564650851988], "unit": "score", "name": "DeltaBlue", "value": 395.7823480000001}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [913.2420091324201], "unit": "score", "name": "RayTrace", "value": 810.2879549999998}, {"lowerIsBetter": false, "replicates": [552.4861878453039], "unit": "score", "name": "Earley", "value": 1206.29803}, {"lowerIsBetter": false, "replicates": [10923.91304347826], "unit": "score", "name": "Boyer", "value": 61.0095482587065}, {"lowerIsBetter": false, "replicates": [24682.926829268294], "unit": "score", "name": "RegExp", "value": 36.907495059288536}, {"lowerIsBetter": false, "replicates": [521.6484089723526], "unit": "score", "name": "Splay", "value": 156.21824700000005}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 23204.038304452253}]} 12:22:24 INFO - RETURN: dromaeo_css: 7482.62 12:22:24 INFO - RETURN: kraken: 1508.60 12:22:24 INFO - RETURN: v8_7: 23204.04 12:22:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23204.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1508.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7482.62"}}} 12:22:24 INFO - Return code: 0 12:22:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 12:22:24 INFO - # TBPL SUCCESS # 12:22:24 INFO - Running post-action listener: _resource_record_post_action 12:22:24 INFO - Running post-run listener: _resource_record_post_run 12:22:25 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 266240; Write bytes: 513589248; Read time: 36; Write time: 389208 12:22:25 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 237023232; Read time: 0; Write time: 197504 12:22:25 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 266240; Write bytes: 276148224; Read time: 36; Write time: 191684 12:22:25 INFO - Running post-run listener: _upload_blobber_files 12:22:25 INFO - Blob upload gear active. 12:22:25 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:22:25 INFO - Copying logs to upload dir... 12:22:25 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.069561 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-21 12:22:24.572075) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-21 12:22:24.575974) ========= 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=920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010079 build_url: 'https://queue.taskcluster.net/v1/task/FOsifgnaQnWJ1BFJw8AZ2w/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-21 12:22:24.627916) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 12:22:24.628240) ========= 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=920470bf432669ad7e3a5387000001ca-1453405800.767633-1082646190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 12:22:24.677693) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 12:22:24.678015) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 12:22:24.678356) ========= ========= Total master_lag: 0.27 =========