builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1453403261.28 results: success (0) buildid: 20160121083822 builduid: b9c400e214f54a5f83c330a60471df34 revision: 8d81327764e1cf434e2847ed4b92117db5d43842 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 11:07:41.282064) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 11:07:41.282857) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 11:07:41.283210) ========= 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=eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005735 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 11:07:41.306415) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 11:07:41.306736) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 11:07:41.320862) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:07:41.321286) ========= 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=eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:07:41.372891) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 11:07:41.373255) ========= 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:07:41.373715) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:07:41.374037) ========= 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=eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 11:07:41-- 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% 96.5M=0s 2016-01-21 11:07:41 (96.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158989 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:07:41.547870) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:07:41.548659) ========= 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=eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014221 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:07:41.600608) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:07:41.600999) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8d81327764e1cf434e2847ed4b92117db5d43842 --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 8d81327764e1cf434e2847ed4b92117db5d43842 --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=eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 11:07:41,883 truncating revision to first 12 chars 2016-01-21 11:07:41,883 Setting DEBUG logging. 2016-01-21 11:07:41,883 attempt 1/10 2016-01-21 11:07:41,883 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8d81327764e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 11:07:42,260 unpacking tar archive at: mozilla-aurora-8d81327764e1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644788 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:07:42.259612) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 11:07:42.260166) ========= echo 8d81327764e1cf434e2847ed4b92117db5d43842 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8d81327764e1cf434e2847ed4b92117db5d43842'] 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=eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8d81327764e1cf434e2847ed4b92117db5d43842 program finished with exit code 0 elapsedTime=0.003793 script_repo_revision: '8d81327764e1cf434e2847ed4b92117db5d43842' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 11:07:42.309990) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 11:07:42.310412) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 11:07:42.321072) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-01-21 11:07:42.321556) ========= /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=eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:07:42 INFO - MultiFileLogger online at 20160121 11:07:42 in /builds/slave/test-pgo 11:07:42 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:07:42 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:07:42 INFO - {'append_to_log': False, 11:07:42 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:07:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:07:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:07:42 INFO - 'branch': 'Mozilla-Aurora', 11:07:42 INFO - 'buildbot_json_path': 'buildprops.json', 11:07:42 INFO - 'config_files': ('talos/linux_config.py',), 11:07:42 INFO - 'default_actions': ('clobber', 11:07:42 INFO - 'read-buildbot-config', 11:07:42 INFO - 'download-and-extract', 11:07:42 INFO - 'populate-webroot', 11:07:42 INFO - 'create-virtualenv', 11:07:42 INFO - 'install', 11:07:42 INFO - 'run-tests'), 11:07:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:07:42 INFO - 'download_minidump_stackwalk': True, 11:07:42 INFO - 'download_symbols': 'ondemand', 11:07:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:07:42 INFO - 'tooltool.py': '/tools/tooltool.py', 11:07:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:07:42 INFO - '/tools/misc-python/virtualenv.py')}, 11:07:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:07:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:07:42 INFO - 'installer_path': 'installer.exe', 11:07:42 INFO - 'log_level': 'info', 11:07:42 INFO - 'log_name': 'talos', 11:07:42 INFO - 'log_to_console': True, 11:07:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:07:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:07:42 INFO - 'opt_config_files': (), 11:07:42 INFO - 'pip_index': False, 11:07:42 INFO - 'sps_profile': False, 11:07:42 INFO - 'sps_profile_interval': 0, 11:07:42 INFO - 'suite': 'dromaeojs-e10s', 11:07:42 INFO - 'system_bits': '32', 11:07:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:07:42 INFO - 'title': 'talos-linux64-ix-010', 11:07:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:07:42 INFO - 'use_talos_json': True, 11:07:42 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:07:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:07:42 INFO - 'work_dir': 'build'} 11:07:42 INFO - ##### 11:07:42 INFO - ##### Running clobber step. 11:07:42 INFO - ##### 11:07:42 INFO - Running pre-action listener: _resource_record_pre_action 11:07:42 INFO - Running main action method: clobber 11:07:42 INFO - rmtree: /builds/slave/test-pgo/build 11:07:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:07:43 INFO - Running post-action listener: _resource_record_post_action 11:07:43 INFO - ##### 11:07:43 INFO - ##### Running read-buildbot-config step. 11:07:43 INFO - ##### 11:07:43 INFO - Running pre-action listener: _resource_record_pre_action 11:07:43 INFO - Running main action method: read_buildbot_config 11:07:43 INFO - Using buildbot properties: 11:07:43 INFO - { 11:07:43 INFO - "properties": { 11:07:43 INFO - "buildnumber": 97, 11:07:43 INFO - "product": "firefox", 11:07:43 INFO - "script_repo_revision": "production", 11:07:43 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:07:43 INFO - "repository": "", 11:07:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:07:43 INFO - "buildid": "20160121083822", 11:07:43 INFO - "slavename": "talos-linux64-ix-010", 11:07:43 INFO - "pgo_build": "True", 11:07:43 INFO - "basedir": "/builds/slave/test-pgo", 11:07:43 INFO - "project": "", 11:07:43 INFO - "platform": "ubuntu64_hw", 11:07:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:07:43 INFO - "slavebuilddir": "test", 11:07:43 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:07:43 INFO - "branch": "mozilla-aurora", 11:07:43 INFO - "repo_path": "releases/mozilla-aurora", 11:07:43 INFO - "stage_platform": "linux64-pgo", 11:07:43 INFO - "builduid": "b9c400e214f54a5f83c330a60471df34", 11:07:43 INFO - "revision": "8d81327764e1cf434e2847ed4b92117db5d43842" 11:07:43 INFO - }, 11:07:43 INFO - "sourcestamp": { 11:07:43 INFO - "repository": "", 11:07:43 INFO - "hasPatch": false, 11:07:43 INFO - "project": "", 11:07:43 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:07:43 INFO - "changes": [ 11:07:43 INFO - { 11:07:43 INFO - "category": null, 11:07:43 INFO - "files": [ 11:07:43 INFO - { 11:07:43 INFO - "url": null, 11:07:43 INFO - "name": "https://queue.taskcluster.net/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 11:07:43 INFO - } 11:07:43 INFO - ], 11:07:43 INFO - "repository": "", 11:07:43 INFO - "rev": "8d81327764e1cf434e2847ed4b92117db5d43842", 11:07:43 INFO - "who": "mconley@mozilla.com", 11:07:43 INFO - "when": 1453403174, 11:07:43 INFO - "number": 7494749, 11:07:43 INFO - "comments": "Bug 1233803 - Add sessionHistory shim for gBrowser and remote browsers. r=krizsa, a=sylvestre", 11:07:43 INFO - "project": "", 11:07:43 INFO - "at": "Thu 21 Jan 2016 11:06:14", 11:07:43 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:07:43 INFO - "revlink": "", 11:07:43 INFO - "properties": [ 11:07:43 INFO - [ 11:07:43 INFO - "buildid", 11:07:43 INFO - "20160121083822", 11:07:43 INFO - "Change" 11:07:43 INFO - ], 11:07:43 INFO - [ 11:07:43 INFO - "builduid", 11:07:43 INFO - "b9c400e214f54a5f83c330a60471df34", 11:07:43 INFO - "Change" 11:07:43 INFO - ], 11:07:43 INFO - [ 11:07:43 INFO - "pgo_build", 11:07:43 INFO - "True", 11:07:43 INFO - "Change" 11:07:43 INFO - ] 11:07:43 INFO - ], 11:07:43 INFO - "revision": "8d81327764e1cf434e2847ed4b92117db5d43842" 11:07:43 INFO - } 11:07:43 INFO - ], 11:07:43 INFO - "revision": "8d81327764e1cf434e2847ed4b92117db5d43842" 11:07:43 INFO - } 11:07:43 INFO - } 11:07:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 11:07:43 INFO - Running post-action listener: _resource_record_post_action 11:07:43 INFO - ##### 11:07:43 INFO - ##### Running download-and-extract step. 11:07:43 INFO - ##### 11:07:43 INFO - Running pre-action listener: _resource_record_pre_action 11:07:43 INFO - Running main action method: download_and_extract 11:07:43 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:43 INFO - https://queue.taskcluster.net/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:07:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/test_packages.json 11:07:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/test_packages.json 11:07:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:07:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:07:43 INFO - Downloaded 1302 bytes. 11:07:43 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:07:43 INFO - Using the following test package requirements: 11:07:43 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:07:43 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:43 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:07:43 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:43 INFO - u'jsshell-linux-x86_64.zip'], 11:07:43 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:43 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:07:43 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:07:43 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:43 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:07:43 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:43 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:07:43 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:43 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:07:43 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:07:43 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:07:43 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:07:43 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:43 INFO - https://queue.taskcluster.net/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:07:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:07:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:07:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/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:07:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/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:07:44 INFO - Downloaded 23159148 bytes. 11:07:44 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:07:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:07:44 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:07:46 INFO - Return code: 0 11:07:46 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:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:46 INFO - https://queue.taskcluster.net/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:07:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:07:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:07:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/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:07:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/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:07:48 INFO - Downloaded 23159148 bytes. 11:07: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:07:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:07: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:07:49 INFO - Return code: 0 11:07: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:07:49 INFO - https://queue.taskcluster.net/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:07:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:07:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:07:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/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:07:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/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:07:50 INFO - Downloaded 11132038 bytes. 11:07:50 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:07:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:07:50 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:07:50 INFO - Return code: 0 11:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:50 INFO - https://queue.taskcluster.net/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:07:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:07:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:07:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/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:07:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sBIPRMg6RXqj3KEOyYOEFg/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:07:53 INFO - Downloaded 58120779 bytes. 11:07:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:07:53 INFO - mkdir: /builds/slave/test-pgo/properties 11:07:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:07:53 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:07:53 INFO - Contents: 11:07:53 INFO - build_url:https://queue.taskcluster.net/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:07:53 INFO - Running post-action listener: _resource_record_post_action 11:07:53 INFO - Running post-action listener: set_extra_try_arguments 11:07:53 INFO - ##### 11:07:53 INFO - ##### Running populate-webroot step. 11:07:53 INFO - ##### 11:07:53 INFO - Running pre-action listener: _resource_record_pre_action 11:07:53 INFO - Running main action method: populate_webroot 11:07:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:07:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:07:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:07:53 INFO - '--tppagecycles', 11:07:53 INFO - '7'], 11:07:53 INFO - 'tests': ['tsvgm']}}, 11:07:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:07:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:07:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:07:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:07:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:07:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:07:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:53 INFO - 'talos_options': ['--e10s'], 11:07:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:53 INFO - 'tests': ['damp', 'tps']}, 11:07:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:53 INFO - 'talos_options': ['--e10s'], 11:07:53 INFO - 'tests': ['damp', 'tps']}, 11:07:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:07:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:07:53 INFO - 'other': {'tests': ['a11yr', 11:07:53 INFO - 'ts_paint', 11:07:53 INFO - 'tpaint', 11:07:53 INFO - 'sessionrestore', 11:07:53 INFO - 'sessionrestore_no_auto_restore']}, 11:07:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:07:53 INFO - 'tests': ['a11yr', 11:07:53 INFO - 'ts_paint', 11:07:53 INFO - 'tpaint', 11:07:53 INFO - 'sessionrestore', 11:07:53 INFO - 'sessionrestore_no_auto_restore']}, 11:07:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:07:53 INFO - 'tests': ['a11yr', 11:07:53 INFO - 'ts_paint', 11:07:53 INFO - 'tpaint', 11:07:53 INFO - 'sessionrestore', 11:07:53 INFO - 'sessionrestore_no_auto_restore']}, 11:07:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:07:53 INFO - 'tests': ['a11yr', 11:07:53 INFO - 'ts_paint', 11:07:53 INFO - 'tpaint', 11:07:53 INFO - 'sessionrestore', 11:07:53 INFO - 'sessionrestore_no_auto_restore']}, 11:07:53 INFO - 'other_l64': {'tests': ['a11yr', 11:07:53 INFO - 'ts_paint', 11:07:53 INFO - 'tpaint', 11:07:53 INFO - 'sessionrestore', 11:07:53 INFO - 'sessionrestore_no_auto_restore']}, 11:07:53 INFO - 'other_nol64': {'tests': ['a11yr', 11:07:53 INFO - 'ts_paint', 11:07:53 INFO - 'tpaint', 11:07:53 INFO - 'sessionrestore', 11:07:53 INFO - 'sessionrestore_no_auto_restore']}, 11:07:53 INFO - 'svgr': {'tests': ['tsvgx', 11:07:53 INFO - 'tsvgr_opacity', 11:07:53 INFO - 'tart', 11:07:53 INFO - 'tscrollx', 11:07:53 INFO - 'cart']}, 11:07:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:07:53 INFO - 'tests': ['tsvgx', 11:07:53 INFO - 'tsvgr_opacity', 11:07:53 INFO - 'tart', 11:07:53 INFO - 'tscrollx', 11:07:53 INFO - 'cart']}, 11:07:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:53 INFO - 'tests': ['tp5o']}, 11:07:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:53 INFO - 'talos_options': ['--e10s'], 11:07:53 INFO - 'tests': ['tp5o']}, 11:07:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:53 INFO - 'talos_options': ['--xperf_path', 11:07:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:53 INFO - 'tests': ['tp5n']}, 11:07:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:53 INFO - 'talos_options': ['--e10s', 11:07:53 INFO - '--xperf_path', 11:07:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:53 INFO - 'tests': ['tp5n']}}, 11:07:53 INFO - 'talos.zip': {'path': '', 11:07:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:07:53 INFO - Running post-action listener: _resource_record_post_action 11:07:53 INFO - ##### 11:07:53 INFO - ##### Running create-virtualenv step. 11:07:53 INFO - ##### 11:07:53 INFO - Running pre-action listener: _resource_record_pre_action 11:07:53 INFO - Running main action method: create_virtualenv 11:07:53 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:07:53 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:07:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:07:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:07:53 INFO - Using real prefix '/usr' 11:07:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:07:53 INFO - Installing distribute.............................................................................................................................................................................................done. 11:07:55 INFO - Installing pip.................done. 11:07:55 INFO - Return code: 0 11:07:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59c0948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1405450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1497a50>, '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 0x1403550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14039e0>, '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': 'eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776', '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:07:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 11:07:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:07:55 INFO - Using env: {'DISPLAY': ':0', 11:07:55 INFO - 'HOME': '/home/cltbld', 11:07:55 INFO - 'LANG': 'en_US.UTF-8', 11:07:55 INFO - 'LANGUAGE': 'en_US:en', 11:07:55 INFO - 'LOGNAME': 'cltbld', 11:07:55 INFO - 'MAIL': '/var/mail/cltbld', 11:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:55 INFO - 'MOZ_NO_REMOTE': '1', 11:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:55 INFO - 'NO_EM_RESTART': '1', 11:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:07:55 INFO - 'PWD': '/builds/slave/test-pgo', 11:07:55 INFO - 'SHELL': '/bin/bash', 11:07:55 INFO - 'SHLVL': '1', 11:07:55 INFO - 'TERM': 'linux', 11:07:55 INFO - 'TMOUT': '86400', 11:07:55 INFO - 'USER': 'cltbld', 11:07:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776', 11:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:55 INFO - '_': '/tools/buildbot/bin/python'} 11:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:56 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:07:56 INFO - Cleaning up... 11:07:56 INFO - Return code: 0 11:07:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f59c0948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1405450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1497a50>, '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 0x1403550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14039e0>, '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': 'eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776', '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:07:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 11:07:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:07:56 INFO - Using env: {'DISPLAY': ':0', 11:07:56 INFO - 'HOME': '/home/cltbld', 11:07:56 INFO - 'LANG': 'en_US.UTF-8', 11:07:56 INFO - 'LANGUAGE': 'en_US:en', 11:07:56 INFO - 'LOGNAME': 'cltbld', 11:07:56 INFO - 'MAIL': '/var/mail/cltbld', 11:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:56 INFO - 'MOZ_NO_REMOTE': '1', 11:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:56 INFO - 'NO_EM_RESTART': '1', 11:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:07:56 INFO - 'PWD': '/builds/slave/test-pgo', 11:07:56 INFO - 'SHELL': '/bin/bash', 11:07:56 INFO - 'SHLVL': '1', 11:07:56 INFO - 'TERM': 'linux', 11:07:56 INFO - 'TMOUT': '86400', 11:07:56 INFO - 'USER': 'cltbld', 11:07:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776', 11:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:56 INFO - '_': '/tools/buildbot/bin/python'} 11:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:56 INFO - Downloading/unpacking psutil>=0.7.1 11:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:07:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:58 INFO - Installing collected packages: psutil 11:07:58 INFO - Running setup.py install for psutil 11:07:58 INFO - building 'psutil._psutil_linux' extension 11:07:58 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:07:58 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:07:58 INFO - building 'psutil._psutil_posix' extension 11:07:58 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:07:58 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:07:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:58 INFO - Successfully installed psutil 11:07:58 INFO - Cleaning up... 11:07:58 INFO - Return code: 0 11:07:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:07: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:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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', '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 0x7f59c0948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1405450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1497a50>, '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 0x1403550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14039e0>, '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': 'eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776', '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:07: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 11:07: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 mozsystemmonitor==0.0.0 11:07:58 INFO - Using env: {'DISPLAY': ':0', 11:07:58 INFO - 'HOME': '/home/cltbld', 11:07:58 INFO - 'LANG': 'en_US.UTF-8', 11:07:58 INFO - 'LANGUAGE': 'en_US:en', 11:07:58 INFO - 'LOGNAME': 'cltbld', 11:07:58 INFO - 'MAIL': '/var/mail/cltbld', 11:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:58 INFO - 'MOZ_NO_REMOTE': '1', 11:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:58 INFO - 'NO_EM_RESTART': '1', 11:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:07:58 INFO - 'PWD': '/builds/slave/test-pgo', 11:07:58 INFO - 'SHELL': '/bin/bash', 11:07:58 INFO - 'SHLVL': '1', 11:07:58 INFO - 'TERM': 'linux', 11:07:58 INFO - 'TMOUT': '86400', 11:07:58 INFO - 'USER': 'cltbld', 11:07:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776', 11:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:58 INFO - '_': '/tools/buildbot/bin/python'} 11:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:07: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:07: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:07: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:07: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:07: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:07: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:08:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:08:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:08:00 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:08:00 INFO - Installing collected packages: mozsystemmonitor 11:08:00 INFO - Running setup.py install for mozsystemmonitor 11:08:00 INFO - Successfully installed mozsystemmonitor 11:08:00 INFO - Cleaning up... 11:08:00 INFO - Return code: 0 11:08:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:08: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:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08: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:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08: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', '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 0x7f59c0948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1405450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1497a50>, '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 0x1403550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14039e0>, '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': 'eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776', '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:08: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 11:08: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 blobuploader==1.2.4 11:08:00 INFO - Using env: {'DISPLAY': ':0', 11:08:00 INFO - 'HOME': '/home/cltbld', 11:08:00 INFO - 'LANG': 'en_US.UTF-8', 11:08:00 INFO - 'LANGUAGE': 'en_US:en', 11:08:00 INFO - 'LOGNAME': 'cltbld', 11:08:00 INFO - 'MAIL': '/var/mail/cltbld', 11:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:00 INFO - 'MOZ_NO_REMOTE': '1', 11:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:00 INFO - 'NO_EM_RESTART': '1', 11:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:08:00 INFO - 'PWD': '/builds/slave/test-pgo', 11:08:00 INFO - 'SHELL': '/bin/bash', 11:08:00 INFO - 'SHLVL': '1', 11:08:00 INFO - 'TERM': 'linux', 11:08:00 INFO - 'TMOUT': '86400', 11:08:00 INFO - 'USER': 'cltbld', 11:08:00 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776', 11:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:00 INFO - '_': '/tools/buildbot/bin/python'} 11:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:01 INFO - Downloading/unpacking blobuploader==1.2.4 11:08: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:08: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:08: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:08: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:08: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:08: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:08:02 INFO - Downloading blobuploader-1.2.4.tar.gz 11:08:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:08:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:08: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:08: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:08: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:08: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:08: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:08: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:08:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:08:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:08: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:08: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:08: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:08: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:08: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:08: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:08:03 INFO - Downloading docopt-0.6.1.tar.gz 11:08:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:08:03 INFO - Installing collected packages: blobuploader, requests, docopt 11:08:03 INFO - Running setup.py install for blobuploader 11:08:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:08:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:08:03 INFO - Running setup.py install for requests 11:08:04 INFO - Running setup.py install for docopt 11:08:04 INFO - Successfully installed blobuploader requests docopt 11:08:04 INFO - Cleaning up... 11:08:04 INFO - Return code: 0 11:08:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:04 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 0x7f59c0948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1405450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1497a50>, '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 0x1403550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14039e0>, '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': 'eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776', '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:08:04 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:08:04 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:08:04 INFO - Using env: {'DISPLAY': ':0', 11:08:04 INFO - 'HOME': '/home/cltbld', 11:08:04 INFO - 'LANG': 'en_US.UTF-8', 11:08:04 INFO - 'LANGUAGE': 'en_US:en', 11:08:04 INFO - 'LOGNAME': 'cltbld', 11:08:04 INFO - 'MAIL': '/var/mail/cltbld', 11:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:04 INFO - 'MOZ_NO_REMOTE': '1', 11:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:04 INFO - 'NO_EM_RESTART': '1', 11:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:08:04 INFO - 'PWD': '/builds/slave/test-pgo', 11:08:04 INFO - 'SHELL': '/bin/bash', 11:08:04 INFO - 'SHLVL': '1', 11:08:04 INFO - 'TERM': 'linux', 11:08:04 INFO - 'TMOUT': '86400', 11:08:04 INFO - 'USER': 'cltbld', 11:08:04 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776', 11:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:04 INFO - '_': '/tools/buildbot/bin/python'} 11:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:08:04 INFO - Running setup.py (path:/tmp/pip-I3EKET-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:08:04 INFO - Running setup.py (path:/tmp/pip-15W5Ep-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:08:04 INFO - Running setup.py (path:/tmp/pip-wwBrZq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:08:04 INFO - Running setup.py (path:/tmp/pip-gKtL2r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:08:04 INFO - Running setup.py (path:/tmp/pip-rOppnY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:08:04 INFO - Running setup.py (path:/tmp/pip-4WtlY5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:08:04 INFO - Running setup.py (path:/tmp/pip-LGCRl8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:08:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:08:05 INFO - Running setup.py (path:/tmp/pip-OuNHDF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:08:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:08:05 INFO - Running setup.py (path:/tmp/pip-_iiJEO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:08:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:08:05 INFO - Running setup.py (path:/tmp/pip-NIs5Es-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:08:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:08:05 INFO - Running setup.py (path:/tmp/pip-2QDQna-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:08:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:08:05 INFO - Running setup.py (path:/tmp/pip-HhFwd8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:08:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:08:05 INFO - Running setup.py (path:/tmp/pip-jrB7BI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:08:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:08:05 INFO - Running setup.py (path:/tmp/pip-GhgGj6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:08:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:08:05 INFO - Running setup.py (path:/tmp/pip-phb0Mz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:08:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:08:05 INFO - Running setup.py (path:/tmp/pip-9ELmcc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:08:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:08:05 INFO - Running setup.py (path:/tmp/pip-rr_2Wj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:08:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:08:05 INFO - Running setup.py install for manifestparser 11:08:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:08:05 INFO - Running setup.py install for mozcrash 11:08:05 INFO - Running setup.py install for mozdebug 11:08:06 INFO - Running setup.py install for mozdevice 11:08:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:08:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:08:06 INFO - Running setup.py install for mozfile 11:08:06 INFO - Running setup.py install for mozhttpd 11:08:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:08:06 INFO - Running setup.py install for mozinfo 11:08:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:08:06 INFO - Running setup.py install for mozInstall 11:08:06 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:08:06 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:08:06 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:08:06 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:08:06 INFO - Running setup.py install for mozleak 11:08:06 INFO - Running setup.py install for mozlog 11:08:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:08:06 INFO - Running setup.py install for moznetwork 11:08:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:08:06 INFO - Running setup.py install for mozprocess 11:08:07 INFO - Running setup.py install for mozprofile 11:08:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:08:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:08:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:08:07 INFO - Running setup.py install for mozrunner 11:08:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:08:07 INFO - Running setup.py install for mozscreenshot 11:08:07 INFO - Running setup.py install for moztest 11:08:07 INFO - Running setup.py install for mozversion 11:08:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:08:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:08:07 INFO - Cleaning up... 11:08:07 INFO - Return code: 0 11:08:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:08:07 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:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:07 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:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:07 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 0x7f59c0948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1405450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1497a50>, '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 0x1403550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14039e0>, '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': 'eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776', '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:08:07 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:08:07 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:08:07 INFO - Using env: {'DISPLAY': ':0', 11:08:07 INFO - 'HOME': '/home/cltbld', 11:08:07 INFO - 'LANG': 'en_US.UTF-8', 11:08:07 INFO - 'LANGUAGE': 'en_US:en', 11:08:07 INFO - 'LOGNAME': 'cltbld', 11:08:07 INFO - 'MAIL': '/var/mail/cltbld', 11:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:07 INFO - 'MOZ_NO_REMOTE': '1', 11:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:07 INFO - 'NO_EM_RESTART': '1', 11:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:08:07 INFO - 'PWD': '/builds/slave/test-pgo', 11:08:07 INFO - 'SHELL': '/bin/bash', 11:08:07 INFO - 'SHLVL': '1', 11:08:07 INFO - 'TERM': 'linux', 11:08:07 INFO - 'TMOUT': '86400', 11:08:07 INFO - 'USER': 'cltbld', 11:08:07 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776', 11:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:07 INFO - '_': '/tools/buildbot/bin/python'} 11:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:08:07 INFO - Running setup.py (path:/tmp/pip-t2R2gZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:08:07 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:08:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:08:07 INFO - Running setup.py (path:/tmp/pip-IZMYEl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:08:07 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:08:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:08:07 INFO - Running setup.py (path:/tmp/pip-kqOr3W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:08:08 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:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:08:08 INFO - Running setup.py (path:/tmp/pip-JAdpvx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:08:08 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:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:08:08 INFO - Running setup.py (path:/tmp/pip-I9iNeG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:08:08 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:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:08:08 INFO - Running setup.py (path:/tmp/pip-qqaYg8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:08:08 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:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:08:08 INFO - Running setup.py (path:/tmp/pip-hNBo_I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:08:08 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:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:08:08 INFO - Running setup.py (path:/tmp/pip-NahyRk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:08:08 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:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:08:08 INFO - Running setup.py (path:/tmp/pip-mLGeLq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:08:08 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:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:08:08 INFO - Running setup.py (path:/tmp/pip-tiEpAw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:08:08 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:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:08:08 INFO - Running setup.py (path:/tmp/pip-uTK8r4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:08:08 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:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:08:08 INFO - Running setup.py (path:/tmp/pip-hRwcjq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:08:08 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:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:08:08 INFO - Running setup.py (path:/tmp/pip-CJUvM8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:08:08 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:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:08:08 INFO - Running setup.py (path:/tmp/pip-ypNkQN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:08:08 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:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:08:08 INFO - Running setup.py (path:/tmp/pip-QAILgt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:08:08 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:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:08:08 INFO - Running setup.py (path:/tmp/pip-kM7WVk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:08:08 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:08:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:08:08 INFO - Running setup.py (path:/tmp/pip-9lBOAe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:08:09 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:08:09 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:08:09 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:08:09 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:08:09 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:08:09 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:08:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:08:09 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:08:09 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:08:09 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:08:09 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:08:09 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:08:09 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:08:10 INFO - Downloading blessings-1.6.tar.gz 11:08:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:08:10 INFO - Installing collected packages: blessings 11:08:10 INFO - Running setup.py install for blessings 11:08:10 INFO - Successfully installed blessings 11:08:10 INFO - Cleaning up... 11:08:11 INFO - Return code: 0 11:08:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:08:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:08:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:08:11 INFO - Reading from file tmpfile_stdout 11:08:11 INFO - Current package versions: 11:08:11 INFO - argparse == 1.2.1 11:08:11 INFO - blessings == 1.6 11:08:11 INFO - blobuploader == 1.2.4 11:08:11 INFO - docopt == 0.6.1 11:08:11 INFO - manifestparser == 1.1 11:08:11 INFO - mozInstall == 1.12 11:08:11 INFO - mozcrash == 0.16 11:08:11 INFO - mozdebug == 0.1 11:08:11 INFO - mozdevice == 0.47 11:08:11 INFO - mozfile == 1.2 11:08:11 INFO - mozhttpd == 0.7 11:08:11 INFO - mozinfo == 0.9 11:08:11 INFO - mozleak == 0.1 11:08:11 INFO - mozlog == 3.1 11:08:11 INFO - moznetwork == 0.27 11:08:11 INFO - mozprocess == 0.22 11:08:11 INFO - mozprofile == 0.27 11:08:11 INFO - mozrunner == 6.11 11:08:11 INFO - mozscreenshot == 0.1 11:08:11 INFO - mozsystemmonitor == 0.0 11:08:11 INFO - moztest == 0.7 11:08:11 INFO - mozversion == 1.4 11:08:11 INFO - psutil == 3.1.1 11:08:11 INFO - requests == 1.2.3 11:08:11 INFO - wsgiref == 0.1.2 11:08:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:08:11 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:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:11 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:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:11 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 0x7f59c0948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1405450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1497a50>, '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 0x1403550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14039e0>, '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': 'eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776', '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:08:11 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:08:11 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:08:11 INFO - Using env: {'DISPLAY': ':0', 11:08:11 INFO - 'HOME': '/home/cltbld', 11:08:11 INFO - 'LANG': 'en_US.UTF-8', 11:08:11 INFO - 'LANGUAGE': 'en_US:en', 11:08:11 INFO - 'LOGNAME': 'cltbld', 11:08:11 INFO - 'MAIL': '/var/mail/cltbld', 11:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:11 INFO - 'MOZ_NO_REMOTE': '1', 11:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:11 INFO - 'NO_EM_RESTART': '1', 11:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:08:11 INFO - 'PWD': '/builds/slave/test-pgo', 11:08:11 INFO - 'SHELL': '/bin/bash', 11:08:11 INFO - 'SHLVL': '1', 11:08:11 INFO - 'TERM': 'linux', 11:08:11 INFO - 'TMOUT': '86400', 11:08:11 INFO - 'USER': 'cltbld', 11:08:11 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776', 11:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:11 INFO - '_': '/tools/buildbot/bin/python'} 11:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:11 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:08:11 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:08:11 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:08:11 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:08:11 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:08:11 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:08:11 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:08:11 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:08: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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:08: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 11:08:11 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:08:11 INFO - Cleaning up... 11:08:11 INFO - Return code: 0 11:08:11 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:08:11 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:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:11 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:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:11 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 0x7f59c0948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1405450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1497a50>, '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 0x1403550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14039e0>, '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': 'eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776', '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:08:11 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:08:11 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:08:11 INFO - Using env: {'DISPLAY': ':0', 11:08:11 INFO - 'HOME': '/home/cltbld', 11:08:11 INFO - 'LANG': 'en_US.UTF-8', 11:08:11 INFO - 'LANGUAGE': 'en_US:en', 11:08:11 INFO - 'LOGNAME': 'cltbld', 11:08:11 INFO - 'MAIL': '/var/mail/cltbld', 11:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:11 INFO - 'MOZ_NO_REMOTE': '1', 11:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:11 INFO - 'NO_EM_RESTART': '1', 11:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:08:11 INFO - 'PWD': '/builds/slave/test-pgo', 11:08:11 INFO - 'SHELL': '/bin/bash', 11:08:11 INFO - 'SHLVL': '1', 11:08:11 INFO - 'TERM': 'linux', 11:08:11 INFO - 'TMOUT': '86400', 11:08:11 INFO - 'USER': 'cltbld', 11:08:11 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776', 11:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:11 INFO - '_': '/tools/buildbot/bin/python'} 11:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:11 INFO - Downloading/unpacking jsonschema 11:08: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:08: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:08: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:08: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:08: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:08: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:08:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:08:13 INFO - Downloading/unpacking functools32 (from jsonschema) 11:08: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:08: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:08: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:08: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:08: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:08: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:08:13 INFO - Downloading functools32-3.2.3-2.tar.gz 11:08:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:08:13 INFO - warning: no files found matching '*.txt' 11:08:13 INFO - no previously-included directories found matching 'build' 11:08:13 INFO - no previously-included directories found matching 'dist' 11:08:13 INFO - no previously-included directories found matching '.git*' 11:08:13 INFO - Installing collected packages: jsonschema, functools32 11:08:13 INFO - Running setup.py install for functools32 11:08:13 INFO - warning: no files found matching '*.txt' 11:08:13 INFO - no previously-included directories found matching 'build' 11:08:13 INFO - no previously-included directories found matching 'dist' 11:08:13 INFO - no previously-included directories found matching '.git*' 11:08:13 INFO - Successfully installed jsonschema functools32 11:08:13 INFO - Cleaning up... 11:08:13 INFO - Return code: 0 11:08:13 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:08: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:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08: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:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59c0948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1405450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1497a50>, '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 0x1403550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14039e0>, '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': 'eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776', '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:08: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', 'flake8'] in /builds/slave/test-pgo/build 11:08: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 flake8 11:08:13 INFO - Using env: {'DISPLAY': ':0', 11:08:13 INFO - 'HOME': '/home/cltbld', 11:08:13 INFO - 'LANG': 'en_US.UTF-8', 11:08:13 INFO - 'LANGUAGE': 'en_US:en', 11:08:13 INFO - 'LOGNAME': 'cltbld', 11:08:13 INFO - 'MAIL': '/var/mail/cltbld', 11:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:13 INFO - 'MOZ_NO_REMOTE': '1', 11:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:13 INFO - 'NO_EM_RESTART': '1', 11:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:08:13 INFO - 'PWD': '/builds/slave/test-pgo', 11:08:13 INFO - 'SHELL': '/bin/bash', 11:08:13 INFO - 'SHLVL': '1', 11:08:13 INFO - 'TERM': 'linux', 11:08:13 INFO - 'TMOUT': '86400', 11:08:13 INFO - 'USER': 'cltbld', 11:08:13 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776', 11:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:13 INFO - '_': '/tools/buildbot/bin/python'} 11:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:14 INFO - Downloading/unpacking flake8 11:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:08:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:08: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:08: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:08: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:08: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:08: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:08: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:08:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:08:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:08: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:08: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:08: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:08: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:08: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:08: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:08:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:08: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:08: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:08: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:08: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:08: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:08: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:08:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:08:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:08:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:08:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:08:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:08:16 INFO - no previously-included directories found matching 'docs/_build' 11:08:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:08:16 INFO - Running setup.py install for pep8 11:08:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:08:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:08:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:08:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:08:16 INFO - no previously-included directories found matching 'docs/_build' 11:08:16 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:08:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:08:16 INFO - Cleaning up... 11:08:16 INFO - Return code: 0 11:08:16 INFO - Running post-action listener: _resource_record_post_action 11:08:16 INFO - Running post-action listener: _start_resource_monitoring 11:08:16 INFO - Starting resource monitoring. 11:08:16 INFO - ##### 11:08:16 INFO - ##### Running install step. 11:08:16 INFO - ##### 11:08:16 INFO - Running pre-action listener: _resource_record_pre_action 11:08:16 INFO - Running main action method: install 11:08:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:08:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:08:17 INFO - Reading from file tmpfile_stdout 11:08:17 INFO - Detecting whether we're running mozinstall >=1.0... 11:08:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:08:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:08:17 INFO - Reading from file tmpfile_stdout 11:08:17 INFO - Output received: 11:08:17 INFO - Usage: mozinstall [options] installer 11:08:17 INFO - Options: 11:08:17 INFO - -h, --help show this help message and exit 11:08:17 INFO - -d DEST, --destination=DEST 11:08:17 INFO - Directory to install application into. [default: 11:08:17 INFO - "/builds/slave/test-pgo"] 11:08:17 INFO - --app=APP Application being installed. [default: firefox] 11:08:17 INFO - mkdir: /builds/slave/test-pgo/build/application 11:08:17 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:08:17 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:08:31 INFO - Reading from file tmpfile_stdout 11:08:31 INFO - Output received: 11:08:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:08:31 INFO - Running post-action listener: _resource_record_post_action 11:08:31 INFO - ##### 11:08:31 INFO - ##### Running run-tests step. 11:08:31 INFO - ##### 11:08:31 INFO - Running pre-action listener: _resource_record_pre_action 11:08:31 INFO - Running main action method: run_tests 11:08:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:08:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:08:31 INFO - Python 2.7.3 11:08:31 INFO - Return code: 0 11:08:31 INFO - grabbing minidump binary from tooltool 11:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:31 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 0x1497a50>, '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 0x1403550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14039e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:08:31 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:08:31 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:08:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:08:31 INFO - Return code: 0 11:08:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:08:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:08:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:08:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:08:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:08:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:08:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:08:32 INFO - Return code: 0 11:08:32 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/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 11:08:32 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/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost 11:08:32 INFO - Using env: {'DISPLAY': ':0', 11:08:32 INFO - 'HOME': '/home/cltbld', 11:08:32 INFO - 'LANG': 'en_US.UTF-8', 11:08:32 INFO - 'LANGUAGE': 'en_US:en', 11:08:32 INFO - 'LOGNAME': 'cltbld', 11:08:32 INFO - 'MAIL': '/var/mail/cltbld', 11:08:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:08:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:32 INFO - 'MOZ_NO_REMOTE': '1', 11:08:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:08:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:32 INFO - 'NO_EM_RESTART': '1', 11:08:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:08:32 INFO - 'PWD': '/builds/slave/test-pgo', 11:08:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:08:32 INFO - 'SHELL': '/bin/bash', 11:08:32 INFO - 'SHLVL': '1', 11:08:32 INFO - 'TERM': 'linux', 11:08:32 INFO - 'TMOUT': '86400', 11:08:32 INFO - 'USER': 'cltbld', 11:08:32 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776', 11:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:32 INFO - '_': '/tools/buildbot/bin/python'} 11:08:32 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/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] with output_timeout 3600 11:08:33 INFO - mozversion INFO | application_buildid: 20160121083822 11:08:33 INFO - mozversion INFO | application_changeset: 8d81327764e1cf434e2847ed4b92117db5d43842 11:08:33 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 11:08:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:08:33 INFO - mozversion INFO | application_name: Firefox 11:08:33 INFO - mozversion INFO | application_remotingname: firefox-dev 11:08:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:08:33 INFO - mozversion INFO | application_vendor: Mozilla 11:08:33 INFO - mozversion INFO | application_version: 45.0a2 11:08:33 INFO - mozversion INFO | platform_buildid: 20160121083822 11:08:33 INFO - mozversion INFO | platform_changeset: 8d81327764e1cf434e2847ed4b92117db5d43842 11:08:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:08:33 INFO - mozversion INFO | platform_version: 45.0a2 11:08:33 INFO - 2016-01-21 11:08:33,031 DEBUG : using testdate: 1453403313 11:08:33 INFO - 2016-01-21 11:08:33,031 DEBUG : actual date: 1453403313 11:08:33 INFO - 2016-01-21 11:08:33,042 INFO : starting webserver on 'localhost:47296' 11:08:33 INFO - 2016-01-21 11:08:33,043 INFO : Starting test suite talos-linux64-ix-010.e 11:08:33 INFO - 2016-01-21 11:08:33,043 INFO : Starting test dromaeo_css 11:08:33 INFO - 2016-01-21 11:08:33,043 DEBUG : operating with platform_type : linux_ 11:08:33 INFO - 2016-01-21 11:08:33,044 INFO : Initialising browser for dromaeo_css test... 11:08:33 INFO - 2016-01-21 11:08:33,056 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9yuaKH/profile http://localhost:47296/getInfo.html 11:08:37 INFO - 2016-01-21 11:08:37,103 DEBUG : BROWSER_OUTPUT: 11:08:37 INFO - 2016-01-21 11:08:37,103 DEBUG : BROWSER_OUTPUT: (process:23256): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:08:38 INFO - 2016-01-21 11:08:38,093 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:08:38 INFO - 2016-01-21 11:08:38,094 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:08:38 INFO - 2016-01-21 11:08:38,094 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:08:38 INFO - 2016-01-21 11:08:38,094 DEBUG : BROWSER_OUTPUT: __metrics 11:08:39 INFO - 2016-01-21 11:08:39,121 INFO : Browser initialized. 11:08:39 INFO - 2016-01-21 11:08:39,122 INFO : Running cycle 1/1 for dromaeo_css test... 11:08:39 INFO - 2016-01-21 11:08:39,122 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9yuaKH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:08:40 INFO - 2016-01-21 11:08:40,400 DEBUG : BROWSER_OUTPUT: 11:08:40 INFO - 2016-01-21 11:08:40,401 DEBUG : BROWSER_OUTPUT: (process:23369): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:08:50 INFO - 2016-01-21 11:08:50,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 136327168 11:08:50 INFO - 2016-01-21 11:08:50,909 DEBUG : BROWSER_OUTPUT: 11:09:40 INFO - 2016-01-21 11:09:40,501 DEBUG : BROWSER_OUTPUT: 1453403380496 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:11:48 INFO - 2016-01-21 11:11:48,592 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47296/tests/dromaeo/cssquery-ext.html) 11:11:49 INFO - 2016-01-21 11:11:49,948 DEBUG : BROWSER_OUTPUT: RSS: Main: 142176256 11:11:49 INFO - 2016-01-21 11:11:49,948 DEBUG : BROWSER_OUTPUT: 11:14:51 INFO - 2016-01-21 11:14:51,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/dromaeo/cssquery-ext.html (next: http://localhost:47296/tests/dromaeo/cssquery-jquery.html) 11:14:52 INFO - 2016-01-21 11:14:52,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 139251712 11:14:52 INFO - 2016-01-21 11:14:52,412 DEBUG : BROWSER_OUTPUT: 11:17:54 INFO - 2016-01-21 11:17:54,023 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47296/tests/dromaeo/cssquery-mootools.html) 11:17:54 INFO - 2016-01-21 11:17:54,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 138530816 11:17:54 INFO - 2016-01-21 11:17:54,613 DEBUG : BROWSER_OUTPUT: 11:20:56 INFO - 2016-01-21 11:20:56,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47296/tests/dromaeo/cssquery-prototype.html) 11:20:56 INFO - 2016-01-21 11:20:56,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 138485760 11:20:56 INFO - 2016-01-21 11:20:56,763 DEBUG : BROWSER_OUTPUT: 11:23:59 INFO - 2016-01-21 11:23:59,021 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47296/tests/dromaeo/cssquery-yui.html) 11:23:59 INFO - 2016-01-21 11:23:59,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 138440704 11:23:59 INFO - 2016-01-21 11:23:59,603 DEBUG : BROWSER_OUTPUT: 11:27:01 INFO - 2016-01-21 11:27:01,601 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/dromaeo/cssquery-yui.html (next: http://localhost:47296/tests/dromaeo/cssquery-dojo.html) 11:27:01 INFO - 2016-01-21 11:27:01,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 141041664 11:27:01 INFO - 2016-01-21 11:27:01,851 DEBUG : BROWSER_OUTPUT: 11:27:01 INFO - 2016-01-21 11:27:01,851 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:27:01 INFO - 2016-01-21 11:27:01,851 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:27:01 INFO - 2016-01-21 11:27:01,852 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:27:01 INFO - 2016-01-21 11:27:01,852 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:27:01 INFO - 2016-01-21 11:27:01,853 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3317.3033662930784;3391.13526050857;3405.965940340596;3424.2466657335394;3432.9313413731734;5586.301712285965;5606.607537472369;5613.831585052455;5640.830775076754;5670.71646417679;5546.946080244751;5627.2684551008415;5644.774209031634;5662.178984047321;5678.829635110943;5097.847064588068;5131.666441681297;5143.4599367066485;5214.66104703195;5224.033553792541;4996.350474438318;5064.442911279774;5156.175011998081;5158.174692049273;5171.689698618076;5026.97486512567;5067.442581316052;5089.720065396402;5090.363704536933;5097.872553186182;5170.379554453452;5181.4248168763625;5190.247414124969;5206.843794686166;5238.816641417551;4967.552920237196;5028.396592408898;5086.1353569892835;5118.053160165344;5149.48505149482;5426.457354264581;5442.510174084312;5471.781128754845;5491.890162196773;5497.202905578669;6015.879682406327;6043.305019922721;6068.241469816273;6080.935836228642;6113.052476866093;5924.7333869975955;5993.8801223975715;6057.636541807506;6106.938930610681;6125.264968203844;5552.222688823568;5730.4269573042775;5744.971275143639;5748.367679555246;5758.021136406821;6150.477209437158;6191.1641928339095;6200.472959798468;6215.564910456224;6223.159873417031;5744.454276843693;5802.274715660543;5877.471027607536;5910.054391297458;5933.465988061009;6112.419320164578;6131.540134489931;6150.415710507495;6152.107944348045;6175.3824617538785;5746;6071.210742603434;6120.785772497941;6124.938750612437;6128.908066379008;5700.458456446631;5841.88316233673;5845.795397161164;5929.762809487572;6071.605345652519;4644.7213167210075;4671.416072990876;4673.135469938073;4679.836205732783;4686.062787442525;4171.186618609342;4199.0342221289275;4204.894877628084;4208.810603522848;4230.873073807729;5470.863228419242;5505.394406615269;5564.749586268627;5565.387807341189;5567.526760225345;5969.641821490724;5975.312839023481;6159.630422174684;6169.383061693795;6194.783182588678;5714.657120572779;5790.305163380337;5803.332616749043;5812.244408226903;5826.417358264224;5057.873553161126;5131.640785145079;5254.15933450646;5260.973695131576;5359.035373632705;6149.877002460015;6210.596311239755;6212.0371342441995;6219.253689557192;6249.875002499924;6058.878822423439;6113.969430152821;6128.142060111677;6132.448079672851;6134.938650613615;5920.437558431942;5981.1028345746745;6067.726952287069;6097.664628445301;6233.314335423009;5864.06175011996;6015.488683461955;6033.939660603513;6038.849028774316;6046.395360464095;6090.817275481742;6092.847678808065;6141.631502109888;6153.138560601609;6168;5734.942650573441;5752.137179422953;5833.4749872511675;5834.679092649945;5848.473637372486;5829.09649004405;5964.343922168471;5983.7008149591475;6018.699065046642;6024.096385542204;5875.94124058771;5878.088896221093;5925.348211696623;5933.525317974465;5939.940600593939;5613.859653508532;5694.886102278014;5704.942950570441;5733.913991290051;5734.254546908875;5772.884542309214;5781.161731548817;5815.505682017076;5818.214541036906;5841.036229022334 11:27:01 INFO - 2016-01-21 11:27:01,854 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.1724248112793;595.9374265702102;602.0126991733558;657.8026592022395;677.3565113142516;39712.60287397125;41266;41273.793631031804;41348;41473.79263103688;40030.7998460008;40452;40543;40626;40696.38955415671;9017.45895246284;9152.679656212034;9176.17414432701;9177.816443671123;9204.309676774268;8921.598528066253;8997.280217582578;9032.367734258605;9049.95475022624;9068.546572671374;8925.687600933968;8937.106289371044;8951.373403861733;8964.103589641049;8985.95507022464;8945.373823832302;8947.910520894806;9020.278377729832;9023.05257947916;9025.593848276843;8859.379843410963;8931.419457735226;8951.836261285991;9005.594748236344;9020;41033.17933641341;41243.58756412457;41422.58577414217;41484;41512.37731434031;3299.4226010448315;3344.5150453184397;3356.580427446569;3370.8146051967133;3436.1409647588102;31162.799928553064;31177.532337014964;31397.37205255882;31589.526157107663;31986.200344991328;4251.44731184944;4279.465066866642;4325.264705000126;4340.826366945318;4349.7825108744755;286682;287183.5640821803;288538;288865;290634;58326.7083664579;58757.11864322038;59014.70492647509;59103.408965910654;59208.7039564808;63008;63172;63193.368066319665;63300.05049924255;63386;14000.229987350589;14696.338664760111;14803.92598037003;14822.407103715947;14833.18417487027;10345.948270258601;10353.792924141475;10362.119219866245;10364.689059328231;10373.066424021874;19664.115114819866;19840.206391744458;19860;19926.103325350396;20077;7923.286904178536;8043.1554686757045;8078.151794061657;8149.592520373958;8185.631646575918;1030.1552726763982;1037.2479952034864;1046.3303485769113;1077.2836064017497;1115.9892084540356;28261.173882611987;28404.43191136166;28867.566986495218;29096.563551546744;29423;1067.604986155112;1077.3966578715945;1087.2715280761909;1094.6059418609295;1109.8314312637465;14158.362873670709;14206.431742730176;14241.21984751906;14257.572272831832;14493.78259326111;471125;476719;502650;502916;508503;56389.43610563924;57768.422315776304;57868.13197802036;57922.7103864478;58697.70651146717;1378.8965827562972;1385.6743665238862;1386.2098603795941;1416.4759039155786;1428.5357258890901;29819.3220845158;29917;30500;31127.221819454695;31319.21701957469;46768.298475523574;47011.764941175075;47373.28940065833;47398.763006184745;47525.52474475211;328648;331462;331630;333864;334191;33586.49620255649;33903;33914.49128263029;34217.144571385914;46595;45703.085938281714;46117;46209.30686039645;46464.53535464602;46536.76731616456;38666;38788.224235514564;40145.59854401535;40871;41108.177836443705;39952.2009559813;40209.1958160841;40636.390454142624;40718;40927.38608920928;39184;41130.38304425496;41435.7928210357;41560.584394155674;42061.78969105135;31294.68705312918;32798.18004549905;33131;33230.5015424764;33262.50106248457;27444.862775686794;27893.44213115767;28116.702962321997;28803;28842.71157288484 11:27:01 INFO - 2016-01-21 11:27:01,854 DEBUG : BROWSER_OUTPUT: |2;jquery.html;381.8892521168861;382.8028565288877;385.85337571722744;386.23139951496523;386.95936926622704;15848.683026339466;16862.39807218312;17352.56618584536;17677.1161441928;17718.46844594661;12189.573364932228;12211.38943052846;12257.816132758016;13158.407871645775;16658.916705416486;5216.087184742674;5246.291750613656;5284.867878303054;5287.471252874701;5287.947120528803;5243.947560524403;5283.656562323436;5330.600204984622;5331.493508116722;5337.5196232339085;5180.430152683201;5217.634765566412;5311.256424100629;5409.648372855751;5415.620906536544;4454.265046267362;5413;5442.755076021569;5456.863578410552;6138.785142520035;5523.143912693539;5529.585281103893;5545.445455454463;5554.805581804618;5570.275864137636;19498;19571.608567828705;19703.704444433344;20079.598408031903;20117.79882201174;2189.5839790439763;2195.034184958629;2205.867647941129;2220.322801545528;2241.237979087118;9663.323567350288;10040.29717919746;10545.683629491128;13002.414891329818;14132.293385330693;1920.1263425141526;1933.236371633211;1984.642764302425;1990.8407327413772;1998.6402447559433;63989.3601063988;65783.67108164428;66141.66929165323;66535;67170.66414667896;10652.414117223472;10773.299735517166;10783.622573210057;10880.075193608633;10962.068224200873;13938.163710177421;14032.579022629337;14091.436342546389;14171.574852754435;14218.075825071337;7476.102867655916;7477.252274772479;7549.3583045440655;7551.697932082765;7613.124490683532;7095.361417472453;7161.212266650664;7187.065681461377;7241.167265764505;7361.227071157451;4727.929081063787;4754.120487709784;4760.285957106462;4771.761411929459;4792.353032340659;1874.9718754218698;1905.4283714885478;1940.4178746376313;1977.960440791176;2000.6698894682506;452.9026259354255;469.3288597305817;474.50177313820353;476.5282370453226;656.9671516424255;10118.08937195656;10263.178945684327;10459.633912813015;10474.68575942723;10716.303440276357;465.85791333642885;472.2349793334751;479.0084525033148;485.9028194361142;490.30376864851996;5733.684647344353;5884.558658100659;5898.528117750569;5952.85117872048;9811.705648830546;601709;609928;619793;623413;626666;73453.26546734464;79504.6024769884;85383;85617.14382856217;86128;1206.0411972481897;1212.2605210821391;1245.414655112096;1249.7000719827176;1280.1934781088041;16489.67020659604;16512.94554974851;16569;16757.32970681159;16980;37855.242895142495;38307.425388618634;38667.22665546617;38988.80505597454;39290.21419571535;50072.49927500678;50812.74593627008;51121.466356009376;51633.22550161826;52653.157139499934;10073.647422340184;10101.595936162765;10139.391636501834;10152.949235254073;10304.381737095799;12511.624651260478;12580.748385032432;18597.535061623028;18827.058647067865;18852.434426967215;13284.468621255042;14781.260936953324;15025;15151;15495;14593.489227876973;14628.102063962417;14726.926365368105;14879.628009299855;15018;15058.774118388452;15195.696086078438;15453.613659658598;15825.604359891095;16014.839851601335;9893.950530247303;10126.544305506122;10152.74618134523;10349.223808214565;10359.896401035892;14990.625234369229;15008.699826003638;15306.923465382602;15447.2276386178;16233.918830405772 11:27:01 INFO - 2016-01-21 11:27:01,856 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1402.4179965314393;1455.1196526101705;1611.9435819746304;1648.967020659586;1782.5632719983598;7650.808729781751;7793.805154871131;7972.441929064968;8065.475744076631;8081.757547273583;8236.91763082369;8268.91731082689;8304.33565314775;8320.084790673036;8325.583720813966;2267.183813827021;2329.0683726509365;2337.4623836517612;2338.497223097034;2343.250159948817;2389.1518510928545;2428.7935525480357;2433.0267892842917;2435.1111844176835;2464.5194187133516;2306.5617532668825;2349.2012715676665;2350.21267875262;2379.8810059496955;2413.4328432818274;2339.6373562097815;2374.3707917401903;2378.0487804878103;2380.8690522021284;2389.2712722619594;2324.8837558122027;2382.9642555361684;2385.2248019393764;2385.2248019393764;2392.461696118377;8058.11360750317;8135.145809690016;8162.469439486415;8177.264046235808;8180.550069746161;4736.786844592001;4828.444728856191;4869.172240719086;4887.437944636376;4890.853274401774;3228.96771032289;3246.2371342734436;3327.3012667339885;3342.5821772278464;3355.9496607550905;1041.458441610366;1080.168270431771;1087.8041952448557;1088.395940253159;1096.17786660005;11136.387498687569;11225.101991840633;11259.099272058216;11260;11348.65954021389;4287.421198138211;4338.045629961403;4377.671674624416;4459.732416054982;4481.238189507726;9185;9219.308551858638;9226.261899048195;9227.26181905446;9228.676996305232;4911.238757992517;4916.7541622919425;4923.77842997066;4926.630502712311;4931.358923340014;4492.460904691458;4494.258447356149;4496.392986946786;4520.977395113004;4524.88687782808;3583.516225309602;3651.9817400912825;3657.3782456982376;3657.3782456982376;3670.559532856021;1158.5481662151767;1164.6738913104343;1171.3499008050444;1174.395186478964;1177.5996161305197;1063.4151216830712;1067.9359238445563;1113.9443027848574;1247.2454165230088;1352.0535625062496;7284.70861165558;7285.635718214068;7378.372838308804;7403.8149046274275;7410.370118539984;1106.3085571517802;1110.8500352452315;1118.7208925858624;1129.282905355089;1135.795556799784;5666.914996275059;5686.317641882918;5698.800541981093;5717.714114294268;5728.598998070095;9688.273379496424;9731.367461115005;9943.552540135712;10036.247281453774;10103.343282686601;9666.275029372826;9728.124468797841;9743.366681165844;9844.163246124159;9873.456959867133;7236.38490728294;7492.063492063492;7503.7748867534065;7507.737229196952;7705.691772329156;7290.453216008715;7303.415726741741;7362;7375.96312018458;7428.1086269647985;8618.78453038679;8803.163699448798;8865.069167737294;8899.599518021834;8909.866352004596;8836.381453298465;8853.15894989975;8928.017918029142;8935;8938.284937205139;7771.766846994599;7784.88322675149;7858.842823143619;7876.84246315059;7892.605369731606;7853.371730261451;7935.325497332791;7985.241402066795;7989.2809647132035;8041.839163216586;7218.097737782778;7455.254474552501;7479.551226926402;7522.962385188039;7662.118856331594;7030;7124.21633620291;7133.17968433616;7185.425165986604;7218.27817218274;7133.500654954103;7136.107986501687;7154.964225178841;7156.892646610409;7206.4595155364605;6639.402453779183;6677.632730199885;6681.398674119353;6700.262971073081;6730;6533.477321814148;6607;6671.566348187353;6687.933120668731;6701.932980670131 11:27:01 INFO - 2016-01-21 11:27:01,857 DEBUG : BROWSER_OUTPUT: |4;prototype.html;350.8491348720051;354.3285474026718;355.7918617608699;360.5421115183716;362.71345636946813;6397.58415702979;6474.5791523551;6487.253965793935;6497.642629655367;6498.9926561383;6302.149209856668;6440.194975628046;6447.484201263899;6448.193975753031;6464.676766161697;4904.926426103611;4933.777979990891;4937.061958227925;4942.233953737176;4944.7280399578185;4953.232249001392;4953.23224900141;4954.578860796837;4954.900901981958;4966.9751651241695;4680.227762419214;4738.4313882334;4754.334393184957;4758.191107511731;4776.28355746639;4755.334253204537;4761.9761751223305;4762.571368576828;4768.523147685239;4810.206315957863;4130.607592278729;4138.213739389506;4143.6685065195015;4147.149834283965;4148.128892932487;6035.366286539894;6118.847028824271;6127.4791642710425;6133.907991380132;6147.44672979434;5600.52395546375;5606.523445507137;5621.213030175779;5621.213030175779;5621.353544342372;6757.594544327307;6807.693653785592;6812.216595091579;6813.148356455443;6816.7614133505585;4570.451545814523;4604.1252162089095;4604.332371806103;4614.054118905617;4628.884277893046;6963.0251764752975;7018.508704390695;7117.359437650636;7121.216666166718;7135.072440582743;4823.710577365369;4830;4830.130576496194;4830.565249127595;4831.613470922318;4878.000009997942;4890.413150421972;4890.850650097224;4894.951050489521;4898.632602554822;5572.637778544382;5689.857753556194;5694.259746232963;5699.287589051369;5707.315122185364;6857.759978400732;6882.724691012403;6884.139482564679;6892.241853396123;6909.27452617478;1619.6679680665436;1639.1148779659088;1698.5923378389098;1732.1339330334833;1736.3575477073564;1131.4003578103618;1138.1236447935044;1142.5429828068839;1146.134668325409;1152.6196355202762;6363.936360636427;6404.903926441107;6437.163168788121;6447.967760161169;6460.870782584416;6966.9303306967295;6979.267176946449;6981.162260528769;7002.474814388941;7016.543924644881;6404.679766011681;6412.935870641234;6447.709853056624;6451.645159516178;6471.546991710535;3870.2066076454257;3913.3542965410957;3915.727388598717;3915.882523524299;3923.4114882767813;7427.220141885133;7433.7769866903;7438.776836694908;7442.627868606548;7450.105987281561;7134.785956421316;7398.815029624302;7405.1854296027395;7410.925890741024;7414.740484083031;7418.406527477789;7446.925530744732;7466.25337466249;7467.402607791364;7475.028246328051;7226.710931562889;7231.3130252625915;7235.167955685163;7240.818979525343;7243.7464688735645;6997.510174287751;7066.222715501393;7143.8571228576175;7145.249748776304;7156.856862862818;7386.667599957907;7402.259774022555;7408.37028852532;7417.592032438052;7429.14564825052;4799.66402351832;4810.6632535722165;4863.392075990501;4870.853874383774;4881.048195601824;7055.717771289091;7118.750843720445;7191.892121618284;7193.3166349196745;7223.061002069908;6927.27263637331;6960.060391847036;6974.825629359104;6997.47518936092;7028.753993610199;6934.4452443805385;6968.233494315723;6969.233384327618;6975.093237879043;6976.965115174392;6714.160729908762;6782.69477873487;6862.553933994274;6877.105976223259;6877.209120951155;6944.791656250321;6957.130358705162;6982.755603553851;6997.300269972962;7019;6668.699908504226;6784.3894049535775;6834.965825170842;6858.691358888762;6863.347981941708 11:27:01 INFO - 2016-01-21 11:27:01,858 DEBUG : BROWSER_OUTPUT: |5;yui.html;781.335864515162;795.7294519863245;801.2828518475964;805.7945223967887;829.216390510967;13976.580702578925;14328.211948342838;14340.498082567112;14358.497452589161;14378.640533986656;12991.805122923164;13106.95144388449;13120.147190432615;13168.539101131462;13599.456021759142;840.2731637133896;843.633019636457;846.174979395091;849;853.607340623311;853.8463076646201;854.8845905802731;855.4781583234222;860.0797147052656;860.2644738748373;892.5671049540967;898.469902757373;900.0549423105746;902.620899222325;903.3676426501443;876.7019213467388;887.6937456577471;890.6882591093098;896.5248418338258;897.1835629577087;646.524804268862;649.8148027812051;650.5348675696899;651.1144843013498;652.3346186889394;14104.506342278073;14107.506237281646;14201.573952781433;14202.573922782332;14236.43054277838;12300.261984280973;12433.875661243363;12984.091113622051;13057.151285166434;13295.3352332383;11336.093112550976;11546.884531154748;11736.119791015708;11836;11858.940705296505;3735.0662334416397;3763;3797.2215695782297;3807.847686092553;3815.9809200954096;48668.51331486675;48809.51190488085;49165.26252106221;49315;49531;10008.14930730896;10142.949285253526;10163.69508914719;10193.847092293621;10470.685879423629;17544.649107017787;19072.2371105157;19220.231190752213;19265.51836204078;19267.22931082769;7749.651265693057;7768.339691126204;7793.2596403341595;7950.24472675095;8045.436819422701;4555.997680510282;4596.747178905125;4632.374629425052;4703.435587729495;4718.4809670936165;3303.6200836904063;3330.533725278463;3396.7961922284744;3509.7192224621967;3510.64893510652;635.0791352538837;641.3874749614107;649.4706813946618;652.7225928980164;660.5508254386967;638.7987783848073;675.7634827810227;720.8738470767595;726.5459088069956;743.605888878895;9305.581248843819;9584.137427631547;9630.374025688308;9654.372465789702;9683.322167448352;515.7060475528988;574.9453801888814;594.7769586405099;641.8940874755706;661.9602823830586;4180.435641188401;4201.243776120266;4315.683716466445;4328.220920234388;4392.121575684812;56746.71626641923;65355.69288614201;65703.67148164229;66330.66834665796;66751.33248667548;50777.49222507728;51106.23340649893;51937;52214.47785522096;52853;46094.30858537058;47261;47277.05445891063;48010;48785.268220976715;9230.630774769203;9264.861027084735;9271.814563708824;9503.382280151767;9625.855612165964;35753;35802.28395432129;36590.8170459146;36708.81645591755;36953.26093478169;41112.38331424971;46639;46774.06451871012;46893.2966005517;47171.29243061425;10122.369847749736;10554.313969591953;11232.55069797199;11268.492917818554;11323.660290191307;11940.880591193976;12109.636710898687;12185.878141218474;12475.438605262967;12607.054470914902;11895.107866909842;11996.700082498008;12156.817647735468;12287.447064881922;12404.937975310066;11670.416479175838;11695.239809412702;11712.70718232051;11864.940675296568;12120.09099317537;10558.577656893638;11375.772484550429;11381;11834.230774999598;12257.448414821176;9421.81156376855;9950.35322704022;10587.523561439599;10683.679489615324;10973.780524389627;9637.71086867395;10008.749781255236;10108.241881858743;10184.643537476153;10221.437820919624 11:27:01 INFO - 2016-01-21 11:27:01,858 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:27:01 INFO - 2016-01-21 11:27:01,858 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:27:01 INFO - 2016-01-21 11:27:01,858 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,297 11:27:01 INFO - 2016-01-21 11:27:01,858 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:27:01 INFO - 2016-01-21 11:27:01,858 DEBUG : BROWSER_OUTPUT: __startTimestamp1453404421850__endTimestamp 11:27:01 INFO - 2016-01-21 11:27:01,859 DEBUG : BROWSER_OUTPUT: 11:27:01 INFO - 2016-01-21 11:27:01,859 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:27:01 INFO - 2016-01-21 11:27:01,859 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:27:01 INFO - 2016-01-21 11:27:01,859 DEBUG : BROWSER_OUTPUT: 11:27:01 INFO - 2016-01-21 11:27:01,859 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5601.39 Median:5781.16 stddev:615.50 (10.6%) stddev-sans-first:590.73 11:27:01 INFO - 2016-01-21 11:27:01,860 DEBUG : BROWSER_OUTPUT: Values: 3317.3 3391.1 3406.0 3424.2 3432.9 5586.3 5606.6 5613.8 5640.8 5670.7 5546.9 5627.3 5644.8 5662.2 5678.8 5097.8 5131.7 5143.5 5214.7 5224.0 4996.4 5064.4 5156.2 5158.2 5171.7 5027.0 5067.4 5089.7 5090.4 5097.9 5170.4 5181.4 5190.2 5206.8 5238.8 4967.6 5028.4 5086.1 5118.1 5149.5 5426.5 5442.5 5471.8 5491.9 5497.2 6015.9 6043.3 6068.2 6080.9 6113.1 5924.7 5993.9 6057.6 6106.9 6125.3 5552.2 5730.4 5745.0 5748.4 5758.0 6150.5 6191.2 6200.5 6215.6 6223.2 5744.5 5802.3 5877.5 5910.1 5933.5 6112.4 6131.5 6150.4 6152.1 6175.4 5746.0 6071.2 6120.8 6124.9 6128.9 5700.5 5841.9 5845.8 5929.8 6071.6 4644.7 4671.4 4673.1 4679.8 4686.1 4171.2 4199.0 4204.9 4208.8 4230.9 5470.9 5505.4 5564.7 5565.4 5567.5 5969.6 5975.3 6159.6 6169.4 6194.8 5714.7 5790.3 5803.3 5812.2 5826.4 5057.9 5131.6 5254.2 5261.0 5359.0 6149.9 6210.6 6212.0 6219.3 6249.9 6058.9 6114.0 6128.1 6132.4 6134.9 5920.4 5981.1 6067.7 6097.7 6233.3 5864.1 6015.5 6033.9 6038.8 6046.4 6090.8 6092.8 6141.6 6153.1 6168.0 5734.9 5752.1 5833.5 5834.7 5848.5 5829.1 5964.3 5983.7 6018.7 6024.1 5875.9 5878.1 5925.3 5933.5 5939.9 5613.9 5694.9 5704.9 5733.9 5734.3 5772.9 5781.2 5815.5 5818.2 5841.0 11:27:01 INFO - 2016-01-21 11:27:01,860 DEBUG : BROWSER_OUTPUT: 11:27:01 INFO - 2016-01-21 11:27:01,860 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:53960.94 Median:40666.39 stddev:100797.31 (247.9%) stddev-sans-first:101000.32 11:27:01 INFO - 2016-01-21 11:27:01,860 DEBUG : BROWSER_OUTPUT: Values: 559.2 595.9 602.0 657.8 677.4 39712.6 41266.0 41273.8 41348.0 41473.8 40030.8 40452.0 40543.0 40626.0 40696.4 9017.5 9152.7 9176.2 9177.8 9204.3 8921.6 8997.3 9032.4 9050.0 9068.5 8925.7 8937.1 8951.4 8964.1 8986.0 8945.4 8947.9 9020.3 9023.1 9025.6 8859.4 8931.4 8951.8 9005.6 9020.0 41033.2 41243.6 41422.6 41484.0 41512.4 3299.4 3344.5 3356.6 3370.8 3436.1 31162.8 31177.5 31397.4 31589.5 31986.2 4251.4 4279.5 4325.3 4340.8 4349.8 286682.0 287183.6 288538.0 288865.0 290634.0 58326.7 58757.1 59014.7 59103.4 59208.7 63008.0 63172.0 63193.4 63300.1 63386.0 14000.2 14696.3 14803.9 14822.4 14833.2 10345.9 10353.8 10362.1 10364.7 10373.1 19664.1 19840.2 19860.0 19926.1 20077.0 7923.3 8043.2 8078.2 8149.6 8185.6 1030.2 1037.2 1046.3 1077.3 1116.0 28261.2 28404.4 28867.6 29096.6 29423.0 1067.6 1077.4 1087.3 1094.6 1109.8 14158.4 14206.4 14241.2 14257.6 14493.8 471125.0 476719.0 502650.0 502916.0 508503.0 56389.4 57768.4 57868.1 57922.7 58697.7 1378.9 1385.7 1386.2 1416.5 1428.5 29819.3 29917.0 30500.0 31127.2 31319.2 46768.3 47011.8 47373.3 47398.8 47525.5 328648.0 331462.0 331630.0 333864.0 334191.0 33586.5 33903.0 33914.5 34217.1 46595.0 45703.1 46117.0 46209.3 46464.5 46536.8 38666.0 38788.2 40145.6 40871.0 41108.2 39952.2 40209.2 40636.4 40718.0 40927.4 39184.0 41130.4 41435.8 41560.6 42061.8 31294.7 32798.2 33131.0 33230.5 33262.5 27444.9 27893.4 28116.7 28803.0 28842.7 11:27:01 INFO - 2016-01-21 11:27:01,860 DEBUG : BROWSER_OUTPUT: 11:27:01 INFO - 2016-01-21 11:27:01,860 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31290.72 Median:2213.10 stddev:100739.63 (4552.0%) stddev-sans-first:100995.49 11:27:01 INFO - 2016-01-21 11:27:01,861 DEBUG : BROWSER_OUTPUT: Values: 381.9 382.8 385.9 386.2 387.0 15848.7 16862.4 17352.6 17677.1 17718.5 12189.6 12211.4 12257.8 13158.4 16658.9 5216.1 5246.3 5284.9 5287.5 5287.9 5243.9 5283.7 5330.6 5331.5 5337.5 5180.4 5217.6 5311.3 5409.6 5415.6 4454.3 5413.0 5442.8 5456.9 6138.8 5523.1 5529.6 5545.4 5554.8 5570.3 19498.0 19571.6 19703.7 20079.6 20117.8 2189.6 2195.0 2205.9 2220.3 2241.2 9663.3 10040.3 10545.7 13002.4 14132.3 1920.1 1933.2 1984.6 1990.8 1998.6 63989.4 65783.7 66141.7 66535.0 67170.7 10652.4 10773.3 10783.6 10880.1 10962.1 13938.2 14032.6 14091.4 14171.6 14218.1 7476.1 7477.3 7549.4 7551.7 7613.1 7095.4 7161.2 7187.1 7241.2 7361.2 4727.9 4754.1 4760.3 4771.8 4792.4 1875.0 1905.4 1940.4 1978.0 2000.7 452.9 469.3 474.5 476.5 657.0 10118.1 10263.2 10459.6 10474.7 10716.3 465.9 472.2 479.0 485.9 490.3 5733.7 5884.6 5898.5 5952.9 9811.7 601709.0 609928.0 619793.0 623413.0 626666.0 73453.3 79504.6 85383.0 85617.1 86128.0 1206.0 1212.3 1245.4 1249.7 1280.2 16489.7 16512.9 16569.0 16757.3 16980.0 37855.2 38307.4 38667.2 38988.8 39290.2 50072.5 50812.7 51121.5 51633.2 52653.2 10073.6 10101.6 10139.4 10152.9 10304.4 12511.6 12580.7 18597.5 18827.1 18852.4 13284.5 14781.3 15025.0 15151.0 15495.0 14593.5 14628.1 14726.9 14879.6 15018.0 15058.8 15195.7 15453.6 15825.6 16014.8 9894.0 10126.5 10152.7 10349.2 10359.9 14990.6 15008.7 15306.9 15447.2 16233.9 11:27:01 INFO - 2016-01-21 11:27:01,861 DEBUG : BROWSER_OUTPUT: 11:27:01 INFO - 2016-01-21 11:27:01,861 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5682.23 Median:5723.16 stddev:2955.90 (51.6%) stddev-sans-first:2946.69 11:27:01 INFO - 2016-01-21 11:27:01,862 DEBUG : BROWSER_OUTPUT: Values: 1402.4 1455.1 1611.9 1649.0 1782.6 7650.8 7793.8 7972.4 8065.5 8081.8 8236.9 8268.9 8304.3 8320.1 8325.6 2267.2 2329.1 2337.5 2338.5 2343.3 2389.2 2428.8 2433.0 2435.1 2464.5 2306.6 2349.2 2350.2 2379.9 2413.4 2339.6 2374.4 2378.0 2380.9 2389.3 2324.9 2383.0 2385.2 2385.2 2392.5 8058.1 8135.1 8162.5 8177.3 8180.6 4736.8 4828.4 4869.2 4887.4 4890.9 3229.0 3246.2 3327.3 3342.6 3355.9 1041.5 1080.2 1087.8 1088.4 1096.2 11136.4 11225.1 11259.1 11260.0 11348.7 4287.4 4338.0 4377.7 4459.7 4481.2 9185.0 9219.3 9226.3 9227.3 9228.7 4911.2 4916.8 4923.8 4926.6 4931.4 4492.5 4494.3 4496.4 4521.0 4524.9 3583.5 3652.0 3657.4 3657.4 3670.6 1158.5 1164.7 1171.3 1174.4 1177.6 1063.4 1067.9 1113.9 1247.2 1352.1 7284.7 7285.6 7378.4 7403.8 7410.4 1106.3 1110.9 1118.7 1129.3 1135.8 5666.9 5686.3 5698.8 5717.7 5728.6 9688.3 9731.4 9943.6 10036.2 10103.3 9666.3 9728.1 9743.4 9844.2 9873.5 7236.4 7492.1 7503.8 7507.7 7705.7 7290.5 7303.4 7362.0 7376.0 7428.1 8618.8 8803.2 8865.1 8899.6 8909.9 8836.4 8853.2 8928.0 8935.0 8938.3 7771.8 7784.9 7858.8 7876.8 7892.6 7853.4 7935.3 7985.2 7989.3 8041.8 7218.1 7455.3 7479.6 7523.0 7662.1 7030.0 7124.2 7133.2 7185.4 7218.3 7133.5 7136.1 7155.0 7156.9 7206.5 6639.4 6677.6 6681.4 6700.3 6730.0 6533.5 6607.0 6671.6 6687.9 6701.9 11:27:01 INFO - 2016-01-21 11:27:01,862 DEBUG : BROWSER_OUTPUT: 11:27:01 INFO - 2016-01-21 11:27:01,862 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5733.35 Median:6448.08 stddev:1764.23 (27.4%) stddev-sans-first:1722.31 11:27:01 INFO - 2016-01-21 11:27:01,862 DEBUG : BROWSER_OUTPUT: Values: 350.8 354.3 355.8 360.5 362.7 6397.6 6474.6 6487.3 6497.6 6499.0 6302.1 6440.2 6447.5 6448.2 6464.7 4904.9 4933.8 4937.1 4942.2 4944.7 4953.2 4953.2 4954.6 4954.9 4967.0 4680.2 4738.4 4754.3 4758.2 4776.3 4755.3 4762.0 4762.6 4768.5 4810.2 4130.6 4138.2 4143.7 4147.1 4148.1 6035.4 6118.8 6127.5 6133.9 6147.4 5600.5 5606.5 5621.2 5621.2 5621.4 6757.6 6807.7 6812.2 6813.1 6816.8 4570.5 4604.1 4604.3 4614.1 4628.9 6963.0 7018.5 7117.4 7121.2 7135.1 4823.7 4830.0 4830.1 4830.6 4831.6 4878.0 4890.4 4890.9 4895.0 4898.6 5572.6 5689.9 5694.3 5699.3 5707.3 6857.8 6882.7 6884.1 6892.2 6909.3 1619.7 1639.1 1698.6 1732.1 1736.4 1131.4 1138.1 1142.5 1146.1 1152.6 6363.9 6404.9 6437.2 6448.0 6460.9 6966.9 6979.3 6981.2 7002.5 7016.5 6404.7 6412.9 6447.7 6451.6 6471.5 3870.2 3913.4 3915.7 3915.9 3923.4 7427.2 7433.8 7438.8 7442.6 7450.1 7134.8 7398.8 7405.2 7410.9 7414.7 7418.4 7446.9 7466.3 7467.4 7475.0 7226.7 7231.3 7235.2 7240.8 7243.7 6997.5 7066.2 7143.9 7145.2 7156.9 7386.7 7402.3 7408.4 7417.6 7429.1 4799.7 4810.7 4863.4 4870.9 4881.0 7055.7 7118.8 7191.9 7193.3 7223.1 6927.3 6960.1 6974.8 6997.5 7028.8 6934.4 6968.2 6969.2 6975.1 6977.0 6714.2 6782.7 6862.6 6877.1 6877.2 6944.8 6957.1 6982.8 6997.3 7019.0 6668.7 6784.4 6835.0 6858.7 6863.3 11:27:01 INFO - 2016-01-21 11:27:01,862 DEBUG : BROWSER_OUTPUT: 11:27:01 INFO - 2016-01-21 11:27:01,862 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14405.41 Median:25363.34 stddev:16693.92 (65.8%) stddev-sans-first:16709.40 11:27:01 INFO - 2016-01-21 11:27:01,862 DEBUG : BROWSER_OUTPUT: Values: 781.3 795.7 801.3 805.8 829.2 13976.6 14328.2 14340.5 14358.5 14378.6 12991.8 13107.0 13120.1 13168.5 13599.5 840.3 843.6 846.2 849.0 853.6 853.8 854.9 855.5 860.1 860.3 892.6 898.5 900.1 902.6 903.4 876.7 887.7 890.7 896.5 897.2 646.5 649.8 650.5 651.1 652.3 14104.5 14107.5 14201.6 14202.6 14236.4 12300.3 12433.9 12984.1 13057.2 13295.3 11336.1 11546.9 11736.1 11836.0 11858.9 3735.1 3763.0 3797.2 3807.8 3816.0 48668.5 48809.5 49165.3 49315.0 49531.0 10008.1 10142.9 10163.7 10193.8 10470.7 17544.6 19072.2 19220.2 19265.5 19267.2 7749.7 7768.3 7793.3 7950.2 8045.4 4556.0 4596.7 4632.4 4703.4 4718.5 3303.6 3330.5 3396.8 3509.7 3510.6 635.1 641.4 649.5 652.7 660.6 638.8 675.8 720.9 726.5 743.6 9305.6 9584.1 9630.4 9654.4 9683.3 515.7 574.9 594.8 641.9 662.0 4180.4 4201.2 4315.7 4328.2 4392.1 56746.7 65355.7 65703.7 66330.7 66751.3 50777.5 51106.2 51937.0 52214.5 52853.0 46094.3 47261.0 47277.1 48010.0 48785.3 9230.6 9264.9 9271.8 9503.4 9625.9 35753.0 35802.3 36590.8 36708.8 36953.3 41112.4 46639.0 46774.1 46893.3 47171.3 10122.4 10554.3 11232.6 11268.5 11323.7 11940.9 12109.6 12185.9 12475.4 12607.1 11895.1 11996.7 12156.8 12287.4 12404.9 11670.4 11695.2 11712.7 11864.9 12120.1 10558.6 11375.8 11381.0 11834.2 12257.4 9421.8 9950.4 10587.5 10683.7 10973.8 9637.7 10008.7 10108.2 10184.6 10221.4 11:27:01 INFO - 2016-01-21 11:27:01,862 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:27:01 INFO - 2016-01-21 11:27:01,862 DEBUG : BROWSER_OUTPUT: 11:27:02 INFO - 2016-01-21 11:27:02,537 INFO : Browser exited with error code: 0 11:27:02 INFO - 2016-01-21 11:27:02,556 INFO : Completed test dromaeo_css (00:18:29) 11:27:02 INFO - 2016-01-21 11:27:02,556 INFO : Starting test kraken 11:27:02 INFO - 2016-01-21 11:27:02,556 DEBUG : operating with platform_type : linux_ 11:27:02 INFO - 2016-01-21 11:27:02,556 INFO : Initialising browser for kraken test... 11:27:02 INFO - 2016-01-21 11:27:02,563 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOyH8zQ/profile http://localhost:47296/getInfo.html 11:27:06 INFO - 2016-01-21 11:27:06,337 DEBUG : BROWSER_OUTPUT: 11:27:06 INFO - 2016-01-21 11:27:06,337 DEBUG : BROWSER_OUTPUT: (process:23642): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:27:07 INFO - 2016-01-21 11:27:07,286 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:27:07 INFO - 2016-01-21 11:27:07,286 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:27:07 INFO - 2016-01-21 11:27:07,286 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:27:07 INFO - 2016-01-21 11:27:07,286 DEBUG : BROWSER_OUTPUT: __metrics 11:27:08 INFO - 2016-01-21 11:27:08,341 INFO : Browser initialized. 11:27:08 INFO - 2016-01-21 11:27:08,342 INFO : Running cycle 1/1 for kraken test... 11:27:08 INFO - 2016-01-21 11:27:08,342 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOyH8zQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:27:09 INFO - 2016-01-21 11:27:09,659 DEBUG : BROWSER_OUTPUT: 11:27:09 INFO - 2016-01-21 11:27:09,659 DEBUG : BROWSER_OUTPUT: (process:23754): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:27:20 INFO - 2016-01-21 11:27:20,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 137375744 11:27:20 INFO - 2016-01-21 11:27:20,164 DEBUG : BROWSER_OUTPUT: 11:27:22 INFO - 2016-01-21 11:27:22,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47296/tests/kraken/driver.html?testName=audio-beat-detection) 11:27:23 INFO - 2016-01-21 11:27:23,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 139198464 11:27:23 INFO - 2016-01-21 11:27:23,206 DEBUG : BROWSER_OUTPUT: 11:27:25 INFO - 2016-01-21 11:27:25,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47296/tests/kraken/driver.html?testName=audio-dft) 11:27:26 INFO - 2016-01-21 11:27:26,382 DEBUG : BROWSER_OUTPUT: RSS: Main: 138100736 11:27:26 INFO - 2016-01-21 11:27:26,383 DEBUG : BROWSER_OUTPUT: 11:27:29 INFO - 2016-01-21 11:27:29,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47296/tests/kraken/driver.html?testName=audio-fft) 11:27:29 INFO - 2016-01-21 11:27:29,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 138964992 11:27:29 INFO - 2016-01-21 11:27:29,796 DEBUG : BROWSER_OUTPUT: 11:27:31 INFO - 2016-01-21 11:27:31,793 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47296/tests/kraken/driver.html?testName=audio-oscillator) 11:27:32 INFO - 2016-01-21 11:27:32,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 139710464 11:27:32 INFO - 2016-01-21 11:27:32,380 DEBUG : BROWSER_OUTPUT: 11:27:34 INFO - 2016-01-21 11:27:34,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:27:35 INFO - 2016-01-21 11:27:35,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 140238848 11:27:35 INFO - 2016-01-21 11:27:35,140 DEBUG : BROWSER_OUTPUT: 11:27:38 INFO - 2016-01-21 11:27:38,046 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47296/tests/kraken/driver.html?testName=imaging-darkroom) 11:27:38 INFO - 2016-01-21 11:27:38,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 138190848 11:27:38 INFO - 2016-01-21 11:27:38,632 DEBUG : BROWSER_OUTPUT: 11:27:41 INFO - 2016-01-21 11:27:41,958 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47296/tests/kraken/driver.html?testName=imaging-desaturate) 11:27:42 INFO - 2016-01-21 11:27:42,545 DEBUG : BROWSER_OUTPUT: RSS: Main: 138178560 11:27:42 INFO - 2016-01-21 11:27:42,546 DEBUG : BROWSER_OUTPUT: 11:27:45 INFO - 2016-01-21 11:27:45,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47296/tests/kraken/driver.html?testName=json-parse-financial) 11:27:45 INFO - 2016-01-21 11:27:45,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 138919936 11:27:45 INFO - 2016-01-21 11:27:45,970 DEBUG : BROWSER_OUTPUT: 11:27:47 INFO - 2016-01-21 11:27:47,527 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:27:48 INFO - 2016-01-21 11:27:48,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 139661312 11:27:48 INFO - 2016-01-21 11:27:48,109 DEBUG : BROWSER_OUTPUT: 11:27:49 INFO - 2016-01-21 11:27:49,860 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:27:50 INFO - 2016-01-21 11:27:50,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 138948608 11:27:50 INFO - 2016-01-21 11:27:50,467 DEBUG : BROWSER_OUTPUT: 11:27:52 INFO - 2016-01-21 11:27:52,504 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:27:53 INFO - 2016-01-21 11:27:53,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 138964992 11:27:53 INFO - 2016-01-21 11:27:53,091 DEBUG : BROWSER_OUTPUT: 11:27:55 INFO - 2016-01-21 11:27:55,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:27:56 INFO - 2016-01-21 11:27:56,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 138948608 11:27:56 INFO - 2016-01-21 11:27:56,100 DEBUG : BROWSER_OUTPUT: 11:27:58 INFO - 2016-01-21 11:27:58,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:27:59 INFO - 2016-01-21 11:27:59,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 139624448 11:27:59 INFO - 2016-01-21 11:27:59,194 DEBUG : BROWSER_OUTPUT: 11:28:00 INFO - 2016-01-21 11:28:00,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47296/tests/kraken/driver.html?testName=ai-astar) 11:28:01 INFO - 2016-01-21 11:28:01,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 139399168 11:28:01 INFO - 2016-01-21 11:28:01,119 DEBUG : BROWSER_OUTPUT: 11:28:01 INFO - 2016-01-21 11:28:01,120 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:28:01 INFO - 2016-01-21 11:28:01,120 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:28:01 INFO - 2016-01-21 11:28:01,120 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:28:01 INFO - 2016-01-21 11:28:01,121 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:28:01 INFO - 2016-01-21 11:28:01,121 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;106;111;110;111;119;109;109;110;108 11:28:01 INFO - 2016-01-21 11:28:01,121 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;122;150;164;123;147;153;123;159;123 11:28:01 INFO - 2016-01-21 11:28:01,121 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;162;165;162;163;160;162;164;162 11:28:01 INFO - 2016-01-21 11:28:01,121 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;78;72;155;71;71;72;71;155;72 11:28:01 INFO - 2016-01-21 11:28:01,121 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;135;93;94;93;131;92;94;134 11:28:01 INFO - 2016-01-21 11:28:01,121 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;109;110 11:28:01 INFO - 2016-01-21 11:28:01,121 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;147;146;147;147;147;147;146;147 11:28:01 INFO - 2016-01-21 11:28:01,121 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;96;96;95;97;96;95 11:28:01 INFO - 2016-01-21 11:28:01,121 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;59;60;61;62;59;62;60;57 11:28:01 INFO - 2016-01-21 11:28:01,121 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;64;64;65;65;65;64;64;66;65 11:28:01 INFO - 2016-01-21 11:28:01,121 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;82;81;85;82;81;82;89;81 11:28:01 INFO - 2016-01-21 11:28:01,121 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;124;115;123;119;115;113;115;119;114 11:28:01 INFO - 2016-01-21 11:28:01,121 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;144;142;149;144;136;147;145;143;143 11:28:01 INFO - 2016-01-21 11:28:01,122 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;65;64;69;65;66;66;67;65;68 11:28:01 INFO - 2016-01-21 11:28:01,122 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:28:01 INFO - 2016-01-21 11:28:01,122 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:28:01 INFO - 2016-01-21 11:28:01,122 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,695 11:28:01 INFO - 2016-01-21 11:28:01,122 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:28:01 INFO - 2016-01-21 11:28:01,122 DEBUG : BROWSER_OUTPUT: __startTimestamp1453404481118__endTimestamp 11:28:01 INFO - 2016-01-21 11:28:01,122 DEBUG : BROWSER_OUTPUT: 11:28:01 INFO - 2016-01-21 11:28:01,125 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:28:01 INFO - 2016-01-21 11:28:01,125 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:28:01 INFO - 2016-01-21 11:28:01,126 DEBUG : BROWSER_OUTPUT: 11:28:01 INFO - 2016-01-21 11:28:01,126 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.30 Median:110.00 stddev:3.40 (3.1%) stddev-sans-first:3.61 11:28:01 INFO - 2016-01-21 11:28:01,126 DEBUG : BROWSER_OUTPUT: Values: 110.0 106.0 111.0 110.0 111.0 119.0 109.0 109.0 110.0 108.0 11:28:01 INFO - 2016-01-21 11:28:01,126 DEBUG : BROWSER_OUTPUT: 11:28:01 INFO - 2016-01-21 11:28:01,127 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.10 Median:148.50 stddev:16.61 (11.2%) stddev-sans-first:17.48 11:28:01 INFO - 2016-01-21 11:28:01,127 DEBUG : BROWSER_OUTPUT: Values: 147.0 122.0 150.0 164.0 123.0 147.0 153.0 123.0 159.0 123.0 11:28:01 INFO - 2016-01-21 11:28:01,127 DEBUG : BROWSER_OUTPUT: 11:28:01 INFO - 2016-01-21 11:28:01,127 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:1.35 (0.8%) stddev-sans-first:1.42 11:28:01 INFO - 2016-01-21 11:28:01,128 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 162.0 165.0 162.0 163.0 160.0 162.0 164.0 162.0 11:28:01 INFO - 2016-01-21 11:28:01,128 DEBUG : BROWSER_OUTPUT: 11:28:01 INFO - 2016-01-21 11:28:01,128 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.90 Median:72.00 stddev:34.90 (48.5%) stddev-sans-first:36.48 11:28:01 INFO - 2016-01-21 11:28:01,128 DEBUG : BROWSER_OUTPUT: Values: 72.0 78.0 72.0 155.0 71.0 71.0 72.0 71.0 155.0 72.0 11:28:01 INFO - 2016-01-21 11:28:01,128 DEBUG : BROWSER_OUTPUT: 11:28:01 INFO - 2016-01-21 11:28:01,129 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.30 Median:93.00 stddev:19.38 (20.8%) stddev-sans-first:20.04 11:28:01 INFO - 2016-01-21 11:28:01,129 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 135.0 93.0 94.0 93.0 131.0 92.0 94.0 134.0 11:28:01 INFO - 2016-01-21 11:28:01,129 DEBUG : BROWSER_OUTPUT: 11:28:01 INFO - 2016-01-21 11:28:01,129 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:28:01 INFO - 2016-01-21 11:28:01,130 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 11:28:01 INFO - 2016-01-21 11:28:01,130 DEBUG : BROWSER_OUTPUT: 11:28:01 INFO - 2016-01-21 11:28:01,130 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 11:28:01 INFO - 2016-01-21 11:28:01,130 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 147.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 11:28:01 INFO - 2016-01-21 11:28:01,131 DEBUG : BROWSER_OUTPUT: 11:28:01 INFO - 2016-01-21 11:28:01,131 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 11:28:01 INFO - 2016-01-21 11:28:01,131 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 96.0 96.0 95.0 97.0 96.0 95.0 11:28:01 INFO - 2016-01-21 11:28:01,131 DEBUG : BROWSER_OUTPUT: 11:28:01 INFO - 2016-01-21 11:28:01,131 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.80 Median:60.00 stddev:1.55 (2.6%) stddev-sans-first:1.62 11:28:01 INFO - 2016-01-21 11:28:01,132 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 59.0 60.0 61.0 62.0 59.0 62.0 60.0 57.0 11:28:01 INFO - 2016-01-21 11:28:01,132 DEBUG : BROWSER_OUTPUT: 11:28:01 INFO - 2016-01-21 11:28:01,132 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 11:28:01 INFO - 2016-01-21 11:28:01,132 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 64.0 65.0 65.0 65.0 64.0 64.0 66.0 65.0 11:28:01 INFO - 2016-01-21 11:28:01,133 DEBUG : BROWSER_OUTPUT: 11:28:01 INFO - 2016-01-21 11:28:01,133 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:2.55 (3.1%) stddev-sans-first:2.64 11:28:01 INFO - 2016-01-21 11:28:01,133 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 82.0 81.0 85.0 82.0 81.0 82.0 89.0 81.0 11:28:01 INFO - 2016-01-21 11:28:01,133 DEBUG : BROWSER_OUTPUT: 11:28:01 INFO - 2016-01-21 11:28:01,133 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:119.00 stddev:5.48 (4.6%) stddev-sans-first:4.00 11:28:01 INFO - 2016-01-21 11:28:01,133 DEBUG : BROWSER_OUTPUT: Values: 130.0 124.0 115.0 123.0 119.0 115.0 113.0 115.0 119.0 114.0 11:28:01 INFO - 2016-01-21 11:28:01,133 DEBUG : BROWSER_OUTPUT: 11:28:01 INFO - 2016-01-21 11:28:01,134 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.40 Median:144.50 stddev:4.12 (2.8%) stddev-sans-first:3.61 11:28:01 INFO - 2016-01-21 11:28:01,134 DEBUG : BROWSER_OUTPUT: Values: 151.0 144.0 142.0 149.0 144.0 136.0 147.0 145.0 143.0 143.0 11:28:01 INFO - 2016-01-21 11:28:01,134 DEBUG : BROWSER_OUTPUT: 11:28:01 INFO - 2016-01-21 11:28:01,134 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.56 (2.4%) stddev-sans-first:1.62 11:28:01 INFO - 2016-01-21 11:28:01,134 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 64.0 69.0 65.0 66.0 66.0 67.0 65.0 68.0 11:28:01 INFO - 2016-01-21 11:28:01,134 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:28:01 INFO - 2016-01-21 11:28:01,134 DEBUG : BROWSER_OUTPUT: 11:28:02 INFO - 2016-01-21 11:28:02,001 INFO : Browser exited with error code: 0 11:28:02 INFO - 2016-01-21 11:28:02,050 INFO : Completed test kraken (00:00:59) 11:28:02 INFO - 2016-01-21 11:28:02,050 INFO : Starting test v8_7 11:28:02 INFO - 2016-01-21 11:28:02,050 DEBUG : operating with platform_type : linux_ 11:28:02 INFO - 2016-01-21 11:28:02,050 INFO : Initialising browser for v8_7 test... 11:28:02 INFO - 2016-01-21 11:28:02,056 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOVWs84/profile http://localhost:47296/getInfo.html 11:28:05 INFO - 2016-01-21 11:28:05,842 DEBUG : BROWSER_OUTPUT: 11:28:05 INFO - 2016-01-21 11:28:05,843 DEBUG : BROWSER_OUTPUT: (process:24060): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:28:06 INFO - 2016-01-21 11:28:06,806 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:28:06 INFO - 2016-01-21 11:28:06,807 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:28:06 INFO - 2016-01-21 11:28:06,807 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:28:06 INFO - 2016-01-21 11:28:06,807 DEBUG : BROWSER_OUTPUT: __metrics 11:28:07 INFO - 2016-01-21 11:28:07,841 INFO : Browser initialized. 11:28:07 INFO - 2016-01-21 11:28:07,842 INFO : Running cycle 1/1 for v8_7 test... 11:28:07 INFO - 2016-01-21 11:28:07,842 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOVWs84/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:28:09 INFO - 2016-01-21 11:28:09,133 DEBUG : BROWSER_OUTPUT: 11:28:09 INFO - 2016-01-21 11:28:09,133 DEBUG : BROWSER_OUTPUT: (process:24173): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:28:19 INFO - 2016-01-21 11:28:19,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 136491008 11:28:19 INFO - 2016-01-21 11:28:19,630 DEBUG : BROWSER_OUTPUT: 11:28:40 INFO - 2016-01-21 11:28:40,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47296/tests/v8_7/run.html (next: http://localhost:47296/tests/v8_7/run.html) 11:28:41 INFO - 2016-01-21 11:28:41,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 136462336 11:28:41 INFO - 2016-01-21 11:28:41,235 DEBUG : BROWSER_OUTPUT: 11:28:41 INFO - 2016-01-21 11:28:41,235 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:28:41 INFO - 2016-01-21 11:28:41,235 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:28:41 INFO - 2016-01-21 11:28:41,235 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:28:41 INFO - 2016-01-21 11:28:41,236 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:28:41 INFO - 2016-01-21 11:28:41,236 DEBUG : BROWSER_OUTPUT: |0;Richards;164.50074025333114 11:28:41 INFO - 2016-01-21 11:28:41,236 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.07026652821045 11:28:41 INFO - 2016-01-21 11:28:41,236 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.473962684489 11:28:41 INFO - 2016-01-21 11:28:41,237 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 11:28:41 INFO - 2016-01-21 11:28:41,237 DEBUG : BROWSER_OUTPUT: |4;RayTrace;924.2144177449168 11:28:41 INFO - 2016-01-21 11:28:41,237 DEBUG : BROWSER_OUTPUT: |5;Earley;549.1488193300385 11:28:41 INFO - 2016-01-21 11:28:41,237 DEBUG : BROWSER_OUTPUT: |6;Boyer;10621.052631578947 11:28:41 INFO - 2016-01-21 11:28:41,237 DEBUG : BROWSER_OUTPUT: |7;RegExp;24512.19512195122 11:28:41 INFO - 2016-01-21 11:28:41,237 DEBUG : BROWSER_OUTPUT: |8;Splay;524.1090146750524 11:28:41 INFO - 2016-01-21 11:28:41,237 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 11:28:41 INFO - 2016-01-21 11:28:41,238 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:28:41 INFO - 2016-01-21 11:28:41,238 DEBUG : BROWSER_OUTPUT: __startTimestamp1453404521232__endTimestamp 11:28:41 INFO - 2016-01-21 11:28:41,238 DEBUG : BROWSER_OUTPUT: 11:28:41 INFO - 2016-01-21 11:28:41,238 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:28:41 INFO - 2016-01-21 11:28:41,239 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:28:41 INFO - 2016-01-21 11:28:41,239 DEBUG : BROWSER_OUTPUT: 11:28:41 INFO - 2016-01-21 11:28:41,239 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.50 Median:164.50 stddev:0.00 (0.0%) 11:28:41 INFO - 2016-01-21 11:28:41,240 DEBUG : BROWSER_OUTPUT: Values: 164.5 11:28:41 INFO - 2016-01-21 11:28:41,240 DEBUG : BROWSER_OUTPUT: 11:28:41 INFO - 2016-01-21 11:28:41,240 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.07 Median:173.07 stddev:0.00 (0.0%) 11:28:41 INFO - 2016-01-21 11:28:41,240 DEBUG : BROWSER_OUTPUT: Values: 173.1 11:28:41 INFO - 2016-01-21 11:28:41,241 DEBUG : BROWSER_OUTPUT: 11:28:41 INFO - 2016-01-21 11:28:41,241 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 11:28:41 INFO - 2016-01-21 11:28:41,241 DEBUG : BROWSER_OUTPUT: Values: 278.5 11:28:41 INFO - 2016-01-21 11:28:41,241 DEBUG : BROWSER_OUTPUT: 11:28:41 INFO - 2016-01-21 11:28:41,242 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 11:28:41 INFO - 2016-01-21 11:28:41,242 DEBUG : BROWSER_OUTPUT: Values: 5186.5 11:28:41 INFO - 2016-01-21 11:28:41,242 DEBUG : BROWSER_OUTPUT: 11:28:41 INFO - 2016-01-21 11:28:41,244 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:924.21 Median:924.21 stddev:0.00 (0.0%) 11:28:41 INFO - 2016-01-21 11:28:41,244 DEBUG : BROWSER_OUTPUT: Values: 924.2 11:28:41 INFO - 2016-01-21 11:28:41,244 DEBUG : BROWSER_OUTPUT: 11:28:41 INFO - 2016-01-21 11:28:41,244 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:549.15 Median:549.15 stddev:0.00 (0.0%) 11:28:41 INFO - 2016-01-21 11:28:41,245 DEBUG : BROWSER_OUTPUT: Values: 549.1 11:28:41 INFO - 2016-01-21 11:28:41,245 DEBUG : BROWSER_OUTPUT: 11:28:41 INFO - 2016-01-21 11:28:41,245 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10621.05 Median:10621.05 stddev:0.00 (0.0%) 11:28:41 INFO - 2016-01-21 11:28:41,245 DEBUG : BROWSER_OUTPUT: Values: 10621.1 11:28:41 INFO - 2016-01-21 11:28:41,245 DEBUG : BROWSER_OUTPUT: 11:28:41 INFO - 2016-01-21 11:28:41,246 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24512.20 Median:24512.20 stddev:0.00 (0.0%) 11:28:41 INFO - 2016-01-21 11:28:41,246 DEBUG : BROWSER_OUTPUT: Values: 24512.2 11:28:41 INFO - 2016-01-21 11:28:41,246 DEBUG : BROWSER_OUTPUT: 11:28:41 INFO - 2016-01-21 11:28:41,246 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:524.11 Median:524.11 stddev:0.00 (0.0%) 11:28:41 INFO - 2016-01-21 11:28:41,247 DEBUG : BROWSER_OUTPUT: Values: 524.1 11:28:41 INFO - 2016-01-21 11:28:41,247 DEBUG : BROWSER_OUTPUT: 11:28:41 INFO - 2016-01-21 11:28:41,247 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 11:28:41 INFO - 2016-01-21 11:28:41,247 DEBUG : BROWSER_OUTPUT: Values: 4840.6 11:28:41 INFO - 2016-01-21 11:28:41,247 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:28:41 INFO - 2016-01-21 11:28:41,248 DEBUG : BROWSER_OUTPUT: 11:28:42 INFO - 2016-01-21 11:28:42,065 INFO : Browser exited with error code: 0 11:28:42 INFO - 2016-01-21 11:28:42,080 INFO : Completed test v8_7 (00:00:40) 11:28:42 INFO - 2016-01-21 11:28:42,278 INFO : Completed test suite (00:20:09) 11:28:42 INFO - 2016-01-21 11:28:42,278 DEBUG : Working with test: dromaeo_css 11:28:42 INFO - 2016-01-21 11:28:42,278 DEBUG : Generating results file: dromaeo_css 11:28:42 INFO - 2016-01-21 11:28:42,279 DEBUG : Working with test: kraken 11:28:42 INFO - 2016-01-21 11:28:42,279 DEBUG : Generating results file: kraken 11:28:42 INFO - 2016-01-21 11:28:42,279 INFO : javascript benchmark 11:28:42 INFO - 2016-01-21 11:28:42,280 DEBUG : Working with test: v8_7 11:28:42 INFO - 2016-01-21 11:28:42,280 DEBUG : Generating results file: v8_7 11:28:42 INFO - 2016-01-21 11:28:42,280 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:28:42 INFO - 2016-01-21 11:28:42,334 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 11:28:42 INFO - 2016-01-21 11:28:42,334 DEBUG : process_Request line: dromaeo_css 7284.53 graph.html#tests=[[72,52,43]] 11:28:42 INFO - 2016-01-21 11:28:42,334 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:28:42 INFO - 2016-01-21 11:28:42,362 DEBUG : process_Request line: kraken 1496.80 graph.html#tests=[[232,52,43]] 11:28:42 INFO - 2016-01-21 11:28:42,363 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:28:42 INFO - 2016-01-21 11:28:42,396 DEBUG : process_Request line: v8_7 23199.19 graph.html#tests=[[230,52,43]] 11:28:42 INFO - 2016-01-21 11:28:42,397 INFO : javascript benchmark 11:28:42 INFO - 2016-01-21 11:28:42,401 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3317.3033662930784, 3391.13526050857, 3405.965940340596, 3424.2466657335394, 3432.9313413731734, 5586.301712285965, 5606.607537472369, 5613.831585052455, 5640.830775076754, 5670.71646417679, 5546.946080244751, 5627.2684551008415, 5644.774209031634, 5662.178984047321, 5678.829635110943, 5097.847064588068, 5131.666441681297, 5143.4599367066485, 5214.66104703195, 5224.033553792541, 4996.350474438318, 5064.442911279774, 5156.175011998081, 5158.174692049273, 5171.689698618076, 5026.97486512567, 5067.442581316052, 5089.720065396402, 5090.363704536933, 5097.872553186182, 5170.379554453452, 5181.4248168763625, 5190.247414124969, 5206.843794686166, 5238.816641417551, 4967.552920237196, 5028.396592408898, 5086.1353569892835, 5118.053160165344, 5149.48505149482, 5426.457354264581, 5442.510174084312, 5471.781128754845, 5491.890162196773, 5497.202905578669, 6015.879682406327, 6043.305019922721, 6068.241469816273, 6080.935836228642, 6113.052476866093, 5924.7333869975955, 5993.8801223975715, 6057.636541807506, 6106.938930610681, 6125.264968203844, 5552.222688823568, 5730.4269573042775, 5744.971275143639, 5748.367679555246, 5758.021136406821, 6150.477209437158, 6191.1641928339095, 6200.472959798468, 6215.564910456224, 6223.159873417031, 5744.454276843693, 5802.274715660543, 5877.471027607536, 5910.054391297458, 5933.465988061009, 6112.419320164578, 6131.540134489931, 6150.415710507495, 6152.107944348045, 6175.3824617538785, 5746.0, 6071.210742603434, 6120.785772497941, 6124.938750612437, 6128.908066379008, 5700.458456446631, 5841.88316233673, 5845.795397161164, 5929.762809487572, 6071.605345652519, 4644.7213167210075, 4671.416072990876, 4673.135469938073, 4679.836205732783, 4686.062787442525, 4171.186618609342, 4199.0342221289275, 4204.894877628084, 4208.810603522848, 4230.873073807729, 5470.863228419242, 5505.394406615269, 5564.749586268627, 5565.387807341189, 5567.526760225345, 5969.641821490724, 5975.312839023481, 6159.630422174684, 6169.383061693795, 6194.783182588678, 5714.657120572779, 5790.305163380337, 5803.332616749043, 5812.244408226903, 5826.417358264224, 5057.873553161126, 5131.640785145079, 5254.15933450646, 5260.973695131576, 5359.035373632705, 6149.877002460015, 6210.596311239755, 6212.0371342441995, 6219.253689557192, 6249.875002499924, 6058.878822423439, 6113.969430152821, 6128.142060111677, 6132.448079672851, 6134.938650613615, 5920.437558431942, 5981.1028345746745, 6067.726952287069, 6097.664628445301, 6233.314335423009, 5864.06175011996, 6015.488683461955, 6033.939660603513, 6038.849028774316, 6046.395360464095, 6090.817275481742, 6092.847678808065, 6141.631502109888, 6153.138560601609, 6168.0, 5734.942650573441, 5752.137179422953, 5833.4749872511675, 5834.679092649945, 5848.473637372486, 5829.09649004405, 5964.343922168471, 5983.7008149591475, 6018.699065046642, 6024.096385542204, 5875.94124058771, 5878.088896221093, 5925.348211696623, 5933.525317974465, 5939.940600593939, 5613.859653508532, 5694.886102278014, 5704.942950570441, 5733.913991290051, 5734.254546908875, 5772.884542309214, 5781.161731548817, 5815.505682017076, 5818.214541036906, 5841.036229022334], "unit": "ms", "name": "dojo.html", "value": 5562.175305200549}, {"lowerIsBetter": false, "replicates": [559.1724248112793, 595.9374265702102, 602.0126991733558, 657.8026592022395, 677.3565113142516, 39712.60287397125, 41266.0, 41273.793631031804, 41348.0, 41473.79263103688, 40030.7998460008, 40452.0, 40543.0, 40626.0, 40696.38955415671, 9017.45895246284, 9152.679656212034, 9176.17414432701, 9177.816443671123, 9204.309676774268, 8921.598528066253, 8997.280217582578, 9032.367734258605, 9049.95475022624, 9068.546572671374, 8925.687600933968, 8937.106289371044, 8951.373403861733, 8964.103589641049, 8985.95507022464, 8945.373823832302, 8947.910520894806, 9020.278377729832, 9023.05257947916, 9025.593848276843, 8859.379843410963, 8931.419457735226, 8951.836261285991, 9005.594748236344, 9020.0, 41033.17933641341, 41243.58756412457, 41422.58577414217, 41484.0, 41512.37731434031, 3299.4226010448315, 3344.5150453184397, 3356.580427446569, 3370.8146051967133, 3436.1409647588102, 31162.799928553064, 31177.532337014964, 31397.37205255882, 31589.526157107663, 31986.200344991328, 4251.44731184944, 4279.465066866642, 4325.264705000126, 4340.826366945318, 4349.7825108744755, 286682.0, 287183.5640821803, 288538.0, 288865.0, 290634.0, 58326.7083664579, 58757.11864322038, 59014.70492647509, 59103.408965910654, 59208.7039564808, 63008.0, 63172.0, 63193.368066319665, 63300.05049924255, 63386.0, 14000.229987350589, 14696.338664760111, 14803.92598037003, 14822.407103715947, 14833.18417487027, 10345.948270258601, 10353.792924141475, 10362.119219866245, 10364.689059328231, 10373.066424021874, 19664.115114819866, 19840.206391744458, 19860.0, 19926.103325350396, 20077.0, 7923.286904178536, 8043.1554686757045, 8078.151794061657, 8149.592520373958, 8185.631646575918, 1030.1552726763982, 1037.2479952034864, 1046.3303485769113, 1077.2836064017497, 1115.9892084540356, 28261.173882611987, 28404.43191136166, 28867.566986495218, 29096.563551546744, 29423.0, 1067.604986155112, 1077.3966578715945, 1087.2715280761909, 1094.6059418609295, 1109.8314312637465, 14158.362873670709, 14206.431742730176, 14241.21984751906, 14257.572272831832, 14493.78259326111, 471125.0, 476719.0, 502650.0, 502916.0, 508503.0, 56389.43610563924, 57768.422315776304, 57868.13197802036, 57922.7103864478, 58697.70651146717, 1378.8965827562972, 1385.6743665238862, 1386.2098603795941, 1416.4759039155786, 1428.5357258890901, 29819.3220845158, 29917.0, 30500.0, 31127.221819454695, 31319.21701957469, 46768.298475523574, 47011.764941175075, 47373.28940065833, 47398.763006184745, 47525.52474475211, 328648.0, 331462.0, 331630.0, 333864.0, 334191.0, 33586.49620255649, 33903.0, 33914.49128263029, 34217.144571385914, 46595.0, 45703.085938281714, 46117.0, 46209.30686039645, 46464.53535464602, 46536.76731616456, 38666.0, 38788.224235514564, 40145.59854401535, 40871.0, 41108.177836443705, 39952.2009559813, 40209.1958160841, 40636.390454142624, 40718.0, 40927.38608920928, 39184.0, 41130.38304425496, 41435.7928210357, 41560.584394155674, 42061.78969105135, 31294.68705312918, 32798.18004549905, 33131.0, 33230.5015424764, 33262.50106248457, 27444.862775686794, 27893.44213115767, 28116.702962321997, 28803.0, 28842.71157288484], "unit": "ms", "name": "ext.html", "value": 19509.71719081629}, {"lowerIsBetter": false, "replicates": [381.8892521168861, 382.8028565288877, 385.85337571722744, 386.23139951496523, 386.95936926622704, 15848.683026339466, 16862.39807218312, 17352.56618584536, 17677.1161441928, 17718.46844594661, 12189.573364932228, 12211.38943052846, 12257.816132758016, 13158.407871645775, 16658.916705416486, 5216.087184742674, 5246.291750613656, 5284.867878303054, 5287.471252874701, 5287.947120528803, 5243.947560524403, 5283.656562323436, 5330.600204984622, 5331.493508116722, 5337.5196232339085, 5180.430152683201, 5217.634765566412, 5311.256424100629, 5409.648372855751, 5415.620906536544, 4454.265046267362, 5413.0, 5442.755076021569, 5456.863578410552, 6138.785142520035, 5523.143912693539, 5529.585281103893, 5545.445455454463, 5554.805581804618, 5570.275864137636, 19498.0, 19571.608567828705, 19703.704444433344, 20079.598408031903, 20117.79882201174, 2189.5839790439763, 2195.034184958629, 2205.867647941129, 2220.322801545528, 2241.237979087118, 9663.323567350288, 10040.29717919746, 10545.683629491128, 13002.414891329818, 14132.293385330693, 1920.1263425141526, 1933.236371633211, 1984.642764302425, 1990.8407327413772, 1998.6402447559433, 63989.3601063988, 65783.67108164428, 66141.66929165323, 66535.0, 67170.66414667896, 10652.414117223472, 10773.299735517166, 10783.622573210057, 10880.075193608633, 10962.068224200873, 13938.163710177421, 14032.579022629337, 14091.436342546389, 14171.574852754435, 14218.075825071337, 7476.102867655916, 7477.252274772479, 7549.3583045440655, 7551.697932082765, 7613.124490683532, 7095.361417472453, 7161.212266650664, 7187.065681461377, 7241.167265764505, 7361.227071157451, 4727.929081063787, 4754.120487709784, 4760.285957106462, 4771.761411929459, 4792.353032340659, 1874.9718754218698, 1905.4283714885478, 1940.4178746376313, 1977.960440791176, 2000.6698894682506, 452.9026259354255, 469.3288597305817, 474.50177313820353, 476.5282370453226, 656.9671516424255, 10118.08937195656, 10263.178945684327, 10459.633912813015, 10474.68575942723, 10716.303440276357, 465.85791333642885, 472.2349793334751, 479.0084525033148, 485.9028194361142, 490.30376864851996, 5733.684647344353, 5884.558658100659, 5898.528117750569, 5952.85117872048, 9811.705648830546, 601709.0, 609928.0, 619793.0, 623413.0, 626666.0, 73453.26546734464, 79504.6024769884, 85383.0, 85617.14382856217, 86128.0, 1206.0411972481897, 1212.2605210821391, 1245.414655112096, 1249.7000719827176, 1280.1934781088041, 16489.67020659604, 16512.94554974851, 16569.0, 16757.32970681159, 16980.0, 37855.242895142495, 38307.425388618634, 38667.22665546617, 38988.80505597454, 39290.21419571535, 50072.49927500678, 50812.74593627008, 51121.466356009376, 51633.22550161826, 52653.157139499934, 10073.647422340184, 10101.595936162765, 10139.391636501834, 10152.949235254073, 10304.381737095799, 12511.624651260478, 12580.748385032432, 18597.535061623028, 18827.058647067865, 18852.434426967215, 13284.468621255042, 14781.260936953324, 15025.0, 15151.0, 15495.0, 14593.489227876973, 14628.102063962417, 14726.926365368105, 14879.628009299855, 15018.0, 15058.774118388452, 15195.696086078438, 15453.613659658598, 15825.604359891095, 16014.839851601335, 9893.950530247303, 10126.544305506122, 10152.74618134523, 10349.223808214565, 10359.896401035892, 14990.625234369229, 15008.699826003638, 15306.923465382602, 15447.2276386178, 16233.918830405772], "unit": "ms", "name": "jquery.html", "value": 8670.011916224443}, {"lowerIsBetter": false, "replicates": [1402.4179965314393, 1455.1196526101705, 1611.9435819746304, 1648.967020659586, 1782.5632719983598, 7650.808729781751, 7793.805154871131, 7972.441929064968, 8065.475744076631, 8081.757547273583, 8236.91763082369, 8268.91731082689, 8304.33565314775, 8320.084790673036, 8325.583720813966, 2267.183813827021, 2329.0683726509365, 2337.4623836517612, 2338.497223097034, 2343.250159948817, 2389.1518510928545, 2428.7935525480357, 2433.0267892842917, 2435.1111844176835, 2464.5194187133516, 2306.5617532668825, 2349.2012715676665, 2350.21267875262, 2379.8810059496955, 2413.4328432818274, 2339.6373562097815, 2374.3707917401903, 2378.0487804878103, 2380.8690522021284, 2389.2712722619594, 2324.8837558122027, 2382.9642555361684, 2385.2248019393764, 2385.2248019393764, 2392.461696118377, 8058.11360750317, 8135.145809690016, 8162.469439486415, 8177.264046235808, 8180.550069746161, 4736.786844592001, 4828.444728856191, 4869.172240719086, 4887.437944636376, 4890.853274401774, 3228.96771032289, 3246.2371342734436, 3327.3012667339885, 3342.5821772278464, 3355.9496607550905, 1041.458441610366, 1080.168270431771, 1087.8041952448557, 1088.395940253159, 1096.17786660005, 11136.387498687569, 11225.101991840633, 11259.099272058216, 11260.0, 11348.65954021389, 4287.421198138211, 4338.045629961403, 4377.671674624416, 4459.732416054982, 4481.238189507726, 9185.0, 9219.308551858638, 9226.261899048195, 9227.26181905446, 9228.676996305232, 4911.238757992517, 4916.7541622919425, 4923.77842997066, 4926.630502712311, 4931.358923340014, 4492.460904691458, 4494.258447356149, 4496.392986946786, 4520.977395113004, 4524.88687782808, 3583.516225309602, 3651.9817400912825, 3657.3782456982376, 3657.3782456982376, 3670.559532856021, 1158.5481662151767, 1164.6738913104343, 1171.3499008050444, 1174.395186478964, 1177.5996161305197, 1063.4151216830712, 1067.9359238445563, 1113.9443027848574, 1247.2454165230088, 1352.0535625062496, 7284.70861165558, 7285.635718214068, 7378.372838308804, 7403.8149046274275, 7410.370118539984, 1106.3085571517802, 1110.8500352452315, 1118.7208925858624, 1129.282905355089, 1135.795556799784, 5666.914996275059, 5686.317641882918, 5698.800541981093, 5717.714114294268, 5728.598998070095, 9688.273379496424, 9731.367461115005, 9943.552540135712, 10036.247281453774, 10103.343282686601, 9666.275029372826, 9728.124468797841, 9743.366681165844, 9844.163246124159, 9873.456959867133, 7236.38490728294, 7492.063492063492, 7503.7748867534065, 7507.737229196952, 7705.691772329156, 7290.453216008715, 7303.415726741741, 7362.0, 7375.96312018458, 7428.1086269647985, 8618.78453038679, 8803.163699448798, 8865.069167737294, 8899.599518021834, 8909.866352004596, 8836.381453298465, 8853.15894989975, 8928.017918029142, 8935.0, 8938.284937205139, 7771.766846994599, 7784.88322675149, 7858.842823143619, 7876.84246315059, 7892.605369731606, 7853.371730261451, 7935.325497332791, 7985.241402066795, 7989.2809647132035, 8041.839163216586, 7218.097737782778, 7455.254474552501, 7479.551226926402, 7522.962385188039, 7662.118856331594, 7030.0, 7124.21633620291, 7133.17968433616, 7185.425165986604, 7218.27817218274, 7133.500654954103, 7136.107986501687, 7154.964225178841, 7156.892646610409, 7206.4595155364605, 6639.402453779183, 6677.632730199885, 6681.398674119353, 6700.262971073081, 6730.0, 6533.477321814148, 6607.0, 6671.566348187353, 6687.933120668731, 6701.932980670131], "unit": "ms", "name": "mootools.html", "value": 4658.626432009702}, {"lowerIsBetter": false, "replicates": [350.8491348720051, 354.3285474026718, 355.7918617608699, 360.5421115183716, 362.71345636946813, 6397.58415702979, 6474.5791523551, 6487.253965793935, 6497.642629655367, 6498.9926561383, 6302.149209856668, 6440.194975628046, 6447.484201263899, 6448.193975753031, 6464.676766161697, 4904.926426103611, 4933.777979990891, 4937.061958227925, 4942.233953737176, 4944.7280399578185, 4953.232249001392, 4953.23224900141, 4954.578860796837, 4954.900901981958, 4966.9751651241695, 4680.227762419214, 4738.4313882334, 4754.334393184957, 4758.191107511731, 4776.28355746639, 4755.334253204537, 4761.9761751223305, 4762.571368576828, 4768.523147685239, 4810.206315957863, 4130.607592278729, 4138.213739389506, 4143.6685065195015, 4147.149834283965, 4148.128892932487, 6035.366286539894, 6118.847028824271, 6127.4791642710425, 6133.907991380132, 6147.44672979434, 5600.52395546375, 5606.523445507137, 5621.213030175779, 5621.213030175779, 5621.353544342372, 6757.594544327307, 6807.693653785592, 6812.216595091579, 6813.148356455443, 6816.7614133505585, 4570.451545814523, 4604.1252162089095, 4604.332371806103, 4614.054118905617, 4628.884277893046, 6963.0251764752975, 7018.508704390695, 7117.359437650636, 7121.216666166718, 7135.072440582743, 4823.710577365369, 4830.0, 4830.130576496194, 4830.565249127595, 4831.613470922318, 4878.000009997942, 4890.413150421972, 4890.850650097224, 4894.951050489521, 4898.632602554822, 5572.637778544382, 5689.857753556194, 5694.259746232963, 5699.287589051369, 5707.315122185364, 6857.759978400732, 6882.724691012403, 6884.139482564679, 6892.241853396123, 6909.27452617478, 1619.6679680665436, 1639.1148779659088, 1698.5923378389098, 1732.1339330334833, 1736.3575477073564, 1131.4003578103618, 1138.1236447935044, 1142.5429828068839, 1146.134668325409, 1152.6196355202762, 6363.936360636427, 6404.903926441107, 6437.163168788121, 6447.967760161169, 6460.870782584416, 6966.9303306967295, 6979.267176946449, 6981.162260528769, 7002.474814388941, 7016.543924644881, 6404.679766011681, 6412.935870641234, 6447.709853056624, 6451.645159516178, 6471.546991710535, 3870.2066076454257, 3913.3542965410957, 3915.727388598717, 3915.882523524299, 3923.4114882767813, 7427.220141885133, 7433.7769866903, 7438.776836694908, 7442.627868606548, 7450.105987281561, 7134.785956421316, 7398.815029624302, 7405.1854296027395, 7410.925890741024, 7414.740484083031, 7418.406527477789, 7446.925530744732, 7466.25337466249, 7467.402607791364, 7475.028246328051, 7226.710931562889, 7231.3130252625915, 7235.167955685163, 7240.818979525343, 7243.7464688735645, 6997.510174287751, 7066.222715501393, 7143.8571228576175, 7145.249748776304, 7156.856862862818, 7386.667599957907, 7402.259774022555, 7408.37028852532, 7417.592032438052, 7429.14564825052, 4799.66402351832, 4810.6632535722165, 4863.392075990501, 4870.853874383774, 4881.048195601824, 7055.717771289091, 7118.750843720445, 7191.892121618284, 7193.3166349196745, 7223.061002069908, 6927.27263637331, 6960.060391847036, 6974.825629359104, 6997.47518936092, 7028.753993610199, 6934.4452443805385, 6968.233494315723, 6969.233384327618, 6975.093237879043, 6976.965115174392, 6714.160729908762, 6782.69477873487, 6862.553933994274, 6877.105976223259, 6877.209120951155, 6944.791656250321, 6957.130358705162, 6982.755603553851, 6997.300269972962, 7019.0, 6668.699908504226, 6784.3894049535775, 6834.965825170842, 6858.691358888762, 6863.347981941708], "unit": "ms", "name": "prototype.html", "value": 5155.995518423765}, {"lowerIsBetter": false, "replicates": [781.335864515162, 795.7294519863245, 801.2828518475964, 805.7945223967887, 829.216390510967, 13976.580702578925, 14328.211948342838, 14340.498082567112, 14358.497452589161, 14378.640533986656, 12991.805122923164, 13106.95144388449, 13120.147190432615, 13168.539101131462, 13599.456021759142, 840.2731637133896, 843.633019636457, 846.174979395091, 849.0, 853.607340623311, 853.8463076646201, 854.8845905802731, 855.4781583234222, 860.0797147052656, 860.2644738748373, 892.5671049540967, 898.469902757373, 900.0549423105746, 902.620899222325, 903.3676426501443, 876.7019213467388, 887.6937456577471, 890.6882591093098, 896.5248418338258, 897.1835629577087, 646.524804268862, 649.8148027812051, 650.5348675696899, 651.1144843013498, 652.3346186889394, 14104.506342278073, 14107.506237281646, 14201.573952781433, 14202.573922782332, 14236.43054277838, 12300.261984280973, 12433.875661243363, 12984.091113622051, 13057.151285166434, 13295.3352332383, 11336.093112550976, 11546.884531154748, 11736.119791015708, 11836.0, 11858.940705296505, 3735.0662334416397, 3763.0, 3797.2215695782297, 3807.847686092553, 3815.9809200954096, 48668.51331486675, 48809.51190488085, 49165.26252106221, 49315.0, 49531.0, 10008.14930730896, 10142.949285253526, 10163.69508914719, 10193.847092293621, 10470.685879423629, 17544.649107017787, 19072.2371105157, 19220.231190752213, 19265.51836204078, 19267.22931082769, 7749.651265693057, 7768.339691126204, 7793.2596403341595, 7950.24472675095, 8045.436819422701, 4555.997680510282, 4596.747178905125, 4632.374629425052, 4703.435587729495, 4718.4809670936165, 3303.6200836904063, 3330.533725278463, 3396.7961922284744, 3509.7192224621967, 3510.64893510652, 635.0791352538837, 641.3874749614107, 649.4706813946618, 652.7225928980164, 660.5508254386967, 638.7987783848073, 675.7634827810227, 720.8738470767595, 726.5459088069956, 743.605888878895, 9305.581248843819, 9584.137427631547, 9630.374025688308, 9654.372465789702, 9683.322167448352, 515.7060475528988, 574.9453801888814, 594.7769586405099, 641.8940874755706, 661.9602823830586, 4180.435641188401, 4201.243776120266, 4315.683716466445, 4328.220920234388, 4392.121575684812, 56746.71626641923, 65355.69288614201, 65703.67148164229, 66330.66834665796, 66751.33248667548, 50777.49222507728, 51106.23340649893, 51937.0, 52214.47785522096, 52853.0, 46094.30858537058, 47261.0, 47277.05445891063, 48010.0, 48785.268220976715, 9230.630774769203, 9264.861027084735, 9271.814563708824, 9503.382280151767, 9625.855612165964, 35753.0, 35802.28395432129, 36590.8170459146, 36708.81645591755, 36953.26093478169, 41112.38331424971, 46639.0, 46774.06451871012, 46893.2966005517, 47171.29243061425, 10122.369847749736, 10554.313969591953, 11232.55069797199, 11268.492917818554, 11323.660290191307, 11940.880591193976, 12109.636710898687, 12185.878141218474, 12475.438605262967, 12607.054470914902, 11895.107866909842, 11996.700082498008, 12156.817647735468, 12287.447064881922, 12404.937975310066, 11670.416479175838, 11695.239809412702, 11712.70718232051, 11864.940675296568, 12120.09099317537, 10558.577656893638, 11375.772484550429, 11381.0, 11834.230774999598, 12257.448414821176, 9421.81156376855, 9950.35322704022, 10587.523561439599, 10683.679489615324, 10973.780524389627, 9637.71086867395, 10008.749781255236, 10108.241881858743, 10184.643537476153, 10221.437820919624], "unit": "ms", "name": "yui.html", "value": 6611.275522639942}], "name": "dromaeo_css", "value": 7284.523438215679}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 111.0, 110.0, 111.0, 119.0, 109.0, 109.0, 110.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [147.0, 122.0, 150.0, 164.0, 123.0, 147.0, 153.0, 123.0, 159.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.1}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 165.0, 162.0, 163.0, 160.0, 162.0, 164.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [72.0, 78.0, 72.0, 155.0, 71.0, 71.0, 72.0, 71.0, 155.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 88.9}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 135.0, 93.0, 94.0, 93.0, 131.0, 92.0, 94.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 105.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 59.0, 60.0, 61.0, 62.0, 59.0, 62.0, 60.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 59.8}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0, 66.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.7}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 81.0, 85.0, 82.0, 81.0, 82.0, 89.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [130.0, 124.0, 115.0, 123.0, 119.0, 115.0, 113.0, 115.0, 119.0, 114.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.7}, {"lowerIsBetter": true, "replicates": [151.0, 144.0, 142.0, 149.0, 144.0, 136.0, 147.0, 145.0, 143.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.4}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 69.0, 65.0, 66.0, 66.0, 67.0, 65.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1496.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.50074025333114], "unit": "score", "name": "Richards", "value": 214.60085799999993}, {"lowerIsBetter": false, "replicates": [173.07026652821045], "unit": "score", "name": "DeltaBlue", "value": 382.029804}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [924.2144177449168], "unit": "score", "name": "RayTrace", "value": 800.6680980000003}, {"lowerIsBetter": false, "replicates": [549.1488193300385], "unit": "score", "name": "Earley", "value": 1213.6291230000002}, {"lowerIsBetter": false, "replicates": [10621.052631578947], "unit": "score", "name": "Boyer", "value": 62.749241823587695}, {"lowerIsBetter": false, "replicates": [24512.19512195122], "unit": "score", "name": "RegExp", "value": 37.1645621890547}, {"lowerIsBetter": false, "replicates": [524.1090146750524], "unit": "score", "name": "Splay", "value": 155.48482799999994}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 23199.18551324391}]} 11:28:42 INFO - RETURN: dromaeo_css: 7284.53 11:28:42 INFO - RETURN: kraken: 1496.80 11:28:42 INFO - RETURN: v8_7: 23199.19 11:28:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23199.19"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1496.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7284.53"}}} 11:28:42 INFO - Return code: 0 11:28:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:28:42 INFO - # TBPL SUCCESS # 11:28:42 INFO - Running post-action listener: _resource_record_post_action 11:28:42 INFO - Running post-run listener: _resource_record_post_run 11:28:43 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 270336; Write bytes: 514527232; Read time: 364; Write time: 486616 11:28:43 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 4096; Write bytes: 237801472; Read time: 144; Write time: 290684 11:28:43 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 266240; Write bytes: 276131840; Read time: 220; Write time: 195932 11:28:43 INFO - Running post-run listener: _upload_blobber_files 11:28:43 INFO - Blob upload gear active. 11:28:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:28:43 INFO - Copying logs to upload dir... 11:28:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1261.076257 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-01-21 11:28:43.415591) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-21 11:28:43.419570) ========= 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=eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009895 build_url: 'https://queue.taskcluster.net/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-21 11:28:43.471171) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:28:43.471531) ========= 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=eca2ab57546de7b41f256b19000001ef-1453403219.780282-1119127776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:28:43.522184) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 11:28:43.522506) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 11:28:43.522810) ========= ========= Total master_lag: 0.28 =========