builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1453722372.75 results: success (0) buildid: 20160125001712 builduid: 5d8eb007e2de4c2eae63c4ce4fd78a1e revision: ab89c814f1b8a841168de98ac2679a1d66122a06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.748909) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.749314) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.749599) ========= 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-1453721234.894395-1936994184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006466 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.820491) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.820792) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.902143) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.902608) ========= 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-1453721234.894395-1936994184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.987619) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.987875) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.988189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.988469) ========= 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-1453721234.894395-1936994184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 03:46:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.9M=0s 2016-01-25 03:46:13 (37.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162798 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.176128) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.176424) ========= 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-1453721234.894395-1936994184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017769 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.230871) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.231178) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ab89c814f1b8a841168de98ac2679a1d66122a06 --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 ab89c814f1b8a841168de98ac2679a1d66122a06 --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-1453721234.894395-1936994184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 03:46:13,479 truncating revision to first 12 chars 2016-01-25 03:46:13,479 Setting DEBUG logging. 2016-01-25 03:46:13,479 attempt 1/10 2016-01-25 03:46:13,479 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ab89c814f1b8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 03:46:14,015 unpacking tar archive at: mozilla-aurora-ab89c814f1b8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.831645 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:14.075469) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:14.075794) ========= echo ab89c814f1b8a841168de98ac2679a1d66122a06 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ab89c814f1b8a841168de98ac2679a1d66122a06'] 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-1453721234.894395-1936994184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ab89c814f1b8a841168de98ac2679a1d66122a06 program finished with exit code 0 elapsedTime=0.003574 script_repo_revision: 'ab89c814f1b8a841168de98ac2679a1d66122a06' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:14.132338) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:14.132629) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:14.154301) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-25 03:46:14.154575) ========= /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-1453721234.894395-1936994184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:46:14 INFO - MultiFileLogger online at 20160125 03:46:14 in /builds/slave/test-pgo 03:46:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:46:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:46:14 INFO - {'append_to_log': False, 03:46:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:46:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:46:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:46:14 INFO - 'branch': 'Mozilla-Aurora', 03:46:14 INFO - 'buildbot_json_path': 'buildprops.json', 03:46:14 INFO - 'config_files': ('talos/linux_config.py',), 03:46:14 INFO - 'default_actions': ('clobber', 03:46:14 INFO - 'read-buildbot-config', 03:46:14 INFO - 'download-and-extract', 03:46:14 INFO - 'populate-webroot', 03:46:14 INFO - 'create-virtualenv', 03:46:14 INFO - 'install', 03:46:14 INFO - 'run-tests'), 03:46:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:46:14 INFO - 'download_minidump_stackwalk': True, 03:46:14 INFO - 'download_symbols': 'ondemand', 03:46:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:46:14 INFO - 'tooltool.py': '/tools/tooltool.py', 03:46:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:46:14 INFO - '/tools/misc-python/virtualenv.py')}, 03:46:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:46:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:46:14 INFO - 'installer_path': 'installer.exe', 03:46:14 INFO - 'log_level': 'info', 03:46:14 INFO - 'log_name': 'talos', 03:46:14 INFO - 'log_to_console': True, 03:46:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:46:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:46:14 INFO - 'opt_config_files': (), 03:46:14 INFO - 'pip_index': False, 03:46:14 INFO - 'sps_profile': False, 03:46:14 INFO - 'sps_profile_interval': 0, 03:46:14 INFO - 'suite': 'dromaeojs-e10s', 03:46:14 INFO - 'system_bits': '32', 03:46:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:46:14 INFO - 'title': 'talos-linux64-ix-053', 03:46:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:46:14 INFO - 'use_talos_json': True, 03:46:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:46:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:46:14 INFO - 'work_dir': 'build'} 03:46:14 INFO - ##### 03:46:14 INFO - ##### Running clobber step. 03:46:14 INFO - ##### 03:46:14 INFO - Running pre-action listener: _resource_record_pre_action 03:46:14 INFO - Running main action method: clobber 03:46:14 INFO - rmtree: /builds/slave/test-pgo/build 03:46:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:46:14 INFO - Running post-action listener: _resource_record_post_action 03:46:14 INFO - ##### 03:46:14 INFO - ##### Running read-buildbot-config step. 03:46:14 INFO - ##### 03:46:14 INFO - Running pre-action listener: _resource_record_pre_action 03:46:14 INFO - Running main action method: read_buildbot_config 03:46:14 INFO - Using buildbot properties: 03:46:14 INFO - { 03:46:14 INFO - "properties": { 03:46:14 INFO - "buildnumber": 83, 03:46:14 INFO - "product": "firefox", 03:46:14 INFO - "script_repo_revision": "production", 03:46:14 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:46:14 INFO - "repository": "", 03:46:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:46:14 INFO - "buildid": "20160125001712", 03:46:14 INFO - "slavename": "talos-linux64-ix-053", 03:46:14 INFO - "pgo_build": "True", 03:46:14 INFO - "basedir": "/builds/slave/test-pgo", 03:46:14 INFO - "project": "", 03:46:14 INFO - "platform": "ubuntu64_hw", 03:46:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:46:14 INFO - "slavebuilddir": "test", 03:46:14 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:46:14 INFO - "branch": "mozilla-aurora", 03:46:14 INFO - "repo_path": "releases/mozilla-aurora", 03:46:14 INFO - "stage_platform": "linux64-pgo", 03:46:14 INFO - "builduid": "5d8eb007e2de4c2eae63c4ce4fd78a1e", 03:46:14 INFO - "revision": "ab89c814f1b8a841168de98ac2679a1d66122a06" 03:46:14 INFO - }, 03:46:14 INFO - "sourcestamp": { 03:46:14 INFO - "repository": "", 03:46:14 INFO - "hasPatch": false, 03:46:14 INFO - "project": "", 03:46:14 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:46:14 INFO - "changes": [ 03:46:14 INFO - { 03:46:14 INFO - "category": null, 03:46:14 INFO - "files": [ 03:46:14 INFO - { 03:46:14 INFO - "url": null, 03:46:14 INFO - "name": "https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 03:46:14 INFO - } 03:46:14 INFO - ], 03:46:14 INFO - "repository": "", 03:46:14 INFO - "rev": "ab89c814f1b8a841168de98ac2679a1d66122a06", 03:46:14 INFO - "who": "cbook@mozilla.com", 03:46:14 INFO - "when": 1453717351, 03:46:14 INFO - "number": 7510169, 03:46:14 INFO - "comments": "Bug 1241061 - [firefox-ui-tests] Workaround for bug 1237706 to use ZipFile if unzip command is not available. r=maja_zf, a=test-only", 03:46:14 INFO - "project": "", 03:46:14 INFO - "at": "Mon 25 Jan 2016 02:22:31", 03:46:14 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:46:14 INFO - "revlink": "", 03:46:14 INFO - "properties": [ 03:46:14 INFO - [ 03:46:14 INFO - "buildid", 03:46:14 INFO - "20160125001712", 03:46:14 INFO - "Change" 03:46:14 INFO - ], 03:46:14 INFO - [ 03:46:14 INFO - "builduid", 03:46:14 INFO - "5d8eb007e2de4c2eae63c4ce4fd78a1e", 03:46:14 INFO - "Change" 03:46:14 INFO - ], 03:46:14 INFO - [ 03:46:14 INFO - "pgo_build", 03:46:14 INFO - "True", 03:46:14 INFO - "Change" 03:46:14 INFO - ] 03:46:14 INFO - ], 03:46:14 INFO - "revision": "ab89c814f1b8a841168de98ac2679a1d66122a06" 03:46:14 INFO - } 03:46:14 INFO - ], 03:46:14 INFO - "revision": "ab89c814f1b8a841168de98ac2679a1d66122a06" 03:46:14 INFO - } 03:46:14 INFO - } 03:46:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 03:46:14 INFO - Running post-action listener: _resource_record_post_action 03:46:14 INFO - ##### 03:46:14 INFO - ##### Running download-and-extract step. 03:46:14 INFO - ##### 03:46:14 INFO - Running pre-action listener: _resource_record_pre_action 03:46:14 INFO - Running main action method: download_and_extract 03:46:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:46: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')]} 03:46:14 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:46:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json 03:46:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json 03:46:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:46:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:46:35 INFO - Downloaded 1302 bytes. 03:46:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:46:35 INFO - Using the following test package requirements: 03:46:35 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:46:35 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:35 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:46:35 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:35 INFO - u'jsshell-linux-x86_64.zip'], 03:46:35 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:35 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:46:35 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:46:35 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:35 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:46:35 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:35 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:46:35 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:35 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:46:35 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:46:35 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:35 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:46:35 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:35 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:46:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:46:37 INFO - Downloaded 23159167 bytes. 03:46:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:46:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:46:38 INFO - Return code: 0 03:46:38 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:46: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')]} 03:46:38 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:46:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:46:43 INFO - Downloaded 23159167 bytes. 03:46:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:46:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:46:45 INFO - Return code: 0 03:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:45 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:46:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:46:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:46:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:46:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:46:46 INFO - Downloaded 11132038 bytes. 03:46:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 03:46:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:46:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:46:46 INFO - Return code: 0 03:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:46 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:46:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:46:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:46:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:46:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:46:48 INFO - Downloaded 58033452 bytes. 03:46:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:46:48 INFO - mkdir: /builds/slave/test-pgo/properties 03:46:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:46:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:46:48 INFO - Contents: 03:46:48 INFO - build_url:https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:46:48 INFO - Running post-action listener: _resource_record_post_action 03:46:48 INFO - Running post-action listener: set_extra_try_arguments 03:46:48 INFO - ##### 03:46:48 INFO - ##### Running populate-webroot step. 03:46:48 INFO - ##### 03:46:48 INFO - Running pre-action listener: _resource_record_pre_action 03:46:48 INFO - Running main action method: populate_webroot 03:46:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:46:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:46:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:46:48 INFO - '--tppagecycles', 03:46:48 INFO - '7'], 03:46:48 INFO - 'tests': ['tsvgm']}}, 03:46:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:46:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:46:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:46:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:46:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:46:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:46:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:48 INFO - 'talos_options': ['--e10s'], 03:46:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:48 INFO - 'tests': ['damp', 'tps']}, 03:46:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:48 INFO - 'talos_options': ['--e10s'], 03:46:48 INFO - 'tests': ['damp', 'tps']}, 03:46:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:46:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:46:48 INFO - 'other': {'tests': ['a11yr', 03:46:48 INFO - 'ts_paint', 03:46:48 INFO - 'tpaint', 03:46:48 INFO - 'sessionrestore', 03:46:48 INFO - 'sessionrestore_no_auto_restore']}, 03:46:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:46:48 INFO - 'tests': ['a11yr', 03:46:48 INFO - 'ts_paint', 03:46:48 INFO - 'tpaint', 03:46:48 INFO - 'sessionrestore', 03:46:48 INFO - 'sessionrestore_no_auto_restore']}, 03:46:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:46:48 INFO - 'tests': ['a11yr', 03:46:48 INFO - 'ts_paint', 03:46:48 INFO - 'tpaint', 03:46:48 INFO - 'sessionrestore', 03:46:48 INFO - 'sessionrestore_no_auto_restore']}, 03:46:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:46:48 INFO - 'tests': ['a11yr', 03:46:48 INFO - 'ts_paint', 03:46:48 INFO - 'tpaint', 03:46:48 INFO - 'sessionrestore', 03:46:48 INFO - 'sessionrestore_no_auto_restore']}, 03:46:48 INFO - 'other_l64': {'tests': ['a11yr', 03:46:48 INFO - 'ts_paint', 03:46:48 INFO - 'tpaint', 03:46:48 INFO - 'sessionrestore', 03:46:48 INFO - 'sessionrestore_no_auto_restore']}, 03:46:48 INFO - 'other_nol64': {'tests': ['a11yr', 03:46:48 INFO - 'ts_paint', 03:46:48 INFO - 'tpaint', 03:46:48 INFO - 'sessionrestore', 03:46:48 INFO - 'sessionrestore_no_auto_restore']}, 03:46:48 INFO - 'svgr': {'tests': ['tsvgx', 03:46:48 INFO - 'tsvgr_opacity', 03:46:48 INFO - 'tart', 03:46:48 INFO - 'tscrollx', 03:46:48 INFO - 'cart']}, 03:46:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:46:48 INFO - 'tests': ['tsvgx', 03:46:48 INFO - 'tsvgr_opacity', 03:46:48 INFO - 'tart', 03:46:48 INFO - 'tscrollx', 03:46:48 INFO - 'cart']}, 03:46:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:48 INFO - 'tests': ['tp5o']}, 03:46:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:48 INFO - 'talos_options': ['--e10s'], 03:46:48 INFO - 'tests': ['tp5o']}, 03:46:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:48 INFO - 'talos_options': ['--xperf_path', 03:46:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:48 INFO - 'tests': ['tp5n']}, 03:46:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:48 INFO - 'talos_options': ['--e10s', 03:46:48 INFO - '--xperf_path', 03:46:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:48 INFO - 'tests': ['tp5n']}}, 03:46:48 INFO - 'talos.zip': {'path': '', 03:46:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:46:48 INFO - Running post-action listener: _resource_record_post_action 03:46:48 INFO - ##### 03:46:48 INFO - ##### Running create-virtualenv step. 03:46:48 INFO - ##### 03:46:48 INFO - Running pre-action listener: _resource_record_pre_action 03:46:48 INFO - Running main action method: create_virtualenv 03:46:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:46:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 03:46:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:46:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:46:48 INFO - Using real prefix '/usr' 03:46:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:46:48 INFO - Installing distribute.............................................................................................................................................................................................done. 03:46:50 INFO - Installing pip.................done. 03:46:50 INFO - Return code: 0 03:46:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:46: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')]} 03:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46: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')]} 03:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:50 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 0x7f267bf72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ec450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157ea50>, '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 0x14ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea9e0>, '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-1453721234.894395-1936994184', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:50 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 03:46:50 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 03:46:50 INFO - Using env: {'DISPLAY': ':0', 03:46:50 INFO - 'HOME': '/home/cltbld', 03:46:50 INFO - 'LANG': 'en_US.UTF-8', 03:46:50 INFO - 'LANGUAGE': 'en_US:en', 03:46:50 INFO - 'LOGNAME': 'cltbld', 03:46:50 INFO - 'MAIL': '/var/mail/cltbld', 03:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:50 INFO - 'MOZ_NO_REMOTE': '1', 03:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:50 INFO - 'NO_EM_RESTART': '1', 03:46:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:50 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:50 INFO - 'SHELL': '/bin/bash', 03:46:50 INFO - 'SHLVL': '1', 03:46:50 INFO - 'TERM': 'linux', 03:46:50 INFO - 'TMOUT': '86400', 03:46:50 INFO - 'USER': 'cltbld', 03:46:50 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453721234.894395-1936994184', 03:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:50 INFO - '_': '/tools/buildbot/bin/python'} 03:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:46:50 INFO - Cleaning up... 03:46:50 INFO - Return code: 0 03:46:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:46: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')]} 03:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46: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')]} 03:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:50 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 0x7f267bf72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ec450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157ea50>, '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 0x14ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea9e0>, '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-1453721234.894395-1936994184', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:50 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 03:46:50 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 03:46:50 INFO - Using env: {'DISPLAY': ':0', 03:46:50 INFO - 'HOME': '/home/cltbld', 03:46:50 INFO - 'LANG': 'en_US.UTF-8', 03:46:50 INFO - 'LANGUAGE': 'en_US:en', 03:46:50 INFO - 'LOGNAME': 'cltbld', 03:46:50 INFO - 'MAIL': '/var/mail/cltbld', 03:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:50 INFO - 'MOZ_NO_REMOTE': '1', 03:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:50 INFO - 'NO_EM_RESTART': '1', 03:46:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:50 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:50 INFO - 'SHELL': '/bin/bash', 03:46:50 INFO - 'SHLVL': '1', 03:46:50 INFO - 'TERM': 'linux', 03:46:50 INFO - 'TMOUT': '86400', 03:46:50 INFO - 'USER': 'cltbld', 03:46:50 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453721234.894395-1936994184', 03:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:50 INFO - '_': '/tools/buildbot/bin/python'} 03:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:51 INFO - Downloading/unpacking psutil>=0.7.1 03:46: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 03:46: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 03:46: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 03:46: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 03:46: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 03:46: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 03:46:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:46:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:46:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:46:52 INFO - Installing collected packages: psutil 03:46:52 INFO - Running setup.py install for psutil 03:46:52 INFO - building 'psutil._psutil_linux' extension 03:46:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:46:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:46:53 INFO - building 'psutil._psutil_posix' extension 03:46:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:46:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:46:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:46:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:46:53 INFO - Successfully installed psutil 03:46:53 INFO - Cleaning up... 03:46:53 INFO - Return code: 0 03:46:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:46: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')]} 03:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46: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')]} 03:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:53 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 0x7f267bf72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ec450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157ea50>, '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 0x14ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea9e0>, '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-1453721234.894395-1936994184', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:53 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 03:46:53 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 03:46:53 INFO - Using env: {'DISPLAY': ':0', 03:46:53 INFO - 'HOME': '/home/cltbld', 03:46:53 INFO - 'LANG': 'en_US.UTF-8', 03:46:53 INFO - 'LANGUAGE': 'en_US:en', 03:46:53 INFO - 'LOGNAME': 'cltbld', 03:46:53 INFO - 'MAIL': '/var/mail/cltbld', 03:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:53 INFO - 'MOZ_NO_REMOTE': '1', 03:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:53 INFO - 'NO_EM_RESTART': '1', 03:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:53 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:53 INFO - 'SHELL': '/bin/bash', 03:46:53 INFO - 'SHLVL': '1', 03:46:53 INFO - 'TERM': 'linux', 03:46:53 INFO - 'TMOUT': '86400', 03:46:53 INFO - 'USER': 'cltbld', 03:46:53 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453721234.894395-1936994184', 03:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:53 INFO - '_': '/tools/buildbot/bin/python'} 03:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:46:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:46:55 INFO - Installing collected packages: mozsystemmonitor 03:46:55 INFO - Running setup.py install for mozsystemmonitor 03:46:55 INFO - Successfully installed mozsystemmonitor 03:46:55 INFO - Cleaning up... 03:46:55 INFO - Return code: 0 03:46:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:55 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 0x7f267bf72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ec450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157ea50>, '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 0x14ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea9e0>, '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-1453721234.894395-1936994184', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:55 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 03:46:55 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 03:46:55 INFO - Using env: {'DISPLAY': ':0', 03:46:55 INFO - 'HOME': '/home/cltbld', 03:46:55 INFO - 'LANG': 'en_US.UTF-8', 03:46:55 INFO - 'LANGUAGE': 'en_US:en', 03:46:55 INFO - 'LOGNAME': 'cltbld', 03:46:55 INFO - 'MAIL': '/var/mail/cltbld', 03:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:55 INFO - 'MOZ_NO_REMOTE': '1', 03:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:55 INFO - 'NO_EM_RESTART': '1', 03:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:55 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:55 INFO - 'SHELL': '/bin/bash', 03:46:55 INFO - 'SHLVL': '1', 03:46:55 INFO - 'TERM': 'linux', 03:46:55 INFO - 'TMOUT': '86400', 03:46:55 INFO - 'USER': 'cltbld', 03:46:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453721234.894395-1936994184', 03:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:55 INFO - '_': '/tools/buildbot/bin/python'} 03:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:46:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:46:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:46:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:46: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 03:46: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 03:46: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 03:46: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 03:46: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 03:46: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 03:46:58 INFO - Downloading docopt-0.6.1.tar.gz 03:46:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:46:58 INFO - Installing collected packages: blobuploader, requests, docopt 03:46:58 INFO - Running setup.py install for blobuploader 03:46:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:46:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:46:58 INFO - Running setup.py install for requests 03:46:58 INFO - Running setup.py install for docopt 03:46:58 INFO - Successfully installed blobuploader requests docopt 03:46:58 INFO - Cleaning up... 03:46:58 INFO - Return code: 0 03:46:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:58 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 0x7f267bf72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ec450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157ea50>, '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 0x14ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea9e0>, '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-1453721234.894395-1936994184', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:58 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 03:46:58 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 03:46:58 INFO - Using env: {'DISPLAY': ':0', 03:46:58 INFO - 'HOME': '/home/cltbld', 03:46:58 INFO - 'LANG': 'en_US.UTF-8', 03:46:58 INFO - 'LANGUAGE': 'en_US:en', 03:46:58 INFO - 'LOGNAME': 'cltbld', 03:46:58 INFO - 'MAIL': '/var/mail/cltbld', 03:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:58 INFO - 'MOZ_NO_REMOTE': '1', 03:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:58 INFO - 'NO_EM_RESTART': '1', 03:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:58 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:58 INFO - 'SHELL': '/bin/bash', 03:46:58 INFO - 'SHLVL': '1', 03:46:58 INFO - 'TERM': 'linux', 03:46:58 INFO - 'TMOUT': '86400', 03:46:58 INFO - 'USER': 'cltbld', 03:46:58 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453721234.894395-1936994184', 03:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:58 INFO - '_': '/tools/buildbot/bin/python'} 03:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:46:59 INFO - Running setup.py (path:/tmp/pip-uck0fe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:46:59 INFO - Running setup.py (path:/tmp/pip-eXSgFk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:46:59 INFO - Running setup.py (path:/tmp/pip-NHFIH5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:46:59 INFO - Running setup.py (path:/tmp/pip-Qhpmjw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:46:59 INFO - Running setup.py (path:/tmp/pip-5pW87r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:46:59 INFO - Running setup.py (path:/tmp/pip-KPgwJ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:46:59 INFO - Running setup.py (path:/tmp/pip-hby3b7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:46:59 INFO - Running setup.py (path:/tmp/pip-ng9nq6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:46:59 INFO - Running setup.py (path:/tmp/pip-u6zcTd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:46:59 INFO - Running setup.py (path:/tmp/pip-8votVg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:46:59 INFO - Running setup.py (path:/tmp/pip-08ifcZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:46:59 INFO - Running setup.py (path:/tmp/pip-HhllPA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:00 INFO - Running setup.py (path:/tmp/pip-aRckiP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:00 INFO - Running setup.py (path:/tmp/pip-q06A5t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:00 INFO - Running setup.py (path:/tmp/pip-HWIEEh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:00 INFO - Running setup.py (path:/tmp/pip-vxuxFd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:00 INFO - Running setup.py (path:/tmp/pip-rwVoeA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:47:00 INFO - Running setup.py install for manifestparser 03:47:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:47:00 INFO - Running setup.py install for mozcrash 03:47:00 INFO - Running setup.py install for mozdebug 03:47:00 INFO - Running setup.py install for mozdevice 03:47:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:47:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:47:00 INFO - Running setup.py install for mozfile 03:47:00 INFO - Running setup.py install for mozhttpd 03:47:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:47:01 INFO - Running setup.py install for mozinfo 03:47:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:47:01 INFO - Running setup.py install for mozInstall 03:47:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:47:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:47:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:47:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:47:01 INFO - Running setup.py install for mozleak 03:47:01 INFO - Running setup.py install for mozlog 03:47:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:47:01 INFO - Running setup.py install for moznetwork 03:47:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:47:01 INFO - Running setup.py install for mozprocess 03:47:01 INFO - Running setup.py install for mozprofile 03:47:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:47:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:47:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:47:01 INFO - Running setup.py install for mozrunner 03:47:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:47:01 INFO - Running setup.py install for mozscreenshot 03:47:01 INFO - Running setup.py install for moztest 03:47:02 INFO - Running setup.py install for mozversion 03:47:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:47:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:47:02 INFO - Cleaning up... 03:47:02 INFO - Return code: 0 03:47:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:02 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 0x7f267bf72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ec450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157ea50>, '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 0x14ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea9e0>, '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-1453721234.894395-1936994184', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:47:02 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 03:47:02 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 03:47:02 INFO - Using env: {'DISPLAY': ':0', 03:47:02 INFO - 'HOME': '/home/cltbld', 03:47:02 INFO - 'LANG': 'en_US.UTF-8', 03:47:02 INFO - 'LANGUAGE': 'en_US:en', 03:47:02 INFO - 'LOGNAME': 'cltbld', 03:47:02 INFO - 'MAIL': '/var/mail/cltbld', 03:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:02 INFO - 'MOZ_NO_REMOTE': '1', 03:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:02 INFO - 'NO_EM_RESTART': '1', 03:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:02 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:02 INFO - 'SHELL': '/bin/bash', 03:47:02 INFO - 'SHLVL': '1', 03:47:02 INFO - 'TERM': 'linux', 03:47:02 INFO - 'TMOUT': '86400', 03:47:02 INFO - 'USER': 'cltbld', 03:47:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453721234.894395-1936994184', 03:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:02 INFO - '_': '/tools/buildbot/bin/python'} 03:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:47:02 INFO - Running setup.py (path:/tmp/pip-2TkVB7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 03:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:47:02 INFO - Running setup.py (path:/tmp/pip-3Onfb9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:47:02 INFO - Running setup.py (path:/tmp/pip-eZhPf4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:47:02 INFO - Running setup.py (path:/tmp/pip-MtMTij-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:47:02 INFO - Running setup.py (path:/tmp/pip-CJgF1g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 03:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:47:02 INFO - Running setup.py (path:/tmp/pip-ISIBeI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 03:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:47:02 INFO - Running setup.py (path:/tmp/pip-LviGpJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 03:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:47:02 INFO - Running setup.py (path:/tmp/pip-8_XMl6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 03:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:47:02 INFO - Running setup.py (path:/tmp/pip-9xdazN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:47:03 INFO - Running setup.py (path:/tmp/pip-j7ugUC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:47:03 INFO - Running setup.py (path:/tmp/pip-7zhXmY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:47:03 INFO - Running setup.py (path:/tmp/pip-NDje2F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:03 INFO - Running setup.py (path:/tmp/pip-EnsaZY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:03 INFO - Running setup.py (path:/tmp/pip-NTBzgI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:03 INFO - Running setup.py (path:/tmp/pip-uJK_VG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:03 INFO - Running setup.py (path:/tmp/pip-SjDKoJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:03 INFO - Running setup.py (path:/tmp/pip-bvk0K9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 03:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:47:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:05 INFO - Downloading blessings-1.6.tar.gz 03:47:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:47:05 INFO - Installing collected packages: blessings 03:47:05 INFO - Running setup.py install for blessings 03:47:05 INFO - Successfully installed blessings 03:47:05 INFO - Cleaning up... 03:47:05 INFO - Return code: 0 03:47:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:47:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:47:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:47:05 INFO - Reading from file tmpfile_stdout 03:47:05 INFO - Current package versions: 03:47:05 INFO - argparse == 1.2.1 03:47:05 INFO - blessings == 1.6 03:47:05 INFO - blobuploader == 1.2.4 03:47:05 INFO - docopt == 0.6.1 03:47:05 INFO - manifestparser == 1.1 03:47:05 INFO - mozInstall == 1.12 03:47:05 INFO - mozcrash == 0.16 03:47:05 INFO - mozdebug == 0.1 03:47:05 INFO - mozdevice == 0.47 03:47:05 INFO - mozfile == 1.2 03:47:05 INFO - mozhttpd == 0.7 03:47:05 INFO - mozinfo == 0.9 03:47:05 INFO - mozleak == 0.1 03:47:05 INFO - mozlog == 3.1 03:47:05 INFO - moznetwork == 0.27 03:47:05 INFO - mozprocess == 0.22 03:47:05 INFO - mozprofile == 0.27 03:47:05 INFO - mozrunner == 6.11 03:47:05 INFO - mozscreenshot == 0.1 03:47:05 INFO - mozsystemmonitor == 0.0 03:47:05 INFO - moztest == 0.7 03:47:05 INFO - mozversion == 1.4 03:47:05 INFO - psutil == 3.1.1 03:47:05 INFO - requests == 1.2.3 03:47:05 INFO - wsgiref == 0.1.2 03:47:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:05 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 0x7f267bf72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ec450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157ea50>, '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 0x14ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea9e0>, '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-1453721234.894395-1936994184', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:47:05 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 03:47:05 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 03:47:05 INFO - Using env: {'DISPLAY': ':0', 03:47:05 INFO - 'HOME': '/home/cltbld', 03:47:05 INFO - 'LANG': 'en_US.UTF-8', 03:47:05 INFO - 'LANGUAGE': 'en_US:en', 03:47:05 INFO - 'LOGNAME': 'cltbld', 03:47:05 INFO - 'MAIL': '/var/mail/cltbld', 03:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:05 INFO - 'MOZ_NO_REMOTE': '1', 03:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:05 INFO - 'NO_EM_RESTART': '1', 03:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:05 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:05 INFO - 'SHELL': '/bin/bash', 03:47:05 INFO - 'SHLVL': '1', 03:47:05 INFO - 'TERM': 'linux', 03:47:05 INFO - 'TMOUT': '86400', 03:47:05 INFO - 'USER': 'cltbld', 03:47:05 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453721234.894395-1936994184', 03:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:05 INFO - '_': '/tools/buildbot/bin/python'} 03:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:47:06 INFO - Cleaning up... 03:47:06 INFO - Return code: 0 03:47:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:06 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 0x7f267bf72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ec450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157ea50>, '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 0x14ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea9e0>, '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-1453721234.894395-1936994184', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:47:06 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 03:47:06 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 03:47:06 INFO - Using env: {'DISPLAY': ':0', 03:47:06 INFO - 'HOME': '/home/cltbld', 03:47:06 INFO - 'LANG': 'en_US.UTF-8', 03:47:06 INFO - 'LANGUAGE': 'en_US:en', 03:47:06 INFO - 'LOGNAME': 'cltbld', 03:47:06 INFO - 'MAIL': '/var/mail/cltbld', 03:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:06 INFO - 'MOZ_NO_REMOTE': '1', 03:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:06 INFO - 'NO_EM_RESTART': '1', 03:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:06 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:06 INFO - 'SHELL': '/bin/bash', 03:47:06 INFO - 'SHLVL': '1', 03:47:06 INFO - 'TERM': 'linux', 03:47:06 INFO - 'TMOUT': '86400', 03:47:06 INFO - 'USER': 'cltbld', 03:47:06 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453721234.894395-1936994184', 03:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:06 INFO - '_': '/tools/buildbot/bin/python'} 03:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:06 INFO - Downloading/unpacking jsonschema 03:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:47:08 INFO - Downloading/unpacking functools32 (from jsonschema) 03:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:08 INFO - Downloading functools32-3.2.3-2.tar.gz 03:47:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:47:08 INFO - warning: no files found matching '*.txt' 03:47:08 INFO - no previously-included directories found matching 'build' 03:47:08 INFO - no previously-included directories found matching 'dist' 03:47:08 INFO - no previously-included directories found matching '.git*' 03:47:08 INFO - Installing collected packages: jsonschema, functools32 03:47:08 INFO - Running setup.py install for functools32 03:47:08 INFO - warning: no files found matching '*.txt' 03:47:08 INFO - no previously-included directories found matching 'build' 03:47:08 INFO - no previously-included directories found matching 'dist' 03:47:08 INFO - no previously-included directories found matching '.git*' 03:47:08 INFO - Successfully installed jsonschema functools32 03:47:08 INFO - Cleaning up... 03:47:08 INFO - Return code: 0 03:47:08 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:08 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 0x7f267bf72f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ec450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157ea50>, '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 0x14ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea9e0>, '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-1453721234.894395-1936994184', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:47:08 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 03:47:08 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 03:47:08 INFO - Using env: {'DISPLAY': ':0', 03:47:08 INFO - 'HOME': '/home/cltbld', 03:47:08 INFO - 'LANG': 'en_US.UTF-8', 03:47:08 INFO - 'LANGUAGE': 'en_US:en', 03:47:08 INFO - 'LOGNAME': 'cltbld', 03:47:08 INFO - 'MAIL': '/var/mail/cltbld', 03:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:08 INFO - 'MOZ_NO_REMOTE': '1', 03:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:08 INFO - 'NO_EM_RESTART': '1', 03:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:08 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:08 INFO - 'SHELL': '/bin/bash', 03:47:08 INFO - 'SHLVL': '1', 03:47:08 INFO - 'TERM': 'linux', 03:47:08 INFO - 'TMOUT': '86400', 03:47:08 INFO - 'USER': 'cltbld', 03:47:08 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453721234.894395-1936994184', 03:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:08 INFO - '_': '/tools/buildbot/bin/python'} 03:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:08 INFO - Downloading/unpacking flake8 03:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:47:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:47:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:47:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:47:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:47:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:47:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:47:11 INFO - no previously-included directories found matching 'docs/_build' 03:47:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:47:11 INFO - Running setup.py install for pep8 03:47:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:47:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:47:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:47:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:47:11 INFO - no previously-included directories found matching 'docs/_build' 03:47:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:47:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:47:11 INFO - Cleaning up... 03:47:11 INFO - Return code: 0 03:47:11 INFO - Running post-action listener: _resource_record_post_action 03:47:11 INFO - Running post-action listener: _start_resource_monitoring 03:47:11 INFO - Starting resource monitoring. 03:47:11 INFO - ##### 03:47:11 INFO - ##### Running install step. 03:47:11 INFO - ##### 03:47:11 INFO - Running pre-action listener: _resource_record_pre_action 03:47:11 INFO - Running main action method: install 03:47:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:47:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:47:11 INFO - Reading from file tmpfile_stdout 03:47:11 INFO - Detecting whether we're running mozinstall >=1.0... 03:47:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:47:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:47:11 INFO - Reading from file tmpfile_stdout 03:47:11 INFO - Output received: 03:47:11 INFO - Usage: mozinstall [options] installer 03:47:11 INFO - Options: 03:47:11 INFO - -h, --help show this help message and exit 03:47:11 INFO - -d DEST, --destination=DEST 03:47:11 INFO - Directory to install application into. [default: 03:47:11 INFO - "/builds/slave/test-pgo"] 03:47:11 INFO - --app=APP Application being installed. [default: firefox] 03:47:11 INFO - mkdir: /builds/slave/test-pgo/build/application 03:47:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:47:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:47:26 INFO - Reading from file tmpfile_stdout 03:47:26 INFO - Output received: 03:47:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:47:26 INFO - Running post-action listener: _resource_record_post_action 03:47:26 INFO - ##### 03:47:26 INFO - ##### Running run-tests step. 03:47:26 INFO - ##### 03:47:26 INFO - Running pre-action listener: _resource_record_pre_action 03:47:26 INFO - Running main action method: run_tests 03:47:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:47:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:47:26 INFO - Python 2.7.3 03:47:26 INFO - Return code: 0 03:47:26 INFO - grabbing minidump binary from tooltool 03:47:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:26 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 0x157ea50>, '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 0x14ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea9e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:47:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 03:47:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:47:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:47:26 INFO - Return code: 0 03:47:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:47:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:47:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:47:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:47:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:47:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:47:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:47:27 INFO - Return code: 0 03:47:27 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/hWuNuRHrQOytGSTwM74O8w/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 03:47:27 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/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost 03:47:27 INFO - Using env: {'DISPLAY': ':0', 03:47:27 INFO - 'HOME': '/home/cltbld', 03:47:27 INFO - 'LANG': 'en_US.UTF-8', 03:47:27 INFO - 'LANGUAGE': 'en_US:en', 03:47:27 INFO - 'LOGNAME': 'cltbld', 03:47:27 INFO - 'MAIL': '/var/mail/cltbld', 03:47:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:47:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:27 INFO - 'MOZ_NO_REMOTE': '1', 03:47:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:27 INFO - 'NO_EM_RESTART': '1', 03:47:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:27 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:47:27 INFO - 'SHELL': '/bin/bash', 03:47:27 INFO - 'SHLVL': '1', 03:47:27 INFO - 'TERM': 'linux', 03:47:27 INFO - 'TMOUT': '86400', 03:47:27 INFO - 'USER': 'cltbld', 03:47:27 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453721234.894395-1936994184', 03:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:27 INFO - '_': '/tools/buildbot/bin/python'} 03:47:27 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/hWuNuRHrQOytGSTwM74O8w/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 03:47:27 INFO - mozversion INFO | application_buildid: 20160125001712 03:47:27 INFO - mozversion INFO | application_changeset: ab89c814f1b8a841168de98ac2679a1d66122a06 03:47:27 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:47:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:47:27 INFO - mozversion INFO | application_name: Firefox 03:47:27 INFO - mozversion INFO | application_remotingname: firefox-dev 03:47:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:47:27 INFO - mozversion INFO | application_vendor: Mozilla 03:47:27 INFO - mozversion INFO | application_version: 45.0a2 03:47:27 INFO - mozversion INFO | platform_buildid: 20160125001712 03:47:27 INFO - mozversion INFO | platform_changeset: ab89c814f1b8a841168de98ac2679a1d66122a06 03:47:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:47:27 INFO - mozversion INFO | platform_version: 45.0a2 03:47:27 INFO - 2016-01-25 03:47:27,616 DEBUG : using testdate: 1453722447 03:47:27 INFO - 2016-01-25 03:47:27,616 DEBUG : actual date: 1453722447 03:47:27 INFO - 2016-01-25 03:47:27,628 INFO : starting webserver on 'localhost:46316' 03:47:27 INFO - 2016-01-25 03:47:27,629 INFO : Starting test suite talos-linux64-ix-053.e 03:47:27 INFO - 2016-01-25 03:47:27,629 INFO : Starting test dromaeo_css 03:47:27 INFO - 2016-01-25 03:47:27,630 DEBUG : operating with platform_type : linux_ 03:47:27 INFO - 2016-01-25 03:47:27,630 INFO : Initialising browser for dromaeo_css test... 03:47:27 INFO - 2016-01-25 03:47:27,647 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5wNRUn/profile http://localhost:46316/getInfo.html 03:47:31 INFO - 2016-01-25 03:47:31,668 DEBUG : BROWSER_OUTPUT: 03:47:31 INFO - 2016-01-25 03:47:31,669 DEBUG : BROWSER_OUTPUT: (process:14735): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:47:32 INFO - 2016-01-25 03:47:32,519 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:47:32 INFO - 2016-01-25 03:47:32,519 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:47:32 INFO - 2016-01-25 03:47:32,519 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:47:32 INFO - 2016-01-25 03:47:32,519 DEBUG : BROWSER_OUTPUT: __metrics 03:47:33 INFO - 2016-01-25 03:47:33,574 INFO : Browser initialized. 03:47:33 INFO - 2016-01-25 03:47:33,575 INFO : Running cycle 1/1 for dromaeo_css test... 03:47:33 INFO - 2016-01-25 03:47:33,575 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5wNRUn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:47:34 INFO - 2016-01-25 03:47:34,891 DEBUG : BROWSER_OUTPUT: 03:47:34 INFO - 2016-01-25 03:47:34,891 DEBUG : BROWSER_OUTPUT: (process:14848): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:47:45 INFO - 2016-01-25 03:47:45,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 136695808 03:47:45 INFO - 2016-01-25 03:47:45,399 DEBUG : BROWSER_OUTPUT: 03:48:35 INFO - 2016-01-25 03:48:35,007 DEBUG : BROWSER_OUTPUT: 1453722515003 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:50:43 INFO - 2016-01-25 03:50:43,346 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46316/tests/dromaeo/cssquery-ext.html) 03:50:44 INFO - 2016-01-25 03:50:44,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 141209600 03:50:44 INFO - 2016-01-25 03:50:44,436 DEBUG : BROWSER_OUTPUT: 03:53:46 INFO - 2016-01-25 03:53:46,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/dromaeo/cssquery-ext.html (next: http://localhost:46316/tests/dromaeo/cssquery-jquery.html) 03:53:46 INFO - 2016-01-25 03:53:46,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 139358208 03:53:46 INFO - 2016-01-25 03:53:46,794 DEBUG : BROWSER_OUTPUT: 03:56:48 INFO - 2016-01-25 03:56:48,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46316/tests/dromaeo/cssquery-mootools.html) 03:56:49 INFO - 2016-01-25 03:56:49,032 DEBUG : BROWSER_OUTPUT: RSS: Main: 140697600 03:56:49 INFO - 2016-01-25 03:56:49,032 DEBUG : BROWSER_OUTPUT: 03:59:50 INFO - 2016-01-25 03:59:50,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46316/tests/dromaeo/cssquery-prototype.html) 03:59:51 INFO - 2016-01-25 03:59:51,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 139243520 03:59:51 INFO - 2016-01-25 03:59:51,186 DEBUG : BROWSER_OUTPUT: 04:02:53 INFO - 2016-01-25 04:02:53,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46316/tests/dromaeo/cssquery-yui.html) 04:02:54 INFO - 2016-01-25 04:02:54,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 139448320 04:02:54 INFO - 2016-01-25 04:02:54,025 DEBUG : BROWSER_OUTPUT: 04:05:56 INFO - 2016-01-25 04:05:56,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/dromaeo/cssquery-yui.html (next: http://localhost:46316/tests/dromaeo/cssquery-dojo.html) 04:05:56 INFO - 2016-01-25 04:05:56,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 141660160 04:05:56 INFO - 2016-01-25 04:05:56,323 DEBUG : BROWSER_OUTPUT: 04:05:56 INFO - 2016-01-25 04:05:56,324 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:05:56 INFO - 2016-01-25 04:05:56,324 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:05:56 INFO - 2016-01-25 04:05:56,324 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:05:56 INFO - 2016-01-25 04:05:56,324 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:05:56 INFO - 2016-01-25 04:05:56,325 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3389.6610338966098;3409.727221822253;3416.1630400551853;3420.9144771380697;3440.174358154043;5551.583631227654;5568.9443105568935;5596.720163991799;5602.971985140074;5617.045102332608;5577.414371490986;5591.6365436246615;5611.775528978836;5618.269624948761;5635.5773317001185;5113.923291150636;5143.434222235551;5189.351331083614;5238.4499627539135;5240.187770895498;4972.03045406146;5090.770915308802;5094.745262736867;5172.431032586413;5269.420363759983;5115.590752739772;5191.948080519184;5193.844184674465;5194.92207616886;5232.92150617741;5204.791808327663;5204.9479505204845;5205.6616319939085;5221.034108689885;5248.895022099575;4962.727050012248;4991.07665081961;5040.873978150539;5130.127878260667;5131.974340128313;5433.320834895638;5472.2338872557875;5477.75350109246;5482.835514934558;5521;6072.453479186895;6114.2968558615885;6160.845978850564;6171.382861713838;6182.907256391158;5656;5837.241158649391;5947.286325640907;6105.725242364104;6141.907871381933;5688.715564221772;5691.8861622768145;5711.914321285184;5719.771209151629;5731.770729170828;6139.84650383744;6142;6150.969245153746;6152.753889844356;6157.322694503601;5561.749721262553;5710.2576665033275;5864.208331875142;5974.462298393166;5988.550858685616;6034.034554471264;6040.244969378828;6061;6062.484688801501;6072.05883088122;5975.581709280309;6017.308009578955;6019.849503762441;6031.638101713911;6043.153958445821;5852.268466441695;5870.0607902735355;5964.880702385928;5983.551233657493;6004.639721616717;4658.231391820379;4717.976410117927;4725.787339569728;4737.862912900948;4756.001239739624;4015.7992100394863;4239.364095385717;4246.915061698749;4265.680073994401;4279.593438623326;5623;5675.177099320658;5745.741441635137;5807.912881306784;5825.650460972271;6215.160953271251;6219.689015549205;6245.5628106032145;6246.063090536365;6248.5313601480075;5584.246126772915;5693.715314234271;5875.970620146872;5879.588428810028;5900.291964964232;5272.130098533776;5368.32895888014;5373.194020896896;5379.919301210485;5398.757055932492;6178.505719542426;6192.59748116371;6192.8761424771255;6192.969035154795;6196.845078873064;5993.250843644544;5994.490468310068;6006.969965150146;6058.757649693963;6120.7551697931585;6292.087647291209;6292.528060395397;6319.115323854572;6347.238331400262;6358.745650173942;6083.482903953037;6089.878202435838;6104.694765261808;6114.113453549299;6122.051082082285;5860.912086318624;5917.733701983507;6017.518598512196;6133.509319254538;6187.969060154671;5942.7920022799;6056.394360564084;6060.030395136933;6067.423594758491;6088.573799833969;6033.849153771191;6034.306054803754;6050.21347224858;6057.485113765203;6064.332923378513;5638.943610564006;5756;5780.190773291826;5865.648061116347;6017.759289628366;6017.097435384552;6060.6666633333825;6096.725647345968;6096.786612468542;6098.817035488943;5908.334368401441;5921.674307912934;5962.2249107615735;5966.582339236212;5984.251968503937 04:05:56 INFO - 2016-01-25 04:05:56,326 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.3673880146033;589.9941000589995;592.0556712044289;594.3610618585022;626.8589567347344;32039.839800800994;32903.341933161355;40714;41105;41682.37476437848;45173.54826451735;45291;45639;45763.08473830522;45905.31142032864;8970.147835955573;9101.317401194903;9126.087391260853;9140.131687489678;9174.08259174084;8931.55342232889;9055.411398259124;9075.954620226923;9086.86369704455;9114.680986165453;9058.592363343665;9132.863007054866;9167.174954254117;9189.127032931861;9215.585298661543;9025.368224224307;9069.138431848964;9096.181343679067;9096.681616143469;9117.49853758043;8968.058353872815;9113.316501262365;9116.772080697969;9129.132732390412;9131;41635.37546936798;42043.7897810509;42051;42092.57907420917;42369.15261694749;3492.266624008961;3507.1232191952013;3581.1226249568763;3740.971232910971;3848.0956975110826;32268.515972260437;32346.514802277983;32372.352552949043;32847.507287390705;32930.34139317224;3790.848366065354;3890.202508485782;3910;3954.228925359556;3975.582563830785;282259;285980;286429.5678521615;287104;287666;44851.55148448539;45845.31232031522;46078;46106.308405373944;63289;44263.55736442659;44295.335569966475;44376.3343549847;44402.55597444049;44499.77750111229;15244.23778811055;15289.694206115815;15320.080795152326;15397.538073857802;15405.691886162214;12159.878401216052;12189.939050304869;12193.878061219451;12215.633530994084;12349.691257718629;15441.613959651098;15575.922120389552;15579.844201558066;15606.375744970073;15633.296501657453;6272.717727702265;6338.492920566436;6350.0792385103905;6408.423241908251;6441.194850643669;1021.9489025548693;1025.9432784232254;1053.2837670384213;1087.7498175419698;1135.3982389333667;29369.559456608167;29435.264118397212;29731.85134074359;30024.699753002627;30087.247818804266;1123.1464087293716;1123.3652986063012;1158.472894832849;1213.8725433829497;1247.8253044573767;15394.615134621725;16712.164391780607;16971.490855274362;17547.21037553313;17662.646747064988;536898;539486;543759;544429;853078;58315;58566.41433585695;58631.41368586345;58812.117818231905;58830;1426.8573142685857;1428.4643258777958;1439.9640008999859;1464.6191990082443;1476.9261536923111;30255.671876093173;30921.8453907729;31543.36913261676;31552.52671209888;31634.683653163174;50370.49629503658;50564.49435505745;50803.74598126986;50937;51104.74447627738;317041;318086;318097;319332;320523;33786.32427351488;33874.49188262129;34219.82890085633;34567;34849.47725784065;44710.55289447194;44926;44936.550634494546;45183;45884.31173532466;39039.41378484174;39186;39661.80169099136;39979.2004159921;40250.79874600608;38781.224375512895;39280.669618123466;39419;39457;39696.603033970445;38556.42165367465;38677.2264554713;38758;39118.21763564656;39325.213495730495;34573.30853382969;34583.4812477808;34819;37456.25087498289;39713.2057358857;27958.161255162377;27990;28599.857000714863;29625.111246662636;30055.398892022473 04:05:56 INFO - 2016-01-25 04:05:56,329 DEBUG : BROWSER_OUTPUT: |2;jquery.html;379.47063845934906;388.66768912579744;389.06041908790274;391.2859032266114;393.2802970563868;16706.83293167068;17825.108744562785;17979.640407191848;18535.258589656398;19261.807381926177;11928.70178245542;12054.939725301361;12080.577179798709;16944.72914531412;17463.388781392652;5132.076226279269;5238.816641417551;5248.0553500369915;5254.737263136847;5264.39459462161;5230.398504172031;5451.700156491392;5566.666000039991;5602.495775380215;5619.185218143387;5528.474794894479;5532.6680399176175;5538.75075621596;5556.361018482866;5568.415316391782;5496.31296087987;5695.857603559903;5707.086866101446;5715.057015592422;5719.714014299289;5486.506214440719;5501.697406642633;5507.256520369739;5521.613487055908;5528.032594296023;20380.694289585666;21936.670949935764;22348.664770028463;22509.662355064687;22718.204862829887;2274.374546999572;2345.7185137783404;2347.366211123004;2386.2125498585424;2388.164142550111;10355.792884142274;10467.685969420929;12857.4214160363;14026.43894244229;14337.928310358486;1989.8607097503182;1998.9100490477817;2038.5718999010226;2041.13251867957;2054.9486262843398;62683.680402299025;65841.34158658447;66870.66564667194;67329;67799.32200678029;11143.387113708824;11193.27243729155;11245.15661325404;11258.493367798468;11258.549658013751;13691.041627086208;13782.65543361404;13800.516981905786;13825.79261311081;13970.580882573538;8257.876131858027;8274.13121622221;8280.171982801672;8364.456310339809;8397.034341050736;8001.639926203335;8022.839543209103;8056.234657707509;8072.919270807334;8124.350051995826;4772.809087636525;4800.3759511263315;4817.181079216542;4855.223164293696;4862.076205521011;1822.48059303098;1882.9152688129068;1934.2166422598589;1967.2131147541097;2013.2953466286683;978.5498670611456;993.036754348281;1040.661784919904;1054.1356088007913;1060.2419270221674;16966.55530086243;17540.736888946674;17907.388335049647;17998.1000949952;18324.54188645268;966.917811985989;1018.5671089786811;1021.6781713760141;1032.4115254304975;1071.239420011785;9372.34393592442;10273.178145748323;10284.228682848816;10320.071193592612;10396;616407;638795;645141;654818;660780;71679.92480112803;76773.2322676766;85968.57015714882;87640.5617971906;89138;1205.5177928828539;1211.1703483114095;1217.5373358123857;1219.8597161326384;1237.5173682263924;16441.342346306013;16617;16818.66362672764;16844.57888552796;16878.409255675993;22701.205457808897;35263.294734105686;35598.11004724903;35691;39658.20683586255;42158;43696.78151609222;43853.34219986639;46394.53605463902;50339.24491132563;9743.26925480606;9885.258605604753;10024.799504010025;10252.026057524523;10294.588216471557;11382;11389.829152562885;12490.687732806753;18128.90935545314;18130;13218.339083046001;13973.930130349283;14985.850141498882;15536.30086646081;16389;15128.092314461168;15144.772828407804;15390.615234618776;15434;15512.92243538775;14215.218163001135;14541.418343266574;14779.482718104815;15099.943003989616;15229.6192595186;9280.396774209656;10036.397816131055;10375.688729338131;10413.739656508647;10467.947660261954;10863.348199108079;10956.616518421817;14511.85488145105;14815.629609259855;15760.763588545951 04:05:56 INFO - 2016-01-25 04:05:56,331 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1504.1799422698534;1515.6589767302364;1714.5884987602979;1785.892846429214;1839.8225135913015;7165.3551180393815;7536.585487798176;7565.583892885896;7570.810729731759;7709.3447057000085;7694.30751232389;7710.498817576854;7779;7792.376609871211;7822.726204582841;2254.7068881045484;2293.8394312398054;2294.6443301288327;2296.276672848056;2304.562133194696;2112.514121751998;2120.4698825293676;2125.7024016637683;2129.5315030693223;2173.500094978156;2230.4423894026495;2282.4408020035116;2288.233441797;2298.885055747214;2301.056566807609;2261.796438320551;2276.7837055479704;2293.5298263855952;2299.7470278269375;2302.194232018797;2207.2164381644448;2282.4522114692522;2282.8402011859175;2301.4131396493785;2303.6314189729565;7600.201978792203;7624.961875190644;7634.351080158138;7658.502197357154;7664.080310362737;4520.547945205486;4564.2240819060835;4571.748553829538;4603.309503574457;4609.700369476007;2979.5232762757855;2982.120274519022;2992.2220222742026;3020.199647093522;3028.8334141622204;935.5369092299287;939.9624015039391;965.4545181972163;972.4068318325816;985.3939827006411;9973;10054.044865737744;10078.092971632588;10103.545340459697;10116.291859569834;3989.0426297688928;4006.1587066716315;4048.4129801178665;4057.1479989202007;4060.451839001756;8365.330773538102;8400.243978042006;8407.789805254795;8412.663493460315;8430.367722420842;4585.587297143273;4608.308753686973;4613.354130421743;4614.054118905617;4633.814647414133;4243.108947121077;4247.32042873145;4253.80857861397;4298.46269216348;4310.224159651293;3407.063057659114;3422.281320922584;3424.7260219182403;3433.4678124890684;3442.4836274559016;990.8117457683018;1000.2648053680539;1001.0490034467285;1003.8293490106553;1006.4615430744662;1073.457903758597;1079.0342643334172;1120.0423637789736;1123.3316176874746;1329.0895736420582;7025.051618031501;7028.894566581505;7062.046623705836;7071.82320441993;7073.858522829618;1122.9550817967354;1160.2980196980704;1167.6847251242286;1172.4841069929205;1187.7446349035;5479.0959491684225;5510.91733623996;5522.779088836482;5534.557235421156;5538.196961440569;8788.560571971377;8867.556622168995;9082.273418126666;9181.081891810765;9285.860712089325;9037.593308301142;9067.365284430027;9092.408993415407;9096.8635470468;9145.679901203426;6924.826879328057;7110.964445177741;7292.833146696609;7326.194118646945;7386.704531818775;7135.393491553276;7159.8926016110845;7181.533200341961;7184.676689549087;7196.8920466194095;7958.204179581995;8263.091059983517;8269.503829770232;8275.379346548913;8287.461315014505;8242.835143296981;8496.06543280251;8527.18991695788;8558.52928088961;8593.44142630727;6450.903236451363;6657.167854018247;6666.899996500153;6856.314368563104;6978.930210698031;7318;7370.15243247012;7370.373518251009;7375.594342311224;7397.593132377771;6865.176178858369;7031.578105313698;7036.542624729376;7056.682449289897;7174.2108368078425;6716.731330746716;6903.551269167488;7011.448481831757;7045.859082818212;7059.223485416703;6799.354061364163;6810.114685090906;6819.897701534382;6822.147231596051;6834.692438840363;6269.937300626935;6334.461570766536;6388.936110638834;6393.520485963479;6395.904061438989;6360.936390636034;6412.775552855815;6433.581817181868;6444.967775161094;6444.967775161094 04:05:56 INFO - 2016-01-25 04:05:56,332 DEBUG : BROWSER_OUTPUT: |4;prototype.html;359.64574893729673;366.3881318198608;369.0515375485003;369.7079307347196;373.1231605726543;6404.583702059363;6410.935890641098;6426.132472116263;6438.742450301988;6594.241662208848;6379.425851673349;6384.553081284312;6399.456046236064;6425.678716064202;6427.132337134485;4795.280707893818;4810.037992401533;4812.422509298872;4815.518448155191;4820.566149046585;4815.927761083586;4821.276808478721;4821.7589120543835;4828.348172996635;4828.927566086511;4588.839390621329;4664.626829853603;4728.527147285261;4733.171694953387;4740.597049250818;4691.873950251949;4708.646851486135;4727.030958653468;4728.574428301452;4753.33453316536;4039.9092245093952;4069.5726948670554;4071.124708187724;4073.714839961204;4074.9592504074876;5907.5864689471755;5985.461308482214;6023.156758053876;6032.426919442646;6049.334573196945;5558.082916318803;5560.972195139039;5561.026820306471;5566.081596536566;5568.747031917786;6685.665716714145;6711.9664401678165;6717.261101278856;6724.596524208514;6733.797986060426;4513.593776560093;4527.864164075083;4527.886802829923;4565.977170114162;4570.65720070996;6920.4809639277255;6997.685104170274;7079.823004424879;7090.326418990187;7096;4732.296373305608;4733.053389322149;4740.905181896412;4743.95256047442;4759.262314341283;4783.641226907996;4791.113643975876;4794.640401969867;4795.520447955247;4813.663043586916;5470.234167216593;5600.103983362724;5603.327600687943;5604.439556044363;5626.521745651666;6836.6923488443135;6850.725970961205;6850.965745171342;6859.965700171567;6871.209810871714;1641.5567796695063;1670.9582260443585;1702.1999660159952;1703.5144983679593;1706.0360896093666;1098.3958822647671;1109.672646569264;1117.6535274065066;1121.9046381057537;1135.5117299561102;6509.349065093453;6541.574797638138;6556.442702370352;6571.408573228432;6573.3426657333885;6968.65156742171;6984.2317345092;6993.19578248508;6994.61529615876;6995.160580730243;6446.548741588043;6482.351764823574;6483.513736469689;6485.513586481033;6528.477721782246;3847.499825022785;3847.7306588539095;3851.595582463801;3872.4191371294532;3886.9611303887164;7392.852142957111;7408.99978502906;7426.9257307427315;7432.405407567381;7435.739749108755;7120.465965052538;7290.307420795016;7304.306090921354;7321.121465424077;7335.7432489862595;7360.190379058299;7402.851942961111;7411.0736157980255;7422.443316751265;7428.814279643052;7103.786886393416;7156.821079472847;7183.712651493882;7198.064251647253;7201.3158749918675;6876.209235937731;7019.6841142147705;7026.824329391806;7070.7525236616475;7085.82285442868;7394.186639469546;7396.371308438843;7405.2594740527675;7409.66656500448;7429;4717.386739723814;4742.051589682008;4771;4774.212254978029;4782.832600859092;7023.824404389931;7039.120109986252;7160.997460355658;7187.101612298463;7193.244709305657;6958.269381714847;6963.825904352431;6984.057152284377;6997.825054373681;7020.859582808417;6847.349501797321;6956.0609317741455;6970.059042029261;6971.477139214478;6994.370506654222;6708.396244338033;6849.8972515411315;6871.106756121672;6886.552374095868;6888.621125838127;6989.231184569591;6993.650317484207;6994.755183568551;7021.929780702128;7024.438044956493;6716.83207919806;6849.4177994871;6859.657017149222;6865.5537390069485;6865.691043903136 04:05:56 INFO - 2016-01-25 04:05:56,332 DEBUG : BROWSER_OUTPUT: |5;yui.html;789.4513313247292;798.6406117247241;832.2717622080679;870.2211520688984;926.9860952085718;13639.045266831314;13824.93087534561;13847.723045539084;13851.792223116661;13889.513867014657;14131.434742610283;14307.928460357709;14395.2082635455;15967.361305547764;16280.185990700447;894.9194572488459;902.9819403611957;909.8089401225751;910.8815853939012;919.9540022998823;893.0489029183931;899.325505870597;902.0348227396688;908.0420156734642;908.5366463103832;926.9026752191024;931.8089791592707;934.6401635370397;936.6628013914985;939.318993729544;928.6517555916531;934.359963425056;936.1621348892771;937.2736129499624;937.8640097185938;695.9860802783967;698.1970733656285;699.1714817940757;701.3092104277283;702.1083224305104;15219.61950951224;15223.543293701206;15313.846861531465;15341.156236406992;15362;12827.743445131138;12828.422720977485;12984.805227921588;13300.600981970556;13389.129706569041;11096.833547496793;11138.721531961684;11166.497507612177;11267.54929802815;11442.256253343588;3918.2163567286657;3928.626780455852;3935.783531905744;3942.5466071401584;3973.324534829057;52066.47933520692;52567;52650.47349526494;52770;53057.73471132619;10647.787044259227;10666;10754.73113172177;10861.239713219999;10919.344839309666;18979;19078.427647170607;19109.713354299696;19119.13963871629;19131.13909874059;8221.218984196492;8300.335973122135;8320.292775114183;8463.111373305837;8547.188017138362;4683.16125848118;4711.104890070944;4756.762161891892;4778.068276686013;4846.61227101831;3138.686131386843;3162.810231386124;3163.2724473371254;3183.2996740717003;3187.920301992469;592.386879579633;608.5861614102453;615.566025951703;622.9657368844667;623.037407205868;671.9227288861746;706.0715159565156;723.6707298179316;751.4514404484647;771.3944553525456;9211.677591284273;9460.479673618018;9619.855702164474;9636.180924621345;10093.646722364681;712.8895021271711;718.5939943931662;721.8989341492195;726.9273072692688;753.1978442958232;4136.8138433770555;4241.151769646083;4301.311790113629;4438.289873620205;4503.234450143418;61314.38685613176;61367.38632613706;64089.35910640834;64262.67868660627;64282.35717642857;53943;54474;55384;59977;60347;51275.743621281654;51628;51754.48245517572;52970.470295297324;53208;9080.500572468578;9141.3601047926;9147.0852914708;9191.21874640663;9204.861927070966;38271.42592861054;39168.412473813485;39402.80298598488;39963.2007359857;40244.39633405443;51242.23136653028;51394.22908656448;51408;51464.48535514597;51581.48418515767;11350;11953.521859125885;12100.213486123726;12259.448324825582;12516.436760345989;12273.447694853574;12374.938125309316;12481.313527756061;12699.809502857279;12843.871561284268;11196.496157673088;11221;11225.101991840469;11253.324800511995;11348.024263345793;11028.338299702044;11285.316434254722;11379;11439.828402573801;11574.074074074222;11493.942530287295;11633.243839150427;11671.183017188716;11688.415579220835;12161.756764864831;10447.111995480469;10461.581536738446;10708.250422470664;10850.457477125954;11254.21220514556;9546.140847323773;9810.803783924139;9895.703128906145;9918.107370336704;9926.205903527845 04:05:56 INFO - 2016-01-25 04:05:56,332 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:05:56 INFO - 2016-01-25 04:05:56,332 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:05:56 INFO - 2016-01-25 04:05:56,332 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,314 04:05:56 INFO - 2016-01-25 04:05:56,332 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:05:56 INFO - 2016-01-25 04:05:56,332 DEBUG : BROWSER_OUTPUT: __startTimestamp1453723556322__endTimestamp 04:05:56 INFO - 2016-01-25 04:05:56,332 DEBUG : BROWSER_OUTPUT: 04:05:56 INFO - 2016-01-25 04:05:56,333 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:05:56 INFO - 2016-01-25 04:05:56,333 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:05:56 INFO - 2016-01-25 04:05:56,333 DEBUG : BROWSER_OUTPUT: 04:05:56 INFO - 2016-01-25 04:05:56,333 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5644.00 Median:5865.65 stddev:621.50 (10.6%) stddev-sans-first:597.72 04:05:56 INFO - 2016-01-25 04:05:56,334 DEBUG : BROWSER_OUTPUT: Values: 3389.7 3409.7 3416.2 3420.9 3440.2 5551.6 5568.9 5596.7 5603.0 5617.0 5577.4 5591.6 5611.8 5618.3 5635.6 5113.9 5143.4 5189.4 5238.4 5240.2 4972.0 5090.8 5094.7 5172.4 5269.4 5115.6 5191.9 5193.8 5194.9 5232.9 5204.8 5204.9 5205.7 5221.0 5248.9 4962.7 4991.1 5040.9 5130.1 5132.0 5433.3 5472.2 5477.8 5482.8 5521.0 6072.5 6114.3 6160.8 6171.4 6182.9 5656.0 5837.2 5947.3 6105.7 6141.9 5688.7 5691.9 5711.9 5719.8 5731.8 6139.8 6142.0 6151.0 6152.8 6157.3 5561.7 5710.3 5864.2 5974.5 5988.6 6034.0 6040.2 6061.0 6062.5 6072.1 5975.6 6017.3 6019.8 6031.6 6043.2 5852.3 5870.1 5964.9 5983.6 6004.6 4658.2 4718.0 4725.8 4737.9 4756.0 4015.8 4239.4 4246.9 4265.7 4279.6 5623.0 5675.2 5745.7 5807.9 5825.7 6215.2 6219.7 6245.6 6246.1 6248.5 5584.2 5693.7 5876.0 5879.6 5900.3 5272.1 5368.3 5373.2 5379.9 5398.8 6178.5 6192.6 6192.9 6193.0 6196.8 5993.3 5994.5 6007.0 6058.8 6120.8 6292.1 6292.5 6319.1 6347.2 6358.7 6083.5 6089.9 6104.7 6114.1 6122.1 5860.9 5917.7 6017.5 6133.5 6188.0 5942.8 6056.4 6060.0 6067.4 6088.6 6033.8 6034.3 6050.2 6057.5 6064.3 5638.9 5756.0 5780.2 5865.6 6017.8 6017.1 6060.7 6096.7 6096.8 6098.8 5908.3 5921.7 5962.2 5966.6 5984.3 04:05:56 INFO - 2016-01-25 04:05:56,334 DEBUG : BROWSER_OUTPUT: 04:05:56 INFO - 2016-01-25 04:05:56,334 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:55991.80 Median:39233.33 stddev:115823.12 (295.2%) stddev-sans-first:116073.25 04:05:56 INFO - 2016-01-25 04:05:56,334 DEBUG : BROWSER_OUTPUT: Values: 557.4 590.0 592.1 594.4 626.9 32039.8 32903.3 40714.0 41105.0 41682.4 45173.5 45291.0 45639.0 45763.1 45905.3 8970.1 9101.3 9126.1 9140.1 9174.1 8931.6 9055.4 9076.0 9086.9 9114.7 9058.6 9132.9 9167.2 9189.1 9215.6 9025.4 9069.1 9096.2 9096.7 9117.5 8968.1 9113.3 9116.8 9129.1 9131.0 41635.4 42043.8 42051.0 42092.6 42369.2 3492.3 3507.1 3581.1 3741.0 3848.1 32268.5 32346.5 32372.4 32847.5 32930.3 3790.8 3890.2 3910.0 3954.2 3975.6 282259.0 285980.0 286429.6 287104.0 287666.0 44851.6 45845.3 46078.0 46106.3 63289.0 44263.6 44295.3 44376.3 44402.6 44499.8 15244.2 15289.7 15320.1 15397.5 15405.7 12159.9 12189.9 12193.9 12215.6 12349.7 15441.6 15575.9 15579.8 15606.4 15633.3 6272.7 6338.5 6350.1 6408.4 6441.2 1021.9 1025.9 1053.3 1087.7 1135.4 29369.6 29435.3 29731.9 30024.7 30087.2 1123.1 1123.4 1158.5 1213.9 1247.8 15394.6 16712.2 16971.5 17547.2 17662.6 536898.0 539486.0 543759.0 544429.0 853078.0 58315.0 58566.4 58631.4 58812.1 58830.0 1426.9 1428.5 1440.0 1464.6 1476.9 30255.7 30921.8 31543.4 31552.5 31634.7 50370.5 50564.5 50803.7 50937.0 51104.7 317041.0 318086.0 318097.0 319332.0 320523.0 33786.3 33874.5 34219.8 34567.0 34849.5 44710.6 44926.0 44936.6 45183.0 45884.3 39039.4 39186.0 39661.8 39979.2 40250.8 38781.2 39280.7 39419.0 39457.0 39696.6 38556.4 38677.2 38758.0 39118.2 39325.2 34573.3 34583.5 34819.0 37456.3 39713.2 27958.2 27990.0 28599.9 29625.1 30055.4 04:05:56 INFO - 2016-01-25 04:05:56,334 DEBUG : BROWSER_OUTPUT: 04:05:56 INFO - 2016-01-25 04:05:56,334 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32170.02 Median:11209.63 stddev:105024.00 (936.9%) stddev-sans-first:105291.49 04:05:56 INFO - 2016-01-25 04:05:56,336 DEBUG : BROWSER_OUTPUT: Values: 379.5 388.7 389.1 391.3 393.3 16706.8 17825.1 17979.6 18535.3 19261.8 11928.7 12054.9 12080.6 16944.7 17463.4 5132.1 5238.8 5248.1 5254.7 5264.4 5230.4 5451.7 5566.7 5602.5 5619.2 5528.5 5532.7 5538.8 5556.4 5568.4 5496.3 5695.9 5707.1 5715.1 5719.7 5486.5 5501.7 5507.3 5521.6 5528.0 20380.7 21936.7 22348.7 22509.7 22718.2 2274.4 2345.7 2347.4 2386.2 2388.2 10355.8 10467.7 12857.4 14026.4 14337.9 1989.9 1998.9 2038.6 2041.1 2054.9 62683.7 65841.3 66870.7 67329.0 67799.3 11143.4 11193.3 11245.2 11258.5 11258.5 13691.0 13782.7 13800.5 13825.8 13970.6 8257.9 8274.1 8280.2 8364.5 8397.0 8001.6 8022.8 8056.2 8072.9 8124.4 4772.8 4800.4 4817.2 4855.2 4862.1 1822.5 1882.9 1934.2 1967.2 2013.3 978.5 993.0 1040.7 1054.1 1060.2 16966.6 17540.7 17907.4 17998.1 18324.5 966.9 1018.6 1021.7 1032.4 1071.2 9372.3 10273.2 10284.2 10320.1 10396.0 616407.0 638795.0 645141.0 654818.0 660780.0 71679.9 76773.2 85968.6 87640.6 89138.0 1205.5 1211.2 1217.5 1219.9 1237.5 16441.3 16617.0 16818.7 16844.6 16878.4 22701.2 35263.3 35598.1 35691.0 39658.2 42158.0 43696.8 43853.3 46394.5 50339.2 9743.3 9885.3 10024.8 10252.0 10294.6 11382.0 11389.8 12490.7 18128.9 18130.0 13218.3 13973.9 14985.9 15536.3 16389.0 15128.1 15144.8 15390.6 15434.0 15512.9 14215.2 14541.4 14779.5 15099.9 15229.6 9280.4 10036.4 10375.7 10413.7 10467.9 10863.3 10956.6 14511.9 14815.6 15760.8 04:05:56 INFO - 2016-01-25 04:05:56,336 DEBUG : BROWSER_OUTPUT: 04:05:56 INFO - 2016-01-25 04:05:56,336 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5331.28 Median:6439.27 stddev:2728.95 (42.4%) stddev-sans-first:2721.44 04:05:56 INFO - 2016-01-25 04:05:56,337 DEBUG : BROWSER_OUTPUT: Values: 1504.2 1515.7 1714.6 1785.9 1839.8 7165.4 7536.6 7565.6 7570.8 7709.3 7694.3 7710.5 7779.0 7792.4 7822.7 2254.7 2293.8 2294.6 2296.3 2304.6 2112.5 2120.5 2125.7 2129.5 2173.5 2230.4 2282.4 2288.2 2298.9 2301.1 2261.8 2276.8 2293.5 2299.7 2302.2 2207.2 2282.5 2282.8 2301.4 2303.6 7600.2 7625.0 7634.4 7658.5 7664.1 4520.5 4564.2 4571.7 4603.3 4609.7 2979.5 2982.1 2992.2 3020.2 3028.8 935.5 940.0 965.5 972.4 985.4 9973.0 10054.0 10078.1 10103.5 10116.3 3989.0 4006.2 4048.4 4057.1 4060.5 8365.3 8400.2 8407.8 8412.7 8430.4 4585.6 4608.3 4613.4 4614.1 4633.8 4243.1 4247.3 4253.8 4298.5 4310.2 3407.1 3422.3 3424.7 3433.5 3442.5 990.8 1000.3 1001.0 1003.8 1006.5 1073.5 1079.0 1120.0 1123.3 1329.1 7025.1 7028.9 7062.0 7071.8 7073.9 1123.0 1160.3 1167.7 1172.5 1187.7 5479.1 5510.9 5522.8 5534.6 5538.2 8788.6 8867.6 9082.3 9181.1 9285.9 9037.6 9067.4 9092.4 9096.9 9145.7 6924.8 7111.0 7292.8 7326.2 7386.7 7135.4 7159.9 7181.5 7184.7 7196.9 7958.2 8263.1 8269.5 8275.4 8287.5 8242.8 8496.1 8527.2 8558.5 8593.4 6450.9 6657.2 6666.9 6856.3 6978.9 7318.0 7370.2 7370.4 7375.6 7397.6 6865.2 7031.6 7036.5 7056.7 7174.2 6716.7 6903.6 7011.4 7045.9 7059.2 6799.4 6810.1 6819.9 6822.1 6834.7 6269.9 6334.5 6388.9 6393.5 6395.9 6360.9 6412.8 6433.6 6445.0 6445.0 04:05:56 INFO - 2016-01-25 04:05:56,338 DEBUG : BROWSER_OUTPUT: 04:05:56 INFO - 2016-01-25 04:05:56,338 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5695.30 Median:6482.93 stddev:1770.00 (27.3%) stddev-sans-first:1729.06 04:05:56 INFO - 2016-01-25 04:05:56,339 DEBUG : BROWSER_OUTPUT: Values: 359.6 366.4 369.1 369.7 373.1 6404.6 6410.9 6426.1 6438.7 6594.2 6379.4 6384.6 6399.5 6425.7 6427.1 4795.3 4810.0 4812.4 4815.5 4820.6 4815.9 4821.3 4821.8 4828.3 4828.9 4588.8 4664.6 4728.5 4733.2 4740.6 4691.9 4708.6 4727.0 4728.6 4753.3 4039.9 4069.6 4071.1 4073.7 4075.0 5907.6 5985.5 6023.2 6032.4 6049.3 5558.1 5561.0 5561.0 5566.1 5568.7 6685.7 6712.0 6717.3 6724.6 6733.8 4513.6 4527.9 4527.9 4566.0 4570.7 6920.5 6997.7 7079.8 7090.3 7096.0 4732.3 4733.1 4740.9 4744.0 4759.3 4783.6 4791.1 4794.6 4795.5 4813.7 5470.2 5600.1 5603.3 5604.4 5626.5 6836.7 6850.7 6851.0 6860.0 6871.2 1641.6 1671.0 1702.2 1703.5 1706.0 1098.4 1109.7 1117.7 1121.9 1135.5 6509.3 6541.6 6556.4 6571.4 6573.3 6968.7 6984.2 6993.2 6994.6 6995.2 6446.5 6482.4 6483.5 6485.5 6528.5 3847.5 3847.7 3851.6 3872.4 3887.0 7392.9 7409.0 7426.9 7432.4 7435.7 7120.5 7290.3 7304.3 7321.1 7335.7 7360.2 7402.9 7411.1 7422.4 7428.8 7103.8 7156.8 7183.7 7198.1 7201.3 6876.2 7019.7 7026.8 7070.8 7085.8 7394.2 7396.4 7405.3 7409.7 7429.0 4717.4 4742.1 4771.0 4774.2 4782.8 7023.8 7039.1 7161.0 7187.1 7193.2 6958.3 6963.8 6984.1 6997.8 7020.9 6847.3 6956.1 6970.1 6971.5 6994.4 6708.4 6849.9 6871.1 6886.6 6888.6 6989.2 6993.7 6994.8 7021.9 7024.4 6716.8 6849.4 6859.7 6865.6 6865.7 04:05:56 INFO - 2016-01-25 04:05:56,340 DEBUG : BROWSER_OUTPUT: 04:05:56 INFO - 2016-01-25 04:05:56,340 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15106.13 Median:28044.42 stddev:17800.31 (63.5%) stddev-sans-first:17817.77 04:05:56 INFO - 2016-01-25 04:05:56,341 DEBUG : BROWSER_OUTPUT: Values: 789.5 798.6 832.3 870.2 927.0 13639.0 13824.9 13847.7 13851.8 13889.5 14131.4 14307.9 14395.2 15967.4 16280.2 894.9 903.0 909.8 910.9 920.0 893.0 899.3 902.0 908.0 908.5 926.9 931.8 934.6 936.7 939.3 928.7 934.4 936.2 937.3 937.9 696.0 698.2 699.2 701.3 702.1 15219.6 15223.5 15313.8 15341.2 15362.0 12827.7 12828.4 12984.8 13300.6 13389.1 11096.8 11138.7 11166.5 11267.5 11442.3 3918.2 3928.6 3935.8 3942.5 3973.3 52066.5 52567.0 52650.5 52770.0 53057.7 10647.8 10666.0 10754.7 10861.2 10919.3 18979.0 19078.4 19109.7 19119.1 19131.1 8221.2 8300.3 8320.3 8463.1 8547.2 4683.2 4711.1 4756.8 4778.1 4846.6 3138.7 3162.8 3163.3 3183.3 3187.9 592.4 608.6 615.6 623.0 623.0 671.9 706.1 723.7 751.5 771.4 9211.7 9460.5 9619.9 9636.2 10093.6 712.9 718.6 721.9 726.9 753.2 4136.8 4241.2 4301.3 4438.3 4503.2 61314.4 61367.4 64089.4 64262.7 64282.4 53943.0 54474.0 55384.0 59977.0 60347.0 51275.7 51628.0 51754.5 52970.5 53208.0 9080.5 9141.4 9147.1 9191.2 9204.9 38271.4 39168.4 39402.8 39963.2 40244.4 51242.2 51394.2 51408.0 51464.5 51581.5 11350.0 11953.5 12100.2 12259.4 12516.4 12273.4 12374.9 12481.3 12699.8 12843.9 11196.5 11221.0 11225.1 11253.3 11348.0 11028.3 11285.3 11379.0 11439.8 11574.1 11493.9 11633.2 11671.2 11688.4 12161.8 10447.1 10461.6 10708.3 10850.5 11254.2 9546.1 9810.8 9895.7 9918.1 9926.2 04:05:56 INFO - 2016-01-25 04:05:56,341 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:05:56 INFO - 2016-01-25 04:05:56,341 DEBUG : BROWSER_OUTPUT: 04:05:56 INFO - 2016-01-25 04:05:56,951 INFO : Browser exited with error code: 0 04:05:56 INFO - 2016-01-25 04:05:56,972 INFO : Completed test dromaeo_css (00:18:29) 04:05:56 INFO - 2016-01-25 04:05:56,972 INFO : Starting test kraken 04:05:56 INFO - 2016-01-25 04:05:56,972 DEBUG : operating with platform_type : linux_ 04:05:56 INFO - 2016-01-25 04:05:56,972 INFO : Initialising browser for kraken test... 04:05:56 INFO - 2016-01-25 04:05:56,978 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYnNwgB/profile http://localhost:46316/getInfo.html 04:06:00 INFO - 2016-01-25 04:06:00,532 DEBUG : BROWSER_OUTPUT: 04:06:00 INFO - 2016-01-25 04:06:00,532 DEBUG : BROWSER_OUTPUT: (process:15114): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:06:01 INFO - 2016-01-25 04:06:01,402 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:06:01 INFO - 2016-01-25 04:06:01,403 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:06:01 INFO - 2016-01-25 04:06:01,403 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:06:01 INFO - 2016-01-25 04:06:01,403 DEBUG : BROWSER_OUTPUT: __metrics 04:06:02 INFO - 2016-01-25 04:06:02,402 INFO : Browser initialized. 04:06:02 INFO - 2016-01-25 04:06:02,403 INFO : Running cycle 1/1 for kraken test... 04:06:02 INFO - 2016-01-25 04:06:02,403 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYnNwgB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:06:03 INFO - 2016-01-25 04:06:03,754 DEBUG : BROWSER_OUTPUT: 04:06:03 INFO - 2016-01-25 04:06:03,754 DEBUG : BROWSER_OUTPUT: (process:15233): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:06:14 INFO - 2016-01-25 04:06:14,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 135921664 04:06:14 INFO - 2016-01-25 04:06:14,259 DEBUG : BROWSER_OUTPUT: 04:06:16 INFO - 2016-01-25 04:06:16,699 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46316/tests/kraken/driver.html?testName=audio-beat-detection) 04:06:17 INFO - 2016-01-25 04:06:17,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 137453568 04:06:17 INFO - 2016-01-25 04:06:17,302 DEBUG : BROWSER_OUTPUT: 04:06:19 INFO - 2016-01-25 04:06:19,899 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46316/tests/kraken/driver.html?testName=audio-dft) 04:06:20 INFO - 2016-01-25 04:06:20,489 DEBUG : BROWSER_OUTPUT: RSS: Main: 139264000 04:06:20 INFO - 2016-01-25 04:06:20,489 DEBUG : BROWSER_OUTPUT: 04:06:23 INFO - 2016-01-25 04:06:23,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46316/tests/kraken/driver.html?testName=audio-fft) 04:06:23 INFO - 2016-01-25 04:06:23,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 138309632 04:06:23 INFO - 2016-01-25 04:06:23,895 DEBUG : BROWSER_OUTPUT: 04:06:25 INFO - 2016-01-25 04:06:25,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46316/tests/kraken/driver.html?testName=audio-oscillator) 04:06:26 INFO - 2016-01-25 04:06:26,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 139354112 04:06:26 INFO - 2016-01-25 04:06:26,495 DEBUG : BROWSER_OUTPUT: 04:06:28 INFO - 2016-01-25 04:06:28,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46316/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:06:29 INFO - 2016-01-25 04:06:29,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 138330112 04:06:29 INFO - 2016-01-25 04:06:29,250 DEBUG : BROWSER_OUTPUT: 04:06:32 INFO - 2016-01-25 04:06:32,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46316/tests/kraken/driver.html?testName=imaging-darkroom) 04:06:32 INFO - 2016-01-25 04:06:32,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 137703424 04:06:32 INFO - 2016-01-25 04:06:32,801 DEBUG : BROWSER_OUTPUT: 04:06:36 INFO - 2016-01-25 04:06:36,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46316/tests/kraken/driver.html?testName=imaging-desaturate) 04:06:36 INFO - 2016-01-25 04:06:36,704 DEBUG : BROWSER_OUTPUT: RSS: Main: 138993664 04:06:36 INFO - 2016-01-25 04:06:36,704 DEBUG : BROWSER_OUTPUT: 04:06:39 INFO - 2016-01-25 04:06:39,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46316/tests/kraken/driver.html?testName=json-parse-financial) 04:06:40 INFO - 2016-01-25 04:06:40,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 138125312 04:06:40 INFO - 2016-01-25 04:06:40,073 DEBUG : BROWSER_OUTPUT: 04:06:41 INFO - 2016-01-25 04:06:41,643 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46316/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:06:42 INFO - 2016-01-25 04:06:42,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 139075584 04:06:42 INFO - 2016-01-25 04:06:42,218 DEBUG : BROWSER_OUTPUT: 04:06:43 INFO - 2016-01-25 04:06:43,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46316/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:06:44 INFO - 2016-01-25 04:06:44,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 138764288 04:06:44 INFO - 2016-01-25 04:06:44,582 DEBUG : BROWSER_OUTPUT: 04:06:46 INFO - 2016-01-25 04:06:46,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46316/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:06:47 INFO - 2016-01-25 04:06:47,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 138149888 04:06:47 INFO - 2016-01-25 04:06:47,222 DEBUG : BROWSER_OUTPUT: 04:06:49 INFO - 2016-01-25 04:06:49,601 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:06:50 INFO - 2016-01-25 04:06:50,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 139251712 04:06:50 INFO - 2016-01-25 04:06:50,204 DEBUG : BROWSER_OUTPUT: 04:06:52 INFO - 2016-01-25 04:06:52,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:06:53 INFO - 2016-01-25 04:06:53,291 DEBUG : BROWSER_OUTPUT: RSS: Main: 138182656 04:06:53 INFO - 2016-01-25 04:06:53,291 DEBUG : BROWSER_OUTPUT: 04:06:54 INFO - 2016-01-25 04:06:54,940 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46316/tests/kraken/driver.html?testName=ai-astar) 04:06:55 INFO - 2016-01-25 04:06:55,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 140218368 04:06:55 INFO - 2016-01-25 04:06:55,190 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2016-01-25 04:06:55,190 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:06:55 INFO - 2016-01-25 04:06:55,190 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:06:55 INFO - 2016-01-25 04:06:55,190 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:06:55 INFO - 2016-01-25 04:06:55,190 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:06:55 INFO - 2016-01-25 04:06:55,190 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;106;112;111;112;122;111;112;111;112 04:06:55 INFO - 2016-01-25 04:06:55,191 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;123;155;155;128;146;145;126;163;125 04:06:55 INFO - 2016-01-25 04:06:55,191 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;161;163;167;162;162;161;160;165;161 04:06:55 INFO - 2016-01-25 04:06:55,191 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;72;74;155;73;71;72;73;157;71 04:06:55 INFO - 2016-01-25 04:06:55,191 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;92;140;93;94;92;134;93;94;137 04:06:55 INFO - 2016-01-25 04:06:55,191 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;110;110;109;109;111;109;110 04:06:55 INFO - 2016-01-25 04:06:55,192 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;147;146;147;146;147;147 04:06:55 INFO - 2016-01-25 04:06:55,192 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;96;97;95;97;95;96 04:06:55 INFO - 2016-01-25 04:06:55,192 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;62;60;60;62;64;61;60;63;59 04:06:55 INFO - 2016-01-25 04:06:55,192 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;63;64;64;63;63;64;64;63 04:06:55 INFO - 2016-01-25 04:06:55,192 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;90;93;83;82;85;83;84;83 04:06:55 INFO - 2016-01-25 04:06:55,193 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;123;116;117;114;121;116;124;121;113 04:06:55 INFO - 2016-01-25 04:06:55,193 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;154;143;145;146;142;153;137;143;134 04:06:55 INFO - 2016-01-25 04:06:55,193 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;64;65;65;66;66;64;65;65;64 04:06:55 INFO - 2016-01-25 04:06:55,193 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:06:55 INFO - 2016-01-25 04:06:55,193 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:06:55 INFO - 2016-01-25 04:06:55,193 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,685 04:06:55 INFO - 2016-01-25 04:06:55,194 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:06:55 INFO - 2016-01-25 04:06:55,194 DEBUG : BROWSER_OUTPUT: __startTimestamp1453723615188__endTimestamp 04:06:55 INFO - 2016-01-25 04:06:55,194 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2016-01-25 04:06:55,202 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:06:55 INFO - 2016-01-25 04:06:55,202 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:06:55 INFO - 2016-01-25 04:06:55,202 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2016-01-25 04:06:55,202 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:3.93 (3.5%) stddev-sans-first:4.17 04:06:55 INFO - 2016-01-25 04:06:55,202 DEBUG : BROWSER_OUTPUT: Values: 112.0 106.0 112.0 111.0 112.0 122.0 111.0 112.0 111.0 112.0 04:06:55 INFO - 2016-01-25 04:06:55,202 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2016-01-25 04:06:55,202 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.70 Median:148.50 stddev:14.86 (10.0%) stddev-sans-first:15.37 04:06:55 INFO - 2016-01-25 04:06:55,202 DEBUG : BROWSER_OUTPUT: Values: 151.0 123.0 155.0 155.0 128.0 146.0 145.0 126.0 163.0 125.0 04:06:55 INFO - 2016-01-25 04:06:55,202 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2016-01-25 04:06:55,203 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:2.12 (1.3%) stddev-sans-first:2.24 04:06:55 INFO - 2016-01-25 04:06:55,203 DEBUG : BROWSER_OUTPUT: Values: 163.0 161.0 163.0 167.0 162.0 162.0 161.0 160.0 165.0 161.0 04:06:55 INFO - 2016-01-25 04:06:55,203 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2016-01-25 04:06:55,203 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.50 Median:72.50 stddev:35.09 (48.4%) stddev-sans-first:36.93 04:06:55 INFO - 2016-01-25 04:06:55,203 DEBUG : BROWSER_OUTPUT: Values: 77.0 72.0 74.0 155.0 73.0 71.0 72.0 73.0 157.0 71.0 04:06:55 INFO - 2016-01-25 04:06:55,203 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2016-01-25 04:06:55,203 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.40 Median:93.00 stddev:21.18 (22.8%) stddev-sans-first:22.06 04:06:55 INFO - 2016-01-25 04:06:55,203 DEBUG : BROWSER_OUTPUT: Values: 95.0 92.0 140.0 93.0 94.0 92.0 134.0 93.0 94.0 137.0 04:06:55 INFO - 2016-01-25 04:06:55,203 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2016-01-25 04:06:55,203 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 04:06:55 INFO - 2016-01-25 04:06:55,203 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 110.0 110.0 109.0 109.0 111.0 109.0 110.0 04:06:55 INFO - 2016-01-25 04:06:55,204 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2016-01-25 04:06:55,204 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:06:55 INFO - 2016-01-25 04:06:55,204 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 147.0 147.0 04:06:55 INFO - 2016-01-25 04:06:55,204 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2016-01-25 04:06:55,204 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 04:06:55 INFO - 2016-01-25 04:06:55,204 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 96.0 97.0 95.0 97.0 95.0 96.0 04:06:55 INFO - 2016-01-25 04:06:55,204 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2016-01-25 04:06:55,204 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.10 Median:61.50 stddev:1.60 (2.6%) stddev-sans-first:1.64 04:06:55 INFO - 2016-01-25 04:06:55,204 DEBUG : BROWSER_OUTPUT: Values: 60.0 62.0 60.0 60.0 62.0 64.0 61.0 60.0 63.0 59.0 04:06:55 INFO - 2016-01-25 04:06:55,204 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2016-01-25 04:06:55,204 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:64.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 04:06:55 INFO - 2016-01-25 04:06:55,204 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 64.0 64.0 63.0 63.0 64.0 64.0 63.0 04:06:55 INFO - 2016-01-25 04:06:55,205 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2016-01-25 04:06:55,205 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:83.50 stddev:3.77 (4.5%) stddev-sans-first:3.87 04:06:55 INFO - 2016-01-25 04:06:55,205 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 90.0 93.0 83.0 82.0 85.0 83.0 84.0 83.0 04:06:55 INFO - 2016-01-25 04:06:55,205 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2016-01-25 04:06:55,205 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.80 Median:119.00 stddev:4.13 (3.5%) stddev-sans-first:4.00 04:06:55 INFO - 2016-01-25 04:06:55,205 DEBUG : BROWSER_OUTPUT: Values: 113.0 123.0 116.0 117.0 114.0 121.0 116.0 124.0 121.0 113.0 04:06:55 INFO - 2016-01-25 04:06:55,205 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2016-01-25 04:06:55,205 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.30 Median:145.50 stddev:6.18 (4.2%) stddev-sans-first:6.53 04:06:55 INFO - 2016-01-25 04:06:55,205 DEBUG : BROWSER_OUTPUT: Values: 146.0 154.0 143.0 145.0 146.0 142.0 153.0 137.0 143.0 134.0 04:06:55 INFO - 2016-01-25 04:06:55,205 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2016-01-25 04:06:55,205 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.00 stddev:2.07 (3.2%) stddev-sans-first:0.78 04:06:55 INFO - 2016-01-25 04:06:55,205 DEBUG : BROWSER_OUTPUT: Values: 71.0 64.0 65.0 65.0 66.0 66.0 64.0 65.0 65.0 64.0 04:06:55 INFO - 2016-01-25 04:06:55,205 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:06:55 INFO - 2016-01-25 04:06:55,205 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2016-01-25 04:06:55,998 INFO : Browser exited with error code: 0 04:06:56 INFO - 2016-01-25 04:06:56,047 INFO : Completed test kraken (00:00:59) 04:06:56 INFO - 2016-01-25 04:06:56,047 INFO : Starting test v8_7 04:06:56 INFO - 2016-01-25 04:06:56,047 DEBUG : operating with platform_type : linux_ 04:06:56 INFO - 2016-01-25 04:06:56,047 INFO : Initialising browser for v8_7 test... 04:06:56 INFO - 2016-01-25 04:06:56,053 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0uH0zZ/profile http://localhost:46316/getInfo.html 04:06:59 INFO - 2016-01-25 04:06:59,678 DEBUG : BROWSER_OUTPUT: 04:06:59 INFO - 2016-01-25 04:06:59,678 DEBUG : BROWSER_OUTPUT: (process:15542): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:07:00 INFO - 2016-01-25 04:07:00,489 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:07:00 INFO - 2016-01-25 04:07:00,489 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:07:00 INFO - 2016-01-25 04:07:00,489 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:07:00 INFO - 2016-01-25 04:07:00,489 DEBUG : BROWSER_OUTPUT: __metrics 04:07:01 INFO - 2016-01-25 04:07:01,446 INFO : Browser initialized. 04:07:01 INFO - 2016-01-25 04:07:01,447 INFO : Running cycle 1/1 for v8_7 test... 04:07:01 INFO - 2016-01-25 04:07:01,447 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0uH0zZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:07:02 INFO - 2016-01-25 04:07:02,719 DEBUG : BROWSER_OUTPUT: 04:07:02 INFO - 2016-01-25 04:07:02,719 DEBUG : BROWSER_OUTPUT: (process:15659): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:07:13 INFO - 2016-01-25 04:07:13,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 135647232 04:07:13 INFO - 2016-01-25 04:07:13,222 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2016-01-25 04:07:34,592 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46316/tests/v8_7/run.html (next: http://localhost:46316/tests/v8_7/run.html) 04:07:34 INFO - 2016-01-25 04:07:34,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 136159232 04:07:34 INFO - 2016-01-25 04:07:34,843 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2016-01-25 04:07:34,844 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:07:34 INFO - 2016-01-25 04:07:34,844 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:07:34 INFO - 2016-01-25 04:07:34,845 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:07:34 INFO - 2016-01-25 04:07:34,845 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:07:34 INFO - 2016-01-25 04:07:34,845 DEBUG : BROWSER_OUTPUT: |0;Richards;166.88918558077435 04:07:34 INFO - 2016-01-25 04:07:34,845 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.50418760469012 04:07:34 INFO - 2016-01-25 04:07:34,845 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.2415136338342 04:07:34 INFO - 2016-01-25 04:07:34,845 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 04:07:34 INFO - 2016-01-25 04:07:34,845 DEBUG : BROWSER_OUTPUT: |4;RayTrace;925.0693802035153 04:07:34 INFO - 2016-01-25 04:07:34,846 DEBUG : BROWSER_OUTPUT: |5;Earley;543.773790103317 04:07:34 INFO - 2016-01-25 04:07:34,846 DEBUG : BROWSER_OUTPUT: |6;Boyer;11043.956043956045 04:07:34 INFO - 2016-01-25 04:07:34,846 DEBUG : BROWSER_OUTPUT: |7;RegExp;24095.238095238095 04:07:34 INFO - 2016-01-25 04:07:34,846 DEBUG : BROWSER_OUTPUT: |8;Splay;526.592943654555 04:07:34 INFO - 2016-01-25 04:07:34,847 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 04:07:34 INFO - 2016-01-25 04:07:34,847 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:07:34 INFO - 2016-01-25 04:07:34,847 DEBUG : BROWSER_OUTPUT: __startTimestamp1453723654843__endTimestamp 04:07:34 INFO - 2016-01-25 04:07:34,847 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2016-01-25 04:07:34,847 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:07:34 INFO - 2016-01-25 04:07:34,847 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:07:34 INFO - 2016-01-25 04:07:34,848 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2016-01-25 04:07:34,848 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.89 Median:166.89 stddev:0.00 (0.0%) 04:07:34 INFO - 2016-01-25 04:07:34,848 DEBUG : BROWSER_OUTPUT: Values: 166.9 04:07:34 INFO - 2016-01-25 04:07:34,848 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2016-01-25 04:07:34,848 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.50 Median:167.50 stddev:0.00 (0.0%) 04:07:34 INFO - 2016-01-25 04:07:34,848 DEBUG : BROWSER_OUTPUT: Values: 167.5 04:07:34 INFO - 2016-01-25 04:07:34,849 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2016-01-25 04:07:34,849 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.24 Median:278.24 stddev:0.00 (0.0%) 04:07:34 INFO - 2016-01-25 04:07:34,849 DEBUG : BROWSER_OUTPUT: Values: 278.2 04:07:34 INFO - 2016-01-25 04:07:34,849 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2016-01-25 04:07:34,849 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 04:07:34 INFO - 2016-01-25 04:07:34,850 DEBUG : BROWSER_OUTPUT: Values: 5170.1 04:07:34 INFO - 2016-01-25 04:07:34,850 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2016-01-25 04:07:34,850 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:925.07 Median:925.07 stddev:0.00 (0.0%) 04:07:34 INFO - 2016-01-25 04:07:34,850 DEBUG : BROWSER_OUTPUT: Values: 925.1 04:07:34 INFO - 2016-01-25 04:07:34,850 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2016-01-25 04:07:34,850 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:543.77 Median:543.77 stddev:0.00 (0.0%) 04:07:34 INFO - 2016-01-25 04:07:34,850 DEBUG : BROWSER_OUTPUT: Values: 543.8 04:07:34 INFO - 2016-01-25 04:07:34,851 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2016-01-25 04:07:34,851 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11043.96 Median:11043.96 stddev:0.00 (0.0%) 04:07:34 INFO - 2016-01-25 04:07:34,851 DEBUG : BROWSER_OUTPUT: Values: 11044.0 04:07:34 INFO - 2016-01-25 04:07:34,851 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2016-01-25 04:07:34,851 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24095.24 Median:24095.24 stddev:0.00 (0.0%) 04:07:34 INFO - 2016-01-25 04:07:34,851 DEBUG : BROWSER_OUTPUT: Values: 24095.2 04:07:34 INFO - 2016-01-25 04:07:34,851 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2016-01-25 04:07:34,851 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:526.59 Median:526.59 stddev:0.00 (0.0%) 04:07:34 INFO - 2016-01-25 04:07:34,851 DEBUG : BROWSER_OUTPUT: Values: 526.6 04:07:34 INFO - 2016-01-25 04:07:34,851 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2016-01-25 04:07:34,852 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 04:07:34 INFO - 2016-01-25 04:07:34,852 DEBUG : BROWSER_OUTPUT: Values: 4835.7 04:07:34 INFO - 2016-01-25 04:07:34,852 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:07:34 INFO - 2016-01-25 04:07:34,852 DEBUG : BROWSER_OUTPUT: 04:07:35 INFO - 2016-01-25 04:07:35,631 INFO : Browser exited with error code: 0 04:07:35 INFO - 2016-01-25 04:07:35,647 INFO : Completed test v8_7 (00:00:39) 04:07:35 INFO - 2016-01-25 04:07:35,906 INFO : Completed test suite (00:20:08) 04:07:35 INFO - 2016-01-25 04:07:35,906 DEBUG : Working with test: dromaeo_css 04:07:35 INFO - 2016-01-25 04:07:35,906 DEBUG : Generating results file: dromaeo_css 04:07:35 INFO - 2016-01-25 04:07:35,907 DEBUG : Working with test: kraken 04:07:35 INFO - 2016-01-25 04:07:35,907 DEBUG : Generating results file: kraken 04:07:35 INFO - 2016-01-25 04:07:35,908 INFO : javascript benchmark 04:07:35 INFO - 2016-01-25 04:07:35,908 DEBUG : Working with test: v8_7 04:07:35 INFO - 2016-01-25 04:07:35,908 DEBUG : Generating results file: v8_7 04:07:35 INFO - 2016-01-25 04:07:35,908 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:35 INFO - 2016-01-25 04:07:35,956 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 04:07:35 INFO - 2016-01-25 04:07:35,956 DEBUG : process_Request line: dromaeo_css 7337.34 graph.html#tests=[[72,52,43]] 04:07:35 INFO - 2016-01-25 04:07:35,956 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:35 INFO - 2016-01-25 04:07:35,991 DEBUG : process_Request line: kraken 1500.90 graph.html#tests=[[232,52,43]] 04:07:35 INFO - 2016-01-25 04:07:35,992 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:36 INFO - 2016-01-25 04:07:36,020 DEBUG : process_Request line: v8_7 23212.46 graph.html#tests=[[230,52,43]] 04:07:36 INFO - 2016-01-25 04:07:36,021 INFO : javascript benchmark 04:07:36 INFO - 2016-01-25 04:07:36,025 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3389.6610338966098, 3409.727221822253, 3416.1630400551853, 3420.9144771380697, 3440.174358154043, 5551.583631227654, 5568.9443105568935, 5596.720163991799, 5602.971985140074, 5617.045102332608, 5577.414371490986, 5591.6365436246615, 5611.775528978836, 5618.269624948761, 5635.5773317001185, 5113.923291150636, 5143.434222235551, 5189.351331083614, 5238.4499627539135, 5240.187770895498, 4972.03045406146, 5090.770915308802, 5094.745262736867, 5172.431032586413, 5269.420363759983, 5115.590752739772, 5191.948080519184, 5193.844184674465, 5194.92207616886, 5232.92150617741, 5204.791808327663, 5204.9479505204845, 5205.6616319939085, 5221.034108689885, 5248.895022099575, 4962.727050012248, 4991.07665081961, 5040.873978150539, 5130.127878260667, 5131.974340128313, 5433.320834895638, 5472.2338872557875, 5477.75350109246, 5482.835514934558, 5521.0, 6072.453479186895, 6114.2968558615885, 6160.845978850564, 6171.382861713838, 6182.907256391158, 5656.0, 5837.241158649391, 5947.286325640907, 6105.725242364104, 6141.907871381933, 5688.715564221772, 5691.8861622768145, 5711.914321285184, 5719.771209151629, 5731.770729170828, 6139.84650383744, 6142.0, 6150.969245153746, 6152.753889844356, 6157.322694503601, 5561.749721262553, 5710.2576665033275, 5864.208331875142, 5974.462298393166, 5988.550858685616, 6034.034554471264, 6040.244969378828, 6061.0, 6062.484688801501, 6072.05883088122, 5975.581709280309, 6017.308009578955, 6019.849503762441, 6031.638101713911, 6043.153958445821, 5852.268466441695, 5870.0607902735355, 5964.880702385928, 5983.551233657493, 6004.639721616717, 4658.231391820379, 4717.976410117927, 4725.787339569728, 4737.862912900948, 4756.001239739624, 4015.7992100394863, 4239.364095385717, 4246.915061698749, 4265.680073994401, 4279.593438623326, 5623.0, 5675.177099320658, 5745.741441635137, 5807.912881306784, 5825.650460972271, 6215.160953271251, 6219.689015549205, 6245.5628106032145, 6246.063090536365, 6248.5313601480075, 5584.246126772915, 5693.715314234271, 5875.970620146872, 5879.588428810028, 5900.291964964232, 5272.130098533776, 5368.32895888014, 5373.194020896896, 5379.919301210485, 5398.757055932492, 6178.505719542426, 6192.59748116371, 6192.8761424771255, 6192.969035154795, 6196.845078873064, 5993.250843644544, 5994.490468310068, 6006.969965150146, 6058.757649693963, 6120.7551697931585, 6292.087647291209, 6292.528060395397, 6319.115323854572, 6347.238331400262, 6358.745650173942, 6083.482903953037, 6089.878202435838, 6104.694765261808, 6114.113453549299, 6122.051082082285, 5860.912086318624, 5917.733701983507, 6017.518598512196, 6133.509319254538, 6187.969060154671, 5942.7920022799, 6056.394360564084, 6060.030395136933, 6067.423594758491, 6088.573799833969, 6033.849153771191, 6034.306054803754, 6050.21347224858, 6057.485113765203, 6064.332923378513, 5638.943610564006, 5756.0, 5780.190773291826, 5865.648061116347, 6017.759289628366, 6017.097435384552, 6060.6666633333825, 6096.725647345968, 6096.786612468542, 6098.817035488943, 5908.334368401441, 5921.674307912934, 5962.2249107615735, 5966.582339236212, 5984.251968503937], "unit": "ms", "name": "dojo.html", "value": 5604.316835198782}, {"lowerIsBetter": false, "replicates": [557.3673880146033, 589.9941000589995, 592.0556712044289, 594.3610618585022, 626.8589567347344, 32039.839800800994, 32903.341933161355, 40714.0, 41105.0, 41682.37476437848, 45173.54826451735, 45291.0, 45639.0, 45763.08473830522, 45905.31142032864, 8970.147835955573, 9101.317401194903, 9126.087391260853, 9140.131687489678, 9174.08259174084, 8931.55342232889, 9055.411398259124, 9075.954620226923, 9086.86369704455, 9114.680986165453, 9058.592363343665, 9132.863007054866, 9167.174954254117, 9189.127032931861, 9215.585298661543, 9025.368224224307, 9069.138431848964, 9096.181343679067, 9096.681616143469, 9117.49853758043, 8968.058353872815, 9113.316501262365, 9116.772080697969, 9129.132732390412, 9131.0, 41635.37546936798, 42043.7897810509, 42051.0, 42092.57907420917, 42369.15261694749, 3492.266624008961, 3507.1232191952013, 3581.1226249568763, 3740.971232910971, 3848.0956975110826, 32268.515972260437, 32346.514802277983, 32372.352552949043, 32847.507287390705, 32930.34139317224, 3790.848366065354, 3890.202508485782, 3910.0, 3954.228925359556, 3975.582563830785, 282259.0, 285980.0, 286429.5678521615, 287104.0, 287666.0, 44851.55148448539, 45845.31232031522, 46078.0, 46106.308405373944, 63289.0, 44263.55736442659, 44295.335569966475, 44376.3343549847, 44402.55597444049, 44499.77750111229, 15244.23778811055, 15289.694206115815, 15320.080795152326, 15397.538073857802, 15405.691886162214, 12159.878401216052, 12189.939050304869, 12193.878061219451, 12215.633530994084, 12349.691257718629, 15441.613959651098, 15575.922120389552, 15579.844201558066, 15606.375744970073, 15633.296501657453, 6272.717727702265, 6338.492920566436, 6350.0792385103905, 6408.423241908251, 6441.194850643669, 1021.9489025548693, 1025.9432784232254, 1053.2837670384213, 1087.7498175419698, 1135.3982389333667, 29369.559456608167, 29435.264118397212, 29731.85134074359, 30024.699753002627, 30087.247818804266, 1123.1464087293716, 1123.3652986063012, 1158.472894832849, 1213.8725433829497, 1247.8253044573767, 15394.615134621725, 16712.164391780607, 16971.490855274362, 17547.21037553313, 17662.646747064988, 536898.0, 539486.0, 543759.0, 544429.0, 853078.0, 58315.0, 58566.41433585695, 58631.41368586345, 58812.117818231905, 58830.0, 1426.8573142685857, 1428.4643258777958, 1439.9640008999859, 1464.6191990082443, 1476.9261536923111, 30255.671876093173, 30921.8453907729, 31543.36913261676, 31552.52671209888, 31634.683653163174, 50370.49629503658, 50564.49435505745, 50803.74598126986, 50937.0, 51104.74447627738, 317041.0, 318086.0, 318097.0, 319332.0, 320523.0, 33786.32427351488, 33874.49188262129, 34219.82890085633, 34567.0, 34849.47725784065, 44710.55289447194, 44926.0, 44936.550634494546, 45183.0, 45884.31173532466, 39039.41378484174, 39186.0, 39661.80169099136, 39979.2004159921, 40250.79874600608, 38781.224375512895, 39280.669618123466, 39419.0, 39457.0, 39696.603033970445, 38556.42165367465, 38677.2264554713, 38758.0, 39118.21763564656, 39325.213495730495, 34573.30853382969, 34583.4812477808, 34819.0, 37456.25087498289, 39713.2057358857, 27958.161255162377, 27990.0, 28599.857000714863, 29625.111246662636, 30055.398892022473], "unit": "ms", "name": "ext.html", "value": 19392.801187570767}, {"lowerIsBetter": false, "replicates": [379.47063845934906, 388.66768912579744, 389.06041908790274, 391.2859032266114, 393.2802970563868, 16706.83293167068, 17825.108744562785, 17979.640407191848, 18535.258589656398, 19261.807381926177, 11928.70178245542, 12054.939725301361, 12080.577179798709, 16944.72914531412, 17463.388781392652, 5132.076226279269, 5238.816641417551, 5248.0553500369915, 5254.737263136847, 5264.39459462161, 5230.398504172031, 5451.700156491392, 5566.666000039991, 5602.495775380215, 5619.185218143387, 5528.474794894479, 5532.6680399176175, 5538.75075621596, 5556.361018482866, 5568.415316391782, 5496.31296087987, 5695.857603559903, 5707.086866101446, 5715.057015592422, 5719.714014299289, 5486.506214440719, 5501.697406642633, 5507.256520369739, 5521.613487055908, 5528.032594296023, 20380.694289585666, 21936.670949935764, 22348.664770028463, 22509.662355064687, 22718.204862829887, 2274.374546999572, 2345.7185137783404, 2347.366211123004, 2386.2125498585424, 2388.164142550111, 10355.792884142274, 10467.685969420929, 12857.4214160363, 14026.43894244229, 14337.928310358486, 1989.8607097503182, 1998.9100490477817, 2038.5718999010226, 2041.13251867957, 2054.9486262843398, 62683.680402299025, 65841.34158658447, 66870.66564667194, 67329.0, 67799.32200678029, 11143.387113708824, 11193.27243729155, 11245.15661325404, 11258.493367798468, 11258.549658013751, 13691.041627086208, 13782.65543361404, 13800.516981905786, 13825.79261311081, 13970.580882573538, 8257.876131858027, 8274.13121622221, 8280.171982801672, 8364.456310339809, 8397.034341050736, 8001.639926203335, 8022.839543209103, 8056.234657707509, 8072.919270807334, 8124.350051995826, 4772.809087636525, 4800.3759511263315, 4817.181079216542, 4855.223164293696, 4862.076205521011, 1822.48059303098, 1882.9152688129068, 1934.2166422598589, 1967.2131147541097, 2013.2953466286683, 978.5498670611456, 993.036754348281, 1040.661784919904, 1054.1356088007913, 1060.2419270221674, 16966.55530086243, 17540.736888946674, 17907.388335049647, 17998.1000949952, 18324.54188645268, 966.917811985989, 1018.5671089786811, 1021.6781713760141, 1032.4115254304975, 1071.239420011785, 9372.34393592442, 10273.178145748323, 10284.228682848816, 10320.071193592612, 10396.0, 616407.0, 638795.0, 645141.0, 654818.0, 660780.0, 71679.92480112803, 76773.2322676766, 85968.57015714882, 87640.5617971906, 89138.0, 1205.5177928828539, 1211.1703483114095, 1217.5373358123857, 1219.8597161326384, 1237.5173682263924, 16441.342346306013, 16617.0, 16818.66362672764, 16844.57888552796, 16878.409255675993, 22701.205457808897, 35263.294734105686, 35598.11004724903, 35691.0, 39658.20683586255, 42158.0, 43696.78151609222, 43853.34219986639, 46394.53605463902, 50339.24491132563, 9743.26925480606, 9885.258605604753, 10024.799504010025, 10252.026057524523, 10294.588216471557, 11382.0, 11389.829152562885, 12490.687732806753, 18128.90935545314, 18130.0, 13218.339083046001, 13973.930130349283, 14985.850141498882, 15536.30086646081, 16389.0, 15128.092314461168, 15144.772828407804, 15390.615234618776, 15434.0, 15512.92243538775, 14215.218163001135, 14541.418343266574, 14779.482718104815, 15099.943003989616, 15229.6192595186, 9280.396774209656, 10036.397816131055, 10375.688729338131, 10413.739656508647, 10467.947660261954, 10863.348199108079, 10956.616518421817, 14511.85488145105, 14815.629609259855, 15760.763588545951], "unit": "ms", "name": "jquery.html", "value": 9330.878755126067}, {"lowerIsBetter": false, "replicates": [1504.1799422698534, 1515.6589767302364, 1714.5884987602979, 1785.892846429214, 1839.8225135913015, 7165.3551180393815, 7536.585487798176, 7565.583892885896, 7570.810729731759, 7709.3447057000085, 7694.30751232389, 7710.498817576854, 7779.0, 7792.376609871211, 7822.726204582841, 2254.7068881045484, 2293.8394312398054, 2294.6443301288327, 2296.276672848056, 2304.562133194696, 2112.514121751998, 2120.4698825293676, 2125.7024016637683, 2129.5315030693223, 2173.500094978156, 2230.4423894026495, 2282.4408020035116, 2288.233441797, 2298.885055747214, 2301.056566807609, 2261.796438320551, 2276.7837055479704, 2293.5298263855952, 2299.7470278269375, 2302.194232018797, 2207.2164381644448, 2282.4522114692522, 2282.8402011859175, 2301.4131396493785, 2303.6314189729565, 7600.201978792203, 7624.961875190644, 7634.351080158138, 7658.502197357154, 7664.080310362737, 4520.547945205486, 4564.2240819060835, 4571.748553829538, 4603.309503574457, 4609.700369476007, 2979.5232762757855, 2982.120274519022, 2992.2220222742026, 3020.199647093522, 3028.8334141622204, 935.5369092299287, 939.9624015039391, 965.4545181972163, 972.4068318325816, 985.3939827006411, 9973.0, 10054.044865737744, 10078.092971632588, 10103.545340459697, 10116.291859569834, 3989.0426297688928, 4006.1587066716315, 4048.4129801178665, 4057.1479989202007, 4060.451839001756, 8365.330773538102, 8400.243978042006, 8407.789805254795, 8412.663493460315, 8430.367722420842, 4585.587297143273, 4608.308753686973, 4613.354130421743, 4614.054118905617, 4633.814647414133, 4243.108947121077, 4247.32042873145, 4253.80857861397, 4298.46269216348, 4310.224159651293, 3407.063057659114, 3422.281320922584, 3424.7260219182403, 3433.4678124890684, 3442.4836274559016, 990.8117457683018, 1000.2648053680539, 1001.0490034467285, 1003.8293490106553, 1006.4615430744662, 1073.457903758597, 1079.0342643334172, 1120.0423637789736, 1123.3316176874746, 1329.0895736420582, 7025.051618031501, 7028.894566581505, 7062.046623705836, 7071.82320441993, 7073.858522829618, 1122.9550817967354, 1160.2980196980704, 1167.6847251242286, 1172.4841069929205, 1187.7446349035, 5479.0959491684225, 5510.91733623996, 5522.779088836482, 5534.557235421156, 5538.196961440569, 8788.560571971377, 8867.556622168995, 9082.273418126666, 9181.081891810765, 9285.860712089325, 9037.593308301142, 9067.365284430027, 9092.408993415407, 9096.8635470468, 9145.679901203426, 6924.826879328057, 7110.964445177741, 7292.833146696609, 7326.194118646945, 7386.704531818775, 7135.393491553276, 7159.8926016110845, 7181.533200341961, 7184.676689549087, 7196.8920466194095, 7958.204179581995, 8263.091059983517, 8269.503829770232, 8275.379346548913, 8287.461315014505, 8242.835143296981, 8496.06543280251, 8527.18991695788, 8558.52928088961, 8593.44142630727, 6450.903236451363, 6657.167854018247, 6666.899996500153, 6856.314368563104, 6978.930210698031, 7318.0, 7370.15243247012, 7370.373518251009, 7375.594342311224, 7397.593132377771, 6865.176178858369, 7031.578105313698, 7036.542624729376, 7056.682449289897, 7174.2108368078425, 6716.731330746716, 6903.551269167488, 7011.448481831757, 7045.859082818212, 7059.223485416703, 6799.354061364163, 6810.114685090906, 6819.897701534382, 6822.147231596051, 6834.692438840363, 6269.937300626935, 6334.461570766536, 6388.936110638834, 6393.520485963479, 6395.904061438989, 6360.936390636034, 6412.775552855815, 6433.581817181868, 6444.967775161094, 6444.967775161094], "unit": "ms", "name": "mootools.html", "value": 4390.501904291595}, {"lowerIsBetter": false, "replicates": [359.64574893729673, 366.3881318198608, 369.0515375485003, 369.7079307347196, 373.1231605726543, 6404.583702059363, 6410.935890641098, 6426.132472116263, 6438.742450301988, 6594.241662208848, 6379.425851673349, 6384.553081284312, 6399.456046236064, 6425.678716064202, 6427.132337134485, 4795.280707893818, 4810.037992401533, 4812.422509298872, 4815.518448155191, 4820.566149046585, 4815.927761083586, 4821.276808478721, 4821.7589120543835, 4828.348172996635, 4828.927566086511, 4588.839390621329, 4664.626829853603, 4728.527147285261, 4733.171694953387, 4740.597049250818, 4691.873950251949, 4708.646851486135, 4727.030958653468, 4728.574428301452, 4753.33453316536, 4039.9092245093952, 4069.5726948670554, 4071.124708187724, 4073.714839961204, 4074.9592504074876, 5907.5864689471755, 5985.461308482214, 6023.156758053876, 6032.426919442646, 6049.334573196945, 5558.082916318803, 5560.972195139039, 5561.026820306471, 5566.081596536566, 5568.747031917786, 6685.665716714145, 6711.9664401678165, 6717.261101278856, 6724.596524208514, 6733.797986060426, 4513.593776560093, 4527.864164075083, 4527.886802829923, 4565.977170114162, 4570.65720070996, 6920.4809639277255, 6997.685104170274, 7079.823004424879, 7090.326418990187, 7096.0, 4732.296373305608, 4733.053389322149, 4740.905181896412, 4743.95256047442, 4759.262314341283, 4783.641226907996, 4791.113643975876, 4794.640401969867, 4795.520447955247, 4813.663043586916, 5470.234167216593, 5600.103983362724, 5603.327600687943, 5604.439556044363, 5626.521745651666, 6836.6923488443135, 6850.725970961205, 6850.965745171342, 6859.965700171567, 6871.209810871714, 1641.5567796695063, 1670.9582260443585, 1702.1999660159952, 1703.5144983679593, 1706.0360896093666, 1098.3958822647671, 1109.672646569264, 1117.6535274065066, 1121.9046381057537, 1135.5117299561102, 6509.349065093453, 6541.574797638138, 6556.442702370352, 6571.408573228432, 6573.3426657333885, 6968.65156742171, 6984.2317345092, 6993.19578248508, 6994.61529615876, 6995.160580730243, 6446.548741588043, 6482.351764823574, 6483.513736469689, 6485.513586481033, 6528.477721782246, 3847.499825022785, 3847.7306588539095, 3851.595582463801, 3872.4191371294532, 3886.9611303887164, 7392.852142957111, 7408.99978502906, 7426.9257307427315, 7432.405407567381, 7435.739749108755, 7120.465965052538, 7290.307420795016, 7304.306090921354, 7321.121465424077, 7335.7432489862595, 7360.190379058299, 7402.851942961111, 7411.0736157980255, 7422.443316751265, 7428.814279643052, 7103.786886393416, 7156.821079472847, 7183.712651493882, 7198.064251647253, 7201.3158749918675, 6876.209235937731, 7019.6841142147705, 7026.824329391806, 7070.7525236616475, 7085.82285442868, 7394.186639469546, 7396.371308438843, 7405.2594740527675, 7409.66656500448, 7429.0, 4717.386739723814, 4742.051589682008, 4771.0, 4774.212254978029, 4782.832600859092, 7023.824404389931, 7039.120109986252, 7160.997460355658, 7187.101612298463, 7193.244709305657, 6958.269381714847, 6963.825904352431, 6984.057152284377, 6997.825054373681, 7020.859582808417, 6847.349501797321, 6956.0609317741455, 6970.059042029261, 6971.477139214478, 6994.370506654222, 6708.396244338033, 6849.8972515411315, 6871.106756121672, 6886.552374095868, 6888.621125838127, 6989.231184569591, 6993.650317484207, 6994.755183568551, 7021.929780702128, 7024.438044956493, 6716.83207919806, 6849.4177994871, 6859.657017149222, 6865.5537390069485, 6865.691043903136], "unit": "ms", "name": "prototype.html", "value": 5120.389484540936}, {"lowerIsBetter": false, "replicates": [789.4513313247292, 798.6406117247241, 832.2717622080679, 870.2211520688984, 926.9860952085718, 13639.045266831314, 13824.93087534561, 13847.723045539084, 13851.792223116661, 13889.513867014657, 14131.434742610283, 14307.928460357709, 14395.2082635455, 15967.361305547764, 16280.185990700447, 894.9194572488459, 902.9819403611957, 909.8089401225751, 910.8815853939012, 919.9540022998823, 893.0489029183931, 899.325505870597, 902.0348227396688, 908.0420156734642, 908.5366463103832, 926.9026752191024, 931.8089791592707, 934.6401635370397, 936.6628013914985, 939.318993729544, 928.6517555916531, 934.359963425056, 936.1621348892771, 937.2736129499624, 937.8640097185938, 695.9860802783967, 698.1970733656285, 699.1714817940757, 701.3092104277283, 702.1083224305104, 15219.61950951224, 15223.543293701206, 15313.846861531465, 15341.156236406992, 15362.0, 12827.743445131138, 12828.422720977485, 12984.805227921588, 13300.600981970556, 13389.129706569041, 11096.833547496793, 11138.721531961684, 11166.497507612177, 11267.54929802815, 11442.256253343588, 3918.2163567286657, 3928.626780455852, 3935.783531905744, 3942.5466071401584, 3973.324534829057, 52066.47933520692, 52567.0, 52650.47349526494, 52770.0, 53057.73471132619, 10647.787044259227, 10666.0, 10754.73113172177, 10861.239713219999, 10919.344839309666, 18979.0, 19078.427647170607, 19109.713354299696, 19119.13963871629, 19131.13909874059, 8221.218984196492, 8300.335973122135, 8320.292775114183, 8463.111373305837, 8547.188017138362, 4683.16125848118, 4711.104890070944, 4756.762161891892, 4778.068276686013, 4846.61227101831, 3138.686131386843, 3162.810231386124, 3163.2724473371254, 3183.2996740717003, 3187.920301992469, 592.386879579633, 608.5861614102453, 615.566025951703, 622.9657368844667, 623.037407205868, 671.9227288861746, 706.0715159565156, 723.6707298179316, 751.4514404484647, 771.3944553525456, 9211.677591284273, 9460.479673618018, 9619.855702164474, 9636.180924621345, 10093.646722364681, 712.8895021271711, 718.5939943931662, 721.8989341492195, 726.9273072692688, 753.1978442958232, 4136.8138433770555, 4241.151769646083, 4301.311790113629, 4438.289873620205, 4503.234450143418, 61314.38685613176, 61367.38632613706, 64089.35910640834, 64262.67868660627, 64282.35717642857, 53943.0, 54474.0, 55384.0, 59977.0, 60347.0, 51275.743621281654, 51628.0, 51754.48245517572, 52970.470295297324, 53208.0, 9080.500572468578, 9141.3601047926, 9147.0852914708, 9191.21874640663, 9204.861927070966, 38271.42592861054, 39168.412473813485, 39402.80298598488, 39963.2007359857, 40244.39633405443, 51242.23136653028, 51394.22908656448, 51408.0, 51464.48535514597, 51581.48418515767, 11350.0, 11953.521859125885, 12100.213486123726, 12259.448324825582, 12516.436760345989, 12273.447694853574, 12374.938125309316, 12481.313527756061, 12699.809502857279, 12843.871561284268, 11196.496157673088, 11221.0, 11225.101991840469, 11253.324800511995, 11348.024263345793, 11028.338299702044, 11285.316434254722, 11379.0, 11439.828402573801, 11574.074074074222, 11493.942530287295, 11633.243839150427, 11671.183017188716, 11688.415579220835, 12161.756764864831, 10447.111995480469, 10461.581536738446, 10708.250422470664, 10850.457477125954, 11254.21220514556, 9546.140847323773, 9810.803783924139, 9895.703128906145, 9918.107370336704, 9926.205903527845], "unit": "ms", "name": "yui.html", "value": 6843.6826522732945}], "name": "dromaeo_css", "value": 7337.338346460335}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 112.0, 111.0, 112.0, 122.0, 111.0, 112.0, 111.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [151.0, 123.0, 155.0, 155.0, 128.0, 146.0, 145.0, 126.0, 163.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.7}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 163.0, 167.0, 162.0, 162.0, 161.0, 160.0, 165.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [77.0, 72.0, 74.0, 155.0, 73.0, 71.0, 72.0, 73.0, 157.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 89.5}, {"lowerIsBetter": true, "replicates": [95.0, 92.0, 140.0, 93.0, 94.0, 92.0, 134.0, 93.0, 94.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 111.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 97.0, 95.0, 97.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [60.0, 62.0, 60.0, 60.0, 62.0, 64.0, 61.0, 60.0, 63.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 61.1}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 64.0, 64.0, 63.0, 63.0, 64.0, 64.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.5}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 90.0, 93.0, 83.0, 82.0, 85.0, 83.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [113.0, 123.0, 116.0, 117.0, 114.0, 121.0, 116.0, 124.0, 121.0, 113.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.8}, {"lowerIsBetter": true, "replicates": [146.0, 154.0, 143.0, 145.0, 146.0, 142.0, 153.0, 137.0, 143.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.3}, {"lowerIsBetter": true, "replicates": [71.0, 64.0, 65.0, 65.0, 66.0, 66.0, 64.0, 65.0, 65.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.5}], "name": "kraken", "value": 1500.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.88918558077435], "unit": "score", "name": "Richards", "value": 211.52958400000006}, {"lowerIsBetter": false, "replicates": [167.50418760469012], "unit": "score", "name": "DeltaBlue", "value": 394.72445999999985}, {"lowerIsBetter": false, "replicates": [278.2415136338342], "unit": "score", "name": "Encrypt", "value": 956.654514}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [925.0693802035153], "unit": "score", "name": "RayTrace", "value": 799.928109}, {"lowerIsBetter": false, "replicates": [543.773790103317], "unit": "score", "name": "Earley", "value": 1225.6254570000006}, {"lowerIsBetter": false, "replicates": [11043.956043956045], "unit": "score", "name": "Boyer", "value": 60.346400995024844}, {"lowerIsBetter": false, "replicates": [24095.238095238095], "unit": "score", "name": "RegExp", "value": 37.80767786561265}, {"lowerIsBetter": false, "replicates": [526.592943654555], "unit": "score", "name": "Splay", "value": 154.75140899999997}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23212.45887995659}]} 04:07:36 INFO - RETURN: dromaeo_css: 7337.34 04:07:36 INFO - RETURN: kraken: 1500.90 04:07:36 INFO - RETURN: v8_7: 23212.46 04:07:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23212.46"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1500.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7337.34"}}} 04:07:36 INFO - Return code: 0 04:07:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:07:36 INFO - # TBPL SUCCESS # 04:07:36 INFO - Running post-action listener: _resource_record_post_action 04:07:36 INFO - Running post-run listener: _resource_record_post_run 04:07:37 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 0; Write bytes: 501592064; Read time: 0; Write time: 469736 04:07:37 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 237953024; Read time: 0; Write time: 284224 04:07:37 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 0; Write bytes: 263639040; Read time: 0; Write time: 185512 04:07:37 INFO - Running post-run listener: _upload_blobber_files 04:07:37 INFO - Blob upload gear active. 04:07:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:07:37 INFO - Copying logs to upload dir... 04:07:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1282.910650 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-25 04:07:37.077024) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:07:37.080815) ========= 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-1453721234.894395-1936994184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009993 build_url: 'https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/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-25 04:07:37.134825) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:07:37.135163) ========= 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-1453721234.894395-1936994184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:07:37.185136) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 04:07:37.185478) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 04:07:37.185782) ========= ========= Total master_lag: 0.37 =========