builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1453405358.93 results: success (0) buildid: 20160121094023 builduid: 5f59f3e721e34478b94e61c29e1c7618 revision: 41159a21b1aaee33952d73720715f45aeb6b04e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:38.926958) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:38.927456) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:38.927926) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006274 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:38.950718) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:38.951000) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:38.963899) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:38.964179) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:39.012745) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:39.013024) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:39.013398) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:39.013667) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 11:42:40-- 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% 221M=0s 2016-01-21 11:42:40 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174639 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:39.201498) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:39.201806) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014727 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:39.251935) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:39.252311) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 41159a21b1aaee33952d73720715f45aeb6b04e3 --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 41159a21b1aaee33952d73720715f45aeb6b04e3 --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=337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 11:42:40,619 truncating revision to first 12 chars 2016-01-21 11:42:40,619 Setting DEBUG logging. 2016-01-21 11:42:40,619 attempt 1/10 2016-01-21 11:42:40,619 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/41159a21b1aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 11:42:40,878 unpacking tar archive at: mozilla-aurora-41159a21b1aa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.546950 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:39.813438) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:39.813770) ========= echo 41159a21b1aaee33952d73720715f45aeb6b04e3 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'41159a21b1aaee33952d73720715f45aeb6b04e3'] 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=337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 41159a21b1aaee33952d73720715f45aeb6b04e3 program finished with exit code 0 elapsedTime=0.004427 script_repo_revision: '41159a21b1aaee33952d73720715f45aeb6b04e3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:39.867658) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:39.867941) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 11:42:39.878534) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-21 11:42:39.878824) ========= /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=337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:42:41 INFO - MultiFileLogger online at 20160121 11:42:41 in /builds/slave/test-pgo 11:42:41 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 11:42:41 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:42:41 INFO - {'append_to_log': False, 11:42:41 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:42:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:42:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:42:41 INFO - 'branch': 'Mozilla-Aurora', 11:42:41 INFO - 'buildbot_json_path': 'buildprops.json', 11:42:41 INFO - 'config_files': ('talos/linux_config.py',), 11:42:41 INFO - 'default_actions': ('clobber', 11:42:41 INFO - 'read-buildbot-config', 11:42:41 INFO - 'download-and-extract', 11:42:41 INFO - 'populate-webroot', 11:42:41 INFO - 'create-virtualenv', 11:42:41 INFO - 'install', 11:42:41 INFO - 'run-tests'), 11:42:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:42:41 INFO - 'download_minidump_stackwalk': True, 11:42:41 INFO - 'download_symbols': 'ondemand', 11:42:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:42:41 INFO - 'tooltool.py': '/tools/tooltool.py', 11:42:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:42:41 INFO - '/tools/misc-python/virtualenv.py')}, 11:42:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:42:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:42:41 INFO - 'installer_path': 'installer.exe', 11:42:41 INFO - 'log_level': 'info', 11:42:41 INFO - 'log_name': 'talos', 11:42:41 INFO - 'log_to_console': True, 11:42:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:42:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:42:41 INFO - 'opt_config_files': (), 11:42:41 INFO - 'pip_index': False, 11:42:41 INFO - 'sps_profile': False, 11:42:41 INFO - 'sps_profile_interval': 0, 11:42:41 INFO - 'suite': 'dromaeojs-e10s', 11:42:41 INFO - 'system_bits': '32', 11:42:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:42:41 INFO - 'title': 'talos-linux64-ix-060', 11:42:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:42:41 INFO - 'use_talos_json': True, 11:42:41 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:42:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:42:41 INFO - 'work_dir': 'build'} 11:42:41 INFO - ##### 11:42:41 INFO - ##### Running clobber step. 11:42:41 INFO - ##### 11:42:41 INFO - Running pre-action listener: _resource_record_pre_action 11:42:41 INFO - Running main action method: clobber 11:42:41 INFO - rmtree: /builds/slave/test-pgo/build 11:42:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:42:41 INFO - Running post-action listener: _resource_record_post_action 11:42:41 INFO - ##### 11:42:41 INFO - ##### Running read-buildbot-config step. 11:42:41 INFO - ##### 11:42:41 INFO - Running pre-action listener: _resource_record_pre_action 11:42:41 INFO - Running main action method: read_buildbot_config 11:42:41 INFO - Using buildbot properties: 11:42:41 INFO - { 11:42:41 INFO - "properties": { 11:42:41 INFO - "buildnumber": 100, 11:42:41 INFO - "product": "firefox", 11:42:41 INFO - "script_repo_revision": "production", 11:42:41 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:42:41 INFO - "repository": "", 11:42:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:42:41 INFO - "buildid": "20160121094023", 11:42:41 INFO - "slavename": "talos-linux64-ix-060", 11:42:41 INFO - "pgo_build": "True", 11:42:41 INFO - "basedir": "/builds/slave/test-pgo", 11:42:41 INFO - "project": "", 11:42:41 INFO - "platform": "ubuntu64_hw", 11:42:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:42:41 INFO - "slavebuilddir": "test", 11:42:41 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:42:41 INFO - "branch": "mozilla-aurora", 11:42:41 INFO - "repo_path": "releases/mozilla-aurora", 11:42:41 INFO - "stage_platform": "linux64-pgo", 11:42:41 INFO - "builduid": "5f59f3e721e34478b94e61c29e1c7618", 11:42:41 INFO - "revision": "41159a21b1aaee33952d73720715f45aeb6b04e3" 11:42:41 INFO - }, 11:42:41 INFO - "sourcestamp": { 11:42:41 INFO - "repository": "", 11:42:41 INFO - "hasPatch": false, 11:42:41 INFO - "project": "", 11:42:41 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:42:41 INFO - "changes": [ 11:42:41 INFO - { 11:42:41 INFO - "category": null, 11:42:41 INFO - "files": [ 11:42:41 INFO - { 11:42:41 INFO - "url": null, 11:42:41 INFO - "name": "https://queue.taskcluster.net/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 11:42:41 INFO - } 11:42:41 INFO - ], 11:42:41 INFO - "repository": "", 11:42:41 INFO - "rev": "41159a21b1aaee33952d73720715f45aeb6b04e3", 11:42:41 INFO - "who": "ryanvm@gmail.com", 11:42:41 INFO - "when": 1453405307, 11:42:41 INFO - "number": 7494979, 11:42:41 INFO - "comments": "Bug 1213633 - Test childDocument prior to use. r=tanvi, a=test-only", 11:42:41 INFO - "project": "", 11:42:41 INFO - "at": "Thu 21 Jan 2016 11:41:47", 11:42:41 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:42:41 INFO - "revlink": "", 11:42:41 INFO - "properties": [ 11:42:41 INFO - [ 11:42:41 INFO - "buildid", 11:42:41 INFO - "20160121094023", 11:42:41 INFO - "Change" 11:42:41 INFO - ], 11:42:41 INFO - [ 11:42:41 INFO - "builduid", 11:42:41 INFO - "5f59f3e721e34478b94e61c29e1c7618", 11:42:41 INFO - "Change" 11:42:41 INFO - ], 11:42:41 INFO - [ 11:42:41 INFO - "pgo_build", 11:42:41 INFO - "True", 11:42:41 INFO - "Change" 11:42:41 INFO - ] 11:42:41 INFO - ], 11:42:41 INFO - "revision": "41159a21b1aaee33952d73720715f45aeb6b04e3" 11:42:41 INFO - } 11:42:41 INFO - ], 11:42:41 INFO - "revision": "41159a21b1aaee33952d73720715f45aeb6b04e3" 11:42:41 INFO - } 11:42:41 INFO - } 11:42:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 11:42:41 INFO - Running post-action listener: _resource_record_post_action 11:42:41 INFO - ##### 11:42:41 INFO - ##### Running download-and-extract step. 11:42:41 INFO - ##### 11:42:41 INFO - Running pre-action listener: _resource_record_pre_action 11:42:41 INFO - Running main action method: download_and_extract 11:42:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:41 INFO - https://queue.taskcluster.net/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:42:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/test_packages.json 11:42:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/test_packages.json 11:42:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:42:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:42:42 INFO - Downloaded 1302 bytes. 11:42:42 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:42:42 INFO - Using the following test package requirements: 11:42:42 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:42:42 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:42:42 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:42:42 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:42:42 INFO - u'jsshell-linux-x86_64.zip'], 11:42:42 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:42:42 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:42:42 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:42:42 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:42:42 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:42:42 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:42:42 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:42:42 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:42:42 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:42:42 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:42:42 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:42:42 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:42:42 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:42:42 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')]} 11:42:42 INFO - https://queue.taskcluster.net/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:42:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:42:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:42:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/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 11:42:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/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 11:42:43 INFO - Downloaded 23159787 bytes. 11:42:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:42:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:42:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:42:44 INFO - Return code: 0 11:42:44 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 11:42:44 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')]} 11:42:44 INFO - https://queue.taskcluster.net/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:42:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:42:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:42:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/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 11:42:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/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 11:42:48 INFO - Downloaded 23159787 bytes. 11:42:48 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 11:42:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:42:48 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 11:42:49 INFO - Return code: 0 11:42:49 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')]} 11:42:49 INFO - https://queue.taskcluster.net/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:42:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:42:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:42:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/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 11:42:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/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 11:42:51 INFO - Downloaded 11132038 bytes. 11:42:51 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 11:42:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:42:51 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 11:42:51 INFO - Return code: 0 11:42:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:51 INFO - https://queue.taskcluster.net/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:42:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:42:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:42:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/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 11:42:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rfUKFcihSJWtFGH3-h3Q_w/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 11:42:55 INFO - Downloaded 58161794 bytes. 11:42:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:42:55 INFO - mkdir: /builds/slave/test-pgo/properties 11:42:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:42:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:42:55 INFO - Contents: 11:42:55 INFO - build_url:https://queue.taskcluster.net/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:42:55 INFO - Running post-action listener: _resource_record_post_action 11:42:55 INFO - Running post-action listener: set_extra_try_arguments 11:42:55 INFO - ##### 11:42:55 INFO - ##### Running populate-webroot step. 11:42:55 INFO - ##### 11:42:55 INFO - Running pre-action listener: _resource_record_pre_action 11:42:55 INFO - Running main action method: populate_webroot 11:42:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:42:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:42:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:42:55 INFO - '--tppagecycles', 11:42:55 INFO - '7'], 11:42:55 INFO - 'tests': ['tsvgm']}}, 11:42:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:42:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:42:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:42:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:42:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:42:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:42:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:55 INFO - 'talos_options': ['--e10s'], 11:42:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:55 INFO - 'tests': ['damp', 'tps']}, 11:42:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:55 INFO - 'talos_options': ['--e10s'], 11:42:55 INFO - 'tests': ['damp', 'tps']}, 11:42:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:42:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:42:55 INFO - 'other': {'tests': ['a11yr', 11:42:55 INFO - 'ts_paint', 11:42:55 INFO - 'tpaint', 11:42:55 INFO - 'sessionrestore', 11:42:55 INFO - 'sessionrestore_no_auto_restore']}, 11:42:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:42:55 INFO - 'tests': ['a11yr', 11:42:55 INFO - 'ts_paint', 11:42:55 INFO - 'tpaint', 11:42:55 INFO - 'sessionrestore', 11:42:55 INFO - 'sessionrestore_no_auto_restore']}, 11:42:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:42:55 INFO - 'tests': ['a11yr', 11:42:55 INFO - 'ts_paint', 11:42:55 INFO - 'tpaint', 11:42:55 INFO - 'sessionrestore', 11:42:55 INFO - 'sessionrestore_no_auto_restore']}, 11:42:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:42:55 INFO - 'tests': ['a11yr', 11:42:55 INFO - 'ts_paint', 11:42:55 INFO - 'tpaint', 11:42:55 INFO - 'sessionrestore', 11:42:55 INFO - 'sessionrestore_no_auto_restore']}, 11:42:55 INFO - 'other_l64': {'tests': ['a11yr', 11:42:55 INFO - 'ts_paint', 11:42:55 INFO - 'tpaint', 11:42:55 INFO - 'sessionrestore', 11:42:55 INFO - 'sessionrestore_no_auto_restore']}, 11:42:55 INFO - 'other_nol64': {'tests': ['a11yr', 11:42:55 INFO - 'ts_paint', 11:42:55 INFO - 'tpaint', 11:42:55 INFO - 'sessionrestore', 11:42:55 INFO - 'sessionrestore_no_auto_restore']}, 11:42:55 INFO - 'svgr': {'tests': ['tsvgx', 11:42:55 INFO - 'tsvgr_opacity', 11:42:55 INFO - 'tart', 11:42:55 INFO - 'tscrollx', 11:42:55 INFO - 'cart']}, 11:42:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:42:55 INFO - 'tests': ['tsvgx', 11:42:55 INFO - 'tsvgr_opacity', 11:42:55 INFO - 'tart', 11:42:55 INFO - 'tscrollx', 11:42:55 INFO - 'cart']}, 11:42:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:55 INFO - 'tests': ['tp5o']}, 11:42:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:55 INFO - 'talos_options': ['--e10s'], 11:42:55 INFO - 'tests': ['tp5o']}, 11:42:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:55 INFO - 'talos_options': ['--xperf_path', 11:42:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:55 INFO - 'tests': ['tp5n']}, 11:42:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:55 INFO - 'talos_options': ['--e10s', 11:42:55 INFO - '--xperf_path', 11:42:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:55 INFO - 'tests': ['tp5n']}}, 11:42:55 INFO - 'talos.zip': {'path': '', 11:42:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:42:55 INFO - Running post-action listener: _resource_record_post_action 11:42:55 INFO - ##### 11:42:55 INFO - ##### Running create-virtualenv step. 11:42:55 INFO - ##### 11:42:55 INFO - Running pre-action listener: _resource_record_pre_action 11:42:55 INFO - Running main action method: create_virtualenv 11:42:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:42:55 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 11:42:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:42:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:42:55 INFO - Using real prefix '/usr' 11:42:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:42:55 INFO - Installing distribute.............................................................................................................................................................................................done. 11:42:57 INFO - Installing pip.................done. 11:42:57 INFO - Return code: 0 11:42:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:42:57 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')]} 11:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:57 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')]} 11:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:57 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 0x7f596b162f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfe500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfb6a0>, '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 0xdfc5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfca30>, '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': '337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438', '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 11:42:57 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 11:42:57 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 11:42:57 INFO - Using env: {'DISPLAY': ':0', 11:42:57 INFO - 'HOME': '/home/cltbld', 11:42:57 INFO - 'LANG': 'en_US.UTF-8', 11:42:57 INFO - 'LANGUAGE': 'en_US:en', 11:42:57 INFO - 'LOGNAME': 'cltbld', 11:42:57 INFO - 'MAIL': '/var/mail/cltbld', 11:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:57 INFO - 'MOZ_NO_REMOTE': '1', 11:42:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:57 INFO - 'NO_EM_RESTART': '1', 11:42:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:42:57 INFO - 'PWD': '/builds/slave/test-pgo', 11:42:57 INFO - 'SHELL': '/bin/bash', 11:42:57 INFO - 'SHLVL': '1', 11:42:57 INFO - 'TERM': 'linux', 11:42:57 INFO - 'TMOUT': '86400', 11:42:57 INFO - 'USER': 'cltbld', 11:42:57 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438', 11:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:57 INFO - '_': '/tools/buildbot/bin/python'} 11:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:58 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 11:42:58 INFO - Cleaning up... 11:42:58 INFO - Return code: 0 11:42:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:58 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 0x7f596b162f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfe500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfb6a0>, '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 0xdfc5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfca30>, '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': '337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438', '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 11:42:58 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 11:42:58 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 11:42:58 INFO - Using env: {'DISPLAY': ':0', 11:42:58 INFO - 'HOME': '/home/cltbld', 11:42:58 INFO - 'LANG': 'en_US.UTF-8', 11:42:58 INFO - 'LANGUAGE': 'en_US:en', 11:42:58 INFO - 'LOGNAME': 'cltbld', 11:42:58 INFO - 'MAIL': '/var/mail/cltbld', 11:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:58 INFO - 'MOZ_NO_REMOTE': '1', 11:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:58 INFO - 'NO_EM_RESTART': '1', 11:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:42:58 INFO - 'PWD': '/builds/slave/test-pgo', 11:42:58 INFO - 'SHELL': '/bin/bash', 11:42:58 INFO - 'SHLVL': '1', 11:42:58 INFO - 'TERM': 'linux', 11:42:58 INFO - 'TMOUT': '86400', 11:42:58 INFO - 'USER': 'cltbld', 11:42:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438', 11:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:58 INFO - '_': '/tools/buildbot/bin/python'} 11:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:58 INFO - Downloading/unpacking psutil>=0.7.1 11:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:43:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:43:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:43:00 INFO - Installing collected packages: psutil 11:43:00 INFO - Running setup.py install for psutil 11:43:00 INFO - building 'psutil._psutil_linux' extension 11:43:00 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 11:43:00 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 11:43:00 INFO - building 'psutil._psutil_posix' extension 11:43:00 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 11:43:00 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 11:43:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:43:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:43:00 INFO - Successfully installed psutil 11:43:00 INFO - Cleaning up... 11:43:00 INFO - Return code: 0 11:43:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:43:00 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')]} 11:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:00 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')]} 11:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:00 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 0x7f596b162f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfe500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfb6a0>, '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 0xdfc5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfca30>, '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': '337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438', '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 11:43:00 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 11:43:00 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 11:43:00 INFO - Using env: {'DISPLAY': ':0', 11:43:00 INFO - 'HOME': '/home/cltbld', 11:43:00 INFO - 'LANG': 'en_US.UTF-8', 11:43:00 INFO - 'LANGUAGE': 'en_US:en', 11:43:00 INFO - 'LOGNAME': 'cltbld', 11:43:00 INFO - 'MAIL': '/var/mail/cltbld', 11:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:00 INFO - 'MOZ_NO_REMOTE': '1', 11:43:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:00 INFO - 'NO_EM_RESTART': '1', 11:43:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:43:00 INFO - 'PWD': '/builds/slave/test-pgo', 11:43:00 INFO - 'SHELL': '/bin/bash', 11:43:00 INFO - 'SHLVL': '1', 11:43:00 INFO - 'TERM': 'linux', 11:43:00 INFO - 'TMOUT': '86400', 11:43:00 INFO - 'USER': 'cltbld', 11:43:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438', 11:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:00 INFO - '_': '/tools/buildbot/bin/python'} 11:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:43:01 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 11:43:01 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 11:43:01 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 11:43:01 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 11:43:01 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 11:43:01 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 11:43:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:43:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:43:02 INFO - Installing collected packages: mozsystemmonitor 11:43:02 INFO - Running setup.py install for mozsystemmonitor 11:43:03 INFO - Successfully installed mozsystemmonitor 11:43:03 INFO - Cleaning up... 11:43:03 INFO - Return code: 0 11:43:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:43:03 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')]} 11:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:03 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')]} 11:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:03 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 0x7f596b162f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfe500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfb6a0>, '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 0xdfc5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfca30>, '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': '337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438', '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 11:43:03 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 11:43:03 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 11:43:03 INFO - Using env: {'DISPLAY': ':0', 11:43:03 INFO - 'HOME': '/home/cltbld', 11:43:03 INFO - 'LANG': 'en_US.UTF-8', 11:43:03 INFO - 'LANGUAGE': 'en_US:en', 11:43:03 INFO - 'LOGNAME': 'cltbld', 11:43:03 INFO - 'MAIL': '/var/mail/cltbld', 11:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:03 INFO - 'MOZ_NO_REMOTE': '1', 11:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:03 INFO - 'NO_EM_RESTART': '1', 11:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:43:03 INFO - 'PWD': '/builds/slave/test-pgo', 11:43:03 INFO - 'SHELL': '/bin/bash', 11:43:03 INFO - 'SHLVL': '1', 11:43:03 INFO - 'TERM': 'linux', 11:43:03 INFO - 'TMOUT': '86400', 11:43:03 INFO - 'USER': 'cltbld', 11:43:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438', 11:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:03 INFO - '_': '/tools/buildbot/bin/python'} 11:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:03 INFO - Downloading/unpacking blobuploader==1.2.4 11:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:43:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:05 INFO - Downloading blobuploader-1.2.4.tar.gz 11:43:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:43:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:43:05 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 11:43:05 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 11:43:05 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 11:43:05 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 11:43:05 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 11:43:05 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 11:43:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:43:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:43:05 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 11:43:05 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 11:43:05 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 11:43:05 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 11:43:05 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 11:43:05 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 11:43:05 INFO - Downloading docopt-0.6.1.tar.gz 11:43:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:43:05 INFO - Installing collected packages: blobuploader, requests, docopt 11:43:05 INFO - Running setup.py install for blobuploader 11:43:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:43:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:43:05 INFO - Running setup.py install for requests 11:43:06 INFO - Running setup.py install for docopt 11:43:06 INFO - Successfully installed blobuploader requests docopt 11:43:06 INFO - Cleaning up... 11:43:06 INFO - Return code: 0 11:43:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:06 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 0x7f596b162f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfe500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfb6a0>, '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 0xdfc5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfca30>, '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': '337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438', '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 11:43:06 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 11:43:06 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 11:43:06 INFO - Using env: {'DISPLAY': ':0', 11:43:06 INFO - 'HOME': '/home/cltbld', 11:43:06 INFO - 'LANG': 'en_US.UTF-8', 11:43:06 INFO - 'LANGUAGE': 'en_US:en', 11:43:06 INFO - 'LOGNAME': 'cltbld', 11:43:06 INFO - 'MAIL': '/var/mail/cltbld', 11:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:06 INFO - 'MOZ_NO_REMOTE': '1', 11:43:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:06 INFO - 'NO_EM_RESTART': '1', 11:43:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:43:06 INFO - 'PWD': '/builds/slave/test-pgo', 11:43:06 INFO - 'SHELL': '/bin/bash', 11:43:06 INFO - 'SHLVL': '1', 11:43:06 INFO - 'TERM': 'linux', 11:43:06 INFO - 'TMOUT': '86400', 11:43:06 INFO - 'USER': 'cltbld', 11:43:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438', 11:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:06 INFO - '_': '/tools/buildbot/bin/python'} 11:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:43:06 INFO - Running setup.py (path:/tmp/pip-m5IGEo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:43:06 INFO - Running setup.py (path:/tmp/pip-HkB2NW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:43:06 INFO - Running setup.py (path:/tmp/pip-MpYEqH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:43:06 INFO - Running setup.py (path:/tmp/pip-sh5D2X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:43:06 INFO - Running setup.py (path:/tmp/pip-ImoTvD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:43:07 INFO - Running setup.py (path:/tmp/pip-QtBUeL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:43:07 INFO - Running setup.py (path:/tmp/pip-9A97Zd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:43:07 INFO - Running setup.py (path:/tmp/pip-QKdE8K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:43:07 INFO - Running setup.py (path:/tmp/pip-6IPc91-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:43:07 INFO - Running setup.py (path:/tmp/pip-f1yMgt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:43:07 INFO - Running setup.py (path:/tmp/pip-DHmQbh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:43:07 INFO - Running setup.py (path:/tmp/pip-32LDmV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:43:07 INFO - Running setup.py (path:/tmp/pip-nkJ7qW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:43:07 INFO - Running setup.py (path:/tmp/pip-sSq9XL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:43:07 INFO - Running setup.py (path:/tmp/pip-zo0xui-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:43:07 INFO - Running setup.py (path:/tmp/pip-0NbWYB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:43:07 INFO - Running setup.py (path:/tmp/pip-5zsCE3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:43:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:43:07 INFO - Running setup.py install for manifestparser 11:43:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:43:08 INFO - Running setup.py install for mozcrash 11:43:08 INFO - Running setup.py install for mozdebug 11:43:08 INFO - Running setup.py install for mozdevice 11:43:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:43:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:43:08 INFO - Running setup.py install for mozfile 11:43:08 INFO - Running setup.py install for mozhttpd 11:43:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:43:08 INFO - Running setup.py install for mozinfo 11:43:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:43:08 INFO - Running setup.py install for mozInstall 11:43:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:43:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:43:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:43:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:43:08 INFO - Running setup.py install for mozleak 11:43:08 INFO - Running setup.py install for mozlog 11:43:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:43:08 INFO - Running setup.py install for moznetwork 11:43:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:43:09 INFO - Running setup.py install for mozprocess 11:43:09 INFO - Running setup.py install for mozprofile 11:43:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:43:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:43:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:43:09 INFO - Running setup.py install for mozrunner 11:43:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:43:09 INFO - Running setup.py install for mozscreenshot 11:43:09 INFO - Running setup.py install for moztest 11:43:09 INFO - Running setup.py install for mozversion 11:43:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:43:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:43:09 INFO - Cleaning up... 11:43:09 INFO - Return code: 0 11:43:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:09 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 0x7f596b162f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfe500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfb6a0>, '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 0xdfc5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfca30>, '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': '337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438', '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 11:43:09 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 11:43:09 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 11:43:09 INFO - Using env: {'DISPLAY': ':0', 11:43:09 INFO - 'HOME': '/home/cltbld', 11:43:09 INFO - 'LANG': 'en_US.UTF-8', 11:43:09 INFO - 'LANGUAGE': 'en_US:en', 11:43:09 INFO - 'LOGNAME': 'cltbld', 11:43:09 INFO - 'MAIL': '/var/mail/cltbld', 11:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:09 INFO - 'MOZ_NO_REMOTE': '1', 11:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:09 INFO - 'NO_EM_RESTART': '1', 11:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:43:09 INFO - 'PWD': '/builds/slave/test-pgo', 11:43:09 INFO - 'SHELL': '/bin/bash', 11:43:09 INFO - 'SHLVL': '1', 11:43:09 INFO - 'TERM': 'linux', 11:43:09 INFO - 'TMOUT': '86400', 11:43:09 INFO - 'USER': 'cltbld', 11:43:09 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438', 11:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:09 INFO - '_': '/tools/buildbot/bin/python'} 11:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:43:09 INFO - Running setup.py (path:/tmp/pip-_Wx0m1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:43:09 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)) 11:43:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:43:09 INFO - Running setup.py (path:/tmp/pip-ufaTl7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:43:10 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)) 11:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:43:10 INFO - Running setup.py (path:/tmp/pip-XFSoIq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:43:10 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)) 11:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:43:10 INFO - Running setup.py (path:/tmp/pip-7oS2DV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:43:10 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)) 11:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:43:10 INFO - Running setup.py (path:/tmp/pip-7nmBcQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:43:10 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)) 11:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:43:10 INFO - Running setup.py (path:/tmp/pip-pgHeu0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:43:10 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)) 11:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:43:10 INFO - Running setup.py (path:/tmp/pip-C2KP3f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:43:10 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)) 11:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:43:10 INFO - Running setup.py (path:/tmp/pip-yNneoz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:43:10 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)) 11:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:43:10 INFO - Running setup.py (path:/tmp/pip-ieMsGE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:43:10 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)) 11:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:43:10 INFO - Running setup.py (path:/tmp/pip-he58IM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:43:10 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)) 11:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:43:10 INFO - Running setup.py (path:/tmp/pip-EMTqKq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:43:10 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)) 11:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:43:10 INFO - Running setup.py (path:/tmp/pip-6ebKMK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:43:10 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)) 11:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:43:10 INFO - Running setup.py (path:/tmp/pip-oe_la6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:43:10 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)) 11:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:43:10 INFO - Running setup.py (path:/tmp/pip-3nqsgP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:43:10 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)) 11:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:43:10 INFO - Running setup.py (path:/tmp/pip-X9yUv9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:43:10 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)) 11:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:43:10 INFO - Running setup.py (path:/tmp/pip-qvWENW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:43:11 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)) 11:43:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:43:11 INFO - Running setup.py (path:/tmp/pip-pKS5tj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:43:11 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)) 11:43:11 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)) 11:43:11 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)) 11:43:11 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)) 11:43:11 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)) 11:43:11 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)) 11:43:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:43:11 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 11:43:11 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 11:43:11 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 11:43:11 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 11:43:11 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 11:43:11 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 11:43:12 INFO - Downloading blessings-1.6.tar.gz 11:43:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:43:12 INFO - Installing collected packages: blessings 11:43:12 INFO - Running setup.py install for blessings 11:43:13 INFO - Successfully installed blessings 11:43:13 INFO - Cleaning up... 11:43:13 INFO - Return code: 0 11:43:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:43:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:43:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:43:13 INFO - Reading from file tmpfile_stdout 11:43:13 INFO - Current package versions: 11:43:13 INFO - argparse == 1.2.1 11:43:13 INFO - blessings == 1.6 11:43:13 INFO - blobuploader == 1.2.4 11:43:13 INFO - docopt == 0.6.1 11:43:13 INFO - manifestparser == 1.1 11:43:13 INFO - mozInstall == 1.12 11:43:13 INFO - mozcrash == 0.16 11:43:13 INFO - mozdebug == 0.1 11:43:13 INFO - mozdevice == 0.47 11:43:13 INFO - mozfile == 1.2 11:43:13 INFO - mozhttpd == 0.7 11:43:13 INFO - mozinfo == 0.9 11:43:13 INFO - mozleak == 0.1 11:43:13 INFO - mozlog == 3.1 11:43:13 INFO - moznetwork == 0.27 11:43:13 INFO - mozprocess == 0.22 11:43:13 INFO - mozprofile == 0.27 11:43:13 INFO - mozrunner == 6.11 11:43:13 INFO - mozscreenshot == 0.1 11:43:13 INFO - mozsystemmonitor == 0.0 11:43:13 INFO - moztest == 0.7 11:43:13 INFO - mozversion == 1.4 11:43:13 INFO - psutil == 3.1.1 11:43:13 INFO - requests == 1.2.3 11:43:13 INFO - wsgiref == 0.1.2 11:43:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:13 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 0x7f596b162f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfe500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfb6a0>, '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 0xdfc5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfca30>, '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': '337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438', '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 11:43:13 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 11:43:13 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 11:43:13 INFO - Using env: {'DISPLAY': ':0', 11:43:13 INFO - 'HOME': '/home/cltbld', 11:43:13 INFO - 'LANG': 'en_US.UTF-8', 11:43:13 INFO - 'LANGUAGE': 'en_US:en', 11:43:13 INFO - 'LOGNAME': 'cltbld', 11:43:13 INFO - 'MAIL': '/var/mail/cltbld', 11:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:13 INFO - 'MOZ_NO_REMOTE': '1', 11:43:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:13 INFO - 'NO_EM_RESTART': '1', 11:43:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:43:13 INFO - 'PWD': '/builds/slave/test-pgo', 11:43:13 INFO - 'SHELL': '/bin/bash', 11:43:13 INFO - 'SHLVL': '1', 11:43:13 INFO - 'TERM': 'linux', 11:43:13 INFO - 'TMOUT': '86400', 11:43:13 INFO - 'USER': 'cltbld', 11:43:13 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438', 11:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:13 INFO - '_': '/tools/buildbot/bin/python'} 11:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:13 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)) 11:43:13 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)) 11:43:13 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)) 11:43:13 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)) 11:43:13 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)) 11:43:13 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)) 11:43:13 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)) 11:43:13 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)) 11:43:13 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)) 11:43:13 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)) 11:43:13 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)) 11:43:13 INFO - Cleaning up... 11:43:13 INFO - Return code: 0 11:43:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:13 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 0x7f596b162f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfe500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfb6a0>, '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 0xdfc5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfca30>, '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': '337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438', '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 11:43:13 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 11:43:13 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 11:43:13 INFO - Using env: {'DISPLAY': ':0', 11:43:13 INFO - 'HOME': '/home/cltbld', 11:43:13 INFO - 'LANG': 'en_US.UTF-8', 11:43:13 INFO - 'LANGUAGE': 'en_US:en', 11:43:13 INFO - 'LOGNAME': 'cltbld', 11:43:13 INFO - 'MAIL': '/var/mail/cltbld', 11:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:13 INFO - 'MOZ_NO_REMOTE': '1', 11:43:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:13 INFO - 'NO_EM_RESTART': '1', 11:43:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:43:13 INFO - 'PWD': '/builds/slave/test-pgo', 11:43:13 INFO - 'SHELL': '/bin/bash', 11:43:13 INFO - 'SHLVL': '1', 11:43:13 INFO - 'TERM': 'linux', 11:43:13 INFO - 'TMOUT': '86400', 11:43:13 INFO - 'USER': 'cltbld', 11:43:13 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438', 11:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:13 INFO - '_': '/tools/buildbot/bin/python'} 11:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:13 INFO - Downloading/unpacking jsonschema 11:43:13 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 11:43:13 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 11:43:13 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 11:43:13 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 11:43:13 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 11:43:13 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 11:43:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:43:15 INFO - Downloading/unpacking functools32 (from jsonschema) 11:43:15 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 11:43:15 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 11:43:15 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 11:43:15 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 11:43:15 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 11:43:15 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 11:43:15 INFO - Downloading functools32-3.2.3-2.tar.gz 11:43:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:43:15 INFO - warning: no files found matching '*.txt' 11:43:15 INFO - no previously-included directories found matching 'build' 11:43:15 INFO - no previously-included directories found matching 'dist' 11:43:15 INFO - no previously-included directories found matching '.git*' 11:43:15 INFO - Installing collected packages: jsonschema, functools32 11:43:15 INFO - Running setup.py install for functools32 11:43:15 INFO - warning: no files found matching '*.txt' 11:43:15 INFO - no previously-included directories found matching 'build' 11:43:15 INFO - no previously-included directories found matching 'dist' 11:43:15 INFO - no previously-included directories found matching '.git*' 11:43:15 INFO - Successfully installed jsonschema functools32 11:43:15 INFO - Cleaning up... 11:43:16 INFO - Return code: 0 11:43:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:16 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 0x7f596b162f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfe500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfb6a0>, '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 0xdfc5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfca30>, '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': '337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438', '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 11:43:16 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 11:43:16 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 11:43:16 INFO - Using env: {'DISPLAY': ':0', 11:43:16 INFO - 'HOME': '/home/cltbld', 11:43:16 INFO - 'LANG': 'en_US.UTF-8', 11:43:16 INFO - 'LANGUAGE': 'en_US:en', 11:43:16 INFO - 'LOGNAME': 'cltbld', 11:43:16 INFO - 'MAIL': '/var/mail/cltbld', 11:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:16 INFO - 'MOZ_NO_REMOTE': '1', 11:43:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:16 INFO - 'NO_EM_RESTART': '1', 11:43:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:43:16 INFO - 'PWD': '/builds/slave/test-pgo', 11:43:16 INFO - 'SHELL': '/bin/bash', 11:43:16 INFO - 'SHLVL': '1', 11:43:16 INFO - 'TERM': 'linux', 11:43:16 INFO - 'TMOUT': '86400', 11:43:16 INFO - 'USER': 'cltbld', 11:43:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438', 11:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:16 INFO - '_': '/tools/buildbot/bin/python'} 11:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:16 INFO - Downloading/unpacking flake8 11:43:16 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 11:43:16 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 11:43:16 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 11:43:16 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 11:43:16 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 11:43:16 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 11:43:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:43:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:43:18 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 11:43:18 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 11:43:18 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 11:43:18 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 11:43:18 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 11:43:18 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 11:43:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:43:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:43:18 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 11:43:18 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 11:43:18 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 11:43:18 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 11:43:18 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 11:43:18 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 11:43:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:43:18 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 11:43:18 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 11:43:18 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 11:43:18 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 11:43:18 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 11:43:18 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 11:43:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:43:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:43:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:43:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:43:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:43:18 INFO - no previously-included directories found matching 'docs/_build' 11:43:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:43:18 INFO - Running setup.py install for pep8 11:43:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:43:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:43:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:43:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:43:18 INFO - no previously-included directories found matching 'docs/_build' 11:43:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:43:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:43:18 INFO - Cleaning up... 11:43:18 INFO - Return code: 0 11:43:18 INFO - Running post-action listener: _resource_record_post_action 11:43:18 INFO - Running post-action listener: _start_resource_monitoring 11:43:18 INFO - Starting resource monitoring. 11:43:18 INFO - ##### 11:43:18 INFO - ##### Running install step. 11:43:18 INFO - ##### 11:43:18 INFO - Running pre-action listener: _resource_record_pre_action 11:43:18 INFO - Running main action method: install 11:43:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:43:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:43:19 INFO - Reading from file tmpfile_stdout 11:43:19 INFO - Detecting whether we're running mozinstall >=1.0... 11:43:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:43:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:43:19 INFO - Reading from file tmpfile_stdout 11:43:19 INFO - Output received: 11:43:19 INFO - Usage: mozinstall [options] installer 11:43:19 INFO - Options: 11:43:19 INFO - -h, --help show this help message and exit 11:43:19 INFO - -d DEST, --destination=DEST 11:43:19 INFO - Directory to install application into. [default: 11:43:19 INFO - "/builds/slave/test-pgo"] 11:43:19 INFO - --app=APP Application being installed. [default: firefox] 11:43:19 INFO - mkdir: /builds/slave/test-pgo/build/application 11:43:19 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'] 11:43:19 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 11:43:33 INFO - Reading from file tmpfile_stdout 11:43:33 INFO - Output received: 11:43:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:43:33 INFO - Running post-action listener: _resource_record_post_action 11:43:33 INFO - ##### 11:43:33 INFO - ##### Running run-tests step. 11:43:33 INFO - ##### 11:43:33 INFO - Running pre-action listener: _resource_record_pre_action 11:43:33 INFO - Running main action method: run_tests 11:43:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:43:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:43:33 INFO - Python 2.7.3 11:43:33 INFO - Return code: 0 11:43:33 INFO - grabbing minidump binary from tooltool 11:43: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')]} 11:43:33 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 0xdfb6a0>, '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 0xdfc5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfca30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:43:33 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 11:43:33 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 11:43:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:43:33 INFO - Return code: 0 11:43:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:43:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:43:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:43:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:43:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:43:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:43:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:43:34 INFO - Return code: 0 11:43:34 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/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 11:43:34 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/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost 11:43:34 INFO - Using env: {'DISPLAY': ':0', 11:43:34 INFO - 'HOME': '/home/cltbld', 11:43:34 INFO - 'LANG': 'en_US.UTF-8', 11:43:34 INFO - 'LANGUAGE': 'en_US:en', 11:43:34 INFO - 'LOGNAME': 'cltbld', 11:43:34 INFO - 'MAIL': '/var/mail/cltbld', 11:43:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:43:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:34 INFO - 'MOZ_NO_REMOTE': '1', 11:43:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:43:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:34 INFO - 'NO_EM_RESTART': '1', 11:43:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:43:34 INFO - 'PWD': '/builds/slave/test-pgo', 11:43:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:43:34 INFO - 'SHELL': '/bin/bash', 11:43:34 INFO - 'SHLVL': '1', 11:43:34 INFO - 'TERM': 'linux', 11:43:34 INFO - 'TMOUT': '86400', 11:43:34 INFO - 'USER': 'cltbld', 11:43:34 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438', 11:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:34 INFO - '_': '/tools/buildbot/bin/python'} 11:43:34 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/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] with output_timeout 3600 11:43:35 INFO - mozversion INFO | application_buildid: 20160121094023 11:43:35 INFO - mozversion INFO | application_changeset: 41159a21b1aaee33952d73720715f45aeb6b04e3 11:43:35 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 11:43:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:43:35 INFO - mozversion INFO | application_name: Firefox 11:43:35 INFO - mozversion INFO | application_remotingname: firefox-dev 11:43:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:43:35 INFO - mozversion INFO | application_vendor: Mozilla 11:43:35 INFO - mozversion INFO | application_version: 45.0a2 11:43:35 INFO - mozversion INFO | platform_buildid: 20160121094023 11:43:35 INFO - mozversion INFO | platform_changeset: 41159a21b1aaee33952d73720715f45aeb6b04e3 11:43:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:43:35 INFO - mozversion INFO | platform_version: 45.0a2 11:43:35 INFO - 2016-01-21 11:43:35,176 DEBUG : using testdate: 1453405415 11:43:35 INFO - 2016-01-21 11:43:35,176 DEBUG : actual date: 1453405415 11:43:35 INFO - 2016-01-21 11:43:35,224 INFO : starting webserver on 'localhost:46098' 11:43:35 INFO - 2016-01-21 11:43:35,225 INFO : Starting test suite talos-linux64-ix-060.e 11:43:35 INFO - 2016-01-21 11:43:35,225 INFO : Starting test dromaeo_css 11:43:35 INFO - 2016-01-21 11:43:35,225 DEBUG : operating with platform_type : linux_ 11:43:35 INFO - 2016-01-21 11:43:35,226 INFO : Initialising browser for dromaeo_css test... 11:43:35 INFO - 2016-01-21 11:43:35,237 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgB8DUg/profile http://localhost:46098/getInfo.html 11:43:38 INFO - 2016-01-21 11:43:38,808 DEBUG : BROWSER_OUTPUT: 11:43:38 INFO - 2016-01-21 11:43:38,808 DEBUG : BROWSER_OUTPUT: (process:21146): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:43:39 INFO - 2016-01-21 11:43:39,639 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:43:39 INFO - 2016-01-21 11:43:39,641 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:43:39 INFO - 2016-01-21 11:43:39,641 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:43:39 INFO - 2016-01-21 11:43:39,641 DEBUG : BROWSER_OUTPUT: __metrics 11:43:40 INFO - 2016-01-21 11:43:40,613 INFO : Browser initialized. 11:43:40 INFO - 2016-01-21 11:43:40,614 INFO : Running cycle 1/1 for dromaeo_css test... 11:43:40 INFO - 2016-01-21 11:43:40,614 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgB8DUg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:43:41 INFO - 2016-01-21 11:43:41,952 DEBUG : BROWSER_OUTPUT: 11:43:41 INFO - 2016-01-21 11:43:41,952 DEBUG : BROWSER_OUTPUT: (process:21263): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:43:52 INFO - 2016-01-21 11:43:52,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 136650752 11:43:52 INFO - 2016-01-21 11:43:52,456 DEBUG : BROWSER_OUTPUT: 11:44:42 INFO - 2016-01-21 11:44:42,079 DEBUG : BROWSER_OUTPUT: 1453405482079 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] 11:46:49 INFO - 2016-01-21 11:46:49,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46098/tests/dromaeo/cssquery-ext.html) 11:46:50 INFO - 2016-01-21 11:46:50,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 141422592 11:46:50 INFO - 2016-01-21 11:46:50,985 DEBUG : BROWSER_OUTPUT: 11:49:52 INFO - 2016-01-21 11:49:52,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/dromaeo/cssquery-ext.html (next: http://localhost:46098/tests/dromaeo/cssquery-jquery.html) 11:49:53 INFO - 2016-01-21 11:49:53,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 140275712 11:49:53 INFO - 2016-01-21 11:49:53,314 DEBUG : BROWSER_OUTPUT: 11:52:54 INFO - 2016-01-21 11:52:54,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46098/tests/dromaeo/cssquery-mootools.html) 11:52:55 INFO - 2016-01-21 11:52:55,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 139100160 11:52:55 INFO - 2016-01-21 11:52:55,492 DEBUG : BROWSER_OUTPUT: 11:55:57 INFO - 2016-01-21 11:55:57,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46098/tests/dromaeo/cssquery-prototype.html) 11:55:57 INFO - 2016-01-21 11:55:57,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 139489280 11:55:57 INFO - 2016-01-21 11:55:57,676 DEBUG : BROWSER_OUTPUT: 11:58:59 INFO - 2016-01-21 11:58:59,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46098/tests/dromaeo/cssquery-yui.html) 11:59:00 INFO - 2016-01-21 11:59:00,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 140492800 11:59:00 INFO - 2016-01-21 11:59:00,568 DEBUG : BROWSER_OUTPUT: 12:02:02 INFO - 2016-01-21 12:02:02,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/dromaeo/cssquery-yui.html (next: http://localhost:46098/tests/dromaeo/cssquery-dojo.html) 12:02:02 INFO - 2016-01-21 12:02:02,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 141762560 12:02:02 INFO - 2016-01-21 12:02:02,821 DEBUG : BROWSER_OUTPUT: 12:02:02 INFO - 2016-01-21 12:02:02,821 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:02:02 INFO - 2016-01-21 12:02:02,821 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:02:02 INFO - 2016-01-21 12:02:02,821 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:02:02 INFO - 2016-01-21 12:02:02,821 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:02:02 INFO - 2016-01-21 12:02:02,821 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3293.736501079914;3326.4843949187884;3331.550240717502;3337.766356355056;3350.229447227138;5558.610897237195;5562.638428502155;5568.6658800472;5575.526080283175;5592.692401917898;5574.944250557493;5667.291588551431;5679.261695979527;5679.375268720438;5716.1711551825065;5135.460776618466;5163.148080566721;5206;5230.163173892178;5254.395744489394;5042.722650254234;5133.948660513403;5141.691498510083;5142.66572672777;5243.2135179723155;5094.184930411135;5183.481651834805;5184.144616138333;5203.011427828719;5215.6349055566125;5181.352330958612;5207.427183009866;5249.081410753141;5258.447862974409;5283.735813209324;4947.653664243504;5000.324956130912;5000.424951130593;5153.56194723449;5169.741512924339;5358.303420555342;5407.756650950677;5413.512783849433;5431.918521222185;5474.616776825624;6085.087236914454;6111.969440152815;6139.447449729501;6145.3547377525165;6168.537359698041;5945.643261404286;6077.058056001327;6101.755929762804;6182.165407669952;6186;5707.1724599933195;5708.400617935098;5731.598788084877;5734.483896449339;5767.36558978512;6208.441240288305;6216.595921265103;6221.657808820558;6226.25284965807;6236.469900058455;5744.4829965303325;5902;6022.427869352405;6029.276486821609;6133.671320645445;6150.907736383958;6162.044883043135;6181.536384771161;6189.876202475925;6204.875902482016;6087.421694938974;6156.29202641693;6165.075238714228;6175.320714721377;6185.257769067741;6002.249718785152;6002.939970600325;6117.174181485442;6128.380904898417;6132.814448934737;4681.180793361216;4683.929741053887;4684.273937539687;4713.104510143062;4715.481297057321;4036.233115708006;4180.3102488089735;4185.22573323936;4194.182134483807;4220.198162349144;5653.9151912721345;5709.628874123168;5717.285339332583;5748.109043098243;5799.739011744482;6150.661713605795;6239.719212635442;6243.500519958392;6247.75008999644;6258.780942666985;5581.74882130297;5692.829215123553;5783.508401785895;5836.708164591753;5841.94158058414;5268.078086334876;5339.0389729849;5350.5987050971335;5353.598480114007;5376.462353764592;6242.781502647385;6282.089097080898;6310.05349197624;6326.082718005863;6335.334789847;6020.247469066367;6034.125051867542;6132.78535251264;6166.445019948226;6180.227471566054;6258.311585725658;6288.088227207121;6308.842278943063;6329.620222786648;6334.144890439916;6038.607490513103;6057.061155520902;6058.12157237207;6061.515078793774;6084.269887613515;5963.493103086286;6000.549958753199;6055.576109672281;6108.08378743192;6146.0473626587955;6037.547183961133;6082.695865206811;6086.939130608815;6090.056041313604;6098.115773212948;5986.4013598639785;6046.425589568984;6058.394160583906;6064.090386442069;6090.056041313604;5638.915416268841;5741.13882917549;5762.193292938908;5874.353821079592;5895.263092113486;5979.611325263844;6007.549433792396;6035.728392222272;6067.393260673897;6092.543059270483;5677.744501497526;5904;5904.704764761659;5934.851628709144;5955.940440595712 12:02:02 INFO - 2016-01-21 12:02:02,822 DEBUG : BROWSER_OUTPUT: |1;ext.html;587.3421767620264;618.7927044440113;630.9369063093694;633.3318349141655;659.567982971154;41191.58808411915;41665.3750193747;41819.581804182024;41852.58147418525;42086.78956605217;45792;46016.30975535361;46039.76980115103;46440.76779616105;46534.767326163324;8980.640774369034;9181.127792859701;9195.126462986005;9233.6306547738;9252.306077044215;8993.865092023625;9029.322800789934;9045.547722613843;9057.773555661128;9061.909380906205;9075.455472671661;9150.54247287633;9169.40398874071;9172.403793753418;9176.311776616747;9009.819803603892;9036.77408064797;9045.773855653595;9089.363744537884;9125.68060117896;8960.731178064669;9196;9210.401323913991;9214.216791572724;9214.585343659484;42186;42557.36163957543;42624.57375426268;42696.35955460671;42772.57227427748;3489.371913055674;3533.2050288685095;3581.7850928944345;3664.0107171063664;4022.597740225954;32435.837820810746;32931.176720582174;33013.17467063318;33139;33345.166370840925;3656.634336566349;3731.9440208396895;3755.248950209969;3808.4668146459517;3820.6561409473;268799;272729;273111;273784;276024;44308.556914430446;45189.32216016763;45288.77355613267;60948.39051609516;61498.69250653808;42386.788066059475;42866.571334286884;42889.14221715548;43055.13889722188;43130.56869431266;16808.74786878198;17034.31862725502;17034.48896533106;17070.48788536346;17090.829091708925;13365.465381384636;13462.798058029137;13485.595432137052;13503.12229705066;13509.2569908654;14879.958402911692;15138.091714497166;15189.468368607268;15225;15225.6193595161;5958.880822383528;5980.843313896887;6078.3617720138745;6086.573939824169;6111.236095488064;1027.6249169053242;1055.9208059395576;1129.7345123895877;1136.4147464056018;1195.9701007474882;29683;30142.24644383864;34003.65996340055;34065;34277.82861085729;1061.7683487154864;1091.0780390569955;1110.8111621024445;1127.4869934179928;1171.1509155862102;17245.741313880302;17457.65084698299;17532.561685957953;17573.472795816146;17676.292948282182;401877;551864;556822;558979;856830;57977;58657.70671146702;58693.70653146792;59165.70417147973;59214.40785592175;1437.5184313255177;1446.1395469695515;1446.4720377062297;1455.1269238457053;1460.1822979131932;30258.092257232318;30747.84626076945;30876.382472350877;31283.374332512765;31633.841830790698;49225.50774492209;49730.751346243036;49786.75106624444;49877.75061124671;49879.25181122214;329021;331600;332706;332776;333702;33677.831610841786;33866.153346166546;34076.31847362989;34376.656233437345;34612.65387346094;44935.32597011113;45721.77139114283;46081.76959115317;46377.072458551316;46408.76795616;38530.80734596309;38839.61160388473;38971.41542876802;40204.39693404543;40398.59601403948;37672.50206028585;37970.62029379671;38096.42855357117;38229.42655860109;38532;38452.80773596114;38478.61521384862;39119.80440097781;39134.804325978184;39258.803705981285;33477;34817.65182348144;35100;35250.64749352474;35632.64367356293;26234.60648090242;26672;26773.464530709665;26867;27026.243728888214 12:02:02 INFO - 2016-01-21 12:02:02,823 DEBUG : BROWSER_OUTPUT: |2;jquery.html;376.77581838805935;380.16363999201764;383.9731218814682;389.6337442803765;391.77081407376687;16038.43865464709;17353;17985.730214046765;19139.61720765584;19190.904045479772;11815.527378904855;11966.521339146424;12076.637700868967;18503.444896653124;18747.718784218247;5181.326427564421;5303.443138470463;5310.946890531084;5548.112302031675;5814.302283725938;5415.48552887475;5580.274564306635;5605.747741351649;5615.606907516475;5653.773849046033;5516.586256030793;5520.337559492847;5581.413951535092;5611.0741727614895;5804.216430781833;5758.9424105759035;5807.128930660392;5811.4479124483105;5823.068309070529;5824.0390335594575;5433.483819037185;5557.41647127054;5595.524380427669;5603.159526071081;5648.774049038034;13571.389287481989;13680.179189248676;13769;13834.584962451041;14195.148291102567;2177.7060096886876;2259.6949411829355;2321.257197696738;2327.7206735191717;2339.5554844579474;10091.69724908254;10143.543540540619;10293.3823970562;10424.583016679324;11199.776004479865;1879.642867855103;1898.0699457265841;1919.8560107991957;1929.68160253558;1949.9122539485616;66562.33437665658;67095.99356009664;68639;68852.6557367215;68897.65551172262;10510.63212787564;10794.46027698612;10881.564737410416;10940.890591093987;10961.12311015117;13925.512607058907;14170.64573385653;14175.574732758034;14183.290835458185;14211.64470888236;8499.532525711145;8512.233898949;8525.01962274334;8541.572921353907;8586.055533891267;8439.746807595782;8524.06235314115;8536.975562932488;8561.10108438605;8587.48475091484;4235.830566777356;4343.587359200871;4620.1221767864;4637.350770892078;4665.370175026328;1865.048825099182;1913.2633935934487;1944.2903340280695;1944.6791279438735;1968.6948522978962;979.9608015679293;1085.3379438542484;1099.0490532919139;1108.772701596171;1132.0660455124391;17674.911625442048;18260.54348641268;18588.628227435645;18723.157457914425;18855.90572047131;974.025974025974;981.4307701533094;1006.7936073104996;1015.0661391519819;1016.0499932563077;10296.536655850505;10562.630307939186;10590.099841513404;10601.734956626146;10606.893931060591;589253;595777;613824;635348;642589;85034.57482712547;85377.14622853816;85715;86114.56942715247;86775;1121.2599684208546;1132.371533798733;1142.8514293142005;1148.534843388429;1150.3902931446346;13704.45182192741;14193.503227387406;14677.192754398611;16821.579460513585;16924;37177.6282237185;37326.813365933;37520.43719344267;38149.80925095357;38507;46750.766246168554;47489.52510474851;47770.52229477661;48768.26847597218;49362.259566107256;10452.634157804441;10541.31481453703;10625.734356641145;10649.254552181274;10777.461126943464;15042.6991460168;18023.549411264823;19014.809851901304;19146.23415063382;19375.51561210981;15561.533154005398;15607.453739119077;15826.841731582997;16037.278322475284;16049.358025678843;14571.85428145705;15481.767773483632;15870.682586347977;16010.19949002522;16209.108499032194;14919.850801491846;15055.698886022437;15357.078575285519;15538.61153471127;15806.525804225892;9928.801423971625;10016.799664006825;10052.949735251277;10071.093601575893;10089.747756305858;14711.3379897907;14858.108513489226;14907;15108.39566417331;15453.61365965815 12:02:02 INFO - 2016-01-21 12:02:02,825 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1474.4839306242816;1494.006485687018;1647.2587335698938;1771.3446024970758;1828.8445482134014;8164.224398682123;8393.580320983949;8415.789605259872;8426.620802063906;8558.400911936167;8364.665413383473;8368.121347258542;8409.78975525612;8418.32653387729;8448.197421244971;2369.5971684813535;2406.42245860993;2406.68713067301;2408.205292253561;2408.5664580375524;2344.3670209043635;2374.0385144016614;2375.8455700379504;2380.6310021946624;2390.1156572068357;2278.6809846621486;2332.941676458085;2342.3441436397834;2381.452265978826;2404.4469771952463;2358.587247231736;2369.644553316999;2383.690120284369;2386.3676125826755;2387.319613910036;2317.3974766560814;2342.4143964009;2348.7768661977257;2355.1756885090253;2355.2698663414394;8306.252437280613;8397.076321604618;8414.915850841475;8422.368322375785;8439.409241353107;5048.469910659402;5096.51583099605;5098.6176036797015;5098.796048158107;5142.04872098663;3098.209956461088;3158.392906070183;3218.2758879251983;3245.96754032459;3253.430649636304;946.6260826973376;954.2652157838495;966.3187452845727;981.8379967305386;1017.0541396501251;11550.826737598944;11618.59334923282;11629.418529073597;11632.418379081013;11666.358350290731;4325.4593175853015;4355.368471571668;4356.738595684269;4378.715383500063;4393.7363758174615;9350.485723285285;9377.1091746284;9384;9429.57566909477;9436;4765.332853400527;4832.710037397767;4849.199882019428;4852.636052296092;4862.80548778052;4405.31717583775;4430.712003719812;4441.400410944546;4453.22068637987;4494.696538004007;3603.171270607775;3641.6540428659237;3647.6170002149925;3718.442233664972;3722.40441529354;1091.1979694924225;1093.956241750337;1100.7743412600398;1120.675004248775;1128.7121783945042;1113.9832902506469;1120.815065514181;1149.844770955927;1337.197681391177;1406.2617126008927;7517.548947063085;7542.886856697154;7631.3894888408795;7678.884816727754;7681.116671582728;1129.4860838318546;1148.8334191542347;1150.677810213125;1157.4733496259182;1173.524722487377;6318.052292156213;6351.301356850743;6365.586236894587;6388.105665206875;6399.968000159969;9707.66023189185;9834.606615735434;9885.654002109892;10038.598456061676;10065.144462720751;9617.51912404377;9836.803263934824;9889.60441582343;9896.208303335716;9949.850752238723;7938.880916786253;7992.800179995546;7998.040235171817;8006.599670016476;8023.719169829028;7890.132085470708;7922.128565857636;7972.402069844668;7982.521048737094;8000.279974802295;8778.122187781171;9062.048484909254;9068.501232432016;9070.410423322463;9132.452052876582;9226.907730922605;9235.953820230856;9329.440233586007;9359.15767580921;9506.667266645634;7467.58928258951;7538.849223015619;7632.80917977055;7639.732609358646;7668.233176682287;7582.574344343298;8087.393445491494;8138.389620778347;8159.46963447374;8207.261346478846;7110.822229444098;7438.256174382518;7476.401887849068;7483.625818709152;7710.460267781202;7316.926830731624;7458.254174582498;7529.774106776806;7543.321101100927;7671.232876712284;7654.119776225582;7665.923340766521;7673.309402153833;7678.040244969379;7690;6643.368879956396;6886.035954966409;6987.301269872972;7011;7017;7072.186698529735;7095.751648692478;7098.858022839618;7109.928900710926;7157.105361829771 12:02:02 INFO - 2016-01-21 12:02:02,825 DEBUG : BROWSER_OUTPUT: |4;prototype.html;353.5509902423922;356.4813196798658;359.6475454055026;361.2576155999421;362.8711807308407;6304.495640348767;6314.55798094133;6328.430441260291;6382.872342553146;6473.4173924346915;6353.459955903742;6376.139221205136;6379.521535884804;6382.521310901678;6394.360563943604;4866.294387313837;4872.488388719186;4873.415190177184;4874.512548745124;4877.3903262092235;4874.805007799684;4882.218844984804;4885.242787367946;4887.853364399056;4891.315215869763;4640.79116439761;4703.694259873115;4787.54518320759;4788.97605511972;4797.568218860302;4751.786169622375;4764.023375208074;4774.570288674018;4786.186348320759;4808.206645903421;4185.204811085884;4185.455890734185;4192.413062171298;4192.706510544263;4192.895177620553;5994.730237139339;5995.250593675791;5999.580029397944;6004.729787159588;6006.5495087868585;5492.642978206404;5550.389457159709;5569.443055694439;5574.554035677136;5579.302587176603;6605.141331626905;6660.067590537328;6694.230163531208;6694.83262918426;6701.731930722765;4577.130345234395;4586.678932474728;4587.472440669332;4601.907961840778;4614.261718125117;6835.179778426621;6950.652467376611;6988.301169882971;7011.439084873198;7018.473614478883;4725.220338644154;4726.527347265246;4726.527347265246;4732.100900828831;4747.643926705511;4774.641901857374;4777.904441911142;4789;4790.94599188178;4791.9936813268905;5539.695316757537;5546.168074788814;5569.470900264469;5569.721513924369;5580.665160090408;6653.600783952978;6772.424343930723;6782.626955517395;6783.830404239933;6797.388235058868;1681.5880109373281;1689.9408520701963;1691.2135856826635;1693.9745903811452;1694.1105919392417;1123.9438028098562;1132.0660455124555;1132.3715337987496;1141.8458508101467;1148.454484120053;6488.156539649815;6520.347965203537;6520.804375868732;6525.086487891699;6535.411812936763;6960.65196740161;6977.720891164398;6980.581165130108;6994.230634630187;7006.544574602634;6212.565120441525;6242.843928901813;6457.935420645827;6497.610143391317;6526.34736526353;3768.679662228741;3782.9432558511644;3784.110733977513;3800.5819359870393;3801.7718936863876;7264.891026634605;7281.381082607932;7295.051643286339;7301.963490182515;7303.853922921512;7120.9643951780945;7209.89185162223;7244.855102898018;7293.197748247689;7300.853982920312;7262.419006479575;7290.927090729131;7299.70801167958;7305.4886157969495;7325.084364454443;7009.369156775914;7013.2986701329455;7033.050538177486;7052.153741551047;7058.941158826217;6775.288594697683;7007.6846541904715;7012.298770122947;7015.123109611299;7021.5787052777;7280.417566594554;7307;7307.378872795659;7309.122905251404;7323.340899319087;4769.475357710579;4794.832180873653;4805.255185446262;4806.062817750505;4814.325994360863;6854.897176542256;7014.333638304353;7021.578705277495;7048.436125110082;7049.6122713249215;6768.0863083485065;6849.691763870538;6855.657217139223;6862.9313706862295;6875.4155896749335;6711.429528490133;6790.743712413219;6828.9658551706925;6839.829004274734;6847.281035491202;6711.46308295345;6714.563553369016;6717.261101278757;6722.361375669304;6726.428253598499;6818.079559259437;6835.453163746789;6835.93164068353;6852.177738671192;6872;6502.772402965874;6654.101696270942;6704.4636429084585;6704.7988560343265;6707.832304192434 12:02:02 INFO - 2016-01-21 12:02:02,826 DEBUG : BROWSER_OUTPUT: |5;yui.html;904.8597467392557;923.6490133749179;929.0941332201103;945.0407836046412;950.7052813627776;13094.869051309495;13369.598912032654;13378.531751388715;13380.531681391154;13383.197008179515;12461.813072803916;12536.247825130498;12548.1216314858;12569.434375453104;12575.496980120806;878.2052242720316;881.5063564403938;895.5343221524803;896.7130518234168;897.4974014551839;906.3927168796889;909.849874770662;911.5305617606938;914.1315750037458;917.6696389299847;942.740746294771;947.0482165423739;951.4957072751419;951.7430293820664;954.88063992001;935.3031991166556;937.0254934867729;940.1867384712243;941.8445956417183;945.413843417079;684.4968947823346;685.4721864164566;689.8758223519765;695.8851789454734;700.7722490190708;13397.464101435931;13434.86565134346;13467.461301547926;13496.662583435394;13506.32468376587;12034.21777584463;12159.088068394905;12324.383780810924;12453.626391208278;12791.48834046637;10960.506777195045;11042.889571104266;11076.39079850608;11114.499847506882;11159.107271418348;3715.16408808016;3728;3748.3253014457387;3752.137008488063;3783.5838057813617;50075.24887126696;50154.498455015346;50230;50444.24333634999;50639.49360506421;9622.566984485715;10012.299139060196;10802.415533248273;10934.289271197506;11262.267952583219;19370.903145484182;19428.708569371473;19439.514012149808;19481.90259048724;19487.415377538695;7626.275503827128;7781.766547003599;7787.805304867424;7825.178356272623;7974.282314591715;4289.592488713567;4302.118065796567;4303.33298338758;4336.891577710582;4345.891352716208;3511.2099777550357;3522.682958533693;3549.1304630365726;3555.591107022674;3562.8931132066077;635.885540602696;639.2967735490922;647.4852492268658;649.4933951517824;654.6628486329544;581.7120525339984;583.1835430397392;648.3095503288982;684.5071548485083;696.7665831946355;8175.918240817516;8527.573621318908;9480.146786789222;10148.746281342877;10544.209184311054;477.7849967514632;583.486531851976;620.5376994139395;660.1451120798481;695.8156088636515;4107.199096176217;4220;4667.323238130452;4681.976590117096;4737.8341758038305;57957.710211449514;59896.70051649714;60896.69551652302;61192.38807611956;61727;50195;50286.24570631443;51894.74052629788;53782;53800.46199537955;48928.7553562237;49669.50330496721;49782.253266201034;50111.49888501141;50594.49405505972;9002.549872506479;9325;9749;10260.384376937407;10426.739331516772;37538.81230593829;37596.436053458674;37836;38857.417138743505;39121.021974450865;46918.29622555596;47607;47632.7618361906;48179.75910120427;49902.00587964734;11407.657770266906;11571.305721656727;11586.420678966186;11685.707857303636;12226.510939562319;13267.86960422682;13405.396757146147;13613.931930340284;13678.384472698554;13726.519571814939;12102.576409825613;12334.568290109803;12543.749125017632;12758.48966041348;12797.42411591462;10684.465776710978;10797.784044319227;10962.287451315638;10985.83521247166;11178.944105279421;12267.141300108906;12284.508619655113;12370;12462.252264864137;12833.743325133632;9521.38111022809;10035.749106272402;10188.796224075626;10250.333728307636;10377.688669339932;9922.056666101045;10449.477526123512;10473.738156545842;10582.417967011581;10761.515731791931 12:02:02 INFO - 2016-01-21 12:02:02,826 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:02:02 INFO - 2016-01-21 12:02:02,826 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:02:02 INFO - 2016-01-21 12:02:02,826 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,298 12:02:02 INFO - 2016-01-21 12:02:02,826 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:02:02 INFO - 2016-01-21 12:02:02,826 DEBUG : BROWSER_OUTPUT: __startTimestamp1453406522818__endTimestamp 12:02:02 INFO - 2016-01-21 12:02:02,827 DEBUG : BROWSER_OUTPUT: 12:02:02 INFO - 2016-01-21 12:02:02,827 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:02:02 INFO - 2016-01-21 12:02:02,827 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:02:02 INFO - 2016-01-21 12:02:02,827 DEBUG : BROWSER_OUTPUT: 12:02:02 INFO - 2016-01-21 12:02:02,827 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5663.18 Median:5902.00 stddev:650.19 (11.0%) stddev-sans-first:625.05 12:02:02 INFO - 2016-01-21 12:02:02,827 DEBUG : BROWSER_OUTPUT: Values: 3293.7 3326.5 3331.6 3337.8 3350.2 5558.6 5562.6 5568.7 5575.5 5592.7 5574.9 5667.3 5679.3 5679.4 5716.2 5135.5 5163.1 5206.0 5230.2 5254.4 5042.7 5133.9 5141.7 5142.7 5243.2 5094.2 5183.5 5184.1 5203.0 5215.6 5181.4 5207.4 5249.1 5258.4 5283.7 4947.7 5000.3 5000.4 5153.6 5169.7 5358.3 5407.8 5413.5 5431.9 5474.6 6085.1 6112.0 6139.4 6145.4 6168.5 5945.6 6077.1 6101.8 6182.2 6186.0 5707.2 5708.4 5731.6 5734.5 5767.4 6208.4 6216.6 6221.7 6226.3 6236.5 5744.5 5902.0 6022.4 6029.3 6133.7 6150.9 6162.0 6181.5 6189.9 6204.9 6087.4 6156.3 6165.1 6175.3 6185.3 6002.2 6002.9 6117.2 6128.4 6132.8 4681.2 4683.9 4684.3 4713.1 4715.5 4036.2 4180.3 4185.2 4194.2 4220.2 5653.9 5709.6 5717.3 5748.1 5799.7 6150.7 6239.7 6243.5 6247.8 6258.8 5581.7 5692.8 5783.5 5836.7 5841.9 5268.1 5339.0 5350.6 5353.6 5376.5 6242.8 6282.1 6310.1 6326.1 6335.3 6020.2 6034.1 6132.8 6166.4 6180.2 6258.3 6288.1 6308.8 6329.6 6334.1 6038.6 6057.1 6058.1 6061.5 6084.3 5963.5 6000.5 6055.6 6108.1 6146.0 6037.5 6082.7 6086.9 6090.1 6098.1 5986.4 6046.4 6058.4 6064.1 6090.1 5638.9 5741.1 5762.2 5874.4 5895.3 5979.6 6007.5 6035.7 6067.4 6092.5 5677.7 5904.0 5904.7 5934.9 5955.9 12:02:02 INFO - 2016-01-21 12:02:02,827 DEBUG : BROWSER_OUTPUT: 12:02:02 INFO - 2016-01-21 12:02:02,827 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:55669.63 Median:38531.40 stddev:114349.65 (296.8%) stddev-sans-first:114595.65 12:02:02 INFO - 2016-01-21 12:02:02,827 DEBUG : BROWSER_OUTPUT: Values: 587.3 618.8 630.9 633.3 659.6 41191.6 41665.4 41819.6 41852.6 42086.8 45792.0 46016.3 46039.8 46440.8 46534.8 8980.6 9181.1 9195.1 9233.6 9252.3 8993.9 9029.3 9045.5 9057.8 9061.9 9075.5 9150.5 9169.4 9172.4 9176.3 9009.8 9036.8 9045.8 9089.4 9125.7 8960.7 9196.0 9210.4 9214.2 9214.6 42186.0 42557.4 42624.6 42696.4 42772.6 3489.4 3533.2 3581.8 3664.0 4022.6 32435.8 32931.2 33013.2 33139.0 33345.2 3656.6 3731.9 3755.2 3808.5 3820.7 268799.0 272729.0 273111.0 273784.0 276024.0 44308.6 45189.3 45288.8 60948.4 61498.7 42386.8 42866.6 42889.1 43055.1 43130.6 16808.7 17034.3 17034.5 17070.5 17090.8 13365.5 13462.8 13485.6 13503.1 13509.3 14880.0 15138.1 15189.5 15225.0 15225.6 5958.9 5980.8 6078.4 6086.6 6111.2 1027.6 1055.9 1129.7 1136.4 1196.0 29683.0 30142.2 34003.7 34065.0 34277.8 1061.8 1091.1 1110.8 1127.5 1171.2 17245.7 17457.7 17532.6 17573.5 17676.3 401877.0 551864.0 556822.0 558979.0 856830.0 57977.0 58657.7 58693.7 59165.7 59214.4 1437.5 1446.1 1446.5 1455.1 1460.2 30258.1 30747.8 30876.4 31283.4 31633.8 49225.5 49730.8 49786.8 49877.8 49879.3 329021.0 331600.0 332706.0 332776.0 333702.0 33677.8 33866.2 34076.3 34376.7 34612.7 44935.3 45721.8 46081.8 46377.1 46408.8 38530.8 38839.6 38971.4 40204.4 40398.6 37672.5 37970.6 38096.4 38229.4 38532.0 38452.8 38478.6 39119.8 39134.8 39258.8 33477.0 34817.7 35100.0 35250.6 35632.6 26234.6 26672.0 26773.5 26867.0 27026.2 12:02:02 INFO - 2016-01-21 12:02:02,827 DEBUG : BROWSER_OUTPUT: 12:02:02 INFO - 2016-01-21 12:02:02,827 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31687.13 Median:10526.44 stddev:100608.39 (955.8%) stddev-sans-first:100863.16 12:02:02 INFO - 2016-01-21 12:02:02,828 DEBUG : BROWSER_OUTPUT: Values: 376.8 380.2 384.0 389.6 391.8 16038.4 17353.0 17985.7 19139.6 19190.9 11815.5 11966.5 12076.6 18503.4 18747.7 5181.3 5303.4 5310.9 5548.1 5814.3 5415.5 5580.3 5605.7 5615.6 5653.8 5516.6 5520.3 5581.4 5611.1 5804.2 5758.9 5807.1 5811.4 5823.1 5824.0 5433.5 5557.4 5595.5 5603.2 5648.8 13571.4 13680.2 13769.0 13834.6 14195.1 2177.7 2259.7 2321.3 2327.7 2339.6 10091.7 10143.5 10293.4 10424.6 11199.8 1879.6 1898.1 1919.9 1929.7 1949.9 66562.3 67096.0 68639.0 68852.7 68897.7 10510.6 10794.5 10881.6 10940.9 10961.1 13925.5 14170.6 14175.6 14183.3 14211.6 8499.5 8512.2 8525.0 8541.6 8586.1 8439.7 8524.1 8537.0 8561.1 8587.5 4235.8 4343.6 4620.1 4637.4 4665.4 1865.0 1913.3 1944.3 1944.7 1968.7 980.0 1085.3 1099.0 1108.8 1132.1 17674.9 18260.5 18588.6 18723.2 18855.9 974.0 981.4 1006.8 1015.1 1016.0 10296.5 10562.6 10590.1 10601.7 10606.9 589253.0 595777.0 613824.0 635348.0 642589.0 85034.6 85377.1 85715.0 86114.6 86775.0 1121.3 1132.4 1142.9 1148.5 1150.4 13704.5 14193.5 14677.2 16821.6 16924.0 37177.6 37326.8 37520.4 38149.8 38507.0 46750.8 47489.5 47770.5 48768.3 49362.3 10452.6 10541.3 10625.7 10649.3 10777.5 15042.7 18023.5 19014.8 19146.2 19375.5 15561.5 15607.5 15826.8 16037.3 16049.4 14571.9 15481.8 15870.7 16010.2 16209.1 14919.9 15055.7 15357.1 15538.6 15806.5 9928.8 10016.8 10052.9 10071.1 10089.7 14711.3 14858.1 14907.0 15108.4 15453.6 12:02:02 INFO - 2016-01-21 12:02:02,829 DEBUG : BROWSER_OUTPUT: 12:02:02 INFO - 2016-01-21 12:02:02,829 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5834.01 Median:6999.15 stddev:3069.19 (43.9%) stddev-sans-first:3060.31 12:02:02 INFO - 2016-01-21 12:02:02,829 DEBUG : BROWSER_OUTPUT: Values: 1474.5 1494.0 1647.3 1771.3 1828.8 8164.2 8393.6 8415.8 8426.6 8558.4 8364.7 8368.1 8409.8 8418.3 8448.2 2369.6 2406.4 2406.7 2408.2 2408.6 2344.4 2374.0 2375.8 2380.6 2390.1 2278.7 2332.9 2342.3 2381.5 2404.4 2358.6 2369.6 2383.7 2386.4 2387.3 2317.4 2342.4 2348.8 2355.2 2355.3 8306.3 8397.1 8414.9 8422.4 8439.4 5048.5 5096.5 5098.6 5098.8 5142.0 3098.2 3158.4 3218.3 3246.0 3253.4 946.6 954.3 966.3 981.8 1017.1 11550.8 11618.6 11629.4 11632.4 11666.4 4325.5 4355.4 4356.7 4378.7 4393.7 9350.5 9377.1 9384.0 9429.6 9436.0 4765.3 4832.7 4849.2 4852.6 4862.8 4405.3 4430.7 4441.4 4453.2 4494.7 3603.2 3641.7 3647.6 3718.4 3722.4 1091.2 1094.0 1100.8 1120.7 1128.7 1114.0 1120.8 1149.8 1337.2 1406.3 7517.5 7542.9 7631.4 7678.9 7681.1 1129.5 1148.8 1150.7 1157.5 1173.5 6318.1 6351.3 6365.6 6388.1 6400.0 9707.7 9834.6 9885.7 10038.6 10065.1 9617.5 9836.8 9889.6 9896.2 9949.9 7938.9 7992.8 7998.0 8006.6 8023.7 7890.1 7922.1 7972.4 7982.5 8000.3 8778.1 9062.0 9068.5 9070.4 9132.5 9226.9 9236.0 9329.4 9359.2 9506.7 7467.6 7538.8 7632.8 7639.7 7668.2 7582.6 8087.4 8138.4 8159.5 8207.3 7110.8 7438.3 7476.4 7483.6 7710.5 7316.9 7458.3 7529.8 7543.3 7671.2 7654.1 7665.9 7673.3 7678.0 7690.0 6643.4 6886.0 6987.3 7011.0 7017.0 7072.2 7095.8 7098.9 7109.9 7157.1 12:02:02 INFO - 2016-01-21 12:02:02,829 DEBUG : BROWSER_OUTPUT: 12:02:02 INFO - 2016-01-21 12:02:02,829 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5651.80 Median:6426.15 stddev:1725.67 (26.9%) stddev-sans-first:1684.06 12:02:02 INFO - 2016-01-21 12:02:02,830 DEBUG : BROWSER_OUTPUT: Values: 353.6 356.5 359.6 361.3 362.9 6304.5 6314.6 6328.4 6382.9 6473.4 6353.5 6376.1 6379.5 6382.5 6394.4 4866.3 4872.5 4873.4 4874.5 4877.4 4874.8 4882.2 4885.2 4887.9 4891.3 4640.8 4703.7 4787.5 4789.0 4797.6 4751.8 4764.0 4774.6 4786.2 4808.2 4185.2 4185.5 4192.4 4192.7 4192.9 5994.7 5995.3 5999.6 6004.7 6006.5 5492.6 5550.4 5569.4 5574.6 5579.3 6605.1 6660.1 6694.2 6694.8 6701.7 4577.1 4586.7 4587.5 4601.9 4614.3 6835.2 6950.7 6988.3 7011.4 7018.5 4725.2 4726.5 4726.5 4732.1 4747.6 4774.6 4777.9 4789.0 4790.9 4792.0 5539.7 5546.2 5569.5 5569.7 5580.7 6653.6 6772.4 6782.6 6783.8 6797.4 1681.6 1689.9 1691.2 1694.0 1694.1 1123.9 1132.1 1132.4 1141.8 1148.5 6488.2 6520.3 6520.8 6525.1 6535.4 6960.7 6977.7 6980.6 6994.2 7006.5 6212.6 6242.8 6457.9 6497.6 6526.3 3768.7 3782.9 3784.1 3800.6 3801.8 7264.9 7281.4 7295.1 7302.0 7303.9 7121.0 7209.9 7244.9 7293.2 7300.9 7262.4 7290.9 7299.7 7305.5 7325.1 7009.4 7013.3 7033.1 7052.2 7058.9 6775.3 7007.7 7012.3 7015.1 7021.6 7280.4 7307.0 7307.4 7309.1 7323.3 4769.5 4794.8 4805.3 4806.1 4814.3 6854.9 7014.3 7021.6 7048.4 7049.6 6768.1 6849.7 6855.7 6862.9 6875.4 6711.4 6790.7 6829.0 6839.8 6847.3 6711.5 6714.6 6717.3 6722.4 6726.4 6818.1 6835.5 6835.9 6852.2 6872.0 6502.8 6654.1 6704.5 6704.8 6707.8 12:02:02 INFO - 2016-01-21 12:02:02,830 DEBUG : BROWSER_OUTPUT: 12:02:02 INFO - 2016-01-21 12:02:02,830 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14534.37 Median:4320.11 stddev:16781.83 (388.5%) stddev-sans-first:16797.70 12:02:02 INFO - 2016-01-21 12:02:02,830 DEBUG : BROWSER_OUTPUT: Values: 904.9 923.6 929.1 945.0 950.7 13094.9 13369.6 13378.5 13380.5 13383.2 12461.8 12536.2 12548.1 12569.4 12575.5 878.2 881.5 895.5 896.7 897.5 906.4 909.8 911.5 914.1 917.7 942.7 947.0 951.5 951.7 954.9 935.3 937.0 940.2 941.8 945.4 684.5 685.5 689.9 695.9 700.8 13397.5 13434.9 13467.5 13496.7 13506.3 12034.2 12159.1 12324.4 12453.6 12791.5 10960.5 11042.9 11076.4 11114.5 11159.1 3715.2 3728.0 3748.3 3752.1 3783.6 50075.2 50154.5 50230.0 50444.2 50639.5 9622.6 10012.3 10802.4 10934.3 11262.3 19370.9 19428.7 19439.5 19481.9 19487.4 7626.3 7781.8 7787.8 7825.2 7974.3 4289.6 4302.1 4303.3 4336.9 4345.9 3511.2 3522.7 3549.1 3555.6 3562.9 635.9 639.3 647.5 649.5 654.7 581.7 583.2 648.3 684.5 696.8 8175.9 8527.6 9480.1 10148.7 10544.2 477.8 583.5 620.5 660.1 695.8 4107.2 4220.0 4667.3 4682.0 4737.8 57957.7 59896.7 60896.7 61192.4 61727.0 50195.0 50286.2 51894.7 53782.0 53800.5 48928.8 49669.5 49782.3 50111.5 50594.5 9002.5 9325.0 9749.0 10260.4 10426.7 37538.8 37596.4 37836.0 38857.4 39121.0 46918.3 47607.0 47632.8 48179.8 49902.0 11407.7 11571.3 11586.4 11685.7 12226.5 13267.9 13405.4 13613.9 13678.4 13726.5 12102.6 12334.6 12543.7 12758.5 12797.4 10684.5 10797.8 10962.3 10985.8 11178.9 12267.1 12284.5 12370.0 12462.3 12833.7 9521.4 10035.7 10188.8 10250.3 10377.7 9922.1 10449.5 10473.7 10582.4 10761.5 12:02:02 INFO - 2016-01-21 12:02:02,831 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:02:02 INFO - 2016-01-21 12:02:02,831 DEBUG : BROWSER_OUTPUT: 12:02:03 INFO - 2016-01-21 12:02:03,513 INFO : Browser exited with error code: 0 12:02:03 INFO - 2016-01-21 12:02:03,534 INFO : Completed test dromaeo_css (00:18:28) 12:02:03 INFO - 2016-01-21 12:02:03,534 INFO : Starting test kraken 12:02:03 INFO - 2016-01-21 12:02:03,534 DEBUG : operating with platform_type : linux_ 12:02:03 INFO - 2016-01-21 12:02:03,535 INFO : Initialising browser for kraken test... 12:02:03 INFO - 2016-01-21 12:02:03,541 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpK16Ss0/profile http://localhost:46098/getInfo.html 12:02:06 INFO - 2016-01-21 12:02:06,941 DEBUG : BROWSER_OUTPUT: 12:02:06 INFO - 2016-01-21 12:02:06,941 DEBUG : BROWSER_OUTPUT: (process:21530): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:02:07 INFO - 2016-01-21 12:02:07,749 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:02:07 INFO - 2016-01-21 12:02:07,749 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:02:07 INFO - 2016-01-21 12:02:07,749 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:02:07 INFO - 2016-01-21 12:02:07,749 DEBUG : BROWSER_OUTPUT: __metrics 12:02:08 INFO - 2016-01-21 12:02:08,681 INFO : Browser initialized. 12:02:08 INFO - 2016-01-21 12:02:08,682 INFO : Running cycle 1/1 for kraken test... 12:02:08 INFO - 2016-01-21 12:02:08,682 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpK16Ss0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:02:09 INFO - 2016-01-21 12:02:09,941 DEBUG : BROWSER_OUTPUT: 12:02:09 INFO - 2016-01-21 12:02:09,941 DEBUG : BROWSER_OUTPUT: (process:21643): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:02:20 INFO - 2016-01-21 12:02:20,444 DEBUG : BROWSER_OUTPUT: RSS: Main: 136830976 12:02:20 INFO - 2016-01-21 12:02:20,444 DEBUG : BROWSER_OUTPUT: 12:02:22 INFO - 2016-01-21 12:02:22,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46098/tests/kraken/driver.html?testName=audio-beat-detection) 12:02:23 INFO - 2016-01-21 12:02:23,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 139075584 12:02:23 INFO - 2016-01-21 12:02:23,491 DEBUG : BROWSER_OUTPUT: 12:02:26 INFO - 2016-01-21 12:02:26,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46098/tests/kraken/driver.html?testName=audio-dft) 12:02:26 INFO - 2016-01-21 12:02:26,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 139382784 12:02:26 INFO - 2016-01-21 12:02:26,700 DEBUG : BROWSER_OUTPUT: 12:02:29 INFO - 2016-01-21 12:02:29,524 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46098/tests/kraken/driver.html?testName=audio-fft) 12:02:30 INFO - 2016-01-21 12:02:30,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 138469376 12:02:30 INFO - 2016-01-21 12:02:30,111 DEBUG : BROWSER_OUTPUT: 12:02:32 INFO - 2016-01-21 12:02:32,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46098/tests/kraken/driver.html?testName=audio-oscillator) 12:02:32 INFO - 2016-01-21 12:02:32,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 139456512 12:02:32 INFO - 2016-01-21 12:02:32,706 DEBUG : BROWSER_OUTPUT: 12:02:34 INFO - 2016-01-21 12:02:34,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46098/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:02:35 INFO - 2016-01-21 12:02:35,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 137785344 12:02:35 INFO - 2016-01-21 12:02:35,470 DEBUG : BROWSER_OUTPUT: 12:02:38 INFO - 2016-01-21 12:02:38,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46098/tests/kraken/driver.html?testName=imaging-darkroom) 12:02:39 INFO - 2016-01-21 12:02:39,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 138215424 12:02:39 INFO - 2016-01-21 12:02:39,063 DEBUG : BROWSER_OUTPUT: 12:02:42 INFO - 2016-01-21 12:02:42,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46098/tests/kraken/driver.html?testName=imaging-desaturate) 12:02:42 INFO - 2016-01-21 12:02:42,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 138412032 12:02:42 INFO - 2016-01-21 12:02:42,963 DEBUG : BROWSER_OUTPUT: 12:02:45 INFO - 2016-01-21 12:02:45,747 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46098/tests/kraken/driver.html?testName=json-parse-financial) 12:02:46 INFO - 2016-01-21 12:02:46,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 138543104 12:02:46 INFO - 2016-01-21 12:02:46,340 DEBUG : BROWSER_OUTPUT: 12:02:47 INFO - 2016-01-21 12:02:47,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46098/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:02:48 INFO - 2016-01-21 12:02:48,514 DEBUG : BROWSER_OUTPUT: RSS: Main: 139026432 12:02:48 INFO - 2016-01-21 12:02:48,515 DEBUG : BROWSER_OUTPUT: 12:02:50 INFO - 2016-01-21 12:02:50,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46098/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:02:50 INFO - 2016-01-21 12:02:50,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 138682368 12:02:50 INFO - 2016-01-21 12:02:50,913 DEBUG : BROWSER_OUTPUT: 12:02:52 INFO - 2016-01-21 12:02:52,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46098/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:02:53 INFO - 2016-01-21 12:02:53,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 138625024 12:02:53 INFO - 2016-01-21 12:02:53,567 DEBUG : BROWSER_OUTPUT: 12:02:55 INFO - 2016-01-21 12:02:55,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46098/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:02:56 INFO - 2016-01-21 12:02:56,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 138846208 12:02:56 INFO - 2016-01-21 12:02:56,564 DEBUG : BROWSER_OUTPUT: 12:02:59 INFO - 2016-01-21 12:02:59,080 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46098/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:02:59 INFO - 2016-01-21 12:02:59,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 139763712 12:02:59 INFO - 2016-01-21 12:02:59,663 DEBUG : BROWSER_OUTPUT: 12:03:01 INFO - 2016-01-21 12:03:01,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46098/tests/kraken/driver.html?testName=ai-astar) 12:03:01 INFO - 2016-01-21 12:03:01,651 DEBUG : BROWSER_OUTPUT: RSS: Main: 138903552 12:03:01 INFO - 2016-01-21 12:03:01,651 DEBUG : BROWSER_OUTPUT: 12:03:01 INFO - 2016-01-21 12:03:01,651 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:03:01 INFO - 2016-01-21 12:03:01,651 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:03:01 INFO - 2016-01-21 12:03:01,651 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:03:01 INFO - 2016-01-21 12:03:01,652 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:03:01 INFO - 2016-01-21 12:03:01,652 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;105;110;111;112;121;109;110;110;111 12:03:01 INFO - 2016-01-21 12:03:01,652 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;129;158;165;122;153;154;126;165;125 12:03:01 INFO - 2016-01-21 12:03:01,652 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;163;163;164;167;161;161;163;162 12:03:01 INFO - 2016-01-21 12:03:01,652 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;75;163;71;74;73;74;155;74 12:03:01 INFO - 2016-01-21 12:03:01,652 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;137;93;92;94;131;92;93;137 12:03:01 INFO - 2016-01-21 12:03:01,652 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;111;109;109;110;110;110;109 12:03:01 INFO - 2016-01-21 12:03:01,653 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;151;149;147;146;146;146;148;146;150;147 12:03:01 INFO - 2016-01-21 12:03:01,653 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;101;96;96;96;96;96;97;96;96;96 12:03:01 INFO - 2016-01-21 12:03:01,653 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;62;63;61;60;61;61;63;60;62 12:03:01 INFO - 2016-01-21 12:03:01,653 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;63;64;65;64;64;64;65;66;64 12:03:01 INFO - 2016-01-21 12:03:01,653 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;88;89;83;83;82;89;83;84;82;81 12:03:01 INFO - 2016-01-21 12:03:01,653 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;127;111;122;122;119;118;123;113;112 12:03:01 INFO - 2016-01-21 12:03:01,653 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;144;147;152;144;133;149;145;155;144 12:03:01 INFO - 2016-01-21 12:03:01,654 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;68;69;69;69;69;67;67;73;69 12:03:01 INFO - 2016-01-21 12:03:01,654 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:03:01 INFO - 2016-01-21 12:03:01,654 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:03:01 INFO - 2016-01-21 12:03:01,654 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,707 12:03:01 INFO - 2016-01-21 12:03:01,654 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:03:01 INFO - 2016-01-21 12:03:01,654 DEBUG : BROWSER_OUTPUT: __startTimestamp1453406581645__endTimestamp 12:03:01 INFO - 2016-01-21 12:03:01,655 DEBUG : BROWSER_OUTPUT: 12:03:01 INFO - 2016-01-21 12:03:01,655 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:03:01 INFO - 2016-01-21 12:03:01,655 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:03:01 INFO - 2016-01-21 12:03:01,655 DEBUG : BROWSER_OUTPUT: 12:03:01 INFO - 2016-01-21 12:03:01,655 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:4.00 (3.6%) stddev-sans-first:4.24 12:03:01 INFO - 2016-01-21 12:03:01,655 DEBUG : BROWSER_OUTPUT: Values: 111.0 105.0 110.0 111.0 112.0 121.0 109.0 110.0 110.0 111.0 12:03:01 INFO - 2016-01-21 12:03:01,656 DEBUG : BROWSER_OUTPUT: 12:03:01 INFO - 2016-01-21 12:03:01,656 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.40 Median:153.50 stddev:17.19 (11.2%) stddev-sans-first:18.21 12:03:01 INFO - 2016-01-21 12:03:01,656 DEBUG : BROWSER_OUTPUT: Values: 147.0 129.0 158.0 165.0 122.0 153.0 154.0 126.0 165.0 125.0 12:03:01 INFO - 2016-01-21 12:03:01,656 DEBUG : BROWSER_OUTPUT: 12:03:01 INFO - 2016-01-21 12:03:01,656 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.73 (1.1%) stddev-sans-first:1.83 12:03:01 INFO - 2016-01-21 12:03:01,657 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 163.0 163.0 164.0 167.0 161.0 161.0 163.0 162.0 12:03:01 INFO - 2016-01-21 12:03:01,657 DEBUG : BROWSER_OUTPUT: 12:03:01 INFO - 2016-01-21 12:03:01,657 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.40 Median:73.50 stddev:36.22 (49.3%) stddev-sans-first:37.87 12:03:01 INFO - 2016-01-21 12:03:01,657 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 75.0 163.0 71.0 74.0 73.0 74.0 155.0 74.0 12:03:01 INFO - 2016-01-21 12:03:01,657 DEBUG : BROWSER_OUTPUT: 12:03:01 INFO - 2016-01-21 12:03:01,657 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:93.00 stddev:20.36 (21.9%) stddev-sans-first:21.08 12:03:01 INFO - 2016-01-21 12:03:01,657 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 137.0 93.0 92.0 94.0 131.0 92.0 93.0 137.0 12:03:01 INFO - 2016-01-21 12:03:01,657 DEBUG : BROWSER_OUTPUT: 12:03:01 INFO - 2016-01-21 12:03:01,657 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 12:03:01 INFO - 2016-01-21 12:03:01,657 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 111.0 109.0 109.0 110.0 110.0 110.0 109.0 12:03:01 INFO - 2016-01-21 12:03:01,658 DEBUG : BROWSER_OUTPUT: 12:03:01 INFO - 2016-01-21 12:03:01,658 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.84 (1.2%) stddev-sans-first:1.48 12:03:01 INFO - 2016-01-21 12:03:01,659 DEBUG : BROWSER_OUTPUT: Values: 151.0 149.0 147.0 146.0 146.0 146.0 148.0 146.0 150.0 147.0 12:03:01 INFO - 2016-01-21 12:03:01,659 DEBUG : BROWSER_OUTPUT: 12:03:01 INFO - 2016-01-21 12:03:01,659 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.00 stddev:1.58 (1.6%) stddev-sans-first:0.33 12:03:01 INFO - 2016-01-21 12:03:01,659 DEBUG : BROWSER_OUTPUT: Values: 101.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 12:03:01 INFO - 2016-01-21 12:03:01,659 DEBUG : BROWSER_OUTPUT: 12:03:01 INFO - 2016-01-21 12:03:01,659 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.20 Median:61.50 stddev:1.32 (2.1%) stddev-sans-first:1.13 12:03:01 INFO - 2016-01-21 12:03:01,659 DEBUG : BROWSER_OUTPUT: Values: 59.0 62.0 63.0 61.0 60.0 61.0 61.0 63.0 60.0 62.0 12:03:01 INFO - 2016-01-21 12:03:01,660 DEBUG : BROWSER_OUTPUT: 12:03:01 INFO - 2016-01-21 12:03:01,660 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 12:03:01 INFO - 2016-01-21 12:03:01,660 DEBUG : BROWSER_OUTPUT: Values: 64.0 63.0 64.0 65.0 64.0 64.0 64.0 65.0 66.0 64.0 12:03:01 INFO - 2016-01-21 12:03:01,660 DEBUG : BROWSER_OUTPUT: 12:03:01 INFO - 2016-01-21 12:03:01,660 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:83.50 stddev:3.06 (3.7%) stddev-sans-first:2.96 12:03:01 INFO - 2016-01-21 12:03:01,660 DEBUG : BROWSER_OUTPUT: Values: 88.0 89.0 83.0 83.0 82.0 89.0 83.0 84.0 82.0 81.0 12:03:01 INFO - 2016-01-21 12:03:01,660 DEBUG : BROWSER_OUTPUT: 12:03:01 INFO - 2016-01-21 12:03:01,660 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:121.50 stddev:5.29 (4.4%) stddev-sans-first:5.55 12:03:01 INFO - 2016-01-21 12:03:01,660 DEBUG : BROWSER_OUTPUT: Values: 121.0 127.0 111.0 122.0 122.0 119.0 118.0 123.0 113.0 112.0 12:03:01 INFO - 2016-01-21 12:03:01,660 DEBUG : BROWSER_OUTPUT: 12:03:01 INFO - 2016-01-21 12:03:01,660 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.10 Median:146.00 stddev:6.37 (4.4%) stddev-sans-first:6.21 12:03:01 INFO - 2016-01-21 12:03:01,660 DEBUG : BROWSER_OUTPUT: Values: 138.0 144.0 147.0 152.0 144.0 133.0 149.0 145.0 155.0 144.0 12:03:01 INFO - 2016-01-21 12:03:01,661 DEBUG : BROWSER_OUTPUT: 12:03:01 INFO - 2016-01-21 12:03:01,661 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.79 (2.6%) stddev-sans-first:1.76 12:03:01 INFO - 2016-01-21 12:03:01,661 DEBUG : BROWSER_OUTPUT: Values: 71.0 68.0 69.0 69.0 69.0 69.0 67.0 67.0 73.0 69.0 12:03:01 INFO - 2016-01-21 12:03:01,661 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:03:01 INFO - 2016-01-21 12:03:01,661 DEBUG : BROWSER_OUTPUT: 12:03:02 INFO - 2016-01-21 12:03:02,461 INFO : Browser exited with error code: 0 12:03:02 INFO - 2016-01-21 12:03:02,513 INFO : Completed test kraken (00:00:58) 12:03:02 INFO - 2016-01-21 12:03:02,513 INFO : Starting test v8_7 12:03:02 INFO - 2016-01-21 12:03:02,513 DEBUG : operating with platform_type : linux_ 12:03:02 INFO - 2016-01-21 12:03:02,513 INFO : Initialising browser for v8_7 test... 12:03:02 INFO - 2016-01-21 12:03:02,519 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqj6Yn2/profile http://localhost:46098/getInfo.html 12:03:05 INFO - 2016-01-21 12:03:05,841 DEBUG : BROWSER_OUTPUT: 12:03:05 INFO - 2016-01-21 12:03:05,841 DEBUG : BROWSER_OUTPUT: (process:21954): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:03:06 INFO - 2016-01-21 12:03:06,635 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:03:06 INFO - 2016-01-21 12:03:06,635 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:03:06 INFO - 2016-01-21 12:03:06,635 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:03:06 INFO - 2016-01-21 12:03:06,635 DEBUG : BROWSER_OUTPUT: __metrics 12:03:07 INFO - 2016-01-21 12:03:07,609 INFO : Browser initialized. 12:03:07 INFO - 2016-01-21 12:03:07,610 INFO : Running cycle 1/1 for v8_7 test... 12:03:07 INFO - 2016-01-21 12:03:07,610 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqj6Yn2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:03:08 INFO - 2016-01-21 12:03:08,873 DEBUG : BROWSER_OUTPUT: 12:03:08 INFO - 2016-01-21 12:03:08,873 DEBUG : BROWSER_OUTPUT: (process:22068): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:03:19 INFO - 2016-01-21 12:03:19,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 136687616 12:03:19 INFO - 2016-01-21 12:03:19,377 DEBUG : BROWSER_OUTPUT: 12:03:40 INFO - 2016-01-21 12:03:40,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46098/tests/v8_7/run.html (next: http://localhost:46098/tests/v8_7/run.html) 12:03:41 INFO - 2016-01-21 12:03:41,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 136847360 12:03:41 INFO - 2016-01-21 12:03:41,035 DEBUG : BROWSER_OUTPUT: 12:03:41 INFO - 2016-01-21 12:03:41,035 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:03:41 INFO - 2016-01-21 12:03:41,036 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:03:41 INFO - 2016-01-21 12:03:41,036 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:03:41 INFO - 2016-01-21 12:03:41,036 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:03:41 INFO - 2016-01-21 12:03:41,036 DEBUG : BROWSER_OUTPUT: |0;Richards;165.28925619834712 12:03:41 INFO - 2016-01-21 12:03:41,036 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.77785190126752 12:03:41 INFO - 2016-01-21 12:03:41,036 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.0336040324839 12:03:41 INFO - 2016-01-21 12:03:41,036 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5240.837696335078 12:03:41 INFO - 2016-01-21 12:03:41,037 DEBUG : BROWSER_OUTPUT: |4;RayTrace;919.1176470588235 12:03:41 INFO - 2016-01-21 12:03:41,037 DEBUG : BROWSER_OUTPUT: |5;Earley;551.2679162072767 12:03:41 INFO - 2016-01-21 12:03:41,037 DEBUG : BROWSER_OUTPUT: |6;Boyer;11359.550561797752 12:03:41 INFO - 2016-01-21 12:03:41,037 DEBUG : BROWSER_OUTPUT: |7;RegExp;24142.85714285714 12:03:41 INFO - 2016-01-21 12:03:41,037 DEBUG : BROWSER_OUTPUT: |8;Splay;518.4033177812338 12:03:41 INFO - 2016-01-21 12:03:41,038 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 12:03:41 INFO - 2016-01-21 12:03:41,038 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:03:41 INFO - 2016-01-21 12:03:41,038 DEBUG : BROWSER_OUTPUT: __startTimestamp1453406621034__endTimestamp 12:03:41 INFO - 2016-01-21 12:03:41,038 DEBUG : BROWSER_OUTPUT: 12:03:41 INFO - 2016-01-21 12:03:41,038 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:03:41 INFO - 2016-01-21 12:03:41,039 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:03:41 INFO - 2016-01-21 12:03:41,039 DEBUG : BROWSER_OUTPUT: 12:03:41 INFO - 2016-01-21 12:03:41,039 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.29 Median:165.29 stddev:0.00 (0.0%) 12:03:41 INFO - 2016-01-21 12:03:41,039 DEBUG : BROWSER_OUTPUT: Values: 165.3 12:03:41 INFO - 2016-01-21 12:03:41,039 DEBUG : BROWSER_OUTPUT: 12:03:41 INFO - 2016-01-21 12:03:41,039 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.78 Median:166.78 stddev:0.00 (0.0%) 12:03:41 INFO - 2016-01-21 12:03:41,040 DEBUG : BROWSER_OUTPUT: Values: 166.8 12:03:41 INFO - 2016-01-21 12:03:41,040 DEBUG : BROWSER_OUTPUT: 12:03:41 INFO - 2016-01-21 12:03:41,040 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 12:03:41 INFO - 2016-01-21 12:03:41,040 DEBUG : BROWSER_OUTPUT: Values: 280.0 12:03:41 INFO - 2016-01-21 12:03:41,040 DEBUG : BROWSER_OUTPUT: 12:03:41 INFO - 2016-01-21 12:03:41,040 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 12:03:41 INFO - 2016-01-21 12:03:41,041 DEBUG : BROWSER_OUTPUT: Values: 5240.8 12:03:41 INFO - 2016-01-21 12:03:41,041 DEBUG : BROWSER_OUTPUT: 12:03:41 INFO - 2016-01-21 12:03:41,041 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:919.12 Median:919.12 stddev:0.00 (0.0%) 12:03:41 INFO - 2016-01-21 12:03:41,041 DEBUG : BROWSER_OUTPUT: Values: 919.1 12:03:41 INFO - 2016-01-21 12:03:41,041 DEBUG : BROWSER_OUTPUT: 12:03:41 INFO - 2016-01-21 12:03:41,042 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:551.27 Median:551.27 stddev:0.00 (0.0%) 12:03:41 INFO - 2016-01-21 12:03:41,042 DEBUG : BROWSER_OUTPUT: Values: 551.3 12:03:41 INFO - 2016-01-21 12:03:41,043 DEBUG : BROWSER_OUTPUT: 12:03:41 INFO - 2016-01-21 12:03:41,043 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11359.55 Median:11359.55 stddev:0.00 (0.0%) 12:03:41 INFO - 2016-01-21 12:03:41,043 DEBUG : BROWSER_OUTPUT: Values: 11359.6 12:03:41 INFO - 2016-01-21 12:03:41,043 DEBUG : BROWSER_OUTPUT: 12:03:41 INFO - 2016-01-21 12:03:41,043 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24142.86 Median:24142.86 stddev:0.00 (0.0%) 12:03:41 INFO - 2016-01-21 12:03:41,043 DEBUG : BROWSER_OUTPUT: Values: 24142.9 12:03:41 INFO - 2016-01-21 12:03:41,043 DEBUG : BROWSER_OUTPUT: 12:03:41 INFO - 2016-01-21 12:03:41,043 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:518.40 Median:518.40 stddev:0.00 (0.0%) 12:03:41 INFO - 2016-01-21 12:03:41,043 DEBUG : BROWSER_OUTPUT: Values: 518.4 12:03:41 INFO - 2016-01-21 12:03:41,043 DEBUG : BROWSER_OUTPUT: 12:03:41 INFO - 2016-01-21 12:03:41,043 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 12:03:41 INFO - 2016-01-21 12:03:41,043 DEBUG : BROWSER_OUTPUT: Values: 4840.6 12:03:41 INFO - 2016-01-21 12:03:41,043 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:03:41 INFO - 2016-01-21 12:03:41,044 DEBUG : BROWSER_OUTPUT: 12:03:41 INFO - 2016-01-21 12:03:41,841 INFO : Browser exited with error code: 0 12:03:41 INFO - 2016-01-21 12:03:41,860 INFO : Completed test v8_7 (00:00:39) 12:03:42 INFO - 2016-01-21 12:03:42,086 INFO : Completed test suite (00:20:06) 12:03:42 INFO - 2016-01-21 12:03:42,086 DEBUG : Working with test: dromaeo_css 12:03:42 INFO - 2016-01-21 12:03:42,086 DEBUG : Generating results file: dromaeo_css 12:03:42 INFO - 2016-01-21 12:03:42,086 DEBUG : Working with test: kraken 12:03:42 INFO - 2016-01-21 12:03:42,086 DEBUG : Generating results file: kraken 12:03:42 INFO - 2016-01-21 12:03:42,086 INFO : javascript benchmark 12:03:42 INFO - 2016-01-21 12:03:42,086 DEBUG : Working with test: v8_7 12:03:42 INFO - 2016-01-21 12:03:42,086 DEBUG : Generating results file: v8_7 12:03:42 INFO - 2016-01-21 12:03:42,087 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:03:42 INFO - 2016-01-21 12:03:42,135 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 12:03:42 INFO - 2016-01-21 12:03:42,136 DEBUG : process_Request line: dromaeo_css 7412.29 graph.html#tests=[[72,52,43]] 12:03:42 INFO - 2016-01-21 12:03:42,136 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:03:42 INFO - 2016-01-21 12:03:42,162 DEBUG : process_Request line: kraken 1511.00 graph.html#tests=[[232,52,43]] 12:03:42 INFO - 2016-01-21 12:03:42,163 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:03:42 INFO - 2016-01-21 12:03:42,191 DEBUG : process_Request line: v8_7 23147.04 graph.html#tests=[[230,52,43]] 12:03:42 INFO - 2016-01-21 12:03:42,192 INFO : javascript benchmark 12:03:42 INFO - 2016-01-21 12:03:42,196 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3293.736501079914, 3326.4843949187884, 3331.550240717502, 3337.766356355056, 3350.229447227138, 5558.610897237195, 5562.638428502155, 5568.6658800472, 5575.526080283175, 5592.692401917898, 5574.944250557493, 5667.291588551431, 5679.261695979527, 5679.375268720438, 5716.1711551825065, 5135.460776618466, 5163.148080566721, 5206.0, 5230.163173892178, 5254.395744489394, 5042.722650254234, 5133.948660513403, 5141.691498510083, 5142.66572672777, 5243.2135179723155, 5094.184930411135, 5183.481651834805, 5184.144616138333, 5203.011427828719, 5215.6349055566125, 5181.352330958612, 5207.427183009866, 5249.081410753141, 5258.447862974409, 5283.735813209324, 4947.653664243504, 5000.324956130912, 5000.424951130593, 5153.56194723449, 5169.741512924339, 5358.303420555342, 5407.756650950677, 5413.512783849433, 5431.918521222185, 5474.616776825624, 6085.087236914454, 6111.969440152815, 6139.447449729501, 6145.3547377525165, 6168.537359698041, 5945.643261404286, 6077.058056001327, 6101.755929762804, 6182.165407669952, 6186.0, 5707.1724599933195, 5708.400617935098, 5731.598788084877, 5734.483896449339, 5767.36558978512, 6208.441240288305, 6216.595921265103, 6221.657808820558, 6226.25284965807, 6236.469900058455, 5744.4829965303325, 5902.0, 6022.427869352405, 6029.276486821609, 6133.671320645445, 6150.907736383958, 6162.044883043135, 6181.536384771161, 6189.876202475925, 6204.875902482016, 6087.421694938974, 6156.29202641693, 6165.075238714228, 6175.320714721377, 6185.257769067741, 6002.249718785152, 6002.939970600325, 6117.174181485442, 6128.380904898417, 6132.814448934737, 4681.180793361216, 4683.929741053887, 4684.273937539687, 4713.104510143062, 4715.481297057321, 4036.233115708006, 4180.3102488089735, 4185.22573323936, 4194.182134483807, 4220.198162349144, 5653.9151912721345, 5709.628874123168, 5717.285339332583, 5748.109043098243, 5799.739011744482, 6150.661713605795, 6239.719212635442, 6243.500519958392, 6247.75008999644, 6258.780942666985, 5581.74882130297, 5692.829215123553, 5783.508401785895, 5836.708164591753, 5841.94158058414, 5268.078086334876, 5339.0389729849, 5350.5987050971335, 5353.598480114007, 5376.462353764592, 6242.781502647385, 6282.089097080898, 6310.05349197624, 6326.082718005863, 6335.334789847, 6020.247469066367, 6034.125051867542, 6132.78535251264, 6166.445019948226, 6180.227471566054, 6258.311585725658, 6288.088227207121, 6308.842278943063, 6329.620222786648, 6334.144890439916, 6038.607490513103, 6057.061155520902, 6058.12157237207, 6061.515078793774, 6084.269887613515, 5963.493103086286, 6000.549958753199, 6055.576109672281, 6108.08378743192, 6146.0473626587955, 6037.547183961133, 6082.695865206811, 6086.939130608815, 6090.056041313604, 6098.115773212948, 5986.4013598639785, 6046.425589568984, 6058.394160583906, 6064.090386442069, 6090.056041313604, 5638.915416268841, 5741.13882917549, 5762.193292938908, 5874.353821079592, 5895.263092113486, 5979.611325263844, 6007.549433792396, 6035.728392222272, 6067.393260673897, 6092.543059270483, 5677.744501497526, 5904.0, 5904.704764761659, 5934.851628709144, 5955.940440595712], "unit": "ms", "name": "dojo.html", "value": 5619.304832942304}, {"lowerIsBetter": false, "replicates": [587.3421767620264, 618.7927044440113, 630.9369063093694, 633.3318349141655, 659.567982971154, 41191.58808411915, 41665.3750193747, 41819.581804182024, 41852.58147418525, 42086.78956605217, 45792.0, 46016.30975535361, 46039.76980115103, 46440.76779616105, 46534.767326163324, 8980.640774369034, 9181.127792859701, 9195.126462986005, 9233.6306547738, 9252.306077044215, 8993.865092023625, 9029.322800789934, 9045.547722613843, 9057.773555661128, 9061.909380906205, 9075.455472671661, 9150.54247287633, 9169.40398874071, 9172.403793753418, 9176.311776616747, 9009.819803603892, 9036.77408064797, 9045.773855653595, 9089.363744537884, 9125.68060117896, 8960.731178064669, 9196.0, 9210.401323913991, 9214.216791572724, 9214.585343659484, 42186.0, 42557.36163957543, 42624.57375426268, 42696.35955460671, 42772.57227427748, 3489.371913055674, 3533.2050288685095, 3581.7850928944345, 3664.0107171063664, 4022.597740225954, 32435.837820810746, 32931.176720582174, 33013.17467063318, 33139.0, 33345.166370840925, 3656.634336566349, 3731.9440208396895, 3755.248950209969, 3808.4668146459517, 3820.6561409473, 268799.0, 272729.0, 273111.0, 273784.0, 276024.0, 44308.556914430446, 45189.32216016763, 45288.77355613267, 60948.39051609516, 61498.69250653808, 42386.788066059475, 42866.571334286884, 42889.14221715548, 43055.13889722188, 43130.56869431266, 16808.74786878198, 17034.31862725502, 17034.48896533106, 17070.48788536346, 17090.829091708925, 13365.465381384636, 13462.798058029137, 13485.595432137052, 13503.12229705066, 13509.2569908654, 14879.958402911692, 15138.091714497166, 15189.468368607268, 15225.0, 15225.6193595161, 5958.880822383528, 5980.843313896887, 6078.3617720138745, 6086.573939824169, 6111.236095488064, 1027.6249169053242, 1055.9208059395576, 1129.7345123895877, 1136.4147464056018, 1195.9701007474882, 29683.0, 30142.24644383864, 34003.65996340055, 34065.0, 34277.82861085729, 1061.7683487154864, 1091.0780390569955, 1110.8111621024445, 1127.4869934179928, 1171.1509155862102, 17245.741313880302, 17457.65084698299, 17532.561685957953, 17573.472795816146, 17676.292948282182, 401877.0, 551864.0, 556822.0, 558979.0, 856830.0, 57977.0, 58657.70671146702, 58693.70653146792, 59165.70417147973, 59214.40785592175, 1437.5184313255177, 1446.1395469695515, 1446.4720377062297, 1455.1269238457053, 1460.1822979131932, 30258.092257232318, 30747.84626076945, 30876.382472350877, 31283.374332512765, 31633.841830790698, 49225.50774492209, 49730.751346243036, 49786.75106624444, 49877.75061124671, 49879.25181122214, 329021.0, 331600.0, 332706.0, 332776.0, 333702.0, 33677.831610841786, 33866.153346166546, 34076.31847362989, 34376.656233437345, 34612.65387346094, 44935.32597011113, 45721.77139114283, 46081.76959115317, 46377.072458551316, 46408.76795616, 38530.80734596309, 38839.61160388473, 38971.41542876802, 40204.39693404543, 40398.59601403948, 37672.50206028585, 37970.62029379671, 38096.42855357117, 38229.42655860109, 38532.0, 38452.80773596114, 38478.61521384862, 39119.80440097781, 39134.804325978184, 39258.803705981285, 33477.0, 34817.65182348144, 35100.0, 35250.64749352474, 35632.64367356293, 26234.60648090242, 26672.0, 26773.464530709665, 26867.0, 27026.243728888214], "unit": "ms", "name": "ext.html", "value": 19508.821412992555}, {"lowerIsBetter": false, "replicates": [376.77581838805935, 380.16363999201764, 383.9731218814682, 389.6337442803765, 391.77081407376687, 16038.43865464709, 17353.0, 17985.730214046765, 19139.61720765584, 19190.904045479772, 11815.527378904855, 11966.521339146424, 12076.637700868967, 18503.444896653124, 18747.718784218247, 5181.326427564421, 5303.443138470463, 5310.946890531084, 5548.112302031675, 5814.302283725938, 5415.48552887475, 5580.274564306635, 5605.747741351649, 5615.606907516475, 5653.773849046033, 5516.586256030793, 5520.337559492847, 5581.413951535092, 5611.0741727614895, 5804.216430781833, 5758.9424105759035, 5807.128930660392, 5811.4479124483105, 5823.068309070529, 5824.0390335594575, 5433.483819037185, 5557.41647127054, 5595.524380427669, 5603.159526071081, 5648.774049038034, 13571.389287481989, 13680.179189248676, 13769.0, 13834.584962451041, 14195.148291102567, 2177.7060096886876, 2259.6949411829355, 2321.257197696738, 2327.7206735191717, 2339.5554844579474, 10091.69724908254, 10143.543540540619, 10293.3823970562, 10424.583016679324, 11199.776004479865, 1879.642867855103, 1898.0699457265841, 1919.8560107991957, 1929.68160253558, 1949.9122539485616, 66562.33437665658, 67095.99356009664, 68639.0, 68852.6557367215, 68897.65551172262, 10510.63212787564, 10794.46027698612, 10881.564737410416, 10940.890591093987, 10961.12311015117, 13925.512607058907, 14170.64573385653, 14175.574732758034, 14183.290835458185, 14211.64470888236, 8499.532525711145, 8512.233898949, 8525.01962274334, 8541.572921353907, 8586.055533891267, 8439.746807595782, 8524.06235314115, 8536.975562932488, 8561.10108438605, 8587.48475091484, 4235.830566777356, 4343.587359200871, 4620.1221767864, 4637.350770892078, 4665.370175026328, 1865.048825099182, 1913.2633935934487, 1944.2903340280695, 1944.6791279438735, 1968.6948522978962, 979.9608015679293, 1085.3379438542484, 1099.0490532919139, 1108.772701596171, 1132.0660455124391, 17674.911625442048, 18260.54348641268, 18588.628227435645, 18723.157457914425, 18855.90572047131, 974.025974025974, 981.4307701533094, 1006.7936073104996, 1015.0661391519819, 1016.0499932563077, 10296.536655850505, 10562.630307939186, 10590.099841513404, 10601.734956626146, 10606.893931060591, 589253.0, 595777.0, 613824.0, 635348.0, 642589.0, 85034.57482712547, 85377.14622853816, 85715.0, 86114.56942715247, 86775.0, 1121.2599684208546, 1132.371533798733, 1142.8514293142005, 1148.534843388429, 1150.3902931446346, 13704.45182192741, 14193.503227387406, 14677.192754398611, 16821.579460513585, 16924.0, 37177.6282237185, 37326.813365933, 37520.43719344267, 38149.80925095357, 38507.0, 46750.766246168554, 47489.52510474851, 47770.52229477661, 48768.26847597218, 49362.259566107256, 10452.634157804441, 10541.31481453703, 10625.734356641145, 10649.254552181274, 10777.461126943464, 15042.6991460168, 18023.549411264823, 19014.809851901304, 19146.23415063382, 19375.51561210981, 15561.533154005398, 15607.453739119077, 15826.841731582997, 16037.278322475284, 16049.358025678843, 14571.85428145705, 15481.767773483632, 15870.682586347977, 16010.19949002522, 16209.108499032194, 14919.850801491846, 15055.698886022437, 15357.078575285519, 15538.61153471127, 15806.525804225892, 9928.801423971625, 10016.799664006825, 10052.949735251277, 10071.093601575893, 10089.747756305858, 14711.3379897907, 14858.108513489226, 14907.0, 15108.39566417331, 15453.61365965815], "unit": "ms", "name": "jquery.html", "value": 9347.349663239667}, {"lowerIsBetter": false, "replicates": [1474.4839306242816, 1494.006485687018, 1647.2587335698938, 1771.3446024970758, 1828.8445482134014, 8164.224398682123, 8393.580320983949, 8415.789605259872, 8426.620802063906, 8558.400911936167, 8364.665413383473, 8368.121347258542, 8409.78975525612, 8418.32653387729, 8448.197421244971, 2369.5971684813535, 2406.42245860993, 2406.68713067301, 2408.205292253561, 2408.5664580375524, 2344.3670209043635, 2374.0385144016614, 2375.8455700379504, 2380.6310021946624, 2390.1156572068357, 2278.6809846621486, 2332.941676458085, 2342.3441436397834, 2381.452265978826, 2404.4469771952463, 2358.587247231736, 2369.644553316999, 2383.690120284369, 2386.3676125826755, 2387.319613910036, 2317.3974766560814, 2342.4143964009, 2348.7768661977257, 2355.1756885090253, 2355.2698663414394, 8306.252437280613, 8397.076321604618, 8414.915850841475, 8422.368322375785, 8439.409241353107, 5048.469910659402, 5096.51583099605, 5098.6176036797015, 5098.796048158107, 5142.04872098663, 3098.209956461088, 3158.392906070183, 3218.2758879251983, 3245.96754032459, 3253.430649636304, 946.6260826973376, 954.2652157838495, 966.3187452845727, 981.8379967305386, 1017.0541396501251, 11550.826737598944, 11618.59334923282, 11629.418529073597, 11632.418379081013, 11666.358350290731, 4325.4593175853015, 4355.368471571668, 4356.738595684269, 4378.715383500063, 4393.7363758174615, 9350.485723285285, 9377.1091746284, 9384.0, 9429.57566909477, 9436.0, 4765.332853400527, 4832.710037397767, 4849.199882019428, 4852.636052296092, 4862.80548778052, 4405.31717583775, 4430.712003719812, 4441.400410944546, 4453.22068637987, 4494.696538004007, 3603.171270607775, 3641.6540428659237, 3647.6170002149925, 3718.442233664972, 3722.40441529354, 1091.1979694924225, 1093.956241750337, 1100.7743412600398, 1120.675004248775, 1128.7121783945042, 1113.9832902506469, 1120.815065514181, 1149.844770955927, 1337.197681391177, 1406.2617126008927, 7517.548947063085, 7542.886856697154, 7631.3894888408795, 7678.884816727754, 7681.116671582728, 1129.4860838318546, 1148.8334191542347, 1150.677810213125, 1157.4733496259182, 1173.524722487377, 6318.052292156213, 6351.301356850743, 6365.586236894587, 6388.105665206875, 6399.968000159969, 9707.66023189185, 9834.606615735434, 9885.654002109892, 10038.598456061676, 10065.144462720751, 9617.51912404377, 9836.803263934824, 9889.60441582343, 9896.208303335716, 9949.850752238723, 7938.880916786253, 7992.800179995546, 7998.040235171817, 8006.599670016476, 8023.719169829028, 7890.132085470708, 7922.128565857636, 7972.402069844668, 7982.521048737094, 8000.279974802295, 8778.122187781171, 9062.048484909254, 9068.501232432016, 9070.410423322463, 9132.452052876582, 9226.907730922605, 9235.953820230856, 9329.440233586007, 9359.15767580921, 9506.667266645634, 7467.58928258951, 7538.849223015619, 7632.80917977055, 7639.732609358646, 7668.233176682287, 7582.574344343298, 8087.393445491494, 8138.389620778347, 8159.46963447374, 8207.261346478846, 7110.822229444098, 7438.256174382518, 7476.401887849068, 7483.625818709152, 7710.460267781202, 7316.926830731624, 7458.254174582498, 7529.774106776806, 7543.321101100927, 7671.232876712284, 7654.119776225582, 7665.923340766521, 7673.309402153833, 7678.040244969379, 7690.0, 6643.368879956396, 6886.035954966409, 6987.301269872972, 7011.0, 7017.0, 7072.186698529735, 7095.751648692478, 7098.858022839618, 7109.928900710926, 7157.105361829771], "unit": "ms", "name": "mootools.html", "value": 4743.671949020991}, {"lowerIsBetter": false, "replicates": [353.5509902423922, 356.4813196798658, 359.6475454055026, 361.2576155999421, 362.8711807308407, 6304.495640348767, 6314.55798094133, 6328.430441260291, 6382.872342553146, 6473.4173924346915, 6353.459955903742, 6376.139221205136, 6379.521535884804, 6382.521310901678, 6394.360563943604, 4866.294387313837, 4872.488388719186, 4873.415190177184, 4874.512548745124, 4877.3903262092235, 4874.805007799684, 4882.218844984804, 4885.242787367946, 4887.853364399056, 4891.315215869763, 4640.79116439761, 4703.694259873115, 4787.54518320759, 4788.97605511972, 4797.568218860302, 4751.786169622375, 4764.023375208074, 4774.570288674018, 4786.186348320759, 4808.206645903421, 4185.204811085884, 4185.455890734185, 4192.413062171298, 4192.706510544263, 4192.895177620553, 5994.730237139339, 5995.250593675791, 5999.580029397944, 6004.729787159588, 6006.5495087868585, 5492.642978206404, 5550.389457159709, 5569.443055694439, 5574.554035677136, 5579.302587176603, 6605.141331626905, 6660.067590537328, 6694.230163531208, 6694.83262918426, 6701.731930722765, 4577.130345234395, 4586.678932474728, 4587.472440669332, 4601.907961840778, 4614.261718125117, 6835.179778426621, 6950.652467376611, 6988.301169882971, 7011.439084873198, 7018.473614478883, 4725.220338644154, 4726.527347265246, 4726.527347265246, 4732.100900828831, 4747.643926705511, 4774.641901857374, 4777.904441911142, 4789.0, 4790.94599188178, 4791.9936813268905, 5539.695316757537, 5546.168074788814, 5569.470900264469, 5569.721513924369, 5580.665160090408, 6653.600783952978, 6772.424343930723, 6782.626955517395, 6783.830404239933, 6797.388235058868, 1681.5880109373281, 1689.9408520701963, 1691.2135856826635, 1693.9745903811452, 1694.1105919392417, 1123.9438028098562, 1132.0660455124555, 1132.3715337987496, 1141.8458508101467, 1148.454484120053, 6488.156539649815, 6520.347965203537, 6520.804375868732, 6525.086487891699, 6535.411812936763, 6960.65196740161, 6977.720891164398, 6980.581165130108, 6994.230634630187, 7006.544574602634, 6212.565120441525, 6242.843928901813, 6457.935420645827, 6497.610143391317, 6526.34736526353, 3768.679662228741, 3782.9432558511644, 3784.110733977513, 3800.5819359870393, 3801.7718936863876, 7264.891026634605, 7281.381082607932, 7295.051643286339, 7301.963490182515, 7303.853922921512, 7120.9643951780945, 7209.89185162223, 7244.855102898018, 7293.197748247689, 7300.853982920312, 7262.419006479575, 7290.927090729131, 7299.70801167958, 7305.4886157969495, 7325.084364454443, 7009.369156775914, 7013.2986701329455, 7033.050538177486, 7052.153741551047, 7058.941158826217, 6775.288594697683, 7007.6846541904715, 7012.298770122947, 7015.123109611299, 7021.5787052777, 7280.417566594554, 7307.0, 7307.378872795659, 7309.122905251404, 7323.340899319087, 4769.475357710579, 4794.832180873653, 4805.255185446262, 4806.062817750505, 4814.325994360863, 6854.897176542256, 7014.333638304353, 7021.578705277495, 7048.436125110082, 7049.6122713249215, 6768.0863083485065, 6849.691763870538, 6855.657217139223, 6862.9313706862295, 6875.4155896749335, 6711.429528490133, 6790.743712413219, 6828.9658551706925, 6839.829004274734, 6847.281035491202, 6711.46308295345, 6714.563553369016, 6717.261101278757, 6722.361375669304, 6726.428253598499, 6818.079559259437, 6835.453163746789, 6835.93164068353, 6852.177738671192, 6872.0, 6502.772402965874, 6654.101696270942, 6704.4636429084585, 6704.7988560343265, 6707.832304192434], "unit": "ms", "name": "prototype.html", "value": 5090.544183700072}, {"lowerIsBetter": false, "replicates": [904.8597467392557, 923.6490133749179, 929.0941332201103, 945.0407836046412, 950.7052813627776, 13094.869051309495, 13369.598912032654, 13378.531751388715, 13380.531681391154, 13383.197008179515, 12461.813072803916, 12536.247825130498, 12548.1216314858, 12569.434375453104, 12575.496980120806, 878.2052242720316, 881.5063564403938, 895.5343221524803, 896.7130518234168, 897.4974014551839, 906.3927168796889, 909.849874770662, 911.5305617606938, 914.1315750037458, 917.6696389299847, 942.740746294771, 947.0482165423739, 951.4957072751419, 951.7430293820664, 954.88063992001, 935.3031991166556, 937.0254934867729, 940.1867384712243, 941.8445956417183, 945.413843417079, 684.4968947823346, 685.4721864164566, 689.8758223519765, 695.8851789454734, 700.7722490190708, 13397.464101435931, 13434.86565134346, 13467.461301547926, 13496.662583435394, 13506.32468376587, 12034.21777584463, 12159.088068394905, 12324.383780810924, 12453.626391208278, 12791.48834046637, 10960.506777195045, 11042.889571104266, 11076.39079850608, 11114.499847506882, 11159.107271418348, 3715.16408808016, 3728.0, 3748.3253014457387, 3752.137008488063, 3783.5838057813617, 50075.24887126696, 50154.498455015346, 50230.0, 50444.24333634999, 50639.49360506421, 9622.566984485715, 10012.299139060196, 10802.415533248273, 10934.289271197506, 11262.267952583219, 19370.903145484182, 19428.708569371473, 19439.514012149808, 19481.90259048724, 19487.415377538695, 7626.275503827128, 7781.766547003599, 7787.805304867424, 7825.178356272623, 7974.282314591715, 4289.592488713567, 4302.118065796567, 4303.33298338758, 4336.891577710582, 4345.891352716208, 3511.2099777550357, 3522.682958533693, 3549.1304630365726, 3555.591107022674, 3562.8931132066077, 635.885540602696, 639.2967735490922, 647.4852492268658, 649.4933951517824, 654.6628486329544, 581.7120525339984, 583.1835430397392, 648.3095503288982, 684.5071548485083, 696.7665831946355, 8175.918240817516, 8527.573621318908, 9480.146786789222, 10148.746281342877, 10544.209184311054, 477.7849967514632, 583.486531851976, 620.5376994139395, 660.1451120798481, 695.8156088636515, 4107.199096176217, 4220.0, 4667.323238130452, 4681.976590117096, 4737.8341758038305, 57957.710211449514, 59896.70051649714, 60896.69551652302, 61192.38807611956, 61727.0, 50195.0, 50286.24570631443, 51894.74052629788, 53782.0, 53800.46199537955, 48928.7553562237, 49669.50330496721, 49782.253266201034, 50111.49888501141, 50594.49405505972, 9002.549872506479, 9325.0, 9749.0, 10260.384376937407, 10426.739331516772, 37538.81230593829, 37596.436053458674, 37836.0, 38857.417138743505, 39121.021974450865, 46918.29622555596, 47607.0, 47632.7618361906, 48179.75910120427, 49902.00587964734, 11407.657770266906, 11571.305721656727, 11586.420678966186, 11685.707857303636, 12226.510939562319, 13267.86960422682, 13405.396757146147, 13613.931930340284, 13678.384472698554, 13726.519571814939, 12102.576409825613, 12334.568290109803, 12543.749125017632, 12758.48966041348, 12797.42411591462, 10684.465776710978, 10797.784044319227, 10962.287451315638, 10985.83521247166, 11178.944105279421, 12267.141300108906, 12284.508619655113, 12370.0, 12462.252264864137, 12833.743325133632, 9521.38111022809, 10035.749106272402, 10188.796224075626, 10250.333728307636, 10377.688669339932, 9922.056666101045, 10449.477526123512, 10473.738156545842, 10582.417967011581, 10761.515731791931], "unit": "ms", "name": "yui.html", "value": 6701.907333540387}], "name": "dromaeo_css", "value": 7412.293125617428}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 110.0, 111.0, 112.0, 121.0, 109.0, 110.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [147.0, 129.0, 158.0, 165.0, 122.0, 153.0, 154.0, 126.0, 165.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.4}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 163.0, 163.0, 164.0, 167.0, 161.0, 161.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 75.0, 163.0, 71.0, 74.0, 73.0, 74.0, 155.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 90.4}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 137.0, 93.0, 92.0, 94.0, 131.0, 92.0, 93.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 111.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [151.0, 149.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0, 150.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [101.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [59.0, 62.0, 63.0, 61.0, 60.0, 61.0, 61.0, 63.0, 60.0, 62.0], "unit": "ms", "name": "json-parse-financial", "value": 61.2}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 66.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.3}, {"lowerIsBetter": true, "replicates": [88.0, 89.0, 83.0, 83.0, 82.0, 89.0, 83.0, 84.0, 82.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [121.0, 127.0, 111.0, 122.0, 122.0, 119.0, 118.0, 123.0, 113.0, 112.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.8}, {"lowerIsBetter": true, "replicates": [138.0, 144.0, 147.0, 152.0, 144.0, 133.0, 149.0, 145.0, 155.0, 144.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.1}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 69.0, 69.0, 69.0, 69.0, 67.0, 67.0, 73.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1511.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.28925619834712], "unit": "score", "name": "Richards", "value": 213.5771000000001}, {"lowerIsBetter": false, "replicates": [166.77785190126752], "unit": "score", "name": "DeltaBlue", "value": 396.44352799999996}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [919.1176470588235], "unit": "score", "name": "RayTrace", "value": 805.1080320000001}, {"lowerIsBetter": false, "replicates": [551.2679162072767], "unit": "score", "name": "Earley", "value": 1208.9638819999998}, {"lowerIsBetter": false, "replicates": [11359.550561797752], "unit": "score", "name": "Boyer", "value": 58.669838773491605}, {"lowerIsBetter": false, "replicates": [24142.85714285714], "unit": "score", "name": "RegExp", "value": 37.73310650887576}, {"lowerIsBetter": false, "replicates": [518.4033177812338], "unit": "score", "name": "Splay", "value": 157.19613900000004}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 23147.03655987159}]} 12:03:42 INFO - RETURN: dromaeo_css: 7412.29 12:03:42 INFO - RETURN: kraken: 1511.00 12:03:42 INFO - RETURN: v8_7: 23147.04 12:03:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23147.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1511.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7412.29"}}} 12:03:42 INFO - Return code: 0 12:03:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 12:03:42 INFO - # TBPL SUCCESS # 12:03:42 INFO - Running post-action listener: _resource_record_post_action 12:03:42 INFO - Running post-run listener: _resource_record_post_run 12:03:43 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 266240; Write bytes: 511913984; Read time: 180; Write time: 444232 12:03:43 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 247484416; Read time: 0; Write time: 318924 12:03:43 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 266240; Write bytes: 264429568; Read time: 180; Write time: 125308 12:03:43 INFO - Running post-run listener: _upload_blobber_files 12:03:43 INFO - Blob upload gear active. 12:03:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:03:43 INFO - Copying logs to upload dir... 12:03:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.264385 ========= master_lag: 8.62 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-21 12:03:50.764378) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-21 12:03:50.768088) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009991 build_url: 'https://queue.taskcluster.net/v1/task/rfUKFcihSJWtFGH3-h3Q_w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-21 12:03:50.796073) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-01-21 12:03:50.796384) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453404110.98014-113740438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 1.58 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-01-21 12:03:52.384067) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 12:03:52.384384) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 12:03:52.385020) ========= ========= Total master_lag: 10.40 =========