builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1453669512.68 results: success (0) buildid: 20160124104106 builduid: 78384801082648628d26b8c18f0a8698 revision: 4a8be5bac3533eaf73bbe06d9ab3a3525c8abc23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:12.683199) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:12.683754) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:12.684133) ========= 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=d2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006484 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:12.750394) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:12.750712) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:12.847544) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:12.847856) ========= 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=d2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:12.901882) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:12.902201) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:12.902609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:12.902916) ========= 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=d2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-24 13:05:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.1M=0s 2016-01-24 13:05:14 (35.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.459337 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:13.379805) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:13.380560) ========= 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=d2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020396 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:13.433865) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:13.434694) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4a8be5bac3533eaf73bbe06d9ab3a3525c8abc23 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4a8be5bac3533eaf73bbe06d9ab3a3525c8abc23 --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=d2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-24 13:05:14,371 truncating revision to first 12 chars 2016-01-24 13:05:14,371 Setting DEBUG logging. 2016-01-24 13:05:14,371 attempt 1/10 2016-01-24 13:05:14,371 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4a8be5bac353?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-24 13:05:14,615 unpacking tar archive at: mozilla-aurora-4a8be5bac353/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550686 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:14.001671) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:14.002368) ========= echo 4a8be5bac3533eaf73bbe06d9ab3a3525c8abc23 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4a8be5bac3533eaf73bbe06d9ab3a3525c8abc23'] 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=d2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 4a8be5bac3533eaf73bbe06d9ab3a3525c8abc23 program finished with exit code 0 elapsedTime=0.004615 script_repo_revision: '4a8be5bac3533eaf73bbe06d9ab3a3525c8abc23' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:14.057564) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:14.058204) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-24 13:05:14.070511) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-01-24 13:05:14.071074) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:05:15 INFO - MultiFileLogger online at 20160124 13:05:15 in /builds/slave/test-pgo 13:05:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:05:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:05:15 INFO - {'append_to_log': False, 13:05:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:05:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:05:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:05:15 INFO - 'branch': 'Mozilla-Aurora', 13:05:15 INFO - 'buildbot_json_path': 'buildprops.json', 13:05:15 INFO - 'config_files': ('talos/linux_config.py',), 13:05:15 INFO - 'default_actions': ('clobber', 13:05:15 INFO - 'read-buildbot-config', 13:05:15 INFO - 'download-and-extract', 13:05:15 INFO - 'populate-webroot', 13:05:15 INFO - 'create-virtualenv', 13:05:15 INFO - 'install', 13:05:15 INFO - 'run-tests'), 13:05:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:05:15 INFO - 'download_minidump_stackwalk': True, 13:05:15 INFO - 'download_symbols': 'ondemand', 13:05:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:05:15 INFO - 'tooltool.py': '/tools/tooltool.py', 13:05:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:05:15 INFO - '/tools/misc-python/virtualenv.py')}, 13:05:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:05:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:05:15 INFO - 'installer_path': 'installer.exe', 13:05:15 INFO - 'log_level': 'info', 13:05:15 INFO - 'log_name': 'talos', 13:05:15 INFO - 'log_to_console': True, 13:05:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:05:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:05:15 INFO - 'opt_config_files': (), 13:05:15 INFO - 'pip_index': False, 13:05:15 INFO - 'sps_profile': False, 13:05:15 INFO - 'sps_profile_interval': 0, 13:05:15 INFO - 'suite': 'dromaeojs-e10s', 13:05:15 INFO - 'system_bits': '32', 13:05:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:05:15 INFO - 'title': 'talos-linux64-ix-043', 13:05:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:05:15 INFO - 'use_talos_json': True, 13:05:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:05:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:05:15 INFO - 'work_dir': 'build'} 13:05:15 INFO - ##### 13:05:15 INFO - ##### Running clobber step. 13:05:15 INFO - ##### 13:05:15 INFO - Running pre-action listener: _resource_record_pre_action 13:05:15 INFO - Running main action method: clobber 13:05:15 INFO - rmtree: /builds/slave/test-pgo/build 13:05:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:05:15 INFO - Running post-action listener: _resource_record_post_action 13:05:15 INFO - ##### 13:05:15 INFO - ##### Running read-buildbot-config step. 13:05:15 INFO - ##### 13:05:15 INFO - Running pre-action listener: _resource_record_pre_action 13:05:15 INFO - Running main action method: read_buildbot_config 13:05:15 INFO - Using buildbot properties: 13:05:15 INFO - { 13:05:15 INFO - "properties": { 13:05:15 INFO - "buildnumber": 79, 13:05:15 INFO - "product": "firefox", 13:05:15 INFO - "script_repo_revision": "production", 13:05:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 13:05:15 INFO - "repository": "", 13:05:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 13:05:15 INFO - "buildid": "20160124104106", 13:05:15 INFO - "slavename": "talos-linux64-ix-043", 13:05:15 INFO - "pgo_build": "True", 13:05:15 INFO - "basedir": "/builds/slave/test-pgo", 13:05:15 INFO - "project": "", 13:05:15 INFO - "platform": "ubuntu64_hw", 13:05:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:05:15 INFO - "slavebuilddir": "test", 13:05:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:05:15 INFO - "branch": "mozilla-aurora", 13:05:15 INFO - "repo_path": "releases/mozilla-aurora", 13:05:15 INFO - "stage_platform": "linux64-pgo", 13:05:15 INFO - "builduid": "78384801082648628d26b8c18f0a8698", 13:05:15 INFO - "revision": "4a8be5bac3533eaf73bbe06d9ab3a3525c8abc23" 13:05:15 INFO - }, 13:05:15 INFO - "sourcestamp": { 13:05:15 INFO - "repository": "", 13:05:15 INFO - "hasPatch": false, 13:05:15 INFO - "project": "", 13:05:15 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 13:05:15 INFO - "changes": [ 13:05:15 INFO - { 13:05:15 INFO - "category": null, 13:05:15 INFO - "files": [ 13:05:15 INFO - { 13:05:15 INFO - "url": null, 13:05:15 INFO - "name": "https://queue.taskcluster.net/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 13:05:15 INFO - } 13:05:15 INFO - ], 13:05:15 INFO - "repository": "", 13:05:15 INFO - "rev": "4a8be5bac3533eaf73bbe06d9ab3a3525c8abc23", 13:05:15 INFO - "who": "ryanvm@gmail.com", 13:05:15 INFO - "when": 1453669488, 13:05:15 INFO - "number": 7508019, 13:05:15 INFO - "comments": "Bug 1242218 - Exclude test_NewTabPrefsProvider added in 45. r=florian, a=test-only", 13:05:15 INFO - "project": "", 13:05:15 INFO - "at": "Sun 24 Jan 2016 13:04:48", 13:05:15 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 13:05:15 INFO - "revlink": "", 13:05:15 INFO - "properties": [ 13:05:15 INFO - [ 13:05:15 INFO - "buildid", 13:05:15 INFO - "20160124104106", 13:05:15 INFO - "Change" 13:05:15 INFO - ], 13:05:15 INFO - [ 13:05:15 INFO - "builduid", 13:05:15 INFO - "78384801082648628d26b8c18f0a8698", 13:05:15 INFO - "Change" 13:05:15 INFO - ], 13:05:15 INFO - [ 13:05:15 INFO - "pgo_build", 13:05:15 INFO - "True", 13:05:15 INFO - "Change" 13:05:15 INFO - ] 13:05:15 INFO - ], 13:05:15 INFO - "revision": "4a8be5bac3533eaf73bbe06d9ab3a3525c8abc23" 13:05:15 INFO - } 13:05:15 INFO - ], 13:05:15 INFO - "revision": "4a8be5bac3533eaf73bbe06d9ab3a3525c8abc23" 13:05:15 INFO - } 13:05:15 INFO - } 13:05:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 13:05:15 INFO - Running post-action listener: _resource_record_post_action 13:05:15 INFO - ##### 13:05:15 INFO - ##### Running download-and-extract step. 13:05:15 INFO - ##### 13:05:15 INFO - Running pre-action listener: _resource_record_pre_action 13:05:15 INFO - Running main action method: download_and_extract 13:05:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:05:15 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')]} 13:05:15 INFO - https://queue.taskcluster.net/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:05:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/test_packages.json 13:05:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/test_packages.json 13:05:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:05:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:05:17 INFO - Downloaded 1302 bytes. 13:05:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:05:17 INFO - Using the following test package requirements: 13:05:17 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 13:05:17 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:05:17 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:05:17 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:05:17 INFO - u'jsshell-linux-x86_64.zip'], 13:05:17 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:05:17 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:05:17 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 13:05:17 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:05:17 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:05:17 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:05:17 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:05:17 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:05:17 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:05:17 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 13:05:17 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:05:17 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:05:17 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:05: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')]} 13:05:17 INFO - https://queue.taskcluster.net/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:05:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:05:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:05:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:05:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:05:18 INFO - Downloaded 23159158 bytes. 13:05:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:05:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:05:18 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:05:19 INFO - Return code: 0 13:05:19 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:05: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')]} 13:05:19 INFO - https://queue.taskcluster.net/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:05:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:05:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:05:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:05:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:05:20 INFO - Downloaded 23159158 bytes. 13:05:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:05:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:05:20 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:05:22 INFO - Return code: 0 13:05: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')]} 13:05:22 INFO - https://queue.taskcluster.net/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:05:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 13:05:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 13:05:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 13:05:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:05:23 INFO - Downloaded 11132038 bytes. 13:05:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 13:05:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 13:05:23 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 13:05:23 INFO - Return code: 0 13:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:23 INFO - https://queue.taskcluster.net/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:05:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 13:05:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 13:05:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 13:05:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:05:25 INFO - Downloaded 58020330 bytes. 13:05:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 13:05:25 INFO - mkdir: /builds/slave/test-pgo/properties 13:05:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:05:25 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:05:25 INFO - Contents: 13:05:25 INFO - build_url:https://queue.taskcluster.net/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 13:05:25 INFO - Running post-action listener: _resource_record_post_action 13:05:25 INFO - Running post-action listener: set_extra_try_arguments 13:05:25 INFO - ##### 13:05:25 INFO - ##### Running populate-webroot step. 13:05:25 INFO - ##### 13:05:25 INFO - Running pre-action listener: _resource_record_pre_action 13:05:25 INFO - Running main action method: populate_webroot 13:05:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:05:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:05:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:05:26 INFO - '--tppagecycles', 13:05:26 INFO - '7'], 13:05:26 INFO - 'tests': ['tsvgm']}}, 13:05:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:05:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:05:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:05:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:05:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:05:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:05:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:05:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:26 INFO - 'talos_options': ['--e10s'], 13:05:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:05:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:26 INFO - 'tests': ['damp', 'tps']}, 13:05:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:26 INFO - 'talos_options': ['--e10s'], 13:05:26 INFO - 'tests': ['damp', 'tps']}, 13:05:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:05:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:05:26 INFO - 'other': {'tests': ['a11yr', 13:05:26 INFO - 'ts_paint', 13:05:26 INFO - 'tpaint', 13:05:26 INFO - 'sessionrestore', 13:05:26 INFO - 'sessionrestore_no_auto_restore']}, 13:05:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:05:26 INFO - 'tests': ['a11yr', 13:05:26 INFO - 'ts_paint', 13:05:26 INFO - 'tpaint', 13:05:26 INFO - 'sessionrestore', 13:05:26 INFO - 'sessionrestore_no_auto_restore']}, 13:05:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:05:26 INFO - 'tests': ['a11yr', 13:05:26 INFO - 'ts_paint', 13:05:26 INFO - 'tpaint', 13:05:26 INFO - 'sessionrestore', 13:05:26 INFO - 'sessionrestore_no_auto_restore']}, 13:05:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:05:26 INFO - 'tests': ['a11yr', 13:05:26 INFO - 'ts_paint', 13:05:26 INFO - 'tpaint', 13:05:26 INFO - 'sessionrestore', 13:05:26 INFO - 'sessionrestore_no_auto_restore']}, 13:05:26 INFO - 'other_l64': {'tests': ['a11yr', 13:05:26 INFO - 'ts_paint', 13:05:26 INFO - 'tpaint', 13:05:26 INFO - 'sessionrestore', 13:05:26 INFO - 'sessionrestore_no_auto_restore']}, 13:05:26 INFO - 'other_nol64': {'tests': ['a11yr', 13:05:26 INFO - 'ts_paint', 13:05:26 INFO - 'tpaint', 13:05:26 INFO - 'sessionrestore', 13:05:26 INFO - 'sessionrestore_no_auto_restore']}, 13:05:26 INFO - 'svgr': {'tests': ['tsvgx', 13:05:26 INFO - 'tsvgr_opacity', 13:05:26 INFO - 'tart', 13:05:26 INFO - 'tscrollx', 13:05:26 INFO - 'cart']}, 13:05:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:05:26 INFO - 'tests': ['tsvgx', 13:05:26 INFO - 'tsvgr_opacity', 13:05:26 INFO - 'tart', 13:05:26 INFO - 'tscrollx', 13:05:26 INFO - 'cart']}, 13:05:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:26 INFO - 'tests': ['tp5o']}, 13:05:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:26 INFO - 'talos_options': ['--e10s'], 13:05:26 INFO - 'tests': ['tp5o']}, 13:05:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:26 INFO - 'talos_options': ['--xperf_path', 13:05:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:05:26 INFO - 'tests': ['tp5n']}, 13:05:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:26 INFO - 'talos_options': ['--e10s', 13:05:26 INFO - '--xperf_path', 13:05:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:05:26 INFO - 'tests': ['tp5n']}}, 13:05:26 INFO - 'talos.zip': {'path': '', 13:05:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:05:26 INFO - Running post-action listener: _resource_record_post_action 13:05:26 INFO - ##### 13:05:26 INFO - ##### Running create-virtualenv step. 13:05:26 INFO - ##### 13:05:26 INFO - Running pre-action listener: _resource_record_pre_action 13:05:26 INFO - Running main action method: create_virtualenv 13:05:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:05:26 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 13:05:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:05:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:05:26 INFO - Using real prefix '/usr' 13:05:26 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:05:26 INFO - Installing distribute.............................................................................................................................................................................................done. 13:05:28 INFO - Installing pip.................done. 13:05:28 INFO - Return code: 0 13:05:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad85102f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c1450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2853a50>, '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 0x27bf550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bf9e0>, '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': 'd2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298', '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 13:05:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 13:05:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:05:28 INFO - Using env: {'DISPLAY': ':0', 13:05:28 INFO - 'HOME': '/home/cltbld', 13:05:28 INFO - 'LANG': 'en_US.UTF-8', 13:05:28 INFO - 'LANGUAGE': 'en_US:en', 13:05:28 INFO - 'LOGNAME': 'cltbld', 13:05:28 INFO - 'MAIL': '/var/mail/cltbld', 13:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:28 INFO - 'MOZ_NO_REMOTE': '1', 13:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:28 INFO - 'NO_EM_RESTART': '1', 13:05:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:05:28 INFO - 'PWD': '/builds/slave/test-pgo', 13:05:28 INFO - 'SHELL': '/bin/bash', 13:05:28 INFO - 'SHLVL': '1', 13:05:28 INFO - 'TERM': 'linux', 13:05:28 INFO - 'TMOUT': '86400', 13:05:28 INFO - 'USER': 'cltbld', 13:05:28 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298', 13:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:28 INFO - '_': '/tools/buildbot/bin/python'} 13:05:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:05:28 INFO - Cleaning up... 13:05:28 INFO - Return code: 0 13:05:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad85102f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c1450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2853a50>, '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 0x27bf550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bf9e0>, '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': 'd2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298', '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 13:05:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 13:05:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:05:28 INFO - Using env: {'DISPLAY': ':0', 13:05:28 INFO - 'HOME': '/home/cltbld', 13:05:28 INFO - 'LANG': 'en_US.UTF-8', 13:05:28 INFO - 'LANGUAGE': 'en_US:en', 13:05:28 INFO - 'LOGNAME': 'cltbld', 13:05:28 INFO - 'MAIL': '/var/mail/cltbld', 13:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:28 INFO - 'MOZ_NO_REMOTE': '1', 13:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:28 INFO - 'NO_EM_RESTART': '1', 13:05:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:05:28 INFO - 'PWD': '/builds/slave/test-pgo', 13:05:28 INFO - 'SHELL': '/bin/bash', 13:05:28 INFO - 'SHLVL': '1', 13:05:28 INFO - 'TERM': 'linux', 13:05:28 INFO - 'TMOUT': '86400', 13:05:28 INFO - 'USER': 'cltbld', 13:05:28 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298', 13:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:28 INFO - '_': '/tools/buildbot/bin/python'} 13:05:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:28 INFO - Downloading/unpacking psutil>=0.7.1 13:05:28 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 13:05:28 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 13:05:28 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 13:05:28 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 13:05:28 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 13:05:28 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 13:05:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:05:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:05:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:05:30 INFO - Installing collected packages: psutil 13:05:30 INFO - Running setup.py install for psutil 13:05:30 INFO - building 'psutil._psutil_linux' extension 13:05:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:05:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:05:31 INFO - building 'psutil._psutil_posix' extension 13:05:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:05:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:05:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:05:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:05:31 INFO - Successfully installed psutil 13:05:31 INFO - Cleaning up... 13:05:31 INFO - Return code: 0 13:05:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad85102f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c1450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2853a50>, '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 0x27bf550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bf9e0>, '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': 'd2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298', '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 13:05:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 13:05:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:05:31 INFO - Using env: {'DISPLAY': ':0', 13:05:31 INFO - 'HOME': '/home/cltbld', 13:05:31 INFO - 'LANG': 'en_US.UTF-8', 13:05:31 INFO - 'LANGUAGE': 'en_US:en', 13:05:31 INFO - 'LOGNAME': 'cltbld', 13:05:31 INFO - 'MAIL': '/var/mail/cltbld', 13:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:31 INFO - 'MOZ_NO_REMOTE': '1', 13:05:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:31 INFO - 'NO_EM_RESTART': '1', 13:05:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:05:31 INFO - 'PWD': '/builds/slave/test-pgo', 13:05:31 INFO - 'SHELL': '/bin/bash', 13:05:31 INFO - 'SHLVL': '1', 13:05:31 INFO - 'TERM': 'linux', 13:05:31 INFO - 'TMOUT': '86400', 13:05:31 INFO - 'USER': 'cltbld', 13:05:31 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298', 13:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:31 INFO - '_': '/tools/buildbot/bin/python'} 13:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:05:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:05:33 INFO - Installing collected packages: mozsystemmonitor 13:05:33 INFO - Running setup.py install for mozsystemmonitor 13:05:33 INFO - Successfully installed mozsystemmonitor 13:05:33 INFO - Cleaning up... 13:05:33 INFO - Return code: 0 13:05:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad85102f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c1450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2853a50>, '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 0x27bf550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bf9e0>, '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': 'd2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298', '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 13:05:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 13:05:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:05:33 INFO - Using env: {'DISPLAY': ':0', 13:05:33 INFO - 'HOME': '/home/cltbld', 13:05:33 INFO - 'LANG': 'en_US.UTF-8', 13:05:33 INFO - 'LANGUAGE': 'en_US:en', 13:05:33 INFO - 'LOGNAME': 'cltbld', 13:05:33 INFO - 'MAIL': '/var/mail/cltbld', 13:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:33 INFO - 'MOZ_NO_REMOTE': '1', 13:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:33 INFO - 'NO_EM_RESTART': '1', 13:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:05:33 INFO - 'PWD': '/builds/slave/test-pgo', 13:05:33 INFO - 'SHELL': '/bin/bash', 13:05:33 INFO - 'SHLVL': '1', 13:05:33 INFO - 'TERM': 'linux', 13:05:33 INFO - 'TMOUT': '86400', 13:05:33 INFO - 'USER': 'cltbld', 13:05:33 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298', 13:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:33 INFO - '_': '/tools/buildbot/bin/python'} 13:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:33 INFO - Downloading/unpacking blobuploader==1.2.4 13:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:35 INFO - Downloading blobuploader-1.2.4.tar.gz 13:05:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:05:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:05: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 13:05: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 13:05: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 13:05: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 13:05: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 13:05: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 13:05:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:05:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:36 INFO - Downloading docopt-0.6.1.tar.gz 13:05:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:05:36 INFO - Installing collected packages: blobuploader, requests, docopt 13:05:36 INFO - Running setup.py install for blobuploader 13:05:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:05:36 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:05:36 INFO - Running setup.py install for requests 13:05:36 INFO - Running setup.py install for docopt 13:05:36 INFO - Successfully installed blobuploader requests docopt 13:05:36 INFO - Cleaning up... 13:05:36 INFO - Return code: 0 13:05:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad85102f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c1450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2853a50>, '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 0x27bf550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bf9e0>, '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': 'd2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298', '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 13:05:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 13:05:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:05:36 INFO - Using env: {'DISPLAY': ':0', 13:05:36 INFO - 'HOME': '/home/cltbld', 13:05:36 INFO - 'LANG': 'en_US.UTF-8', 13:05:36 INFO - 'LANGUAGE': 'en_US:en', 13:05:36 INFO - 'LOGNAME': 'cltbld', 13:05:36 INFO - 'MAIL': '/var/mail/cltbld', 13:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:36 INFO - 'MOZ_NO_REMOTE': '1', 13:05:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:36 INFO - 'NO_EM_RESTART': '1', 13:05:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:05:36 INFO - 'PWD': '/builds/slave/test-pgo', 13:05:36 INFO - 'SHELL': '/bin/bash', 13:05:36 INFO - 'SHLVL': '1', 13:05:36 INFO - 'TERM': 'linux', 13:05:36 INFO - 'TMOUT': '86400', 13:05:36 INFO - 'USER': 'cltbld', 13:05:36 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298', 13:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:36 INFO - '_': '/tools/buildbot/bin/python'} 13:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:05:37 INFO - Running setup.py (path:/tmp/pip-ydsUIx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:05:37 INFO - Running setup.py (path:/tmp/pip-gjG3vM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:05:37 INFO - Running setup.py (path:/tmp/pip-htp1dA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:05:37 INFO - Running setup.py (path:/tmp/pip-d16dSt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:05:37 INFO - Running setup.py (path:/tmp/pip-23eg1z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:05:37 INFO - Running setup.py (path:/tmp/pip-jmmi8_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:05:37 INFO - Running setup.py (path:/tmp/pip-IHnaVE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:05:37 INFO - Running setup.py (path:/tmp/pip-BO1lA_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:05:37 INFO - Running setup.py (path:/tmp/pip-LJV0ir-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:05:37 INFO - Running setup.py (path:/tmp/pip-toBk6V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:05:37 INFO - Running setup.py (path:/tmp/pip-_lrfUI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:05:37 INFO - Running setup.py (path:/tmp/pip-rKpWTD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:05:37 INFO - Running setup.py (path:/tmp/pip-HZEEfr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:05:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:05:38 INFO - Running setup.py (path:/tmp/pip-Q4I5zJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:05:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:05:38 INFO - Running setup.py (path:/tmp/pip-4e6q04-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:05:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:05:38 INFO - Running setup.py (path:/tmp/pip-E1FeM8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:05:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:05:38 INFO - Running setup.py (path:/tmp/pip-K1cIIK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:05:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:05:38 INFO - Running setup.py install for manifestparser 13:05:38 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:05:38 INFO - Running setup.py install for mozcrash 13:05:38 INFO - Running setup.py install for mozdebug 13:05:38 INFO - Running setup.py install for mozdevice 13:05:38 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:05:38 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:05:38 INFO - Running setup.py install for mozfile 13:05:38 INFO - Running setup.py install for mozhttpd 13:05:38 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:05:38 INFO - Running setup.py install for mozinfo 13:05:39 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:05:39 INFO - Running setup.py install for mozInstall 13:05:39 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:05:39 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:05:39 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:05:39 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:05:39 INFO - Running setup.py install for mozleak 13:05:39 INFO - Running setup.py install for mozlog 13:05:39 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:05:39 INFO - Running setup.py install for moznetwork 13:05:39 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:05:39 INFO - Running setup.py install for mozprocess 13:05:39 INFO - Running setup.py install for mozprofile 13:05:39 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:05:39 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:05:39 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:05:39 INFO - Running setup.py install for mozrunner 13:05:39 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:05:39 INFO - Running setup.py install for mozscreenshot 13:05:39 INFO - Running setup.py install for moztest 13:05:39 INFO - Running setup.py install for mozversion 13:05:40 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:05:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:05:40 INFO - Cleaning up... 13:05:40 INFO - Return code: 0 13:05:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad85102f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c1450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2853a50>, '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 0x27bf550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bf9e0>, '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': 'd2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298', '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 13:05:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 13:05:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:05:40 INFO - Using env: {'DISPLAY': ':0', 13:05:40 INFO - 'HOME': '/home/cltbld', 13:05:40 INFO - 'LANG': 'en_US.UTF-8', 13:05:40 INFO - 'LANGUAGE': 'en_US:en', 13:05:40 INFO - 'LOGNAME': 'cltbld', 13:05:40 INFO - 'MAIL': '/var/mail/cltbld', 13:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:40 INFO - 'MOZ_NO_REMOTE': '1', 13:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:40 INFO - 'NO_EM_RESTART': '1', 13:05:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:05:40 INFO - 'PWD': '/builds/slave/test-pgo', 13:05:40 INFO - 'SHELL': '/bin/bash', 13:05:40 INFO - 'SHLVL': '1', 13:05:40 INFO - 'TERM': 'linux', 13:05:40 INFO - 'TMOUT': '86400', 13:05:40 INFO - 'USER': 'cltbld', 13:05:40 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298', 13:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:40 INFO - '_': '/tools/buildbot/bin/python'} 13:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:05:40 INFO - Running setup.py (path:/tmp/pip-iZ70vn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 13:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:05:40 INFO - Running setup.py (path:/tmp/pip-gNPfZT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:05:40 INFO - Running setup.py (path:/tmp/pip-jKYykB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:05:40 INFO - Running setup.py (path:/tmp/pip-v_hq4A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:05:40 INFO - Running setup.py (path:/tmp/pip-iWYaya-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 13:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:05:40 INFO - Running setup.py (path:/tmp/pip-O0wwrH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 13:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:05:40 INFO - Running setup.py (path:/tmp/pip-cLp82r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 13:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:05:40 INFO - Running setup.py (path:/tmp/pip-XJfJMn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 13:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:05:40 INFO - Running setup.py (path:/tmp/pip-iZzRmb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 13:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:05:40 INFO - Running setup.py (path:/tmp/pip-fxMd6U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:05:41 INFO - Running setup.py (path:/tmp/pip-Ef_XpR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 13:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:05:41 INFO - Running setup.py (path:/tmp/pip-UaL8l3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 13:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:05:41 INFO - Running setup.py (path:/tmp/pip-eueXdU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 13:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:05:41 INFO - Running setup.py (path:/tmp/pip-t_uQZN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 13:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:05:41 INFO - Running setup.py (path:/tmp/pip-njNsWQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 13:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:05:41 INFO - Running setup.py (path:/tmp/pip-I1k1No-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 13:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:05:41 INFO - Running setup.py (path:/tmp/pip-fT0zE4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 13:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:05:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:43 INFO - Downloading blessings-1.6.tar.gz 13:05:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:05:43 INFO - Installing collected packages: blessings 13:05:43 INFO - Running setup.py install for blessings 13:05:43 INFO - Successfully installed blessings 13:05:43 INFO - Cleaning up... 13:05:43 INFO - Return code: 0 13:05:43 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:05:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:05:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:05:43 INFO - Reading from file tmpfile_stdout 13:05:43 INFO - Current package versions: 13:05:43 INFO - argparse == 1.2.1 13:05:43 INFO - blessings == 1.6 13:05:43 INFO - blobuploader == 1.2.4 13:05:43 INFO - docopt == 0.6.1 13:05:43 INFO - manifestparser == 1.1 13:05:43 INFO - mozInstall == 1.12 13:05:43 INFO - mozcrash == 0.16 13:05:43 INFO - mozdebug == 0.1 13:05:43 INFO - mozdevice == 0.47 13:05:43 INFO - mozfile == 1.2 13:05:43 INFO - mozhttpd == 0.7 13:05:43 INFO - mozinfo == 0.9 13:05:43 INFO - mozleak == 0.1 13:05:43 INFO - mozlog == 3.1 13:05:43 INFO - moznetwork == 0.27 13:05:43 INFO - mozprocess == 0.22 13:05:43 INFO - mozprofile == 0.27 13:05:43 INFO - mozrunner == 6.11 13:05:43 INFO - mozscreenshot == 0.1 13:05:43 INFO - mozsystemmonitor == 0.0 13:05:43 INFO - moztest == 0.7 13:05:43 INFO - mozversion == 1.4 13:05:43 INFO - psutil == 3.1.1 13:05:43 INFO - requests == 1.2.3 13:05:43 INFO - wsgiref == 0.1.2 13:05:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad85102f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c1450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2853a50>, '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 0x27bf550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bf9e0>, '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': 'd2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298', '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 13:05:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 13:05:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:05:43 INFO - Using env: {'DISPLAY': ':0', 13:05:43 INFO - 'HOME': '/home/cltbld', 13:05:43 INFO - 'LANG': 'en_US.UTF-8', 13:05:43 INFO - 'LANGUAGE': 'en_US:en', 13:05:43 INFO - 'LOGNAME': 'cltbld', 13:05:43 INFO - 'MAIL': '/var/mail/cltbld', 13:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:43 INFO - 'MOZ_NO_REMOTE': '1', 13:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:43 INFO - 'NO_EM_RESTART': '1', 13:05:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:05:43 INFO - 'PWD': '/builds/slave/test-pgo', 13:05:43 INFO - 'SHELL': '/bin/bash', 13:05:43 INFO - 'SHLVL': '1', 13:05:43 INFO - 'TERM': 'linux', 13:05:43 INFO - 'TMOUT': '86400', 13:05:43 INFO - 'USER': 'cltbld', 13:05:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298', 13:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:43 INFO - '_': '/tools/buildbot/bin/python'} 13:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 13:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 13:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 13:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 13:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 13:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 13:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 13:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 13:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:05:43 INFO - Cleaning up... 13:05:43 INFO - Return code: 0 13:05:43 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad85102f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c1450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2853a50>, '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 0x27bf550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bf9e0>, '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': 'd2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298', '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 13:05:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 13:05:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:05:43 INFO - Using env: {'DISPLAY': ':0', 13:05:43 INFO - 'HOME': '/home/cltbld', 13:05:43 INFO - 'LANG': 'en_US.UTF-8', 13:05:43 INFO - 'LANGUAGE': 'en_US:en', 13:05:43 INFO - 'LOGNAME': 'cltbld', 13:05:43 INFO - 'MAIL': '/var/mail/cltbld', 13:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:43 INFO - 'MOZ_NO_REMOTE': '1', 13:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:43 INFO - 'NO_EM_RESTART': '1', 13:05:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:05:43 INFO - 'PWD': '/builds/slave/test-pgo', 13:05:43 INFO - 'SHELL': '/bin/bash', 13:05:43 INFO - 'SHLVL': '1', 13:05:43 INFO - 'TERM': 'linux', 13:05:43 INFO - 'TMOUT': '86400', 13:05:43 INFO - 'USER': 'cltbld', 13:05:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298', 13:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:43 INFO - '_': '/tools/buildbot/bin/python'} 13:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:44 INFO - Downloading/unpacking jsonschema 13:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:05:45 INFO - Downloading/unpacking functools32 (from jsonschema) 13:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:46 INFO - Downloading functools32-3.2.3-2.tar.gz 13:05:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:05:46 INFO - warning: no files found matching '*.txt' 13:05:46 INFO - no previously-included directories found matching 'build' 13:05:46 INFO - no previously-included directories found matching 'dist' 13:05:46 INFO - no previously-included directories found matching '.git*' 13:05:46 INFO - Installing collected packages: jsonschema, functools32 13:05:46 INFO - Running setup.py install for functools32 13:05:46 INFO - warning: no files found matching '*.txt' 13:05:46 INFO - no previously-included directories found matching 'build' 13:05:46 INFO - no previously-included directories found matching 'dist' 13:05:46 INFO - no previously-included directories found matching '.git*' 13:05:46 INFO - Successfully installed jsonschema functools32 13:05:46 INFO - Cleaning up... 13:05:46 INFO - Return code: 0 13:05:46 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad85102f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c1450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2853a50>, '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 0x27bf550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bf9e0>, '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': 'd2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298', '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 13:05:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 13:05:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:05:46 INFO - Using env: {'DISPLAY': ':0', 13:05:46 INFO - 'HOME': '/home/cltbld', 13:05:46 INFO - 'LANG': 'en_US.UTF-8', 13:05:46 INFO - 'LANGUAGE': 'en_US:en', 13:05:46 INFO - 'LOGNAME': 'cltbld', 13:05:46 INFO - 'MAIL': '/var/mail/cltbld', 13:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:46 INFO - 'MOZ_NO_REMOTE': '1', 13:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:46 INFO - 'NO_EM_RESTART': '1', 13:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:05:46 INFO - 'PWD': '/builds/slave/test-pgo', 13:05:46 INFO - 'SHELL': '/bin/bash', 13:05:46 INFO - 'SHLVL': '1', 13:05:46 INFO - 'TERM': 'linux', 13:05:46 INFO - 'TMOUT': '86400', 13:05:46 INFO - 'USER': 'cltbld', 13:05:46 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298', 13:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:46 INFO - '_': '/tools/buildbot/bin/python'} 13:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:46 INFO - Downloading/unpacking flake8 13:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:05:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:05:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:05:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:05:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:05:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:05:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:05:49 INFO - no previously-included directories found matching 'docs/_build' 13:05:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:05:49 INFO - Running setup.py install for pep8 13:05:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:05:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:05:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:05:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:05:49 INFO - no previously-included directories found matching 'docs/_build' 13:05:49 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:05:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:05:49 INFO - Cleaning up... 13:05:49 INFO - Return code: 0 13:05:49 INFO - Running post-action listener: _resource_record_post_action 13:05:49 INFO - Running post-action listener: _start_resource_monitoring 13:05:49 INFO - Starting resource monitoring. 13:05:49 INFO - ##### 13:05:49 INFO - ##### Running install step. 13:05:49 INFO - ##### 13:05:49 INFO - Running pre-action listener: _resource_record_pre_action 13:05:49 INFO - Running main action method: install 13:05:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:05:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:05:49 INFO - Reading from file tmpfile_stdout 13:05:49 INFO - Detecting whether we're running mozinstall >=1.0... 13:05:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:05:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:05:49 INFO - Reading from file tmpfile_stdout 13:05:49 INFO - Output received: 13:05:49 INFO - Usage: mozinstall [options] installer 13:05:49 INFO - Options: 13:05:49 INFO - -h, --help show this help message and exit 13:05:49 INFO - -d DEST, --destination=DEST 13:05:49 INFO - Directory to install application into. [default: 13:05:49 INFO - "/builds/slave/test-pgo"] 13:05:49 INFO - --app=APP Application being installed. [default: firefox] 13:05:49 INFO - mkdir: /builds/slave/test-pgo/build/application 13:05:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 13:05:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 13:06:04 INFO - Reading from file tmpfile_stdout 13:06:04 INFO - Output received: 13:06:04 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:06:04 INFO - Running post-action listener: _resource_record_post_action 13:06:04 INFO - ##### 13:06:04 INFO - ##### Running run-tests step. 13:06:04 INFO - ##### 13:06:04 INFO - Running pre-action listener: _resource_record_pre_action 13:06:04 INFO - Running main action method: run_tests 13:06:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:06:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:06:04 INFO - Python 2.7.3 13:06:04 INFO - Return code: 0 13:06:04 INFO - grabbing minidump binary from tooltool 13:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2853a50>, '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 0x27bf550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bf9e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:06:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 13:06:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:06:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:06:04 INFO - Return code: 0 13:06:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:06:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:06:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:06:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:06:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:06:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:06:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:06:05 INFO - Return code: 0 13:06:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 13:06:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost 13:06:05 INFO - Using env: {'DISPLAY': ':0', 13:06:05 INFO - 'HOME': '/home/cltbld', 13:06:05 INFO - 'LANG': 'en_US.UTF-8', 13:06:05 INFO - 'LANGUAGE': 'en_US:en', 13:06:05 INFO - 'LOGNAME': 'cltbld', 13:06:05 INFO - 'MAIL': '/var/mail/cltbld', 13:06:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:06:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:05 INFO - 'MOZ_NO_REMOTE': '1', 13:06:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:05 INFO - 'NO_EM_RESTART': '1', 13:06:05 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:06:05 INFO - 'PWD': '/builds/slave/test-pgo', 13:06:05 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:06:05 INFO - 'SHELL': '/bin/bash', 13:06:05 INFO - 'SHLVL': '1', 13:06:05 INFO - 'TERM': 'linux', 13:06:05 INFO - 'TMOUT': '86400', 13:06:05 INFO - 'USER': 'cltbld', 13:06:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298', 13:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:05 INFO - '_': '/tools/buildbot/bin/python'} 13:06:05 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost'] with output_timeout 3600 13:06:05 INFO - mozversion INFO | application_buildid: 20160124104106 13:06:05 INFO - mozversion INFO | application_changeset: 4a8be5bac3533eaf73bbe06d9ab3a3525c8abc23 13:06:05 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 13:06:05 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:06:05 INFO - mozversion INFO | application_name: Firefox 13:06:05 INFO - mozversion INFO | application_remotingname: firefox-dev 13:06:05 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:06:05 INFO - mozversion INFO | application_vendor: Mozilla 13:06:05 INFO - mozversion INFO | application_version: 45.0a2 13:06:05 INFO - mozversion INFO | platform_buildid: 20160124104106 13:06:05 INFO - mozversion INFO | platform_changeset: 4a8be5bac3533eaf73bbe06d9ab3a3525c8abc23 13:06:05 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:06:05 INFO - mozversion INFO | platform_version: 45.0a2 13:06:05 INFO - 2016-01-24 13:06:05,552 DEBUG : using testdate: 1453669565 13:06:05 INFO - 2016-01-24 13:06:05,552 DEBUG : actual date: 1453669565 13:06:05 INFO - 2016-01-24 13:06:05,659 INFO : starting webserver on 'localhost:46491' 13:06:05 INFO - 2016-01-24 13:06:05,660 INFO : Starting test suite talos-linux64-ix-043.e 13:06:05 INFO - 2016-01-24 13:06:05,660 INFO : Starting test dromaeo_css 13:06:05 INFO - 2016-01-24 13:06:05,660 DEBUG : operating with platform_type : linux_ 13:06:05 INFO - 2016-01-24 13:06:05,661 INFO : Initialising browser for dromaeo_css test... 13:06:05 INFO - 2016-01-24 13:06:05,677 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAP5yOO/profile http://localhost:46491/getInfo.html 13:06:09 INFO - 2016-01-24 13:06:09,479 DEBUG : BROWSER_OUTPUT: 13:06:09 INFO - 2016-01-24 13:06:09,480 DEBUG : BROWSER_OUTPUT: (process:10935): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:06:10 INFO - 2016-01-24 13:06:10,389 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:06:10 INFO - 2016-01-24 13:06:10,389 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:06:10 INFO - 2016-01-24 13:06:10,389 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:06:10 INFO - 2016-01-24 13:06:10,389 DEBUG : BROWSER_OUTPUT: __metrics 13:06:11 INFO - 2016-01-24 13:06:11,345 INFO : Browser initialized. 13:06:11 INFO - 2016-01-24 13:06:11,346 INFO : Running cycle 1/1 for dromaeo_css test... 13:06:11 INFO - 2016-01-24 13:06:11,346 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAP5yOO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:06:12 INFO - 2016-01-24 13:06:12,675 DEBUG : BROWSER_OUTPUT: 13:06:12 INFO - 2016-01-24 13:06:12,675 DEBUG : BROWSER_OUTPUT: (process:11048): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:06:23 INFO - 2016-01-24 13:06:23,181 DEBUG : BROWSER_OUTPUT: RSS: Main: 135483392 13:06:23 INFO - 2016-01-24 13:06:23,181 DEBUG : BROWSER_OUTPUT: 13:07:12 INFO - 2016-01-24 13:07:12,790 DEBUG : BROWSER_OUTPUT: 1453669632784 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] 13:09:20 INFO - 2016-01-24 13:09:20,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46491/tests/dromaeo/cssquery-ext.html) 13:09:21 INFO - 2016-01-24 13:09:21,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 140685312 13:09:21 INFO - 2016-01-24 13:09:21,420 DEBUG : BROWSER_OUTPUT: 13:12:23 INFO - 2016-01-24 13:12:23,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/dromaeo/cssquery-ext.html (next: http://localhost:46491/tests/dromaeo/cssquery-jquery.html) 13:12:23 INFO - 2016-01-24 13:12:23,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 140042240 13:12:23 INFO - 2016-01-24 13:12:23,806 DEBUG : BROWSER_OUTPUT: 13:15:25 INFO - 2016-01-24 13:15:25,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46491/tests/dromaeo/cssquery-mootools.html) 13:15:25 INFO - 2016-01-24 13:15:25,994 DEBUG : BROWSER_OUTPUT: RSS: Main: 137998336 13:15:25 INFO - 2016-01-24 13:15:25,994 DEBUG : BROWSER_OUTPUT: 13:18:27 INFO - 2016-01-24 13:18:27,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46491/tests/dromaeo/cssquery-prototype.html) 13:18:28 INFO - 2016-01-24 13:18:28,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 139726848 13:18:28 INFO - 2016-01-24 13:18:28,159 DEBUG : BROWSER_OUTPUT: 13:21:30 INFO - 2016-01-24 13:21:30,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46491/tests/dromaeo/cssquery-yui.html) 13:21:30 INFO - 2016-01-24 13:21:30,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 140738560 13:21:30 INFO - 2016-01-24 13:21:30,967 DEBUG : BROWSER_OUTPUT: 13:24:32 INFO - 2016-01-24 13:24:32,872 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/dromaeo/cssquery-yui.html (next: http://localhost:46491/tests/dromaeo/cssquery-dojo.html) 13:24:33 INFO - 2016-01-24 13:24:33,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 141770752 13:24:33 INFO - 2016-01-24 13:24:33,131 DEBUG : BROWSER_OUTPUT: 13:24:33 INFO - 2016-01-24 13:24:33,131 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:24:33 INFO - 2016-01-24 13:24:33,131 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:24:33 INFO - 2016-01-24 13:24:33,131 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:24:33 INFO - 2016-01-24 13:24:33,131 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:24:33 INFO - 2016-01-24 13:24:33,131 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3229.4187046331663;3271.2966712156895;3287.3589650018257;3307.4542700454426;3317.9336413271726;5401.459854014596;5409.24270602115;5420.1327787554;5450.209719590657;5458.235846981416;5524.861878453031;5528.723563821803;5529.419410961851;5542.944570554293;5542.972285138579;5027.994401119772;5048.1670524363435;5117.13008788505;5129.3844738631415;5146.099432599299;4832.106060378824;5001.8499445016705;5020.924686129711;5073.695578265298;5199;4993.975030124862;5059.898802023958;5067.239914012891;5070.5183007614405;5174.922376164361;5097.464766199551;5129.512696293846;5155.871103222412;5171.974140129275;5181.093308670967;4872.317875497433;4907.337509436216;4995.875103122415;5046.142155833517;5056.924146137811;5332.493413125747;5350;5411.404745477994;5415.970965516539;5421.322334708161;5939.376365481606;5943;5949.732262048218;6002.699865006733;6013.51891848651;5745.454181852718;5884.411558844125;5961.314448838396;6055.394460553954;6091.329953705089;5553.16702494625;5589.133684278943;5590.972045139789;5594.748236329375;5595.1886976388605;6089.934261504219;6094.146819445281;6112.816615501542;6113.786017489367;6117.327094019654;5638.689872057076;5718.399568045378;5718.7426565804635;5721.427857214246;5726.055200891889;5968.403159683997;5994.340622531518;5995.670238136944;5996.430339117776;6002.369751176151;5911.556633252438;5947.167396564484;5957.106434034843;5957.821265362046;5986.910196347058;5774.884502310014;5828.708564571754;5856.12158176277;5904.291485021825;5919.6152250103605;4560.361549383089;4573.519780423074;4588.220002599566;4592.242280023758;4614.769261536977;4092.7544347339253;4092.7748973806724;4093.549709532009;4099.487564054493;4128.6284234418445;5516.089845175581;5611.579131565149;5681.204631351614;5704.828855134353;5737.88524229513;5994.190784244159;6006.939930600638;6017;6043.7884674036195;6059.848503787441;5556.055470570012;5718.628289161191;5744.109663002241;5751.396103409165;5774.566907481872;5067.670601410897;5133.512316329943;5147;5157.613179011589;5171.7672704728375;6111.755529778759;6114.938850611437;6120.479759220427;6126.724297406628;6150.538709596798;5815.3603103657715;5916.940830591811;5924.822255332347;5963.761449541969;6014.308354539284;6041.426064523863;6093.361679192721;6153.72308246139;6159.260888693386;6164.938350616437;5851.765929362778;5877.118432235199;5896.3514013457625;5909.409059094056;5923.259592550931;5767.0196066669605;5870.647761134345;5906.4093590642315;5949.583529153091;5987.910181347196;5828.184054232495;5828.883422331614;5833.504152147115;5843.2695913010875;5850.180974663465;5827.1841942127285;5827.358990511125;5833.270841144857;5839.795607153899;5848.883022339444;5518.972405138109;5644.350899646429;5648.604597678123;5734.913976290442;5747;5847.532197424281;5876.970615146897;5878.177055212359;5881.088431293157;5902.291724992857;5721.885562288648;5742.08126699726;5774.971125144348;5792.82621521355;5802.854928626649 13:24:33 INFO - 2016-01-24 13:24:33,131 DEBUG : BROWSER_OUTPUT: |1;ext.html;586.8034208540139;621.7481919822468;623.2458724942819;647.45937142486;648.1832890557897;32243.83878080609;38529;38662.80668596656;38799.030024249405;38911.80544097283;44543;45015.54984450155;45486;45543.316850247276;45572.54427455724;8927.642894284238;9101.726948191565;9164.679236226733;9174.633014679404;9181;8950.373473856833;8997.325200609948;9026.368154229207;9035.36752427327;9054.004059553445;8916.554172291391;8938.955305223464;8961.103889611019;8999.280057595377;9072;9019.323550733721;9112.772180695469;9124.635014599407;9126.224270936911;9134.817303653923;8856.778580535474;8917.732468025904;8951.55242237892;8976.8653470198;8985.46087234768;42379.57620423787;43015.78492107551;43073.56926430727;43311.78344108291;43354.34968475475;3490.427391166187;3517.56030496188;3523.5243242162237;3676.9816150919073;3732.0669832541867;32162.195945101324;32979.6702032979;33053.6694633053;33412.33175336479;33804.49293260603;4121.649659778923;4258.169656916903;4302.182585308781;4317.395564620955;4339.816978964461;291934;294189.99999999785;294615;295456;296408;44467.555324446344;44493.55506444894;44582.55417445849;44774.10451790946;45046;42890.57109428866;42892.571074288855;43086.78456607759;43232.35151472731;43279.78360108179;15127.470538531099;15172.165530895907;15337.846621533865;15347.539573812803;15364.154971476675;11954.701132471759;11999.760004799855;12044.457999390048;12068.396580170956;12265.325407102517;15290.770638440432;15353.155576443403;15354.84645153534;15390.538283851502;15440.922795386175;6085.5435842312;6301.7164227608955;6361.872762544724;6367.90448143269;6375.681215939185;1000.9599616015278;1049.8320268757116;1085.6033066082334;1113.9832902506469;1142.057802313095;29393.265168370963;29683.257918552208;29884;30247.546286805715;30314.242143946136;1075.499892549968;1144.5250221158292;1196.1925700152362;1205.879412058787;1252.4113666576877;14748.852511474748;14887.776683349759;14906.92546537282;15011;15338.309776060105;423474;554277;563719;566615;770394;55256.72371638116;57051;57612.423875761546;57666.99999999916;57677.134842977386;1509.1322489568543;1528.801255836734;1530.900491468051;1533.4556232537511;1535.731247031765;31105.377892442477;31560;31828.204294892814;32158;32363.838180808943;50721.239181413046;50756;51075.48924510707;51188.74405628097;51216;315832;316390;316767;317865;317953;35043.64956350506;35095.649043509235;35507.289854203285;35617.64382356143;50628.24057639065;48889.51110488992;48907.51092489172;48941.510584893695;49054.30201338818;49984.500154997986;41615.58384416117;41775.373369398876;42312.365314520925;43002.78498607612;43132.56867431285;41012.58987410207;41117.79441102895;41144.43867151607;41547.58452415437;41628.79185604052;43842;43948.780256098515;44462.333065003404;44552;44958.77520612376;32819;33563.83218083992;33666.326673465905;33736.325273494884;34057;26319.736802631727;26750.680792701292;27180;27198;27426.451470970867 13:24:33 INFO - 2016-01-24 13:24:33,131 DEBUG : BROWSER_OUTPUT: |2;jquery.html;383.56355448844084;384.40417353102686;387.56979752474746;388.3340071776903;393.3823896482522;15847.762283565728;16946.83053169468;17899.28402863884;19827.50431239218;20002.799972000277;11392.25950313229;11555.24890882092;11743.7064073398;17343.392981245626;17364.39224627138;4695.976520117395;5279.472052794728;5306.09796334624;5307.310049693534;5767.423257674241;5287.180487024518;5456.454354564532;5457.072297709379;5459.290292262001;5686.886262274752;5356;5406.324209473816;5428.809991650293;5679.744411501471;5719.084946408576;5657.660540367591;5690.032694441955;5713.657180569137;5719.913216488874;5732.856678583027;5192.247124166975;5272.6309158358545;5301.204819277101;5493;5496.422875598085;12999;12999;14767.630809229748;20274.29039983608;20372.898135509375;2176.5320456101854;2204.063273108922;2237.3511681612313;2293.0254641777346;2442.8167887408517;9674.613015479372;9757.219422446258;9837.803243935154;9855.211583073336;10176.796464070678;1931.9710204346945;1974.565595568987;1986.255154317131;2015.4256037029522;2024.6659301215282;62826;64810;65171;65548.67225663889;67234;10567.15462762977;10818.134549236041;10950.39772812503;10960.232783705223;10992.395418252074;14306.713865722628;14391.640208994859;14414.783778243334;14434.278286085653;14434.494792682415;7930.41391721658;8028;8029.317508011768;8057.395695322874;8115.269625733712;7779.805504862424;7841.803954901173;7846.136924938252;7850.803729906798;7885.645145968445;4550.13547425988;4618.468876079294;4640.721556706609;4679.181143299909;4731.408573928259;1973.7236786849853;1998.0109845626507;2006.839452843769;2017.9899100504404;2027.7161197432372;1020.6325722739808;1024.4212020208706;1046.4663021858908;1070.635983765508;1071.8767341755643;17124.571885702957;18046.368377106737;18388.632227355647;18517.722234166496;18704.158312875952;957.7270477913901;979.8155993022676;1041.4376236832177;1049.1030169205371;1083.7073990022807;9687.840669815952;9776.706698799047;9802.313838031268;9822.214222862154;9949;660564;677158;684378;685988;694893;85201.57399212965;85667.57166214254;87174;87670.56164719263;88640.5567972169;1233.944977044614;1240.2372540887288;1244.3778110944527;1247.7754004279136;1248.1699669719717;15084.170370629281;15131.697366052838;15389.769153462483;15527.146006969273;15695.215239237765;34277.31445371128;34515.309693806485;34977.825110874284;35079.82460087785;35509.28981420409;52206.738966304925;52305.47694523006;54921.45078549323;55038.17442738282;56379.43620563906;10334.173266138841;10426.635067772895;10454.215933805148;10490.632827851294;10491.055804977588;14340.426382944564;14953;17117.486475405756;18240.361587344378;18284.908575457037;15348.539543813704;15454;15799.289031993358;15981.121038343003;16077.67844643124;14807;14839.554813355617;15209.77185342243;15724.68550629004;15766.763498547301;15517.612059698598;15542.766858496905;15556.222188890737;15980;16066.357345706041;9798.363106398061;10009.899901001188;10036.799264014824;10203.69388918304;10230.488475576043;13425.395857186646;14563.92718036403;14610.561683149523;14679.926600366929;14818.851811481747 13:24:33 INFO - 2016-01-24 13:24:33,131 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1565.2017471089748;1583.6199312165077;1824;1835.4218421197324;1863.6831738604435;7241.782746517613;7411.14771801243;7753.224677532244;8013.879791803128;8038.799030024245;7556.5466072035715;7663.386929045677;7787.610619469018;7820.413468989835;7826.373890088779;2212.6017316882912;2236.1279101150485;2249.752527222004;2251.5271792923504;2253.54929014197;2276.2829708641807;2294.6328587426015;2328.685627440291;2335.3927978725483;2344.0858065354523;2204.9669254961186;2227.365200917731;2228.9331320060423;2263.1400067974146;2288.439332363573;2302.458922153293;2318.8840557972035;2339.228054741931;2347.5539647466926;2351.0713268259115;2356.8350215484925;2359.8466099703464;2368;2386.6181410974336;2388.725296590897;8091.39314551411;8103.756887293391;8120.837583248361;8153.347732181412;8179.018517777845;4718.8584342469785;4720.716756994591;4738.2892566115015;4761.095391875532;4763.737994410306;3076.9846150769326;3101.209191656113;3115.719585237317;3122.4223518649123;3144.1982294514983;1062.3360399750156;1066.1257768629728;1077.6551503518876;1082.9404382758946;1089.1504626391427;10830.079443247334;10898.346099234072;10935.28920620165;10936.56253749849;10943.671689849318;4177.289860723684;4230.450041494586;4233.428487154257;4247.384129301296;4291.570842915746;9361.672341468016;9439.858402123973;9444.433333999981;9451.29115316354;9492.193163581172;4745.240761478147;4759.6668233223345;4761.4524329701835;4774.594159496482;4776.379070720784;4289.764062976504;4300.397944287803;4307.827686892552;4403.3174857897075;4416.6908316418185;3569.0720412692885;3570.803605801706;3571.6428357164077;3592.1199306169633;3596.748227624041;1011.0546638892658;1028.83024300991;1030.525958059301;1032.0762917189074;1043.3948309980194;1404.5571178289247;1411.1462565147938;1419.6096073579847;1441.3874103505968;1442.149132012097;7674.462787604925;7680.308772210527;7685.116211635622;7694.461387702919;7801.570913599807;481.90602832447337;492.33534728116757;492.704377373573;496.99254511182363;502.40214145167863;6108.847278817976;6146.231721034871;6174.5060395168275;6214.906776398358;6232;9430;9684.128428441474;9702.51487425626;9838.06538378853;9845.704628861145;9245.676401325922;9465.763355916019;9630.181434577999;9632.422054676741;9649.276304277208;7373.078365204349;7420.109586849505;7430.7399241026305;7447.255274472401;7500.7749767505975;7741.5742134183165;7819.491733037335;7819.921800781919;7885.763427097197;7886.842263154819;8711;8725.52009639476;8778.956105219433;8963.865542017005;9006.099390061203;8833.558322083998;8895.421797583136;8931.062238465127;8950.86573701408;9182.67860624875;6876.965615171892;7070.4343652508705;7075.150981882207;7105.32499412555;7191.208967013729;7671.041119860018;7712.267334603428;7712.421568382506;7725.806854828675;7764.378849691898;7303.890441643273;7406.222346653739;7412.8146796328365;7552.207018263223;7615.086189657055;7053.717851286096;7104.680289387094;7185.2814718527725;7286.089238845145;7295.671694773641;7244.311790379906;7258.3104605062435;7287.489875708649;7304.598247096248;7308.853822923618;6477.935220647733;6498.772542960974;6509.609423434609;6513.609183448819;6523.282438931808;6720.663966801542;6814.557053791487;6854.074699915447;6869.072675188786;6877.140357455318 13:24:33 INFO - 2016-01-24 13:24:33,132 DEBUG : BROWSER_OUTPUT: |4;prototype.html;368.9243705040467;372.6143441538008;375.9022654109934;378.1548239684306;379.4156998222737;6260.186175797151;6328.08242804793;6333.018382150763;6339.239291285046;6434.453071488917;6171.475424588915;6331.4618257448055;6333;6334.814489001299;6335.303116657175;4894.2903279024695;4904.215325547913;4930.827421040264;4933.235348520967;4934.037862616791;4918.729469879156;4925.408950925894;4928.285398617199;4933.506649335073;4934.901301973959;4680.157571637104;4820.686655367407;4833.275008748681;4855.951440485603;4856.951430485685;4819.9036019279765;4821.783019764119;4831.9275210871865;4836.709797412132;4837.492063333335;4231.576842315774;4232.619064284198;4233.1322078973735;4235.089455766994;4245.066085461193;5941.851453713692;6035.517158627299;6037.63774173551;6041.5468839837185;6041.879162416771;5598.636088654265;5606.495415412633;5612.41069687681;5614.157876318544;5615.101583746581;6652.334766523358;6659.067730517731;6664.633445160514;6683.431908287801;6692.59844409337;4651.302304654295;4656.557627025427;4656.743879086649;4667.579917807379;4674.509176536449;6883.552569082994;6947.096877405905;7005.82485437863;7013.403860671798;7035.366816986496;4781.808727650855;4789.137955168034;4796.37647105874;4811.109944660179;4832.565069143794;4891.437484689235;4891.657583969088;4892.143874821892;4893.608511319086;4897.632677549127;5515.586331025189;5625.521830644359;5636.2391077204875;5636.971815140898;5645.774169033275;6679.098321726602;6718.697658605374;6742.157230346207;6743.494237932175;6751.966240168767;1683.1163639089332;1715.5453804741753;1727.6976529107608;1727.870409719276;1728.0150314320717;1131.1911982932243;1144.2619510415734;1168.2873447197203;1178.9646310610694;1182.9645110646695;6537.934620653733;6566.244881838554;6576.86846263072;6577.177852768404;6609.008648702733;6895.4138898194215;6914.274001229798;6920.169579650374;6928.272531384233;6930.064441300461;6437.227532696106;6553.606783593;6566.540342176002;6569.57297775643;6587.80236592903;3738.775673459601;3768.2651882882574;3769.792661403649;3769.8680546180753;3771.189194323179;7120.857582848314;7138.464615153885;7146.7141314346845;7147.53541019832;7149.642517874086;6931.480138989596;7028.8945665814035;7077.398421134261;7089.539179953286;7101.82245443868;7063.82340441493;7073.3987611053635;7099.538529995534;7120.6795694194925;7136.964315178391;6886.552374095668;6888.104546408935;6903.344182302673;6928.272531384334;6936.965315173392;6640.90038649411;6806.693698783468;6808.217055038536;6832.419244364285;6835.179778426621;7071.222165561681;7076.0801095857205;7123.430125589836;7140.357367836919;7144.678489467882;4752.714837109785;4761.785719642555;4775.498572649822;4781.6891902026255;4794.945112075337;6793.270647218301;6894.345037221456;6919.8962015568795;6928.891377379797;6929.653517324013;6715.160604924385;6721.193456785217;6725.058491811053;6726.7981960541265;6729.0915726376315;6637.867242655217;6686.765963191265;6691.431228345645;6691.59850408977;6714.462842972648;6453.386928241809;6521.739130434729;6538.542302038812;6566.179227596551;6612.338766123349;6723.932760672331;6735.090762747162;6739.8542247817;6740.595564266159;6746.4940129489505;6570.5400621956005;6576.868462630625;6578.04618330349;6579.80260592183;6580.638064906285 13:24:33 INFO - 2016-01-24 13:24:33,134 DEBUG : BROWSER_OUTPUT: |5;yui.html;871.4509858788962;935.8034812689335;943.198281460758;950.9857352139719;951.7240000399885;13032.674183145415;13245.602631921034;13341.2656354674;13341.666458338546;13357.332133393316;12420.441080151393;12490.687732806684;12490.875091249085;12500;12522.68693282666;892.6072528087636;905.1355955062899;915.1077699243251;919.6321471411422;920.2086205862953;882.3470631732536;887.7248053103558;900.1358695652182;901.5041727050129;905.5789058087988;935.242453612576;949.4018768176074;951.9571619277149;953.1945506047414;953.5184731710476;938.9859152112724;941.256407438123;948.4072454715803;948.4119845695678;951.2342564235787;698.322627051759;701.7508784381522;702.1188408547291;703.5426972467936;703.7431337561804;14565;14596.854031459656;14631.561053168421;14669.266536673123;14720.779188312184;12798.744025119446;12816.80774788379;13019.804702929463;13040.999171984342;13043;10899.782004359948;10985.560577576887;11079.833802492969;11131.666050018512;11192.048675862561;3918.9804050979565;3926.195129998372;3944.9211015779524;3951.0517475805887;3977.622125898035;48683.51316486825;49256.01487970256;49300.50699492995;49964.75017624888;49997;9742.269329800294;9992.80014399708;10165.542550585242;10216.080552750289;10224.846627300596;18232.544186395182;18235.90882045608;18255.908720456577;18257.17842697082;18311.267549298147;7711.768646940601;7959.681612735426;8047.597620118971;8057.717979870794;8224.62989165489;4383.298672212431;4399.472063352354;4406.581374769392;4455.465344158722;4495.977520112378;3187.888423905152;3192.0902542775198;3207.6792320767736;3222.8388580570877;3224.7742658013713;580.2369883603048;583.1922786940033;599.901016332309;607.6354187487473;609.774383478116;659.2846761263986;664.329027682035;696.5054811084086;703.2369878681585;717.2683862460261;8251.422400432033;8582.098879617675;8717;8727.138333682899;8836.911630883738;632.9113924050637;644.7227692092446;677.6476232359245;693.0470602920983;700.6916956539106;4023.3160362738404;4074.3888416737727;4154.7328064939875;4163.666906647461;4182.895427614334;59876.70061649664;60473;60599;60627.69686151541;61065.38934610686;55494.44505554893;55830.72084639632;56010;56139.719301404046;56840.71579642075;50418;50667.493325067015;50858.491415086115;51366;51973.220401694;8171.959140204261;8369.748907532783;8430.70492532783;8479.830403391774;8549.27331176857;34192.487112692834;35011.46794721177;35426.46860297046;35583;36872.63127368692;42033;42198;46761.53238467572;47419.52580474151;47579.28631070467;10934.125269978224;11183.273087249629;11192.272502287651;11290.266132701348;11509.309441433541;12433.191842530206;12501.56244531437;12515.56195533152;12619.810702839648;12702.745945081231;10821.729456763644;10991.725206869573;11028.28316159447;11047.226694131656;11050.115990720884;10755.462226888469;10829.24195306321;10871.347719136877;10917.853625369222;11119;10529.315594486334;10560.84158737635;10596.735081623021;10954.287971281841;11134.777304454028;9550.761230969281;9878.308518403643;9956.352837065568;10157.644482443078;10160.593576257163;9051.54742262871;9303.255739540686;9332.673356432493;9370.297227708086;9463.290253231173 13:24:33 INFO - 2016-01-24 13:24:33,134 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:24:33 INFO - 2016-01-24 13:24:33,134 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:24:33 INFO - 2016-01-24 13:24:33,134 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,300 13:24:33 INFO - 2016-01-24 13:24:33,134 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:24:33 INFO - 2016-01-24 13:24:33,134 DEBUG : BROWSER_OUTPUT: __startTimestamp1453670673123__endTimestamp 13:24:33 INFO - 2016-01-24 13:24:33,134 DEBUG : BROWSER_OUTPUT: 13:24:33 INFO - 2016-01-24 13:24:33,134 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:24:33 INFO - 2016-01-24 13:24:33,135 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:24:33 INFO - 2016-01-24 13:24:33,135 DEBUG : BROWSER_OUTPUT: 13:24:33 INFO - 2016-01-24 13:24:33,135 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5521.28 Median:5742.08 stddev:614.61 (10.7%) stddev-sans-first:589.61 13:24:33 INFO - 2016-01-24 13:24:33,135 DEBUG : BROWSER_OUTPUT: Values: 3229.4 3271.3 3287.4 3307.5 3317.9 5401.5 5409.2 5420.1 5450.2 5458.2 5524.9 5528.7 5529.4 5542.9 5543.0 5028.0 5048.2 5117.1 5129.4 5146.1 4832.1 5001.8 5020.9 5073.7 5199.0 4994.0 5059.9 5067.2 5070.5 5174.9 5097.5 5129.5 5155.9 5172.0 5181.1 4872.3 4907.3 4995.9 5046.1 5056.9 5332.5 5350.0 5411.4 5416.0 5421.3 5939.4 5943.0 5949.7 6002.7 6013.5 5745.5 5884.4 5961.3 6055.4 6091.3 5553.2 5589.1 5591.0 5594.7 5595.2 6089.9 6094.1 6112.8 6113.8 6117.3 5638.7 5718.4 5718.7 5721.4 5726.1 5968.4 5994.3 5995.7 5996.4 6002.4 5911.6 5947.2 5957.1 5957.8 5986.9 5774.9 5828.7 5856.1 5904.3 5919.6 4560.4 4573.5 4588.2 4592.2 4614.8 4092.8 4092.8 4093.5 4099.5 4128.6 5516.1 5611.6 5681.2 5704.8 5737.9 5994.2 6006.9 6017.0 6043.8 6059.8 5556.1 5718.6 5744.1 5751.4 5774.6 5067.7 5133.5 5147.0 5157.6 5171.8 6111.8 6114.9 6120.5 6126.7 6150.5 5815.4 5916.9 5924.8 5963.8 6014.3 6041.4 6093.4 6153.7 6159.3 6164.9 5851.8 5877.1 5896.4 5909.4 5923.3 5767.0 5870.6 5906.4 5949.6 5987.9 5828.2 5828.9 5833.5 5843.3 5850.2 5827.2 5827.4 5833.3 5839.8 5848.9 5519.0 5644.4 5648.6 5734.9 5747.0 5847.5 5877.0 5878.2 5881.1 5902.3 5721.9 5742.1 5775.0 5792.8 5802.9 13:24:33 INFO - 2016-01-24 13:24:33,135 DEBUG : BROWSER_OUTPUT: 13:24:33 INFO - 2016-01-24 13:24:33,135 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:55581.15 Median:41702.08 stddev:112160.16 (269.0%) stddev-sans-first:112398.80 13:24:33 INFO - 2016-01-24 13:24:33,135 DEBUG : BROWSER_OUTPUT: Values: 586.8 621.7 623.2 647.5 648.2 32243.8 38529.0 38662.8 38799.0 38911.8 44543.0 45015.5 45486.0 45543.3 45572.5 8927.6 9101.7 9164.7 9174.6 9181.0 8950.4 8997.3 9026.4 9035.4 9054.0 8916.6 8939.0 8961.1 8999.3 9072.0 9019.3 9112.8 9124.6 9126.2 9134.8 8856.8 8917.7 8951.6 8976.9 8985.5 42379.6 43015.8 43073.6 43311.8 43354.3 3490.4 3517.6 3523.5 3677.0 3732.1 32162.2 32979.7 33053.7 33412.3 33804.5 4121.6 4258.2 4302.2 4317.4 4339.8 291934.0 294190.0 294615.0 295456.0 296408.0 44467.6 44493.6 44582.6 44774.1 45046.0 42890.6 42892.6 43086.8 43232.4 43279.8 15127.5 15172.2 15337.8 15347.5 15364.2 11954.7 11999.8 12044.5 12068.4 12265.3 15290.8 15353.2 15354.8 15390.5 15440.9 6085.5 6301.7 6361.9 6367.9 6375.7 1001.0 1049.8 1085.6 1114.0 1142.1 29393.3 29683.3 29884.0 30247.5 30314.2 1075.5 1144.5 1196.2 1205.9 1252.4 14748.9 14887.8 14906.9 15011.0 15338.3 423474.0 554277.0 563719.0 566615.0 770394.0 55256.7 57051.0 57612.4 57667.0 57677.1 1509.1 1528.8 1530.9 1533.5 1535.7 31105.4 31560.0 31828.2 32158.0 32363.8 50721.2 50756.0 51075.5 51188.7 51216.0 315832.0 316390.0 316767.0 317865.0 317953.0 35043.6 35095.6 35507.3 35617.6 50628.2 48889.5 48907.5 48941.5 49054.3 49984.5 41615.6 41775.4 42312.4 43002.8 43132.6 41012.6 41117.8 41144.4 41547.6 41628.8 43842.0 43948.8 44462.3 44552.0 44958.8 32819.0 33563.8 33666.3 33736.3 34057.0 26319.7 26750.7 27180.0 27198.0 27426.5 13:24:33 INFO - 2016-01-24 13:24:33,135 DEBUG : BROWSER_OUTPUT: 13:24:33 INFO - 2016-01-24 13:24:33,136 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33454.61 Median:11151.00 stddev:111192.95 (997.2%) stddev-sans-first:111477.14 13:24:33 INFO - 2016-01-24 13:24:33,137 DEBUG : BROWSER_OUTPUT: Values: 383.6 384.4 387.6 388.3 393.4 15847.8 16946.8 17899.3 19827.5 20002.8 11392.3 11555.2 11743.7 17343.4 17364.4 4696.0 5279.5 5306.1 5307.3 5767.4 5287.2 5456.5 5457.1 5459.3 5686.9 5356.0 5406.3 5428.8 5679.7 5719.1 5657.7 5690.0 5713.7 5719.9 5732.9 5192.2 5272.6 5301.2 5493.0 5496.4 12999.0 12999.0 14767.6 20274.3 20372.9 2176.5 2204.1 2237.4 2293.0 2442.8 9674.6 9757.2 9837.8 9855.2 10176.8 1932.0 1974.6 1986.3 2015.4 2024.7 62826.0 64810.0 65171.0 65548.7 67234.0 10567.2 10818.1 10950.4 10960.2 10992.4 14306.7 14391.6 14414.8 14434.3 14434.5 7930.4 8028.0 8029.3 8057.4 8115.3 7779.8 7841.8 7846.1 7850.8 7885.6 4550.1 4618.5 4640.7 4679.2 4731.4 1973.7 1998.0 2006.8 2018.0 2027.7 1020.6 1024.4 1046.5 1070.6 1071.9 17124.6 18046.4 18388.6 18517.7 18704.2 957.7 979.8 1041.4 1049.1 1083.7 9687.8 9776.7 9802.3 9822.2 9949.0 660564.0 677158.0 684378.0 685988.0 694893.0 85201.6 85667.6 87174.0 87670.6 88640.6 1233.9 1240.2 1244.4 1247.8 1248.2 15084.2 15131.7 15389.8 15527.1 15695.2 34277.3 34515.3 34977.8 35079.8 35509.3 52206.7 52305.5 54921.5 55038.2 56379.4 10334.2 10426.6 10454.2 10490.6 10491.1 14340.4 14953.0 17117.5 18240.4 18284.9 15348.5 15454.0 15799.3 15981.1 16077.7 14807.0 14839.6 15209.8 15724.7 15766.8 15517.6 15542.8 15556.2 15980.0 16066.4 9798.4 10009.9 10036.8 10203.7 10230.5 13425.4 14563.9 14610.6 14679.9 14818.9 13:24:33 INFO - 2016-01-24 13:24:33,137 DEBUG : BROWSER_OUTPUT: 13:24:33 INFO - 2016-01-24 13:24:33,137 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5614.96 Median:6488.35 stddev:2955.56 (45.6%) stddev-sans-first:2948.18 13:24:33 INFO - 2016-01-24 13:24:33,138 DEBUG : BROWSER_OUTPUT: Values: 1565.2 1583.6 1824.0 1835.4 1863.7 7241.8 7411.1 7753.2 8013.9 8038.8 7556.5 7663.4 7787.6 7820.4 7826.4 2212.6 2236.1 2249.8 2251.5 2253.5 2276.3 2294.6 2328.7 2335.4 2344.1 2205.0 2227.4 2228.9 2263.1 2288.4 2302.5 2318.9 2339.2 2347.6 2351.1 2356.8 2359.8 2368.0 2386.6 2388.7 8091.4 8103.8 8120.8 8153.3 8179.0 4718.9 4720.7 4738.3 4761.1 4763.7 3077.0 3101.2 3115.7 3122.4 3144.2 1062.3 1066.1 1077.7 1082.9 1089.2 10830.1 10898.3 10935.3 10936.6 10943.7 4177.3 4230.5 4233.4 4247.4 4291.6 9361.7 9439.9 9444.4 9451.3 9492.2 4745.2 4759.7 4761.5 4774.6 4776.4 4289.8 4300.4 4307.8 4403.3 4416.7 3569.1 3570.8 3571.6 3592.1 3596.7 1011.1 1028.8 1030.5 1032.1 1043.4 1404.6 1411.1 1419.6 1441.4 1442.1 7674.5 7680.3 7685.1 7694.5 7801.6 481.9 492.3 492.7 497.0 502.4 6108.8 6146.2 6174.5 6214.9 6232.0 9430.0 9684.1 9702.5 9838.1 9845.7 9245.7 9465.8 9630.2 9632.4 9649.3 7373.1 7420.1 7430.7 7447.3 7500.8 7741.6 7819.5 7819.9 7885.8 7886.8 8711.0 8725.5 8779.0 8963.9 9006.1 8833.6 8895.4 8931.1 8950.9 9182.7 6877.0 7070.4 7075.2 7105.3 7191.2 7671.0 7712.3 7712.4 7725.8 7764.4 7303.9 7406.2 7412.8 7552.2 7615.1 7053.7 7104.7 7185.3 7286.1 7295.7 7244.3 7258.3 7287.5 7304.6 7308.9 6477.9 6498.8 6509.6 6513.6 6523.3 6720.7 6814.6 6854.1 6869.1 6877.1 13:24:33 INFO - 2016-01-24 13:24:33,138 DEBUG : BROWSER_OUTPUT: 13:24:33 INFO - 2016-01-24 13:24:33,138 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5622.27 Median:6445.31 stddev:1676.55 (26.0%) stddev-sans-first:1634.23 13:24:33 INFO - 2016-01-24 13:24:33,138 DEBUG : BROWSER_OUTPUT: Values: 368.9 372.6 375.9 378.2 379.4 6260.2 6328.1 6333.0 6339.2 6434.5 6171.5 6331.5 6333.0 6334.8 6335.3 4894.3 4904.2 4930.8 4933.2 4934.0 4918.7 4925.4 4928.3 4933.5 4934.9 4680.2 4820.7 4833.3 4856.0 4857.0 4819.9 4821.8 4831.9 4836.7 4837.5 4231.6 4232.6 4233.1 4235.1 4245.1 5941.9 6035.5 6037.6 6041.5 6041.9 5598.6 5606.5 5612.4 5614.2 5615.1 6652.3 6659.1 6664.6 6683.4 6692.6 4651.3 4656.6 4656.7 4667.6 4674.5 6883.6 6947.1 7005.8 7013.4 7035.4 4781.8 4789.1 4796.4 4811.1 4832.6 4891.4 4891.7 4892.1 4893.6 4897.6 5515.6 5625.5 5636.2 5637.0 5645.8 6679.1 6718.7 6742.2 6743.5 6752.0 1683.1 1715.5 1727.7 1727.9 1728.0 1131.2 1144.3 1168.3 1179.0 1183.0 6537.9 6566.2 6576.9 6577.2 6609.0 6895.4 6914.3 6920.2 6928.3 6930.1 6437.2 6553.6 6566.5 6569.6 6587.8 3738.8 3768.3 3769.8 3769.9 3771.2 7120.9 7138.5 7146.7 7147.5 7149.6 6931.5 7028.9 7077.4 7089.5 7101.8 7063.8 7073.4 7099.5 7120.7 7137.0 6886.6 6888.1 6903.3 6928.3 6937.0 6640.9 6806.7 6808.2 6832.4 6835.2 7071.2 7076.1 7123.4 7140.4 7144.7 4752.7 4761.8 4775.5 4781.7 4794.9 6793.3 6894.3 6919.9 6928.9 6929.7 6715.2 6721.2 6725.1 6726.8 6729.1 6637.9 6686.8 6691.4 6691.6 6714.5 6453.4 6521.7 6538.5 6566.2 6612.3 6723.9 6735.1 6739.9 6740.6 6746.5 6570.5 6576.9 6578.0 6579.8 6580.6 13:24:33 INFO - 2016-01-24 13:24:33,139 DEBUG : BROWSER_OUTPUT: 13:24:33 INFO - 2016-01-24 13:24:33,139 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14280.28 Median:48969.76 stddev:16874.79 (34.5%) stddev-sans-first:16892.09 13:24:33 INFO - 2016-01-24 13:24:33,140 DEBUG : BROWSER_OUTPUT: Values: 871.5 935.8 943.2 951.0 951.7 13032.7 13245.6 13341.3 13341.7 13357.3 12420.4 12490.7 12490.9 12500.0 12522.7 892.6 905.1 915.1 919.6 920.2 882.3 887.7 900.1 901.5 905.6 935.2 949.4 952.0 953.2 953.5 939.0 941.3 948.4 948.4 951.2 698.3 701.8 702.1 703.5 703.7 14565.0 14596.9 14631.6 14669.3 14720.8 12798.7 12816.8 13019.8 13041.0 13043.0 10899.8 10985.6 11079.8 11131.7 11192.0 3919.0 3926.2 3944.9 3951.1 3977.6 48683.5 49256.0 49300.5 49964.8 49997.0 9742.3 9992.8 10165.5 10216.1 10224.8 18232.5 18235.9 18255.9 18257.2 18311.3 7711.8 7959.7 8047.6 8057.7 8224.6 4383.3 4399.5 4406.6 4455.5 4496.0 3187.9 3192.1 3207.7 3222.8 3224.8 580.2 583.2 599.9 607.6 609.8 659.3 664.3 696.5 703.2 717.3 8251.4 8582.1 8717.0 8727.1 8836.9 632.9 644.7 677.6 693.0 700.7 4023.3 4074.4 4154.7 4163.7 4182.9 59876.7 60473.0 60599.0 60627.7 61065.4 55494.4 55830.7 56010.0 56139.7 56840.7 50418.0 50667.5 50858.5 51366.0 51973.2 8172.0 8369.7 8430.7 8479.8 8549.3 34192.5 35011.5 35426.5 35583.0 36872.6 42033.0 42198.0 46761.5 47419.5 47579.3 10934.1 11183.3 11192.3 11290.3 11509.3 12433.2 12501.6 12515.6 12619.8 12702.7 10821.7 10991.7 11028.3 11047.2 11050.1 10755.5 10829.2 10871.3 10917.9 11119.0 10529.3 10560.8 10596.7 10954.3 11134.8 9550.8 9878.3 9956.4 10157.6 10160.6 9051.5 9303.3 9332.7 9370.3 9463.3 13:24:33 INFO - 2016-01-24 13:24:33,140 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:24:33 INFO - 2016-01-24 13:24:33,140 DEBUG : BROWSER_OUTPUT: 13:24:33 INFO - 2016-01-24 13:24:33,761 INFO : Browser exited with error code: 0 13:24:33 INFO - 2016-01-24 13:24:33,785 INFO : Completed test dromaeo_css (00:18:28) 13:24:33 INFO - 2016-01-24 13:24:33,785 INFO : Starting test kraken 13:24:33 INFO - 2016-01-24 13:24:33,785 DEBUG : operating with platform_type : linux_ 13:24:33 INFO - 2016-01-24 13:24:33,785 INFO : Initialising browser for kraken test... 13:24:33 INFO - 2016-01-24 13:24:33,791 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUJvRam/profile http://localhost:46491/getInfo.html 13:24:37 INFO - 2016-01-24 13:24:37,352 DEBUG : BROWSER_OUTPUT: 13:24:37 INFO - 2016-01-24 13:24:37,352 DEBUG : BROWSER_OUTPUT: (process:11312): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:24:38 INFO - 2016-01-24 13:24:38,257 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:24:38 INFO - 2016-01-24 13:24:38,257 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:24:38 INFO - 2016-01-24 13:24:38,257 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:24:38 INFO - 2016-01-24 13:24:38,257 DEBUG : BROWSER_OUTPUT: __metrics 13:24:39 INFO - 2016-01-24 13:24:39,229 INFO : Browser initialized. 13:24:39 INFO - 2016-01-24 13:24:39,230 INFO : Running cycle 1/1 for kraken test... 13:24:39 INFO - 2016-01-24 13:24:39,230 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUJvRam/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:24:40 INFO - 2016-01-24 13:24:40,554 DEBUG : BROWSER_OUTPUT: 13:24:40 INFO - 2016-01-24 13:24:40,554 DEBUG : BROWSER_OUTPUT: (process:11426): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:24:51 INFO - 2016-01-24 13:24:51,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 136253440 13:24:51 INFO - 2016-01-24 13:24:51,059 DEBUG : BROWSER_OUTPUT: 13:24:53 INFO - 2016-01-24 13:24:53,522 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46491/tests/kraken/driver.html?testName=audio-beat-detection) 13:24:54 INFO - 2016-01-24 13:24:54,129 DEBUG : BROWSER_OUTPUT: RSS: Main: 138989568 13:24:54 INFO - 2016-01-24 13:24:54,130 DEBUG : BROWSER_OUTPUT: 13:24:56 INFO - 2016-01-24 13:24:56,687 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46491/tests/kraken/driver.html?testName=audio-dft) 13:24:57 INFO - 2016-01-24 13:24:57,281 DEBUG : BROWSER_OUTPUT: RSS: Main: 138334208 13:24:57 INFO - 2016-01-24 13:24:57,281 DEBUG : BROWSER_OUTPUT: 13:25:00 INFO - 2016-01-24 13:25:00,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46491/tests/kraken/driver.html?testName=audio-fft) 13:25:00 INFO - 2016-01-24 13:25:00,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 138772480 13:25:00 INFO - 2016-01-24 13:25:00,689 DEBUG : BROWSER_OUTPUT: 13:25:02 INFO - 2016-01-24 13:25:02,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46491/tests/kraken/driver.html?testName=audio-oscillator) 13:25:03 INFO - 2016-01-24 13:25:03,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 139542528 13:25:03 INFO - 2016-01-24 13:25:03,263 DEBUG : BROWSER_OUTPUT: 13:25:05 INFO - 2016-01-24 13:25:05,458 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46491/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:25:06 INFO - 2016-01-24 13:25:06,040 DEBUG : BROWSER_OUTPUT: RSS: Main: 138199040 13:25:06 INFO - 2016-01-24 13:25:06,040 DEBUG : BROWSER_OUTPUT: 13:25:08 INFO - 2016-01-24 13:25:08,972 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46491/tests/kraken/driver.html?testName=imaging-darkroom) 13:25:09 INFO - 2016-01-24 13:25:09,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 139030528 13:25:09 INFO - 2016-01-24 13:25:09,559 DEBUG : BROWSER_OUTPUT: 13:25:12 INFO - 2016-01-24 13:25:12,966 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46491/tests/kraken/driver.html?testName=imaging-desaturate) 13:25:13 INFO - 2016-01-24 13:25:13,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 139321344 13:25:13 INFO - 2016-01-24 13:25:13,555 DEBUG : BROWSER_OUTPUT: 13:25:16 INFO - 2016-01-24 13:25:16,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46491/tests/kraken/driver.html?testName=json-parse-financial) 13:25:16 INFO - 2016-01-24 13:25:16,938 DEBUG : BROWSER_OUTPUT: RSS: Main: 138452992 13:25:16 INFO - 2016-01-24 13:25:16,938 DEBUG : BROWSER_OUTPUT: 13:25:18 INFO - 2016-01-24 13:25:18,527 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46491/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:25:19 INFO - 2016-01-24 13:25:19,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 138326016 13:25:19 INFO - 2016-01-24 13:25:19,095 DEBUG : BROWSER_OUTPUT: 13:25:20 INFO - 2016-01-24 13:25:20,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46491/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:25:21 INFO - 2016-01-24 13:25:21,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 138412032 13:25:21 INFO - 2016-01-24 13:25:21,460 DEBUG : BROWSER_OUTPUT: 13:25:23 INFO - 2016-01-24 13:25:23,463 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46491/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:25:24 INFO - 2016-01-24 13:25:24,049 DEBUG : BROWSER_OUTPUT: RSS: Main: 138952704 13:25:24 INFO - 2016-01-24 13:25:24,049 DEBUG : BROWSER_OUTPUT: 13:25:26 INFO - 2016-01-24 13:25:26,486 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:25:27 INFO - 2016-01-24 13:25:27,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 138555392 13:25:27 INFO - 2016-01-24 13:25:27,080 DEBUG : BROWSER_OUTPUT: 13:25:29 INFO - 2016-01-24 13:25:29,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:25:30 INFO - 2016-01-24 13:25:30,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 138555392 13:25:30 INFO - 2016-01-24 13:25:30,202 DEBUG : BROWSER_OUTPUT: 13:25:31 INFO - 2016-01-24 13:25:31,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46491/tests/kraken/driver.html?testName=ai-astar) 13:25:32 INFO - 2016-01-24 13:25:32,127 DEBUG : BROWSER_OUTPUT: RSS: Main: 140156928 13:25:32 INFO - 2016-01-24 13:25:32,127 DEBUG : BROWSER_OUTPUT: 13:25:32 INFO - 2016-01-24 13:25:32,127 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:25:32 INFO - 2016-01-24 13:25:32,127 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:25:32 INFO - 2016-01-24 13:25:32,127 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:25:32 INFO - 2016-01-24 13:25:32,128 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:25:32 INFO - 2016-01-24 13:25:32,128 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;105;111;109;112;120;110;111;111;111 13:25:32 INFO - 2016-01-24 13:25:32,128 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;124;146;156;125;154;147;124;158;123 13:25:32 INFO - 2016-01-24 13:25:32,128 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;162;161;163;161;161;162;164;163 13:25:32 INFO - 2016-01-24 13:25:32,129 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;72;72;150;74;72;72;73;159;71 13:25:32 INFO - 2016-01-24 13:25:32,129 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;141;92;93;93;136;92;93;145 13:25:32 INFO - 2016-01-24 13:25:32,129 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;111;110;109;111;111;110;110;110 13:25:32 INFO - 2016-01-24 13:25:32,130 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;147;146;147;146;146;147;146;147;146 13:25:32 INFO - 2016-01-24 13:25:32,130 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;102;96;97;96 13:25:32 INFO - 2016-01-24 13:25:32,130 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;63;58;60;61;64;62;60;59;59 13:25:32 INFO - 2016-01-24 13:25:32,130 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;63;64;64;66;63;64;64;64;64 13:25:32 INFO - 2016-01-24 13:25:32,131 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;89;82;82;81;83;82;83;85 13:25:32 INFO - 2016-01-24 13:25:32,131 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;113;118;130;126;120;117;127;124;117 13:25:32 INFO - 2016-01-24 13:25:32,131 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;143;154;146;161;144;145;145;142;145 13:25:32 INFO - 2016-01-24 13:25:32,131 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;68;68;67;66;66;66;66;67;67 13:25:32 INFO - 2016-01-24 13:25:32,131 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:25:32 INFO - 2016-01-24 13:25:32,132 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:25:32 INFO - 2016-01-24 13:25:32,132 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,700 13:25:32 INFO - 2016-01-24 13:25:32,132 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:25:32 INFO - 2016-01-24 13:25:32,132 DEBUG : BROWSER_OUTPUT: __startTimestamp1453670732126__endTimestamp 13:25:32 INFO - 2016-01-24 13:25:32,133 DEBUG : BROWSER_OUTPUT: 13:25:32 INFO - 2016-01-24 13:25:32,134 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:25:32 INFO - 2016-01-24 13:25:32,134 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:25:32 INFO - 2016-01-24 13:25:32,135 DEBUG : BROWSER_OUTPUT: 13:25:32 INFO - 2016-01-24 13:25:32,135 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:3.71 (3.3%) stddev-sans-first:3.92 13:25:32 INFO - 2016-01-24 13:25:32,135 DEBUG : BROWSER_OUTPUT: Values: 112.0 105.0 111.0 109.0 112.0 120.0 110.0 111.0 111.0 111.0 13:25:32 INFO - 2016-01-24 13:25:32,136 DEBUG : BROWSER_OUTPUT: 13:25:32 INFO - 2016-01-24 13:25:32,136 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.20 Median:146.50 stddev:14.57 (9.9%) stddev-sans-first:15.35 13:25:32 INFO - 2016-01-24 13:25:32,136 DEBUG : BROWSER_OUTPUT: Values: 145.0 124.0 146.0 156.0 125.0 154.0 147.0 124.0 158.0 123.0 13:25:32 INFO - 2016-01-24 13:25:32,136 DEBUG : BROWSER_OUTPUT: 13:25:32 INFO - 2016-01-24 13:25:32,137 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 13:25:32 INFO - 2016-01-24 13:25:32,137 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 162.0 161.0 163.0 161.0 161.0 162.0 164.0 163.0 13:25:32 INFO - 2016-01-24 13:25:32,137 DEBUG : BROWSER_OUTPUT: 13:25:32 INFO - 2016-01-24 13:25:32,137 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.90 Median:72.00 stddev:34.65 (48.1%) stddev-sans-first:36.33 13:25:32 INFO - 2016-01-24 13:25:32,137 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 72.0 150.0 74.0 72.0 72.0 73.0 159.0 71.0 13:25:32 INFO - 2016-01-24 13:25:32,138 DEBUG : BROWSER_OUTPUT: 13:25:32 INFO - 2016-01-24 13:25:32,138 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.00 Median:92.50 stddev:23.33 (25.2%) stddev-sans-first:24.11 13:25:32 INFO - 2016-01-24 13:25:32,138 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 141.0 92.0 93.0 93.0 136.0 92.0 93.0 145.0 13:25:32 INFO - 2016-01-24 13:25:32,138 DEBUG : BROWSER_OUTPUT: 13:25:32 INFO - 2016-01-24 13:25:32,138 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 13:25:32 INFO - 2016-01-24 13:25:32,138 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 111.0 110.0 109.0 111.0 111.0 110.0 110.0 110.0 13:25:32 INFO - 2016-01-24 13:25:32,138 DEBUG : BROWSER_OUTPUT: 13:25:32 INFO - 2016-01-24 13:25:32,138 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.95 (0.6%) stddev-sans-first:0.53 13:25:32 INFO - 2016-01-24 13:25:32,139 DEBUG : BROWSER_OUTPUT: Values: 149.0 147.0 146.0 147.0 146.0 146.0 147.0 146.0 147.0 146.0 13:25:32 INFO - 2016-01-24 13:25:32,139 DEBUG : BROWSER_OUTPUT: 13:25:32 INFO - 2016-01-24 13:25:32,139 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:1.89 (2.0%) stddev-sans-first:1.99 13:25:32 INFO - 2016-01-24 13:25:32,140 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 102.0 96.0 97.0 96.0 13:25:32 INFO - 2016-01-24 13:25:32,140 DEBUG : BROWSER_OUTPUT: 13:25:32 INFO - 2016-01-24 13:25:32,140 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.40 Median:60.50 stddev:2.07 (3.4%) stddev-sans-first:2.00 13:25:32 INFO - 2016-01-24 13:25:32,140 DEBUG : BROWSER_OUTPUT: Values: 58.0 63.0 58.0 60.0 61.0 64.0 62.0 60.0 59.0 59.0 13:25:32 INFO - 2016-01-24 13:25:32,140 DEBUG : BROWSER_OUTPUT: 13:25:32 INFO - 2016-01-24 13:25:32,141 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 13:25:32 INFO - 2016-01-24 13:25:32,141 DEBUG : BROWSER_OUTPUT: Values: 64.0 63.0 64.0 64.0 66.0 63.0 64.0 64.0 64.0 64.0 13:25:32 INFO - 2016-01-24 13:25:32,141 DEBUG : BROWSER_OUTPUT: 13:25:32 INFO - 2016-01-24 13:25:32,141 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:2.31 (2.8%) stddev-sans-first:2.40 13:25:32 INFO - 2016-01-24 13:25:32,141 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 89.0 82.0 82.0 81.0 83.0 82.0 83.0 85.0 13:25:32 INFO - 2016-01-24 13:25:32,141 DEBUG : BROWSER_OUTPUT: 13:25:32 INFO - 2016-01-24 13:25:32,141 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:122.00 stddev:5.59 (4.6%) stddev-sans-first:5.66 13:25:32 INFO - 2016-01-24 13:25:32,141 DEBUG : BROWSER_OUTPUT: Values: 116.0 113.0 118.0 130.0 126.0 120.0 117.0 127.0 124.0 117.0 13:25:32 INFO - 2016-01-24 13:25:32,141 DEBUG : BROWSER_OUTPUT: 13:25:32 INFO - 2016-01-24 13:25:32,142 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.10 Median:145.00 stddev:6.84 (4.7%) stddev-sans-first:6.20 13:25:32 INFO - 2016-01-24 13:25:32,142 DEBUG : BROWSER_OUTPUT: Values: 136.0 143.0 154.0 146.0 161.0 144.0 145.0 145.0 142.0 145.0 13:25:32 INFO - 2016-01-24 13:25:32,142 DEBUG : BROWSER_OUTPUT: 13:25:32 INFO - 2016-01-24 13:25:32,142 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.55 (2.3%) stddev-sans-first:0.83 13:25:32 INFO - 2016-01-24 13:25:32,142 DEBUG : BROWSER_OUTPUT: Values: 71.0 68.0 68.0 67.0 66.0 66.0 66.0 66.0 67.0 67.0 13:25:32 INFO - 2016-01-24 13:25:32,142 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:25:32 INFO - 2016-01-24 13:25:32,142 DEBUG : BROWSER_OUTPUT: 13:25:32 INFO - 2016-01-24 13:25:32,973 INFO : Browser exited with error code: 0 13:25:33 INFO - 2016-01-24 13:25:33,027 INFO : Completed test kraken (00:00:59) 13:25:33 INFO - 2016-01-24 13:25:33,028 INFO : Starting test v8_7 13:25:33 INFO - 2016-01-24 13:25:33,028 DEBUG : operating with platform_type : linux_ 13:25:33 INFO - 2016-01-24 13:25:33,028 INFO : Initialising browser for v8_7 test... 13:25:33 INFO - 2016-01-24 13:25:33,034 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsTzhzb/profile http://localhost:46491/getInfo.html 13:25:36 INFO - 2016-01-24 13:25:36,814 DEBUG : BROWSER_OUTPUT: 13:25:36 INFO - 2016-01-24 13:25:36,815 DEBUG : BROWSER_OUTPUT: (process:11734): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:25:37 INFO - 2016-01-24 13:25:37,670 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:25:37 INFO - 2016-01-24 13:25:37,670 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:25:37 INFO - 2016-01-24 13:25:37,670 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:25:37 INFO - 2016-01-24 13:25:37,670 DEBUG : BROWSER_OUTPUT: __metrics 13:25:38 INFO - 2016-01-24 13:25:38,729 INFO : Browser initialized. 13:25:38 INFO - 2016-01-24 13:25:38,730 INFO : Running cycle 1/1 for v8_7 test... 13:25:38 INFO - 2016-01-24 13:25:38,730 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsTzhzb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:25:40 INFO - 2016-01-24 13:25:40,000 DEBUG : BROWSER_OUTPUT: 13:25:40 INFO - 2016-01-24 13:25:40,001 DEBUG : BROWSER_OUTPUT: (process:11847): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:25:50 INFO - 2016-01-24 13:25:50,503 DEBUG : BROWSER_OUTPUT: RSS: Main: 135831552 13:25:50 INFO - 2016-01-24 13:25:50,503 DEBUG : BROWSER_OUTPUT: 13:26:11 INFO - 2016-01-24 13:26:11,876 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46491/tests/v8_7/run.html (next: http://localhost:46491/tests/v8_7/run.html) 13:26:12 INFO - 2016-01-24 13:26:12,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 136269824 13:26:12 INFO - 2016-01-24 13:26:12,119 DEBUG : BROWSER_OUTPUT: 13:26:12 INFO - 2016-01-24 13:26:12,120 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:26:12 INFO - 2016-01-24 13:26:12,120 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:26:12 INFO - 2016-01-24 13:26:12,120 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:26:12 INFO - 2016-01-24 13:26:12,120 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:26:12 INFO - 2016-01-24 13:26:12,121 DEBUG : BROWSER_OUTPUT: |0;Richards;166.36167027116952 13:26:12 INFO - 2016-01-24 13:26:12,121 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.000668002672 13:26:12 INFO - 2016-01-24 13:26:12,121 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.28611898017 13:26:12 INFO - 2016-01-24 13:26:12,121 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 13:26:12 INFO - 2016-01-24 13:26:12,121 DEBUG : BROWSER_OUTPUT: |4;RayTrace;936.3295880149813 13:26:12 INFO - 2016-01-24 13:26:12,121 DEBUG : BROWSER_OUTPUT: |5;Earley;552.4861878453039 13:26:12 INFO - 2016-01-24 13:26:12,121 DEBUG : BROWSER_OUTPUT: |6;Boyer;10923.91304347826 13:26:12 INFO - 2016-01-24 13:26:12,122 DEBUG : BROWSER_OUTPUT: |7;RegExp;24214.285714285714 13:26:12 INFO - 2016-01-24 13:26:12,122 DEBUG : BROWSER_OUTPUT: |8;Splay;529.6899632159748 13:26:12 INFO - 2016-01-24 13:26:12,122 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 13:26:12 INFO - 2016-01-24 13:26:12,122 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:26:12 INFO - 2016-01-24 13:26:12,123 DEBUG : BROWSER_OUTPUT: __startTimestamp1453670772119__endTimestamp 13:26:12 INFO - 2016-01-24 13:26:12,123 DEBUG : BROWSER_OUTPUT: 13:26:12 INFO - 2016-01-24 13:26:12,123 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:26:12 INFO - 2016-01-24 13:26:12,123 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:26:12 INFO - 2016-01-24 13:26:12,123 DEBUG : BROWSER_OUTPUT: 13:26:12 INFO - 2016-01-24 13:26:12,123 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.36 Median:166.36 stddev:0.00 (0.0%) 13:26:12 INFO - 2016-01-24 13:26:12,124 DEBUG : BROWSER_OUTPUT: Values: 166.4 13:26:12 INFO - 2016-01-24 13:26:12,124 DEBUG : BROWSER_OUTPUT: 13:26:12 INFO - 2016-01-24 13:26:12,124 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.00 Median:167.00 stddev:0.00 (0.0%) 13:26:12 INFO - 2016-01-24 13:26:12,124 DEBUG : BROWSER_OUTPUT: Values: 167.0 13:26:12 INFO - 2016-01-24 13:26:12,124 DEBUG : BROWSER_OUTPUT: 13:26:12 INFO - 2016-01-24 13:26:12,125 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.29 Median:283.29 stddev:0.00 (0.0%) 13:26:12 INFO - 2016-01-24 13:26:12,125 DEBUG : BROWSER_OUTPUT: Values: 283.3 13:26:12 INFO - 2016-01-24 13:26:12,125 DEBUG : BROWSER_OUTPUT: 13:26:12 INFO - 2016-01-24 13:26:12,125 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 13:26:12 INFO - 2016-01-24 13:26:12,125 DEBUG : BROWSER_OUTPUT: Values: 5186.5 13:26:12 INFO - 2016-01-24 13:26:12,126 DEBUG : BROWSER_OUTPUT: 13:26:12 INFO - 2016-01-24 13:26:12,127 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:936.33 Median:936.33 stddev:0.00 (0.0%) 13:26:12 INFO - 2016-01-24 13:26:12,127 DEBUG : BROWSER_OUTPUT: Values: 936.3 13:26:12 INFO - 2016-01-24 13:26:12,127 DEBUG : BROWSER_OUTPUT: 13:26:12 INFO - 2016-01-24 13:26:12,127 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:552.49 Median:552.49 stddev:0.00 (0.0%) 13:26:12 INFO - 2016-01-24 13:26:12,128 DEBUG : BROWSER_OUTPUT: Values: 552.5 13:26:12 INFO - 2016-01-24 13:26:12,128 DEBUG : BROWSER_OUTPUT: 13:26:12 INFO - 2016-01-24 13:26:12,128 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10923.91 Median:10923.91 stddev:0.00 (0.0%) 13:26:12 INFO - 2016-01-24 13:26:12,128 DEBUG : BROWSER_OUTPUT: Values: 10923.9 13:26:12 INFO - 2016-01-24 13:26:12,128 DEBUG : BROWSER_OUTPUT: 13:26:12 INFO - 2016-01-24 13:26:12,128 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24214.29 Median:24214.29 stddev:0.00 (0.0%) 13:26:12 INFO - 2016-01-24 13:26:12,128 DEBUG : BROWSER_OUTPUT: Values: 24214.3 13:26:12 INFO - 2016-01-24 13:26:12,129 DEBUG : BROWSER_OUTPUT: 13:26:12 INFO - 2016-01-24 13:26:12,129 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:529.69 Median:529.69 stddev:0.00 (0.0%) 13:26:12 INFO - 2016-01-24 13:26:12,129 DEBUG : BROWSER_OUTPUT: Values: 529.7 13:26:12 INFO - 2016-01-24 13:26:12,129 DEBUG : BROWSER_OUTPUT: 13:26:12 INFO - 2016-01-24 13:26:12,129 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 13:26:12 INFO - 2016-01-24 13:26:12,129 DEBUG : BROWSER_OUTPUT: Values: 4826.9 13:26:12 INFO - 2016-01-24 13:26:12,129 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:26:12 INFO - 2016-01-24 13:26:12,129 DEBUG : BROWSER_OUTPUT: 13:26:12 INFO - 2016-01-24 13:26:12,909 INFO : Browser exited with error code: 0 13:26:12 INFO - 2016-01-24 13:26:12,926 INFO : Completed test v8_7 (00:00:39) 13:26:13 INFO - 2016-01-24 13:26:13,151 INFO : Completed test suite (00:20:07) 13:26:13 INFO - 2016-01-24 13:26:13,151 DEBUG : Working with test: dromaeo_css 13:26:13 INFO - 2016-01-24 13:26:13,151 DEBUG : Generating results file: dromaeo_css 13:26:13 INFO - 2016-01-24 13:26:13,152 DEBUG : Working with test: kraken 13:26:13 INFO - 2016-01-24 13:26:13,152 DEBUG : Generating results file: kraken 13:26:13 INFO - 2016-01-24 13:26:13,153 INFO : javascript benchmark 13:26:13 INFO - 2016-01-24 13:26:13,153 DEBUG : Working with test: v8_7 13:26:13 INFO - 2016-01-24 13:26:13,153 DEBUG : Generating results file: v8_7 13:26:13 INFO - 2016-01-24 13:26:13,153 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:26:13 INFO - 2016-01-24 13:26:13,303 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 13:26:13 INFO - 2016-01-24 13:26:13,303 DEBUG : process_Request line: dromaeo_css 7290.63 graph.html#tests=[[72,52,43]] 13:26:13 INFO - 2016-01-24 13:26:13,303 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:26:13 INFO - 2016-01-24 13:26:13,452 DEBUG : process_Request line: kraken 1504.80 graph.html#tests=[[232,52,43]] 13:26:13 INFO - 2016-01-24 13:26:13,453 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:26:13 INFO - 2016-01-24 13:26:13,487 DEBUG : process_Request line: v8_7 23117.24 graph.html#tests=[[230,52,43]] 13:26:13 INFO - 2016-01-24 13:26:13,488 INFO : javascript benchmark 13:26:13 INFO - 2016-01-24 13:26:13,492 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3229.4187046331663, 3271.2966712156895, 3287.3589650018257, 3307.4542700454426, 3317.9336413271726, 5401.459854014596, 5409.24270602115, 5420.1327787554, 5450.209719590657, 5458.235846981416, 5524.861878453031, 5528.723563821803, 5529.419410961851, 5542.944570554293, 5542.972285138579, 5027.994401119772, 5048.1670524363435, 5117.13008788505, 5129.3844738631415, 5146.099432599299, 4832.106060378824, 5001.8499445016705, 5020.924686129711, 5073.695578265298, 5199.0, 4993.975030124862, 5059.898802023958, 5067.239914012891, 5070.5183007614405, 5174.922376164361, 5097.464766199551, 5129.512696293846, 5155.871103222412, 5171.974140129275, 5181.093308670967, 4872.317875497433, 4907.337509436216, 4995.875103122415, 5046.142155833517, 5056.924146137811, 5332.493413125747, 5350.0, 5411.404745477994, 5415.970965516539, 5421.322334708161, 5939.376365481606, 5943.0, 5949.732262048218, 6002.699865006733, 6013.51891848651, 5745.454181852718, 5884.411558844125, 5961.314448838396, 6055.394460553954, 6091.329953705089, 5553.16702494625, 5589.133684278943, 5590.972045139789, 5594.748236329375, 5595.1886976388605, 6089.934261504219, 6094.146819445281, 6112.816615501542, 6113.786017489367, 6117.327094019654, 5638.689872057076, 5718.399568045378, 5718.7426565804635, 5721.427857214246, 5726.055200891889, 5968.403159683997, 5994.340622531518, 5995.670238136944, 5996.430339117776, 6002.369751176151, 5911.556633252438, 5947.167396564484, 5957.106434034843, 5957.821265362046, 5986.910196347058, 5774.884502310014, 5828.708564571754, 5856.12158176277, 5904.291485021825, 5919.6152250103605, 4560.361549383089, 4573.519780423074, 4588.220002599566, 4592.242280023758, 4614.769261536977, 4092.7544347339253, 4092.7748973806724, 4093.549709532009, 4099.487564054493, 4128.6284234418445, 5516.089845175581, 5611.579131565149, 5681.204631351614, 5704.828855134353, 5737.88524229513, 5994.190784244159, 6006.939930600638, 6017.0, 6043.7884674036195, 6059.848503787441, 5556.055470570012, 5718.628289161191, 5744.109663002241, 5751.396103409165, 5774.566907481872, 5067.670601410897, 5133.512316329943, 5147.0, 5157.613179011589, 5171.7672704728375, 6111.755529778759, 6114.938850611437, 6120.479759220427, 6126.724297406628, 6150.538709596798, 5815.3603103657715, 5916.940830591811, 5924.822255332347, 5963.761449541969, 6014.308354539284, 6041.426064523863, 6093.361679192721, 6153.72308246139, 6159.260888693386, 6164.938350616437, 5851.765929362778, 5877.118432235199, 5896.3514013457625, 5909.409059094056, 5923.259592550931, 5767.0196066669605, 5870.647761134345, 5906.4093590642315, 5949.583529153091, 5987.910181347196, 5828.184054232495, 5828.883422331614, 5833.504152147115, 5843.2695913010875, 5850.180974663465, 5827.1841942127285, 5827.358990511125, 5833.270841144857, 5839.795607153899, 5848.883022339444, 5518.972405138109, 5644.350899646429, 5648.604597678123, 5734.913976290442, 5747.0, 5847.532197424281, 5876.970615146897, 5878.177055212359, 5881.088431293157, 5902.291724992857, 5721.885562288648, 5742.08126699726, 5774.971125144348, 5792.82621521355, 5802.854928626649], "unit": "ms", "name": "dojo.html", "value": 5481.03295607034}, {"lowerIsBetter": false, "replicates": [586.8034208540139, 621.7481919822468, 623.2458724942819, 647.45937142486, 648.1832890557897, 32243.83878080609, 38529.0, 38662.80668596656, 38799.030024249405, 38911.80544097283, 44543.0, 45015.54984450155, 45486.0, 45543.316850247276, 45572.54427455724, 8927.642894284238, 9101.726948191565, 9164.679236226733, 9174.633014679404, 9181.0, 8950.373473856833, 8997.325200609948, 9026.368154229207, 9035.36752427327, 9054.004059553445, 8916.554172291391, 8938.955305223464, 8961.103889611019, 8999.280057595377, 9072.0, 9019.323550733721, 9112.772180695469, 9124.635014599407, 9126.224270936911, 9134.817303653923, 8856.778580535474, 8917.732468025904, 8951.55242237892, 8976.8653470198, 8985.46087234768, 42379.57620423787, 43015.78492107551, 43073.56926430727, 43311.78344108291, 43354.34968475475, 3490.427391166187, 3517.56030496188, 3523.5243242162237, 3676.9816150919073, 3732.0669832541867, 32162.195945101324, 32979.6702032979, 33053.6694633053, 33412.33175336479, 33804.49293260603, 4121.649659778923, 4258.169656916903, 4302.182585308781, 4317.395564620955, 4339.816978964461, 291934.0, 294189.99999999785, 294615.0, 295456.0, 296408.0, 44467.555324446344, 44493.55506444894, 44582.55417445849, 44774.10451790946, 45046.0, 42890.57109428866, 42892.571074288855, 43086.78456607759, 43232.35151472731, 43279.78360108179, 15127.470538531099, 15172.165530895907, 15337.846621533865, 15347.539573812803, 15364.154971476675, 11954.701132471759, 11999.760004799855, 12044.457999390048, 12068.396580170956, 12265.325407102517, 15290.770638440432, 15353.155576443403, 15354.84645153534, 15390.538283851502, 15440.922795386175, 6085.5435842312, 6301.7164227608955, 6361.872762544724, 6367.90448143269, 6375.681215939185, 1000.9599616015278, 1049.8320268757116, 1085.6033066082334, 1113.9832902506469, 1142.057802313095, 29393.265168370963, 29683.257918552208, 29884.0, 30247.546286805715, 30314.242143946136, 1075.499892549968, 1144.5250221158292, 1196.1925700152362, 1205.879412058787, 1252.4113666576877, 14748.852511474748, 14887.776683349759, 14906.92546537282, 15011.0, 15338.309776060105, 423474.0, 554277.0, 563719.0, 566615.0, 770394.0, 55256.72371638116, 57051.0, 57612.423875761546, 57666.99999999916, 57677.134842977386, 1509.1322489568543, 1528.801255836734, 1530.900491468051, 1533.4556232537511, 1535.731247031765, 31105.377892442477, 31560.0, 31828.204294892814, 32158.0, 32363.838180808943, 50721.239181413046, 50756.0, 51075.48924510707, 51188.74405628097, 51216.0, 315832.0, 316390.0, 316767.0, 317865.0, 317953.0, 35043.64956350506, 35095.649043509235, 35507.289854203285, 35617.64382356143, 50628.24057639065, 48889.51110488992, 48907.51092489172, 48941.510584893695, 49054.30201338818, 49984.500154997986, 41615.58384416117, 41775.373369398876, 42312.365314520925, 43002.78498607612, 43132.56867431285, 41012.58987410207, 41117.79441102895, 41144.43867151607, 41547.58452415437, 41628.79185604052, 43842.0, 43948.780256098515, 44462.333065003404, 44552.0, 44958.77520612376, 32819.0, 33563.83218083992, 33666.326673465905, 33736.325273494884, 34057.0, 26319.736802631727, 26750.680792701292, 27180.0, 27198.0, 27426.451470970867], "unit": "ms", "name": "ext.html", "value": 19492.8344872632}, {"lowerIsBetter": false, "replicates": [383.56355448844084, 384.40417353102686, 387.56979752474746, 388.3340071776903, 393.3823896482522, 15847.762283565728, 16946.83053169468, 17899.28402863884, 19827.50431239218, 20002.799972000277, 11392.25950313229, 11555.24890882092, 11743.7064073398, 17343.392981245626, 17364.39224627138, 4695.976520117395, 5279.472052794728, 5306.09796334624, 5307.310049693534, 5767.423257674241, 5287.180487024518, 5456.454354564532, 5457.072297709379, 5459.290292262001, 5686.886262274752, 5356.0, 5406.324209473816, 5428.809991650293, 5679.744411501471, 5719.084946408576, 5657.660540367591, 5690.032694441955, 5713.657180569137, 5719.913216488874, 5732.856678583027, 5192.247124166975, 5272.6309158358545, 5301.204819277101, 5493.0, 5496.422875598085, 12999.0, 12999.0, 14767.630809229748, 20274.29039983608, 20372.898135509375, 2176.5320456101854, 2204.063273108922, 2237.3511681612313, 2293.0254641777346, 2442.8167887408517, 9674.613015479372, 9757.219422446258, 9837.803243935154, 9855.211583073336, 10176.796464070678, 1931.9710204346945, 1974.565595568987, 1986.255154317131, 2015.4256037029522, 2024.6659301215282, 62826.0, 64810.0, 65171.0, 65548.67225663889, 67234.0, 10567.15462762977, 10818.134549236041, 10950.39772812503, 10960.232783705223, 10992.395418252074, 14306.713865722628, 14391.640208994859, 14414.783778243334, 14434.278286085653, 14434.494792682415, 7930.41391721658, 8028.0, 8029.317508011768, 8057.395695322874, 8115.269625733712, 7779.805504862424, 7841.803954901173, 7846.136924938252, 7850.803729906798, 7885.645145968445, 4550.13547425988, 4618.468876079294, 4640.721556706609, 4679.181143299909, 4731.408573928259, 1973.7236786849853, 1998.0109845626507, 2006.839452843769, 2017.9899100504404, 2027.7161197432372, 1020.6325722739808, 1024.4212020208706, 1046.4663021858908, 1070.635983765508, 1071.8767341755643, 17124.571885702957, 18046.368377106737, 18388.632227355647, 18517.722234166496, 18704.158312875952, 957.7270477913901, 979.8155993022676, 1041.4376236832177, 1049.1030169205371, 1083.7073990022807, 9687.840669815952, 9776.706698799047, 9802.313838031268, 9822.214222862154, 9949.0, 660564.0, 677158.0, 684378.0, 685988.0, 694893.0, 85201.57399212965, 85667.57166214254, 87174.0, 87670.56164719263, 88640.5567972169, 1233.944977044614, 1240.2372540887288, 1244.3778110944527, 1247.7754004279136, 1248.1699669719717, 15084.170370629281, 15131.697366052838, 15389.769153462483, 15527.146006969273, 15695.215239237765, 34277.31445371128, 34515.309693806485, 34977.825110874284, 35079.82460087785, 35509.28981420409, 52206.738966304925, 52305.47694523006, 54921.45078549323, 55038.17442738282, 56379.43620563906, 10334.173266138841, 10426.635067772895, 10454.215933805148, 10490.632827851294, 10491.055804977588, 14340.426382944564, 14953.0, 17117.486475405756, 18240.361587344378, 18284.908575457037, 15348.539543813704, 15454.0, 15799.289031993358, 15981.121038343003, 16077.67844643124, 14807.0, 14839.554813355617, 15209.77185342243, 15724.68550629004, 15766.763498547301, 15517.612059698598, 15542.766858496905, 15556.222188890737, 15980.0, 16066.357345706041, 9798.363106398061, 10009.899901001188, 10036.799264014824, 10203.69388918304, 10230.488475576043, 13425.395857186646, 14563.92718036403, 14610.561683149523, 14679.926600366929, 14818.851811481747], "unit": "ms", "name": "jquery.html", "value": 9320.014341204114}, {"lowerIsBetter": false, "replicates": [1565.2017471089748, 1583.6199312165077, 1824.0, 1835.4218421197324, 1863.6831738604435, 7241.782746517613, 7411.14771801243, 7753.224677532244, 8013.879791803128, 8038.799030024245, 7556.5466072035715, 7663.386929045677, 7787.610619469018, 7820.413468989835, 7826.373890088779, 2212.6017316882912, 2236.1279101150485, 2249.752527222004, 2251.5271792923504, 2253.54929014197, 2276.2829708641807, 2294.6328587426015, 2328.685627440291, 2335.3927978725483, 2344.0858065354523, 2204.9669254961186, 2227.365200917731, 2228.9331320060423, 2263.1400067974146, 2288.439332363573, 2302.458922153293, 2318.8840557972035, 2339.228054741931, 2347.5539647466926, 2351.0713268259115, 2356.8350215484925, 2359.8466099703464, 2368.0, 2386.6181410974336, 2388.725296590897, 8091.39314551411, 8103.756887293391, 8120.837583248361, 8153.347732181412, 8179.018517777845, 4718.8584342469785, 4720.716756994591, 4738.2892566115015, 4761.095391875532, 4763.737994410306, 3076.9846150769326, 3101.209191656113, 3115.719585237317, 3122.4223518649123, 3144.1982294514983, 1062.3360399750156, 1066.1257768629728, 1077.6551503518876, 1082.9404382758946, 1089.1504626391427, 10830.079443247334, 10898.346099234072, 10935.28920620165, 10936.56253749849, 10943.671689849318, 4177.289860723684, 4230.450041494586, 4233.428487154257, 4247.384129301296, 4291.570842915746, 9361.672341468016, 9439.858402123973, 9444.433333999981, 9451.29115316354, 9492.193163581172, 4745.240761478147, 4759.6668233223345, 4761.4524329701835, 4774.594159496482, 4776.379070720784, 4289.764062976504, 4300.397944287803, 4307.827686892552, 4403.3174857897075, 4416.6908316418185, 3569.0720412692885, 3570.803605801706, 3571.6428357164077, 3592.1199306169633, 3596.748227624041, 1011.0546638892658, 1028.83024300991, 1030.525958059301, 1032.0762917189074, 1043.3948309980194, 1404.5571178289247, 1411.1462565147938, 1419.6096073579847, 1441.3874103505968, 1442.149132012097, 7674.462787604925, 7680.308772210527, 7685.116211635622, 7694.461387702919, 7801.570913599807, 481.90602832447337, 492.33534728116757, 492.704377373573, 496.99254511182363, 502.40214145167863, 6108.847278817976, 6146.231721034871, 6174.5060395168275, 6214.906776398358, 6232.0, 9430.0, 9684.128428441474, 9702.51487425626, 9838.06538378853, 9845.704628861145, 9245.676401325922, 9465.763355916019, 9630.181434577999, 9632.422054676741, 9649.276304277208, 7373.078365204349, 7420.109586849505, 7430.7399241026305, 7447.255274472401, 7500.7749767505975, 7741.5742134183165, 7819.491733037335, 7819.921800781919, 7885.763427097197, 7886.842263154819, 8711.0, 8725.52009639476, 8778.956105219433, 8963.865542017005, 9006.099390061203, 8833.558322083998, 8895.421797583136, 8931.062238465127, 8950.86573701408, 9182.67860624875, 6876.965615171892, 7070.4343652508705, 7075.150981882207, 7105.32499412555, 7191.208967013729, 7671.041119860018, 7712.267334603428, 7712.421568382506, 7725.806854828675, 7764.378849691898, 7303.890441643273, 7406.222346653739, 7412.8146796328365, 7552.207018263223, 7615.086189657055, 7053.717851286096, 7104.680289387094, 7185.2814718527725, 7286.089238845145, 7295.671694773641, 7244.311790379906, 7258.3104605062435, 7287.489875708649, 7304.598247096248, 7308.853822923618, 6477.935220647733, 6498.772542960974, 6509.609423434609, 6513.609183448819, 6523.282438931808, 6720.663966801542, 6814.557053791487, 6854.074699915447, 6869.072675188786, 6877.140357455318], "unit": "ms", "name": "mootools.html", "value": 4519.839626191479}, {"lowerIsBetter": false, "replicates": [368.9243705040467, 372.6143441538008, 375.9022654109934, 378.1548239684306, 379.4156998222737, 6260.186175797151, 6328.08242804793, 6333.018382150763, 6339.239291285046, 6434.453071488917, 6171.475424588915, 6331.4618257448055, 6333.0, 6334.814489001299, 6335.303116657175, 4894.2903279024695, 4904.215325547913, 4930.827421040264, 4933.235348520967, 4934.037862616791, 4918.729469879156, 4925.408950925894, 4928.285398617199, 4933.506649335073, 4934.901301973959, 4680.157571637104, 4820.686655367407, 4833.275008748681, 4855.951440485603, 4856.951430485685, 4819.9036019279765, 4821.783019764119, 4831.9275210871865, 4836.709797412132, 4837.492063333335, 4231.576842315774, 4232.619064284198, 4233.1322078973735, 4235.089455766994, 4245.066085461193, 5941.851453713692, 6035.517158627299, 6037.63774173551, 6041.5468839837185, 6041.879162416771, 5598.636088654265, 5606.495415412633, 5612.41069687681, 5614.157876318544, 5615.101583746581, 6652.334766523358, 6659.067730517731, 6664.633445160514, 6683.431908287801, 6692.59844409337, 4651.302304654295, 4656.557627025427, 4656.743879086649, 4667.579917807379, 4674.509176536449, 6883.552569082994, 6947.096877405905, 7005.82485437863, 7013.403860671798, 7035.366816986496, 4781.808727650855, 4789.137955168034, 4796.37647105874, 4811.109944660179, 4832.565069143794, 4891.437484689235, 4891.657583969088, 4892.143874821892, 4893.608511319086, 4897.632677549127, 5515.586331025189, 5625.521830644359, 5636.2391077204875, 5636.971815140898, 5645.774169033275, 6679.098321726602, 6718.697658605374, 6742.157230346207, 6743.494237932175, 6751.966240168767, 1683.1163639089332, 1715.5453804741753, 1727.6976529107608, 1727.870409719276, 1728.0150314320717, 1131.1911982932243, 1144.2619510415734, 1168.2873447197203, 1178.9646310610694, 1182.9645110646695, 6537.934620653733, 6566.244881838554, 6576.86846263072, 6577.177852768404, 6609.008648702733, 6895.4138898194215, 6914.274001229798, 6920.169579650374, 6928.272531384233, 6930.064441300461, 6437.227532696106, 6553.606783593, 6566.540342176002, 6569.57297775643, 6587.80236592903, 3738.775673459601, 3768.2651882882574, 3769.792661403649, 3769.8680546180753, 3771.189194323179, 7120.857582848314, 7138.464615153885, 7146.7141314346845, 7147.53541019832, 7149.642517874086, 6931.480138989596, 7028.8945665814035, 7077.398421134261, 7089.539179953286, 7101.82245443868, 7063.82340441493, 7073.3987611053635, 7099.538529995534, 7120.6795694194925, 7136.964315178391, 6886.552374095668, 6888.104546408935, 6903.344182302673, 6928.272531384334, 6936.965315173392, 6640.90038649411, 6806.693698783468, 6808.217055038536, 6832.419244364285, 6835.179778426621, 7071.222165561681, 7076.0801095857205, 7123.430125589836, 7140.357367836919, 7144.678489467882, 4752.714837109785, 4761.785719642555, 4775.498572649822, 4781.6891902026255, 4794.945112075337, 6793.270647218301, 6894.345037221456, 6919.8962015568795, 6928.891377379797, 6929.653517324013, 6715.160604924385, 6721.193456785217, 6725.058491811053, 6726.7981960541265, 6729.0915726376315, 6637.867242655217, 6686.765963191265, 6691.431228345645, 6691.59850408977, 6714.462842972648, 6453.386928241809, 6521.739130434729, 6538.542302038812, 6566.179227596551, 6612.338766123349, 6723.932760672331, 6735.090762747162, 6739.8542247817, 6740.595564266159, 6746.4940129489505, 6570.5400621956005, 6576.868462630625, 6578.04618330349, 6579.80260592183, 6580.638064906285], "unit": "ms", "name": "prototype.html", "value": 5083.933172548411}, {"lowerIsBetter": false, "replicates": [871.4509858788962, 935.8034812689335, 943.198281460758, 950.9857352139719, 951.7240000399885, 13032.674183145415, 13245.602631921034, 13341.2656354674, 13341.666458338546, 13357.332133393316, 12420.441080151393, 12490.687732806684, 12490.875091249085, 12500.0, 12522.68693282666, 892.6072528087636, 905.1355955062899, 915.1077699243251, 919.6321471411422, 920.2086205862953, 882.3470631732536, 887.7248053103558, 900.1358695652182, 901.5041727050129, 905.5789058087988, 935.242453612576, 949.4018768176074, 951.9571619277149, 953.1945506047414, 953.5184731710476, 938.9859152112724, 941.256407438123, 948.4072454715803, 948.4119845695678, 951.2342564235787, 698.322627051759, 701.7508784381522, 702.1188408547291, 703.5426972467936, 703.7431337561804, 14565.0, 14596.854031459656, 14631.561053168421, 14669.266536673123, 14720.779188312184, 12798.744025119446, 12816.80774788379, 13019.804702929463, 13040.999171984342, 13043.0, 10899.782004359948, 10985.560577576887, 11079.833802492969, 11131.666050018512, 11192.048675862561, 3918.9804050979565, 3926.195129998372, 3944.9211015779524, 3951.0517475805887, 3977.622125898035, 48683.51316486825, 49256.01487970256, 49300.50699492995, 49964.75017624888, 49997.0, 9742.269329800294, 9992.80014399708, 10165.542550585242, 10216.080552750289, 10224.846627300596, 18232.544186395182, 18235.90882045608, 18255.908720456577, 18257.17842697082, 18311.267549298147, 7711.768646940601, 7959.681612735426, 8047.597620118971, 8057.717979870794, 8224.62989165489, 4383.298672212431, 4399.472063352354, 4406.581374769392, 4455.465344158722, 4495.977520112378, 3187.888423905152, 3192.0902542775198, 3207.6792320767736, 3222.8388580570877, 3224.7742658013713, 580.2369883603048, 583.1922786940033, 599.901016332309, 607.6354187487473, 609.774383478116, 659.2846761263986, 664.329027682035, 696.5054811084086, 703.2369878681585, 717.2683862460261, 8251.422400432033, 8582.098879617675, 8717.0, 8727.138333682899, 8836.911630883738, 632.9113924050637, 644.7227692092446, 677.6476232359245, 693.0470602920983, 700.6916956539106, 4023.3160362738404, 4074.3888416737727, 4154.7328064939875, 4163.666906647461, 4182.895427614334, 59876.70061649664, 60473.0, 60599.0, 60627.69686151541, 61065.38934610686, 55494.44505554893, 55830.72084639632, 56010.0, 56139.719301404046, 56840.71579642075, 50418.0, 50667.493325067015, 50858.491415086115, 51366.0, 51973.220401694, 8171.959140204261, 8369.748907532783, 8430.70492532783, 8479.830403391774, 8549.27331176857, 34192.487112692834, 35011.46794721177, 35426.46860297046, 35583.0, 36872.63127368692, 42033.0, 42198.0, 46761.53238467572, 47419.52580474151, 47579.28631070467, 10934.125269978224, 11183.273087249629, 11192.272502287651, 11290.266132701348, 11509.309441433541, 12433.191842530206, 12501.56244531437, 12515.56195533152, 12619.810702839648, 12702.745945081231, 10821.729456763644, 10991.725206869573, 11028.28316159447, 11047.226694131656, 11050.115990720884, 10755.462226888469, 10829.24195306321, 10871.347719136877, 10917.853625369222, 11119.0, 10529.315594486334, 10560.84158737635, 10596.735081623021, 10954.287971281841, 11134.777304454028, 9550.761230969281, 9878.308518403643, 9956.352837065568, 10157.644482443078, 10160.593576257163, 9051.54742262871, 9303.255739540686, 9332.673356432493, 9370.297227708086, 9463.290253231173], "unit": "ms", "name": "yui.html", "value": 6562.613523342278}], "name": "dromaeo_css", "value": 7290.63477348401}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 111.0, 109.0, 112.0, 120.0, 110.0, 111.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [145.0, 124.0, 146.0, 156.0, 125.0, 154.0, 147.0, 124.0, 158.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.2}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 161.0, 163.0, 161.0, 161.0, 162.0, 164.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 72.0, 150.0, 74.0, 72.0, 72.0, 73.0, 159.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 88.9}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 141.0, 92.0, 93.0, 93.0, 136.0, 92.0, 93.0, 145.0], "unit": "ms", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 111.0, 110.0, 109.0, 111.0, 111.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 102.0, 96.0, 97.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [58.0, 63.0, 58.0, 60.0, 61.0, 64.0, 62.0, 60.0, 59.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 60.4}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 64.0, 64.0, 66.0, 63.0, 64.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.0}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 89.0, 82.0, 82.0, 81.0, 83.0, 82.0, 83.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [116.0, 113.0, 118.0, 130.0, 126.0, 120.0, 117.0, 127.0, 124.0, 117.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.8}, {"lowerIsBetter": true, "replicates": [136.0, 143.0, 154.0, 146.0, 161.0, 144.0, 145.0, 145.0, 142.0, 145.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.1}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 68.0, 67.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1504.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.36167027116952], "unit": "score", "name": "Richards", "value": 212.20032200000009}, {"lowerIsBetter": false, "replicates": [167.000668002672], "unit": "score", "name": "DeltaBlue", "value": 395.91458399999993}, {"lowerIsBetter": false, "replicates": [283.28611898017], "unit": "score", "name": "Encrypt", "value": 939.6189299999998}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [936.3295880149813], "unit": "score", "name": "RayTrace", "value": 790.3082519999997}, {"lowerIsBetter": false, "replicates": [552.4861878453039], "unit": "score", "name": "Earley", "value": 1206.29803}, {"lowerIsBetter": false, "replicates": [10923.91304347826], "unit": "score", "name": "Boyer", "value": 61.0095482587065}, {"lowerIsBetter": false, "replicates": [24214.285714285714], "unit": "score", "name": "RegExp", "value": 37.621799410029524}, {"lowerIsBetter": false, "replicates": [529.6899632159748], "unit": "score", "name": "Splay", "value": 153.84660019841272}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23117.24320344155}]} 13:26:13 INFO - RETURN: dromaeo_css: 7290.63 13:26:13 INFO - RETURN: kraken: 1504.80 13:26:13 INFO - RETURN: v8_7: 23117.24 13:26:13 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23117.24"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1504.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7290.63"}}} 13:26:13 INFO - Return code: 0 13:26:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:26:13 INFO - # TBPL SUCCESS # 13:26:13 INFO - Running post-action listener: _resource_record_post_action 13:26:13 INFO - Running post-run listener: _resource_record_post_run 13:26:14 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 262144; Write bytes: 520646656; Read time: 8; Write time: 631144 13:26:14 INFO - install - Wall time: 15s; CPU: 17.0%; Read bytes: 0; Write bytes: 247578624; Read time: 0; Write time: 426456 13:26:14 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 262144; Write bytes: 272887808; Read time: 8; Write time: 204660 13:26:14 INFO - Running post-run listener: _upload_blobber_files 13:26:14 INFO - Blob upload gear active. 13:26:14 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:26:14 INFO - Copying logs to upload dir... 13:26:14 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.753293 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-01-24 13:26:13.844780) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-24 13:26:13.848812) ========= 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=d2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009919 build_url: 'https://queue.taskcluster.net/v1/task/WskZesW5T06SiKi5jAe5jA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-24 13:26:13.901558) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 13:26:13.901943) ========= 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=d2a8c569965ab8367867b893000001a1-1453658252.134062-2096143298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004612 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 13:26:13.954911) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-24 13:26:13.955669) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-24 13:26:13.956483) ========= ========= Total master_lag: 0.34 =========