builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1451944647.38 results: success (0) buildid: 20160104112930 builduid: b1fa96970dd94f25831e2119698d8fe1 revision: f7687a837b4533f5d749d21e7e898793843e2301 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:27.379875) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:27.380633) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:27.381113) ========= 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=1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006442 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:27.416677) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:27.417061) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:27.448410) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:27.448921) ========= 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=1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004630 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:27.499163) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:27.499531) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:27.499967) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:27.500306) ========= 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=1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 13:57:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.6M=0s 2016-01-04 13:57:27 (60.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157361 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:27.672002) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:27.672491) ========= 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=1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018483 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:27.725389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:27.725796) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f7687a837b4533f5d749d21e7e898793843e2301 --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 f7687a837b4533f5d749d21e7e898793843e2301 --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=1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 13:57:28,017 truncating revision to first 12 chars 2016-01-04 13:57:28,018 Setting DEBUG logging. 2016-01-04 13:57:28,018 attempt 1/10 2016-01-04 13:57:28,018 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f7687a837b45?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 13:57:28,272 unpacking tar archive at: mozilla-aurora-f7687a837b45/testing/mozharness/ program finished with exit code 0 elapsedTime=0.543531 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:28.284505) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:28.284854) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:28.295915) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:28.296362) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 13:57:28.296926) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-04 13:57:28.297334) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:57:28 INFO - MultiFileLogger online at 20160104 13:57:28 in /builds/slave/test-pgo 13:57:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:57:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:57:28 INFO - {'append_to_log': False, 13:57:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:57:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:57:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:57:28 INFO - 'branch': 'Mozilla-Aurora', 13:57:28 INFO - 'buildbot_json_path': 'buildprops.json', 13:57:28 INFO - 'config_files': ('talos/linux_config.py',), 13:57:28 INFO - 'default_actions': ('clobber', 13:57:28 INFO - 'read-buildbot-config', 13:57:28 INFO - 'download-and-extract', 13:57:28 INFO - 'populate-webroot', 13:57:28 INFO - 'create-virtualenv', 13:57:28 INFO - 'install', 13:57:28 INFO - 'run-tests'), 13:57:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:57:28 INFO - 'download_minidump_stackwalk': True, 13:57:28 INFO - 'download_symbols': 'ondemand', 13:57:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:57:28 INFO - 'tooltool.py': '/tools/tooltool.py', 13:57:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:57:28 INFO - '/tools/misc-python/virtualenv.py')}, 13:57:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:57:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:57:28 INFO - 'installer_path': 'installer.exe', 13:57:28 INFO - 'log_level': 'info', 13:57:28 INFO - 'log_name': 'talos', 13:57:28 INFO - 'log_to_console': True, 13:57:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:57:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:57:28 INFO - 'opt_config_files': (), 13:57:28 INFO - 'pip_index': False, 13:57:28 INFO - 'sps_profile': False, 13:57:28 INFO - 'sps_profile_interval': 0, 13:57:28 INFO - 'suite': 'dromaeojs', 13:57:28 INFO - 'system_bits': '32', 13:57:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:57:28 INFO - 'title': 'talos-linux64-ix-045', 13:57:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:57:28 INFO - 'use_talos_json': True, 13:57:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:57:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:57:28 INFO - 'work_dir': 'build'} 13:57:28 INFO - ##### 13:57:28 INFO - ##### Running clobber step. 13:57:28 INFO - ##### 13:57:28 INFO - Running pre-action listener: _resource_record_pre_action 13:57:28 INFO - Running main action method: clobber 13:57:28 INFO - rmtree: /builds/slave/test-pgo/build 13:57:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:57:29 INFO - Running post-action listener: _resource_record_post_action 13:57:29 INFO - ##### 13:57:29 INFO - ##### Running read-buildbot-config step. 13:57:29 INFO - ##### 13:57:29 INFO - Running pre-action listener: _resource_record_pre_action 13:57:29 INFO - Running main action method: read_buildbot_config 13:57:29 INFO - Using buildbot properties: 13:57:29 INFO - { 13:57:29 INFO - "properties": { 13:57:29 INFO - "buildnumber": 172, 13:57:29 INFO - "product": "firefox", 13:57:29 INFO - "script_repo_revision": "production", 13:57:29 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 13:57:29 INFO - "repository": "", 13:57:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 13:57:29 INFO - "buildid": "20160104112930", 13:57:29 INFO - "slavename": "talos-linux64-ix-045", 13:57:29 INFO - "pgo_build": "True", 13:57:29 INFO - "basedir": "/builds/slave/test-pgo", 13:57:29 INFO - "project": "", 13:57:29 INFO - "platform": "ubuntu64_hw", 13:57:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:57:29 INFO - "slavebuilddir": "test", 13:57:29 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:57:29 INFO - "branch": "mozilla-aurora", 13:57:29 INFO - "repo_path": "releases/mozilla-aurora", 13:57:29 INFO - "stage_platform": "linux64-pgo", 13:57:29 INFO - "builduid": "b1fa96970dd94f25831e2119698d8fe1", 13:57:29 INFO - "revision": "f7687a837b4533f5d749d21e7e898793843e2301" 13:57:29 INFO - }, 13:57:29 INFO - "sourcestamp": { 13:57:29 INFO - "repository": "", 13:57:29 INFO - "hasPatch": false, 13:57:29 INFO - "project": "", 13:57:29 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 13:57:29 INFO - "changes": [ 13:57:29 INFO - { 13:57:29 INFO - "category": null, 13:57:29 INFO - "files": [ 13:57:29 INFO - { 13:57:29 INFO - "url": null, 13:57:29 INFO - "name": "https://queue.taskcluster.net/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 13:57:29 INFO - } 13:57:29 INFO - ], 13:57:29 INFO - "repository": "", 13:57:29 INFO - "rev": "f7687a837b4533f5d749d21e7e898793843e2301", 13:57:29 INFO - "who": "kwierso@gmail.com", 13:57:29 INFO - "when": 1451944615, 13:57:29 INFO - "number": 7414502, 13:57:29 INFO - "comments": "Bug 1236120: [ffmpeg] Use demuxed dimensions to determine picture size and offset. r=gerald a=sylvestre\n\nDon't assume it always has an offset of (0,0)", 13:57:29 INFO - "project": "", 13:57:29 INFO - "at": "Mon 04 Jan 2016 13:56:55", 13:57:29 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 13:57:29 INFO - "revlink": "", 13:57:29 INFO - "properties": [ 13:57:29 INFO - [ 13:57:29 INFO - "buildid", 13:57:29 INFO - "20160104112930", 13:57:29 INFO - "Change" 13:57:29 INFO - ], 13:57:29 INFO - [ 13:57:29 INFO - "builduid", 13:57:29 INFO - "b1fa96970dd94f25831e2119698d8fe1", 13:57:29 INFO - "Change" 13:57:29 INFO - ], 13:57:29 INFO - [ 13:57:29 INFO - "pgo_build", 13:57:29 INFO - "True", 13:57:29 INFO - "Change" 13:57:29 INFO - ] 13:57:29 INFO - ], 13:57:29 INFO - "revision": "f7687a837b4533f5d749d21e7e898793843e2301" 13:57:29 INFO - } 13:57:29 INFO - ], 13:57:29 INFO - "revision": "f7687a837b4533f5d749d21e7e898793843e2301" 13:57:29 INFO - } 13:57:29 INFO - } 13:57:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 13:57:29 INFO - Running post-action listener: _resource_record_post_action 13:57:29 INFO - ##### 13:57:29 INFO - ##### Running download-and-extract step. 13:57:29 INFO - ##### 13:57:29 INFO - Running pre-action listener: _resource_record_pre_action 13:57:29 INFO - Running main action method: download_and_extract 13:57:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:29 INFO - https://queue.taskcluster.net/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:57:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/test_packages.json 13:57:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/test_packages.json 13:57:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:57:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:57:36 INFO - Downloaded 1302 bytes. 13:57:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:57:36 INFO - Using the following test package requirements: 13:57:36 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 13:57:36 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:57:36 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:57:36 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:57:36 INFO - u'jsshell-linux-x86_64.zip'], 13:57:36 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:57:36 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:57:36 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 13:57:36 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:57:36 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:57:36 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:57:36 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:57:36 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:57:36 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:57:36 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 13:57:36 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:57:36 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:57:36 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:36 INFO - https://queue.taskcluster.net/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:57:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:57:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:57:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:57:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:57:38 INFO - Downloaded 23023788 bytes. 13:57:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:57:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:57:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:57:39 INFO - Return code: 0 13:57:39 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:39 INFO - https://queue.taskcluster.net/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:57:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:57:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:57:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:57:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:57:43 INFO - Downloaded 23023788 bytes. 13:57:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:57:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:57:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:57:45 INFO - Return code: 0 13:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:45 INFO - https://queue.taskcluster.net/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:57:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 13:57:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 13:57:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 13:57:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:57:46 INFO - Downloaded 11132038 bytes. 13:57:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 13:57:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 13:57:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 13:57:46 INFO - Return code: 0 13:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:46 INFO - https://queue.taskcluster.net/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:57:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 13:57:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 13:57:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 13:57:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:57:50 INFO - Downloaded 58095914 bytes. 13:57:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 13:57:50 INFO - mkdir: /builds/slave/test-pgo/properties 13:57:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:57:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:57:50 INFO - Contents: 13:57:50 INFO - build_url:https://queue.taskcluster.net/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 13:57:50 INFO - Running post-action listener: _resource_record_post_action 13:57:50 INFO - Running post-action listener: set_extra_try_arguments 13:57:50 INFO - ##### 13:57:50 INFO - ##### Running populate-webroot step. 13:57:50 INFO - ##### 13:57:50 INFO - Running pre-action listener: _resource_record_pre_action 13:57:50 INFO - Running main action method: populate_webroot 13:57:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:57:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:57:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:57:50 INFO - '--tppagecycles', 13:57:50 INFO - '7'], 13:57:50 INFO - 'tests': ['tsvgm']}}, 13:57:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:57:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:57:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:57:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:57:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:57:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:57:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:57:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:50 INFO - 'talos_options': ['--e10s'], 13:57:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:57:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:50 INFO - 'tests': ['damp', 'tps']}, 13:57:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:50 INFO - 'talos_options': ['--e10s'], 13:57:50 INFO - 'tests': ['damp', 'tps']}, 13:57:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:57:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:57:50 INFO - 'other': {'tests': ['a11yr', 13:57:50 INFO - 'ts_paint', 13:57:50 INFO - 'tpaint', 13:57:50 INFO - 'sessionrestore', 13:57:50 INFO - 'sessionrestore_no_auto_restore']}, 13:57:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:57:50 INFO - 'tests': ['a11yr', 13:57:50 INFO - 'ts_paint', 13:57:50 INFO - 'tpaint', 13:57:50 INFO - 'sessionrestore', 13:57:50 INFO - 'sessionrestore_no_auto_restore']}, 13:57:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:57:50 INFO - 'tests': ['a11yr', 13:57:50 INFO - 'ts_paint', 13:57:50 INFO - 'tpaint', 13:57:50 INFO - 'sessionrestore', 13:57:50 INFO - 'sessionrestore_no_auto_restore']}, 13:57:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:57:50 INFO - 'tests': ['a11yr', 13:57:50 INFO - 'ts_paint', 13:57:50 INFO - 'tpaint', 13:57:50 INFO - 'sessionrestore', 13:57:50 INFO - 'sessionrestore_no_auto_restore']}, 13:57:50 INFO - 'other_l64': {'tests': ['a11yr', 13:57:50 INFO - 'ts_paint', 13:57:50 INFO - 'tpaint', 13:57:50 INFO - 'sessionrestore', 13:57:50 INFO - 'sessionrestore_no_auto_restore']}, 13:57:50 INFO - 'other_nol64': {'tests': ['a11yr', 13:57:50 INFO - 'ts_paint', 13:57:50 INFO - 'tpaint', 13:57:50 INFO - 'sessionrestore', 13:57:50 INFO - 'sessionrestore_no_auto_restore']}, 13:57:50 INFO - 'svgr': {'tests': ['tsvgx', 13:57:50 INFO - 'tsvgr_opacity', 13:57:50 INFO - 'tart', 13:57:50 INFO - 'tscrollx', 13:57:50 INFO - 'cart']}, 13:57:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:57:50 INFO - 'tests': ['tsvgx', 13:57:50 INFO - 'tsvgr_opacity', 13:57:50 INFO - 'tart', 13:57:50 INFO - 'tscrollx', 13:57:50 INFO - 'cart']}, 13:57:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:50 INFO - 'tests': ['tp5o']}, 13:57:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:50 INFO - 'talos_options': ['--e10s'], 13:57:50 INFO - 'tests': ['tp5o']}, 13:57:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:50 INFO - 'talos_options': ['--xperf_path', 13:57:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:57:50 INFO - 'tests': ['tp5n']}, 13:57:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:50 INFO - 'talos_options': ['--e10s', 13:57:50 INFO - '--xperf_path', 13:57:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:57:50 INFO - 'tests': ['tp5n']}}, 13:57:50 INFO - 'talos.zip': {'path': '', 13:57:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:57:50 INFO - Running post-action listener: _resource_record_post_action 13:57:50 INFO - ##### 13:57:50 INFO - ##### Running create-virtualenv step. 13:57:50 INFO - ##### 13:57:50 INFO - Running pre-action listener: _resource_record_pre_action 13:57:50 INFO - Running main action method: create_virtualenv 13:57:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:57:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 13:57:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:57:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:57:50 INFO - Using real prefix '/usr' 13:57:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:57:51 INFO - Installing distribute.............................................................................................................................................................................................done. 13:57:53 INFO - Installing pip.................done. 13:57:53 INFO - Return code: 0 13:57:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ff54fa90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1746350>, '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 0x1747250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17476e0>, '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': '1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:57:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 13:57:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:57:53 INFO - Using env: {'DISPLAY': ':0', 13:57:53 INFO - 'HOME': '/home/cltbld', 13:57:53 INFO - 'LANG': 'en_US.UTF-8', 13:57:53 INFO - 'LANGUAGE': 'en_US:en', 13:57:53 INFO - 'LOGNAME': 'cltbld', 13:57:53 INFO - 'MAIL': '/var/mail/cltbld', 13:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:53 INFO - 'MOZ_NO_REMOTE': '1', 13:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:53 INFO - 'NO_EM_RESTART': '1', 13:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:57:53 INFO - 'PWD': '/builds/slave/test-pgo', 13:57:53 INFO - 'SHELL': '/bin/bash', 13:57:53 INFO - 'SHLVL': '1', 13:57:53 INFO - 'TERM': 'linux', 13:57:53 INFO - 'TMOUT': '86400', 13:57:53 INFO - 'USER': 'cltbld', 13:57:53 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328', 13:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:53 INFO - '_': '/tools/buildbot/bin/python'} 13:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:57:53 INFO - Cleaning up... 13:57:53 INFO - Return code: 0 13:57:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ff54fa90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1746350>, '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 0x1747250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17476e0>, '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': '1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:57:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 13:57:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:57:53 INFO - Using env: {'DISPLAY': ':0', 13:57:53 INFO - 'HOME': '/home/cltbld', 13:57:53 INFO - 'LANG': 'en_US.UTF-8', 13:57:53 INFO - 'LANGUAGE': 'en_US:en', 13:57:53 INFO - 'LOGNAME': 'cltbld', 13:57:53 INFO - 'MAIL': '/var/mail/cltbld', 13:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:53 INFO - 'MOZ_NO_REMOTE': '1', 13:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:53 INFO - 'NO_EM_RESTART': '1', 13:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:57:53 INFO - 'PWD': '/builds/slave/test-pgo', 13:57:53 INFO - 'SHELL': '/bin/bash', 13:57:53 INFO - 'SHLVL': '1', 13:57:53 INFO - 'TERM': 'linux', 13:57:53 INFO - 'TMOUT': '86400', 13:57:53 INFO - 'USER': 'cltbld', 13:57:53 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328', 13:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:53 INFO - '_': '/tools/buildbot/bin/python'} 13:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:53 INFO - Downloading/unpacking psutil>=0.7.1 13:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:57:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:57:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:57:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:57:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:57:55 INFO - Installing collected packages: psutil 13:57:55 INFO - Running setup.py install for psutil 13:57:55 INFO - building 'psutil._psutil_linux' extension 13:57:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:57:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:57:55 INFO - building 'psutil._psutil_posix' extension 13:57:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:57:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:57:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:57:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:57:55 INFO - Successfully installed psutil 13:57:55 INFO - Cleaning up... 13:57:55 INFO - Return code: 0 13:57:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:57: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')]} 13:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57: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')]} 13:57:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ff54fa90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1746350>, '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 0x1747250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17476e0>, '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': '1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:57:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 13:57:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:57:55 INFO - Using env: {'DISPLAY': ':0', 13:57:55 INFO - 'HOME': '/home/cltbld', 13:57:55 INFO - 'LANG': 'en_US.UTF-8', 13:57:55 INFO - 'LANGUAGE': 'en_US:en', 13:57:55 INFO - 'LOGNAME': 'cltbld', 13:57:55 INFO - 'MAIL': '/var/mail/cltbld', 13:57:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:55 INFO - 'MOZ_NO_REMOTE': '1', 13:57:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:55 INFO - 'NO_EM_RESTART': '1', 13:57:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:57:55 INFO - 'PWD': '/builds/slave/test-pgo', 13:57:55 INFO - 'SHELL': '/bin/bash', 13:57:55 INFO - 'SHLVL': '1', 13:57:55 INFO - 'TERM': 'linux', 13:57:55 INFO - 'TMOUT': '86400', 13:57:55 INFO - 'USER': 'cltbld', 13:57:55 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328', 13:57:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:55 INFO - '_': '/tools/buildbot/bin/python'} 13:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:57:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:57:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:57:57 INFO - Installing collected packages: mozsystemmonitor 13:57:57 INFO - Running setup.py install for mozsystemmonitor 13:57:57 INFO - Successfully installed mozsystemmonitor 13:57:57 INFO - Cleaning up... 13:57:58 INFO - Return code: 0 13:57:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:57: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')]} 13:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57: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')]} 13:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ff54fa90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1746350>, '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 0x1747250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17476e0>, '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': '1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:57:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 13:57:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:57:58 INFO - Using env: {'DISPLAY': ':0', 13:57:58 INFO - 'HOME': '/home/cltbld', 13:57:58 INFO - 'LANG': 'en_US.UTF-8', 13:57:58 INFO - 'LANGUAGE': 'en_US:en', 13:57:58 INFO - 'LOGNAME': 'cltbld', 13:57:58 INFO - 'MAIL': '/var/mail/cltbld', 13:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:58 INFO - 'MOZ_NO_REMOTE': '1', 13:57:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:58 INFO - 'NO_EM_RESTART': '1', 13:57:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:57:58 INFO - 'PWD': '/builds/slave/test-pgo', 13:57:58 INFO - 'SHELL': '/bin/bash', 13:57:58 INFO - 'SHLVL': '1', 13:57:58 INFO - 'TERM': 'linux', 13:57:58 INFO - 'TMOUT': '86400', 13:57:58 INFO - 'USER': 'cltbld', 13:57:58 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328', 13:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:58 INFO - '_': '/tools/buildbot/bin/python'} 13:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:58 INFO - Downloading/unpacking blobuploader==1.2.4 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57:59 INFO - Downloading blobuploader-1.2.4.tar.gz 13:57:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:57:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:57:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:58:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:58:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:00 INFO - Downloading docopt-0.6.1.tar.gz 13:58:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:58:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:58:00 INFO - Installing collected packages: blobuploader, requests, docopt 13:58:00 INFO - Running setup.py install for blobuploader 13:58:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:58:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:58:00 INFO - Running setup.py install for requests 13:58:01 INFO - Running setup.py install for docopt 13:58:01 INFO - Successfully installed blobuploader requests docopt 13:58:01 INFO - Cleaning up... 13:58:01 INFO - Return code: 0 13:58:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ff54fa90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1746350>, '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 0x1747250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17476e0>, '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': '1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:58:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 13:58:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:58:01 INFO - Using env: {'DISPLAY': ':0', 13:58:01 INFO - 'HOME': '/home/cltbld', 13:58:01 INFO - 'LANG': 'en_US.UTF-8', 13:58:01 INFO - 'LANGUAGE': 'en_US:en', 13:58:01 INFO - 'LOGNAME': 'cltbld', 13:58:01 INFO - 'MAIL': '/var/mail/cltbld', 13:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:01 INFO - 'MOZ_NO_REMOTE': '1', 13:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:01 INFO - 'NO_EM_RESTART': '1', 13:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:58:01 INFO - 'PWD': '/builds/slave/test-pgo', 13:58:01 INFO - 'SHELL': '/bin/bash', 13:58:01 INFO - 'SHLVL': '1', 13:58:01 INFO - 'TERM': 'linux', 13:58:01 INFO - 'TMOUT': '86400', 13:58:01 INFO - 'USER': 'cltbld', 13:58:01 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328', 13:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:01 INFO - '_': '/tools/buildbot/bin/python'} 13:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:58:01 INFO - Running setup.py (path:/tmp/pip-J_DvFm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:58:01 INFO - Running setup.py (path:/tmp/pip-hLYntB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:58:01 INFO - Running setup.py (path:/tmp/pip-Axiisp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:58:01 INFO - Running setup.py (path:/tmp/pip-ZWjQ6d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:58:01 INFO - Running setup.py (path:/tmp/pip-hWCaps-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:58:01 INFO - Running setup.py (path:/tmp/pip-Fu2wDH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:58:01 INFO - Running setup.py (path:/tmp/pip-UdV91H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:58:01 INFO - Running setup.py (path:/tmp/pip-gJXnqT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:58:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:58:02 INFO - Running setup.py (path:/tmp/pip-wRoylW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:58:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:58:02 INFO - Running setup.py (path:/tmp/pip-WWJi5I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:58:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:58:02 INFO - Running setup.py (path:/tmp/pip-6h9KtS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:58:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:58:02 INFO - Running setup.py (path:/tmp/pip-nwHU2X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:58:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:58:02 INFO - Running setup.py (path:/tmp/pip-khm8t2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:58:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:58:02 INFO - Running setup.py (path:/tmp/pip-4gjsD4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:58:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:58:02 INFO - Running setup.py (path:/tmp/pip-j5_QI0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:58:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:58:02 INFO - Running setup.py (path:/tmp/pip-CbiJsD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:58:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:58:02 INFO - Running setup.py (path:/tmp/pip-HLmmKU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:58:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:58:02 INFO - Running setup.py install for manifestparser 13:58:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:58:02 INFO - Running setup.py install for mozcrash 13:58:02 INFO - Running setup.py install for mozdebug 13:58:02 INFO - Running setup.py install for mozdevice 13:58:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:58:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:58:03 INFO - Running setup.py install for mozfile 13:58:03 INFO - Running setup.py install for mozhttpd 13:58:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:58:03 INFO - Running setup.py install for mozinfo 13:58:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:58:03 INFO - Running setup.py install for mozInstall 13:58:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:58:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:58:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:58:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:58:03 INFO - Running setup.py install for mozleak 13:58:03 INFO - Running setup.py install for mozlog 13:58:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:58:03 INFO - Running setup.py install for moznetwork 13:58:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:58:03 INFO - Running setup.py install for mozprocess 13:58:03 INFO - Running setup.py install for mozprofile 13:58:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:58:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:58:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:58:03 INFO - Running setup.py install for mozrunner 13:58:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:58:04 INFO - Running setup.py install for mozscreenshot 13:58:04 INFO - Running setup.py install for moztest 13:58:04 INFO - Running setup.py install for mozversion 13:58:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:58:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:58:04 INFO - Cleaning up... 13:58:04 INFO - Return code: 0 13:58:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ff54fa90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1746350>, '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 0x1747250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17476e0>, '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': '1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:58:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 13:58:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:58:04 INFO - Using env: {'DISPLAY': ':0', 13:58:04 INFO - 'HOME': '/home/cltbld', 13:58:04 INFO - 'LANG': 'en_US.UTF-8', 13:58:04 INFO - 'LANGUAGE': 'en_US:en', 13:58:04 INFO - 'LOGNAME': 'cltbld', 13:58:04 INFO - 'MAIL': '/var/mail/cltbld', 13:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:04 INFO - 'MOZ_NO_REMOTE': '1', 13:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:04 INFO - 'NO_EM_RESTART': '1', 13:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:58:04 INFO - 'PWD': '/builds/slave/test-pgo', 13:58:04 INFO - 'SHELL': '/bin/bash', 13:58:04 INFO - 'SHLVL': '1', 13:58:04 INFO - 'TERM': 'linux', 13:58:04 INFO - 'TMOUT': '86400', 13:58:04 INFO - 'USER': 'cltbld', 13:58:04 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328', 13:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:04 INFO - '_': '/tools/buildbot/bin/python'} 13:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:58:04 INFO - Running setup.py (path:/tmp/pip-sP5BMX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 13:58:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:58:04 INFO - Running setup.py (path:/tmp/pip-cb13sw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:58:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:58:04 INFO - Running setup.py (path:/tmp/pip-z6gj29-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:58:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:58:04 INFO - Running setup.py (path:/tmp/pip-V9V9AZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:58:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:58:04 INFO - Running setup.py (path:/tmp/pip-bdjY6L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 13:58:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:58:05 INFO - Running setup.py (path:/tmp/pip-af5RL2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 13:58:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:58:05 INFO - Running setup.py (path:/tmp/pip-2JlWyY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 13:58:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:58:05 INFO - Running setup.py (path:/tmp/pip-KAdr4r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 13:58:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:58:05 INFO - Running setup.py (path:/tmp/pip-0FuH8G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 13:58:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:58:05 INFO - Running setup.py (path:/tmp/pip-lkKe98-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:58:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:58:05 INFO - Running setup.py (path:/tmp/pip-ZMLhTN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 13:58:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:58:05 INFO - Running setup.py (path:/tmp/pip-3pnOMr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 13:58:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:58:05 INFO - Running setup.py (path:/tmp/pip-wP3VD1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 13:58:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:58:05 INFO - Running setup.py (path:/tmp/pip-boI_eT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 13:58:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:58:05 INFO - Running setup.py (path:/tmp/pip-_PRY_H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 13:58:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:58:05 INFO - Running setup.py (path:/tmp/pip-Xr0cRJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 13:58:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:58:05 INFO - Running setup.py (path:/tmp/pip-Pl7Qet-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:58:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:07 INFO - Downloading blessings-1.5.1.tar.gz 13:58:07 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 13:58:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:58:07 INFO - Installing collected packages: blessings 13:58:07 INFO - Running setup.py install for blessings 13:58:07 INFO - Successfully installed blessings 13:58:07 INFO - Cleaning up... 13:58:07 INFO - Return code: 0 13:58:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:58:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:58:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:58:07 INFO - Reading from file tmpfile_stdout 13:58:07 INFO - Current package versions: 13:58:07 INFO - argparse == 1.2.1 13:58:07 INFO - blessings == 1.5.1 13:58:07 INFO - blobuploader == 1.2.4 13:58:07 INFO - docopt == 0.6.1 13:58:07 INFO - manifestparser == 1.1 13:58:07 INFO - mozInstall == 1.12 13:58:07 INFO - mozcrash == 0.16 13:58:07 INFO - mozdebug == 0.1 13:58:08 INFO - mozdevice == 0.47 13:58:08 INFO - mozfile == 1.2 13:58:08 INFO - mozhttpd == 0.7 13:58:08 INFO - mozinfo == 0.9 13:58:08 INFO - mozleak == 0.1 13:58:08 INFO - mozlog == 3.1 13:58:08 INFO - moznetwork == 0.27 13:58:08 INFO - mozprocess == 0.22 13:58:08 INFO - mozprofile == 0.27 13:58:08 INFO - mozrunner == 6.11 13:58:08 INFO - mozscreenshot == 0.1 13:58:08 INFO - mozsystemmonitor == 0.0 13:58:08 INFO - moztest == 0.7 13:58:08 INFO - mozversion == 1.4 13:58:08 INFO - psutil == 3.1.1 13:58:08 INFO - requests == 1.2.3 13:58:08 INFO - wsgiref == 0.1.2 13:58:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ff54fa90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1746350>, '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 0x1747250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17476e0>, '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': '1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:58:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 13:58:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:58:08 INFO - Using env: {'DISPLAY': ':0', 13:58:08 INFO - 'HOME': '/home/cltbld', 13:58:08 INFO - 'LANG': 'en_US.UTF-8', 13:58:08 INFO - 'LANGUAGE': 'en_US:en', 13:58:08 INFO - 'LOGNAME': 'cltbld', 13:58:08 INFO - 'MAIL': '/var/mail/cltbld', 13:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:08 INFO - 'MOZ_NO_REMOTE': '1', 13:58:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:08 INFO - 'NO_EM_RESTART': '1', 13:58:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:58:08 INFO - 'PWD': '/builds/slave/test-pgo', 13:58:08 INFO - 'SHELL': '/bin/bash', 13:58:08 INFO - 'SHLVL': '1', 13:58:08 INFO - 'TERM': 'linux', 13:58:08 INFO - 'TMOUT': '86400', 13:58:08 INFO - 'USER': 'cltbld', 13:58:08 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328', 13:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:08 INFO - '_': '/tools/buildbot/bin/python'} 13:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 13:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 13:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 13:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 13:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 13:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 13:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 13:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 13:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:58:08 INFO - Cleaning up... 13:58:08 INFO - Return code: 0 13:58:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ff54fa90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1746350>, '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 0x1747250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17476e0>, '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': '1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:58:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 13:58:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:58:08 INFO - Using env: {'DISPLAY': ':0', 13:58:08 INFO - 'HOME': '/home/cltbld', 13:58:08 INFO - 'LANG': 'en_US.UTF-8', 13:58:08 INFO - 'LANGUAGE': 'en_US:en', 13:58:08 INFO - 'LOGNAME': 'cltbld', 13:58:08 INFO - 'MAIL': '/var/mail/cltbld', 13:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:08 INFO - 'MOZ_NO_REMOTE': '1', 13:58:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:08 INFO - 'NO_EM_RESTART': '1', 13:58:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:58:08 INFO - 'PWD': '/builds/slave/test-pgo', 13:58:08 INFO - 'SHELL': '/bin/bash', 13:58:08 INFO - 'SHLVL': '1', 13:58:08 INFO - 'TERM': 'linux', 13:58:08 INFO - 'TMOUT': '86400', 13:58:08 INFO - 'USER': 'cltbld', 13:58:08 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328', 13:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:08 INFO - '_': '/tools/buildbot/bin/python'} 13:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:08 INFO - Downloading/unpacking jsonschema 13:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:58:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 13:58:10 INFO - Downloading/unpacking functools32 (from jsonschema) 13:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:10 INFO - Downloading functools32-3.2.3-2.tar.gz 13:58:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:58:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:58:10 INFO - warning: no files found matching '*.txt' 13:58:10 INFO - no previously-included directories found matching 'build' 13:58:10 INFO - no previously-included directories found matching 'dist' 13:58:10 INFO - no previously-included directories found matching '.git*' 13:58:10 INFO - Installing collected packages: jsonschema, functools32 13:58:10 INFO - Running setup.py install for functools32 13:58:10 INFO - warning: no files found matching '*.txt' 13:58:10 INFO - no previously-included directories found matching 'build' 13:58:10 INFO - no previously-included directories found matching 'dist' 13:58:10 INFO - no previously-included directories found matching '.git*' 13:58:10 INFO - Successfully installed jsonschema functools32 13:58:10 INFO - Cleaning up... 13:58:10 INFO - Return code: 0 13:58:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ff54fa90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1746350>, '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 0x1747250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17476e0>, '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': '1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:58:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 13:58:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:58:10 INFO - Using env: {'DISPLAY': ':0', 13:58:10 INFO - 'HOME': '/home/cltbld', 13:58:10 INFO - 'LANG': 'en_US.UTF-8', 13:58:10 INFO - 'LANGUAGE': 'en_US:en', 13:58:10 INFO - 'LOGNAME': 'cltbld', 13:58:10 INFO - 'MAIL': '/var/mail/cltbld', 13:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:10 INFO - 'MOZ_NO_REMOTE': '1', 13:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:10 INFO - 'NO_EM_RESTART': '1', 13:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:58:10 INFO - 'PWD': '/builds/slave/test-pgo', 13:58:10 INFO - 'SHELL': '/bin/bash', 13:58:10 INFO - 'SHLVL': '1', 13:58:10 INFO - 'TERM': 'linux', 13:58:10 INFO - 'TMOUT': '86400', 13:58:10 INFO - 'USER': 'cltbld', 13:58:10 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328', 13:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:10 INFO - '_': '/tools/buildbot/bin/python'} 13:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:10 INFO - Downloading/unpacking flake8 13:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:58:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 13:58:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:58:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 13:58:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 13:58:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:58:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:58:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:58:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:58:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:58:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:58:13 INFO - no previously-included directories found matching 'docs/_build' 13:58:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:58:13 INFO - Running setup.py install for pep8 13:58:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:58:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:58:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:58:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:58:13 INFO - no previously-included directories found matching 'docs/_build' 13:58:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:58:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:58:13 INFO - Cleaning up... 13:58:13 INFO - Return code: 0 13:58:13 INFO - Running post-action listener: _resource_record_post_action 13:58:13 INFO - Running post-action listener: _start_resource_monitoring 13:58:13 INFO - Starting resource monitoring. 13:58:13 INFO - ##### 13:58:13 INFO - ##### Running install step. 13:58:13 INFO - ##### 13:58:13 INFO - Running pre-action listener: _resource_record_pre_action 13:58:13 INFO - Running main action method: install 13:58:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:58:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:58:13 INFO - Reading from file tmpfile_stdout 13:58:13 INFO - Detecting whether we're running mozinstall >=1.0... 13:58:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:58:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:58:13 INFO - Reading from file tmpfile_stdout 13:58:13 INFO - Output received: 13:58:13 INFO - Usage: mozinstall [options] installer 13:58:13 INFO - Options: 13:58:13 INFO - -h, --help show this help message and exit 13:58:13 INFO - -d DEST, --destination=DEST 13:58:13 INFO - Directory to install application into. [default: 13:58:13 INFO - "/builds/slave/test-pgo"] 13:58:13 INFO - --app=APP Application being installed. [default: firefox] 13:58:13 INFO - mkdir: /builds/slave/test-pgo/build/application 13:58:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 13:58:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 13:58:28 INFO - Reading from file tmpfile_stdout 13:58:28 INFO - Output received: 13:58:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:58:28 INFO - Running post-action listener: _resource_record_post_action 13:58:28 INFO - ##### 13:58:28 INFO - ##### Running run-tests step. 13:58:28 INFO - ##### 13:58:28 INFO - Running pre-action listener: _resource_record_pre_action 13:58:28 INFO - Running main action method: run_tests 13:58:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:58:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:58:28 INFO - Python 2.7.3 13:58:28 INFO - Return code: 0 13:58:28 INFO - grabbing minidump binary from tooltool 13:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:28 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 0x1746350>, '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 0x1747250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17476e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:58:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 13:58:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:58:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:58:28 INFO - Return code: 0 13:58:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:58:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:58:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:58:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:58:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:58:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:58:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:58:29 INFO - Return code: 0 13:58:29 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 13:58:29 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost 13:58:29 INFO - Using env: {'DISPLAY': ':0', 13:58:29 INFO - 'HOME': '/home/cltbld', 13:58:29 INFO - 'LANG': 'en_US.UTF-8', 13:58:29 INFO - 'LANGUAGE': 'en_US:en', 13:58:29 INFO - 'LOGNAME': 'cltbld', 13:58:29 INFO - 'MAIL': '/var/mail/cltbld', 13:58:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:58:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:29 INFO - 'MOZ_NO_REMOTE': '1', 13:58:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:29 INFO - 'NO_EM_RESTART': '1', 13:58:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:58:29 INFO - 'PWD': '/builds/slave/test-pgo', 13:58:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:58:29 INFO - 'SHELL': '/bin/bash', 13:58:29 INFO - 'SHLVL': '1', 13:58:29 INFO - 'TERM': 'linux', 13:58:29 INFO - 'TMOUT': '86400', 13:58:29 INFO - 'USER': 'cltbld', 13:58:29 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328', 13:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:29 INFO - '_': '/tools/buildbot/bin/python'} 13:58:29 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] with output_timeout 3600 13:58:29 INFO - mozversion INFO | application_buildid: 20160104112930 13:58:29 INFO - mozversion INFO | application_changeset: f7687a837b4533f5d749d21e7e898793843e2301 13:58:29 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 13:58:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:58:29 INFO - mozversion INFO | application_name: Firefox 13:58:29 INFO - mozversion INFO | application_remotingname: firefox-dev 13:58:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:58:29 INFO - mozversion INFO | application_vendor: Mozilla 13:58:29 INFO - mozversion INFO | application_version: 45.0a2 13:58:29 INFO - mozversion INFO | platform_buildid: 20160104112930 13:58:29 INFO - mozversion INFO | platform_changeset: f7687a837b4533f5d749d21e7e898793843e2301 13:58:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:58:29 INFO - mozversion INFO | platform_version: 45.0a2 13:58:29 INFO - 2016-01-04 13:58:29,414 DEBUG : using testdate: 1451944709 13:58:29 INFO - 2016-01-04 13:58:29,414 DEBUG : actual date: 1451944709 13:58:29 INFO - 2016-01-04 13:58:29,466 INFO : starting webserver on 'localhost:44809' 13:58:29 INFO - 2016-01-04 13:58:29,467 INFO : Starting test suite talos-linux64-ix-045 13:58:29 INFO - 2016-01-04 13:58:29,467 INFO : Starting test dromaeo_css 13:58:29 INFO - 2016-01-04 13:58:29,467 DEBUG : operating with platform_type : linux_ 13:58:29 INFO - 2016-01-04 13:58:29,468 INFO : Initialising browser for dromaeo_css test... 13:58:29 INFO - 2016-01-04 13:58:29,485 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMESb3t/profile http://localhost:44809/getInfo.html 13:58:32 INFO - 2016-01-04 13:58:32,923 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:58:32 INFO - 2016-01-04 13:58:32,923 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:58:32 INFO - 2016-01-04 13:58:32,923 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:58:32 INFO - 2016-01-04 13:58:32,924 DEBUG : BROWSER_OUTPUT: __metrics 13:58:33 INFO - 2016-01-04 13:58:33,052 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:58:34 INFO - 2016-01-04 13:58:34,004 INFO : Browser initialized. 13:58:34 INFO - 2016-01-04 13:58:34,005 INFO : Running cycle 1/1 for dromaeo_css test... 13:58:34 INFO - 2016-01-04 13:58:34,005 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMESb3t/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:58:45 INFO - 2016-01-04 13:58:45,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 137990144 13:58:45 INFO - 2016-01-04 13:58:45,711 DEBUG : BROWSER_OUTPUT: 13:59:36 INFO - 2016-01-04 13:59:36,731 DEBUG : BROWSER_OUTPUT: 1451944776726 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] 14:01:45 INFO - 2016-01-04 14:01:45,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44809/tests/dromaeo/cssquery-ext.html) 14:01:46 INFO - 2016-01-04 14:01:46,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 248385536 14:01:46 INFO - 2016-01-04 14:01:46,259 DEBUG : BROWSER_OUTPUT: 14:04:48 INFO - 2016-01-04 14:04:48,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/dromaeo/cssquery-ext.html (next: http://localhost:44809/tests/dromaeo/cssquery-jquery.html) 14:04:48 INFO - 2016-01-04 14:04:48,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 217600000 14:04:48 INFO - 2016-01-04 14:04:48,953 DEBUG : BROWSER_OUTPUT: 14:07:50 INFO - 2016-01-04 14:07:50,901 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44809/tests/dromaeo/cssquery-mootools.html) 14:07:51 INFO - 2016-01-04 14:07:51,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 206704640 14:07:51 INFO - 2016-01-04 14:07:51,463 DEBUG : BROWSER_OUTPUT: 14:10:53 INFO - 2016-01-04 14:10:53,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44809/tests/dromaeo/cssquery-prototype.html) 14:10:53 INFO - 2016-01-04 14:10:53,760 DEBUG : BROWSER_OUTPUT: RSS: Main: 200736768 14:10:53 INFO - 2016-01-04 14:10:53,760 DEBUG : BROWSER_OUTPUT: 14:13:56 INFO - 2016-01-04 14:13:56,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44809/tests/dromaeo/cssquery-yui.html) 14:13:56 INFO - 2016-01-04 14:13:56,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 203698176 14:13:56 INFO - 2016-01-04 14:13:56,723 DEBUG : BROWSER_OUTPUT: 14:16:58 INFO - 2016-01-04 14:16:58,895 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/dromaeo/cssquery-yui.html (next: http://localhost:44809/tests/dromaeo/cssquery-dojo.html) 14:16:59 INFO - 2016-01-04 14:16:59,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 240930816 14:16:59 INFO - 2016-01-04 14:16:59,145 DEBUG : BROWSER_OUTPUT: 14:16:59 INFO - 2016-01-04 14:16:59,147 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:16:59 INFO - 2016-01-04 14:16:59,147 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:16:59 INFO - 2016-01-04 14:16:59,147 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:16:59 INFO - 2016-01-04 14:16:59,147 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:16:59 INFO - 2016-01-04 14:16:59,148 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3318.518814771858;3364.024432914455;3364.444866597013;3371.7134043606293;3382.4926261060837;5568.443155684435;5570.6657600543895;5576.5259952904;5581.302337207844;5632.633878797876;5591.7483713232905;5598.328200615932;5598.832035038945;5612.607117501777;5634.436556344363;4865.290343150933;5099.005693889693;5120.385553733558;5188.247704082905;5237.476252374751;5046.268291097788;5085.288059671649;5104.5405913467785;5164.147915593922;5169.663971841818;5074.517920797537;5103.209002604603;5103.948960510403;5108.361454818148;5116.462771409004;4921.901561968776;5085.288059671649;5096.592272618182;5143.09995750744;5172.586193104561;4871.658983871131;4990.600751939836;4993.625478089158;4999.3000979862845;5036.697798132123;5376;5383.757730902119;5392.649477783971;5394.136938089926;5427.511523962823;5906.940930590682;5999.790007349766;6002.069679199731;6003.729832157564;6068;5969.731362088716;6010.308814486346;6039.788607398764;6048.60684055535;6070.453659170652;5564.805231816867;5724.084146536576;5738.454846789548;5738.770449182028;5748.338941021836;5932.317783454958;5944.791932282349;6085.5435842312;6128.3565225651555;6160.10678451622;5842.766289348378;5850.882982340415;5865.736041878125;5871.588988770745;5892.587518873724;5914.822555323261;5947.791827286111;5950.31571369298;5950.702464876739;5953.970230148908;5720.68536230503;5807.186993820868;5839.153322768175;5911.201987731602;5923.407659234128;5830.970845145747;5858.589898707135;5860.355360910296;5864.70676466175;5968.612040217459;4525.0497395546645;4527.886802829889;4532.116237333688;4542.545745425431;4558.316252562142;4046.4132700758223;4059.5331536873045;4074.714769966133;4132.318167502329;4137.958620413818;5728.627639203439;5787.305523337226;5787.363390027093;5790.10253410722;5792.681402522818;6056.303525094582;6103;6109.419605137505;6111.84720381994;6124.479419249414;5445.591580631469;5598.720063996784;5686.715664216773;5795.304563452412;5798.391168927202;5047.899042019139;5052.5452709255605;5053.216751403538;5076.6446348755235;5100.566451851634;6004.909926351195;6256.7810126645345;6258.499320054385;6262.966610509215;6263.749450022039;5996.220491336098;6017.849553761191;6103.241942475062;6103.9774818233145;6136.171616831671;6213.720382582705;6222.408871157233;6226.657533835682;6234.37656234391;6234.719437625408;5623.100303951512;5719.513841323368;5946.1972633693895;5958.791442299499;5994.760209591567;5938.198343223609;6001.06983417571;6015.699215039318;6021.698915054142;6039.456448919618;5773.278340207474;5811.970940145272;5818.796342128006;5821.27234095738;5852.356240813422;5650.434956504317;5711.400302968294;5740.6268592541355;5757.3954734753925;5846.649201047951;5558.972205138948;5779.595428319977;5802;5806.535477161901;5807.970960145172;5883.146943693226;5920.970395148169;5928.762849485972;5929.258842644669;5931.525477961839;5555.416681248411;5596.720163991866;5648.971755141198;5703.08750599902;5762.423757624204 14:16:59 INFO - 2016-01-04 14:16:59,150 DEBUG : BROWSER_OUTPUT: |1;ext.html;578.6499168003357;611.7461253579764;630.165031333483;635.7043974551835;640.6124294801642;32903.83548082259;33633.83183084081;33682.83158584207;42473;42940;47687.76156119223;48014.519854801445;48108.51891481084;48216.51783482173;48395;8915.242204412632;9157.95421022894;9159.908400916005;9161.770955726093;9161.862572061424;8326;8510.957445212796;10885.074768644636;11139.888601113966;11150.219484636078;10726.946365268202;10840.349579025244;10847.077998370149;10851.67444976652;10855.620053298137;8386.161383861627;8578.914210857936;10676.78646427071;10692.625758098508;10778.946105269462;8252.257296843252;10572.788544229072;10728.141748660088;10768.892311076866;10770.56917723298;39184.21631567381;39644;39695.80152099221;39741.80129099365;39782;3675.7794532328144;3785.6592906638534;3838.3858582626644;3857.286402015636;4287.506936702288;33352.83323583391;33397;33612.15969600755;33842.323153537036;34255.31489370199;4109.301418758818;4232.153569286155;4269.423627810268;4291.9785401072795;4299.505556860939;304583;304760;305160;307177;307751.4612426946;61080.69459652673;61986.38013619896;68082.65958670175;68533.65733171302;74349.62825185839;67634.66182669056;67667;67766.66116669386;68135.65932170307;68237;18243.17905694247;18415.171317290755;18442.815571844378;18509.074546272634;18524.722129168073;14105.85894141066;14140.787888181685;14174.787378189336;14177.078489898124;14177.44048154702;22440.214592489512;22746.09015639389;22763.430914226945;22779.658305125435;22930;8301.418900676894;8476.576171191417;8592.509759677372;8644.524551149621;8654.264387527004;1013.8225810483136;1067.4502631144967;1094.3816743539874;1119.7424592343807;1169.3568537304448;31566.36867262642;33844.323113538085;35019.64980350215;35125.824370877985;35544.82227588846;1105.7622611138643;1182.5447202826974;1182.9940850295693;1235.765204611121;1276.6616846535676;14836.406543738345;15206.923965380101;15670.216489175724;17414.738778918327;17669.469915902286;438472;442224;443376;443678;445478;61616.69191654103;62400.375996239454;62508.37491625026;62520.37479625236;62609;1437.1520802726232;1452.782082687584;1466.8973171878079;1484;1485.2870622101452;31048.22379440532;34220.82889585536;34503;34674;34693.47959780555;56162.438375617356;57254.42745572491;57258.42741572531;57392.1391179141;57403.42596573981;333835;334518;335399;336852;337130;34701;35534;35642.821785890905;36039.63960360363;36066.27867442689;48448.5155148444;48528;49372.25941610807;49680.50319496759;49784.25323620076;39245;40212.39681404723;40234;40441.39337909993;40674;39911;40993;41056.178876421705;41107.58892411157;41366.1726765469;39656;39881;45040;45966.540334596226;46018.76990615026;33429.83285083657;34910;35066.546413071184;35534;36101.27797444089;26566.867165664047;27268.863655681595;27272;27285.181444556696;27291.477190838297 14:16:59 INFO - 2016-01-04 14:16:59,151 DEBUG : BROWSER_OUTPUT: |2;jquery.html;365.2749292654081;367.53690350158803;367.5846293688132;368.5724559510967;371.3353097954661;15028.323725432354;15085.773713394281;17328.740068898962;17792.82207177928;18327.908360458197;14505.202213878232;17484.125793710326;17855;17968;18056.18747156378;5187.221916712504;5321.574274058085;5367.785288588452;5474.644148130379;5489.4236105208975;3824.9043773905737;3917.784521851297;5178.223266510016;5304.92042619361;5317.707526086083;5230.21546767984;5246.134387826004;5265.0259701955065;5272.182811664198;5276.3668359796875;5220.347456567929;5224.111900976843;5232.3459567554055;5385.192221166817;5401.351837779492;5342.572594192456;5347.786088556453;5359.785608575652;5365.114756065244;5368.651037682538;12580;20351.796482035137;20615.89692051545;21090;21204.151833926626;2214.6677998300224;2226.443389152712;2252.609851943014;2275.635898256271;2349.3304408243566;9832.262580306435;9995.500224988722;10250.641227557;13271.402786874614;13568.728625427535;1952.4142757172933;1952.4337941996803;1962.1660794162567;2011.215625905898;2012.748406449194;65759.3424065758;67055.3294467054;67668.6616566919;69169.65415172942;69517.30482695159;10225.284230103971;10525.947370263253;10740.677779666466;10763.730906727238;10802.459877006275;13275.933620331836;13292.534761283501;13319.667008324675;13330.733385332433;13348.733025339634;8053.798655033554;8244.587770611566;8328.6668533258;8388.370872184489;8402.159784021549;8394.076651568323;8414.200650938152;8421.15788421153;8508.957455212809;8519.403641745019;4510.2783554631105;4536.705114167568;4570.428696412949;4575.267957126844;4624.12141693084;1730.39928682026;1816.1645643004365;1825.4067428085925;1864.3195233739586;1867.215769376865;930.6417029443713;1032.9845052324222;1048.3605000949415;1078.1590359519587;1086.2559146984183;17493.387731429593;17625.911870440566;18076.276948921895;18106.728399074025;18115.003674798012;485.18488938583516;489.8359049718313;496.9254611808258;926.0183207935024;1079.2660990526517;5920.644761314335;6198.876022479525;6287.371262873768;6325.5255855811;6335.144755458046;447408;454178;460704;464141;708222;74528.62735686287;77277.61361193158;85031.57484212663;85049;85936;517.3533083645443;519.7375325460619;527.0039625108548;531.4260598553553;533.4585395823243;11237.71905702364;11287.717807054889;11296.209265351676;11469.942650286695;15847.969881958097;35997;39252.41121383238;39288.21423571456;40476;40559.39160912648;48596;49269.75365123151;49358.25962610635;50342.49657503525;51867;10012.599496020077;10245.590176392861;10253.436061016715;10281.434521101412;10450.68647940563;11686.357250351311;11768.470418831002;11771.823422648838;11850.940745296219;11858.16992810495;13860.792088118485;15847.841521585098;15890.841091588936;16332.265048073103;16506.174691265147;14575.708485830011;15257.694846102793;15360.769588455958;15459.768103478233;15954.04275743459;9008.459492430475;9264.027277135803;10450.059494645518;15991.280392382138;16357.18214089267;15262.694746104793;15554.688906221585;16003.599910001878;16021.519354419386;16060.357585696442;10713.785724285315;11048.281861678965;11059.83410248863;11072;11459.48432320531 14:16:59 INFO - 2016-01-04 14:16:59,152 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1556.400785697506;1564.6401327694623;1611.9758203626955;1832.6059897122118;1852.8888266704002;6590.340965903407;7734;7887.92112078879;7901.32838708709;7919.366450683946;7925.564093974829;8145;8146.2261085196815;8147.103818579952;8148.429609927308;2035.9287424940055;2073.388350436617;2077.0757013129164;2336.789688927996;2381.368937231635;2328.685627440291;2370.691810064689;2377.2749311459997;2377.6671266022686;2378.203301893859;2282.5206706591553;2292.5185711000627;2324.476992676651;2325.1164557468223;2331.4987277735286;2317.432229103872;2322.605157123293;2361.9645705314433;2365.3968238099346;2375.97624023761;2318.2465698648007;2324.418895276181;2331.94170145746;2361.362432143329;2362.2913126062285;8192.713255036104;8263.380246481538;8282.088970213272;8283.958580207121;8289.917100828974;4862.5380588844;4930.161872481651;4957.7769000395065;4960.801567937278;4963.528464795839;3097.7521798256084;3116.8285744284053;3117.6258848938046;3129.8435078246;3165.667604901498;963.0465838819588;966.3622009473784;986.6398764450995;1004.4274763384874;1021.1065317846884;11412.54349826006;11416;11422.657320280405;11433.656990290221;11440.256383335056;4350.303951367766;4364.650827933758;4380.102079073846;4407;4423.447069116361;9713.07725766051;9741;9744.561494732754;9763.170130538841;9768.951155244178;4901.607871370353;4957.950420495821;4963.057019166346;4964.453910069889;4966.329545511382;4465.687401881902;4487.304467807495;4528.5245049270015;4532.320151977164;4533.750643714561;3328.6504916983367;3430.382531144418;3655.83548740302;3709.091272638167;3741.812909354576;1144.8053830848776;1149.5286932357694;1152.809786385237;1154.4977934598476;1162.9476673549711;1098.423327752936;1115.007643197555;1115.2137742891243;1288.5361269942814;1381.9654508637364;7351.044364232723;7410.629468526552;7431.071116110486;7522.3605993491165;7528.811779705442;1165.2658824940404;1176.3882780953857;1188.631524227475;1196.234409977615;1197.9820302695466;5684.971575142181;5738.512226460798;5739.512141467939;5740.167675687086;5743.10981797822;9437.150656440954;9770.853437198306;9777.41335519871;9808.117269445642;9826.606935722491;9769.413835169771;9865.901340986642;9870.358426702242;9874.901250987541;9883.30816842814;7578.848423031509;7725.768226953088;7739.110002349689;7747.30274275318;7820.217978202248;7020.684069217;7069.22238553769;7104.254053324326;7127.607981561064;7134.393576545845;8646.265067469336;8671.21959023691;8709.042005379277;8711.21599056088;8808.339374546806;8890.244329232088;8993.32550058735;9074.183323500916;9077.228435583049;9162.816743665222;7096.2548932363425;7124.85750284981;7127.75052873147;7131.322524360177;7139.8572028560175;6959.7216111357;7144.214136445091;7592.4305677073335;7755.68977240904;7762.68949242024;7218.314260145278;7235.529690570096;7239.914012897897;7299.160596531467;7342.706291748484;7212.386947109554;7234.421246300178;7276.96361518189;7290;7307.232740562377;7260.092488438945;7304.817379565553;7345.045144131229;7346;7362.852742945004;6163.229596300463;6171.938280617136;6172.753089876354;6190.442860142609;6196.039613859859;6314.305426403;6370.649614271259;6375.171227740364;6377.266614339411;6447.484201263981 14:16:59 INFO - 2016-01-04 14:16:59,156 DEBUG : BROWSER_OUTPUT: |4;prototype.html;366.78726338723527;368.1403921842498;368.71056220866615;373.21997026215206;377.83375314861456;5971.193888825007;6081.239845019372;6090.17782599349;6096.420840020197;6119.449249567538;5963.16515687803;5971.641701497902;5985.102234664802;5987.491063259628;5989.970050149754;4722.220833562458;4722.38608980832;4726.432828060629;4729.47975722672;4731.172044892147;4629.6990695604845;4720.551547602972;4720.693154944935;4722.527747225285;4727.290906364038;4643.582077613014;4651.209294419939;4658.138244424776;4659.930101048487;4664.277037059244;4491.056878055612;4581.3815134956685;4645.86062418128;4652.209124448852;4653.0228651983125;4103.261412945669;4136.648384887289;4164.875053748392;4174.791260436966;4182.247195504808;5752.7986520472;5758.395368486333;5769.307683078057;5774.740136693859;5777.364489906107;5217.895642087137;5347.839564813062;5360.9463905360835;5482.835514934558;5503.284573005523;6401.295857455676;6417.422431981144;6429.38920802523;6430.935690643128;6437.163168788027;4628;4629.976850115761;4630.722156670577;4631.4673812511655;4633.559811817872;6540.182477190351;6674.3325667433355;6683.4987375947;6684.532082754209;6689.732410703615;4756.143894099096;4766.523347665275;4767.427908650984;4771.165046116916;4774.331593576902;4848.442429120626;4852.8544143675745;4855.781489832966;4856.854294371175;4859.198232291632;5517.944820551824;5530.806421775299;5535;5535.667859928417;5536.252605898233;6388.872222555523;6478.708458119396;6483.967580162163;6491.480681545465;6493;1682.7139386304357;1714.8456638902558;1715.3395942561954;1716.4078392954411;1716.9656606867793;1157.745296034871;1181.5037684172669;1182.4974385885964;1186.424584076722;1208.8670246272902;6208.596441231305;6224.221972253468;6229.345918678564;6231.937680623227;6238.65687387189;6684.2647308795995;6700.865982680319;6713.429358504484;6714.395704386531;6714.462842972551;6212.72042758077;6276.403741644536;6339.683015849189;6340.556161068681;6342.270638876588;3598.0285322962654;3636.6726994570618;3639.7816131032223;3667.468217108504;3668.156324045431;6975.476839237078;6989.231184569693;6989.615571143636;6996.650167491605;6998.545094568837;6433.678316084177;6688.899666505006;6916.827079322957;6929.514933954575;6935.757248496278;6846.315368463213;6946.756863509753;6956.8956465653055;6969.895451568129;6972.2330543640155;6762.932370676231;6765.221999470124;6771.52599318043;6774.4580433564215;6777.966110169417;6569.310222426768;6667.233268174028;6676.632785196861;6678.899816502853;6682.899756503753;6923.4807389447;6951.339622735832;6959.408450281783;6963.895541566982;6972.79081627552;4647;4679.298105284234;4709;4710.717356958594;4711.293306004127;6642.070110184674;6751;6756.932430675631;6758.0876581662815;6758.898616520854;6538.084668146558;6547.869042619026;6554.770583029571;6555.180602424697;6555.4427873631275;6574.309697481695;6575.506836987341;6577.276499584946;6580.177477815273;6584.078229048033;6354.301026887131;6473.514486413632;6483.837904052248;6484.902726459201;6487.610743355413;6604.768833090819;6618.172728408949;6620;6621.569597976116;6631.403173714389;6389.169407976933;6461.870762584628;6464.095026696173;6470.644114573555;6470.708818103102 14:16:59 INFO - 2016-01-04 14:16:59,156 DEBUG : BROWSER_OUTPUT: |5;yui.html;860.2429861721685;921.6589861751153;927.0821886332533;939.6053657463865;939.8543225799995;16258.105804180781;16300.673986520293;16308.347666093357;16319.428819991303;16324.265408056637;15749.84250157498;15915.602109947256;15926.84073159268;15932.761008584881;15944.521664350088;763.2405756272517;776.2198990015027;923.1276443760648;938.6761567259284;940.1585580905086;948.8244674735162;950.0452045694068;954.0507195340646;954.4941181173989;955.7132860141965;806.2783808491397;815.8613035783931;989.6684610655439;991.2664628175135;992.2161492420979;976.199516396555;986.4623780039896;988.0564061321421;988.1748739802274;993.746594618375;722.9132504099489;723.0094770164856;723.1466869094467;724.6847621284758;727.4762171236754;12967.286799226038;13103.60689179326;13106.148100373444;13145.474181032747;13234.139780914209;13304.20174789506;13615.931920340434;13690;13893.513727019506;14211.076280041763;10867.728306792314;11349.546018159264;11436.085113190924;11462.770744585061;11465.312081275068;4083.4283200351974;4122.546519882811;4130.070734084837;4160.417541544186;4176.4570605821355;50559;50581.494185058415;50629.49370506284;50842.49157508415;51664.74167629138;10847.240693151403;10936.617218397478;11185.832212516818;11236.719082022852;11371.658850234506;17240.224189911485;17257.39599114025;17291.481255562354;17301.13494325304;17302.91348543249;7833.843323133619;7897.842043159219;7966.442349035512;8014.278714915686;8271.048829384577;4899.436564795023;4935.679180853233;4961.975190124026;4971.602271818246;4973.104841128559;3225.3549290142064;3249.382617302705;3267;3270.967290327114;3280.065181423283;628.9716962736687;631.4443289904946;634.2420807135521;635.758411803521;638.5753473939778;708.8511412603308;710.9786706398713;712.814668186265;732.1214542548962;753.7437271327775;8535.189157030196;9095.49974751395;9104.362694611445;9301.674441394518;9357.906420935704;581.3953488372103;615.230961298377;685.8249664005072;700.7722490190708;740.489062546841;4512.187806194916;4525.547445255448;4564.817407303737;4613.331066995267;4738.8341408050555;62100.68949655223;65281.67359163174;66076;66553.66723166354;66728.33271667318;56847.55811516238;58017.41982580205;58054.70972645194;58070.7096464515;58441.8311633765;49071.509284907406;49289;50259;51859.22211166836;52369;9206.631734730536;9472.431654100776;9565.760855978378;9611.519424028911;9931.553080111267;37315.25369492649;39887.2022559553;40108;40211.59788402078;40252;50882;51621.22568161556;52540;52628.47371526389;52863.207051893485;11050.171237157407;11361.943190283995;11741.823872641746;12008.699782505508;12329.198602090835;12779.208872900424;13360.331983400596;13374.732505349644;13721.588352349445;13902.86097139056;12338.198017128858;12541.498340066295;12612.306323152316;12740.936295318465;13278.80081798793;12087.153899226969;12197.390130493617;12270.32513211782;12573.685657858627;12957;10834.133269338276;10892.727681808019;11013.504392302206;11084.722881928017;11299.322040677585;10072.949635251776;10768.469409688874;11092.556297748;11164.720881978015;11244.381559014333;10746.462676866282;10848.511816968414;10932.398718070583;10938.289011214245;10985.121190304597 14:16:59 INFO - 2016-01-04 14:16:59,156 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:16:59 INFO - 2016-01-04 14:16:59,156 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:16:59 INFO - 2016-01-04 14:16:59,156 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,880 14:16:59 INFO - 2016-01-04 14:16:59,156 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:16:59 INFO - 2016-01-04 14:16:59,157 DEBUG : BROWSER_OUTPUT: __startTimestamp1451945819146__endTimestamp 14:16:59 INFO - 2016-01-04 14:16:59,157 DEBUG : BROWSER_OUTPUT: 14:16:59 INFO - 2016-01-04 14:16:59,157 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:16:59 INFO - 2016-01-04 14:16:59,158 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:16:59 INFO - 2016-01-04 14:16:59,158 DEBUG : BROWSER_OUTPUT: 14:16:59 INFO - 2016-01-04 14:16:59,158 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5548.65 Median:5773.28 stddev:623.52 (10.8%) stddev-sans-first:600.39 14:16:59 INFO - 2016-01-04 14:16:59,160 DEBUG : BROWSER_OUTPUT: Values: 3318.5 3364.0 3364.4 3371.7 3382.5 5568.4 5570.7 5576.5 5581.3 5632.6 5591.7 5598.3 5598.8 5612.6 5634.4 4865.3 5099.0 5120.4 5188.2 5237.5 5046.3 5085.3 5104.5 5164.1 5169.7 5074.5 5103.2 5103.9 5108.4 5116.5 4921.9 5085.3 5096.6 5143.1 5172.6 4871.7 4990.6 4993.6 4999.3 5036.7 5376.0 5383.8 5392.6 5394.1 5427.5 5906.9 5999.8 6002.1 6003.7 6068.0 5969.7 6010.3 6039.8 6048.6 6070.5 5564.8 5724.1 5738.5 5738.8 5748.3 5932.3 5944.8 6085.5 6128.4 6160.1 5842.8 5850.9 5865.7 5871.6 5892.6 5914.8 5947.8 5950.3 5950.7 5954.0 5720.7 5807.2 5839.2 5911.2 5923.4 5831.0 5858.6 5860.4 5864.7 5968.6 4525.0 4527.9 4532.1 4542.5 4558.3 4046.4 4059.5 4074.7 4132.3 4138.0 5728.6 5787.3 5787.4 5790.1 5792.7 6056.3 6103.0 6109.4 6111.8 6124.5 5445.6 5598.7 5686.7 5795.3 5798.4 5047.9 5052.5 5053.2 5076.6 5100.6 6004.9 6256.8 6258.5 6263.0 6263.7 5996.2 6017.8 6103.2 6104.0 6136.2 6213.7 6222.4 6226.7 6234.4 6234.7 5623.1 5719.5 5946.2 5958.8 5994.8 5938.2 6001.1 6015.7 6021.7 6039.5 5773.3 5812.0 5818.8 5821.3 5852.4 5650.4 5711.4 5740.6 5757.4 5846.6 5559.0 5779.6 5802.0 5806.5 5808.0 5883.1 5921.0 5928.8 5929.3 5931.5 5555.4 5596.7 5649.0 5703.1 5762.4 14:16:59 INFO - 2016-01-04 14:16:59,160 DEBUG : BROWSER_OUTPUT: 14:16:59 INFO - 2016-01-04 14:16:59,160 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:54958.75 Median:36052.96 stddev:96168.73 (266.7%) stddev-sans-first:96351.83 14:16:59 INFO - 2016-01-04 14:16:59,162 DEBUG : BROWSER_OUTPUT: Values: 578.6 611.7 630.2 635.7 640.6 32903.8 33633.8 33682.8 42473.0 42940.0 47687.8 48014.5 48108.5 48216.5 48395.0 8915.2 9158.0 9159.9 9161.8 9161.9 8326.0 8511.0 10885.1 11139.9 11150.2 10726.9 10840.3 10847.1 10851.7 10855.6 8386.2 8578.9 10676.8 10692.6 10778.9 8252.3 10572.8 10728.1 10768.9 10770.6 39184.2 39644.0 39695.8 39741.8 39782.0 3675.8 3785.7 3838.4 3857.3 4287.5 33352.8 33397.0 33612.2 33842.3 34255.3 4109.3 4232.2 4269.4 4292.0 4299.5 304583.0 304760.0 305160.0 307177.0 307751.5 61080.7 61986.4 68082.7 68533.7 74349.6 67634.7 67667.0 67766.7 68135.7 68237.0 18243.2 18415.2 18442.8 18509.1 18524.7 14105.9 14140.8 14174.8 14177.1 14177.4 22440.2 22746.1 22763.4 22779.7 22930.0 8301.4 8476.6 8592.5 8644.5 8654.3 1013.8 1067.5 1094.4 1119.7 1169.4 31566.4 33844.3 35019.6 35125.8 35544.8 1105.8 1182.5 1183.0 1235.8 1276.7 14836.4 15206.9 15670.2 17414.7 17669.5 438472.0 442224.0 443376.0 443678.0 445478.0 61616.7 62400.4 62508.4 62520.4 62609.0 1437.2 1452.8 1466.9 1484.0 1485.3 31048.2 34220.8 34503.0 34674.0 34693.5 56162.4 57254.4 57258.4 57392.1 57403.4 333835.0 334518.0 335399.0 336852.0 337130.0 34701.0 35534.0 35642.8 36039.6 36066.3 48448.5 48528.0 49372.3 49680.5 49784.3 39245.0 40212.4 40234.0 40441.4 40674.0 39911.0 40993.0 41056.2 41107.6 41366.2 39656.0 39881.0 45040.0 45966.5 46018.8 33429.8 34910.0 35066.5 35534.0 36101.3 26566.9 27268.9 27272.0 27285.2 27291.5 14:16:59 INFO - 2016-01-04 14:16:59,162 DEBUG : BROWSER_OUTPUT: 14:16:59 INFO - 2016-01-04 14:16:59,162 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28280.54 Median:19173.17 stddev:84745.48 (442.0%) stddev-sans-first:84957.29 14:16:59 INFO - 2016-01-04 14:16:59,164 DEBUG : BROWSER_OUTPUT: Values: 365.3 367.5 367.6 368.6 371.3 15028.3 15085.8 17328.7 17792.8 18327.9 14505.2 17484.1 17855.0 17968.0 18056.2 5187.2 5321.6 5367.8 5474.6 5489.4 3824.9 3917.8 5178.2 5304.9 5317.7 5230.2 5246.1 5265.0 5272.2 5276.4 5220.3 5224.1 5232.3 5385.2 5401.4 5342.6 5347.8 5359.8 5365.1 5368.7 12580.0 20351.8 20615.9 21090.0 21204.2 2214.7 2226.4 2252.6 2275.6 2349.3 9832.3 9995.5 10250.6 13271.4 13568.7 1952.4 1952.4 1962.2 2011.2 2012.7 65759.3 67055.3 67668.7 69169.7 69517.3 10225.3 10525.9 10740.7 10763.7 10802.5 13275.9 13292.5 13319.7 13330.7 13348.7 8053.8 8244.6 8328.7 8388.4 8402.2 8394.1 8414.2 8421.2 8509.0 8519.4 4510.3 4536.7 4570.4 4575.3 4624.1 1730.4 1816.2 1825.4 1864.3 1867.2 930.6 1033.0 1048.4 1078.2 1086.3 17493.4 17625.9 18076.3 18106.7 18115.0 485.2 489.8 496.9 926.0 1079.3 5920.6 6198.9 6287.4 6325.5 6335.1 447408.0 454178.0 460704.0 464141.0 708222.0 74528.6 77277.6 85031.6 85049.0 85936.0 517.4 519.7 527.0 531.4 533.5 11237.7 11287.7 11296.2 11469.9 15848.0 35997.0 39252.4 39288.2 40476.0 40559.4 48596.0 49269.8 49358.3 50342.5 51867.0 10012.6 10245.6 10253.4 10281.4 10450.7 11686.4 11768.5 11771.8 11850.9 11858.2 13860.8 15847.8 15890.8 16332.3 16506.2 14575.7 15257.7 15360.8 15459.8 15954.0 9008.5 9264.0 10450.1 15991.3 16357.2 15262.7 15554.7 16003.6 16021.5 16060.4 10713.8 11048.3 11059.8 11072.0 11459.5 14:16:59 INFO - 2016-01-04 14:16:59,164 DEBUG : BROWSER_OUTPUT: 14:16:59 INFO - 2016-01-04 14:16:59,164 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5629.81 Median:6193.24 stddev:2961.95 (47.8%) stddev-sans-first:2954.43 14:16:59 INFO - 2016-01-04 14:16:59,165 DEBUG : BROWSER_OUTPUT: Values: 1556.4 1564.6 1612.0 1832.6 1852.9 6590.3 7734.0 7887.9 7901.3 7919.4 7925.6 8145.0 8146.2 8147.1 8148.4 2035.9 2073.4 2077.1 2336.8 2381.4 2328.7 2370.7 2377.3 2377.7 2378.2 2282.5 2292.5 2324.5 2325.1 2331.5 2317.4 2322.6 2362.0 2365.4 2376.0 2318.2 2324.4 2331.9 2361.4 2362.3 8192.7 8263.4 8282.1 8284.0 8289.9 4862.5 4930.2 4957.8 4960.8 4963.5 3097.8 3116.8 3117.6 3129.8 3165.7 963.0 966.4 986.6 1004.4 1021.1 11412.5 11416.0 11422.7 11433.7 11440.3 4350.3 4364.7 4380.1 4407.0 4423.4 9713.1 9741.0 9744.6 9763.2 9769.0 4901.6 4958.0 4963.1 4964.5 4966.3 4465.7 4487.3 4528.5 4532.3 4533.8 3328.7 3430.4 3655.8 3709.1 3741.8 1144.8 1149.5 1152.8 1154.5 1162.9 1098.4 1115.0 1115.2 1288.5 1382.0 7351.0 7410.6 7431.1 7522.4 7528.8 1165.3 1176.4 1188.6 1196.2 1198.0 5685.0 5738.5 5739.5 5740.2 5743.1 9437.2 9770.9 9777.4 9808.1 9826.6 9769.4 9865.9 9870.4 9874.9 9883.3 7578.8 7725.8 7739.1 7747.3 7820.2 7020.7 7069.2 7104.3 7127.6 7134.4 8646.3 8671.2 8709.0 8711.2 8808.3 8890.2 8993.3 9074.2 9077.2 9162.8 7096.3 7124.9 7127.8 7131.3 7139.9 6959.7 7144.2 7592.4 7755.7 7762.7 7218.3 7235.5 7239.9 7299.2 7342.7 7212.4 7234.4 7277.0 7290.0 7307.2 7260.1 7304.8 7345.0 7346.0 7362.9 6163.2 6171.9 6172.8 6190.4 6196.0 6314.3 6370.6 6375.2 6377.3 6447.5 14:16:59 INFO - 2016-01-04 14:16:59,166 DEBUG : BROWSER_OUTPUT: 14:16:59 INFO - 2016-01-04 14:16:59,166 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5463.37 Median:6210.66 stddev:1620.04 (26.1%) stddev-sans-first:1578.78 14:16:59 INFO - 2016-01-04 14:16:59,167 DEBUG : BROWSER_OUTPUT: Values: 366.8 368.1 368.7 373.2 377.8 5971.2 6081.2 6090.2 6096.4 6119.4 5963.2 5971.6 5985.1 5987.5 5990.0 4722.2 4722.4 4726.4 4729.5 4731.2 4629.7 4720.6 4720.7 4722.5 4727.3 4643.6 4651.2 4658.1 4659.9 4664.3 4491.1 4581.4 4645.9 4652.2 4653.0 4103.3 4136.6 4164.9 4174.8 4182.2 5752.8 5758.4 5769.3 5774.7 5777.4 5217.9 5347.8 5360.9 5482.8 5503.3 6401.3 6417.4 6429.4 6430.9 6437.2 4628.0 4630.0 4630.7 4631.5 4633.6 6540.2 6674.3 6683.5 6684.5 6689.7 4756.1 4766.5 4767.4 4771.2 4774.3 4848.4 4852.9 4855.8 4856.9 4859.2 5517.9 5530.8 5535.0 5535.7 5536.3 6388.9 6478.7 6484.0 6491.5 6493.0 1682.7 1714.8 1715.3 1716.4 1717.0 1157.7 1181.5 1182.5 1186.4 1208.9 6208.6 6224.2 6229.3 6231.9 6238.7 6684.3 6700.9 6713.4 6714.4 6714.5 6212.7 6276.4 6339.7 6340.6 6342.3 3598.0 3636.7 3639.8 3667.5 3668.2 6975.5 6989.2 6989.6 6996.7 6998.5 6433.7 6688.9 6916.8 6929.5 6935.8 6846.3 6946.8 6956.9 6969.9 6972.2 6762.9 6765.2 6771.5 6774.5 6778.0 6569.3 6667.2 6676.6 6678.9 6682.9 6923.5 6951.3 6959.4 6963.9 6972.8 4647.0 4679.3 4709.0 4710.7 4711.3 6642.1 6751.0 6756.9 6758.1 6758.9 6538.1 6547.9 6554.8 6555.2 6555.4 6574.3 6575.5 6577.3 6580.2 6584.1 6354.3 6473.5 6483.8 6484.9 6487.6 6604.8 6618.2 6620.0 6621.6 6631.4 6389.2 6461.9 6464.1 6470.6 6470.7 14:16:59 INFO - 2016-01-04 14:16:59,167 DEBUG : BROWSER_OUTPUT: 14:16:59 INFO - 2016-01-04 14:16:59,168 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15251.88 Median:26985.47 stddev:17857.11 (66.2%) stddev-sans-first:17874.50 14:16:59 INFO - 2016-01-04 14:16:59,169 DEBUG : BROWSER_OUTPUT: Values: 860.2 921.7 927.1 939.6 939.9 16258.1 16300.7 16308.3 16319.4 16324.3 15749.8 15915.6 15926.8 15932.8 15944.5 763.2 776.2 923.1 938.7 940.2 948.8 950.0 954.1 954.5 955.7 806.3 815.9 989.7 991.3 992.2 976.2 986.5 988.1 988.2 993.7 722.9 723.0 723.1 724.7 727.5 12967.3 13103.6 13106.1 13145.5 13234.1 13304.2 13615.9 13690.0 13893.5 14211.1 10867.7 11349.5 11436.1 11462.8 11465.3 4083.4 4122.5 4130.1 4160.4 4176.5 50559.0 50581.5 50629.5 50842.5 51664.7 10847.2 10936.6 11185.8 11236.7 11371.7 17240.2 17257.4 17291.5 17301.1 17302.9 7833.8 7897.8 7966.4 8014.3 8271.0 4899.4 4935.7 4962.0 4971.6 4973.1 3225.4 3249.4 3267.0 3271.0 3280.1 629.0 631.4 634.2 635.8 638.6 708.9 711.0 712.8 732.1 753.7 8535.2 9095.5 9104.4 9301.7 9357.9 581.4 615.2 685.8 700.8 740.5 4512.2 4525.5 4564.8 4613.3 4738.8 62100.7 65281.7 66076.0 66553.7 66728.3 56847.6 58017.4 58054.7 58070.7 58441.8 49071.5 49289.0 50259.0 51859.2 52369.0 9206.6 9472.4 9565.8 9611.5 9931.6 37315.3 39887.2 40108.0 40211.6 40252.0 50882.0 51621.2 52540.0 52628.5 52863.2 11050.2 11361.9 11741.8 12008.7 12329.2 12779.2 13360.3 13374.7 13721.6 13902.9 12338.2 12541.5 12612.3 12740.9 13278.8 12087.2 12197.4 12270.3 12573.7 12957.0 10834.1 10892.7 11013.5 11084.7 11299.3 10072.9 10768.5 11092.6 11164.7 11244.4 10746.5 10848.5 10932.4 10938.3 10985.1 14:16:59 INFO - 2016-01-04 14:16:59,169 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:16:59 INFO - 2016-01-04 14:16:59,169 DEBUG : BROWSER_OUTPUT: 14:16:59 INFO - 2016-01-04 14:16:59,752 INFO : Browser exited with error code: 0 14:16:59 INFO - 2016-01-04 14:16:59,767 INFO : Completed test dromaeo_css (00:18:30) 14:16:59 INFO - 2016-01-04 14:16:59,767 INFO : Starting test kraken 14:16:59 INFO - 2016-01-04 14:16:59,767 DEBUG : operating with platform_type : linux_ 14:16:59 INFO - 2016-01-04 14:16:59,767 INFO : Initialising browser for kraken test... 14:16:59 INFO - 2016-01-04 14:16:59,773 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp182raT/profile http://localhost:44809/getInfo.html 14:17:03 INFO - 2016-01-04 14:17:03,351 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:17:03 INFO - 2016-01-04 14:17:03,351 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:17:03 INFO - 2016-01-04 14:17:03,351 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:17:03 INFO - 2016-01-04 14:17:03,351 DEBUG : BROWSER_OUTPUT: __metrics 14:17:03 INFO - 2016-01-04 14:17:03,479 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:17:04 INFO - 2016-01-04 14:17:04,243 INFO : Browser initialized. 14:17:04 INFO - 2016-01-04 14:17:04,243 INFO : Running cycle 1/1 for kraken test... 14:17:04 INFO - 2016-01-04 14:17:04,244 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp182raT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:17:16 INFO - 2016-01-04 14:17:16,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 137576448 14:17:16 INFO - 2016-01-04 14:17:16,016 DEBUG : BROWSER_OUTPUT: 14:17:18 INFO - 2016-01-04 14:17:18,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44809/tests/kraken/driver.html?testName=audio-beat-detection) 14:17:19 INFO - 2016-01-04 14:17:19,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 167206912 14:17:19 INFO - 2016-01-04 14:17:19,054 DEBUG : BROWSER_OUTPUT: 14:17:21 INFO - 2016-01-04 14:17:21,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44809/tests/kraken/driver.html?testName=audio-dft) 14:17:22 INFO - 2016-01-04 14:17:22,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 165040128 14:17:22 INFO - 2016-01-04 14:17:22,191 DEBUG : BROWSER_OUTPUT: 14:17:24 INFO - 2016-01-04 14:17:24,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44809/tests/kraken/driver.html?testName=audio-fft) 14:17:25 INFO - 2016-01-04 14:17:25,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 163917824 14:17:25 INFO - 2016-01-04 14:17:25,563 DEBUG : BROWSER_OUTPUT: 14:17:27 INFO - 2016-01-04 14:17:27,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44809/tests/kraken/driver.html?testName=audio-oscillator) 14:17:28 INFO - 2016-01-04 14:17:28,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 162529280 14:17:28 INFO - 2016-01-04 14:17:28,113 DEBUG : BROWSER_OUTPUT: 14:17:30 INFO - 2016-01-04 14:17:30,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44809/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:17:30 INFO - 2016-01-04 14:17:30,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 161374208 14:17:30 INFO - 2016-01-04 14:17:30,856 DEBUG : BROWSER_OUTPUT: 14:17:33 INFO - 2016-01-04 14:17:33,694 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44809/tests/kraken/driver.html?testName=imaging-darkroom) 14:17:34 INFO - 2016-01-04 14:17:34,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 162578432 14:17:34 INFO - 2016-01-04 14:17:34,260 DEBUG : BROWSER_OUTPUT: 14:17:37 INFO - 2016-01-04 14:17:37,591 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44809/tests/kraken/driver.html?testName=imaging-desaturate) 14:17:38 INFO - 2016-01-04 14:17:38,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 162521088 14:17:38 INFO - 2016-01-04 14:17:38,165 DEBUG : BROWSER_OUTPUT: 14:17:40 INFO - 2016-01-04 14:17:40,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44809/tests/kraken/driver.html?testName=json-parse-financial) 14:17:41 INFO - 2016-01-04 14:17:41,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 162709504 14:17:41 INFO - 2016-01-04 14:17:41,440 DEBUG : BROWSER_OUTPUT: 14:17:42 INFO - 2016-01-04 14:17:42,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44809/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:17:43 INFO - 2016-01-04 14:17:43,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 168992768 14:17:43 INFO - 2016-01-04 14:17:43,558 DEBUG : BROWSER_OUTPUT: 14:17:45 INFO - 2016-01-04 14:17:45,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44809/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:17:45 INFO - 2016-01-04 14:17:45,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 167612416 14:17:45 INFO - 2016-01-04 14:17:45,899 DEBUG : BROWSER_OUTPUT: 14:17:47 INFO - 2016-01-04 14:17:47,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44809/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:17:48 INFO - 2016-01-04 14:17:48,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 176754688 14:17:48 INFO - 2016-01-04 14:17:48,453 DEBUG : BROWSER_OUTPUT: 14:17:50 INFO - 2016-01-04 14:17:50,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:17:51 INFO - 2016-01-04 14:17:51,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 186159104 14:17:51 INFO - 2016-01-04 14:17:51,440 DEBUG : BROWSER_OUTPUT: 14:17:53 INFO - 2016-01-04 14:17:53,896 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:17:54 INFO - 2016-01-04 14:17:54,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 183926784 14:17:54 INFO - 2016-01-04 14:17:54,463 DEBUG : BROWSER_OUTPUT: 14:17:56 INFO - 2016-01-04 14:17:56,113 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44809/tests/kraken/driver.html?testName=ai-astar) 14:17:56 INFO - 2016-01-04 14:17:56,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 242348032 14:17:56 INFO - 2016-01-04 14:17:56,364 DEBUG : BROWSER_OUTPUT: 14:17:56 INFO - 2016-01-04 14:17:56,365 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:17:56 INFO - 2016-01-04 14:17:56,365 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:17:56 INFO - 2016-01-04 14:17:56,365 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:17:56 INFO - 2016-01-04 14:17:56,365 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:17:56 INFO - 2016-01-04 14:17:56,365 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;105;110;108;109;99;109;108;108 14:17:56 INFO - 2016-01-04 14:17:56,365 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;144;121;151;163;128;144;154;123;162;128 14:17:56 INFO - 2016-01-04 14:17:56,365 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;159;159;160;160;159;160;161;159;160 14:17:56 INFO - 2016-01-04 14:17:56,365 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;73;72;149;70;72;72;72;160;70 14:17:56 INFO - 2016-01-04 14:17:56,365 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;143;92;93;92;137;93;93;145 14:17:56 INFO - 2016-01-04 14:17:56,366 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;108;110;109;109;109 14:17:56 INFO - 2016-01-04 14:17:56,366 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;145;145;146;145;146;146;146 14:17:56 INFO - 2016-01-04 14:17:56,366 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;94;96;95;95;96;95;95;96 14:17:56 INFO - 2016-01-04 14:17:56,366 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;59;58;57;57;59;59;59;58;56 14:17:56 INFO - 2016-01-04 14:17:56,366 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;62;63;63;63;63;63;63;63 14:17:56 INFO - 2016-01-04 14:17:56,366 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;78;78;80;79;80;80;80;87;80 14:17:56 INFO - 2016-01-04 14:17:56,366 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;124;110;115;115;113;126;124;118;112 14:17:56 INFO - 2016-01-04 14:17:56,366 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;131;146;142;144;140;134;144;143;142;133 14:17:56 INFO - 2016-01-04 14:17:56,366 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;65;67;65;63;62;65;65;63;64 14:17:56 INFO - 2016-01-04 14:17:56,366 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:17:56 INFO - 2016-01-04 14:17:56,366 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:17:56 INFO - 2016-01-04 14:17:56,366 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,912 14:17:56 INFO - 2016-01-04 14:17:56,366 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:17:56 INFO - 2016-01-04 14:17:56,366 DEBUG : BROWSER_OUTPUT: __startTimestamp1451945876363__endTimestamp 14:17:56 INFO - 2016-01-04 14:17:56,366 DEBUG : BROWSER_OUTPUT: 14:17:56 INFO - 2016-01-04 14:17:56,370 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:17:56 INFO - 2016-01-04 14:17:56,370 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:17:56 INFO - 2016-01-04 14:17:56,370 DEBUG : BROWSER_OUTPUT: 14:17:56 INFO - 2016-01-04 14:17:56,370 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.60 Median:109.00 stddev:3.41 (3.1%) stddev-sans-first:3.57 14:17:56 INFO - 2016-01-04 14:17:56,370 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 105.0 110.0 108.0 109.0 99.0 109.0 108.0 108.0 14:17:56 INFO - 2016-01-04 14:17:56,370 DEBUG : BROWSER_OUTPUT: 14:17:56 INFO - 2016-01-04 14:17:56,370 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.80 Median:147.50 stddev:15.87 (10.8%) stddev-sans-first:16.82 14:17:56 INFO - 2016-01-04 14:17:56,370 DEBUG : BROWSER_OUTPUT: Values: 144.0 121.0 151.0 163.0 128.0 144.0 154.0 123.0 162.0 128.0 14:17:56 INFO - 2016-01-04 14:17:56,370 DEBUG : BROWSER_OUTPUT: 14:17:56 INFO - 2016-01-04 14:17:56,370 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.60 Median:160.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 14:17:56 INFO - 2016-01-04 14:17:56,371 DEBUG : BROWSER_OUTPUT: Values: 159.0 159.0 159.0 160.0 160.0 159.0 160.0 161.0 159.0 160.0 14:17:56 INFO - 2016-01-04 14:17:56,371 DEBUG : BROWSER_OUTPUT: 14:17:56 INFO - 2016-01-04 14:17:56,371 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.80 Median:72.00 stddev:34.79 (48.3%) stddev-sans-first:36.68 14:17:56 INFO - 2016-01-04 14:17:56,371 DEBUG : BROWSER_OUTPUT: Values: 78.0 73.0 72.0 149.0 70.0 72.0 72.0 72.0 160.0 70.0 14:17:56 INFO - 2016-01-04 14:17:56,371 DEBUG : BROWSER_OUTPUT: 14:17:56 INFO - 2016-01-04 14:17:56,371 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.50 Median:93.00 stddev:23.67 (25.4%) stddev-sans-first:24.59 14:17:56 INFO - 2016-01-04 14:17:56,371 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 143.0 92.0 93.0 92.0 137.0 93.0 93.0 145.0 14:17:56 INFO - 2016-01-04 14:17:56,371 DEBUG : BROWSER_OUTPUT: 14:17:56 INFO - 2016-01-04 14:17:56,371 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 14:17:56 INFO - 2016-01-04 14:17:56,371 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 108.0 110.0 109.0 109.0 109.0 14:17:56 INFO - 2016-01-04 14:17:56,371 DEBUG : BROWSER_OUTPUT: 14:17:56 INFO - 2016-01-04 14:17:56,371 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 14:17:56 INFO - 2016-01-04 14:17:56,371 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 145.0 145.0 146.0 145.0 146.0 146.0 146.0 14:17:56 INFO - 2016-01-04 14:17:56,372 DEBUG : BROWSER_OUTPUT: 14:17:56 INFO - 2016-01-04 14:17:56,372 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 14:17:56 INFO - 2016-01-04 14:17:56,372 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 94.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 14:17:56 INFO - 2016-01-04 14:17:56,372 DEBUG : BROWSER_OUTPUT: 14:17:56 INFO - 2016-01-04 14:17:56,372 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.50 stddev:1.05 (1.8%) stddev-sans-first:1.12 14:17:56 INFO - 2016-01-04 14:17:56,372 DEBUG : BROWSER_OUTPUT: Values: 58.0 59.0 58.0 57.0 57.0 59.0 59.0 59.0 58.0 56.0 14:17:56 INFO - 2016-01-04 14:17:56,372 DEBUG : BROWSER_OUTPUT: 14:17:56 INFO - 2016-01-04 14:17:56,372 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 14:17:56 INFO - 2016-01-04 14:17:56,372 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 62.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0 14:17:56 INFO - 2016-01-04 14:17:56,372 DEBUG : BROWSER_OUTPUT: 14:17:56 INFO - 2016-01-04 14:17:56,372 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:80.00 stddev:2.73 (3.4%) stddev-sans-first:2.68 14:17:56 INFO - 2016-01-04 14:17:56,372 DEBUG : BROWSER_OUTPUT: Values: 77.0 78.0 78.0 80.0 79.0 80.0 80.0 80.0 87.0 80.0 14:17:56 INFO - 2016-01-04 14:17:56,372 DEBUG : BROWSER_OUTPUT: 14:17:56 INFO - 2016-01-04 14:17:56,373 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:117.00 stddev:5.56 (4.8%) stddev-sans-first:5.88 14:17:56 INFO - 2016-01-04 14:17:56,373 DEBUG : BROWSER_OUTPUT: Values: 116.0 124.0 110.0 115.0 115.0 113.0 126.0 124.0 118.0 112.0 14:17:56 INFO - 2016-01-04 14:17:56,373 DEBUG : BROWSER_OUTPUT: 14:17:56 INFO - 2016-01-04 14:17:56,373 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.90 Median:142.50 stddev:5.28 (3.7%) stddev-sans-first:4.51 14:17:56 INFO - 2016-01-04 14:17:56,373 DEBUG : BROWSER_OUTPUT: Values: 131.0 146.0 142.0 144.0 140.0 134.0 144.0 143.0 142.0 133.0 14:17:56 INFO - 2016-01-04 14:17:56,373 DEBUG : BROWSER_OUTPUT: 14:17:56 INFO - 2016-01-04 14:17:56,373 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:65.00 stddev:1.42 (2.2%) stddev-sans-first:1.50 14:17:56 INFO - 2016-01-04 14:17:56,373 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 67.0 65.0 63.0 62.0 65.0 65.0 63.0 64.0 14:17:56 INFO - 2016-01-04 14:17:56,373 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:17:56 INFO - 2016-01-04 14:17:56,373 DEBUG : BROWSER_OUTPUT: 14:17:57 INFO - 2016-01-04 14:17:57,173 INFO : Browser exited with error code: 0 14:17:57 INFO - 2016-01-04 14:17:57,227 INFO : Completed test kraken (00:00:57) 14:17:57 INFO - 2016-01-04 14:17:57,227 INFO : Starting test v8_7 14:17:57 INFO - 2016-01-04 14:17:57,227 DEBUG : operating with platform_type : linux_ 14:17:57 INFO - 2016-01-04 14:17:57,227 INFO : Initialising browser for v8_7 test... 14:17:57 INFO - 2016-01-04 14:17:57,233 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoJhwoh/profile http://localhost:44809/getInfo.html 14:18:00 INFO - 2016-01-04 14:18:00,921 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:18:00 INFO - 2016-01-04 14:18:00,921 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:18:00 INFO - 2016-01-04 14:18:00,921 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:18:00 INFO - 2016-01-04 14:18:00,921 DEBUG : BROWSER_OUTPUT: __metrics 14:18:01 INFO - 2016-01-04 14:18:01,037 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:18:01 INFO - 2016-01-04 14:18:01,753 INFO : Browser initialized. 14:18:01 INFO - 2016-01-04 14:18:01,753 INFO : Running cycle 1/1 for v8_7 test... 14:18:01 INFO - 2016-01-04 14:18:01,753 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoJhwoh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:18:13 INFO - 2016-01-04 14:18:13,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 137252864 14:18:13 INFO - 2016-01-04 14:18:13,505 DEBUG : BROWSER_OUTPUT: 14:18:34 INFO - 2016-01-04 14:18:34,844 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44809/tests/v8_7/run.html (next: http://localhost:44809/tests/v8_7/run.html) 14:18:35 INFO - 2016-01-04 14:18:35,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 428142592 14:18:35 INFO - 2016-01-04 14:18:35,090 DEBUG : BROWSER_OUTPUT: 14:18:35 INFO - 2016-01-04 14:18:35,092 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:18:35 INFO - 2016-01-04 14:18:35,092 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:18:35 INFO - 2016-01-04 14:18:35,092 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:18:35 INFO - 2016-01-04 14:18:35,092 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:18:35 INFO - 2016-01-04 14:18:35,093 DEBUG : BROWSER_OUTPUT: |0;Richards;165.26194017517767 14:18:35 INFO - 2016-01-04 14:18:35,093 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.61111111111111 14:18:35 INFO - 2016-01-04 14:18:35,093 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 14:18:35 INFO - 2016-01-04 14:18:35,093 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 14:18:35 INFO - 2016-01-04 14:18:35,094 DEBUG : BROWSER_OUTPUT: |4;RayTrace;958.7727708533077 14:18:35 INFO - 2016-01-04 14:18:35,094 DEBUG : BROWSER_OUTPUT: |5;Earley;563.3802816901408 14:18:35 INFO - 2016-01-04 14:18:35,094 DEBUG : BROWSER_OUTPUT: |6;Boyer;11122.222222222223 14:18:35 INFO - 2016-01-04 14:18:35,094 DEBUG : BROWSER_OUTPUT: |7;RegExp;24357.14285714286 14:18:35 INFO - 2016-01-04 14:18:35,094 DEBUG : BROWSER_OUTPUT: |8;Splay;524.1090146750524 14:18:35 INFO - 2016-01-04 14:18:35,095 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 14:18:35 INFO - 2016-01-04 14:18:35,095 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:18:35 INFO - 2016-01-04 14:18:35,095 DEBUG : BROWSER_OUTPUT: __startTimestamp1451945915090__endTimestamp 14:18:35 INFO - 2016-01-04 14:18:35,095 DEBUG : BROWSER_OUTPUT: 14:18:35 INFO - 2016-01-04 14:18:35,096 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:18:35 INFO - 2016-01-04 14:18:35,096 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:18:35 INFO - 2016-01-04 14:18:35,096 DEBUG : BROWSER_OUTPUT: 14:18:35 INFO - 2016-01-04 14:18:35,096 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.26 Median:165.26 stddev:0.00 (0.0%) 14:18:35 INFO - 2016-01-04 14:18:35,096 DEBUG : BROWSER_OUTPUT: Values: 165.3 14:18:35 INFO - 2016-01-04 14:18:35,097 DEBUG : BROWSER_OUTPUT: 14:18:35 INFO - 2016-01-04 14:18:35,097 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.61 Median:173.61 stddev:0.00 (0.0%) 14:18:35 INFO - 2016-01-04 14:18:35,097 DEBUG : BROWSER_OUTPUT: Values: 173.6 14:18:35 INFO - 2016-01-04 14:18:35,097 DEBUG : BROWSER_OUTPUT: 14:18:35 INFO - 2016-01-04 14:18:35,097 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 14:18:35 INFO - 2016-01-04 14:18:35,097 DEBUG : BROWSER_OUTPUT: Values: 279.4 14:18:35 INFO - 2016-01-04 14:18:35,097 DEBUG : BROWSER_OUTPUT: 14:18:35 INFO - 2016-01-04 14:18:35,099 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 14:18:35 INFO - 2016-01-04 14:18:35,099 DEBUG : BROWSER_OUTPUT: Values: 5181.3 14:18:35 INFO - 2016-01-04 14:18:35,099 DEBUG : BROWSER_OUTPUT: 14:18:35 INFO - 2016-01-04 14:18:35,099 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:958.77 Median:958.77 stddev:0.00 (0.0%) 14:18:35 INFO - 2016-01-04 14:18:35,099 DEBUG : BROWSER_OUTPUT: Values: 958.8 14:18:35 INFO - 2016-01-04 14:18:35,099 DEBUG : BROWSER_OUTPUT: 14:18:35 INFO - 2016-01-04 14:18:35,099 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:563.38 Median:563.38 stddev:0.00 (0.0%) 14:18:35 INFO - 2016-01-04 14:18:35,099 DEBUG : BROWSER_OUTPUT: Values: 563.4 14:18:35 INFO - 2016-01-04 14:18:35,099 DEBUG : BROWSER_OUTPUT: 14:18:35 INFO - 2016-01-04 14:18:35,099 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11122.22 Median:11122.22 stddev:0.00 (0.0%) 14:18:35 INFO - 2016-01-04 14:18:35,099 DEBUG : BROWSER_OUTPUT: Values: 11122.2 14:18:35 INFO - 2016-01-04 14:18:35,099 DEBUG : BROWSER_OUTPUT: 14:18:35 INFO - 2016-01-04 14:18:35,099 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24357.14 Median:24357.14 stddev:0.00 (0.0%) 14:18:35 INFO - 2016-01-04 14:18:35,099 DEBUG : BROWSER_OUTPUT: Values: 24357.1 14:18:35 INFO - 2016-01-04 14:18:35,099 DEBUG : BROWSER_OUTPUT: 14:18:35 INFO - 2016-01-04 14:18:35,099 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:524.11 Median:524.11 stddev:0.00 (0.0%) 14:18:35 INFO - 2016-01-04 14:18:35,100 DEBUG : BROWSER_OUTPUT: Values: 524.1 14:18:35 INFO - 2016-01-04 14:18:35,100 DEBUG : BROWSER_OUTPUT: 14:18:35 INFO - 2016-01-04 14:18:35,100 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 14:18:35 INFO - 2016-01-04 14:18:35,100 DEBUG : BROWSER_OUTPUT: Values: 4835.7 14:18:35 INFO - 2016-01-04 14:18:35,100 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:18:35 INFO - 2016-01-04 14:18:35,100 DEBUG : BROWSER_OUTPUT: 14:18:35 INFO - 2016-01-04 14:18:35,889 INFO : Browser exited with error code: 0 14:18:35 INFO - 2016-01-04 14:18:35,904 INFO : Completed test v8_7 (00:00:38) 14:18:36 INFO - 2016-01-04 14:18:36,133 INFO : Completed test suite (00:20:06) 14:18:36 INFO - 2016-01-04 14:18:36,133 DEBUG : Working with test: dromaeo_css 14:18:36 INFO - 2016-01-04 14:18:36,134 DEBUG : Generating results file: dromaeo_css 14:18:36 INFO - 2016-01-04 14:18:36,135 DEBUG : Working with test: kraken 14:18:36 INFO - 2016-01-04 14:18:36,135 DEBUG : Generating results file: kraken 14:18:36 INFO - 2016-01-04 14:18:36,135 INFO : javascript benchmark 14:18:36 INFO - 2016-01-04 14:18:36,135 DEBUG : Working with test: v8_7 14:18:36 INFO - 2016-01-04 14:18:36,135 DEBUG : Generating results file: v8_7 14:18:36 INFO - 2016-01-04 14:18:36,136 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:18:36 INFO - 2016-01-04 14:18:36,187 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 14:18:36 INFO - 2016-01-04 14:18:36,187 DEBUG : process_Request line: dromaeo_css 7359.44 graph.html#tests=[[72,52,35]] 14:18:36 INFO - 2016-01-04 14:18:36,187 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:18:36 INFO - 2016-01-04 14:18:36,219 DEBUG : process_Request line: kraken 1477.70 graph.html#tests=[[232,52,35]] 14:18:36 INFO - 2016-01-04 14:18:36,219 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:18:36 INFO - 2016-01-04 14:18:36,247 DEBUG : process_Request line: v8_7 22943.17 graph.html#tests=[[230,52,35]] 14:18:36 INFO - 2016-01-04 14:18:36,248 INFO : javascript benchmark 14:18:36 INFO - 2016-01-04 14:18:36,252 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3318.518814771858, 3364.024432914455, 3364.444866597013, 3371.7134043606293, 3382.4926261060837, 5568.443155684435, 5570.6657600543895, 5576.5259952904, 5581.302337207844, 5632.633878797876, 5591.7483713232905, 5598.328200615932, 5598.832035038945, 5612.607117501777, 5634.436556344363, 4865.290343150933, 5099.005693889693, 5120.385553733558, 5188.247704082905, 5237.476252374751, 5046.268291097788, 5085.288059671649, 5104.5405913467785, 5164.147915593922, 5169.663971841818, 5074.517920797537, 5103.209002604603, 5103.948960510403, 5108.361454818148, 5116.462771409004, 4921.901561968776, 5085.288059671649, 5096.592272618182, 5143.09995750744, 5172.586193104561, 4871.658983871131, 4990.600751939836, 4993.625478089158, 4999.3000979862845, 5036.697798132123, 5376.0, 5383.757730902119, 5392.649477783971, 5394.136938089926, 5427.511523962823, 5906.940930590682, 5999.790007349766, 6002.069679199731, 6003.729832157564, 6068.0, 5969.731362088716, 6010.308814486346, 6039.788607398764, 6048.60684055535, 6070.453659170652, 5564.805231816867, 5724.084146536576, 5738.454846789548, 5738.770449182028, 5748.338941021836, 5932.317783454958, 5944.791932282349, 6085.5435842312, 6128.3565225651555, 6160.10678451622, 5842.766289348378, 5850.882982340415, 5865.736041878125, 5871.588988770745, 5892.587518873724, 5914.822555323261, 5947.791827286111, 5950.31571369298, 5950.702464876739, 5953.970230148908, 5720.68536230503, 5807.186993820868, 5839.153322768175, 5911.201987731602, 5923.407659234128, 5830.970845145747, 5858.589898707135, 5860.355360910296, 5864.70676466175, 5968.612040217459, 4525.0497395546645, 4527.886802829889, 4532.116237333688, 4542.545745425431, 4558.316252562142, 4046.4132700758223, 4059.5331536873045, 4074.714769966133, 4132.318167502329, 4137.958620413818, 5728.627639203439, 5787.305523337226, 5787.363390027093, 5790.10253410722, 5792.681402522818, 6056.303525094582, 6103.0, 6109.419605137505, 6111.84720381994, 6124.479419249414, 5445.591580631469, 5598.720063996784, 5686.715664216773, 5795.304563452412, 5798.391168927202, 5047.899042019139, 5052.5452709255605, 5053.216751403538, 5076.6446348755235, 5100.566451851634, 6004.909926351195, 6256.7810126645345, 6258.499320054385, 6262.966610509215, 6263.749450022039, 5996.220491336098, 6017.849553761191, 6103.241942475062, 6103.9774818233145, 6136.171616831671, 6213.720382582705, 6222.408871157233, 6226.657533835682, 6234.37656234391, 6234.719437625408, 5623.100303951512, 5719.513841323368, 5946.1972633693895, 5958.791442299499, 5994.760209591567, 5938.198343223609, 6001.06983417571, 6015.699215039318, 6021.698915054142, 6039.456448919618, 5773.278340207474, 5811.970940145272, 5818.796342128006, 5821.27234095738, 5852.356240813422, 5650.434956504317, 5711.400302968294, 5740.6268592541355, 5757.3954734753925, 5846.649201047951, 5558.972205138948, 5779.595428319977, 5802.0, 5806.535477161901, 5807.970960145172, 5883.146943693226, 5920.970395148169, 5928.762849485972, 5929.258842644669, 5931.525477961839, 5555.416681248411, 5596.720163991866, 5648.971755141198, 5703.08750599902, 5762.423757624204], "unit": "ms", "name": "dojo.html", "value": 5508.015437416121}, {"lowerIsBetter": false, "replicates": [578.6499168003357, 611.7461253579764, 630.165031333483, 635.7043974551835, 640.6124294801642, 32903.83548082259, 33633.83183084081, 33682.83158584207, 42473.0, 42940.0, 47687.76156119223, 48014.519854801445, 48108.51891481084, 48216.51783482173, 48395.0, 8915.242204412632, 9157.95421022894, 9159.908400916005, 9161.770955726093, 9161.862572061424, 8326.0, 8510.957445212796, 10885.074768644636, 11139.888601113966, 11150.219484636078, 10726.946365268202, 10840.349579025244, 10847.077998370149, 10851.67444976652, 10855.620053298137, 8386.161383861627, 8578.914210857936, 10676.78646427071, 10692.625758098508, 10778.946105269462, 8252.257296843252, 10572.788544229072, 10728.141748660088, 10768.892311076866, 10770.56917723298, 39184.21631567381, 39644.0, 39695.80152099221, 39741.80129099365, 39782.0, 3675.7794532328144, 3785.6592906638534, 3838.3858582626644, 3857.286402015636, 4287.506936702288, 33352.83323583391, 33397.0, 33612.15969600755, 33842.323153537036, 34255.31489370199, 4109.301418758818, 4232.153569286155, 4269.423627810268, 4291.9785401072795, 4299.505556860939, 304583.0, 304760.0, 305160.0, 307177.0, 307751.4612426946, 61080.69459652673, 61986.38013619896, 68082.65958670175, 68533.65733171302, 74349.62825185839, 67634.66182669056, 67667.0, 67766.66116669386, 68135.65932170307, 68237.0, 18243.17905694247, 18415.171317290755, 18442.815571844378, 18509.074546272634, 18524.722129168073, 14105.85894141066, 14140.787888181685, 14174.787378189336, 14177.078489898124, 14177.44048154702, 22440.214592489512, 22746.09015639389, 22763.430914226945, 22779.658305125435, 22930.0, 8301.418900676894, 8476.576171191417, 8592.509759677372, 8644.524551149621, 8654.264387527004, 1013.8225810483136, 1067.4502631144967, 1094.3816743539874, 1119.7424592343807, 1169.3568537304448, 31566.36867262642, 33844.323113538085, 35019.64980350215, 35125.824370877985, 35544.82227588846, 1105.7622611138643, 1182.5447202826974, 1182.9940850295693, 1235.765204611121, 1276.6616846535676, 14836.406543738345, 15206.923965380101, 15670.216489175724, 17414.738778918327, 17669.469915902286, 438472.0, 442224.0, 443376.0, 443678.0, 445478.0, 61616.69191654103, 62400.375996239454, 62508.37491625026, 62520.37479625236, 62609.0, 1437.1520802726232, 1452.782082687584, 1466.8973171878079, 1484.0, 1485.2870622101452, 31048.22379440532, 34220.82889585536, 34503.0, 34674.0, 34693.47959780555, 56162.438375617356, 57254.42745572491, 57258.42741572531, 57392.1391179141, 57403.42596573981, 333835.0, 334518.0, 335399.0, 336852.0, 337130.0, 34701.0, 35534.0, 35642.821785890905, 36039.63960360363, 36066.27867442689, 48448.5155148444, 48528.0, 49372.25941610807, 49680.50319496759, 49784.25323620076, 39245.0, 40212.39681404723, 40234.0, 40441.39337909993, 40674.0, 39911.0, 40993.0, 41056.178876421705, 41107.58892411157, 41366.1726765469, 39656.0, 39881.0, 45040.0, 45966.540334596226, 46018.76990615026, 33429.83285083657, 34910.0, 35066.546413071184, 35534.0, 36101.27797444089, 26566.867165664047, 27268.863655681595, 27272.0, 27285.181444556696, 27291.477190838297], "unit": "ms", "name": "ext.html", "value": 20973.836849792777}, {"lowerIsBetter": false, "replicates": [365.2749292654081, 367.53690350158803, 367.5846293688132, 368.5724559510967, 371.3353097954661, 15028.323725432354, 15085.773713394281, 17328.740068898962, 17792.82207177928, 18327.908360458197, 14505.202213878232, 17484.125793710326, 17855.0, 17968.0, 18056.18747156378, 5187.221916712504, 5321.574274058085, 5367.785288588452, 5474.644148130379, 5489.4236105208975, 3824.9043773905737, 3917.784521851297, 5178.223266510016, 5304.92042619361, 5317.707526086083, 5230.21546767984, 5246.134387826004, 5265.0259701955065, 5272.182811664198, 5276.3668359796875, 5220.347456567929, 5224.111900976843, 5232.3459567554055, 5385.192221166817, 5401.351837779492, 5342.572594192456, 5347.786088556453, 5359.785608575652, 5365.114756065244, 5368.651037682538, 12580.0, 20351.796482035137, 20615.89692051545, 21090.0, 21204.151833926626, 2214.6677998300224, 2226.443389152712, 2252.609851943014, 2275.635898256271, 2349.3304408243566, 9832.262580306435, 9995.500224988722, 10250.641227557, 13271.402786874614, 13568.728625427535, 1952.4142757172933, 1952.4337941996803, 1962.1660794162567, 2011.215625905898, 2012.748406449194, 65759.3424065758, 67055.3294467054, 67668.6616566919, 69169.65415172942, 69517.30482695159, 10225.284230103971, 10525.947370263253, 10740.677779666466, 10763.730906727238, 10802.459877006275, 13275.933620331836, 13292.534761283501, 13319.667008324675, 13330.733385332433, 13348.733025339634, 8053.798655033554, 8244.587770611566, 8328.6668533258, 8388.370872184489, 8402.159784021549, 8394.076651568323, 8414.200650938152, 8421.15788421153, 8508.957455212809, 8519.403641745019, 4510.2783554631105, 4536.705114167568, 4570.428696412949, 4575.267957126844, 4624.12141693084, 1730.39928682026, 1816.1645643004365, 1825.4067428085925, 1864.3195233739586, 1867.215769376865, 930.6417029443713, 1032.9845052324222, 1048.3605000949415, 1078.1590359519587, 1086.2559146984183, 17493.387731429593, 17625.911870440566, 18076.276948921895, 18106.728399074025, 18115.003674798012, 485.18488938583516, 489.8359049718313, 496.9254611808258, 926.0183207935024, 1079.2660990526517, 5920.644761314335, 6198.876022479525, 6287.371262873768, 6325.5255855811, 6335.144755458046, 447408.0, 454178.0, 460704.0, 464141.0, 708222.0, 74528.62735686287, 77277.61361193158, 85031.57484212663, 85049.0, 85936.0, 517.3533083645443, 519.7375325460619, 527.0039625108548, 531.4260598553553, 533.4585395823243, 11237.71905702364, 11287.717807054889, 11296.209265351676, 11469.942650286695, 15847.969881958097, 35997.0, 39252.41121383238, 39288.21423571456, 40476.0, 40559.39160912648, 48596.0, 49269.75365123151, 49358.25962610635, 50342.49657503525, 51867.0, 10012.599496020077, 10245.590176392861, 10253.436061016715, 10281.434521101412, 10450.68647940563, 11686.357250351311, 11768.470418831002, 11771.823422648838, 11850.940745296219, 11858.16992810495, 13860.792088118485, 15847.841521585098, 15890.841091588936, 16332.265048073103, 16506.174691265147, 14575.708485830011, 15257.694846102793, 15360.769588455958, 15459.768103478233, 15954.04275743459, 9008.459492430475, 9264.027277135803, 10450.059494645518, 15991.280392382138, 16357.18214089267, 15262.694746104793, 15554.688906221585, 16003.599910001878, 16021.519354419386, 16060.357585696442, 10713.785724285315, 11048.281861678965, 11059.83410248863, 11072.0, 11459.48432320531], "unit": "ms", "name": "jquery.html", "value": 8659.291301848645}, {"lowerIsBetter": false, "replicates": [1556.400785697506, 1564.6401327694623, 1611.9758203626955, 1832.6059897122118, 1852.8888266704002, 6590.340965903407, 7734.0, 7887.92112078879, 7901.32838708709, 7919.366450683946, 7925.564093974829, 8145.0, 8146.2261085196815, 8147.103818579952, 8148.429609927308, 2035.9287424940055, 2073.388350436617, 2077.0757013129164, 2336.789688927996, 2381.368937231635, 2328.685627440291, 2370.691810064689, 2377.2749311459997, 2377.6671266022686, 2378.203301893859, 2282.5206706591553, 2292.5185711000627, 2324.476992676651, 2325.1164557468223, 2331.4987277735286, 2317.432229103872, 2322.605157123293, 2361.9645705314433, 2365.3968238099346, 2375.97624023761, 2318.2465698648007, 2324.418895276181, 2331.94170145746, 2361.362432143329, 2362.2913126062285, 8192.713255036104, 8263.380246481538, 8282.088970213272, 8283.958580207121, 8289.917100828974, 4862.5380588844, 4930.161872481651, 4957.7769000395065, 4960.801567937278, 4963.528464795839, 3097.7521798256084, 3116.8285744284053, 3117.6258848938046, 3129.8435078246, 3165.667604901498, 963.0465838819588, 966.3622009473784, 986.6398764450995, 1004.4274763384874, 1021.1065317846884, 11412.54349826006, 11416.0, 11422.657320280405, 11433.656990290221, 11440.256383335056, 4350.303951367766, 4364.650827933758, 4380.102079073846, 4407.0, 4423.447069116361, 9713.07725766051, 9741.0, 9744.561494732754, 9763.170130538841, 9768.951155244178, 4901.607871370353, 4957.950420495821, 4963.057019166346, 4964.453910069889, 4966.329545511382, 4465.687401881902, 4487.304467807495, 4528.5245049270015, 4532.320151977164, 4533.750643714561, 3328.6504916983367, 3430.382531144418, 3655.83548740302, 3709.091272638167, 3741.812909354576, 1144.8053830848776, 1149.5286932357694, 1152.809786385237, 1154.4977934598476, 1162.9476673549711, 1098.423327752936, 1115.007643197555, 1115.2137742891243, 1288.5361269942814, 1381.9654508637364, 7351.044364232723, 7410.629468526552, 7431.071116110486, 7522.3605993491165, 7528.811779705442, 1165.2658824940404, 1176.3882780953857, 1188.631524227475, 1196.234409977615, 1197.9820302695466, 5684.971575142181, 5738.512226460798, 5739.512141467939, 5740.167675687086, 5743.10981797822, 9437.150656440954, 9770.853437198306, 9777.41335519871, 9808.117269445642, 9826.606935722491, 9769.413835169771, 9865.901340986642, 9870.358426702242, 9874.901250987541, 9883.30816842814, 7578.848423031509, 7725.768226953088, 7739.110002349689, 7747.30274275318, 7820.217978202248, 7020.684069217, 7069.22238553769, 7104.254053324326, 7127.607981561064, 7134.393576545845, 8646.265067469336, 8671.21959023691, 8709.042005379277, 8711.21599056088, 8808.339374546806, 8890.244329232088, 8993.32550058735, 9074.183323500916, 9077.228435583049, 9162.816743665222, 7096.2548932363425, 7124.85750284981, 7127.75052873147, 7131.322524360177, 7139.8572028560175, 6959.7216111357, 7144.214136445091, 7592.4305677073335, 7755.68977240904, 7762.68949242024, 7218.314260145278, 7235.529690570096, 7239.914012897897, 7299.160596531467, 7342.706291748484, 7212.386947109554, 7234.421246300178, 7276.96361518189, 7290.0, 7307.232740562377, 7260.092488438945, 7304.817379565553, 7345.045144131229, 7346.0, 7362.852742945004, 6163.229596300463, 6171.938280617136, 6172.753089876354, 6190.442860142609, 6196.039613859859, 6314.305426403, 6370.649614271259, 6375.171227740364, 6377.266614339411, 6447.484201263981], "unit": "ms", "name": "mootools.html", "value": 4609.79121133956}, {"lowerIsBetter": false, "replicates": [366.78726338723527, 368.1403921842498, 368.71056220866615, 373.21997026215206, 377.83375314861456, 5971.193888825007, 6081.239845019372, 6090.17782599349, 6096.420840020197, 6119.449249567538, 5963.16515687803, 5971.641701497902, 5985.102234664802, 5987.491063259628, 5989.970050149754, 4722.220833562458, 4722.38608980832, 4726.432828060629, 4729.47975722672, 4731.172044892147, 4629.6990695604845, 4720.551547602972, 4720.693154944935, 4722.527747225285, 4727.290906364038, 4643.582077613014, 4651.209294419939, 4658.138244424776, 4659.930101048487, 4664.277037059244, 4491.056878055612, 4581.3815134956685, 4645.86062418128, 4652.209124448852, 4653.0228651983125, 4103.261412945669, 4136.648384887289, 4164.875053748392, 4174.791260436966, 4182.247195504808, 5752.7986520472, 5758.395368486333, 5769.307683078057, 5774.740136693859, 5777.364489906107, 5217.895642087137, 5347.839564813062, 5360.9463905360835, 5482.835514934558, 5503.284573005523, 6401.295857455676, 6417.422431981144, 6429.38920802523, 6430.935690643128, 6437.163168788027, 4628.0, 4629.976850115761, 4630.722156670577, 4631.4673812511655, 4633.559811817872, 6540.182477190351, 6674.3325667433355, 6683.4987375947, 6684.532082754209, 6689.732410703615, 4756.143894099096, 4766.523347665275, 4767.427908650984, 4771.165046116916, 4774.331593576902, 4848.442429120626, 4852.8544143675745, 4855.781489832966, 4856.854294371175, 4859.198232291632, 5517.944820551824, 5530.806421775299, 5535.0, 5535.667859928417, 5536.252605898233, 6388.872222555523, 6478.708458119396, 6483.967580162163, 6491.480681545465, 6493.0, 1682.7139386304357, 1714.8456638902558, 1715.3395942561954, 1716.4078392954411, 1716.9656606867793, 1157.745296034871, 1181.5037684172669, 1182.4974385885964, 1186.424584076722, 1208.8670246272902, 6208.596441231305, 6224.221972253468, 6229.345918678564, 6231.937680623227, 6238.65687387189, 6684.2647308795995, 6700.865982680319, 6713.429358504484, 6714.395704386531, 6714.462842972551, 6212.72042758077, 6276.403741644536, 6339.683015849189, 6340.556161068681, 6342.270638876588, 3598.0285322962654, 3636.6726994570618, 3639.7816131032223, 3667.468217108504, 3668.156324045431, 6975.476839237078, 6989.231184569693, 6989.615571143636, 6996.650167491605, 6998.545094568837, 6433.678316084177, 6688.899666505006, 6916.827079322957, 6929.514933954575, 6935.757248496278, 6846.315368463213, 6946.756863509753, 6956.8956465653055, 6969.895451568129, 6972.2330543640155, 6762.932370676231, 6765.221999470124, 6771.52599318043, 6774.4580433564215, 6777.966110169417, 6569.310222426768, 6667.233268174028, 6676.632785196861, 6678.899816502853, 6682.899756503753, 6923.4807389447, 6951.339622735832, 6959.408450281783, 6963.895541566982, 6972.79081627552, 4647.0, 4679.298105284234, 4709.0, 4710.717356958594, 4711.293306004127, 6642.070110184674, 6751.0, 6756.932430675631, 6758.0876581662815, 6758.898616520854, 6538.084668146558, 6547.869042619026, 6554.770583029571, 6555.180602424697, 6555.4427873631275, 6574.309697481695, 6575.506836987341, 6577.276499584946, 6580.177477815273, 6584.078229048033, 6354.301026887131, 6473.514486413632, 6483.837904052248, 6484.902726459201, 6487.610743355413, 6604.768833090819, 6618.172728408949, 6620.0, 6621.569597976116, 6631.403173714389, 6389.169407976933, 6461.870762584628, 6464.095026696173, 6470.644114573555, 6470.708818103102], "unit": "ms", "name": "prototype.html", "value": 4950.74274955917}, {"lowerIsBetter": false, "replicates": [860.2429861721685, 921.6589861751153, 927.0821886332533, 939.6053657463865, 939.8543225799995, 16258.105804180781, 16300.673986520293, 16308.347666093357, 16319.428819991303, 16324.265408056637, 15749.84250157498, 15915.602109947256, 15926.84073159268, 15932.761008584881, 15944.521664350088, 763.2405756272517, 776.2198990015027, 923.1276443760648, 938.6761567259284, 940.1585580905086, 948.8244674735162, 950.0452045694068, 954.0507195340646, 954.4941181173989, 955.7132860141965, 806.2783808491397, 815.8613035783931, 989.6684610655439, 991.2664628175135, 992.2161492420979, 976.199516396555, 986.4623780039896, 988.0564061321421, 988.1748739802274, 993.746594618375, 722.9132504099489, 723.0094770164856, 723.1466869094467, 724.6847621284758, 727.4762171236754, 12967.286799226038, 13103.60689179326, 13106.148100373444, 13145.474181032747, 13234.139780914209, 13304.20174789506, 13615.931920340434, 13690.0, 13893.513727019506, 14211.076280041763, 10867.728306792314, 11349.546018159264, 11436.085113190924, 11462.770744585061, 11465.312081275068, 4083.4283200351974, 4122.546519882811, 4130.070734084837, 4160.417541544186, 4176.4570605821355, 50559.0, 50581.494185058415, 50629.49370506284, 50842.49157508415, 51664.74167629138, 10847.240693151403, 10936.617218397478, 11185.832212516818, 11236.719082022852, 11371.658850234506, 17240.224189911485, 17257.39599114025, 17291.481255562354, 17301.13494325304, 17302.91348543249, 7833.843323133619, 7897.842043159219, 7966.442349035512, 8014.278714915686, 8271.048829384577, 4899.436564795023, 4935.679180853233, 4961.975190124026, 4971.602271818246, 4973.104841128559, 3225.3549290142064, 3249.382617302705, 3267.0, 3270.967290327114, 3280.065181423283, 628.9716962736687, 631.4443289904946, 634.2420807135521, 635.758411803521, 638.5753473939778, 708.8511412603308, 710.9786706398713, 712.814668186265, 732.1214542548962, 753.7437271327775, 8535.189157030196, 9095.49974751395, 9104.362694611445, 9301.674441394518, 9357.906420935704, 581.3953488372103, 615.230961298377, 685.8249664005072, 700.7722490190708, 740.489062546841, 4512.187806194916, 4525.547445255448, 4564.817407303737, 4613.331066995267, 4738.8341408050555, 62100.68949655223, 65281.67359163174, 66076.0, 66553.66723166354, 66728.33271667318, 56847.55811516238, 58017.41982580205, 58054.70972645194, 58070.7096464515, 58441.8311633765, 49071.509284907406, 49289.0, 50259.0, 51859.22211166836, 52369.0, 9206.631734730536, 9472.431654100776, 9565.760855978378, 9611.519424028911, 9931.553080111267, 37315.25369492649, 39887.2022559553, 40108.0, 40211.59788402078, 40252.0, 50882.0, 51621.22568161556, 52540.0, 52628.47371526389, 52863.207051893485, 11050.171237157407, 11361.943190283995, 11741.823872641746, 12008.699782505508, 12329.198602090835, 12779.208872900424, 13360.331983400596, 13374.732505349644, 13721.588352349445, 13902.86097139056, 12338.198017128858, 12541.498340066295, 12612.306323152316, 12740.936295318465, 13278.80081798793, 12087.153899226969, 12197.390130493617, 12270.32513211782, 12573.685657858627, 12957.0, 10834.133269338276, 10892.727681808019, 11013.504392302206, 11084.722881928017, 11299.322040677585, 10072.949635251776, 10768.469409688874, 11092.556297748, 11164.720881978015, 11244.381559014333, 10746.462676866282, 10848.511816968414, 10932.398718070583, 10938.289011214245, 10985.121190304597], "unit": "ms", "name": "yui.html", "value": 6958.569924738498}], "name": "dromaeo_css", "value": 7359.435350485525}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 105.0, 110.0, 108.0, 109.0, 99.0, 109.0, 108.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [144.0, 121.0, 151.0, 163.0, 128.0, 144.0, 154.0, 123.0, 162.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.8}, {"lowerIsBetter": true, "replicates": [159.0, 159.0, 159.0, 160.0, 160.0, 159.0, 160.0, 161.0, 159.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 159.6}, {"lowerIsBetter": true, "replicates": [78.0, 73.0, 72.0, 149.0, 70.0, 72.0, 72.0, 72.0, 160.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 88.8}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 143.0, 92.0, 93.0, 92.0, 137.0, 93.0, 93.0, 145.0], "unit": "ms", "name": "audio-oscillator", "value": 107.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 108.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 58.0, 57.0, 57.0, 59.0, 59.0, 59.0, 58.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 62.9}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 78.0, 80.0, 79.0, 80.0, 80.0, 80.0, 87.0, 80.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.9}, {"lowerIsBetter": true, "replicates": [116.0, 124.0, 110.0, 115.0, 115.0, 113.0, 126.0, 124.0, 118.0, 112.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.3}, {"lowerIsBetter": true, "replicates": [131.0, 146.0, 142.0, 144.0, 140.0, 134.0, 144.0, 143.0, 142.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 139.9}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 67.0, 65.0, 63.0, 62.0, 65.0, 65.0, 63.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.3}], "name": "kraken", "value": 1477.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.26194017517767], "unit": "score", "name": "Richards", "value": 213.61240199999997}, {"lowerIsBetter": false, "replicates": [173.61111111111111], "unit": "score", "name": "DeltaBlue", "value": 380.8396800000001}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [958.7727708533077], "unit": "score", "name": "RayTrace", "value": 771.8085270000001}, {"lowerIsBetter": false, "replicates": [563.3802816901408], "unit": "score", "name": "Earley", "value": 1182.9718249999999}, {"lowerIsBetter": false, "replicates": [11122.222222222223], "unit": "score", "name": "Boyer", "value": 59.92174825174829}, {"lowerIsBetter": false, "replicates": [24357.14285714286], "unit": "score", "name": "RegExp", "value": 37.40114369501463}, {"lowerIsBetter": false, "replicates": [524.1090146750524], "unit": "score", "name": "Splay", "value": 155.48482799999994}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 22943.169997473015}]} 14:18:36 INFO - RETURN: dromaeo_css: 7359.44 14:18:36 INFO - RETURN: kraken: 1477.70 14:18:36 INFO - RETURN: v8_7: 22943.17 14:18:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "22943.17"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1477.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7359.44"}}} 14:18:36 INFO - Return code: 0 14:18:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:18:36 INFO - # TBPL SUCCESS # 14:18:36 INFO - Running post-action listener: _resource_record_post_action 14:18:36 INFO - Running post-run listener: _resource_record_post_run 14:18:37 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 262144; Write bytes: 506015744; Read time: 20; Write time: 459612 14:18:37 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 236392448; Read time: 0; Write time: 290372 14:18:37 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 262144; Write bytes: 269316096; Read time: 20; Write time: 169216 14:18:37 INFO - Running post-run listener: _upload_blobber_files 14:18:37 INFO - Blob upload gear active. 14:18:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:18:37 INFO - Copying logs to upload dir... 14:18:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.937907 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-04 14:18:37.260690) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-04 14:18:37.264468) ========= 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=1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/CGegDfEzRVuYUy2U7hsgKw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010043 build_url: 'https://queue.taskcluster.net/v1/task/CGegDfEzRVuYUy2U7hsgKw/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-04 14:18:37.315543) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 14:18:37.315909) ========= 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=1b9da9da7504fe468691862d000001b9-1451943999.204558-991366328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 14:18:37.366247) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 14:18:37.366599) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 14:18:37.366924) ========= ========= Total master_lag: 0.25 =========