builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1457258339.22 results: success (0) buildid: 20160305031719 builduid: 77ad713622c74f5a93e694d0d647c68b revision: 78fe98c670fcc9a1548ac655ae9a488d940fd9c8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-06 01:58:59.224922) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-06 01:58:59.225352) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-06 01:58:59.225631) ========= 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=5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005395 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-06 01:58:59.246860) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-06 01:58:59.247187) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-06 01:58:59.259912) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:58:59.260186) ========= 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=5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:58:59.308550) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-06 01:58:59.308858) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-06 01:58:59.309251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:58:59.309520) ========= 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=5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-06 01:58:59-- 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% 34.5M=0s 2016-03-06 01:59:00 (34.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153956 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:58:59.475227) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:58:59.475521) ========= 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=5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022750 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 01:58:59.524383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-06 01:58:59.524701) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 78fe98c670fcc9a1548ac655ae9a488d940fd9c8 --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-beta --rev 78fe98c670fcc9a1548ac655ae9a488d940fd9c8 --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=5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-06 01:59:00,116 truncating revision to first 12 chars 2016-03-06 01:59:00,116 Setting DEBUG logging. 2016-03-06 01:59:00,116 attempt 1/10 2016-03-06 01:59:00,116 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/78fe98c670fc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-06 01:59:00,864 unpacking tar archive at: mozilla-beta-78fe98c670fc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.045899 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-06 01:59:00.582621) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-06 01:59:00.582945) ========= echo 78fe98c670fcc9a1548ac655ae9a488d940fd9c8 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'78fe98c670fcc9a1548ac655ae9a488d940fd9c8'] 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=5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 78fe98c670fcc9a1548ac655ae9a488d940fd9c8 program finished with exit code 0 elapsedTime=0.004177 script_repo_revision: '78fe98c670fcc9a1548ac655ae9a488d940fd9c8' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-06 01:59:00.632276) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-06 01:59:00.632591) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-06 01:59:00.642877) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-06 01:59:00.643152) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:59:01 INFO - MultiFileLogger online at 20160306 01:59:01 in /builds/slave/test-pgo 01:59:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 01:59:01 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:59:01 INFO - {'append_to_log': False, 01:59:01 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:59:01 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:59:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:59:01 INFO - 'branch': 'Mozilla-Beta', 01:59:01 INFO - 'buildbot_json_path': 'buildprops.json', 01:59:01 INFO - 'config_files': ('talos/linux_config.py',), 01:59:01 INFO - 'default_actions': ('clobber', 01:59:01 INFO - 'read-buildbot-config', 01:59:01 INFO - 'download-and-extract', 01:59:01 INFO - 'populate-webroot', 01:59:01 INFO - 'create-virtualenv', 01:59:01 INFO - 'install', 01:59:01 INFO - 'run-tests'), 01:59:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:59:01 INFO - 'download_minidump_stackwalk': True, 01:59:01 INFO - 'download_symbols': 'ondemand', 01:59:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:59:01 INFO - 'tooltool.py': '/tools/tooltool.py', 01:59:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:59:01 INFO - '/tools/misc-python/virtualenv.py')}, 01:59:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:59:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:59:01 INFO - 'installer_path': 'installer.exe', 01:59:01 INFO - 'log_level': 'info', 01:59:01 INFO - 'log_name': 'talos', 01:59:01 INFO - 'log_to_console': True, 01:59:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:59:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:59:01 INFO - 'opt_config_files': (), 01:59:01 INFO - 'pip_index': False, 01:59:01 INFO - 'sps_profile': False, 01:59:01 INFO - 'sps_profile_interval': 0, 01:59:01 INFO - 'suite': 'dromaeojs', 01:59:01 INFO - 'system_bits': '32', 01:59:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:59:01 INFO - 'title': 'talos-linux64-ix-011', 01:59:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:59:01 INFO - 'use_talos_json': True, 01:59:01 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:59:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:59:01 INFO - 'work_dir': 'build'} 01:59:01 INFO - ##### 01:59:01 INFO - ##### Running clobber step. 01:59:01 INFO - ##### 01:59:01 INFO - Running pre-action listener: _resource_record_pre_action 01:59:01 INFO - Running main action method: clobber 01:59:01 INFO - rmtree: /builds/slave/test-pgo/build 01:59:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:59:01 INFO - Running post-action listener: _resource_record_post_action 01:59:01 INFO - ##### 01:59:01 INFO - ##### Running read-buildbot-config step. 01:59:01 INFO - ##### 01:59:01 INFO - Running pre-action listener: _resource_record_pre_action 01:59:01 INFO - Running main action method: read_buildbot_config 01:59:01 INFO - Using buildbot properties: 01:59:01 INFO - { 01:59:01 INFO - "properties": { 01:59:01 INFO - "buildnumber": 128, 01:59:01 INFO - "product": "firefox", 01:59:01 INFO - "script_repo_revision": "production", 01:59:01 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 01:59:01 INFO - "repository": "", 01:59:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 01:59:01 INFO - "buildid": "20160305031719", 01:59:01 INFO - "slavename": "talos-linux64-ix-011", 01:59:01 INFO - "pgo_build": "True", 01:59:01 INFO - "basedir": "/builds/slave/test-pgo", 01:59:01 INFO - "project": "", 01:59:01 INFO - "platform": "ubuntu64_hw", 01:59:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:59:01 INFO - "slavebuilddir": "test", 01:59:01 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 01:59:01 INFO - "branch": "mozilla-beta", 01:59:01 INFO - "repo_path": "releases/mozilla-beta", 01:59:01 INFO - "stage_platform": "linux64-pgo", 01:59:01 INFO - "builduid": "77ad713622c74f5a93e694d0d647c68b", 01:59:01 INFO - "revision": "78fe98c670fcc9a1548ac655ae9a488d940fd9c8" 01:59:01 INFO - }, 01:59:01 INFO - "sourcestamp": { 01:59:01 INFO - "repository": "", 01:59:01 INFO - "hasPatch": false, 01:59:01 INFO - "project": "", 01:59:01 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 01:59:01 INFO - "changes": [ 01:59:01 INFO - { 01:59:01 INFO - "category": null, 01:59:01 INFO - "files": [ 01:59:01 INFO - { 01:59:01 INFO - "url": null, 01:59:01 INFO - "name": "https://queue.taskcluster.net/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2" 01:59:01 INFO - } 01:59:01 INFO - ], 01:59:01 INFO - "repository": "", 01:59:01 INFO - "rev": "78fe98c670fcc9a1548ac655ae9a488d940fd9c8", 01:59:01 INFO - "who": "ffxbld", 01:59:01 INFO - "when": 1457185072, 01:59:01 INFO - "number": 7697725, 01:59:01 INFO - "comments": "No bug, Automated blocklist update from host bld-linux64-spot-470 - a=blocklist-update", 01:59:01 INFO - "project": "", 01:59:01 INFO - "at": "Sat 05 Mar 2016 05:37:52", 01:59:01 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 01:59:01 INFO - "revlink": "", 01:59:01 INFO - "properties": [ 01:59:01 INFO - [ 01:59:01 INFO - "buildid", 01:59:01 INFO - "20160305031719", 01:59:01 INFO - "Change" 01:59:01 INFO - ], 01:59:01 INFO - [ 01:59:01 INFO - "builduid", 01:59:01 INFO - "77ad713622c74f5a93e694d0d647c68b", 01:59:01 INFO - "Change" 01:59:01 INFO - ], 01:59:01 INFO - [ 01:59:01 INFO - "pgo_build", 01:59:01 INFO - "True", 01:59:01 INFO - "Change" 01:59:01 INFO - ] 01:59:01 INFO - ], 01:59:01 INFO - "revision": "78fe98c670fcc9a1548ac655ae9a488d940fd9c8" 01:59:01 INFO - } 01:59:01 INFO - ], 01:59:01 INFO - "revision": "78fe98c670fcc9a1548ac655ae9a488d940fd9c8" 01:59:01 INFO - } 01:59:01 INFO - } 01:59:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2. 01:59:01 INFO - Running post-action listener: _resource_record_post_action 01:59:01 INFO - ##### 01:59:01 INFO - ##### Running download-and-extract step. 01:59:01 INFO - ##### 01:59:01 INFO - Running pre-action listener: _resource_record_pre_action 01:59:01 INFO - Running main action method: download_and_extract 01:59:01 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:01 INFO - https://queue.taskcluster.net/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:59:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/test_packages.json 01:59:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/test_packages.json 01:59:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:59:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:59:02 INFO - Downloaded 1270 bytes. 01:59:02 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:59:02 INFO - Using the following test package requirements: 01:59:02 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 01:59:02 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:59:02 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 01:59:02 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:59:02 INFO - u'jsshell-linux-x86_64.zip'], 01:59:02 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:59:02 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 01:59:02 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 01:59:02 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:59:02 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 01:59:02 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:59:02 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 01:59:02 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:59:02 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 01:59:02 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 01:59:02 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:59:02 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 01:59:02 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:59: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')]} 01:59:02 INFO - https://queue.taskcluster.net/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:59:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:59:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:59:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:59:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:59:04 INFO - Downloaded 21584474 bytes. 01:59:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 01:59:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:59:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:59:05 INFO - Return code: 0 01:59:05 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:59: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')]} 01:59:05 INFO - https://queue.taskcluster.net/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:59:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:59:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:59:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:59:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:59:06 INFO - Downloaded 21584474 bytes. 01:59:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 01:59:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:59:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:59:08 INFO - Return code: 0 01:59: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')]} 01:59:08 INFO - https://queue.taskcluster.net/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:59:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 01:59:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 01:59:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 01:59:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:59:09 INFO - Downloaded 11132038 bytes. 01:59:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 01:59:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 01:59:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 01:59:09 INFO - Return code: 0 01:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:09 INFO - https://queue.taskcluster.net/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:59:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 01:59:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 01:59:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 01:59:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:59:10 INFO - Downloaded 57946057 bytes. 01:59:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 01:59:10 INFO - mkdir: /builds/slave/test-pgo/properties 01:59:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:59:10 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:59:10 INFO - Contents: 01:59:10 INFO - build_url:https://queue.taskcluster.net/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 01:59:11 INFO - Running post-action listener: _resource_record_post_action 01:59:11 INFO - Running post-action listener: set_extra_try_arguments 01:59:11 INFO - ##### 01:59:11 INFO - ##### Running populate-webroot step. 01:59:11 INFO - ##### 01:59:11 INFO - Running pre-action listener: _resource_record_pre_action 01:59:11 INFO - Running main action method: populate_webroot 01:59:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:59:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:59:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:59:11 INFO - '--tppagecycles', 01:59:11 INFO - '7'], 01:59:11 INFO - 'tests': ['tsvgm']}}, 01:59:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:59:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:59:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:59:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:59:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:59:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:59:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:59:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:11 INFO - 'talos_options': ['--e10s'], 01:59:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:59:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:11 INFO - 'tests': ['damp', 'tps']}, 01:59:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:11 INFO - 'talos_options': ['--e10s'], 01:59:11 INFO - 'tests': ['damp', 'tps']}, 01:59:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:59:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:59:11 INFO - 'other': {'tests': ['a11yr', 01:59:11 INFO - 'ts_paint', 01:59:11 INFO - 'tpaint', 01:59:11 INFO - 'sessionrestore', 01:59:11 INFO - 'sessionrestore_no_auto_restore']}, 01:59:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:59:11 INFO - 'tests': ['a11yr', 01:59:11 INFO - 'ts_paint', 01:59:11 INFO - 'tpaint', 01:59:11 INFO - 'sessionrestore', 01:59:11 INFO - 'sessionrestore_no_auto_restore']}, 01:59:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:59:11 INFO - 'tests': ['a11yr', 01:59:11 INFO - 'ts_paint', 01:59:11 INFO - 'tpaint', 01:59:11 INFO - 'sessionrestore', 01:59:11 INFO - 'sessionrestore_no_auto_restore']}, 01:59:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:59:11 INFO - 'tests': ['a11yr', 01:59:11 INFO - 'ts_paint', 01:59:11 INFO - 'tpaint', 01:59:11 INFO - 'sessionrestore', 01:59:11 INFO - 'sessionrestore_no_auto_restore']}, 01:59:11 INFO - 'other_l64': {'tests': ['a11yr', 01:59:11 INFO - 'ts_paint', 01:59:11 INFO - 'tpaint', 01:59:11 INFO - 'sessionrestore', 01:59:11 INFO - 'sessionrestore_no_auto_restore']}, 01:59:11 INFO - 'other_nol64': {'tests': ['a11yr', 01:59:11 INFO - 'ts_paint', 01:59:11 INFO - 'tpaint', 01:59:11 INFO - 'sessionrestore', 01:59:11 INFO - 'sessionrestore_no_auto_restore']}, 01:59:11 INFO - 'svgr': {'tests': ['tsvgx', 01:59:11 INFO - 'tsvgr_opacity', 01:59:11 INFO - 'tart', 01:59:11 INFO - 'tscrollx', 01:59:11 INFO - 'cart']}, 01:59:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:59:11 INFO - 'tests': ['tsvgx', 01:59:11 INFO - 'tsvgr_opacity', 01:59:11 INFO - 'tart', 01:59:11 INFO - 'tscrollx', 01:59:11 INFO - 'cart']}, 01:59:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:11 INFO - 'tests': ['tp5o']}, 01:59:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:11 INFO - 'talos_options': ['--e10s'], 01:59:11 INFO - 'tests': ['tp5o']}, 01:59:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:11 INFO - 'talos_options': ['--xperf_path', 01:59:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:59:11 INFO - 'tests': ['tp5n']}, 01:59:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:11 INFO - 'talos_options': ['--e10s', 01:59:11 INFO - '--xperf_path', 01:59:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:59:11 INFO - 'tests': ['tp5n']}}, 01:59:11 INFO - 'talos.zip': {'path': '', 01:59:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:59:11 INFO - Running post-action listener: _resource_record_post_action 01:59:11 INFO - ##### 01:59:11 INFO - ##### Running create-virtualenv step. 01:59:11 INFO - ##### 01:59:11 INFO - Running pre-action listener: _resource_record_pre_action 01:59:11 INFO - Running main action method: create_virtualenv 01:59:11 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:59:11 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 01:59:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:59:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:59:11 INFO - Using real prefix '/usr' 01:59:11 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:59:12 INFO - Installing distribute.............................................................................................................................................................................................done. 01:59:14 INFO - Installing pip.................done. 01:59:14 INFO - Return code: 0 01:59:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:59: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')]} 01:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59: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')]} 01:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:14 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 0x7fbbc2e67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1733660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c23b0>, '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 0x17c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3740>, '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': '5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066', '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 01:59:14 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 01:59:14 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 01:59:14 INFO - Using env: {'DISPLAY': ':0', 01:59:14 INFO - 'HOME': '/home/cltbld', 01:59:14 INFO - 'LANG': 'en_US.UTF-8', 01:59:14 INFO - 'LANGUAGE': 'en_US:en', 01:59:14 INFO - 'LOGNAME': 'cltbld', 01:59:14 INFO - 'MAIL': '/var/mail/cltbld', 01:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:14 INFO - 'MOZ_NO_REMOTE': '1', 01:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:14 INFO - 'NO_EM_RESTART': '1', 01:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:14 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:14 INFO - 'SHELL': '/bin/bash', 01:59:14 INFO - 'SHLVL': '1', 01:59:14 INFO - 'TERM': 'linux', 01:59:14 INFO - 'TMOUT': '86400', 01:59:14 INFO - 'USER': 'cltbld', 01:59:14 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066', 01:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:14 INFO - '_': '/tools/buildbot/bin/python'} 01:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:14 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 01:59:14 INFO - Cleaning up... 01:59:14 INFO - Return code: 0 01:59:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:59: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')]} 01:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59: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')]} 01:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:14 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 0x7fbbc2e67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1733660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c23b0>, '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 0x17c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3740>, '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': '5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066', '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 01:59:14 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 01:59:14 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 01:59:14 INFO - Using env: {'DISPLAY': ':0', 01:59:14 INFO - 'HOME': '/home/cltbld', 01:59:14 INFO - 'LANG': 'en_US.UTF-8', 01:59:14 INFO - 'LANGUAGE': 'en_US:en', 01:59:14 INFO - 'LOGNAME': 'cltbld', 01:59:14 INFO - 'MAIL': '/var/mail/cltbld', 01:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:14 INFO - 'MOZ_NO_REMOTE': '1', 01:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:14 INFO - 'NO_EM_RESTART': '1', 01:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:14 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:14 INFO - 'SHELL': '/bin/bash', 01:59:14 INFO - 'SHLVL': '1', 01:59:14 INFO - 'TERM': 'linux', 01:59:14 INFO - 'TMOUT': '86400', 01:59:14 INFO - 'USER': 'cltbld', 01:59:14 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066', 01:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:14 INFO - '_': '/tools/buildbot/bin/python'} 01:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:14 INFO - Downloading/unpacking psutil>=0.7.1 01:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:59:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:59:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:59:16 INFO - Installing collected packages: psutil 01:59:16 INFO - Running setup.py install for psutil 01:59:16 INFO - building 'psutil._psutil_linux' extension 01:59:16 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 01:59:16 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 01:59:16 INFO - building 'psutil._psutil_posix' extension 01:59:16 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 01:59:16 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 01:59:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:59:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:59:17 INFO - Successfully installed psutil 01:59:17 INFO - Cleaning up... 01:59:17 INFO - Return code: 0 01:59:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:59:17 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')]} 01:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:17 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')]} 01:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:17 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 0x7fbbc2e67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1733660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c23b0>, '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 0x17c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3740>, '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': '5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066', '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 01:59:17 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 01:59:17 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 01:59:17 INFO - Using env: {'DISPLAY': ':0', 01:59:17 INFO - 'HOME': '/home/cltbld', 01:59:17 INFO - 'LANG': 'en_US.UTF-8', 01:59:17 INFO - 'LANGUAGE': 'en_US:en', 01:59:17 INFO - 'LOGNAME': 'cltbld', 01:59:17 INFO - 'MAIL': '/var/mail/cltbld', 01:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:17 INFO - 'MOZ_NO_REMOTE': '1', 01:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:17 INFO - 'NO_EM_RESTART': '1', 01:59:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:17 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:17 INFO - 'SHELL': '/bin/bash', 01:59:17 INFO - 'SHLVL': '1', 01:59:17 INFO - 'TERM': 'linux', 01:59:17 INFO - 'TMOUT': '86400', 01:59:17 INFO - 'USER': 'cltbld', 01:59:17 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066', 01:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:17 INFO - '_': '/tools/buildbot/bin/python'} 01:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:59:17 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 01:59:17 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 01:59:17 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 01:59:17 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 01:59:17 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 01:59:17 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 01:59:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:59:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:59:19 INFO - Installing collected packages: mozsystemmonitor 01:59:19 INFO - Running setup.py install for mozsystemmonitor 01:59:19 INFO - Successfully installed mozsystemmonitor 01:59:19 INFO - Cleaning up... 01:59:19 INFO - Return code: 0 01:59:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:59:19 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')]} 01:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:19 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')]} 01:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:19 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 0x7fbbc2e67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1733660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c23b0>, '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 0x17c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3740>, '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': '5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066', '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 01:59:19 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 01:59:19 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 01:59:19 INFO - Using env: {'DISPLAY': ':0', 01:59:19 INFO - 'HOME': '/home/cltbld', 01:59:19 INFO - 'LANG': 'en_US.UTF-8', 01:59:19 INFO - 'LANGUAGE': 'en_US:en', 01:59:19 INFO - 'LOGNAME': 'cltbld', 01:59:19 INFO - 'MAIL': '/var/mail/cltbld', 01:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:19 INFO - 'MOZ_NO_REMOTE': '1', 01:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:19 INFO - 'NO_EM_RESTART': '1', 01:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:19 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:19 INFO - 'SHELL': '/bin/bash', 01:59:19 INFO - 'SHLVL': '1', 01:59:19 INFO - 'TERM': 'linux', 01:59:19 INFO - 'TMOUT': '86400', 01:59:19 INFO - 'USER': 'cltbld', 01:59:19 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066', 01:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:19 INFO - '_': '/tools/buildbot/bin/python'} 01:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:19 INFO - Downloading/unpacking blobuploader==1.2.4 01:59:19 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 01:59:19 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 01:59:19 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 01:59:19 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 01:59:19 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 01:59:19 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 01:59:21 INFO - Downloading blobuploader-1.2.4.tar.gz 01:59:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:59:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:59:21 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 01:59:21 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 01:59:21 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 01:59:21 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 01:59:21 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 01:59:21 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 01:59:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:59:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:59:21 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 01:59:21 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 01:59:21 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 01:59:21 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 01:59:21 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 01:59:21 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 01:59:22 INFO - Downloading docopt-0.6.1.tar.gz 01:59:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:59:22 INFO - Installing collected packages: blobuploader, requests, docopt 01:59:22 INFO - Running setup.py install for blobuploader 01:59:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:59:22 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:59:22 INFO - Running setup.py install for requests 01:59:22 INFO - Running setup.py install for docopt 01:59:22 INFO - Successfully installed blobuploader requests docopt 01:59:22 INFO - Cleaning up... 01:59:22 INFO - Return code: 0 01:59:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:22 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 0x7fbbc2e67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1733660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c23b0>, '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 0x17c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3740>, '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': '5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066', '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 01:59:22 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 01:59:22 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 01:59:22 INFO - Using env: {'DISPLAY': ':0', 01:59:22 INFO - 'HOME': '/home/cltbld', 01:59:22 INFO - 'LANG': 'en_US.UTF-8', 01:59:22 INFO - 'LANGUAGE': 'en_US:en', 01:59:22 INFO - 'LOGNAME': 'cltbld', 01:59:22 INFO - 'MAIL': '/var/mail/cltbld', 01:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:22 INFO - 'MOZ_NO_REMOTE': '1', 01:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:22 INFO - 'NO_EM_RESTART': '1', 01:59:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:22 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:22 INFO - 'SHELL': '/bin/bash', 01:59:22 INFO - 'SHLVL': '1', 01:59:22 INFO - 'TERM': 'linux', 01:59:22 INFO - 'TMOUT': '86400', 01:59:22 INFO - 'USER': 'cltbld', 01:59:22 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066', 01:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:22 INFO - '_': '/tools/buildbot/bin/python'} 01:59:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:59:23 INFO - Running setup.py (path:/tmp/pip-0QNuBD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:59:23 INFO - Running setup.py (path:/tmp/pip-jykc0Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:59:23 INFO - Running setup.py (path:/tmp/pip-JbSUlY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:59:23 INFO - Running setup.py (path:/tmp/pip-p3lCOC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:59:23 INFO - Running setup.py (path:/tmp/pip-_qd5RE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:59:23 INFO - Running setup.py (path:/tmp/pip-3IszAc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:59:23 INFO - Running setup.py (path:/tmp/pip-PlbKYQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:59:23 INFO - Running setup.py (path:/tmp/pip-0ftUgh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:59:23 INFO - Running setup.py (path:/tmp/pip-iLss6s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:59:23 INFO - Running setup.py (path:/tmp/pip-QS_xq7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:59:23 INFO - Running setup.py (path:/tmp/pip-tHr5hZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:59:23 INFO - Running setup.py (path:/tmp/pip-VrM24T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:59:23 INFO - Running setup.py (path:/tmp/pip-RjCtsT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:59:24 INFO - Running setup.py (path:/tmp/pip-6yvNWB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:59:24 INFO - Running setup.py (path:/tmp/pip-kgcSD_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:59:24 INFO - Running setup.py (path:/tmp/pip-gtxr1Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:59:24 INFO - Running setup.py (path:/tmp/pip-YmqFlg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:59:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:59:24 INFO - Running setup.py install for manifestparser 01:59:24 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:59:24 INFO - Running setup.py install for mozcrash 01:59:24 INFO - Running setup.py install for mozdebug 01:59:24 INFO - Running setup.py install for mozdevice 01:59:24 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:59:24 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:59:24 INFO - Running setup.py install for mozfile 01:59:24 INFO - Running setup.py install for mozhttpd 01:59:24 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:59:24 INFO - Running setup.py install for mozinfo 01:59:24 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:59:25 INFO - Running setup.py install for mozInstall 01:59:25 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:59:25 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:59:25 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:59:25 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:59:25 INFO - Running setup.py install for mozleak 01:59:25 INFO - Running setup.py install for mozlog 01:59:25 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:59:25 INFO - Running setup.py install for moznetwork 01:59:25 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:59:25 INFO - Running setup.py install for mozprocess 01:59:25 INFO - Running setup.py install for mozprofile 01:59:25 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:59:25 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:59:25 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:59:25 INFO - Running setup.py install for mozrunner 01:59:25 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:59:25 INFO - Running setup.py install for mozscreenshot 01:59:25 INFO - Running setup.py install for moztest 01:59:25 INFO - Running setup.py install for mozversion 01:59:26 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:59:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:59:26 INFO - Cleaning up... 01:59:26 INFO - Return code: 0 01:59:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:59: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')]} 01:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59: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')]} 01:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:26 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 0x7fbbc2e67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1733660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c23b0>, '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 0x17c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3740>, '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': '5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066', '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 01:59:26 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 01:59:26 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 01:59:26 INFO - Using env: {'DISPLAY': ':0', 01:59:26 INFO - 'HOME': '/home/cltbld', 01:59:26 INFO - 'LANG': 'en_US.UTF-8', 01:59:26 INFO - 'LANGUAGE': 'en_US:en', 01:59:26 INFO - 'LOGNAME': 'cltbld', 01:59:26 INFO - 'MAIL': '/var/mail/cltbld', 01:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:26 INFO - 'MOZ_NO_REMOTE': '1', 01:59:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:26 INFO - 'NO_EM_RESTART': '1', 01:59:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:26 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:26 INFO - 'SHELL': '/bin/bash', 01:59:26 INFO - 'SHLVL': '1', 01:59:26 INFO - 'TERM': 'linux', 01:59:26 INFO - 'TMOUT': '86400', 01:59:26 INFO - 'USER': 'cltbld', 01:59:26 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066', 01:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:26 INFO - '_': '/tools/buildbot/bin/python'} 01:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:59:26 INFO - Running setup.py (path:/tmp/pip-bzeMN1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:59:26 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)) 01:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:59:26 INFO - Running setup.py (path:/tmp/pip-41f9H9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:59:26 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)) 01:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:59:26 INFO - Running setup.py (path:/tmp/pip-I0S7iM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:59:26 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)) 01:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:59:26 INFO - Running setup.py (path:/tmp/pip-0v1VZj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:59:26 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)) 01:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:59:26 INFO - Running setup.py (path:/tmp/pip-9iydSi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:59:26 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)) 01:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:59:26 INFO - Running setup.py (path:/tmp/pip-bS6JaJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:59:26 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)) 01:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:59:26 INFO - Running setup.py (path:/tmp/pip-VYUCFP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:59:26 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)) 01:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:59:26 INFO - Running setup.py (path:/tmp/pip-gK3R96-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:59:26 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)) 01:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:59:26 INFO - Running setup.py (path:/tmp/pip-rLs6Pp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:59:26 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)) 01:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:59:26 INFO - Running setup.py (path:/tmp/pip-i5zKQp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:59:27 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)) 01:59:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:59:27 INFO - Running setup.py (path:/tmp/pip-dlVb5m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:59:27 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)) 01:59:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:59:27 INFO - Running setup.py (path:/tmp/pip-DFodqv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:59:27 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)) 01:59:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:59:27 INFO - Running setup.py (path:/tmp/pip-4jvz8Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:59:27 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)) 01:59:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:59:27 INFO - Running setup.py (path:/tmp/pip-Adwdg2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:59:27 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)) 01:59:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:59:27 INFO - Running setup.py (path:/tmp/pip-DiBmnL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:59:27 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)) 01:59:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:59:27 INFO - Running setup.py (path:/tmp/pip-AMkjUD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:59:27 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)) 01:59:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:59:27 INFO - Running setup.py (path:/tmp/pip-YAgJ2B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:59:27 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)) 01:59:27 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)) 01:59:27 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)) 01:59:27 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)) 01:59:27 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)) 01:59:27 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)) 01:59:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:59:27 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 01:59:27 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 01:59:27 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 01:59:27 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 01:59:27 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 01:59:27 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 01:59:29 INFO - Downloading blessings-1.6.tar.gz 01:59:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:59:29 INFO - Installing collected packages: blessings 01:59:29 INFO - Running setup.py install for blessings 01:59:29 INFO - Successfully installed blessings 01:59:29 INFO - Cleaning up... 01:59:29 INFO - Return code: 0 01:59:29 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:59:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:59:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:59:30 INFO - Reading from file tmpfile_stdout 01:59:30 INFO - Current package versions: 01:59:30 INFO - argparse == 1.2.1 01:59:30 INFO - blessings == 1.6 01:59:30 INFO - blobuploader == 1.2.4 01:59:30 INFO - docopt == 0.6.1 01:59:30 INFO - manifestparser == 1.1 01:59:30 INFO - mozInstall == 1.12 01:59:30 INFO - mozcrash == 0.16 01:59:30 INFO - mozdebug == 0.1 01:59:30 INFO - mozdevice == 0.47 01:59:30 INFO - mozfile == 1.2 01:59:30 INFO - mozhttpd == 0.7 01:59:30 INFO - mozinfo == 0.9 01:59:30 INFO - mozleak == 0.1 01:59:30 INFO - mozlog == 3.1 01:59:30 INFO - moznetwork == 0.27 01:59:30 INFO - mozprocess == 0.22 01:59:30 INFO - mozprofile == 0.27 01:59:30 INFO - mozrunner == 6.11 01:59:30 INFO - mozscreenshot == 0.1 01:59:30 INFO - mozsystemmonitor == 0.0 01:59:30 INFO - moztest == 0.7 01:59:30 INFO - mozversion == 1.4 01:59:30 INFO - psutil == 3.1.1 01:59:30 INFO - requests == 1.2.3 01:59:30 INFO - wsgiref == 0.1.2 01:59:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:30 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 0x7fbbc2e67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1733660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c23b0>, '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 0x17c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3740>, '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': '5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066', '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 01:59:30 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 01:59:30 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 01:59:30 INFO - Using env: {'DISPLAY': ':0', 01:59:30 INFO - 'HOME': '/home/cltbld', 01:59:30 INFO - 'LANG': 'en_US.UTF-8', 01:59:30 INFO - 'LANGUAGE': 'en_US:en', 01:59:30 INFO - 'LOGNAME': 'cltbld', 01:59:30 INFO - 'MAIL': '/var/mail/cltbld', 01:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:30 INFO - 'MOZ_NO_REMOTE': '1', 01:59:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:30 INFO - 'NO_EM_RESTART': '1', 01:59:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:30 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:30 INFO - 'SHELL': '/bin/bash', 01:59:30 INFO - 'SHLVL': '1', 01:59:30 INFO - 'TERM': 'linux', 01:59:30 INFO - 'TMOUT': '86400', 01:59:30 INFO - 'USER': 'cltbld', 01:59:30 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066', 01:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:30 INFO - '_': '/tools/buildbot/bin/python'} 01:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:30 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)) 01:59:30 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)) 01:59:30 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)) 01:59:30 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)) 01:59:30 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)) 01:59:30 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)) 01:59:30 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)) 01:59:30 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)) 01:59:30 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)) 01:59:30 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)) 01:59:30 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)) 01:59:30 INFO - Cleaning up... 01:59:30 INFO - Return code: 0 01:59:30 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:30 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 0x7fbbc2e67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1733660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c23b0>, '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 0x17c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3740>, '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': '5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066', '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 01:59:30 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 01:59:30 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 01:59:30 INFO - Using env: {'DISPLAY': ':0', 01:59:30 INFO - 'HOME': '/home/cltbld', 01:59:30 INFO - 'LANG': 'en_US.UTF-8', 01:59:30 INFO - 'LANGUAGE': 'en_US:en', 01:59:30 INFO - 'LOGNAME': 'cltbld', 01:59:30 INFO - 'MAIL': '/var/mail/cltbld', 01:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:30 INFO - 'MOZ_NO_REMOTE': '1', 01:59:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:30 INFO - 'NO_EM_RESTART': '1', 01:59:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:30 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:30 INFO - 'SHELL': '/bin/bash', 01:59:30 INFO - 'SHLVL': '1', 01:59:30 INFO - 'TERM': 'linux', 01:59:30 INFO - 'TMOUT': '86400', 01:59:30 INFO - 'USER': 'cltbld', 01:59:30 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066', 01:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:30 INFO - '_': '/tools/buildbot/bin/python'} 01:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:30 INFO - Downloading/unpacking jsonschema 01:59:30 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 01:59:30 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 01:59:30 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 01:59:30 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 01:59:30 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 01:59:30 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 01:59:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:59:32 INFO - Downloading/unpacking functools32 (from jsonschema) 01:59:32 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 01:59:32 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 01:59:32 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 01:59:32 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 01:59:32 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 01:59:32 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 01:59:32 INFO - Downloading functools32-3.2.3-2.tar.gz 01:59:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:59:32 INFO - warning: no files found matching '*.txt' 01:59:32 INFO - no previously-included directories found matching 'build' 01:59:32 INFO - no previously-included directories found matching 'dist' 01:59:32 INFO - no previously-included directories found matching '.git*' 01:59:32 INFO - Installing collected packages: jsonschema, functools32 01:59:32 INFO - Running setup.py install for functools32 01:59:32 INFO - warning: no files found matching '*.txt' 01:59:32 INFO - no previously-included directories found matching 'build' 01:59:32 INFO - no previously-included directories found matching 'dist' 01:59:32 INFO - no previously-included directories found matching '.git*' 01:59:32 INFO - Successfully installed jsonschema functools32 01:59:32 INFO - Cleaning up... 01:59:32 INFO - Return code: 0 01:59:32 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:59:32 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')]} 01:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:32 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')]} 01:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:32 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 0x7fbbc2e67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1733660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c23b0>, '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 0x17c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3740>, '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': '5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066', '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 01:59:32 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 01:59:32 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 01:59:32 INFO - Using env: {'DISPLAY': ':0', 01:59:32 INFO - 'HOME': '/home/cltbld', 01:59:32 INFO - 'LANG': 'en_US.UTF-8', 01:59:32 INFO - 'LANGUAGE': 'en_US:en', 01:59:32 INFO - 'LOGNAME': 'cltbld', 01:59:32 INFO - 'MAIL': '/var/mail/cltbld', 01:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:32 INFO - 'MOZ_NO_REMOTE': '1', 01:59:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:32 INFO - 'NO_EM_RESTART': '1', 01:59:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:32 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:32 INFO - 'SHELL': '/bin/bash', 01:59:32 INFO - 'SHLVL': '1', 01:59:32 INFO - 'TERM': 'linux', 01:59:32 INFO - 'TMOUT': '86400', 01:59:32 INFO - 'USER': 'cltbld', 01:59:32 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066', 01:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:32 INFO - '_': '/tools/buildbot/bin/python'} 01:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:32 INFO - Downloading/unpacking flake8 01:59:32 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 01:59:32 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 01:59:32 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 01:59:32 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 01:59:32 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 01:59:32 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 01:59:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:59:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:59:34 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 01:59:34 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 01:59:34 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 01:59:34 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 01:59:34 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 01:59:34 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 01:59:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:59:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:59:34 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 01:59:34 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 01:59:34 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 01:59:34 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 01:59:34 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 01:59:34 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 01:59:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:59:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:59:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:59:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:59:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:59:35 INFO - no previously-included directories found matching 'docs/_build' 01:59:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:59:35 INFO - Running setup.py install for pep8 01:59:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:59:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:59:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:59:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:59:35 INFO - no previously-included directories found matching 'docs/_build' 01:59:35 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:59:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:59:35 INFO - Cleaning up... 01:59:35 INFO - Return code: 0 01:59:35 INFO - Running post-action listener: _resource_record_post_action 01:59:35 INFO - Running post-action listener: _start_resource_monitoring 01:59:35 INFO - Starting resource monitoring. 01:59:35 INFO - ##### 01:59:35 INFO - ##### Running install step. 01:59:35 INFO - ##### 01:59:35 INFO - Running pre-action listener: _resource_record_pre_action 01:59:35 INFO - Running main action method: install 01:59:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:59:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:59:35 INFO - Reading from file tmpfile_stdout 01:59:35 INFO - Detecting whether we're running mozinstall >=1.0... 01:59:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:59:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:59:36 INFO - Reading from file tmpfile_stdout 01:59:36 INFO - Output received: 01:59:36 INFO - Usage: mozinstall [options] installer 01:59:36 INFO - Options: 01:59:36 INFO - -h, --help show this help message and exit 01:59:36 INFO - -d DEST, --destination=DEST 01:59:36 INFO - Directory to install application into. [default: 01:59:36 INFO - "/builds/slave/test-pgo"] 01:59:36 INFO - --app=APP Application being installed. [default: firefox] 01:59:36 INFO - mkdir: /builds/slave/test-pgo/build/application 01:59:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 01:59:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 01:59:51 INFO - Reading from file tmpfile_stdout 01:59:51 INFO - Output received: 01:59:51 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:59:51 INFO - Running post-action listener: _resource_record_post_action 01:59:51 INFO - ##### 01:59:51 INFO - ##### Running run-tests step. 01:59:51 INFO - ##### 01:59:51 INFO - Running pre-action listener: _resource_record_pre_action 01:59:51 INFO - Running main action method: run_tests 01:59:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:59:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:59:51 INFO - Python 2.7.3 01:59:51 INFO - Return code: 0 01:59:51 INFO - grabbing minidump binary from tooltool 01:59:51 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')]} 01:59:51 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 0x17c23b0>, '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 0x17c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:59:51 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 01:59:51 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 01:59:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:59:51 INFO - Return code: 0 01:59:51 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:59:51 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:59:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:59:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:59:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:59:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:59:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:59:52 INFO - Return code: 0 01:59:52 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-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 01:59:52 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-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost 01:59:52 INFO - Using env: {'DISPLAY': ':0', 01:59:52 INFO - 'HOME': '/home/cltbld', 01:59:52 INFO - 'LANG': 'en_US.UTF-8', 01:59:52 INFO - 'LANGUAGE': 'en_US:en', 01:59:52 INFO - 'LOGNAME': 'cltbld', 01:59:52 INFO - 'MAIL': '/var/mail/cltbld', 01:59:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:59:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:52 INFO - 'MOZ_NO_REMOTE': '1', 01:59:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:52 INFO - 'NO_EM_RESTART': '1', 01:59:52 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:52 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:52 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:59:52 INFO - 'SHELL': '/bin/bash', 01:59:52 INFO - 'SHLVL': '1', 01:59:52 INFO - 'TERM': 'linux', 01:59:52 INFO - 'TMOUT': '86400', 01:59:52 INFO - 'USER': 'cltbld', 01:59:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066', 01:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:52 INFO - '_': '/tools/buildbot/bin/python'} 01:59:52 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] with output_timeout 3600 01:59:52 INFO - mozversion INFO | application_buildid: 20160305031719 01:59:52 INFO - mozversion INFO | application_changeset: 78fe98c670fcc9a1548ac655ae9a488d940fd9c8 01:59:52 INFO - mozversion INFO | application_display_name: Nightly 01:59:52 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:59:52 INFO - mozversion INFO | application_name: Firefox 01:59:52 INFO - mozversion INFO | application_remotingname: firefox 01:59:52 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:59:52 INFO - mozversion INFO | application_vendor: Mozilla 01:59:52 INFO - mozversion INFO | application_version: 45.0 01:59:52 INFO - mozversion INFO | platform_buildid: 20160305031719 01:59:52 INFO - mozversion INFO | platform_changeset: 78fe98c670fcc9a1548ac655ae9a488d940fd9c8 01:59:52 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:59:52 INFO - mozversion INFO | platform_version: 45.0 01:59:52 INFO - 2016-03-06 01:59:52,987 DEBUG : using testdate: 1457258392 01:59:52 INFO - 2016-03-06 01:59:52,987 DEBUG : actual date: 1457258392 01:59:53 INFO - 2016-03-06 01:59:53,034 INFO : starting webserver on 'localhost:51842' 01:59:53 INFO - 2016-03-06 01:59:53,035 INFO : Starting test suite talos-linux64-ix-011 01:59:53 INFO - 2016-03-06 01:59:53,035 INFO : Starting test dromaeo_css 01:59:53 INFO - 2016-03-06 01:59:53,035 DEBUG : operating with platform_type : linux_ 01:59:53 INFO - 2016-03-06 01:59:53,036 INFO : Initialising browser for dromaeo_css test... 01:59:53 INFO - 2016-03-06 01:59:53,051 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNWNNmj/profile http://localhost:51842/getInfo.html 01:59:58 INFO - 2016-03-06 01:59:58,502 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:59:58 INFO - 2016-03-06 01:59:58,503 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:59:58 INFO - 2016-03-06 01:59:58,503 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:59:58 INFO - 2016-03-06 01:59:58,503 DEBUG : BROWSER_OUTPUT: __metrics 01:59:58 INFO - 2016-03-06 01:59:58,802 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:59:59 INFO - 2016-03-06 01:59:59,967 INFO : Browser initialized. 01:59:59 INFO - 2016-03-06 01:59:59,968 INFO : Running cycle 1/1 for dromaeo_css test... 01:59:59 INFO - 2016-03-06 01:59:59,968 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNWNNmj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:00:11 INFO - 2016-03-06 02:00:11,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 134647808 02:00:11 INFO - 2016-03-06 02:00:11,615 DEBUG : BROWSER_OUTPUT: 02:01:02 INFO - 2016-03-06 02:01:02,364 DEBUG : BROWSER_OUTPUT: 1457258462363 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] 02:03:10 INFO - 2016-03-06 02:03:10,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51842/tests/dromaeo/cssquery-ext.html) 02:03:11 INFO - 2016-03-06 02:03:11,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 226459648 02:03:11 INFO - 2016-03-06 02:03:11,920 DEBUG : BROWSER_OUTPUT: 02:06:14 INFO - 2016-03-06 02:06:14,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/dromaeo/cssquery-ext.html (next: http://localhost:51842/tests/dromaeo/cssquery-jquery.html) 02:06:14 INFO - 2016-03-06 02:06:14,605 DEBUG : BROWSER_OUTPUT: RSS: Main: 213364736 02:06:14 INFO - 2016-03-06 02:06:14,606 DEBUG : BROWSER_OUTPUT: 02:09:16 INFO - 2016-03-06 02:09:16,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51842/tests/dromaeo/cssquery-mootools.html) 02:09:16 INFO - 2016-03-06 02:09:16,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 208244736 02:09:16 INFO - 2016-03-06 02:09:16,973 DEBUG : BROWSER_OUTPUT: 02:12:18 INFO - 2016-03-06 02:12:18,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51842/tests/dromaeo/cssquery-prototype.html) 02:12:19 INFO - 2016-03-06 02:12:19,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 202137600 02:12:19 INFO - 2016-03-06 02:12:19,265 DEBUG : BROWSER_OUTPUT: 02:15:21 INFO - 2016-03-06 02:15:21,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51842/tests/dromaeo/cssquery-yui.html) 02:15:22 INFO - 2016-03-06 02:15:22,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 196558848 02:15:22 INFO - 2016-03-06 02:15:22,193 DEBUG : BROWSER_OUTPUT: 02:18:24 INFO - 2016-03-06 02:18:24,289 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/dromaeo/cssquery-yui.html (next: http://localhost:51842/tests/dromaeo/cssquery-dojo.html) 02:18:24 INFO - 2016-03-06 02:18:24,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 242200576 02:18:24 INFO - 2016-03-06 02:18:24,535 DEBUG : BROWSER_OUTPUT: 02:18:24 INFO - 2016-03-06 02:18:24,537 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:18:24 INFO - 2016-03-06 02:18:24,537 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:18:24 INFO - 2016-03-06 02:18:24,537 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:18:24 INFO - 2016-03-06 02:18:24,537 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:18:24 INFO - 2016-03-06 02:18:24,539 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3270.362279355526;3349.363620912028;3361.697447229749;3378.0203740915135;3391.8473668684915;5413.593980451467;5477.972610136943;5487.039768040587;5493.45065493451;5506.669599824013;5483.972580137103;5487.286652735149;5535.916961245584;5544.77820887164;5557.110862262039;4791.089692958344;5000.149974504325;5031;5114.925865568235;5119.206522988924;4967.801287948478;5029.497050294978;5033.446320904697;5033.949660503403;5034.144195486758;4856.4172299323955;4885.780139893695;4971.179755340365;5004.549590536851;5005.974970125144;5001.6998980061135;5051.823186188466;5054.01446717892;5056.721880296583;5080.13637681595;4750.978539613965;4956.454789973136;4981.402231732179;4991.950080499221;5025.572826309768;5176.456472070416;5223.6343455958095;5334.226537152092;5336.573074154058;5339.973300133474;5883.8529036774;5908.143319218732;5934.5845790794665;5939.316978547436;5942.316633587149;5644.266245388073;5727.9427205727825;5954.077118046666;5975.163477113208;5978.432048955342;5406.135018397077;5458.699771512565;5459.317585301837;5463.125899856004;5496;5938.851528711731;5956.047032474783;5961.374055724174;5964.582479226413;5966.582339236299;5568.9443105569235;5604.41153678866;5658.575606829504;5730.226419433323;5731.140328950607;5876.6180198286975;5884.0585506318785;5887.882242355129;5889.440503152194;5937.9406205937385;5816.73824677882;5861.794837180763;5862.530997520188;5863.824085277449;5867.70661466925;5592.636478628876;5701.515371193495;5702.7433765480655;5816.302043754777;5875.853103672357;4480.103979204172;4485.282354823213;4487.371767952489;4504.346869703874;4505.414296141481;4062.6749860011128;4065.6747460203114;4068;4093.836246550164;4098.713090083726;5302.443243459458;5407.134858422713;5472.425395333512;5576.302962129734;5609.046462101453;5812.186293918855;5936.13925980739;5940.198073260054;5940.762369505258;5942.524598032147;5402.729863506809;5553.8333849984565;5584.832455026356;5589.860253493695;5597.468240517144;5028.044671512401;5103.260027296022;5204.76578553966;5210.817621383309;5232.058229518647;5976.402359764076;6025.9096113558335;6030.698465076729;6032.034874420159;6043.8791224175275;5682.659040457585;5779.393163717918;5916.408359164136;5916.852078698067;5924.733386997682;6029.974904266373;6100.4326159576185;6115.249312096529;6124.510039196943;6128.601640893327;5792.855178620568;5830.2420685310635;5835.241418615553;5841.211436456024;5862.794802181903;5704.600677952503;5804.245448091721;5948.762049518144;5954.672493012926;5957.940420595739;5721.742521586455;5805.651660900359;5814.796482123105;5817.650940943557;5855.59010869235;5777.075667893117;5803.274590676166;5822;5832.591718579828;5834.649921004753;5500.972495137498;5520.420355862737;5552.056150454352;5719.142128680564;5730.140478928194;5797.246357973605;5821.94178058231;5824.912626310524;5825.271841019872;5829.300483941955;5670.036093863971;5699.059655156852;5709.771609135588;5717.656940583578;5718.742656580547 02:18:24 INFO - 2016-03-06 02:18:24,540 DEBUG : BROWSER_OUTPUT: |1;ext.html;578.8842231553688;621.5307442880625;630.7792272704556;631.5768435148451;695.25260345129;32730;33201.667983320156;40661.18677626449;40845;40973.7951310243;44549.331760023626;44739;44776;44978.77510612451;45019;8063.475874068196;9118.452892826435;9319.534023298842;9320;9321.114494123047;8272.669093236264;10962.397068161248;11230.382328971904;11238.49426775793;11243.66269011931;10914;11004.834927476095;11016.283941543774;11026.062784663312;11026.889731102707;10950.178736594788;11055.502502387331;11059.557617695282;11066.723331916686;11067.169962252823;10830.72923176919;10986.890131098666;11005.449727513593;11005.779884402267;11006.394648294341;42178.78910605458;42535;42599.57400425987;42632.36051459231;42643;3720.8883733488037;3956.940645890314;4131.327493462447;4227.656833634259;4370.497392799837;31890.202744931332;32052.358952820814;32169.678303217137;32346.676533234837;32396.6760332396;4027.0939038716347;4053.5743746906446;4078.5309689385804;4098.610631989956;4192.538820729717;282737;285536.5723171392;286105;286304;286524;61401.69299153476;62047.6897615509;62544.37455625476;69598.65200673965;71213.28786712067;63459.68270158712;63607;63898.68050659717;63975;64164;16240.431584894472;16439.91780041092;16440.095794731165;16445.25996330168;16450.34198632065;12275.570355037531;12275.877241227474;12360.01119910423;12369.752604947851;12486;20744;20977.160913563286;21031.474213144487;21034;21081.472963175736;8398.622062007224;8589.226969572768;8623.180797824196;8641.913580864111;8679.088695686989;971.2181693736469;1076.1928553584812;1082.3127314155568;1097.9898493386104;1112.7329440934118;29162;29423.11730648084;29473.263168420963;30092.849535752182;30291.848540757597;1154.099802154321;1155.7746239483388;1221.6151912147645;1238.158052524292;1260.6281147061638;12901.935490322488;15216.163111029;15524.301406436738;15946.282417291017;16193.838061619468;368764;371702;372446;372874;376918;56589.71705141448;56862.147067794016;56901.71549142228;56919;56968.14547781787;1358.185088946624;1394.3934388540815;1444.5594093801492;1467.2736995187238;1482.3403585404392;26764.464710705288;28500.85749571239;28786.568201476577;29390.706092939654;30293.242668933453;52274.477255226964;53370;53399;53456.198157028455;53476.46523534715;209302;209661;210403;210847;210915;32897.342053158325;32922.83538582292;32945.835270823496;32961.34077318488;33355.66510344252;45687;45764.54235457603;45938.540614593425;46260;46827.765861170476;36794.26411471809;37087;37267.6273237275;37553.24893502169;38275.617243827204;37529.6247037537;37633.43549846809;37646.24707505889;37652.81173594115;38066.619333807415;36324.09189770277;36836.44745328876;37197.814010929775;37255.25489490249;37325;33074;33119.172020699676;33343.33313333671;33377.332453351286;33475.33049339048;25417.364565886;26629.600555992063;26687.599686004338;26759.86620066965;26803.73196268012 02:18:24 INFO - 2016-03-06 02:18:24,544 DEBUG : BROWSER_OUTPUT: |2;jquery.html;377.11566376846304;378.3492393083895;378.7689509399266;379.69902391507486;384.6269118954614;15254.389824407039;15551.22243887804;17444.215010324533;19150.90424547877;19165.04174791262;13769.793453098211;16751.83248167518;16892.324307027706;17400;17418.825811741877;5507.366652834915;5511.944880551193;5628.465295796893;5633.577481688869;5643.548516118701;4305.311150215966;4392.516823149451;5509.063459211923;5550.389457159709;6094.055421409666;6138.938610613904;6174.567780255384;6201.782937597185;6203;6207.81376558704;6013.338532761392;6121.724522396503;6159.1993040904845;6168.84577885552;6173.166622505949;5431.185322201662;5465.836024919259;5474.972625136888;5480.561555075625;5481.451854814526;19983.600327993503;21309.467263318387;21547.784522154736;22033.779662203335;22139.778602213933;2392.605220138675;2412.2522018174423;2431.3678443604613;2511.4769117398228;2528.216252961588;13659.112157709716;14003.71992560143;14084.507042253574;14202.502912398017;14226.430942762277;1942.2328180368816;1964.8526360523017;1978.5053736565858;1986.8311193548566;2022.6763717805227;59501;60869.6956515219;60957;61014;62415.37584624141;10399.688009359732;10620.309679870783;10720.731981700364;10749;10775.730606734738;14167;14266.714665706628;14271.857281427261;14278.928605356907;14279.357428915724;7727.150013498511;7782.961085194538;8041.035075790943;8068.394870384627;8082.676692932335;7686.231376862381;7702.075750909927;7749.263819937097;7753.767386978399;7787.961060194662;6314.684265786692;6321.462675672619;6348.1430006949395;6383.234011918506;6386.329435409308;1721.8708596855286;1734.2282684205406;1808.4665023818006;1831.3407173417559;1834.8348648621688;450.00324281716155;464.6190124098207;476.69967920210047;1034.943078130695;1096.090245096568;9732.951335243279;10792.082672972729;11050.281731687415;11429.828552571718;11531.13516486267;468.8593421973463;477.3841744150077;479.9976000120047;485.5557165193879;486.02794411177643;6148.200733904653;6226.128342032119;6269.968650156811;6285.277193122849;6285.937140628626;470765;477666;482564;546450;727412;80581.59709201533;83322;87085;87508.5624571873;88144.55927720321;1172.1209093180114;1194.566361487881;1205.8854408831146;1220.2666028096999;1226.405193481161;16475.58811029734;16481.658676370476;16489.422870199964;16567.50297491077;16681.74977375316;35409.64590354064;36087.819560902026;36095.81952090223;36662.266754664226;37145.25709485849;46569.3014604788;46664.53335466602;46970.29544556766;48873.26690099722;48888.75555622199;9749.463779492196;9823.115919567274;10190.388576685422;10200.3369780964;10206.183505319408;11756.470958806703;12159.635210943687;17750.20124094393;17887.463376098738;18036.09819508993;14597.562073137822;14915.403383864525;14935;15217.391304348144;15443.922780386027;14297.428102875769;14441.711165776836;14475.85524144745;14883;15038.774418383951;12126.939365303117;12277.956373707977;15550.922245388701;16105.355785768437;16125.67748645044;8974.730758077269;9362.812743745224;9952.353097048668;9982.251331150337;10054;14814.555563333117;14938.402463901322;15050.849491504945;15316.463923762614;15445.304961276544 02:18:24 INFO - 2016-03-06 02:18:24,545 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1541.8920675552708;1601.126681782315;1611.1299898055051;1789.9821001789987;1889.1215584753088;7346.412287017032;7735.9226407735905;7745.883811742814;7755.7285495007545;7757.3406260467855;6948.096747422828;7093.71625134994;7467.775966720994;7720.498167619101;7754.767356979286;2271.6138256496392;2300.850444721096;2321.907123715058;2323.5585238804656;2323.6514522821544;2019.3437132931783;2277.487565297811;2294.093832935989;2334.1480359668685;2337.6026075567192;2049.4364049886253;2226.0428015953134;2283.178055899883;2301.8849057547054;2306.7923886850263;2246.7753224677404;2286.805621522164;2289.6222123349626;2290.1640901071155;2305.7809508096702;2290.4960908600083;2294.4149241943196;2319.2926157521947;2319.5824751544715;2320.9419764505856;7729.922700772977;7770.689172433096;7786.727464538714;7787;7797;4593.586577208034;4684.227102528079;4705.223638099709;4705.670603057787;4708.4820669726305;2957.6746557878614;2985.5221665275826;3030.0606811888383;3030.6666266710645;3035.3322269100763;994.5176589354157;998.4059484606647;1000.4447531619948;1008.1128606825946;1049.1449468683;10634.787304253949;10645.680629581126;10658.094062004662;10683.572657093784;10693.251472396936;4103.384492326175;4132.896677583084;4161.583841615875;4169.437125988014;4219.810108545123;9178.86231706525;9182.035886231983;9183.265338772882;9201.171894529525;9215.815683686289;4704.223803072523;4713.952860471351;4721;4730.858074257778;4732.266498692708;4259.467566554181;4311.159323931804;4313.266744653416;4313.396124542566;4314.482262128565;3667.9266414671556;3687.649673281034;3715.3126671565847;3716.6840818530186;3756.849726010929;1084.0839490630406;1172.9120315976336;1174.1370092981651;1208.2569219929856;1222.5232159457819;1157.8494795676509;1216.3492531495608;1229.33001514175;1443.0547991065869;1460.5034288342015;7406.407487400995;7437.479376443705;7449.366803821627;7485.139208990927;7488.438367122488;1123.6741345010018;1130.4460814200982;1145.3986657004973;1148.7472755993667;1169.257521473853;5845.1232315153065;5845.152452894392;5852.385499522489;5862.237909071879;5893.322267939242;8845.601947912231;8863.2466240369;9033.322500812465;9082.591283392263;9085.682001129928;8973;8977.012528621846;8978.506182160045;8980.326475514363;8988.910110898807;7412.369948554433;7532.359749421251;7570.242975702496;7588.962055189799;7593.088829340514;7481.064866891638;7534.321911028033;7539.736109236151;7541;7546.358559522502;8314.916850831414;8352.665893364197;8520.360972926932;8550.74347769568;8552.187542183483;8479.40644154928;8492.957535212285;8501.872471912802;8635.481871087755;8654.177853103945;6799.776040312791;6859.828504287233;6908.654567271717;6935.861282774417;6944.375006249462;7662.578558179353;7700.191479894755;7703.807404814925;7708.03649543807;7710.691572337044;6544.44372228366;6966.5471744336455;7094.432445404458;7139.500234983501;7176.533525320838;6583.835404114935;6679.732810687518;6939.930600693929;7022.157341119098;7022.297770222936;7326.670299836626;7339.522931009467;7358.264173582599;7363.521371110861;7375.889361659472;6757.256701762901;6778.288279730755;6803.183617965876;6821.045053692388;6823.454123669995;6834.487413443912;6836.38472537474;6864.107666003388;6868.690908909011;6870.106886104974 02:18:24 INFO - 2016-03-06 02:18:24,546 DEBUG : BROWSER_OUTPUT: |4;prototype.html;357.8425492783175;363.31696410747793;364.7392114638033;365.08728179551116;367.0914486645553;6070.635761854286;6176.505879529638;6180.845478863031;6186.659733714644;6192.690365481731;6028.939710602893;6029;6039.637621742699;6040.154378387018;6042.123892035664;4518.683692141552;4683.250679891218;4694.671373003891;4700.2009658358165;4705.858824235262;4668.206404911173;4677.929831052537;4684.063187362524;4685;4686.742229177394;4426.734395936238;4621.653375996797;4640.559146881058;4644.303354496836;4651.86044418668;4486.820527178909;4519.819207231707;4521.660875434339;4522.502524722295;4577.931331030038;4021.296273152216;4027.456293400412;4038.838446462167;4048.210598933209;4054.9391759123637;5753;5792.623479473821;5803.767849286023;5808.82573522795;5808.941910580882;5170.922436163461;5327.46725327468;5336.439673834269;5397.514223719845;5426.647267927611;6429.35706429358;6437.742490300382;6449.322821103763;6451.741930322782;6465;4483.14820184164;4484.5291244419195;4484.955150448486;4485.529019452943;4485.573870482299;6613.570117942367;6672.132622759059;6760.526763126583;6767.052612634235;6785.558938668971;4631.027484228282;4658.045100754337;4661.463931647904;4663.207254766698;4665.393498845128;4712.976435117871;4714.787834547454;4720.150372932905;4720.315554244616;4720.763961801897;5429.457054294618;5440.020796256633;5440.510354068153;5444.074507333763;5451.754671039813;6386.07401926718;6512.5766825156215;6516.380943810331;6519.185101862267;6530.346965303432;1641.2450272874373;1660.1948055193222;1662.3516828436918;1662.7007138715148;1664.8251933547047;1111.69984104293;1112.0880877680386;1121.5625905896707;1124.5951457475303;1142.9257098288585;6321.810345689637;6328.303886572473;6331.2085989251345;6334.841628959313;6336.1762970814425;6709.261981182066;6714.3957043866285;6717.093192419059;6722.798316050526;6730.596164230162;6235.974494587496;6284.528660350492;6323.36766323364;6325.683715814191;6327.145835312174;3611.4041183204477;3634.909527141847;3641.053326135224;3641.672249497558;3644.1071937375514;6881.793546193622;6883.690233939485;6892.931070689229;6894.931050689529;6907.412869906114;6680.331966803378;6723.865522689519;6825.761098361533;6862.3137686230975;6866.485013623998;6888.242293347727;6904;6956.686949087202;6965.965170174117;6979.4765392595755;6720.731170753311;6749.392554670103;6755.054292399166;6760.222574404006;6763.492738044764;6536.869262614816;6669.399754022162;6685.465162787063;6689.464842812466;6689.933100668931;6950.06174166481;6952.061471701256;6955.791326260221;6957.895631565631;6964.338387853146;4693.483716791082;4702.952970470252;4704.50602686713;4704.764761761967;4709.364235828257;6656.534042617164;6720.932790672031;6730.865382692221;6765.729370825112;6768.796936091925;6572.737090516326;6591.802245932629;6594.142761440982;6599.043138744951;6599.637019963948;6567.047778072249;6574.441172500391;6578.703958321791;6581.572197807127;6582.144321238208;6347.523935704933;6466.579672321284;6505.21937367519;6506;6507.0564768107415;6607.9669601651685;6616.933830661825;6620.63586502747;6631;6638.302978187221;6457.128287681103;6469.967650161719;6476.417122459001;6478.963365861439;6481.837954050998 02:18:24 INFO - 2016-03-06 02:18:24,548 DEBUG : BROWSER_OUTPUT: |5;yui.html;768.9577073260972;808.252366560931;848;900.6442455230184;907.7140700679286;17222.827771722277;17566;17575.824241757564;17608.20763065662;17621.735673964886;15802.604934876634;15874.126923019257;15877.3649054038;15930.044197348137;15930.681386372265;745.1170363119693;757.8484303139367;880.6829541365104;894.5259012723267;913.8355096082703;887.1970866365917;905.651324240169;908.4730856103445;914.5427286356821;915.6108653822132;926.8563372677212;940.9952950235239;941.2470023980823;942.2791564453199;943.481085403029;768.4006474949548;781.2617076862367;919.0533750237233;940.3934462271865;941.2422999485411;687.1994126842222;693.2789898505548;695.2213520856623;698.3819319901872;701.0535776701412;14438.566842994727;14578.343974521173;14587.854121458755;14614.780778288334;14623.488177913721;11925.463354148997;12115.151939364248;12715.809262861065;12786.872131278662;13119.606411807566;10869.945650271777;10911.290766100177;10975.121990240761;11138.387388693618;11143.219974601781;3661.9633803662155;3676.3382591133586;3693.409054551286;3706.9814650926573;3774.0753515388633;47014.76492617549;47069.20134002011;47399.76300118512;47440.28839567409;47952.7602361986;10393.584256629802;10417.876230032887;10513.737156570995;10541.104006159563;10728.51721672511;18117.637647246982;18163.909180454277;18245.908770456062;18267.269309227482;18320.541986450444;7803.960980195063;7817.374610031184;7878.330341921001;7917.683292668229;8031.277185053374;4238.491381034234;4251.489821221411;4258.382534532476;4261.4673165854265;4329.458817647794;3043.1174959261566;3071.7389021933386;3087.444260033171;3094.1955091676327;3348.9162770930434;608.0635820835952;612.3906712820772;617.4319625944142;620.1287191495956;623.3236937922405;595.9135925290808;708.097176100476;709.1525626875937;709.6451774112943;731.2139450091173;8695.782605434788;8920.24177944882;9200.493972831424;9203.953980230055;9407.529623518796;677.7695583501633;696.2932623387265;717.7057406463325;744.0178963767775;744.5272252119835;4211.157768446323;4422.7346359218545;4427.867163985085;4517.503074661785;4588.334691469719;56360.71819640876;57243.71378143166;57265.713671431375;57398.7130064347;57428.42571574314;52047.47952520502;52351.73824130855;53916.19125713118;54223.72888135534;54399.45600544023;46584.5341546587;46797.29804052942;47138.29292560614;47152.05695886063;47166.76416617895;9026.774330641787;9051.32115091384;9078.409903356262;9148.496832674267;9283.210927071275;34233.48649770305;35155.13734739864;35397.469037963936;35474.29051418906;35925.64074359223;45042.549574503835;45976.540234598564;48695;49235.75382123067;51335;11677.299362038304;11701.239419437708;11874.406279686154;11893.167478276437;12009.39953002329;12687.746245075232;12763.74472510526;13180.604581862559;13367.412013232923;13764.380602872694;10953.56185752561;11653.067754579783;11718.531258749554;11803.23278986863;11868.169228153947;11090.003440383985;11255.606053788078;11304.886951130384;11352.148588855704;11483.196176267915;10836.349819010884;10939.28894621847;11233.438328083726;11745.882541174478;11763.117766167401;9405.20055795265;9505.477198753859;9602.711918642452;9907.108360247612;10235.897641023792;9905.306628535933;10160.644377446753;10162.39025658463;10180.389176649425;10226.948865255627 02:18:24 INFO - 2016-03-06 02:18:24,548 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:18:24 INFO - 2016-03-06 02:18:24,548 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:18:24 INFO - 2016-03-06 02:18:24,548 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,753 02:18:24 INFO - 2016-03-06 02:18:24,548 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:18:24 INFO - 2016-03-06 02:18:24,548 DEBUG : BROWSER_OUTPUT: __startTimestamp1457259504535__endTimestamp 02:18:24 INFO - 2016-03-06 02:18:24,548 DEBUG : BROWSER_OUTPUT: 02:18:24 INFO - 2016-03-06 02:18:24,548 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:18:24 INFO - 2016-03-06 02:18:24,548 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:18:24 INFO - 2016-03-06 02:18:24,548 DEBUG : BROWSER_OUTPUT: 02:18:24 INFO - 2016-03-06 02:18:24,549 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5454.85 Median:5658.58 stddev:594.37 (10.5%) stddev-sans-first:570.95 02:18:24 INFO - 2016-03-06 02:18:24,549 DEBUG : BROWSER_OUTPUT: Values: 3270.4 3349.4 3361.7 3378.0 3391.8 5413.6 5478.0 5487.0 5493.5 5506.7 5484.0 5487.3 5535.9 5544.8 5557.1 4791.1 5000.1 5031.0 5114.9 5119.2 4967.8 5029.5 5033.4 5033.9 5034.1 4856.4 4885.8 4971.2 5004.5 5006.0 5001.7 5051.8 5054.0 5056.7 5080.1 4751.0 4956.5 4981.4 4992.0 5025.6 5176.5 5223.6 5334.2 5336.6 5340.0 5883.9 5908.1 5934.6 5939.3 5942.3 5644.3 5727.9 5954.1 5975.2 5978.4 5406.1 5458.7 5459.3 5463.1 5496.0 5938.9 5956.0 5961.4 5964.6 5966.6 5568.9 5604.4 5658.6 5730.2 5731.1 5876.6 5884.1 5887.9 5889.4 5937.9 5816.7 5861.8 5862.5 5863.8 5867.7 5592.6 5701.5 5702.7 5816.3 5875.9 4480.1 4485.3 4487.4 4504.3 4505.4 4062.7 4065.7 4068.0 4093.8 4098.7 5302.4 5407.1 5472.4 5576.3 5609.0 5812.2 5936.1 5940.2 5940.8 5942.5 5402.7 5553.8 5584.8 5589.9 5597.5 5028.0 5103.3 5204.8 5210.8 5232.1 5976.4 6025.9 6030.7 6032.0 6043.9 5682.7 5779.4 5916.4 5916.9 5924.7 6030.0 6100.4 6115.2 6124.5 6128.6 5792.9 5830.2 5835.2 5841.2 5862.8 5704.6 5804.2 5948.8 5954.7 5957.9 5721.7 5805.7 5814.8 5817.7 5855.6 5777.1 5803.3 5822.0 5832.6 5834.6 5501.0 5520.4 5552.1 5719.1 5730.1 5797.2 5821.9 5824.9 5825.3 5829.3 5670.0 5699.1 5709.8 5717.7 5718.7 02:18:24 INFO - 2016-03-06 02:18:24,549 DEBUG : BROWSER_OUTPUT: 02:18:24 INFO - 2016-03-06 02:18:24,549 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47572.04 Median:33272.50 stddev:77745.85 (233.7%) stddev-sans-first:77883.88 02:18:24 INFO - 2016-03-06 02:18:24,550 DEBUG : BROWSER_OUTPUT: Values: 578.9 621.5 630.8 631.6 695.3 32730.0 33201.7 40661.2 40845.0 40973.8 44549.3 44739.0 44776.0 44978.8 45019.0 8063.5 9118.5 9319.5 9320.0 9321.1 8272.7 10962.4 11230.4 11238.5 11243.7 10914.0 11004.8 11016.3 11026.1 11026.9 10950.2 11055.5 11059.6 11066.7 11067.2 10830.7 10986.9 11005.4 11005.8 11006.4 42178.8 42535.0 42599.6 42632.4 42643.0 3720.9 3956.9 4131.3 4227.7 4370.5 31890.2 32052.4 32169.7 32346.7 32396.7 4027.1 4053.6 4078.5 4098.6 4192.5 282737.0 285536.6 286105.0 286304.0 286524.0 61401.7 62047.7 62544.4 69598.7 71213.3 63459.7 63607.0 63898.7 63975.0 64164.0 16240.4 16439.9 16440.1 16445.3 16450.3 12275.6 12275.9 12360.0 12369.8 12486.0 20744.0 20977.2 21031.5 21034.0 21081.5 8398.6 8589.2 8623.2 8641.9 8679.1 971.2 1076.2 1082.3 1098.0 1112.7 29162.0 29423.1 29473.3 30092.8 30291.8 1154.1 1155.8 1221.6 1238.2 1260.6 12901.9 15216.2 15524.3 15946.3 16193.8 368764.0 371702.0 372446.0 372874.0 376918.0 56589.7 56862.1 56901.7 56919.0 56968.1 1358.2 1394.4 1444.6 1467.3 1482.3 26764.5 28500.9 28786.6 29390.7 30293.2 52274.5 53370.0 53399.0 53456.2 53476.5 209302.0 209661.0 210403.0 210847.0 210915.0 32897.3 32922.8 32945.8 32961.3 33355.7 45687.0 45764.5 45938.5 46260.0 46827.8 36794.3 37087.0 37267.6 37553.2 38275.6 37529.6 37633.4 37646.2 37652.8 38066.6 36324.1 36836.4 37197.8 37255.3 37325.0 33074.0 33119.2 33343.3 33377.3 33475.3 25417.4 26629.6 26687.6 26759.9 26803.7 02:18:24 INFO - 2016-03-06 02:18:24,550 DEBUG : BROWSER_OUTPUT: 02:18:24 INFO - 2016-03-06 02:18:24,550 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29246.78 Median:35748.73 stddev:89928.29 (251.6%) stddev-sans-first:90154.44 02:18:24 INFO - 2016-03-06 02:18:24,550 DEBUG : BROWSER_OUTPUT: Values: 377.1 378.3 378.8 379.7 384.6 15254.4 15551.2 17444.2 19150.9 19165.0 13769.8 16751.8 16892.3 17400.0 17418.8 5507.4 5511.9 5628.5 5633.6 5643.5 4305.3 4392.5 5509.1 5550.4 6094.1 6138.9 6174.6 6201.8 6203.0 6207.8 6013.3 6121.7 6159.2 6168.8 6173.2 5431.2 5465.8 5475.0 5480.6 5481.5 19983.6 21309.5 21547.8 22033.8 22139.8 2392.6 2412.3 2431.4 2511.5 2528.2 13659.1 14003.7 14084.5 14202.5 14226.4 1942.2 1964.9 1978.5 1986.8 2022.7 59501.0 60869.7 60957.0 61014.0 62415.4 10399.7 10620.3 10720.7 10749.0 10775.7 14167.0 14266.7 14271.9 14278.9 14279.4 7727.2 7783.0 8041.0 8068.4 8082.7 7686.2 7702.1 7749.3 7753.8 7788.0 6314.7 6321.5 6348.1 6383.2 6386.3 1721.9 1734.2 1808.5 1831.3 1834.8 450.0 464.6 476.7 1034.9 1096.1 9733.0 10792.1 11050.3 11429.8 11531.1 468.9 477.4 480.0 485.6 486.0 6148.2 6226.1 6270.0 6285.3 6285.9 470765.0 477666.0 482564.0 546450.0 727412.0 80581.6 83322.0 87085.0 87508.6 88144.6 1172.1 1194.6 1205.9 1220.3 1226.4 16475.6 16481.7 16489.4 16567.5 16681.7 35409.6 36087.8 36095.8 36662.3 37145.3 46569.3 46664.5 46970.3 48873.3 48888.8 9749.5 9823.1 10190.4 10200.3 10206.2 11756.5 12159.6 17750.2 17887.5 18036.1 14597.6 14915.4 14935.0 15217.4 15443.9 14297.4 14441.7 14475.9 14883.0 15038.8 12126.9 12278.0 15550.9 16105.4 16125.7 8974.7 9362.8 9952.4 9982.3 10054.0 14814.6 14938.4 15050.8 15316.5 15445.3 02:18:24 INFO - 2016-03-06 02:18:24,551 DEBUG : BROWSER_OUTPUT: 02:18:24 INFO - 2016-03-06 02:18:24,551 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5493.08 Median:6718.49 stddev:2807.82 (41.8%) stddev-sans-first:2799.99 02:18:24 INFO - 2016-03-06 02:18:24,552 DEBUG : BROWSER_OUTPUT: Values: 1541.9 1601.1 1611.1 1790.0 1889.1 7346.4 7735.9 7745.9 7755.7 7757.3 6948.1 7093.7 7467.8 7720.5 7754.8 2271.6 2300.9 2321.9 2323.6 2323.7 2019.3 2277.5 2294.1 2334.1 2337.6 2049.4 2226.0 2283.2 2301.9 2306.8 2246.8 2286.8 2289.6 2290.2 2305.8 2290.5 2294.4 2319.3 2319.6 2320.9 7729.9 7770.7 7786.7 7787.0 7797.0 4593.6 4684.2 4705.2 4705.7 4708.5 2957.7 2985.5 3030.1 3030.7 3035.3 994.5 998.4 1000.4 1008.1 1049.1 10634.8 10645.7 10658.1 10683.6 10693.3 4103.4 4132.9 4161.6 4169.4 4219.8 9178.9 9182.0 9183.3 9201.2 9215.8 4704.2 4714.0 4721.0 4730.9 4732.3 4259.5 4311.2 4313.3 4313.4 4314.5 3667.9 3687.6 3715.3 3716.7 3756.8 1084.1 1172.9 1174.1 1208.3 1222.5 1157.8 1216.3 1229.3 1443.1 1460.5 7406.4 7437.5 7449.4 7485.1 7488.4 1123.7 1130.4 1145.4 1148.7 1169.3 5845.1 5845.2 5852.4 5862.2 5893.3 8845.6 8863.2 9033.3 9082.6 9085.7 8973.0 8977.0 8978.5 8980.3 8988.9 7412.4 7532.4 7570.2 7589.0 7593.1 7481.1 7534.3 7539.7 7541.0 7546.4 8314.9 8352.7 8520.4 8550.7 8552.2 8479.4 8493.0 8501.9 8635.5 8654.2 6799.8 6859.8 6908.7 6935.9 6944.4 7662.6 7700.2 7703.8 7708.0 7710.7 6544.4 6966.5 7094.4 7139.5 7176.5 6583.8 6679.7 6939.9 7022.2 7022.3 7326.7 7339.5 7358.3 7363.5 7375.9 6757.3 6778.3 6803.2 6821.0 6823.5 6834.5 6836.4 6864.1 6868.7 6870.1 02:18:24 INFO - 2016-03-06 02:18:24,552 DEBUG : BROWSER_OUTPUT: 02:18:24 INFO - 2016-03-06 02:18:24,553 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5446.00 Median:6260.25 stddev:1643.64 (26.3%) stddev-sans-first:1603.27 02:18:24 INFO - 2016-03-06 02:18:24,553 DEBUG : BROWSER_OUTPUT: Values: 357.8 363.3 364.7 365.1 367.1 6070.6 6176.5 6180.8 6186.7 6192.7 6028.9 6029.0 6039.6 6040.2 6042.1 4518.7 4683.3 4694.7 4700.2 4705.9 4668.2 4677.9 4684.1 4685.0 4686.7 4426.7 4621.7 4640.6 4644.3 4651.9 4486.8 4519.8 4521.7 4522.5 4577.9 4021.3 4027.5 4038.8 4048.2 4054.9 5753.0 5792.6 5803.8 5808.8 5808.9 5170.9 5327.5 5336.4 5397.5 5426.6 6429.4 6437.7 6449.3 6451.7 6465.0 4483.1 4484.5 4485.0 4485.5 4485.6 6613.6 6672.1 6760.5 6767.1 6785.6 4631.0 4658.0 4661.5 4663.2 4665.4 4713.0 4714.8 4720.2 4720.3 4720.8 5429.5 5440.0 5440.5 5444.1 5451.8 6386.1 6512.6 6516.4 6519.2 6530.3 1641.2 1660.2 1662.4 1662.7 1664.8 1111.7 1112.1 1121.6 1124.6 1142.9 6321.8 6328.3 6331.2 6334.8 6336.2 6709.3 6714.4 6717.1 6722.8 6730.6 6236.0 6284.5 6323.4 6325.7 6327.1 3611.4 3634.9 3641.1 3641.7 3644.1 6881.8 6883.7 6892.9 6894.9 6907.4 6680.3 6723.9 6825.8 6862.3 6866.5 6888.2 6904.0 6956.7 6966.0 6979.5 6720.7 6749.4 6755.1 6760.2 6763.5 6536.9 6669.4 6685.5 6689.5 6689.9 6950.1 6952.1 6955.8 6957.9 6964.3 4693.5 4703.0 4704.5 4704.8 4709.4 6656.5 6720.9 6730.9 6765.7 6768.8 6572.7 6591.8 6594.1 6599.0 6599.6 6567.0 6574.4 6578.7 6581.6 6582.1 6347.5 6466.6 6505.2 6506.0 6507.1 6608.0 6616.9 6620.6 6631.0 6638.3 6457.1 6470.0 6476.4 6479.0 6481.8 02:18:24 INFO - 2016-03-06 02:18:24,553 DEBUG : BROWSER_OUTPUT: 02:18:24 INFO - 2016-03-06 02:18:24,554 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14339.00 Median:25282.44 stddev:16212.77 (64.1%) stddev-sans-first:16226.23 02:18:24 INFO - 2016-03-06 02:18:24,555 DEBUG : BROWSER_OUTPUT: Values: 769.0 808.3 848.0 900.6 907.7 17222.8 17566.0 17575.8 17608.2 17621.7 15802.6 15874.1 15877.4 15930.0 15930.7 745.1 757.8 880.7 894.5 913.8 887.2 905.7 908.5 914.5 915.6 926.9 941.0 941.2 942.3 943.5 768.4 781.3 919.1 940.4 941.2 687.2 693.3 695.2 698.4 701.1 14438.6 14578.3 14587.9 14614.8 14623.5 11925.5 12115.2 12715.8 12786.9 13119.6 10869.9 10911.3 10975.1 11138.4 11143.2 3662.0 3676.3 3693.4 3707.0 3774.1 47014.8 47069.2 47399.8 47440.3 47952.8 10393.6 10417.9 10513.7 10541.1 10728.5 18117.6 18163.9 18245.9 18267.3 18320.5 7804.0 7817.4 7878.3 7917.7 8031.3 4238.5 4251.5 4258.4 4261.5 4329.5 3043.1 3071.7 3087.4 3094.2 3348.9 608.1 612.4 617.4 620.1 623.3 595.9 708.1 709.2 709.6 731.2 8695.8 8920.2 9200.5 9204.0 9407.5 677.8 696.3 717.7 744.0 744.5 4211.2 4422.7 4427.9 4517.5 4588.3 56360.7 57243.7 57265.7 57398.7 57428.4 52047.5 52351.7 53916.2 54223.7 54399.5 46584.5 46797.3 47138.3 47152.1 47166.8 9026.8 9051.3 9078.4 9148.5 9283.2 34233.5 35155.1 35397.5 35474.3 35925.6 45042.5 45976.5 48695.0 49235.8 51335.0 11677.3 11701.2 11874.4 11893.2 12009.4 12687.7 12763.7 13180.6 13367.4 13764.4 10953.6 11653.1 11718.5 11803.2 11868.2 11090.0 11255.6 11304.9 11352.1 11483.2 10836.3 10939.3 11233.4 11745.9 11763.1 9405.2 9505.5 9602.7 9907.1 10235.9 9905.3 10160.6 10162.4 10180.4 10226.9 02:18:24 INFO - 2016-03-06 02:18:24,556 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:18:24 INFO - 2016-03-06 02:18:24,556 DEBUG : BROWSER_OUTPUT: 02:18:25 INFO - 2016-03-06 02:18:25,163 INFO : Browser exited with error code: 0 02:18:25 INFO - 2016-03-06 02:18:25,182 INFO : Completed test dromaeo_css (00:18:32) 02:18:25 INFO - 2016-03-06 02:18:25,182 INFO : Starting test kraken 02:18:25 INFO - 2016-03-06 02:18:25,182 DEBUG : operating with platform_type : linux_ 02:18:25 INFO - 2016-03-06 02:18:25,182 INFO : Initialising browser for kraken test... 02:18:25 INFO - 2016-03-06 02:18:25,188 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvL4Y_P/profile http://localhost:51842/getInfo.html 02:18:29 INFO - 2016-03-06 02:18:29,514 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:18:29 INFO - 2016-03-06 02:18:29,515 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:18:29 INFO - 2016-03-06 02:18:29,515 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:18:29 INFO - 2016-03-06 02:18:29,515 DEBUG : BROWSER_OUTPUT: __metrics 02:18:29 INFO - 2016-03-06 02:18:29,672 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:18:31 INFO - 2016-03-06 02:18:31,127 INFO : Browser initialized. 02:18:31 INFO - 2016-03-06 02:18:31,128 INFO : Running cycle 1/1 for kraken test... 02:18:31 INFO - 2016-03-06 02:18:31,128 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvL4Y_P/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:18:42 INFO - 2016-03-06 02:18:42,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 132685824 02:18:42 INFO - 2016-03-06 02:18:42,794 DEBUG : BROWSER_OUTPUT: 02:18:45 INFO - 2016-03-06 02:18:45,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51842/tests/kraken/driver.html?testName=audio-beat-detection) 02:18:45 INFO - 2016-03-06 02:18:45,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 163717120 02:18:45 INFO - 2016-03-06 02:18:45,806 DEBUG : BROWSER_OUTPUT: 02:18:48 INFO - 2016-03-06 02:18:48,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51842/tests/kraken/driver.html?testName=audio-dft) 02:18:48 INFO - 2016-03-06 02:18:48,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 162975744 02:18:48 INFO - 2016-03-06 02:18:48,927 DEBUG : BROWSER_OUTPUT: 02:18:51 INFO - 2016-03-06 02:18:51,709 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51842/tests/kraken/driver.html?testName=audio-fft) 02:18:52 INFO - 2016-03-06 02:18:52,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 159047680 02:18:52 INFO - 2016-03-06 02:18:52,271 DEBUG : BROWSER_OUTPUT: 02:18:54 INFO - 2016-03-06 02:18:54,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51842/tests/kraken/driver.html?testName=audio-oscillator) 02:18:54 INFO - 2016-03-06 02:18:54,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 160145408 02:18:54 INFO - 2016-03-06 02:18:54,800 DEBUG : BROWSER_OUTPUT: 02:18:56 INFO - 2016-03-06 02:18:56,999 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51842/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:18:57 INFO - 2016-03-06 02:18:57,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 158584832 02:18:57 INFO - 2016-03-06 02:18:57,568 DEBUG : BROWSER_OUTPUT: 02:19:00 INFO - 2016-03-06 02:19:00,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51842/tests/kraken/driver.html?testName=imaging-darkroom) 02:19:00 INFO - 2016-03-06 02:19:00,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 159629312 02:19:00 INFO - 2016-03-06 02:19:00,956 DEBUG : BROWSER_OUTPUT: 02:19:04 INFO - 2016-03-06 02:19:04,323 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51842/tests/kraken/driver.html?testName=imaging-desaturate) 02:19:04 INFO - 2016-03-06 02:19:04,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 160096256 02:19:04 INFO - 2016-03-06 02:19:04,904 DEBUG : BROWSER_OUTPUT: 02:19:07 INFO - 2016-03-06 02:19:07,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51842/tests/kraken/driver.html?testName=json-parse-financial) 02:19:08 INFO - 2016-03-06 02:19:08,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 160526336 02:19:08 INFO - 2016-03-06 02:19:08,147 DEBUG : BROWSER_OUTPUT: 02:19:09 INFO - 2016-03-06 02:19:09,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51842/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:19:10 INFO - 2016-03-06 02:19:10,277 DEBUG : BROWSER_OUTPUT: RSS: Main: 165216256 02:19:10 INFO - 2016-03-06 02:19:10,277 DEBUG : BROWSER_OUTPUT: 02:19:12 INFO - 2016-03-06 02:19:12,011 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51842/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:19:12 INFO - 2016-03-06 02:19:12,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 164118528 02:19:12 INFO - 2016-03-06 02:19:12,606 DEBUG : BROWSER_OUTPUT: 02:19:14 INFO - 2016-03-06 02:19:14,589 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51842/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:19:15 INFO - 2016-03-06 02:19:15,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 169136128 02:19:15 INFO - 2016-03-06 02:19:15,162 DEBUG : BROWSER_OUTPUT: 02:19:17 INFO - 2016-03-06 02:19:17,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:19:18 INFO - 2016-03-06 02:19:18,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 176734208 02:19:18 INFO - 2016-03-06 02:19:18,074 DEBUG : BROWSER_OUTPUT: 02:19:20 INFO - 2016-03-06 02:19:20,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:19:21 INFO - 2016-03-06 02:19:21,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 174972928 02:19:21 INFO - 2016-03-06 02:19:21,184 DEBUG : BROWSER_OUTPUT: 02:19:22 INFO - 2016-03-06 02:19:22,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51842/tests/kraken/driver.html?testName=ai-astar) 02:19:23 INFO - 2016-03-06 02:19:23,088 DEBUG : BROWSER_OUTPUT: RSS: Main: 234119168 02:19:23 INFO - 2016-03-06 02:19:23,089 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-03-06 02:19:23,092 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:19:23 INFO - 2016-03-06 02:19:23,092 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:19:23 INFO - 2016-03-06 02:19:23,092 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:19:23 INFO - 2016-03-06 02:19:23,092 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:19:23 INFO - 2016-03-06 02:19:23,093 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;102;108;109;109;98;110;108;109 02:19:23 INFO - 2016-03-06 02:19:23,093 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;121;144;155;127;144;150;130;162;122 02:19:23 INFO - 2016-03-06 02:19:23,093 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;158;160;160;158;160;161;161;159;159 02:19:23 INFO - 2016-03-06 02:19:23,093 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;72;72;158;70;71;71;73;143;70 02:19:23 INFO - 2016-03-06 02:19:23,093 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;139;92;93;93;140;92;93;138 02:19:23 INFO - 2016-03-06 02:19:23,093 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;108;110;109;110;110;109;109;109;109;109 02:19:23 INFO - 2016-03-06 02:19:23,093 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;147;146;146;146;146;146;145 02:19:23 INFO - 2016-03-06 02:19:23,094 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;96;95;95;95;95 02:19:23 INFO - 2016-03-06 02:19:23,094 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;58;57;58;59;59;58;59;56;57 02:19:23 INFO - 2016-03-06 02:19:23,094 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;63;64;64;65;67;64;64;64 02:19:23 INFO - 2016-03-06 02:19:23,094 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;76;79;77;77;85;79;80;79;79 02:19:23 INFO - 2016-03-06 02:19:23,094 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;113;119;111;113;114;128;114;118;112 02:19:23 INFO - 2016-03-06 02:19:23,094 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;148;146;145;139;153;134;144;146;143;152 02:19:23 INFO - 2016-03-06 02:19:23,094 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;64;66;65;64;65;66;62;64;66 02:19:23 INFO - 2016-03-06 02:19:23,094 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:19:23 INFO - 2016-03-06 02:19:23,095 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:19:23 INFO - 2016-03-06 02:19:23,095 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,904 02:19:23 INFO - 2016-03-06 02:19:23,095 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:19:23 INFO - 2016-03-06 02:19:23,095 DEBUG : BROWSER_OUTPUT: __startTimestamp1457259563090__endTimestamp 02:19:23 INFO - 2016-03-06 02:19:23,095 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-03-06 02:19:23,096 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:19:23 INFO - 2016-03-06 02:19:23,096 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:19:23 INFO - 2016-03-06 02:19:23,096 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-03-06 02:19:23,097 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.00 Median:109.00 stddev:3.86 (3.5%) stddev-sans-first:4.08 02:19:23 INFO - 2016-03-06 02:19:23,098 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 102.0 108.0 109.0 109.0 98.0 110.0 108.0 109.0 02:19:23 INFO - 2016-03-06 02:19:23,098 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-03-06 02:19:23,098 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.50 Median:147.00 stddev:14.50 (9.9%) stddev-sans-first:14.97 02:19:23 INFO - 2016-03-06 02:19:23,098 DEBUG : BROWSER_OUTPUT: Values: 150.0 121.0 144.0 155.0 127.0 144.0 150.0 130.0 162.0 122.0 02:19:23 INFO - 2016-03-06 02:19:23,098 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-03-06 02:19:23,098 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.60 Median:160.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 02:19:23 INFO - 2016-03-06 02:19:23,098 DEBUG : BROWSER_OUTPUT: Values: 160.0 158.0 160.0 160.0 158.0 160.0 161.0 161.0 159.0 159.0 02:19:23 INFO - 2016-03-06 02:19:23,098 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-03-06 02:19:23,098 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.40 Median:71.50 stddev:33.47 (46.8%) stddev-sans-first:35.14 02:19:23 INFO - 2016-03-06 02:19:23,098 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 72.0 158.0 70.0 71.0 71.0 73.0 143.0 70.0 02:19:23 INFO - 2016-03-06 02:19:23,098 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-03-06 02:19:23,098 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.60 Median:93.00 stddev:22.37 (24.1%) stddev-sans-first:23.18 02:19:23 INFO - 2016-03-06 02:19:23,098 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 139.0 92.0 93.0 93.0 140.0 92.0 93.0 138.0 02:19:23 INFO - 2016-03-06 02:19:23,098 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-03-06 02:19:23,099 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.63 (0.6%) stddev-sans-first:0.50 02:19:23 INFO - 2016-03-06 02:19:23,099 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 02:19:23 INFO - 2016-03-06 02:19:23,099 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-03-06 02:19:23,099 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 02:19:23 INFO - 2016-03-06 02:19:23,099 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 147.0 146.0 146.0 146.0 146.0 146.0 145.0 02:19:23 INFO - 2016-03-06 02:19:23,099 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-03-06 02:19:23,099 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 02:19:23 INFO - 2016-03-06 02:19:23,100 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 02:19:23 INFO - 2016-03-06 02:19:23,100 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-03-06 02:19:23,100 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.00 stddev:0.99 (1.7%) stddev-sans-first:1.05 02:19:23 INFO - 2016-03-06 02:19:23,100 DEBUG : BROWSER_OUTPUT: Values: 58.0 58.0 57.0 58.0 59.0 59.0 58.0 59.0 56.0 57.0 02:19:23 INFO - 2016-03-06 02:19:23,100 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-03-06 02:19:23,100 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:1.06 (1.7%) stddev-sans-first:1.12 02:19:23 INFO - 2016-03-06 02:19:23,100 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 63.0 64.0 64.0 65.0 67.0 64.0 64.0 64.0 02:19:23 INFO - 2016-03-06 02:19:23,101 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-03-06 02:19:23,101 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:2.47 (3.1%) stddev-sans-first:2.60 02:19:23 INFO - 2016-03-06 02:19:23,101 DEBUG : BROWSER_OUTPUT: Values: 78.0 76.0 79.0 77.0 77.0 85.0 79.0 80.0 79.0 79.0 02:19:23 INFO - 2016-03-06 02:19:23,101 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-03-06 02:19:23,101 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.50 Median:114.00 stddev:5.06 (4.4%) stddev-sans-first:5.29 02:19:23 INFO - 2016-03-06 02:19:23,101 DEBUG : BROWSER_OUTPUT: Values: 113.0 113.0 119.0 111.0 113.0 114.0 128.0 114.0 118.0 112.0 02:19:23 INFO - 2016-03-06 02:19:23,101 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-03-06 02:19:23,101 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.00 Median:146.00 stddev:5.64 (3.9%) stddev-sans-first:5.87 02:19:23 INFO - 2016-03-06 02:19:23,101 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 145.0 139.0 153.0 134.0 144.0 146.0 143.0 152.0 02:19:23 INFO - 2016-03-06 02:19:23,101 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-03-06 02:19:23,101 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:1.26 (1.9%) stddev-sans-first:1.32 02:19:23 INFO - 2016-03-06 02:19:23,101 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 66.0 65.0 64.0 65.0 66.0 62.0 64.0 66.0 02:19:23 INFO - 2016-03-06 02:19:23,101 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:19:23 INFO - 2016-03-06 02:19:23,101 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2016-03-06 02:19:23,831 INFO : Browser exited with error code: 0 02:19:23 INFO - 2016-03-06 02:19:23,879 INFO : Completed test kraken (00:00:58) 02:19:23 INFO - 2016-03-06 02:19:23,879 INFO : Starting test v8_7 02:19:23 INFO - 2016-03-06 02:19:23,879 DEBUG : operating with platform_type : linux_ 02:19:23 INFO - 2016-03-06 02:19:23,880 INFO : Initialising browser for v8_7 test... 02:19:23 INFO - 2016-03-06 02:19:23,886 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprm8Slp/profile http://localhost:51842/getInfo.html 02:19:28 INFO - 2016-03-06 02:19:28,290 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:19:28 INFO - 2016-03-06 02:19:28,290 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:19:28 INFO - 2016-03-06 02:19:28,290 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:19:28 INFO - 2016-03-06 02:19:28,290 DEBUG : BROWSER_OUTPUT: __metrics 02:19:28 INFO - 2016-03-06 02:19:28,452 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:19:29 INFO - 2016-03-06 02:19:29,807 INFO : Browser initialized. 02:19:29 INFO - 2016-03-06 02:19:29,808 INFO : Running cycle 1/1 for v8_7 test... 02:19:29 INFO - 2016-03-06 02:19:29,808 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprm8Slp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:19:41 INFO - 2016-03-06 02:19:41,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 132190208 02:19:41 INFO - 2016-03-06 02:19:41,438 DEBUG : BROWSER_OUTPUT: 02:20:02 INFO - 2016-03-06 02:20:02,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51842/tests/v8_7/run.html (next: http://localhost:51842/tests/v8_7/run.html) 02:20:03 INFO - 2016-03-06 02:20:03,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 426409984 02:20:03 INFO - 2016-03-06 02:20:03,072 DEBUG : BROWSER_OUTPUT: 02:20:03 INFO - 2016-03-06 02:20:03,072 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:20:03 INFO - 2016-03-06 02:20:03,072 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:20:03 INFO - 2016-03-06 02:20:03,072 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:20:03 INFO - 2016-03-06 02:20:03,072 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:20:03 INFO - 2016-03-06 02:20:03,073 DEBUG : BROWSER_OUTPUT: |0;Richards;171.909919202338 02:20:03 INFO - 2016-03-06 02:20:03,073 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.7175094712568 02:20:03 INFO - 2016-03-06 02:20:03,073 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.09572983533354 02:20:03 INFO - 2016-03-06 02:20:03,073 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5138.461538461538 02:20:03 INFO - 2016-03-06 02:20:03,073 DEBUG : BROWSER_OUTPUT: |4;RayTrace;990.0990099009902 02:20:03 INFO - 2016-03-06 02:20:03,073 DEBUG : BROWSER_OUTPUT: |5;Earley;544.069640914037 02:20:03 INFO - 2016-03-06 02:20:03,074 DEBUG : BROWSER_OUTPUT: |6;Boyer;10536.842105263158 02:20:03 INFO - 2016-03-06 02:20:03,074 DEBUG : BROWSER_OUTPUT: |7;RegExp;24463.414634146342 02:20:03 INFO - 2016-03-06 02:20:03,074 DEBUG : BROWSER_OUTPUT: |8;Splay;512.2950819672132 02:20:03 INFO - 2016-03-06 02:20:03,074 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 02:20:03 INFO - 2016-03-06 02:20:03,074 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:20:03 INFO - 2016-03-06 02:20:03,074 DEBUG : BROWSER_OUTPUT: __startTimestamp1457259603071__endTimestamp 02:20:03 INFO - 2016-03-06 02:20:03,075 DEBUG : BROWSER_OUTPUT: 02:20:03 INFO - 2016-03-06 02:20:03,075 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:20:03 INFO - 2016-03-06 02:20:03,075 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:20:03 INFO - 2016-03-06 02:20:03,075 DEBUG : BROWSER_OUTPUT: 02:20:03 INFO - 2016-03-06 02:20:03,075 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:171.91 Median:171.91 stddev:0.00 (0.0%) 02:20:03 INFO - 2016-03-06 02:20:03,076 DEBUG : BROWSER_OUTPUT: Values: 171.9 02:20:03 INFO - 2016-03-06 02:20:03,076 DEBUG : BROWSER_OUTPUT: 02:20:03 INFO - 2016-03-06 02:20:03,076 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.72 Median:164.72 stddev:0.00 (0.0%) 02:20:03 INFO - 2016-03-06 02:20:03,076 DEBUG : BROWSER_OUTPUT: Values: 164.7 02:20:03 INFO - 2016-03-06 02:20:03,076 DEBUG : BROWSER_OUTPUT: 02:20:03 INFO - 2016-03-06 02:20:03,076 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 02:20:03 INFO - 2016-03-06 02:20:03,077 DEBUG : BROWSER_OUTPUT: Values: 279.1 02:20:03 INFO - 2016-03-06 02:20:03,077 DEBUG : BROWSER_OUTPUT: 02:20:03 INFO - 2016-03-06 02:20:03,077 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 02:20:03 INFO - 2016-03-06 02:20:03,077 DEBUG : BROWSER_OUTPUT: Values: 5138.5 02:20:03 INFO - 2016-03-06 02:20:03,077 DEBUG : BROWSER_OUTPUT: 02:20:03 INFO - 2016-03-06 02:20:03,077 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:990.10 Median:990.10 stddev:0.00 (0.0%) 02:20:03 INFO - 2016-03-06 02:20:03,079 DEBUG : BROWSER_OUTPUT: Values: 990.1 02:20:03 INFO - 2016-03-06 02:20:03,079 DEBUG : BROWSER_OUTPUT: 02:20:03 INFO - 2016-03-06 02:20:03,079 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:544.07 Median:544.07 stddev:0.00 (0.0%) 02:20:03 INFO - 2016-03-06 02:20:03,079 DEBUG : BROWSER_OUTPUT: Values: 544.1 02:20:03 INFO - 2016-03-06 02:20:03,079 DEBUG : BROWSER_OUTPUT: 02:20:03 INFO - 2016-03-06 02:20:03,079 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10536.84 Median:10536.84 stddev:0.00 (0.0%) 02:20:03 INFO - 2016-03-06 02:20:03,079 DEBUG : BROWSER_OUTPUT: Values: 10536.8 02:20:03 INFO - 2016-03-06 02:20:03,079 DEBUG : BROWSER_OUTPUT: 02:20:03 INFO - 2016-03-06 02:20:03,079 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24463.41 Median:24463.41 stddev:0.00 (0.0%) 02:20:03 INFO - 2016-03-06 02:20:03,079 DEBUG : BROWSER_OUTPUT: Values: 24463.4 02:20:03 INFO - 2016-03-06 02:20:03,079 DEBUG : BROWSER_OUTPUT: 02:20:03 INFO - 2016-03-06 02:20:03,080 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:512.30 Median:512.30 stddev:0.00 (0.0%) 02:20:03 INFO - 2016-03-06 02:20:03,080 DEBUG : BROWSER_OUTPUT: Values: 512.3 02:20:03 INFO - 2016-03-06 02:20:03,080 DEBUG : BROWSER_OUTPUT: 02:20:03 INFO - 2016-03-06 02:20:03,080 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 02:20:03 INFO - 2016-03-06 02:20:03,080 DEBUG : BROWSER_OUTPUT: Values: 4826.9 02:20:03 INFO - 2016-03-06 02:20:03,080 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:20:03 INFO - 2016-03-06 02:20:03,080 DEBUG : BROWSER_OUTPUT: 02:20:03 INFO - 2016-03-06 02:20:03,883 INFO : Browser exited with error code: 0 02:20:03 INFO - 2016-03-06 02:20:03,897 INFO : Completed test v8_7 (00:00:40) 02:20:04 INFO - 2016-03-06 02:20:04,065 INFO : Completed test suite (00:20:11) 02:20:04 INFO - 2016-03-06 02:20:04,065 DEBUG : Working with test: dromaeo_css 02:20:04 INFO - 2016-03-06 02:20:04,065 DEBUG : Generating results file: dromaeo_css 02:20:04 INFO - 2016-03-06 02:20:04,066 DEBUG : Working with test: kraken 02:20:04 INFO - 2016-03-06 02:20:04,066 DEBUG : Generating results file: kraken 02:20:04 INFO - 2016-03-06 02:20:04,066 INFO : javascript benchmark 02:20:04 INFO - 2016-03-06 02:20:04,067 DEBUG : Working with test: v8_7 02:20:04 INFO - 2016-03-06 02:20:04,067 DEBUG : Generating results file: v8_7 02:20:04 INFO - 2016-03-06 02:20:04,067 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:20:07 INFO - 2016-03-06 02:20:07,481 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 02:20:07 INFO - 2016-03-06 02:20:07,482 DEBUG : process_Request line: dromaeo_css 7228.60 graph.html#tests=[[72,53,35]] 02:20:07 INFO - 2016-03-06 02:20:07,482 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:20:07 INFO - 2016-03-06 02:20:07,627 DEBUG : process_Request line: kraken 1477.50 graph.html#tests=[[232,53,35]] 02:20:07 INFO - 2016-03-06 02:20:07,627 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:20:07 INFO - 2016-03-06 02:20:07,733 DEBUG : process_Request line: v8_7 23171.61 graph.html#tests=[[230,53,35]] 02:20:07 INFO - 2016-03-06 02:20:07,735 INFO : javascript benchmark 02:20:07 INFO - 2016-03-06 02:20:07,738 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3270.362279355526, 3349.363620912028, 3361.697447229749, 3378.0203740915135, 3391.8473668684915, 5413.593980451467, 5477.972610136943, 5487.039768040587, 5493.45065493451, 5506.669599824013, 5483.972580137103, 5487.286652735149, 5535.916961245584, 5544.77820887164, 5557.110862262039, 4791.089692958344, 5000.149974504325, 5031.0, 5114.925865568235, 5119.206522988924, 4967.801287948478, 5029.497050294978, 5033.446320904697, 5033.949660503403, 5034.144195486758, 4856.4172299323955, 4885.780139893695, 4971.179755340365, 5004.549590536851, 5005.974970125144, 5001.6998980061135, 5051.823186188466, 5054.01446717892, 5056.721880296583, 5080.13637681595, 4750.978539613965, 4956.454789973136, 4981.402231732179, 4991.950080499221, 5025.572826309768, 5176.456472070416, 5223.6343455958095, 5334.226537152092, 5336.573074154058, 5339.973300133474, 5883.8529036774, 5908.143319218732, 5934.5845790794665, 5939.316978547436, 5942.316633587149, 5644.266245388073, 5727.9427205727825, 5954.077118046666, 5975.163477113208, 5978.432048955342, 5406.135018397077, 5458.699771512565, 5459.317585301837, 5463.125899856004, 5496.0, 5938.851528711731, 5956.047032474783, 5961.374055724174, 5964.582479226413, 5966.582339236299, 5568.9443105569235, 5604.41153678866, 5658.575606829504, 5730.226419433323, 5731.140328950607, 5876.6180198286975, 5884.0585506318785, 5887.882242355129, 5889.440503152194, 5937.9406205937385, 5816.73824677882, 5861.794837180763, 5862.530997520188, 5863.824085277449, 5867.70661466925, 5592.636478628876, 5701.515371193495, 5702.7433765480655, 5816.302043754777, 5875.853103672357, 4480.103979204172, 4485.282354823213, 4487.371767952489, 4504.346869703874, 4505.414296141481, 4062.6749860011128, 4065.6747460203114, 4068.0, 4093.836246550164, 4098.713090083726, 5302.443243459458, 5407.134858422713, 5472.425395333512, 5576.302962129734, 5609.046462101453, 5812.186293918855, 5936.13925980739, 5940.198073260054, 5940.762369505258, 5942.524598032147, 5402.729863506809, 5553.8333849984565, 5584.832455026356, 5589.860253493695, 5597.468240517144, 5028.044671512401, 5103.260027296022, 5204.76578553966, 5210.817621383309, 5232.058229518647, 5976.402359764076, 6025.9096113558335, 6030.698465076729, 6032.034874420159, 6043.8791224175275, 5682.659040457585, 5779.393163717918, 5916.408359164136, 5916.852078698067, 5924.733386997682, 6029.974904266373, 6100.4326159576185, 6115.249312096529, 6124.510039196943, 6128.601640893327, 5792.855178620568, 5830.2420685310635, 5835.241418615553, 5841.211436456024, 5862.794802181903, 5704.600677952503, 5804.245448091721, 5948.762049518144, 5954.672493012926, 5957.940420595739, 5721.742521586455, 5805.651660900359, 5814.796482123105, 5817.650940943557, 5855.59010869235, 5777.075667893117, 5803.274590676166, 5822.0, 5832.591718579828, 5834.649921004753, 5500.972495137498, 5520.420355862737, 5552.056150454352, 5719.142128680564, 5730.140478928194, 5797.246357973605, 5821.94178058231, 5824.912626310524, 5825.271841019872, 5829.300483941955, 5670.036093863971, 5699.059655156852, 5709.771609135588, 5717.656940583578, 5718.742656580547], "unit": "ms", "name": "dojo.html", "value": 5417.470050101676}, {"lowerIsBetter": false, "replicates": [578.8842231553688, 621.5307442880625, 630.7792272704556, 631.5768435148451, 695.25260345129, 32730.0, 33201.667983320156, 40661.18677626449, 40845.0, 40973.7951310243, 44549.331760023626, 44739.0, 44776.0, 44978.77510612451, 45019.0, 8063.475874068196, 9118.452892826435, 9319.534023298842, 9320.0, 9321.114494123047, 8272.669093236264, 10962.397068161248, 11230.382328971904, 11238.49426775793, 11243.66269011931, 10914.0, 11004.834927476095, 11016.283941543774, 11026.062784663312, 11026.889731102707, 10950.178736594788, 11055.502502387331, 11059.557617695282, 11066.723331916686, 11067.169962252823, 10830.72923176919, 10986.890131098666, 11005.449727513593, 11005.779884402267, 11006.394648294341, 42178.78910605458, 42535.0, 42599.57400425987, 42632.36051459231, 42643.0, 3720.8883733488037, 3956.940645890314, 4131.327493462447, 4227.656833634259, 4370.497392799837, 31890.202744931332, 32052.358952820814, 32169.678303217137, 32346.676533234837, 32396.6760332396, 4027.0939038716347, 4053.5743746906446, 4078.5309689385804, 4098.610631989956, 4192.538820729717, 282737.0, 285536.5723171392, 286105.0, 286304.0, 286524.0, 61401.69299153476, 62047.6897615509, 62544.37455625476, 69598.65200673965, 71213.28786712067, 63459.68270158712, 63607.0, 63898.68050659717, 63975.0, 64164.0, 16240.431584894472, 16439.91780041092, 16440.095794731165, 16445.25996330168, 16450.34198632065, 12275.570355037531, 12275.877241227474, 12360.01119910423, 12369.752604947851, 12486.0, 20744.0, 20977.160913563286, 21031.474213144487, 21034.0, 21081.472963175736, 8398.622062007224, 8589.226969572768, 8623.180797824196, 8641.913580864111, 8679.088695686989, 971.2181693736469, 1076.1928553584812, 1082.3127314155568, 1097.9898493386104, 1112.7329440934118, 29162.0, 29423.11730648084, 29473.263168420963, 30092.849535752182, 30291.848540757597, 1154.099802154321, 1155.7746239483388, 1221.6151912147645, 1238.158052524292, 1260.6281147061638, 12901.935490322488, 15216.163111029, 15524.301406436738, 15946.282417291017, 16193.838061619468, 368764.0, 371702.0, 372446.0, 372874.0, 376918.0, 56589.71705141448, 56862.147067794016, 56901.71549142228, 56919.0, 56968.14547781787, 1358.185088946624, 1394.3934388540815, 1444.5594093801492, 1467.2736995187238, 1482.3403585404392, 26764.464710705288, 28500.85749571239, 28786.568201476577, 29390.706092939654, 30293.242668933453, 52274.477255226964, 53370.0, 53399.0, 53456.198157028455, 53476.46523534715, 209302.0, 209661.0, 210403.0, 210847.0, 210915.0, 32897.342053158325, 32922.83538582292, 32945.835270823496, 32961.34077318488, 33355.66510344252, 45687.0, 45764.54235457603, 45938.540614593425, 46260.0, 46827.765861170476, 36794.26411471809, 37087.0, 37267.6273237275, 37553.24893502169, 38275.617243827204, 37529.6247037537, 37633.43549846809, 37646.24707505889, 37652.81173594115, 38066.619333807415, 36324.09189770277, 36836.44745328876, 37197.814010929775, 37255.25489490249, 37325.0, 33074.0, 33119.172020699676, 33343.33313333671, 33377.332453351286, 33475.33049339048, 25417.364565886, 26629.600555992063, 26687.599686004338, 26759.86620066965, 26803.73196268012], "unit": "ms", "name": "ext.html", "value": 19859.57352133477}, {"lowerIsBetter": false, "replicates": [377.11566376846304, 378.3492393083895, 378.7689509399266, 379.69902391507486, 384.6269118954614, 15254.389824407039, 15551.22243887804, 17444.215010324533, 19150.90424547877, 19165.04174791262, 13769.793453098211, 16751.83248167518, 16892.324307027706, 17400.0, 17418.825811741877, 5507.366652834915, 5511.944880551193, 5628.465295796893, 5633.577481688869, 5643.548516118701, 4305.311150215966, 4392.516823149451, 5509.063459211923, 5550.389457159709, 6094.055421409666, 6138.938610613904, 6174.567780255384, 6201.782937597185, 6203.0, 6207.81376558704, 6013.338532761392, 6121.724522396503, 6159.1993040904845, 6168.84577885552, 6173.166622505949, 5431.185322201662, 5465.836024919259, 5474.972625136888, 5480.561555075625, 5481.451854814526, 19983.600327993503, 21309.467263318387, 21547.784522154736, 22033.779662203335, 22139.778602213933, 2392.605220138675, 2412.2522018174423, 2431.3678443604613, 2511.4769117398228, 2528.216252961588, 13659.112157709716, 14003.71992560143, 14084.507042253574, 14202.502912398017, 14226.430942762277, 1942.2328180368816, 1964.8526360523017, 1978.5053736565858, 1986.8311193548566, 2022.6763717805227, 59501.0, 60869.6956515219, 60957.0, 61014.0, 62415.37584624141, 10399.688009359732, 10620.309679870783, 10720.731981700364, 10749.0, 10775.730606734738, 14167.0, 14266.714665706628, 14271.857281427261, 14278.928605356907, 14279.357428915724, 7727.150013498511, 7782.961085194538, 8041.035075790943, 8068.394870384627, 8082.676692932335, 7686.231376862381, 7702.075750909927, 7749.263819937097, 7753.767386978399, 7787.961060194662, 6314.684265786692, 6321.462675672619, 6348.1430006949395, 6383.234011918506, 6386.329435409308, 1721.8708596855286, 1734.2282684205406, 1808.4665023818006, 1831.3407173417559, 1834.8348648621688, 450.00324281716155, 464.6190124098207, 476.69967920210047, 1034.943078130695, 1096.090245096568, 9732.951335243279, 10792.082672972729, 11050.281731687415, 11429.828552571718, 11531.13516486267, 468.8593421973463, 477.3841744150077, 479.9976000120047, 485.5557165193879, 486.02794411177643, 6148.200733904653, 6226.128342032119, 6269.968650156811, 6285.277193122849, 6285.937140628626, 470765.0, 477666.0, 482564.0, 546450.0, 727412.0, 80581.59709201533, 83322.0, 87085.0, 87508.5624571873, 88144.55927720321, 1172.1209093180114, 1194.566361487881, 1205.8854408831146, 1220.2666028096999, 1226.405193481161, 16475.58811029734, 16481.658676370476, 16489.422870199964, 16567.50297491077, 16681.74977375316, 35409.64590354064, 36087.819560902026, 36095.81952090223, 36662.266754664226, 37145.25709485849, 46569.3014604788, 46664.53335466602, 46970.29544556766, 48873.26690099722, 48888.75555622199, 9749.463779492196, 9823.115919567274, 10190.388576685422, 10200.3369780964, 10206.183505319408, 11756.470958806703, 12159.635210943687, 17750.20124094393, 17887.463376098738, 18036.09819508993, 14597.562073137822, 14915.403383864525, 14935.0, 15217.391304348144, 15443.922780386027, 14297.428102875769, 14441.711165776836, 14475.85524144745, 14883.0, 15038.774418383951, 12126.939365303117, 12277.956373707977, 15550.922245388701, 16105.355785768437, 16125.67748645044, 8974.730758077269, 9362.812743745224, 9952.353097048668, 9982.251331150337, 10054.0, 14814.555563333117, 14938.402463901322, 15050.849491504945, 15316.463923762614, 15445.304961276544], "unit": "ms", "name": "jquery.html", "value": 8917.167150445142}, {"lowerIsBetter": false, "replicates": [1541.8920675552708, 1601.126681782315, 1611.1299898055051, 1789.9821001789987, 1889.1215584753088, 7346.412287017032, 7735.9226407735905, 7745.883811742814, 7755.7285495007545, 7757.3406260467855, 6948.096747422828, 7093.71625134994, 7467.775966720994, 7720.498167619101, 7754.767356979286, 2271.6138256496392, 2300.850444721096, 2321.907123715058, 2323.5585238804656, 2323.6514522821544, 2019.3437132931783, 2277.487565297811, 2294.093832935989, 2334.1480359668685, 2337.6026075567192, 2049.4364049886253, 2226.0428015953134, 2283.178055899883, 2301.8849057547054, 2306.7923886850263, 2246.7753224677404, 2286.805621522164, 2289.6222123349626, 2290.1640901071155, 2305.7809508096702, 2290.4960908600083, 2294.4149241943196, 2319.2926157521947, 2319.5824751544715, 2320.9419764505856, 7729.922700772977, 7770.689172433096, 7786.727464538714, 7787.0, 7797.0, 4593.586577208034, 4684.227102528079, 4705.223638099709, 4705.670603057787, 4708.4820669726305, 2957.6746557878614, 2985.5221665275826, 3030.0606811888383, 3030.6666266710645, 3035.3322269100763, 994.5176589354157, 998.4059484606647, 1000.4447531619948, 1008.1128606825946, 1049.1449468683, 10634.787304253949, 10645.680629581126, 10658.094062004662, 10683.572657093784, 10693.251472396936, 4103.384492326175, 4132.896677583084, 4161.583841615875, 4169.437125988014, 4219.810108545123, 9178.86231706525, 9182.035886231983, 9183.265338772882, 9201.171894529525, 9215.815683686289, 4704.223803072523, 4713.952860471351, 4721.0, 4730.858074257778, 4732.266498692708, 4259.467566554181, 4311.159323931804, 4313.266744653416, 4313.396124542566, 4314.482262128565, 3667.9266414671556, 3687.649673281034, 3715.3126671565847, 3716.6840818530186, 3756.849726010929, 1084.0839490630406, 1172.9120315976336, 1174.1370092981651, 1208.2569219929856, 1222.5232159457819, 1157.8494795676509, 1216.3492531495608, 1229.33001514175, 1443.0547991065869, 1460.5034288342015, 7406.407487400995, 7437.479376443705, 7449.366803821627, 7485.139208990927, 7488.438367122488, 1123.6741345010018, 1130.4460814200982, 1145.3986657004973, 1148.7472755993667, 1169.257521473853, 5845.1232315153065, 5845.152452894392, 5852.385499522489, 5862.237909071879, 5893.322267939242, 8845.601947912231, 8863.2466240369, 9033.322500812465, 9082.591283392263, 9085.682001129928, 8973.0, 8977.012528621846, 8978.506182160045, 8980.326475514363, 8988.910110898807, 7412.369948554433, 7532.359749421251, 7570.242975702496, 7588.962055189799, 7593.088829340514, 7481.064866891638, 7534.321911028033, 7539.736109236151, 7541.0, 7546.358559522502, 8314.916850831414, 8352.665893364197, 8520.360972926932, 8550.74347769568, 8552.187542183483, 8479.40644154928, 8492.957535212285, 8501.872471912802, 8635.481871087755, 8654.177853103945, 6799.776040312791, 6859.828504287233, 6908.654567271717, 6935.861282774417, 6944.375006249462, 7662.578558179353, 7700.191479894755, 7703.807404814925, 7708.03649543807, 7710.691572337044, 6544.44372228366, 6966.5471744336455, 7094.432445404458, 7139.500234983501, 7176.533525320838, 6583.835404114935, 6679.732810687518, 6939.930600693929, 7022.157341119098, 7022.297770222936, 7326.670299836626, 7339.522931009467, 7358.264173582599, 7363.521371110861, 7375.889361659472, 6757.256701762901, 6778.288279730755, 6803.183617965876, 6821.045053692388, 6823.454123669995, 6834.487413443912, 6836.38472537474, 6864.107666003388, 6868.690908909011, 6870.106886104974], "unit": "ms", "name": "mootools.html", "value": 4536.069986297482}, {"lowerIsBetter": false, "replicates": [357.8425492783175, 363.31696410747793, 364.7392114638033, 365.08728179551116, 367.0914486645553, 6070.635761854286, 6176.505879529638, 6180.845478863031, 6186.659733714644, 6192.690365481731, 6028.939710602893, 6029.0, 6039.637621742699, 6040.154378387018, 6042.123892035664, 4518.683692141552, 4683.250679891218, 4694.671373003891, 4700.2009658358165, 4705.858824235262, 4668.206404911173, 4677.929831052537, 4684.063187362524, 4685.0, 4686.742229177394, 4426.734395936238, 4621.653375996797, 4640.559146881058, 4644.303354496836, 4651.86044418668, 4486.820527178909, 4519.819207231707, 4521.660875434339, 4522.502524722295, 4577.931331030038, 4021.296273152216, 4027.456293400412, 4038.838446462167, 4048.210598933209, 4054.9391759123637, 5753.0, 5792.623479473821, 5803.767849286023, 5808.82573522795, 5808.941910580882, 5170.922436163461, 5327.46725327468, 5336.439673834269, 5397.514223719845, 5426.647267927611, 6429.35706429358, 6437.742490300382, 6449.322821103763, 6451.741930322782, 6465.0, 4483.14820184164, 4484.5291244419195, 4484.955150448486, 4485.529019452943, 4485.573870482299, 6613.570117942367, 6672.132622759059, 6760.526763126583, 6767.052612634235, 6785.558938668971, 4631.027484228282, 4658.045100754337, 4661.463931647904, 4663.207254766698, 4665.393498845128, 4712.976435117871, 4714.787834547454, 4720.150372932905, 4720.315554244616, 4720.763961801897, 5429.457054294618, 5440.020796256633, 5440.510354068153, 5444.074507333763, 5451.754671039813, 6386.07401926718, 6512.5766825156215, 6516.380943810331, 6519.185101862267, 6530.346965303432, 1641.2450272874373, 1660.1948055193222, 1662.3516828436918, 1662.7007138715148, 1664.8251933547047, 1111.69984104293, 1112.0880877680386, 1121.5625905896707, 1124.5951457475303, 1142.9257098288585, 6321.810345689637, 6328.303886572473, 6331.2085989251345, 6334.841628959313, 6336.1762970814425, 6709.261981182066, 6714.3957043866285, 6717.093192419059, 6722.798316050526, 6730.596164230162, 6235.974494587496, 6284.528660350492, 6323.36766323364, 6325.683715814191, 6327.145835312174, 3611.4041183204477, 3634.909527141847, 3641.053326135224, 3641.672249497558, 3644.1071937375514, 6881.793546193622, 6883.690233939485, 6892.931070689229, 6894.931050689529, 6907.412869906114, 6680.331966803378, 6723.865522689519, 6825.761098361533, 6862.3137686230975, 6866.485013623998, 6888.242293347727, 6904.0, 6956.686949087202, 6965.965170174117, 6979.4765392595755, 6720.731170753311, 6749.392554670103, 6755.054292399166, 6760.222574404006, 6763.492738044764, 6536.869262614816, 6669.399754022162, 6685.465162787063, 6689.464842812466, 6689.933100668931, 6950.06174166481, 6952.061471701256, 6955.791326260221, 6957.895631565631, 6964.338387853146, 4693.483716791082, 4702.952970470252, 4704.50602686713, 4704.764761761967, 4709.364235828257, 6656.534042617164, 6720.932790672031, 6730.865382692221, 6765.729370825112, 6768.796936091925, 6572.737090516326, 6591.802245932629, 6594.142761440982, 6599.043138744951, 6599.637019963948, 6567.047778072249, 6574.441172500391, 6578.703958321791, 6581.572197807127, 6582.144321238208, 6347.523935704933, 6466.579672321284, 6505.21937367519, 6506.0, 6507.0564768107415, 6607.9669601651685, 6616.933830661825, 6620.63586502747, 6631.0, 6638.302978187221, 6457.128287681103, 6469.967650161719, 6476.417122459001, 6478.963365861439, 6481.837954050998], "unit": "ms", "name": "prototype.html", "value": 4919.224939702148}, {"lowerIsBetter": false, "replicates": [768.9577073260972, 808.252366560931, 848.0, 900.6442455230184, 907.7140700679286, 17222.827771722277, 17566.0, 17575.824241757564, 17608.20763065662, 17621.735673964886, 15802.604934876634, 15874.126923019257, 15877.3649054038, 15930.044197348137, 15930.681386372265, 745.1170363119693, 757.8484303139367, 880.6829541365104, 894.5259012723267, 913.8355096082703, 887.1970866365917, 905.651324240169, 908.4730856103445, 914.5427286356821, 915.6108653822132, 926.8563372677212, 940.9952950235239, 941.2470023980823, 942.2791564453199, 943.481085403029, 768.4006474949548, 781.2617076862367, 919.0533750237233, 940.3934462271865, 941.2422999485411, 687.1994126842222, 693.2789898505548, 695.2213520856623, 698.3819319901872, 701.0535776701412, 14438.566842994727, 14578.343974521173, 14587.854121458755, 14614.780778288334, 14623.488177913721, 11925.463354148997, 12115.151939364248, 12715.809262861065, 12786.872131278662, 13119.606411807566, 10869.945650271777, 10911.290766100177, 10975.121990240761, 11138.387388693618, 11143.219974601781, 3661.9633803662155, 3676.3382591133586, 3693.409054551286, 3706.9814650926573, 3774.0753515388633, 47014.76492617549, 47069.20134002011, 47399.76300118512, 47440.28839567409, 47952.7602361986, 10393.584256629802, 10417.876230032887, 10513.737156570995, 10541.104006159563, 10728.51721672511, 18117.637647246982, 18163.909180454277, 18245.908770456062, 18267.269309227482, 18320.541986450444, 7803.960980195063, 7817.374610031184, 7878.330341921001, 7917.683292668229, 8031.277185053374, 4238.491381034234, 4251.489821221411, 4258.382534532476, 4261.4673165854265, 4329.458817647794, 3043.1174959261566, 3071.7389021933386, 3087.444260033171, 3094.1955091676327, 3348.9162770930434, 608.0635820835952, 612.3906712820772, 617.4319625944142, 620.1287191495956, 623.3236937922405, 595.9135925290808, 708.097176100476, 709.1525626875937, 709.6451774112943, 731.2139450091173, 8695.782605434788, 8920.24177944882, 9200.493972831424, 9203.953980230055, 9407.529623518796, 677.7695583501633, 696.2932623387265, 717.7057406463325, 744.0178963767775, 744.5272252119835, 4211.157768446323, 4422.7346359218545, 4427.867163985085, 4517.503074661785, 4588.334691469719, 56360.71819640876, 57243.71378143166, 57265.713671431375, 57398.7130064347, 57428.42571574314, 52047.47952520502, 52351.73824130855, 53916.19125713118, 54223.72888135534, 54399.45600544023, 46584.5341546587, 46797.29804052942, 47138.29292560614, 47152.05695886063, 47166.76416617895, 9026.774330641787, 9051.32115091384, 9078.409903356262, 9148.496832674267, 9283.210927071275, 34233.48649770305, 35155.13734739864, 35397.469037963936, 35474.29051418906, 35925.64074359223, 45042.549574503835, 45976.540234598564, 48695.0, 49235.75382123067, 51335.0, 11677.299362038304, 11701.239419437708, 11874.406279686154, 11893.167478276437, 12009.39953002329, 12687.746245075232, 12763.74472510526, 13180.604581862559, 13367.412013232923, 13764.380602872694, 10953.56185752561, 11653.067754579783, 11718.531258749554, 11803.23278986863, 11868.169228153947, 11090.003440383985, 11255.606053788078, 11304.886951130384, 11352.148588855704, 11483.196176267915, 10836.349819010884, 10939.28894621847, 11233.438328083726, 11745.882541174478, 11763.117766167401, 9405.20055795265, 9505.477198753859, 9602.711918642452, 9907.108360247612, 10235.897641023792, 9905.306628535933, 10160.644377446753, 10162.39025658463, 10180.389176649425, 10226.948865255627], "unit": "ms", "name": "yui.html", "value": 6663.697372784694}], "name": "dromaeo_css", "value": 7228.59812897171}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 102.0, 108.0, 109.0, 109.0, 98.0, 110.0, 108.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 107.0}, {"lowerIsBetter": true, "replicates": [150.0, 121.0, 144.0, 155.0, 127.0, 144.0, 150.0, 130.0, 162.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.5}, {"lowerIsBetter": true, "replicates": [160.0, 158.0, 160.0, 160.0, 158.0, 160.0, 161.0, 161.0, 159.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 159.6}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 72.0, 158.0, 70.0, 71.0, 71.0, 73.0, 143.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 87.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 139.0, 92.0, 93.0, 93.0, 140.0, 92.0, 93.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [108.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 57.0, 58.0, 59.0, 59.0, 58.0, 59.0, 56.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 63.0, 64.0, 64.0, 65.0, 67.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.3}, {"lowerIsBetter": true, "replicates": [78.0, 76.0, 79.0, 77.0, 77.0, 85.0, 79.0, 80.0, 79.0, 79.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.9}, {"lowerIsBetter": true, "replicates": [113.0, 113.0, 119.0, 111.0, 113.0, 114.0, 128.0, 114.0, 118.0, 112.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.5}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 145.0, 139.0, 153.0, 134.0, 144.0, 146.0, 143.0, 152.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.0}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 66.0, 65.0, 64.0, 65.0, 66.0, 62.0, 64.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.6}], "name": "kraken", "value": 1477.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [171.909919202338], "unit": "score", "name": "Richards", "value": 205.351734}, {"lowerIsBetter": false, "replicates": [164.7175094712568], "unit": "score", "name": "DeltaBlue", "value": 401.40237799999994}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5138.461538461538], "unit": "score", "name": "Decrypt", "value": 51.80169161676644}, {"lowerIsBetter": false, "replicates": [990.0990099009902], "unit": "score", "name": "RayTrace", "value": 747.3888899999998}, {"lowerIsBetter": false, "replicates": [544.069640914037], "unit": "score", "name": "Earley", "value": 1224.9589940000005}, {"lowerIsBetter": false, "replicates": [10536.842105263158], "unit": "score", "name": "Boyer", "value": 63.25073426573423}, {"lowerIsBetter": false, "replicates": [24463.414634146342], "unit": "score", "name": "RegExp", "value": 37.23866899302096}, {"lowerIsBetter": false, "replicates": [512.2950819672132], "unit": "score", "name": "Splay", "value": 159.07043199999998}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23171.61147294928}]} 02:20:07 INFO - RETURN: dromaeo_css: 7228.60 02:20:07 INFO - RETURN: kraken: 1477.50 02:20:07 INFO - RETURN: v8_7: 23171.61 02:20:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23171.61"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1477.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7228.60"}}} 02:20:07 INFO - Return code: 0 02:20:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:20:07 INFO - # TBPL SUCCESS # 02:20:07 INFO - Running post-action listener: _resource_record_post_action 02:20:07 INFO - Running post-run listener: _resource_record_post_run 02:20:08 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 319488; Write bytes: 502636544; Read time: 72; Write time: 1429384 02:20:08 INFO - install - Wall time: 16s; CPU: 18.0%; Read bytes: 0; Write bytes: 241692672; Read time: 0; Write time: 809324 02:20:08 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 319488; Write bytes: 260866048; Read time: 72; Write time: 620008 02:20:08 INFO - Running post-run listener: _upload_blobber_files 02:20:08 INFO - Blob upload gear active. 02:20:08 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:20:08 INFO - Copying logs to upload dir... 02:20:08 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.810674 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-06 02:20:08.470615) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-03-06 02:20:08.474364) ========= 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=5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010042 build_url: 'https://queue.taskcluster.net/v1/task/iV5_o94sS7qlJUxoIhtgeg/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-03-06 02:20:08.524777) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 02:20:08.525116) ========= 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=5cf47e208febbcd81da23b2e0000026f-1457258339.236273-1710697066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004361 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 02:20:08.574696) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-06 02:20:08.575012) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-06 02:20:08.575285) ========= ========= Total master_lag: 0.26 =========