builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1447727545.82 results: success (0) buildid: 20151116163023 builduid: badc5e63e5cd460f97669b98ffea3e2c revision: ffe020f9145296f68d56866b01ffe1d35ac18b83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:25.821057) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:25.821537) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:25.821834) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006057 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:25.839119) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:25.839428) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:25.847885) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:25.848210) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004103 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:25.895912) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:25.896269) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:25.896658) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:25.896959) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-16 18:32:26-- 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% 218M=0s 2015-11-16 18:32:26 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170351 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:26.081212) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:26.081751) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017886 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:26.132752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:26.133125) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ffe020f9145296f68d56866b01ffe1d35ac18b83 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ffe020f9145296f68d56866b01ffe1d35ac18b83 --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=76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-16 18:32:26,523 truncating revision to first 12 chars 2015-11-16 18:32:26,523 Setting DEBUG logging. 2015-11-16 18:32:26,523 attempt 1/10 2015-11-16 18:32:26,523 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ffe020f91452?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 18:32:26,972 unpacking tar archive at: mozilla-central-ffe020f91452/testing/mozharness/ program finished with exit code 0 elapsedTime=0.714666 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:26.860354) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:26.860701) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:26.869055) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:26.869392) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 18:32:26.869821) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-16 18:32:26.870163) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:32:27 INFO - MultiFileLogger online at 20151116 18:32:27 in /builds/slave/test-pgo 18:32:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:32:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:32:27 INFO - {'append_to_log': False, 18:32:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:32:27 INFO - 'blob_upload_branch': 'Firefox', 18:32:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:32:27 INFO - 'branch': 'Firefox', 18:32:27 INFO - 'buildbot_json_path': 'buildprops.json', 18:32:27 INFO - 'config_files': ('talos/linux_config.py',), 18:32:27 INFO - 'default_actions': ('clobber', 18:32:27 INFO - 'read-buildbot-config', 18:32:27 INFO - 'download-and-extract', 18:32:27 INFO - 'populate-webroot', 18:32:27 INFO - 'create-virtualenv', 18:32:27 INFO - 'install', 18:32:27 INFO - 'run-tests'), 18:32:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:32:27 INFO - 'download_minidump_stackwalk': True, 18:32:27 INFO - 'download_symbols': 'ondemand', 18:32:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:32:27 INFO - 'tooltool.py': '/tools/tooltool.py', 18:32:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:32:27 INFO - '/tools/misc-python/virtualenv.py')}, 18:32:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:32:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:32:27 INFO - 'installer_path': 'installer.exe', 18:32:27 INFO - 'log_level': 'info', 18:32:27 INFO - 'log_name': 'talos', 18:32:27 INFO - 'log_to_console': True, 18:32:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:32:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:32:27 INFO - 'opt_config_files': (), 18:32:27 INFO - 'pip_index': False, 18:32:27 INFO - 'sps_profile': False, 18:32:27 INFO - 'sps_profile_interval': 0, 18:32:27 INFO - 'suite': 'dromaeojs', 18:32:27 INFO - 'system_bits': '64', 18:32:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:32:27 INFO - 'title': 'talos-linux64-ix-011', 18:32:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:32:27 INFO - 'use_talos_json': True, 18:32:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:32:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:32:27 INFO - 'work_dir': 'build'} 18:32:27 INFO - ##### 18:32:27 INFO - ##### Running clobber step. 18:32:27 INFO - ##### 18:32:27 INFO - Running pre-action listener: _resource_record_pre_action 18:32:27 INFO - Running main action method: clobber 18:32:27 INFO - rmtree: /builds/slave/test-pgo/build 18:32:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:32:27 INFO - Running post-action listener: _resource_record_post_action 18:32:27 INFO - ##### 18:32:27 INFO - ##### Running read-buildbot-config step. 18:32:27 INFO - ##### 18:32:27 INFO - Running pre-action listener: _resource_record_pre_action 18:32:27 INFO - Running main action method: read_buildbot_config 18:32:27 INFO - Using buildbot properties: 18:32:27 INFO - { 18:32:27 INFO - "properties": { 18:32:27 INFO - "buildnumber": 559, 18:32:27 INFO - "product": "firefox", 18:32:27 INFO - "script_repo_revision": "production", 18:32:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:32:27 INFO - "repository": "", 18:32:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 18:32:27 INFO - "buildid": "20151116163023", 18:32:27 INFO - "slavename": "talos-linux64-ix-011", 18:32:27 INFO - "pgo_build": "True", 18:32:27 INFO - "basedir": "/builds/slave/test-pgo", 18:32:27 INFO - "project": "", 18:32:27 INFO - "platform": "ubuntu64_hw", 18:32:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:32:27 INFO - "slavebuilddir": "test", 18:32:27 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 18:32:27 INFO - "branch": "mozilla-central", 18:32:27 INFO - "repo_path": "mozilla-central", 18:32:27 INFO - "stage_platform": "linux64-pgo", 18:32:27 INFO - "builduid": "badc5e63e5cd460f97669b98ffea3e2c", 18:32:27 INFO - "revision": "ffe020f9145296f68d56866b01ffe1d35ac18b83" 18:32:27 INFO - }, 18:32:27 INFO - "sourcestamp": { 18:32:27 INFO - "repository": "", 18:32:27 INFO - "hasPatch": false, 18:32:27 INFO - "project": "", 18:32:27 INFO - "branch": "mozilla-central-linux64-pgo-talos", 18:32:27 INFO - "changes": [ 18:32:27 INFO - { 18:32:27 INFO - "category": null, 18:32:27 INFO - "files": [ 18:32:27 INFO - { 18:32:27 INFO - "url": null, 18:32:27 INFO - "name": "https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:32:27 INFO - } 18:32:27 INFO - ], 18:32:27 INFO - "repository": "", 18:32:27 INFO - "rev": "ffe020f9145296f68d56866b01ffe1d35ac18b83", 18:32:27 INFO - "who": "sendchange", 18:32:27 INFO - "when": 1447727405, 18:32:27 INFO - "number": 6669588, 18:32:27 INFO - "comments": "", 18:32:27 INFO - "project": "", 18:32:27 INFO - "at": "Mon 16 Nov 2015 18:30:05", 18:32:27 INFO - "branch": "mozilla-central-linux64-pgo-talos", 18:32:27 INFO - "revlink": "", 18:32:27 INFO - "properties": [ 18:32:27 INFO - [ 18:32:27 INFO - "buildid", 18:32:27 INFO - "20151116163023", 18:32:27 INFO - "Change" 18:32:27 INFO - ], 18:32:27 INFO - [ 18:32:27 INFO - "builduid", 18:32:27 INFO - "badc5e63e5cd460f97669b98ffea3e2c", 18:32:27 INFO - "Change" 18:32:27 INFO - ], 18:32:27 INFO - [ 18:32:27 INFO - "pgo_build", 18:32:27 INFO - "True", 18:32:27 INFO - "Change" 18:32:27 INFO - ] 18:32:27 INFO - ], 18:32:27 INFO - "revision": "ffe020f9145296f68d56866b01ffe1d35ac18b83" 18:32:27 INFO - } 18:32:27 INFO - ], 18:32:27 INFO - "revision": "ffe020f9145296f68d56866b01ffe1d35ac18b83" 18:32:27 INFO - } 18:32:27 INFO - } 18:32:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:32:27 INFO - Running post-action listener: _resource_record_post_action 18:32:27 INFO - ##### 18:32:27 INFO - ##### Running download-and-extract step. 18:32:27 INFO - ##### 18:32:27 INFO - Running pre-action listener: _resource_record_pre_action 18:32:27 INFO - Running main action method: download_and_extract 18:32:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:32:27 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')]} 18:32:27 INFO - https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:32:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/test_packages.json 18:32:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/test_packages.json 18:32:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:32:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:32:28 INFO - Downloaded 1302 bytes. 18:32:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:32:28 INFO - Using the following test package requirements: 18:32:28 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:32:28 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:32:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:32:28 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:32:28 INFO - u'jsshell-linux-x86_64.zip'], 18:32:28 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:32:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:32:28 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:32:28 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:32:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:32:28 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:32:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:32:28 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:32:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:32:28 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:32:28 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:32:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:32:28 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:32: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')]} 18:32:28 INFO - https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:32:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:32:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:32:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:32:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:32:29 INFO - Downloaded 22461753 bytes. 18:32:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 18:32:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:32:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:32:30 INFO - Return code: 0 18:32:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:30 INFO - https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:32:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:32:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:32:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:32:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:32:31 INFO - Downloaded 22461753 bytes. 18:32:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 18:32:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:32:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:32:32 INFO - Return code: 0 18:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:32 INFO - https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:32:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:32:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:32:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:32:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:32:33 INFO - Downloaded 11131693 bytes. 18:32:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 18:32:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:32:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:32:33 INFO - Return code: 0 18:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:33 INFO - https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:32:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:32:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:32:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:32:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:32:35 INFO - Downloaded 57150755 bytes. 18:32:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:32:35 INFO - mkdir: /builds/slave/test-pgo/properties 18:32:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:32:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:32:35 INFO - Contents: 18:32:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:32:35 INFO - Running post-action listener: _resource_record_post_action 18:32:35 INFO - Running post-action listener: set_extra_try_arguments 18:32:35 INFO - ##### 18:32:35 INFO - ##### Running populate-webroot step. 18:32:35 INFO - ##### 18:32:35 INFO - Running pre-action listener: _resource_record_pre_action 18:32:35 INFO - Running main action method: populate_webroot 18:32:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:32:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:32:35 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:32:35 INFO - '../fennec_ids.txt'], 18:32:35 INFO - 'tests': ['tcheck2']}, 18:32:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:32:35 INFO - '--tppagecycles', 18:32:35 INFO - '7'], 18:32:35 INFO - 'tests': ['tsvgm']}}, 18:32:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:32:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:32:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:32:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:32:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:32:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:32:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:32:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:35 INFO - 'talos_options': ['--e10s'], 18:32:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:32:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:35 INFO - 'tests': ['damp', 'tps']}, 18:32:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:35 INFO - 'talos_options': ['--e10s'], 18:32:35 INFO - 'tests': ['damp', 'tps']}, 18:32:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:32:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:32:35 INFO - 'other': {'tests': ['a11yr', 18:32:35 INFO - 'ts_paint', 18:32:35 INFO - 'tpaint', 18:32:35 INFO - 'sessionrestore', 18:32:35 INFO - 'sessionrestore_no_auto_restore']}, 18:32:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:32:35 INFO - 'tests': ['a11yr', 18:32:35 INFO - 'ts_paint', 18:32:35 INFO - 'tpaint', 18:32:35 INFO - 'sessionrestore', 18:32:35 INFO - 'sessionrestore_no_auto_restore']}, 18:32:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:32:35 INFO - 'tests': ['a11yr', 18:32:35 INFO - 'ts_paint', 18:32:35 INFO - 'tpaint', 18:32:35 INFO - 'sessionrestore', 18:32:35 INFO - 'sessionrestore_no_auto_restore']}, 18:32:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:32:35 INFO - 'tests': ['a11yr', 18:32:35 INFO - 'ts_paint', 18:32:35 INFO - 'tpaint', 18:32:35 INFO - 'sessionrestore', 18:32:35 INFO - 'sessionrestore_no_auto_restore']}, 18:32:35 INFO - 'other_l64': {'tests': ['a11yr', 18:32:35 INFO - 'ts_paint', 18:32:35 INFO - 'tpaint', 18:32:35 INFO - 'sessionrestore', 18:32:35 INFO - 'sessionrestore_no_auto_restore']}, 18:32:35 INFO - 'other_nol64': {'tests': ['a11yr', 18:32:35 INFO - 'ts_paint', 18:32:35 INFO - 'tpaint', 18:32:35 INFO - 'sessionrestore', 18:32:35 INFO - 'sessionrestore_no_auto_restore']}, 18:32:35 INFO - 'svgr': {'tests': ['tsvgx', 18:32:35 INFO - 'tsvgr_opacity', 18:32:35 INFO - 'tart', 18:32:35 INFO - 'tscrollx', 18:32:35 INFO - 'cart']}, 18:32:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:32:35 INFO - 'tests': ['tsvgx', 18:32:35 INFO - 'tsvgr_opacity', 18:32:35 INFO - 'tart', 18:32:35 INFO - 'tscrollx', 18:32:35 INFO - 'cart']}, 18:32:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:35 INFO - 'tests': ['tp5o']}, 18:32:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:35 INFO - 'talos_options': ['--e10s'], 18:32:35 INFO - 'tests': ['tp5o']}, 18:32:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:35 INFO - 'talos_options': ['--xperf_path', 18:32:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:32:35 INFO - 'tests': ['tp5n']}, 18:32:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:35 INFO - 'talos_options': ['--e10s', 18:32:35 INFO - '--xperf_path', 18:32:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:32:35 INFO - 'tests': ['tp5n']}}, 18:32:35 INFO - 'talos.zip': {'path': '', 18:32:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:32:35 INFO - Running post-action listener: _resource_record_post_action 18:32:35 INFO - ##### 18:32:35 INFO - ##### Running create-virtualenv step. 18:32:35 INFO - ##### 18:32:35 INFO - Running pre-action listener: _resource_record_pre_action 18:32:35 INFO - Running main action method: create_virtualenv 18:32:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:32:35 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 18:32:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:32:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:32:35 INFO - Using real prefix '/usr' 18:32:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:32:35 INFO - Installing distribute.............................................................................................................................................................................................done. 18:32:37 INFO - Installing pip.................done. 18:32:37 INFO - Return code: 0 18:32:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:32:37 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')]} 18:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:37 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')]} 18:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:37 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 0x7fc8ff220c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e988c0>, '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 0x1e45420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e458b0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234', '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 18:32:37 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 18:32:37 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 18:32:37 INFO - Using env: {'DISPLAY': ':0', 18:32:37 INFO - 'HOME': '/home/cltbld', 18:32:37 INFO - 'LANG': 'en_US.UTF-8', 18:32:37 INFO - 'LANGUAGE': 'en_US:en', 18:32:37 INFO - 'LOGNAME': 'cltbld', 18:32:37 INFO - 'MAIL': '/var/mail/cltbld', 18:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:37 INFO - 'MOZ_NO_REMOTE': '1', 18:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:37 INFO - 'NO_EM_RESTART': '1', 18:32:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:32:37 INFO - 'PWD': '/builds/slave/test-pgo', 18:32:37 INFO - 'SHELL': '/bin/bash', 18:32:37 INFO - 'SHLVL': '1', 18:32:37 INFO - 'TERM': 'linux', 18:32:37 INFO - 'TMOUT': '86400', 18:32:37 INFO - 'USER': 'cltbld', 18:32:37 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234', 18:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:37 INFO - '_': '/tools/buildbot/bin/python'} 18:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:38 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 18:32:38 INFO - Cleaning up... 18:32:38 INFO - Return code: 0 18:32:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:32:38 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')]} 18:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:38 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')]} 18:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:38 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 0x7fc8ff220c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e988c0>, '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 0x1e45420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e458b0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234', '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 18:32:38 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 18:32:38 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 18:32:38 INFO - Using env: {'DISPLAY': ':0', 18:32:38 INFO - 'HOME': '/home/cltbld', 18:32:38 INFO - 'LANG': 'en_US.UTF-8', 18:32:38 INFO - 'LANGUAGE': 'en_US:en', 18:32:38 INFO - 'LOGNAME': 'cltbld', 18:32:38 INFO - 'MAIL': '/var/mail/cltbld', 18:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:38 INFO - 'MOZ_NO_REMOTE': '1', 18:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:38 INFO - 'NO_EM_RESTART': '1', 18:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:32:38 INFO - 'PWD': '/builds/slave/test-pgo', 18:32:38 INFO - 'SHELL': '/bin/bash', 18:32:38 INFO - 'SHLVL': '1', 18:32:38 INFO - 'TERM': 'linux', 18:32:38 INFO - 'TMOUT': '86400', 18:32:38 INFO - 'USER': 'cltbld', 18:32:38 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234', 18:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:38 INFO - '_': '/tools/buildbot/bin/python'} 18:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:38 INFO - Downloading/unpacking psutil>=0.7.1 18:32:38 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 18:32:38 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 18:32:38 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 18:32:38 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 18:32:38 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 18:32:38 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 18:32:40 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:32:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:32:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:32:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:32:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:32:40 INFO - Installing collected packages: psutil 18:32:40 INFO - Running setup.py install for psutil 18:32:40 INFO - building 'psutil._psutil_linux' extension 18:32:40 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 18:32:40 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 18:32:40 INFO - building 'psutil._psutil_posix' extension 18:32:40 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 18:32:40 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 18:32:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:32:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:32:40 INFO - Successfully installed psutil 18:32:40 INFO - Cleaning up... 18:32:40 INFO - Return code: 0 18:32:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:40 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 0x7fc8ff220c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e988c0>, '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 0x1e45420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e458b0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234', '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 18:32:40 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 18:32:40 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 18:32:40 INFO - Using env: {'DISPLAY': ':0', 18:32:40 INFO - 'HOME': '/home/cltbld', 18:32:40 INFO - 'LANG': 'en_US.UTF-8', 18:32:40 INFO - 'LANGUAGE': 'en_US:en', 18:32:40 INFO - 'LOGNAME': 'cltbld', 18:32:40 INFO - 'MAIL': '/var/mail/cltbld', 18:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:40 INFO - 'MOZ_NO_REMOTE': '1', 18:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:40 INFO - 'NO_EM_RESTART': '1', 18:32:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:32:40 INFO - 'PWD': '/builds/slave/test-pgo', 18:32:40 INFO - 'SHELL': '/bin/bash', 18:32:40 INFO - 'SHLVL': '1', 18:32:40 INFO - 'TERM': 'linux', 18:32:40 INFO - 'TMOUT': '86400', 18:32:40 INFO - 'USER': 'cltbld', 18:32:40 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234', 18:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:40 INFO - '_': '/tools/buildbot/bin/python'} 18:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:32:40 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 18:32:40 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 18:32:40 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 18:32:40 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 18:32:40 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 18:32:40 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 18:32:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:32:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:32:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:32:42 INFO - Installing collected packages: mozsystemmonitor 18:32:42 INFO - Running setup.py install for mozsystemmonitor 18:32:42 INFO - Successfully installed mozsystemmonitor 18:32:42 INFO - Cleaning up... 18:32:42 INFO - Return code: 0 18:32:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:42 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 0x7fc8ff220c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e988c0>, '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 0x1e45420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e458b0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234', '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 18:32:42 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 18:32:42 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 18:32:42 INFO - Using env: {'DISPLAY': ':0', 18:32:42 INFO - 'HOME': '/home/cltbld', 18:32:42 INFO - 'LANG': 'en_US.UTF-8', 18:32:42 INFO - 'LANGUAGE': 'en_US:en', 18:32:42 INFO - 'LOGNAME': 'cltbld', 18:32:42 INFO - 'MAIL': '/var/mail/cltbld', 18:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:42 INFO - 'MOZ_NO_REMOTE': '1', 18:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:42 INFO - 'NO_EM_RESTART': '1', 18:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:32:42 INFO - 'PWD': '/builds/slave/test-pgo', 18:32:42 INFO - 'SHELL': '/bin/bash', 18:32:42 INFO - 'SHLVL': '1', 18:32:42 INFO - 'TERM': 'linux', 18:32:42 INFO - 'TMOUT': '86400', 18:32:42 INFO - 'USER': 'cltbld', 18:32:42 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234', 18:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:42 INFO - '_': '/tools/buildbot/bin/python'} 18:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:43 INFO - Downloading/unpacking blobuploader==1.2.4 18:32:43 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 18:32:43 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 18:32:43 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 18:32:43 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 18:32:43 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 18:32:43 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 18:32:44 INFO - Downloading blobuploader-1.2.4.tar.gz 18:32:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:32:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:32:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:32:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:32:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:45 INFO - Downloading docopt-0.6.1.tar.gz 18:32:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:32:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:32:45 INFO - Installing collected packages: blobuploader, requests, docopt 18:32:45 INFO - Running setup.py install for blobuploader 18:32:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:32:45 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:32:45 INFO - Running setup.py install for requests 18:32:45 INFO - Running setup.py install for docopt 18:32:45 INFO - Successfully installed blobuploader requests docopt 18:32:45 INFO - Cleaning up... 18:32:45 INFO - Return code: 0 18:32:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:32: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')]} 18:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32: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')]} 18:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:45 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 0x7fc8ff220c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e988c0>, '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 0x1e45420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e458b0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234', '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 18:32:45 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 18:32:45 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 18:32:45 INFO - Using env: {'DISPLAY': ':0', 18:32:45 INFO - 'HOME': '/home/cltbld', 18:32:45 INFO - 'LANG': 'en_US.UTF-8', 18:32:45 INFO - 'LANGUAGE': 'en_US:en', 18:32:45 INFO - 'LOGNAME': 'cltbld', 18:32:45 INFO - 'MAIL': '/var/mail/cltbld', 18:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:45 INFO - 'MOZ_NO_REMOTE': '1', 18:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:45 INFO - 'NO_EM_RESTART': '1', 18:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:32:45 INFO - 'PWD': '/builds/slave/test-pgo', 18:32:45 INFO - 'SHELL': '/bin/bash', 18:32:45 INFO - 'SHLVL': '1', 18:32:45 INFO - 'TERM': 'linux', 18:32:45 INFO - 'TMOUT': '86400', 18:32:45 INFO - 'USER': 'cltbld', 18:32:45 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234', 18:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:45 INFO - '_': '/tools/buildbot/bin/python'} 18:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:32:46 INFO - Running setup.py (path:/tmp/pip-iiO6EN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:32:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:32:46 INFO - Running setup.py (path:/tmp/pip-UsQBQI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:32:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:32:46 INFO - Running setup.py (path:/tmp/pip-Y8ggMy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:32:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:32:46 INFO - Running setup.py (path:/tmp/pip-GQiZed-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:32:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:32:46 INFO - Running setup.py (path:/tmp/pip-pnJIgy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:32:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:32:46 INFO - Running setup.py (path:/tmp/pip-BQL2dL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:32:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:32:46 INFO - Running setup.py (path:/tmp/pip-Zs9Gs1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:32:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:32:46 INFO - Running setup.py (path:/tmp/pip-xZta9X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:32:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:32:46 INFO - Running setup.py (path:/tmp/pip-QA7M9r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:32:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:32:46 INFO - Running setup.py (path:/tmp/pip-Izb5vS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:32:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:32:46 INFO - Running setup.py (path:/tmp/pip-LCree1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:32:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:32:46 INFO - Running setup.py (path:/tmp/pip-ohmsyz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:32:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:32:47 INFO - Running setup.py (path:/tmp/pip-1W41_O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:32:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:32:47 INFO - Running setup.py (path:/tmp/pip-oeFVXe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:32:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:32:47 INFO - Running setup.py (path:/tmp/pip-gc4Nh0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:32:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:32:47 INFO - Running setup.py (path:/tmp/pip-CLmT1j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:32:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:32:47 INFO - Running setup.py (path:/tmp/pip-EtAMh7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:32:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:32:47 INFO - Running setup.py install for manifestparser 18:32:47 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:32:47 INFO - Running setup.py install for mozcrash 18:32:47 INFO - Running setup.py install for mozdebug 18:32:47 INFO - Running setup.py install for mozdevice 18:32:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:32:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:32:47 INFO - Running setup.py install for mozfile 18:32:47 INFO - Running setup.py install for mozhttpd 18:32:48 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:32:48 INFO - Running setup.py install for mozinfo 18:32:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:32:48 INFO - Running setup.py install for mozInstall 18:32:48 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:32:48 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:32:48 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:32:48 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:32:48 INFO - Running setup.py install for mozleak 18:32:48 INFO - Running setup.py install for mozlog 18:32:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:32:48 INFO - Running setup.py install for moznetwork 18:32:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:32:48 INFO - Running setup.py install for mozprocess 18:32:48 INFO - Running setup.py install for mozprofile 18:32:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:32:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:32:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:32:48 INFO - Running setup.py install for mozrunner 18:32:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:32:48 INFO - Running setup.py install for mozscreenshot 18:32:48 INFO - Running setup.py install for moztest 18:32:49 INFO - Running setup.py install for mozversion 18:32:49 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:32:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:32:49 INFO - Cleaning up... 18:32:49 INFO - Return code: 0 18:32:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:49 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 0x7fc8ff220c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e988c0>, '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 0x1e45420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e458b0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234', '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 18:32:49 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 18:32:49 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 18:32:49 INFO - Using env: {'DISPLAY': ':0', 18:32:49 INFO - 'HOME': '/home/cltbld', 18:32:49 INFO - 'LANG': 'en_US.UTF-8', 18:32:49 INFO - 'LANGUAGE': 'en_US:en', 18:32:49 INFO - 'LOGNAME': 'cltbld', 18:32:49 INFO - 'MAIL': '/var/mail/cltbld', 18:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:49 INFO - 'MOZ_NO_REMOTE': '1', 18:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:49 INFO - 'NO_EM_RESTART': '1', 18:32:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:32:49 INFO - 'PWD': '/builds/slave/test-pgo', 18:32:49 INFO - 'SHELL': '/bin/bash', 18:32:49 INFO - 'SHLVL': '1', 18:32:49 INFO - 'TERM': 'linux', 18:32:49 INFO - 'TMOUT': '86400', 18:32:49 INFO - 'USER': 'cltbld', 18:32:49 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234', 18:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:49 INFO - '_': '/tools/buildbot/bin/python'} 18:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:32:49 INFO - Running setup.py (path:/tmp/pip-6RRz4W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:32:49 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)) 18:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:32:49 INFO - Running setup.py (path:/tmp/pip-5Onw7D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:32:49 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)) 18:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:32:49 INFO - Running setup.py (path:/tmp/pip-_2RZ2z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:32:49 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)) 18:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:32:49 INFO - Running setup.py (path:/tmp/pip-tW0uRv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:32:49 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)) 18:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:32:49 INFO - Running setup.py (path:/tmp/pip-O4hr0e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:32:49 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)) 18:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:32:49 INFO - Running setup.py (path:/tmp/pip-EP1BfM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:32:49 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)) 18:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:32:49 INFO - Running setup.py (path:/tmp/pip-YNDir2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:32:49 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)) 18:32:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:32:49 INFO - Running setup.py (path:/tmp/pip-JB2mzQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:32:50 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)) 18:32:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:32:50 INFO - Running setup.py (path:/tmp/pip-dMzTE0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:32:50 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)) 18:32:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:32:50 INFO - Running setup.py (path:/tmp/pip-fiRMkT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 18:32:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:32:50 INFO - Running setup.py (path:/tmp/pip-qPLkns-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:32:50 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)) 18:32:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:32:50 INFO - Running setup.py (path:/tmp/pip-kLU1Gl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:32:50 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)) 18:32:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:32:50 INFO - Running setup.py (path:/tmp/pip-aP762d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:32:50 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)) 18:32:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:32:50 INFO - Running setup.py (path:/tmp/pip-2w6L0v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:32:50 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)) 18:32:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:32:50 INFO - Running setup.py (path:/tmp/pip-eHRnw0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:32:50 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)) 18:32:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:32:50 INFO - Running setup.py (path:/tmp/pip-ulJLu6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:32:50 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)) 18:32:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:32:50 INFO - Running setup.py (path:/tmp/pip-nEdEjC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:32:50 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)) 18:32:50 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)) 18:32:50 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)) 18:32:50 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)) 18:32:50 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)) 18:32:50 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)) 18:32:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:32:50 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 18:32:50 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 18:32:50 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 18:32:50 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 18:32:50 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 18:32:50 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 18:32:52 INFO - Downloading blessings-1.5.1.tar.gz 18:32:52 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 18:32:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:32:52 INFO - Installing collected packages: blessings 18:32:52 INFO - Running setup.py install for blessings 18:32:52 INFO - Successfully installed blessings 18:32:52 INFO - Cleaning up... 18:32:52 INFO - Return code: 0 18:32:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:32:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:32:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:32:52 INFO - Reading from file tmpfile_stdout 18:32:52 INFO - Current package versions: 18:32:52 INFO - argparse == 1.2.1 18:32:52 INFO - blessings == 1.5.1 18:32:52 INFO - blobuploader == 1.2.4 18:32:52 INFO - docopt == 0.6.1 18:32:52 INFO - manifestparser == 1.1 18:32:52 INFO - mozInstall == 1.12 18:32:52 INFO - mozcrash == 0.16 18:32:52 INFO - mozdebug == 0.1 18:32:52 INFO - mozdevice == 0.47 18:32:52 INFO - mozfile == 1.2 18:32:52 INFO - mozhttpd == 0.7 18:32:52 INFO - mozinfo == 0.9 18:32:52 INFO - mozleak == 0.1 18:32:52 INFO - mozlog == 3.0 18:32:52 INFO - moznetwork == 0.27 18:32:52 INFO - mozprocess == 0.22 18:32:52 INFO - mozprofile == 0.27 18:32:52 INFO - mozrunner == 6.11 18:32:52 INFO - mozscreenshot == 0.1 18:32:52 INFO - mozsystemmonitor == 0.0 18:32:52 INFO - moztest == 0.7 18:32:52 INFO - mozversion == 1.4 18:32:52 INFO - psutil == 3.1.1 18:32:52 INFO - requests == 1.2.3 18:32:52 INFO - wsgiref == 0.1.2 18:32:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:32:52 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')]} 18:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:52 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')]} 18:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:52 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 0x7fc8ff220c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e988c0>, '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 0x1e45420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e458b0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234', '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 18:32:52 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 18:32:52 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 18:32:52 INFO - Using env: {'DISPLAY': ':0', 18:32:52 INFO - 'HOME': '/home/cltbld', 18:32:52 INFO - 'LANG': 'en_US.UTF-8', 18:32:52 INFO - 'LANGUAGE': 'en_US:en', 18:32:52 INFO - 'LOGNAME': 'cltbld', 18:32:52 INFO - 'MAIL': '/var/mail/cltbld', 18:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:52 INFO - 'MOZ_NO_REMOTE': '1', 18:32:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:52 INFO - 'NO_EM_RESTART': '1', 18:32:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:32:52 INFO - 'PWD': '/builds/slave/test-pgo', 18:32:52 INFO - 'SHELL': '/bin/bash', 18:32:52 INFO - 'SHLVL': '1', 18:32:52 INFO - 'TERM': 'linux', 18:32:52 INFO - 'TMOUT': '86400', 18:32:52 INFO - 'USER': 'cltbld', 18:32:52 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234', 18:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:52 INFO - '_': '/tools/buildbot/bin/python'} 18:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:52 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)) 18:32:52 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)) 18:32:52 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)) 18:32:52 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)) 18:32:52 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)) 18:32:52 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)) 18:32:52 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)) 18:32:52 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)) 18:32:52 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)) 18:32:52 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)) 18:32:52 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)) 18:32:52 INFO - Cleaning up... 18:32:52 INFO - Return code: 0 18:32:52 INFO - Running post-action listener: _resource_record_post_action 18:32:52 INFO - Running post-action listener: _start_resource_monitoring 18:32:53 INFO - Starting resource monitoring. 18:32:53 INFO - ##### 18:32:53 INFO - ##### Running install step. 18:32:53 INFO - ##### 18:32:53 INFO - Running pre-action listener: _resource_record_pre_action 18:32:53 INFO - Running main action method: install 18:32:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:32:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:32:53 INFO - Reading from file tmpfile_stdout 18:32:53 INFO - Detecting whether we're running mozinstall >=1.0... 18:32:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:32:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:32:53 INFO - Reading from file tmpfile_stdout 18:32:53 INFO - Output received: 18:32:53 INFO - Usage: mozinstall [options] installer 18:32:53 INFO - Options: 18:32:53 INFO - -h, --help show this help message and exit 18:32:53 INFO - -d DEST, --destination=DEST 18:32:53 INFO - Directory to install application into. [default: 18:32:53 INFO - "/builds/slave/test-pgo"] 18:32:53 INFO - --app=APP Application being installed. [default: firefox] 18:32:53 INFO - mkdir: /builds/slave/test-pgo/build/application 18:32:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:32:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:33:07 INFO - Reading from file tmpfile_stdout 18:33:07 INFO - Output received: 18:33:07 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:33:07 INFO - Running post-action listener: _resource_record_post_action 18:33:07 INFO - ##### 18:33:07 INFO - ##### Running run-tests step. 18:33:07 INFO - ##### 18:33:07 INFO - Running pre-action listener: _resource_record_pre_action 18:33:07 INFO - Running main action method: run_tests 18:33:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:33:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:33:07 INFO - Python 2.7.3 18:33:07 INFO - Return code: 0 18:33:07 INFO - grabbing minidump binary from tooltool 18:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:07 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 0x1e988c0>, '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 0x1e45420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e458b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:33:07 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 18:33:07 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 18:33:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:33:07 INFO - Return code: 0 18:33:07 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:33:07 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:33:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:33:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:33:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:33:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 18:33:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost 18:33:07 INFO - Using env: {'DISPLAY': ':0', 18:33:07 INFO - 'HOME': '/home/cltbld', 18:33:07 INFO - 'LANG': 'en_US.UTF-8', 18:33:07 INFO - 'LANGUAGE': 'en_US:en', 18:33:07 INFO - 'LOGNAME': 'cltbld', 18:33:07 INFO - 'MAIL': '/var/mail/cltbld', 18:33:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:33:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:07 INFO - 'MOZ_NO_REMOTE': '1', 18:33:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:07 INFO - 'NO_EM_RESTART': '1', 18:33:07 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:33:07 INFO - 'PWD': '/builds/slave/test-pgo', 18:33:07 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:33:07 INFO - 'SHELL': '/bin/bash', 18:33:07 INFO - 'SHLVL': '1', 18:33:07 INFO - 'TERM': 'linux', 18:33:07 INFO - 'TMOUT': '86400', 18:33:07 INFO - 'USER': 'cltbld', 18:33:07 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234', 18:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:07 INFO - '_': '/tools/buildbot/bin/python'} 18:33:07 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] with output_timeout 3600 18:33:07 INFO - mozversion INFO | application_buildid: 20151116163023 18:33:07 INFO - mozversion INFO | application_changeset: ffe020f9145296f68d56866b01ffe1d35ac18b83 18:33:07 INFO - mozversion INFO | application_display_name: Nightly 18:33:07 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:33:07 INFO - mozversion INFO | application_name: Firefox 18:33:07 INFO - mozversion INFO | application_remotingname: firefox 18:33:07 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 18:33:07 INFO - mozversion INFO | application_vendor: Mozilla 18:33:07 INFO - mozversion INFO | application_version: 45.0a1 18:33:07 INFO - mozversion INFO | platform_buildid: 20151116163023 18:33:07 INFO - mozversion INFO | platform_changeset: ffe020f9145296f68d56866b01ffe1d35ac18b83 18:33:07 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 18:33:07 INFO - mozversion INFO | platform_version: 45.0a1 18:33:07 INFO - 2015-11-16 18:33:07,940 DEBUG : using testdate: 1447727587 18:33:07 INFO - 2015-11-16 18:33:07,940 DEBUG : actual date: 1447727587 18:33:07 INFO - 2015-11-16 18:33:07,948 INFO : starting webserver on 'localhost:44115' 18:33:07 INFO - 2015-11-16 18:33:07,948 INFO : Starting test suite talos-linux64-ix-011 18:33:07 INFO - 2015-11-16 18:33:07,949 INFO : Starting test dromaeo_css 18:33:07 INFO - 2015-11-16 18:33:07,949 DEBUG : operating with platform_type : linux_ 18:33:07 INFO - 2015-11-16 18:33:07,949 INFO : Initialising browser for dromaeo_css test... 18:33:07 INFO - 2015-11-16 18:33:07,959 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppSjMn2/profile http://localhost:44115/getInfo.html 18:33:15 INFO - 2015-11-16 18:33:15,010 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:33:15 INFO - 2015-11-16 18:33:15,010 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:33:15 INFO - 2015-11-16 18:33:15,010 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:33:15 INFO - 2015-11-16 18:33:15,010 DEBUG : BROWSER_OUTPUT: __metrics 18:33:15 INFO - 2015-11-16 18:33:15,152 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:33:16 INFO - 2015-11-16 18:33:16,528 INFO : Browser initialized. 18:33:16 INFO - 2015-11-16 18:33:16,529 INFO : Running cycle 1/1 for dromaeo_css test... 18:33:16 INFO - 2015-11-16 18:33:16,529 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppSjMn2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:33:28 INFO - 2015-11-16 18:33:28,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 141795328 18:33:28 INFO - 2015-11-16 18:33:28,264 DEBUG : BROWSER_OUTPUT: 18:34:19 INFO - 2015-11-16 18:34:19,898 DEBUG : BROWSER_OUTPUT: 1447727659893 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] 18:36:28 INFO - 2015-11-16 18:36:28,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44115/tests/dromaeo/cssquery-ext.html) 18:36:29 INFO - 2015-11-16 18:36:29,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 241065984 18:36:29 INFO - 2015-11-16 18:36:29,837 DEBUG : BROWSER_OUTPUT: 18:39:32 INFO - 2015-11-16 18:39:32,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/dromaeo/cssquery-ext.html (next: http://localhost:44115/tests/dromaeo/cssquery-jquery.html) 18:39:32 INFO - 2015-11-16 18:39:32,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 218652672 18:39:32 INFO - 2015-11-16 18:39:32,765 DEBUG : BROWSER_OUTPUT: 18:42:34 INFO - 2015-11-16 18:42:34,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44115/tests/dromaeo/cssquery-mootools.html) 18:42:35 INFO - 2015-11-16 18:42:35,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 212942848 18:42:35 INFO - 2015-11-16 18:42:35,247 DEBUG : BROWSER_OUTPUT: 18:45:37 INFO - 2015-11-16 18:45:37,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44115/tests/dromaeo/cssquery-prototype.html) 18:45:37 INFO - 2015-11-16 18:45:37,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 198692864 18:45:37 INFO - 2015-11-16 18:45:37,636 DEBUG : BROWSER_OUTPUT: 18:48:39 INFO - 2015-11-16 18:48:39,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44115/tests/dromaeo/cssquery-yui.html) 18:48:40 INFO - 2015-11-16 18:48:40,542 DEBUG : BROWSER_OUTPUT: RSS: Main: 204627968 18:48:40 INFO - 2015-11-16 18:48:40,542 DEBUG : BROWSER_OUTPUT: 18:51:43 INFO - 2015-11-16 18:51:43,080 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/dromaeo/cssquery-yui.html (next: http://localhost:44115/tests/dromaeo/cssquery-dojo.html) 18:51:43 INFO - 2015-11-16 18:51:43,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 274141184 18:51:43 INFO - 2015-11-16 18:51:43,338 DEBUG : BROWSER_OUTPUT: 18:51:43 INFO - 2015-11-16 18:51:43,338 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:51:43 INFO - 2015-11-16 18:51:43,338 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:51:43 INFO - 2015-11-16 18:51:43,339 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:51:43 INFO - 2015-11-16 18:51:43,339 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:51:43 INFO - 2015-11-16 18:51:43,339 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3225.903222903313;3294.1105901406604;3348.112750121217;3362.377960077385;3365.814880181589;5344.278522399475;5462.20797984292;5519.834404967853;5521.558275337973;5597.888042239153;5436.782528698857;5484.314460692413;5554.86112847178;5557.444255574441;5587.580931430139;4983.775730092146;5057.544820966113;5087.592992560586;5101.897962040757;5146.819861304855;4993.475685053071;5112.054269960069;5128.153854614003;5174.818881339153;5180.2229665550285;4888.780004899771;5031.421386540558;5053.418856831475;5055.368078990126;5077.822276220333;5048.091343558158;5050.368703912011;5052.4189718182515;5072.137736584789;5094.3886733591835;4904.485029071931;5019.247112933052;5031.47169547196;5041.042201981649;5044.520770526794;5218.269442278084;5308.575313974911;5320.388155362144;5321.201819727072;5325.174597937326;5974.044152935509;5987.1019347097845;5991;5991.850203744898;6008.459238668541;5888.205092312526;5923.200367950358;5992.310884248323;6025.276966763972;6026.427489388545;5595.7481913313995;5608.186812912105;5612.803551875665;5648.124540696199;5648.915266271009;6113.266408031065;6113.908291375633;6126.958417069109;6127.234095738033;6127.6782420562195;5818.505427038749;5860.765569377262;5929.0513517836935;5932.288125424977;6002.0996850472775;5995.370486098984;5996.880062398727;5999.820005399845;6004.639721616717;6007.729652165663;5975.163477113208;5976.402359764076;5980.820575382745;5984.192134061933;5984.8803023940145;5823.242978412779;5830.47525722687;5907.61600495975;5930.169776231331;5946.67293298864;4569.474510431276;4572.588467037916;4589.10512450069;4591.609713174351;4609.884752881205;3999.8000099994883;4088.100617864065;4088.4276201331836;4090.8568200112854;4111.218868414991;5649.293838270216;5661.065924122474;5738.454846789548;5744.626599271034;5797.188393624896;6037.0642550404755;6039.54703397247;6042.516598672096;6046.909296360558;6049.78825741097;5499.807506737245;5606.24315717373;5682.886342273131;5690.800821971211;5704.3154821421695;5128.8717782055;5203.635745497854;5210.036143313499;5210.062188806051;5248.501392367719;6277.591956522811;6355.3326900674765;6355.618662880242;6358.300586935434;6359.96820015897;5859.677717725566;5892.292924849045;6003.219581454383;6080.422359875804;6099.817005489843;6244.5316601256;6297.748090076346;6307.117003619405;6308.337624549356;6312.43188113072;5924.526037917042;5939.287285525765;5941.257342832146;5941.643501389931;5989.910151347821;5818.4763371296785;5881.794137205177;5940.524758019435;6009.669468179292;6055.757769689163;5815.680137592473;5816.651000939957;5820.30156381237;5823.301203855564;5827.766889324549;5797;5798.072308430631;5799.246098007232;5799.246098007232;5802.361740208658;5560.36055853582;5692.459216374438;5703.401142879938;5800.303963524404;5833.854153646193;5876.676782776817;5905.025670764276;5908.497777688945;5911.408859114054;5968.403159683997;5578.163275508544;5779.768809247751;5784.421557844182;5785.30576330843;5791.218185544897 18:51:43 INFO - 2015-11-16 18:51:43,339 DEBUG : BROWSER_OUTPUT: |1;ext.html;561.8117930493285;582.551435394746;604.2416766957471;604.4408921747382;607.6141650052216;39843.2031359373;40530.59469405305;40536;40569.39145912806;40615;43412.34881476773;43945.12109757811;43963.99999999992;44002.11995760083;44031.339529906996;7693.653785579662;7769.650365733555;8713.302935765156;8857.689980850671;9859.90140098597;10099.14157296627;10158.644447444341;10227.795444091114;10228.846567301496;10238.385696858175;10454.059134677878;10557.102646275076;10563.049325560698;10567.418791966476;10569.577216911315;7848.293653571178;8006.759797206093;10162.441065741381;10306.227032972558;10433.739156521071;9986.600535978552;10056.34633748804;10103.141232995204;10113.544890479947;10139.594416223343;36874.44688329651;37101;37244.627553724386;37278.627213727785;37308.62691373079;3323.7507186960834;3387.593488781362;3388.8644454221803;3429.7770644908;3778.149916268845;30008.8499557503;30027.549586756217;30384.392312153854;30466.695333046828;31808;3502.2645244498685;3509.508668786372;3539.0975301298004;3567.108222944264;3642.2351306225723;273418;273495.6325218381;274295;276071;277224;54428;55748.72125639346;55757.72121139449;57151.714241428526;57322.140167897516;51740;60955;61337;61612.38387616156;61684;14479.565613031626;14618.122912625277;14633.634159146106;14652.12087274767;14706.338214780146;11006.064484518745;11035.337879727242;11070.5571777128;11109.944450277859;11125.109991200685;18777.530561736065;19025.334113306246;19047.80952190488;19094.71357929632;19142.808571914382;7719.11230208522;8005.599720013976;8052.959735201286;8085.595720213966;8103.594820258963;949.7720547068653;988.421773262635;1022.1720406470782;1070.6466865934224;1081.605214096849;27715.816630283705;27821.582676259874;27877.442451150862;28059.438811223663;28139.71860281412;1022.6522982186092;1031.7369070886875;1034.632705389591;1044.185535282481;1154.8729639739622;13210.537631182862;13536.45854165842;13557.728845423037;14984.325705343286;15135.621609459851;329389;333119;333649;333710;333838;52655.73672131615;52694.73652631789;52737;52737;52947.73526132345;1240.9503619855286;1241.025794751116;1255.3346726234927;1322.4247452358254;1345.7173993461483;26228.73771262263;26859.194224173305;27428.177154685392;28032;28232.153035408148;48303;48310.5168948306;48326.75836620794;48392.5160748388;48510.5148948506;286254;286857;298165;301212;302371;28582;28612.42775144527;28692.13923582296;28699;28838.279043023253;39211;40087.79956100201;40145;40402.59597403988;40863.1827363457;36104;37003.62996370002;37033;37242.25515489621;37689.43465847959;36889;36942;37443.62556374401;37649.24701506009;37675.246495070496;35323.64676353204;37013.62986370102;37151.32819023096;37235.813820931806;37262.25475490421;28407.573886392132;29484;29927.55108673328;30890.227744305674;31015;23929.28212153638;24499.608465133533;24608.384790380383;24858.378540536632;25241.873790631664 18:51:43 INFO - 2015-11-16 18:51:43,339 DEBUG : BROWSER_OUTPUT: |2;jquery.html;327.80495605114965;346.0155856588007;347.1460207888594;349.37636319170286;349.65209616431656;15036;15419.460318888841;16478.670426591478;16807.327706891723;17846.107694615264;15963.760543591856;16494.75257871133;16618.169091545435;17289.91355043223;17295.567610809736;5387.542058924996;5509.953108909314;5542.140968149944;5552.500274975251;5555.3611334696625;3975.145343751093;4063.1873625274916;5403.78384864605;5448.128299472085;5877;6052;6056.061310496858;6093.482054025413;6105.633661980295;6110.083487476892;4731.6451266155;4829.034193161382;4832.927506087429;4842.709437433765;6024.1566180734735;4115.52671442782;4172.582741725833;4185.832566697329;4197.454330936989;4199.097194103282;13156.671083222996;13220.206787592775;13450.529231476949;13455.259960702157;13550.59348219555;1962.2053068507278;1971.842252619787;1992;2035.2774764958522;2051.6307064728344;9743.805123897553;9814.312998090136;9836.06557377048;10029.04724051214;10173.237007224488;1590.3161640494582;1593.8246792852776;1642.2363600925628;1734.384293575775;1737.0533059482611;59206.703966479894;59906.40093599052;59927;60126;60878;6749;6892.069570608004;6896.27589103147;6928.757493487805;6975.686094125776;8318.417710760188;8326.084130745614;8327.6668933242;8327.6668933242;8332.16678332162;5489.945100548944;5496.285482887199;5513.5037846594;5532.5573954083575;5543.889122217533;5669.744861481243;5672.971635141798;5674.659520428788;5702.030654788696;5702.686352250583;3173.1591128351006;3204.7916885402374;3219.613646362405;3241.546183534307;3241.6434192238835;1122.820348744197;1149.310413751759;1159.4666453431516;1171.6777886081225;1191.642507247822;467.72638006766425;510.1531457780067;510.5354127743735;513.5660366989888;515.7240876131252;10615.84076238857;11649.708757280967;12071.396430178456;12151.574694885636;12159;490.3355952684133;511.5447251945771;527.5647590737657;539.9379071406838;542.3248056170094;5699.287589051369;6409.070684750778;6470.579412338183;6542.803715888531;6595.406413422719;524239;542347.8826058761;549943;559755;611015;70642.64678676573;72457.6377118111;73188.63405682938;74444.62777686185;74831.62584187153;548.5364866687643;554.204716232208;555.1339909740817;555.9054960656698;555.9138333558224;10865.511052002521;11112;11177.552897883994;11264.60573879943;11327.263727857662;36081.639183607826;36551;37073.443898342084;37445.81277093597;37521.62478375291;47590.76204618955;48590.757046214545;49358;49445;49566.256506151716;6481.384268494486;6794.626295553792;6815.727370905108;6816.965915170393;6820;12011.519539218683;12092.576759813364;12151.149419540547;12163.695907602381;12183.695407614881;10682.679519614425;10793.08258798011;10803.837942430713;10857.837132443177;10942.562297508011;10039.548220329956;10199.184065274909;10487.790244195226;10781.245312828027;11052.889471105507;9247.583858726508;9558.091981261769;10277.331973421704;10783.299085559414;10816.296940698829;6713.060171575886;6861.245263020964;6862.9313706862295;6864.1762988439705;6868.278830722902;10742.24804263694;10851.186161038111;11131.332120072822;11150.609728659458;11196.776064478829 18:51:43 INFO - 2015-11-16 18:51:43,339 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1393.7421577008247;1751.1506919144215;1775.3786174838808;1807.2951548895933;1808.168242608401;6954.547954382968;7395.445341599381;7490.176080631133;7497.775066747992;7499.625018749068;7292.7447539336135;7338.119425668927;7359.558426494414;7370.705171793122;7389.187189409161;1949.727038214651;1988.6519859024686;2212.977870221301;2262.468319944816;2286.017012684545;2237.284069097889;2242.843000989931;2245.303955773707;2245.5621153875;2245.69683092782;2192.4628466025847;2244.1920908473016;2247.381969958258;2248.280550223929;2254.77452254774;1873.7002079667257;1901.6767149584605;2214.7895949884737;2242.215224671368;2246.034205291724;2240.283109404991;2250.2349201271645;2276.2260831317267;2279.4415368234722;2287.3595393289906;7588.506747061479;7645.388368930472;7649.885251721229;7657.961710191469;7663.386929045663;4580.24425969718;4658.4642766082;4662.557057079572;4666.020135771492;4668.6731928765;3060.158456424501;3119.0954623159255;3149.7952633079008;3154.511050787132;3163.794353367047;997.3766396002499;1003.6938733686222;1014.6854475112665;1018.8624535687735;1035.7358873487212;10235.181185505142;10417.531211095518;10418;10426.895731042745;10437.843432348445;4004.2191772604065;4056.3307054335705;4102.220578090153;4105.794710264475;4111.1366613011005;8641.697540586176;8651.221390074923;8652.567371631394;8663.090375510481;8670.91329086701;4580.885477863014;4595.149897269016;4608.3778689876435;4610.077984403133;4615.16926953145;4218.156368726267;4234.809433575497;4235.216484950294;4239.173361194537;4239.59723826236;3322.767406281537;3376.0884561168345;3396.3377141457177;3401.523786669868;3405.267867408519;992.9404235745734;1005.9195264378832;1009.7324209084452;1011.7318910488726;1017.2726500552141;1282.4934151010298;1287.658770425838;1314.4676406055562;1331.673739933703;1352.1278775189946;7114.964425177945;7176.210616832144;7194.856102877913;7200.747973820891;7223.458240631869;471.7570451217626;482.14178761804044;482.1802935010496;484.60988903932673;485.45143987294836;5682.034054210794;5710.857228569319;5724.484796368263;5725.828225153252;5727.742251598688;9012.954935225282;9212.309076819265;9228.16946474807;9239;9318.48748318849;9160.22138118254;9223;9248.075192480697;9254.86117708235;9260.259179265642;7061;7282.708691652275;7317.817054573678;7320.743773967885;7321.194668586451;7123.715051397886;7148;7197.748078817216;7211.278872112747;7215.783526494213;7984.481008734414;8009.519428834055;8171.509709417454;8237.258646721824;8272.793180170544;8380.622871970898;8470.957645211734;8484.787880303042;8486.533240671823;8505.87241191395;6781.321867813376;6943.79168624942;6951.548149370275;6967.512274140761;6974.500482396309;7479.439042071757;7532.698692052476;7533;7583.127940286717;7584.62076896164;6273.1844860167885;6864.347886950732;6918.342757438036;6944.131983502062;7136.5004449690105;6940.652967351713;6986.371226589631;7039.859202816017;7068.29317068289;7114.9288507116335;7050.823729406806;7089.716411343488;7106.360427561544;7133.5719856808755;7140.964295178491;6467.870642587216;6516.934830651822;6529.9347006531225;6531.477481801539;6538.771143009972;6283.214598175228;6411.5832470889245;6414.262359828679;6415.903761443488;6507.316731743288 18:51:43 INFO - 2015-11-16 18:51:43,339 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.935728818304;301.2093255205087;306.90639354996745;308.50946994279093;309.2469835949463;5999.130126131714;6071.605345652535;6147.723352449139;6155;6177.691115444221;6004.42957918997;6058.636481811094;6076.87846243076;6086.969565152179;6103.23709536308;4294.033842385469;4369.956300437003;4494.662900282476;4506.121306345264;4509.639228861692;4381.6494680425485;4478.373027776098;4486.685931984763;4489.124620698965;4492.326151077332;4452.688311818174;4453.755043472608;4465.59809617136;4468.50846406895;4475.127350166719;4232.9153416931795;4342.457192850894;4344.044310251739;4470.351798989161;4473;3827.7320587558884;3832.8466861325514;3836.0985168485386;3836.1368692044066;3842.5581058178386;5638.492535671769;5649.180868774046;5651.2370829937845;5657;5667.659940403548;5142.640015198937;5151.2530683050745;5161.174212126042;5168.870778230536;5176.534111929906;6190.473809726179;6315.273743519462;6326.49388048955;6326.746930122789;6328.810135695937;4219.514755803091;4227;4238.940264933766;4244.660427165819;4246.63903568194;6548.27968923418;6631.640513694681;6632.469402447792;6636.402723754885;6637.46900247979;4222.809973551198;4299.581138224441;4310.870673879788;4312.245357062501;4312.849050283225;4335.154644844225;4365.432493775789;4366.126774645084;4369.934450983238;4374.825006999685;5117.616178786606;5121.667091639031;5132.255822905658;5133.794648214104;5150.690958542499;6398.808035758934;6406.551541392151;6407.743690252338;6409.871802563923;6424.1327420798525;1492.7910092587047;1514.2050423527517;1522.8781697464399;1523.4591719939262;1523.6800271942795;979.1041197304529;999.0409207161207;1011.1304278320638;1011.1556850030161;1020.7703266764919;6221.440070393596;6238.812835614848;6239.438450539473;6263.812085637347;6264.37356264379;6620.768273110418;6623.635700036544;6624.105745724362;6625.271220165778;6632.701528431232;6138.754449822047;6250.9062364064575;6255.56211065221;6263.655498947511;6268.122462855204;3462.4979377990553;3525.5593050868642;3529.0647978285774;3551.751377403609;3604.945925811115;6909.032735417046;6927.5452155047;6942.236354001056;6942.687579058955;6956.860862782716;6810.897836532456;6816.522843401013;6822.556533825285;6824.556403833735;6829.863402731918;6813.931860681429;6933.791986240421;6964.582125072512;6973;6973.302669732986;6648.235452922782;6651.102101216274;6654;6654.600723956578;6663.36698013688;6583.177102862142;6585.736570537125;6590.472762178918;6592.373724496165;6600.438962688226;6799.456043516606;6895.724171033103;6935.757248496278;6966.1988871280455;6969.128858892638;4337.284348082657;4337.327714204177;4341.413909122354;4345.196138714348;4346.891327716832;6593.571417857824;6605.075289459575;6609.504287178384;6618.867622647424;6619.735210591522;6283;6457.741690332334;6461.903071454026;6468.902966455601;6472.773452929313;6441.098246245623;6453.677316134268;6454.290028097;6468.094466774562;6469.482441404771;6298.842528936813;6328.46208072319;6331.778387756406;6335.1447554579545;6337.9366206337345;6393.4885209184085;6473.320301368477;6476.6114033158165;6481.449076828522;6492.577982431127;6321.431071203614;6325.778597749057;6329.113924050729;6335.936640633535;6337.176167098248 18:51:43 INFO - 2015-11-16 18:51:43,339 DEBUG : BROWSER_OUTPUT: |5;yui.html;746.0674157303371;805.7542449552884;808.1151139502244;819.9344052475802;861.298042095692;13502.932485337571;13820.512307784595;13841.446342146328;13845.584632461043;13883.236421996786;12985.220886746778;13085;13555.457781688721;13558.186508809453;13565.593032209024;692.9064576282213;696.0151385789102;832.7085520067973;844.1136806353335;846.4878748357216;837.6523742646795;839.2866063845713;840.6721378662327;843.9282660973824;845.733593917917;875.9474431534128;883.8939327280735;884.305819931354;884.5754038061734;885.57049830832;723.1394640377933;727.2364017781308;865.8051938313861;868.8218915122385;869.7608157756604;637.08260105448;642.2036674523604;645.6965226343611;646.0341789025437;647.6955830759536;13718.314084295745;13856.099353542088;13875.375608097558;13881.583552493441;13913.513027044106;11923.224990375598;12740.388220414792;12808.743825123445;12932.547360842325;12996.41516131767;10145.898541014643;10366.792664146675;10383.584656613726;10401.427921464316;10444.26890117692;3237.482002879528;3286.605607327112;3312.2381852173894;3325.783824051429;3384.915377115567;42056;42217.57782422167;42300.153996919886;42358.15283694309;42431.57568424338;7504.849903001909;7541.773746787496;7570.962145189239;7621.466497345244;7643.961780191064;11646.88353116458;11988.700282492833;11997.220180688402;12015.038796896228;12047.759044819055;6603.933960660428;6698.5980841149685;6721.563098398588;6827.249002609709;6848.14398200225;4259.5101563319995;4286.742795432284;4323.221820072417;4427.867163985085;4451.666125040635;2659.428222932079;2691.0312287576457;2699.460107978412;2700.3654141276784;2701.18964310706;441.6510956344516;450.12226158990103;450.1896586144926;452.08678469491446;455.0671124195386;651.7914267434376;652.7519542573791;654.1300070905684;656.3516212084218;701.6316433872156;8261.13258107902;8352.331813454908;8357.206065423776;8359.164083591591;8761.824763504694;588.3146134752965;631.6936285901335;690.8031211104911;697.9267176946449;710.6233696141054;4069.5501367978522;4093.5497095319492;4196.769177695256;4355.0854320593035;4382.890427739332;49912.500874991514;49936.500634993914;50076.74961625241;53277.73361133169;56985.43014569884;45309.546904530536;45348.09303813971;45623.77188114038;46492;46530;44596.3310550342;45002.09995800131;45914;46361.76819115883;46478.53521464742;8478.23695867375;8750.256228220673;8973.685920992733;9036.909630903607;9073.092690730875;33489.49765753564;34392.65607343894;35394.1151471205;35503;35873;43905.12189756123;44372.334414983154;44779.776101119285;45309.320360195285;45692.31461528146;8461.661533538836;8731.301495880442;8889.866652000355;9006.091680034528;9290.489023103793;12187.51249949992;12198.573049943565;12279.631611051684;12464.5014199431;12535.93732031334;11421.428928553372;11622.88377116218;11657.183997120459;11933.641990740292;12042.578509752117;11065.557377705123;11283.548658053915;11345.773084538097;11729.120315976506;11793.646190614296;11253.80196012169;11575.189736718348;11630.069594432256;11641;11933.582324618597;9833;9998.20014398861;10003.199744020607;10232.539535720762;10381.792364152825;8515.233628973423;9061.818763624822;9395.389299695498;9702.126808587262;9913.45475998827 18:51:43 INFO - 2015-11-16 18:51:43,339 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:51:43 INFO - 2015-11-16 18:51:43,339 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:51:43 INFO - 2015-11-16 18:51:43,339 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,869 18:51:43 INFO - 2015-11-16 18:51:43,339 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:51:43 INFO - 2015-11-16 18:51:43,339 DEBUG : BROWSER_OUTPUT: __startTimestamp1447728703332__endTimestamp 18:51:43 INFO - 2015-11-16 18:51:43,340 DEBUG : BROWSER_OUTPUT: 18:51:43 INFO - 2015-11-16 18:51:43,340 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:51:43 INFO - 2015-11-16 18:51:43,341 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:51:43 INFO - 2015-11-16 18:51:43,341 DEBUG : BROWSER_OUTPUT: 18:51:43 INFO - 2015-11-16 18:51:43,341 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5550.56 Median:5797.00 stddev:634.55 (10.9%) stddev-sans-first:609.73 18:51:43 INFO - 2015-11-16 18:51:43,341 DEBUG : BROWSER_OUTPUT: Values: 3225.9 3294.1 3348.1 3362.4 3365.8 5344.3 5462.2 5519.8 5521.6 5597.9 5436.8 5484.3 5554.9 5557.4 5587.6 4983.8 5057.5 5087.6 5101.9 5146.8 4993.5 5112.1 5128.2 5174.8 5180.2 4888.8 5031.4 5053.4 5055.4 5077.8 5048.1 5050.4 5052.4 5072.1 5094.4 4904.5 5019.2 5031.5 5041.0 5044.5 5218.3 5308.6 5320.4 5321.2 5325.2 5974.0 5987.1 5991.0 5991.9 6008.5 5888.2 5923.2 5992.3 6025.3 6026.4 5595.7 5608.2 5612.8 5648.1 5648.9 6113.3 6113.9 6127.0 6127.2 6127.7 5818.5 5860.8 5929.1 5932.3 6002.1 5995.4 5996.9 5999.8 6004.6 6007.7 5975.2 5976.4 5980.8 5984.2 5984.9 5823.2 5830.5 5907.6 5930.2 5946.7 4569.5 4572.6 4589.1 4591.6 4609.9 3999.8 4088.1 4088.4 4090.9 4111.2 5649.3 5661.1 5738.5 5744.6 5797.2 6037.1 6039.5 6042.5 6046.9 6049.8 5499.8 5606.2 5682.9 5690.8 5704.3 5128.9 5203.6 5210.0 5210.1 5248.5 6277.6 6355.3 6355.6 6358.3 6360.0 5859.7 5892.3 6003.2 6080.4 6099.8 6244.5 6297.7 6307.1 6308.3 6312.4 5924.5 5939.3 5941.3 5941.6 5989.9 5818.5 5881.8 5940.5 6009.7 6055.8 5815.7 5816.7 5820.3 5823.3 5827.8 5797.0 5798.1 5799.2 5799.2 5802.4 5560.4 5692.5 5703.4 5800.3 5833.9 5876.7 5905.0 5908.5 5911.4 5968.4 5578.2 5779.8 5784.4 5785.3 5791.2 18:51:43 INFO - 2015-11-16 18:51:43,341 DEBUG : BROWSER_OUTPUT: 18:51:43 INFO - 2015-11-16 18:51:43,341 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46877.14 Median:166356.38 stddev:78922.19 (47.4%) stddev-sans-first:79066.98 18:51:43 INFO - 2015-11-16 18:51:43,341 DEBUG : BROWSER_OUTPUT: Values: 561.8 582.6 604.2 604.4 607.6 39843.2 40530.6 40536.0 40569.4 40615.0 43412.3 43945.1 43964.0 44002.1 44031.3 7693.7 7769.7 8713.3 8857.7 9859.9 10099.1 10158.6 10227.8 10228.8 10238.4 10454.1 10557.1 10563.0 10567.4 10569.6 7848.3 8006.8 10162.4 10306.2 10433.7 9986.6 10056.3 10103.1 10113.5 10139.6 36874.4 37101.0 37244.6 37278.6 37308.6 3323.8 3387.6 3388.9 3429.8 3778.1 30008.8 30027.5 30384.4 30466.7 31808.0 3502.3 3509.5 3539.1 3567.1 3642.2 273418.0 273495.6 274295.0 276071.0 277224.0 54428.0 55748.7 55757.7 57151.7 57322.1 51740.0 60955.0 61337.0 61612.4 61684.0 14479.6 14618.1 14633.6 14652.1 14706.3 11006.1 11035.3 11070.6 11109.9 11125.1 18777.5 19025.3 19047.8 19094.7 19142.8 7719.1 8005.6 8053.0 8085.6 8103.6 949.8 988.4 1022.2 1070.6 1081.6 27715.8 27821.6 27877.4 28059.4 28139.7 1022.7 1031.7 1034.6 1044.2 1154.9 13210.5 13536.5 13557.7 14984.3 15135.6 329389.0 333119.0 333649.0 333710.0 333838.0 52655.7 52694.7 52737.0 52737.0 52947.7 1241.0 1241.0 1255.3 1322.4 1345.7 26228.7 26859.2 27428.2 28032.0 28232.2 48303.0 48310.5 48326.8 48392.5 48510.5 286254.0 286857.0 298165.0 301212.0 302371.0 28582.0 28612.4 28692.1 28699.0 28838.3 39211.0 40087.8 40145.0 40402.6 40863.2 36104.0 37003.6 37033.0 37242.3 37689.4 36889.0 36942.0 37443.6 37649.2 37675.2 35323.6 37013.6 37151.3 37235.8 37262.3 28407.6 29484.0 29927.6 30890.2 31015.0 23929.3 24499.6 24608.4 24858.4 25241.9 18:51:43 INFO - 2015-11-16 18:51:43,341 DEBUG : BROWSER_OUTPUT: 18:51:43 INFO - 2015-11-16 18:51:43,342 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27564.23 Median:4830.98 stddev:91407.55 (1892.1%) stddev-sans-first:91641.09 18:51:43 INFO - 2015-11-16 18:51:43,343 DEBUG : BROWSER_OUTPUT: Values: 327.8 346.0 347.1 349.4 349.7 15036.0 15419.5 16478.7 16807.3 17846.1 15963.8 16494.8 16618.2 17289.9 17295.6 5387.5 5510.0 5542.1 5552.5 5555.4 3975.1 4063.2 5403.8 5448.1 5877.0 6052.0 6056.1 6093.5 6105.6 6110.1 4731.6 4829.0 4832.9 4842.7 6024.2 4115.5 4172.6 4185.8 4197.5 4199.1 13156.7 13220.2 13450.5 13455.3 13550.6 1962.2 1971.8 1992.0 2035.3 2051.6 9743.8 9814.3 9836.1 10029.0 10173.2 1590.3 1593.8 1642.2 1734.4 1737.1 59206.7 59906.4 59927.0 60126.0 60878.0 6749.0 6892.1 6896.3 6928.8 6975.7 8318.4 8326.1 8327.7 8327.7 8332.2 5489.9 5496.3 5513.5 5532.6 5543.9 5669.7 5673.0 5674.7 5702.0 5702.7 3173.2 3204.8 3219.6 3241.5 3241.6 1122.8 1149.3 1159.5 1171.7 1191.6 467.7 510.2 510.5 513.6 515.7 10615.8 11649.7 12071.4 12151.6 12159.0 490.3 511.5 527.6 539.9 542.3 5699.3 6409.1 6470.6 6542.8 6595.4 524239.0 542347.9 549943.0 559755.0 611015.0 70642.6 72457.6 73188.6 74444.6 74831.6 548.5 554.2 555.1 555.9 555.9 10865.5 11112.0 11177.6 11264.6 11327.3 36081.6 36551.0 37073.4 37445.8 37521.6 47590.8 48590.8 49358.0 49445.0 49566.3 6481.4 6794.6 6815.7 6817.0 6820.0 12011.5 12092.6 12151.1 12163.7 12183.7 10682.7 10793.1 10803.8 10857.8 10942.6 10039.5 10199.2 10487.8 10781.2 11052.9 9247.6 9558.1 10277.3 10783.3 10816.3 6713.1 6861.2 6862.9 6864.2 6868.3 10742.2 10851.2 11131.3 11150.6 11196.8 18:51:43 INFO - 2015-11-16 18:51:43,343 DEBUG : BROWSER_OUTPUT: 18:51:43 INFO - 2015-11-16 18:51:43,343 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5352.68 Median:6412.92 stddev:2791.55 (43.5%) stddev-sans-first:2783.52 18:51:43 INFO - 2015-11-16 18:51:43,343 DEBUG : BROWSER_OUTPUT: Values: 1393.7 1751.2 1775.4 1807.3 1808.2 6954.5 7395.4 7490.2 7497.8 7499.6 7292.7 7338.1 7359.6 7370.7 7389.2 1949.7 1988.7 2213.0 2262.5 2286.0 2237.3 2242.8 2245.3 2245.6 2245.7 2192.5 2244.2 2247.4 2248.3 2254.8 1873.7 1901.7 2214.8 2242.2 2246.0 2240.3 2250.2 2276.2 2279.4 2287.4 7588.5 7645.4 7649.9 7658.0 7663.4 4580.2 4658.5 4662.6 4666.0 4668.7 3060.2 3119.1 3149.8 3154.5 3163.8 997.4 1003.7 1014.7 1018.9 1035.7 10235.2 10417.5 10418.0 10426.9 10437.8 4004.2 4056.3 4102.2 4105.8 4111.1 8641.7 8651.2 8652.6 8663.1 8670.9 4580.9 4595.1 4608.4 4610.1 4615.2 4218.2 4234.8 4235.2 4239.2 4239.6 3322.8 3376.1 3396.3 3401.5 3405.3 992.9 1005.9 1009.7 1011.7 1017.3 1282.5 1287.7 1314.5 1331.7 1352.1 7115.0 7176.2 7194.9 7200.7 7223.5 471.8 482.1 482.2 484.6 485.5 5682.0 5710.9 5724.5 5725.8 5727.7 9013.0 9212.3 9228.2 9239.0 9318.5 9160.2 9223.0 9248.1 9254.9 9260.3 7061.0 7282.7 7317.8 7320.7 7321.2 7123.7 7148.0 7197.7 7211.3 7215.8 7984.5 8009.5 8171.5 8237.3 8272.8 8380.6 8471.0 8484.8 8486.5 8505.9 6781.3 6943.8 6951.5 6967.5 6974.5 7479.4 7532.7 7533.0 7583.1 7584.6 6273.2 6864.3 6918.3 6944.1 7136.5 6940.7 6986.4 7039.9 7068.3 7114.9 7050.8 7089.7 7106.4 7133.6 7141.0 6467.9 6516.9 6529.9 6531.5 6538.8 6283.2 6411.6 6414.3 6415.9 6507.3 18:51:43 INFO - 2015-11-16 18:51:43,343 DEBUG : BROWSER_OUTPUT: 18:51:43 INFO - 2015-11-16 18:51:43,343 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5310.39 Median:6230.13 stddev:1674.98 (26.9%) stddev-sans-first:1636.90 18:51:43 INFO - 2015-11-16 18:51:43,344 DEBUG : BROWSER_OUTPUT: Values: 298.9 301.2 306.9 308.5 309.2 5999.1 6071.6 6147.7 6155.0 6177.7 6004.4 6058.6 6076.9 6087.0 6103.2 4294.0 4370.0 4494.7 4506.1 4509.6 4381.6 4478.4 4486.7 4489.1 4492.3 4452.7 4453.8 4465.6 4468.5 4475.1 4232.9 4342.5 4344.0 4470.4 4473.0 3827.7 3832.8 3836.1 3836.1 3842.6 5638.5 5649.2 5651.2 5657.0 5667.7 5142.6 5151.3 5161.2 5168.9 5176.5 6190.5 6315.3 6326.5 6326.7 6328.8 4219.5 4227.0 4238.9 4244.7 4246.6 6548.3 6631.6 6632.5 6636.4 6637.5 4222.8 4299.6 4310.9 4312.2 4312.8 4335.2 4365.4 4366.1 4369.9 4374.8 5117.6 5121.7 5132.3 5133.8 5150.7 6398.8 6406.6 6407.7 6409.9 6424.1 1492.8 1514.2 1522.9 1523.5 1523.7 979.1 999.0 1011.1 1011.2 1020.8 6221.4 6238.8 6239.4 6263.8 6264.4 6620.8 6623.6 6624.1 6625.3 6632.7 6138.8 6250.9 6255.6 6263.7 6268.1 3462.5 3525.6 3529.1 3551.8 3604.9 6909.0 6927.5 6942.2 6942.7 6956.9 6810.9 6816.5 6822.6 6824.6 6829.9 6813.9 6933.8 6964.6 6973.0 6973.3 6648.2 6651.1 6654.0 6654.6 6663.4 6583.2 6585.7 6590.5 6592.4 6600.4 6799.5 6895.7 6935.8 6966.2 6969.1 4337.3 4337.3 4341.4 4345.2 4346.9 6593.6 6605.1 6609.5 6618.9 6619.7 6283.0 6457.7 6461.9 6468.9 6472.8 6441.1 6453.7 6454.3 6468.1 6469.5 6298.8 6328.5 6331.8 6335.1 6337.9 6393.5 6473.3 6476.6 6481.4 6492.6 6321.4 6325.8 6329.1 6335.9 6337.2 18:51:43 INFO - 2015-11-16 18:51:43,345 DEBUG : BROWSER_OUTPUT: 18:51:43 INFO - 2015-11-16 18:51:43,345 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13045.68 Median:22727.09 stddev:14856.22 (65.4%) stddev-sans-first:14869.18 18:51:43 INFO - 2015-11-16 18:51:43,346 DEBUG : BROWSER_OUTPUT: Values: 746.1 805.8 808.1 819.9 861.3 13502.9 13820.5 13841.4 13845.6 13883.2 12985.2 13085.0 13555.5 13558.2 13565.6 692.9 696.0 832.7 844.1 846.5 837.7 839.3 840.7 843.9 845.7 875.9 883.9 884.3 884.6 885.6 723.1 727.2 865.8 868.8 869.8 637.1 642.2 645.7 646.0 647.7 13718.3 13856.1 13875.4 13881.6 13913.5 11923.2 12740.4 12808.7 12932.5 12996.4 10145.9 10366.8 10383.6 10401.4 10444.3 3237.5 3286.6 3312.2 3325.8 3384.9 42056.0 42217.6 42300.2 42358.2 42431.6 7504.8 7541.8 7571.0 7621.5 7644.0 11646.9 11988.7 11997.2 12015.0 12047.8 6603.9 6698.6 6721.6 6827.2 6848.1 4259.5 4286.7 4323.2 4427.9 4451.7 2659.4 2691.0 2699.5 2700.4 2701.2 441.7 450.1 450.2 452.1 455.1 651.8 652.8 654.1 656.4 701.6 8261.1 8352.3 8357.2 8359.2 8761.8 588.3 631.7 690.8 697.9 710.6 4069.6 4093.5 4196.8 4355.1 4382.9 49912.5 49936.5 50076.7 53277.7 56985.4 45309.5 45348.1 45623.8 46492.0 46530.0 44596.3 45002.1 45914.0 46361.8 46478.5 8478.2 8750.3 8973.7 9036.9 9073.1 33489.5 34392.7 35394.1 35503.0 35873.0 43905.1 44372.3 44779.8 45309.3 45692.3 8461.7 8731.3 8889.9 9006.1 9290.5 12187.5 12198.6 12279.6 12464.5 12535.9 11421.4 11622.9 11657.2 11933.6 12042.6 11065.6 11283.5 11345.8 11729.1 11793.6 11253.8 11575.2 11630.1 11641.0 11933.6 9833.0 9998.2 10003.2 10232.5 10381.8 8515.2 9061.8 9395.4 9702.1 9913.5 18:51:43 INFO - 2015-11-16 18:51:43,346 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:51:43 INFO - 2015-11-16 18:51:43,346 DEBUG : BROWSER_OUTPUT: 18:51:44 INFO - 2015-11-16 18:51:44,111 INFO : Browser exited with error code: 0 18:51:44 INFO - 2015-11-16 18:51:44,132 INFO : Completed test dromaeo_css (00:18:36) 18:51:44 INFO - 2015-11-16 18:51:44,132 INFO : Starting test kraken 18:51:44 INFO - 2015-11-16 18:51:44,132 DEBUG : operating with platform_type : linux_ 18:51:44 INFO - 2015-11-16 18:51:44,132 INFO : Initialising browser for kraken test... 18:51:44 INFO - 2015-11-16 18:51:44,138 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsqaXbX/profile http://localhost:44115/getInfo.html 18:51:48 INFO - 2015-11-16 18:51:48,177 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:51:48 INFO - 2015-11-16 18:51:48,177 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:51:48 INFO - 2015-11-16 18:51:48,178 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:51:48 INFO - 2015-11-16 18:51:48,178 DEBUG : BROWSER_OUTPUT: __metrics 18:51:48 INFO - 2015-11-16 18:51:48,279 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:51:49 INFO - 2015-11-16 18:51:49,708 INFO : Browser initialized. 18:51:49 INFO - 2015-11-16 18:51:49,708 INFO : Running cycle 1/1 for kraken test... 18:51:49 INFO - 2015-11-16 18:51:49,708 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsqaXbX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:52:01 INFO - 2015-11-16 18:52:01,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 141320192 18:52:01 INFO - 2015-11-16 18:52:01,452 DEBUG : BROWSER_OUTPUT: 18:52:03 INFO - 2015-11-16 18:52:03,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44115/tests/kraken/driver.html?testName=audio-beat-detection) 18:52:04 INFO - 2015-11-16 18:52:04,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 178831360 18:52:04 INFO - 2015-11-16 18:52:04,491 DEBUG : BROWSER_OUTPUT: 18:52:07 INFO - 2015-11-16 18:52:07,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44115/tests/kraken/driver.html?testName=audio-dft) 18:52:07 INFO - 2015-11-16 18:52:07,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 169975808 18:52:07 INFO - 2015-11-16 18:52:07,666 DEBUG : BROWSER_OUTPUT: 18:52:10 INFO - 2015-11-16 18:52:10,483 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44115/tests/kraken/driver.html?testName=audio-fft) 18:52:11 INFO - 2015-11-16 18:52:11,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 150134784 18:52:11 INFO - 2015-11-16 18:52:11,044 DEBUG : BROWSER_OUTPUT: 18:52:13 INFO - 2015-11-16 18:52:13,035 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44115/tests/kraken/driver.html?testName=audio-oscillator) 18:52:13 INFO - 2015-11-16 18:52:13,605 DEBUG : BROWSER_OUTPUT: RSS: Main: 153657344 18:52:13 INFO - 2015-11-16 18:52:13,605 DEBUG : BROWSER_OUTPUT: 18:52:15 INFO - 2015-11-16 18:52:15,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44115/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:52:16 INFO - 2015-11-16 18:52:16,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 155824128 18:52:16 INFO - 2015-11-16 18:52:16,303 DEBUG : BROWSER_OUTPUT: 18:52:19 INFO - 2015-11-16 18:52:19,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44115/tests/kraken/driver.html?testName=imaging-darkroom) 18:52:19 INFO - 2015-11-16 18:52:19,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 156295168 18:52:19 INFO - 2015-11-16 18:52:19,775 DEBUG : BROWSER_OUTPUT: 18:52:23 INFO - 2015-11-16 18:52:23,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44115/tests/kraken/driver.html?testName=imaging-desaturate) 18:52:23 INFO - 2015-11-16 18:52:23,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 156176384 18:52:23 INFO - 2015-11-16 18:52:23,783 DEBUG : BROWSER_OUTPUT: 18:52:26 INFO - 2015-11-16 18:52:26,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44115/tests/kraken/driver.html?testName=json-parse-financial) 18:52:27 INFO - 2015-11-16 18:52:27,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 155533312 18:52:27 INFO - 2015-11-16 18:52:27,146 DEBUG : BROWSER_OUTPUT: 18:52:28 INFO - 2015-11-16 18:52:28,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44115/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:52:29 INFO - 2015-11-16 18:52:29,248 DEBUG : BROWSER_OUTPUT: RSS: Main: 166752256 18:52:29 INFO - 2015-11-16 18:52:29,249 DEBUG : BROWSER_OUTPUT: 18:52:31 INFO - 2015-11-16 18:52:31,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44115/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:52:31 INFO - 2015-11-16 18:52:31,651 DEBUG : BROWSER_OUTPUT: RSS: Main: 166801408 18:52:31 INFO - 2015-11-16 18:52:31,651 DEBUG : BROWSER_OUTPUT: 18:52:33 INFO - 2015-11-16 18:52:33,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44115/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:52:34 INFO - 2015-11-16 18:52:34,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 169488384 18:52:34 INFO - 2015-11-16 18:52:34,276 DEBUG : BROWSER_OUTPUT: 18:52:36 INFO - 2015-11-16 18:52:36,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44115/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:52:37 INFO - 2015-11-16 18:52:37,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 180785152 18:52:37 INFO - 2015-11-16 18:52:37,271 DEBUG : BROWSER_OUTPUT: 18:52:39 INFO - 2015-11-16 18:52:39,809 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44115/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:52:40 INFO - 2015-11-16 18:52:40,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 178470912 18:52:40 INFO - 2015-11-16 18:52:40,378 DEBUG : BROWSER_OUTPUT: 18:52:42 INFO - 2015-11-16 18:52:42,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44115/tests/kraken/driver.html?testName=ai-astar) 18:52:42 INFO - 2015-11-16 18:52:42,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 236793856 18:52:42 INFO - 2015-11-16 18:52:42,263 DEBUG : BROWSER_OUTPUT: 18:52:42 INFO - 2015-11-16 18:52:42,266 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:52:42 INFO - 2015-11-16 18:52:42,266 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:52:42 INFO - 2015-11-16 18:52:42,267 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:52:42 INFO - 2015-11-16 18:52:42,267 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:52:42 INFO - 2015-11-16 18:52:42,267 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;105;110;110;110;98;109;110;111 18:52:42 INFO - 2015-11-16 18:52:42,267 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;163;124;155;168;125;151;153;124;164;132 18:52:42 INFO - 2015-11-16 18:52:42,267 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;160;161;159;160;160;164;161;163 18:52:42 INFO - 2015-11-16 18:52:42,267 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;80;81;94;73;71;72;97;90;73 18:52:42 INFO - 2015-11-16 18:52:42,267 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;130;91;90;90;130;92;90;137 18:52:42 INFO - 2015-11-16 18:52:42,267 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;110;109;109;109;109 18:52:42 INFO - 2015-11-16 18:52:42,268 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;145;146;145;146;145;145;146;145 18:52:42 INFO - 2015-11-16 18:52:42,268 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;95;95;96;95;94;95 18:52:42 INFO - 2015-11-16 18:52:42,268 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;57;58;58;56;57;58;64;55;55 18:52:42 INFO - 2015-11-16 18:52:42,268 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;69;69;69;78;68;69;68 18:52:42 INFO - 2015-11-16 18:52:42,268 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;83;84;86;85;95;84;83;86;94 18:52:42 INFO - 2015-11-16 18:52:42,268 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;121;123;117;128;119;120;122;124;120 18:52:42 INFO - 2015-11-16 18:52:42,268 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;155;153;148;150;140;149;149;148;139 18:52:42 INFO - 2015-11-16 18:52:42,268 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;67;66;65;67;66;64;65;66;68 18:52:42 INFO - 2015-11-16 18:52:42,268 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:52:42 INFO - 2015-11-16 18:52:42,269 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:52:42 INFO - 2015-11-16 18:52:42,269 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,916 18:52:42 INFO - 2015-11-16 18:52:42,269 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:52:42 INFO - 2015-11-16 18:52:42,269 DEBUG : BROWSER_OUTPUT: __startTimestamp1447728762264__endTimestamp 18:52:42 INFO - 2015-11-16 18:52:42,269 DEBUG : BROWSER_OUTPUT: 18:52:42 INFO - 2015-11-16 18:52:42,269 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:52:42 INFO - 2015-11-16 18:52:42,269 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:52:42 INFO - 2015-11-16 18:52:42,269 DEBUG : BROWSER_OUTPUT: 18:52:42 INFO - 2015-11-16 18:52:42,271 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.60 Median:110.50 stddev:4.17 (3.8%) stddev-sans-first:4.33 18:52:42 INFO - 2015-11-16 18:52:42,271 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 105.0 110.0 110.0 110.0 98.0 109.0 110.0 111.0 18:52:42 INFO - 2015-11-16 18:52:42,271 DEBUG : BROWSER_OUTPUT: 18:52:42 INFO - 2015-11-16 18:52:42,271 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.90 Median:154.00 stddev:17.82 (11.6%) stddev-sans-first:17.79 18:52:42 INFO - 2015-11-16 18:52:42,271 DEBUG : BROWSER_OUTPUT: Values: 163.0 124.0 155.0 168.0 125.0 151.0 153.0 124.0 164.0 132.0 18:52:42 INFO - 2015-11-16 18:52:42,271 DEBUG : BROWSER_OUTPUT: 18:52:42 INFO - 2015-11-16 18:52:42,271 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.52 (0.9%) stddev-sans-first:1.62 18:52:42 INFO - 2015-11-16 18:52:42,271 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 160.0 161.0 159.0 160.0 160.0 164.0 161.0 163.0 18:52:42 INFO - 2015-11-16 18:52:42,272 DEBUG : BROWSER_OUTPUT: 18:52:42 INFO - 2015-11-16 18:52:42,272 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.50 Median:80.50 stddev:9.79 (12.2%) stddev-sans-first:10.10 18:52:42 INFO - 2015-11-16 18:52:42,272 DEBUG : BROWSER_OUTPUT: Values: 74.0 80.0 81.0 94.0 73.0 71.0 72.0 97.0 90.0 73.0 18:52:42 INFO - 2015-11-16 18:52:42,272 DEBUG : BROWSER_OUTPUT: 18:52:42 INFO - 2015-11-16 18:52:42,272 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.10 Median:90.00 stddev:20.27 (22.5%) stddev-sans-first:21.02 18:52:42 INFO - 2015-11-16 18:52:42,272 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 130.0 91.0 90.0 90.0 130.0 92.0 90.0 137.0 18:52:42 INFO - 2015-11-16 18:52:42,273 DEBUG : BROWSER_OUTPUT: 18:52:42 INFO - 2015-11-16 18:52:42,273 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:52:42 INFO - 2015-11-16 18:52:42,273 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 18:52:42 INFO - 2015-11-16 18:52:42,273 DEBUG : BROWSER_OUTPUT: 18:52:42 INFO - 2015-11-16 18:52:42,274 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 18:52:42 INFO - 2015-11-16 18:52:42,274 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 18:52:42 INFO - 2015-11-16 18:52:42,274 DEBUG : BROWSER_OUTPUT: 18:52:42 INFO - 2015-11-16 18:52:42,274 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 18:52:42 INFO - 2015-11-16 18:52:42,274 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 94.0 95.0 18:52:42 INFO - 2015-11-16 18:52:42,274 DEBUG : BROWSER_OUTPUT: 18:52:42 INFO - 2015-11-16 18:52:42,274 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:2.55 (4.4%) stddev-sans-first:2.70 18:52:42 INFO - 2015-11-16 18:52:42,274 DEBUG : BROWSER_OUTPUT: Values: 58.0 57.0 58.0 58.0 56.0 57.0 58.0 64.0 55.0 55.0 18:52:42 INFO - 2015-11-16 18:52:42,274 DEBUG : BROWSER_OUTPUT: 18:52:42 INFO - 2015-11-16 18:52:42,275 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:3.06 (4.4%) stddev-sans-first:3.21 18:52:42 INFO - 2015-11-16 18:52:42,275 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 69.0 69.0 69.0 78.0 68.0 69.0 68.0 18:52:42 INFO - 2015-11-16 18:52:42,275 DEBUG : BROWSER_OUTPUT: 18:52:42 INFO - 2015-11-16 18:52:42,275 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:85.50 stddev:4.40 (5.1%) stddev-sans-first:4.58 18:52:42 INFO - 2015-11-16 18:52:42,275 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 84.0 86.0 85.0 95.0 84.0 83.0 86.0 94.0 18:52:42 INFO - 2015-11-16 18:52:42,275 DEBUG : BROWSER_OUTPUT: 18:52:42 INFO - 2015-11-16 18:52:42,275 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:122.50 stddev:3.06 (2.5%) stddev-sans-first:3.21 18:52:42 INFO - 2015-11-16 18:52:42,275 DEBUG : BROWSER_OUTPUT: Values: 123.0 121.0 123.0 117.0 128.0 119.0 120.0 122.0 124.0 120.0 18:52:42 INFO - 2015-11-16 18:52:42,275 DEBUG : BROWSER_OUTPUT: 18:52:42 INFO - 2015-11-16 18:52:42,276 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.10 Median:149.00 stddev:5.59 (3.7%) stddev-sans-first:5.30 18:52:42 INFO - 2015-11-16 18:52:42,276 DEBUG : BROWSER_OUTPUT: Values: 140.0 155.0 153.0 148.0 150.0 140.0 149.0 149.0 148.0 139.0 18:52:42 INFO - 2015-11-16 18:52:42,276 DEBUG : BROWSER_OUTPUT: 18:52:42 INFO - 2015-11-16 18:52:42,276 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.15 (1.7%) stddev-sans-first:1.22 18:52:42 INFO - 2015-11-16 18:52:42,276 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 66.0 65.0 67.0 66.0 64.0 65.0 66.0 68.0 18:52:42 INFO - 2015-11-16 18:52:42,276 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:52:42 INFO - 2015-11-16 18:52:42,276 DEBUG : BROWSER_OUTPUT: 18:52:43 INFO - 2015-11-16 18:52:43,131 INFO : Browser exited with error code: 0 18:52:43 INFO - 2015-11-16 18:52:43,218 INFO : Completed test kraken (00:00:59) 18:52:43 INFO - 2015-11-16 18:52:43,218 INFO : Starting test v8_7 18:52:43 INFO - 2015-11-16 18:52:43,218 DEBUG : operating with platform_type : linux_ 18:52:43 INFO - 2015-11-16 18:52:43,219 INFO : Initialising browser for v8_7 test... 18:52:43 INFO - 2015-11-16 18:52:43,225 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXIchMz/profile http://localhost:44115/getInfo.html 18:52:47 INFO - 2015-11-16 18:52:47,391 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:52:47 INFO - 2015-11-16 18:52:47,391 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:52:47 INFO - 2015-11-16 18:52:47,391 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:52:47 INFO - 2015-11-16 18:52:47,391 DEBUG : BROWSER_OUTPUT: __metrics 18:52:47 INFO - 2015-11-16 18:52:47,532 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:52:48 INFO - 2015-11-16 18:52:48,896 INFO : Browser initialized. 18:52:48 INFO - 2015-11-16 18:52:48,896 INFO : Running cycle 1/1 for v8_7 test... 18:52:48 INFO - 2015-11-16 18:52:48,896 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXIchMz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:53:00 INFO - 2015-11-16 18:53:00,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 141520896 18:53:00 INFO - 2015-11-16 18:53:00,686 DEBUG : BROWSER_OUTPUT: 18:53:22 INFO - 2015-11-16 18:53:22,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44115/tests/v8_7/run.html (next: http://localhost:44115/tests/v8_7/run.html) 18:53:22 INFO - 2015-11-16 18:53:22,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 627449856 18:53:22 INFO - 2015-11-16 18:53:22,338 DEBUG : BROWSER_OUTPUT: 18:53:22 INFO - 2015-11-16 18:53:22,338 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:53:22 INFO - 2015-11-16 18:53:22,338 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:53:22 INFO - 2015-11-16 18:53:22,338 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:53:22 INFO - 2015-11-16 18:53:22,338 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:53:22 INFO - 2015-11-16 18:53:22,338 DEBUG : BROWSER_OUTPUT: |0;Richards;166.11295681063123 18:53:22 INFO - 2015-11-16 18:53:22,339 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.5903872348706 18:53:22 INFO - 2015-11-16 18:53:22,339 DEBUG : BROWSER_OUTPUT: |2;Encrypt;286.20492272467084 18:53:22 INFO - 2015-11-16 18:53:22,339 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 18:53:22 INFO - 2015-11-16 18:53:22,339 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1966.6011787819255 18:53:22 INFO - 2015-11-16 18:53:22,339 DEBUG : BROWSER_OUTPUT: |5;Earley;811.0300081103001 18:53:22 INFO - 2015-11-16 18:53:22,339 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 18:53:22 INFO - 2015-11-16 18:53:22,340 DEBUG : BROWSER_OUTPUT: |7;RegExp;25820.51282051282 18:53:22 INFO - 2015-11-16 18:53:22,340 DEBUG : BROWSER_OUTPUT: |8;Splay;632.5110689437065 18:53:22 INFO - 2015-11-16 18:53:22,340 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 18:53:22 INFO - 2015-11-16 18:53:22,340 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:53:22 INFO - 2015-11-16 18:53:22,340 DEBUG : BROWSER_OUTPUT: __startTimestamp1447728802337__endTimestamp 18:53:22 INFO - 2015-11-16 18:53:22,341 DEBUG : BROWSER_OUTPUT: 18:53:22 INFO - 2015-11-16 18:53:22,341 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:53:22 INFO - 2015-11-16 18:53:22,341 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:53:22 INFO - 2015-11-16 18:53:22,341 DEBUG : BROWSER_OUTPUT: 18:53:22 INFO - 2015-11-16 18:53:22,341 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.11 Median:166.11 stddev:0.00 (0.0%) 18:53:22 INFO - 2015-11-16 18:53:22,341 DEBUG : BROWSER_OUTPUT: Values: 166.1 18:53:22 INFO - 2015-11-16 18:53:22,342 DEBUG : BROWSER_OUTPUT: 18:53:22 INFO - 2015-11-16 18:53:22,342 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.59 Median:194.59 stddev:0.00 (0.0%) 18:53:22 INFO - 2015-11-16 18:53:22,342 DEBUG : BROWSER_OUTPUT: Values: 194.6 18:53:22 INFO - 2015-11-16 18:53:22,342 DEBUG : BROWSER_OUTPUT: 18:53:22 INFO - 2015-11-16 18:53:22,342 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:286.20 Median:286.20 stddev:0.00 (0.0%) 18:53:22 INFO - 2015-11-16 18:53:22,342 DEBUG : BROWSER_OUTPUT: Values: 286.2 18:53:22 INFO - 2015-11-16 18:53:22,343 DEBUG : BROWSER_OUTPUT: 18:53:22 INFO - 2015-11-16 18:53:22,344 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 18:53:22 INFO - 2015-11-16 18:53:22,344 DEBUG : BROWSER_OUTPUT: Values: 5050.5 18:53:22 INFO - 2015-11-16 18:53:22,344 DEBUG : BROWSER_OUTPUT: 18:53:22 INFO - 2015-11-16 18:53:22,344 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1966.60 Median:1966.60 stddev:0.00 (0.0%) 18:53:22 INFO - 2015-11-16 18:53:22,344 DEBUG : BROWSER_OUTPUT: Values: 1966.6 18:53:22 INFO - 2015-11-16 18:53:22,345 DEBUG : BROWSER_OUTPUT: 18:53:22 INFO - 2015-11-16 18:53:22,345 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:811.03 Median:811.03 stddev:0.00 (0.0%) 18:53:22 INFO - 2015-11-16 18:53:22,345 DEBUG : BROWSER_OUTPUT: Values: 811.0 18:53:22 INFO - 2015-11-16 18:53:22,345 DEBUG : BROWSER_OUTPUT: 18:53:22 INFO - 2015-11-16 18:53:22,345 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 18:53:22 INFO - 2015-11-16 18:53:22,345 DEBUG : BROWSER_OUTPUT: Values: 12195.1 18:53:22 INFO - 2015-11-16 18:53:22,345 DEBUG : BROWSER_OUTPUT: 18:53:22 INFO - 2015-11-16 18:53:22,346 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25820.51 Median:25820.51 stddev:0.00 (0.0%) 18:53:22 INFO - 2015-11-16 18:53:22,346 DEBUG : BROWSER_OUTPUT: Values: 25820.5 18:53:22 INFO - 2015-11-16 18:53:22,346 DEBUG : BROWSER_OUTPUT: 18:53:22 INFO - 2015-11-16 18:53:22,346 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:632.51 Median:632.51 stddev:0.00 (0.0%) 18:53:22 INFO - 2015-11-16 18:53:22,346 DEBUG : BROWSER_OUTPUT: Values: 632.5 18:53:22 INFO - 2015-11-16 18:53:22,346 DEBUG : BROWSER_OUTPUT: 18:53:22 INFO - 2015-11-16 18:53:22,346 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 18:53:22 INFO - 2015-11-16 18:53:22,347 DEBUG : BROWSER_OUTPUT: Values: 4817.3 18:53:22 INFO - 2015-11-16 18:53:22,347 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:53:22 INFO - 2015-11-16 18:53:22,347 DEBUG : BROWSER_OUTPUT: 18:53:23 INFO - 2015-11-16 18:53:23,251 INFO : Browser exited with error code: 0 18:53:23 INFO - 2015-11-16 18:53:23,263 INFO : Completed test v8_7 (00:00:40) 18:53:23 INFO - 2015-11-16 18:53:23,340 INFO : Completed test suite (00:20:15) 18:53:23 INFO - 2015-11-16 18:53:23,341 DEBUG : Working with test: dromaeo_css 18:53:23 INFO - 2015-11-16 18:53:23,341 DEBUG : Generating results file: dromaeo_css 18:53:23 INFO - 2015-11-16 18:53:23,342 DEBUG : Working with test: kraken 18:53:23 INFO - 2015-11-16 18:53:23,342 DEBUG : Generating results file: kraken 18:53:23 INFO - 2015-11-16 18:53:23,342 INFO : javascript benchmark 18:53:23 INFO - 2015-11-16 18:53:23,342 DEBUG : Working with test: v8_7 18:53:23 INFO - 2015-11-16 18:53:23,342 DEBUG : Generating results file: v8_7 18:53:23 INFO - 2015-11-16 18:53:23,343 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:53:23 INFO - 2015-11-16 18:53:23,393 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 18:53:23 INFO - 2015-11-16 18:53:23,393 DEBUG : process_Request line: dromaeo_css 6690.70 graph.html#tests=[[72,1,35]] 18:53:23 INFO - 2015-11-16 18:53:23,393 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:53:23 INFO - 2015-11-16 18:53:23,420 DEBUG : process_Request line: kraken 1497.30 graph.html#tests=[[232,1,35]] 18:53:23 INFO - 2015-11-16 18:53:23,420 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:53:23 INFO - 2015-11-16 18:53:23,446 DEBUG : process_Request line: v8_7 19676.05 graph.html#tests=[[230,1,35]] 18:53:23 INFO - 2015-11-16 18:53:23,448 INFO : javascript benchmark 18:53:23 INFO - 2015-11-16 18:53:23,451 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [327.80495605114965, 346.0155856588007, 347.1460207888594, 349.37636319170286, 349.65209616431656, 15036.0, 15419.460318888841, 16478.670426591478, 16807.327706891723, 17846.107694615264, 15963.760543591856, 16494.75257871133, 16618.169091545435, 17289.91355043223, 17295.567610809736, 5387.542058924996, 5509.953108909314, 5542.140968149944, 5552.500274975251, 5555.3611334696625, 3975.145343751093, 4063.1873625274916, 5403.78384864605, 5448.128299472085, 5877.0, 6052.0, 6056.061310496858, 6093.482054025413, 6105.633661980295, 6110.083487476892, 4731.6451266155, 4829.034193161382, 4832.927506087429, 4842.709437433765, 6024.1566180734735, 4115.52671442782, 4172.582741725833, 4185.832566697329, 4197.454330936989, 4199.097194103282, 13156.671083222996, 13220.206787592775, 13450.529231476949, 13455.259960702157, 13550.59348219555, 1962.2053068507278, 1971.842252619787, 1992.0, 2035.2774764958522, 2051.6307064728344, 9743.805123897553, 9814.312998090136, 9836.06557377048, 10029.04724051214, 10173.237007224488, 1590.3161640494582, 1593.8246792852776, 1642.2363600925628, 1734.384293575775, 1737.0533059482611, 59206.703966479894, 59906.40093599052, 59927.0, 60126.0, 60878.0, 6749.0, 6892.069570608004, 6896.27589103147, 6928.757493487805, 6975.686094125776, 8318.417710760188, 8326.084130745614, 8327.6668933242, 8327.6668933242, 8332.16678332162, 5489.945100548944, 5496.285482887199, 5513.5037846594, 5532.5573954083575, 5543.889122217533, 5669.744861481243, 5672.971635141798, 5674.659520428788, 5702.030654788696, 5702.686352250583, 3173.1591128351006, 3204.7916885402374, 3219.613646362405, 3241.546183534307, 3241.6434192238835, 1122.820348744197, 1149.310413751759, 1159.4666453431516, 1171.6777886081225, 1191.642507247822, 467.72638006766425, 510.1531457780067, 510.5354127743735, 513.5660366989888, 515.7240876131252, 10615.84076238857, 11649.708757280967, 12071.396430178456, 12151.574694885636, 12159.0, 490.3355952684133, 511.5447251945771, 527.5647590737657, 539.9379071406838, 542.3248056170094, 5699.287589051369, 6409.070684750778, 6470.579412338183, 6542.803715888531, 6595.406413422719, 524239.0, 542347.8826058761, 549943.0, 559755.0, 611015.0, 70642.64678676573, 72457.6377118111, 73188.63405682938, 74444.62777686185, 74831.62584187153, 548.5364866687643, 554.204716232208, 555.1339909740817, 555.9054960656698, 555.9138333558224, 10865.511052002521, 11112.0, 11177.552897883994, 11264.60573879943, 11327.263727857662, 36081.639183607826, 36551.0, 37073.443898342084, 37445.81277093597, 37521.62478375291, 47590.76204618955, 48590.757046214545, 49358.0, 49445.0, 49566.256506151716, 6481.384268494486, 6794.626295553792, 6815.727370905108, 6816.965915170393, 6820.0, 12011.519539218683, 12092.576759813364, 12151.149419540547, 12163.695907602381, 12183.695407614881, 10682.679519614425, 10793.08258798011, 10803.837942430713, 10857.837132443177, 10942.562297508011, 10039.548220329956, 10199.184065274909, 10487.790244195226, 10781.245312828027, 11052.889471105507, 9247.583858726508, 9558.091981261769, 10277.331973421704, 10783.299085559414, 10816.296940698829, 6713.060171575886, 6861.245263020964, 6862.9313706862295, 6864.1762988439705, 6868.278830722902, 10742.24804263694, 10851.186161038111, 11131.332120072822, 11150.609728659458, 11196.776064478829], "dojo.html": [3225.903222903313, 3294.1105901406604, 3348.112750121217, 3362.377960077385, 3365.814880181589, 5344.278522399475, 5462.20797984292, 5519.834404967853, 5521.558275337973, 5597.888042239153, 5436.782528698857, 5484.314460692413, 5554.86112847178, 5557.444255574441, 5587.580931430139, 4983.775730092146, 5057.544820966113, 5087.592992560586, 5101.897962040757, 5146.819861304855, 4993.475685053071, 5112.054269960069, 5128.153854614003, 5174.818881339153, 5180.2229665550285, 4888.780004899771, 5031.421386540558, 5053.418856831475, 5055.368078990126, 5077.822276220333, 5048.091343558158, 5050.368703912011, 5052.4189718182515, 5072.137736584789, 5094.3886733591835, 4904.485029071931, 5019.247112933052, 5031.47169547196, 5041.042201981649, 5044.520770526794, 5218.269442278084, 5308.575313974911, 5320.388155362144, 5321.201819727072, 5325.174597937326, 5974.044152935509, 5987.1019347097845, 5991.0, 5991.850203744898, 6008.459238668541, 5888.205092312526, 5923.200367950358, 5992.310884248323, 6025.276966763972, 6026.427489388545, 5595.7481913313995, 5608.186812912105, 5612.803551875665, 5648.124540696199, 5648.915266271009, 6113.266408031065, 6113.908291375633, 6126.958417069109, 6127.234095738033, 6127.6782420562195, 5818.505427038749, 5860.765569377262, 5929.0513517836935, 5932.288125424977, 6002.0996850472775, 5995.370486098984, 5996.880062398727, 5999.820005399845, 6004.639721616717, 6007.729652165663, 5975.163477113208, 5976.402359764076, 5980.820575382745, 5984.192134061933, 5984.8803023940145, 5823.242978412779, 5830.47525722687, 5907.61600495975, 5930.169776231331, 5946.67293298864, 4569.474510431276, 4572.588467037916, 4589.10512450069, 4591.609713174351, 4609.884752881205, 3999.8000099994883, 4088.100617864065, 4088.4276201331836, 4090.8568200112854, 4111.218868414991, 5649.293838270216, 5661.065924122474, 5738.454846789548, 5744.626599271034, 5797.188393624896, 6037.0642550404755, 6039.54703397247, 6042.516598672096, 6046.909296360558, 6049.78825741097, 5499.807506737245, 5606.24315717373, 5682.886342273131, 5690.800821971211, 5704.3154821421695, 5128.8717782055, 5203.635745497854, 5210.036143313499, 5210.062188806051, 5248.501392367719, 6277.591956522811, 6355.3326900674765, 6355.618662880242, 6358.300586935434, 6359.96820015897, 5859.677717725566, 5892.292924849045, 6003.219581454383, 6080.422359875804, 6099.817005489843, 6244.5316601256, 6297.748090076346, 6307.117003619405, 6308.337624549356, 6312.43188113072, 5924.526037917042, 5939.287285525765, 5941.257342832146, 5941.643501389931, 5989.910151347821, 5818.4763371296785, 5881.794137205177, 5940.524758019435, 6009.669468179292, 6055.757769689163, 5815.680137592473, 5816.651000939957, 5820.30156381237, 5823.301203855564, 5827.766889324549, 5797.0, 5798.072308430631, 5799.246098007232, 5799.246098007232, 5802.361740208658, 5560.36055853582, 5692.459216374438, 5703.401142879938, 5800.303963524404, 5833.854153646193, 5876.676782776817, 5905.025670764276, 5908.497777688945, 5911.408859114054, 5968.403159683997, 5578.163275508544, 5779.768809247751, 5784.421557844182, 5785.30576330843, 5791.218185544897], "mootools.html": [1393.7421577008247, 1751.1506919144215, 1775.3786174838808, 1807.2951548895933, 1808.168242608401, 6954.547954382968, 7395.445341599381, 7490.176080631133, 7497.775066747992, 7499.625018749068, 7292.7447539336135, 7338.119425668927, 7359.558426494414, 7370.705171793122, 7389.187189409161, 1949.727038214651, 1988.6519859024686, 2212.977870221301, 2262.468319944816, 2286.017012684545, 2237.284069097889, 2242.843000989931, 2245.303955773707, 2245.5621153875, 2245.69683092782, 2192.4628466025847, 2244.1920908473016, 2247.381969958258, 2248.280550223929, 2254.77452254774, 1873.7002079667257, 1901.6767149584605, 2214.7895949884737, 2242.215224671368, 2246.034205291724, 2240.283109404991, 2250.2349201271645, 2276.2260831317267, 2279.4415368234722, 2287.3595393289906, 7588.506747061479, 7645.388368930472, 7649.885251721229, 7657.961710191469, 7663.386929045663, 4580.24425969718, 4658.4642766082, 4662.557057079572, 4666.020135771492, 4668.6731928765, 3060.158456424501, 3119.0954623159255, 3149.7952633079008, 3154.511050787132, 3163.794353367047, 997.3766396002499, 1003.6938733686222, 1014.6854475112665, 1018.8624535687735, 1035.7358873487212, 10235.181185505142, 10417.531211095518, 10418.0, 10426.895731042745, 10437.843432348445, 4004.2191772604065, 4056.3307054335705, 4102.220578090153, 4105.794710264475, 4111.1366613011005, 8641.697540586176, 8651.221390074923, 8652.567371631394, 8663.090375510481, 8670.91329086701, 4580.885477863014, 4595.149897269016, 4608.3778689876435, 4610.077984403133, 4615.16926953145, 4218.156368726267, 4234.809433575497, 4235.216484950294, 4239.173361194537, 4239.59723826236, 3322.767406281537, 3376.0884561168345, 3396.3377141457177, 3401.523786669868, 3405.267867408519, 992.9404235745734, 1005.9195264378832, 1009.7324209084452, 1011.7318910488726, 1017.2726500552141, 1282.4934151010298, 1287.658770425838, 1314.4676406055562, 1331.673739933703, 1352.1278775189946, 7114.964425177945, 7176.210616832144, 7194.856102877913, 7200.747973820891, 7223.458240631869, 471.7570451217626, 482.14178761804044, 482.1802935010496, 484.60988903932673, 485.45143987294836, 5682.034054210794, 5710.857228569319, 5724.484796368263, 5725.828225153252, 5727.742251598688, 9012.954935225282, 9212.309076819265, 9228.16946474807, 9239.0, 9318.48748318849, 9160.22138118254, 9223.0, 9248.075192480697, 9254.86117708235, 9260.259179265642, 7061.0, 7282.708691652275, 7317.817054573678, 7320.743773967885, 7321.194668586451, 7123.715051397886, 7148.0, 7197.748078817216, 7211.278872112747, 7215.783526494213, 7984.481008734414, 8009.519428834055, 8171.509709417454, 8237.258646721824, 8272.793180170544, 8380.622871970898, 8470.957645211734, 8484.787880303042, 8486.533240671823, 8505.87241191395, 6781.321867813376, 6943.79168624942, 6951.548149370275, 6967.512274140761, 6974.500482396309, 7479.439042071757, 7532.698692052476, 7533.0, 7583.127940286717, 7584.62076896164, 6273.1844860167885, 6864.347886950732, 6918.342757438036, 6944.131983502062, 7136.5004449690105, 6940.652967351713, 6986.371226589631, 7039.859202816017, 7068.29317068289, 7114.9288507116335, 7050.823729406806, 7089.716411343488, 7106.360427561544, 7133.5719856808755, 7140.964295178491, 6467.870642587216, 6516.934830651822, 6529.9347006531225, 6531.477481801539, 6538.771143009972, 6283.214598175228, 6411.5832470889245, 6414.262359828679, 6415.903761443488, 6507.316731743288], "ext.html": [561.8117930493285, 582.551435394746, 604.2416766957471, 604.4408921747382, 607.6141650052216, 39843.2031359373, 40530.59469405305, 40536.0, 40569.39145912806, 40615.0, 43412.34881476773, 43945.12109757811, 43963.99999999992, 44002.11995760083, 44031.339529906996, 7693.653785579662, 7769.650365733555, 8713.302935765156, 8857.689980850671, 9859.90140098597, 10099.14157296627, 10158.644447444341, 10227.795444091114, 10228.846567301496, 10238.385696858175, 10454.059134677878, 10557.102646275076, 10563.049325560698, 10567.418791966476, 10569.577216911315, 7848.293653571178, 8006.759797206093, 10162.441065741381, 10306.227032972558, 10433.739156521071, 9986.600535978552, 10056.34633748804, 10103.141232995204, 10113.544890479947, 10139.594416223343, 36874.44688329651, 37101.0, 37244.627553724386, 37278.627213727785, 37308.62691373079, 3323.7507186960834, 3387.593488781362, 3388.8644454221803, 3429.7770644908, 3778.149916268845, 30008.8499557503, 30027.549586756217, 30384.392312153854, 30466.695333046828, 31808.0, 3502.2645244498685, 3509.508668786372, 3539.0975301298004, 3567.108222944264, 3642.2351306225723, 273418.0, 273495.6325218381, 274295.0, 276071.0, 277224.0, 54428.0, 55748.72125639346, 55757.72121139449, 57151.714241428526, 57322.140167897516, 51740.0, 60955.0, 61337.0, 61612.38387616156, 61684.0, 14479.565613031626, 14618.122912625277, 14633.634159146106, 14652.12087274767, 14706.338214780146, 11006.064484518745, 11035.337879727242, 11070.5571777128, 11109.944450277859, 11125.109991200685, 18777.530561736065, 19025.334113306246, 19047.80952190488, 19094.71357929632, 19142.808571914382, 7719.11230208522, 8005.599720013976, 8052.959735201286, 8085.595720213966, 8103.594820258963, 949.7720547068653, 988.421773262635, 1022.1720406470782, 1070.6466865934224, 1081.605214096849, 27715.816630283705, 27821.582676259874, 27877.442451150862, 28059.438811223663, 28139.71860281412, 1022.6522982186092, 1031.7369070886875, 1034.632705389591, 1044.185535282481, 1154.8729639739622, 13210.537631182862, 13536.45854165842, 13557.728845423037, 14984.325705343286, 15135.621609459851, 329389.0, 333119.0, 333649.0, 333710.0, 333838.0, 52655.73672131615, 52694.73652631789, 52737.0, 52737.0, 52947.73526132345, 1240.9503619855286, 1241.025794751116, 1255.3346726234927, 1322.4247452358254, 1345.7173993461483, 26228.73771262263, 26859.194224173305, 27428.177154685392, 28032.0, 28232.153035408148, 48303.0, 48310.5168948306, 48326.75836620794, 48392.5160748388, 48510.5148948506, 286254.0, 286857.0, 298165.0, 301212.0, 302371.0, 28582.0, 28612.42775144527, 28692.13923582296, 28699.0, 28838.279043023253, 39211.0, 40087.79956100201, 40145.0, 40402.59597403988, 40863.1827363457, 36104.0, 37003.62996370002, 37033.0, 37242.25515489621, 37689.43465847959, 36889.0, 36942.0, 37443.62556374401, 37649.24701506009, 37675.246495070496, 35323.64676353204, 37013.62986370102, 37151.32819023096, 37235.813820931806, 37262.25475490421, 28407.573886392132, 29484.0, 29927.55108673328, 30890.227744305674, 31015.0, 23929.28212153638, 24499.608465133533, 24608.384790380383, 24858.378540536632, 25241.873790631664], "prototype.html": [298.935728818304, 301.2093255205087, 306.90639354996745, 308.50946994279093, 309.2469835949463, 5999.130126131714, 6071.605345652535, 6147.723352449139, 6155.0, 6177.691115444221, 6004.42957918997, 6058.636481811094, 6076.87846243076, 6086.969565152179, 6103.23709536308, 4294.033842385469, 4369.956300437003, 4494.662900282476, 4506.121306345264, 4509.639228861692, 4381.6494680425485, 4478.373027776098, 4486.685931984763, 4489.124620698965, 4492.326151077332, 4452.688311818174, 4453.755043472608, 4465.59809617136, 4468.50846406895, 4475.127350166719, 4232.9153416931795, 4342.457192850894, 4344.044310251739, 4470.351798989161, 4473.0, 3827.7320587558884, 3832.8466861325514, 3836.0985168485386, 3836.1368692044066, 3842.5581058178386, 5638.492535671769, 5649.180868774046, 5651.2370829937845, 5657.0, 5667.659940403548, 5142.640015198937, 5151.2530683050745, 5161.174212126042, 5168.870778230536, 5176.534111929906, 6190.473809726179, 6315.273743519462, 6326.49388048955, 6326.746930122789, 6328.810135695937, 4219.514755803091, 4227.0, 4238.940264933766, 4244.660427165819, 4246.63903568194, 6548.27968923418, 6631.640513694681, 6632.469402447792, 6636.402723754885, 6637.46900247979, 4222.809973551198, 4299.581138224441, 4310.870673879788, 4312.245357062501, 4312.849050283225, 4335.154644844225, 4365.432493775789, 4366.126774645084, 4369.934450983238, 4374.825006999685, 5117.616178786606, 5121.667091639031, 5132.255822905658, 5133.794648214104, 5150.690958542499, 6398.808035758934, 6406.551541392151, 6407.743690252338, 6409.871802563923, 6424.1327420798525, 1492.7910092587047, 1514.2050423527517, 1522.8781697464399, 1523.4591719939262, 1523.6800271942795, 979.1041197304529, 999.0409207161207, 1011.1304278320638, 1011.1556850030161, 1020.7703266764919, 6221.440070393596, 6238.812835614848, 6239.438450539473, 6263.812085637347, 6264.37356264379, 6620.768273110418, 6623.635700036544, 6624.105745724362, 6625.271220165778, 6632.701528431232, 6138.754449822047, 6250.9062364064575, 6255.56211065221, 6263.655498947511, 6268.122462855204, 3462.4979377990553, 3525.5593050868642, 3529.0647978285774, 3551.751377403609, 3604.945925811115, 6909.032735417046, 6927.5452155047, 6942.236354001056, 6942.687579058955, 6956.860862782716, 6810.897836532456, 6816.522843401013, 6822.556533825285, 6824.556403833735, 6829.863402731918, 6813.931860681429, 6933.791986240421, 6964.582125072512, 6973.0, 6973.302669732986, 6648.235452922782, 6651.102101216274, 6654.0, 6654.600723956578, 6663.36698013688, 6583.177102862142, 6585.736570537125, 6590.472762178918, 6592.373724496165, 6600.438962688226, 6799.456043516606, 6895.724171033103, 6935.757248496278, 6966.1988871280455, 6969.128858892638, 4337.284348082657, 4337.327714204177, 4341.413909122354, 4345.196138714348, 4346.891327716832, 6593.571417857824, 6605.075289459575, 6609.504287178384, 6618.867622647424, 6619.735210591522, 6283.0, 6457.741690332334, 6461.903071454026, 6468.902966455601, 6472.773452929313, 6441.098246245623, 6453.677316134268, 6454.290028097, 6468.094466774562, 6469.482441404771, 6298.842528936813, 6328.46208072319, 6331.778387756406, 6335.1447554579545, 6337.9366206337345, 6393.4885209184085, 6473.320301368477, 6476.6114033158165, 6481.449076828522, 6492.577982431127, 6321.431071203614, 6325.778597749057, 6329.113924050729, 6335.936640633535, 6337.176167098248], "yui.html": [746.0674157303371, 805.7542449552884, 808.1151139502244, 819.9344052475802, 861.298042095692, 13502.932485337571, 13820.512307784595, 13841.446342146328, 13845.584632461043, 13883.236421996786, 12985.220886746778, 13085.0, 13555.457781688721, 13558.186508809453, 13565.593032209024, 692.9064576282213, 696.0151385789102, 832.7085520067973, 844.1136806353335, 846.4878748357216, 837.6523742646795, 839.2866063845713, 840.6721378662327, 843.9282660973824, 845.733593917917, 875.9474431534128, 883.8939327280735, 884.305819931354, 884.5754038061734, 885.57049830832, 723.1394640377933, 727.2364017781308, 865.8051938313861, 868.8218915122385, 869.7608157756604, 637.08260105448, 642.2036674523604, 645.6965226343611, 646.0341789025437, 647.6955830759536, 13718.314084295745, 13856.099353542088, 13875.375608097558, 13881.583552493441, 13913.513027044106, 11923.224990375598, 12740.388220414792, 12808.743825123445, 12932.547360842325, 12996.41516131767, 10145.898541014643, 10366.792664146675, 10383.584656613726, 10401.427921464316, 10444.26890117692, 3237.482002879528, 3286.605607327112, 3312.2381852173894, 3325.783824051429, 3384.915377115567, 42056.0, 42217.57782422167, 42300.153996919886, 42358.15283694309, 42431.57568424338, 7504.849903001909, 7541.773746787496, 7570.962145189239, 7621.466497345244, 7643.961780191064, 11646.88353116458, 11988.700282492833, 11997.220180688402, 12015.038796896228, 12047.759044819055, 6603.933960660428, 6698.5980841149685, 6721.563098398588, 6827.249002609709, 6848.14398200225, 4259.5101563319995, 4286.742795432284, 4323.221820072417, 4427.867163985085, 4451.666125040635, 2659.428222932079, 2691.0312287576457, 2699.460107978412, 2700.3654141276784, 2701.18964310706, 441.6510956344516, 450.12226158990103, 450.1896586144926, 452.08678469491446, 455.0671124195386, 651.7914267434376, 652.7519542573791, 654.1300070905684, 656.3516212084218, 701.6316433872156, 8261.13258107902, 8352.331813454908, 8357.206065423776, 8359.164083591591, 8761.824763504694, 588.3146134752965, 631.6936285901335, 690.8031211104911, 697.9267176946449, 710.6233696141054, 4069.5501367978522, 4093.5497095319492, 4196.769177695256, 4355.0854320593035, 4382.890427739332, 49912.500874991514, 49936.500634993914, 50076.74961625241, 53277.73361133169, 56985.43014569884, 45309.546904530536, 45348.09303813971, 45623.77188114038, 46492.0, 46530.0, 44596.3310550342, 45002.09995800131, 45914.0, 46361.76819115883, 46478.53521464742, 8478.23695867375, 8750.256228220673, 8973.685920992733, 9036.909630903607, 9073.092690730875, 33489.49765753564, 34392.65607343894, 35394.1151471205, 35503.0, 35873.0, 43905.12189756123, 44372.334414983154, 44779.776101119285, 45309.320360195285, 45692.31461528146, 8461.661533538836, 8731.301495880442, 8889.866652000355, 9006.091680034528, 9290.489023103793, 12187.51249949992, 12198.573049943565, 12279.631611051684, 12464.5014199431, 12535.93732031334, 11421.428928553372, 11622.88377116218, 11657.183997120459, 11933.641990740292, 12042.578509752117, 11065.557377705123, 11283.548658053915, 11345.773084538097, 11729.120315976506, 11793.646190614296, 11253.80196012169, 11575.189736718348, 11630.069594432256, 11641.0, 11933.582324618597, 9833.0, 9998.20014398861, 10003.199744020607, 10232.539535720762, 10381.792364152825, 8515.233628973423, 9061.818763624822, 9395.389299695498, 9702.126808587262, 9913.45475998827]}, "summary": {"lowerIsBetter": false, "suite": 6690.702423370806, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7065.678648074723, "unit": "ms", "value": 7065.678648074723}, "dojo.html": {"lowerIsBetter": false, "filtered": 5508.338939972444, "unit": "ms", "value": 5508.338939972444}, "mootools.html": {"lowerIsBetter": false, "filtered": 4321.380087544793, "unit": "ms", "value": 4321.380087544793}, "ext.html": {"lowerIsBetter": false, "filtered": 18557.90376251656, "unit": "ms", "value": 18557.90376251656}, "prototype.html": {"lowerIsBetter": false, "filtered": 4748.330067050102, "unit": "ms", "value": 4748.330067050102}, "yui.html": {"lowerIsBetter": false, "filtered": 6052.370536823565, "unit": "ms", "value": 6052.370536823565}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-011"}, "testrun": {"date": 1447727587, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116163023", "branch": "Firefox", "revision": "ffe020f9145296f68d56866b01ffe1d35ac18b83"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 162.0, 160.0, 161.0, 159.0, 160.0, 160.0, 164.0, 161.0, 163.0], "ai-astar": [111.0, 112.0, 105.0, 110.0, 110.0, 110.0, 98.0, 109.0, 110.0, 111.0], "imaging-gaussian-blur": [109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0], "audio-beat-detection": [163.0, 124.0, 155.0, 168.0, 125.0, 151.0, 153.0, 124.0, 164.0, 132.0], "json-stringify-tinderbox": [68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 78.0, 68.0, 69.0, 68.0], "stanford-crypto-pbkdf2": [140.0, 155.0, 153.0, 148.0, 150.0, 140.0, 149.0, 149.0, 148.0, 139.0], "json-parse-financial": [58.0, 57.0, 58.0, 58.0, 56.0, 57.0, 58.0, 64.0, 55.0, 55.0], "stanford-crypto-sha256-iterative": [66.0, 67.0, 66.0, 65.0, 67.0, 66.0, 64.0, 65.0, 66.0, 68.0], "audio-fft": [74.0, 80.0, 81.0, 94.0, 73.0, 71.0, 72.0, 97.0, 90.0, 73.0], "imaging-darkroom": [146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0], "stanford-crypto-ccm": [123.0, 121.0, 123.0, 117.0, 128.0, 119.0, 120.0, 122.0, 124.0, 120.0], "audio-oscillator": [91.0, 90.0, 130.0, 91.0, 90.0, 90.0, 130.0, 92.0, 90.0, 137.0], "stanford-crypto-aes": [84.0, 83.0, 84.0, 86.0, 85.0, 95.0, 84.0, 83.0, 86.0, 94.0], "imaging-desaturate": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1497.3000000000002, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.5, "unit": "ms", "value": 80.5}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 147.1, "unit": "ms", "value": 147.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.9, "unit": "ms", "value": 145.9}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 121.7, "unit": "ms", "value": 121.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.4, "unit": "ms", "value": 145.4}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 57.6, "unit": "ms", "value": 57.6}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.1, "unit": "ms", "value": 103.1}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.6, "unit": "ms", "value": 108.6}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.1, "unit": "ms", "value": 161.1}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 66.0, "unit": "ms", "value": 66.0}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.4, "unit": "ms", "value": 69.4}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.2, "unit": "ms", "value": 109.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.4, "unit": "ms", "value": 86.4}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.3, "unit": "ms", "value": 95.3}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-011"}, "testrun": {"date": 1447727587, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116163023", "branch": "Firefox", "revision": "ffe020f9145296f68d56866b01ffe1d35ac18b83"}}, {"talos_counters": {}, "results": {"DeltaBlue": [194.5903872348706], "Encrypt": [286.20492272467084], "NavierStokes": [4817.307692307692], "Decrypt": [5050.50505050505], "Splay": [632.5110689437065], "Richards": [166.11295681063123], "RegExp": [25820.51282051282], "Earley": [811.0300081103001], "Boyer": [12195.121951219513], "RayTrace": [1966.6011787819255]}, "summary": {"lowerIsBetter": false, "suite": 19676.052104933315, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 339.780402, "unit": "score", "value": 339.780402}, "Encrypt": {"lowerIsBetter": false, "filtered": 930.036414, "unit": "score", "value": 930.036414}, "NavierStokes": {"lowerIsBetter": false, "filtered": 308.055888223553, "unit": "score", "value": 308.055888223553}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.70383799999996, "unit": "score", "value": 52.70383799999996}, "Splay": {"lowerIsBetter": false, "filtered": 128.83727100000002, "unit": "score", "value": 128.83727100000002}, "RegExp": {"lowerIsBetter": false, "filtered": 35.28144488579943, "unit": "score", "value": 35.28144488579943}, "Richards": {"lowerIsBetter": false, "filtered": 212.51804000000004, "unit": "score", "value": 212.51804000000004}, "Earley": {"lowerIsBetter": false, "filtered": 821.7488789999996, "unit": "score", "value": 821.7488789999996}, "Boyer": {"lowerIsBetter": false, "filtered": 54.64996600000001, "unit": "score", "value": 54.64996600000001}, "RayTrace": {"lowerIsBetter": false, "filtered": 376.2781228771229, "unit": "score", "value": 376.2781228771229}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-011"}, "testrun": {"date": 1447727587, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116163023", "branch": "Firefox", "revision": "ffe020f9145296f68d56866b01ffe1d35ac18b83"}}] 18:53:23 INFO - RETURN: dromaeo_css: 6690.70 18:53:23 INFO - RETURN: kraken: 1497.30 18:53:23 INFO - RETURN: v8_7: 19676.05 18:53:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19676.05"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1497.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6690.70"}}} 18:53:23 INFO - Return code: 0 18:53:23 INFO - # TBPL SUCCESS # 18:53:23 INFO - Running post-action listener: _resource_record_post_action 18:53:23 INFO - Running post-run listener: _resource_record_post_run 18:53:24 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 4096; Write bytes: 523010048; Read time: 268; Write time: 760780 18:53:24 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 66232320; Read time: 0; Write time: 29376 18:53:24 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 4096; Write bytes: 384692224; Read time: 268; Write time: 616196 18:53:24 INFO - Running post-run listener: _upload_blobber_files 18:53:24 INFO - Blob upload gear active. 18:53:24 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:53:24 INFO - Copying logs to upload dir... 18:53:24 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1257.435061 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-16 18:53:24.323657) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 18:53:24.327308) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009947 build_url: 'https://queue.taskcluster.net/v1/task/Uvjmd_YSQsKsCMIQ7WpC-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 18:53:24.379284) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:53:24.379622) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447727544.647650-1496154234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004653 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:53:24.428811) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 18:53:24.429152) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 18:53:24.429488) ========= ========= Total master_lag: 0.22 =========