builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1447162175.38 results: success (0) buildid: 20151110043005 builduid: 8d9067d0bd08431a805c9ee0ee01f362 revision: 7ae90a04b0fd9ed59c96fb60f1b8da0ddb0cbf93 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:35.380025) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:35.380407) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:35.380697) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.003636 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:35.416522) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:35.416840) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:35.469421) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:35.469678) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004657 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:35.518305) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:35.518568) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:35.518921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:35.519197) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-10 05:29:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 77.9M=0s 2015-11-10 05:29:35 (77.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114428 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:35.645843) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:35.646151) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020596 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:35.700499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:35.700810) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7ae90a04b0fd9ed59c96fb60f1b8da0ddb0cbf93 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7ae90a04b0fd9ed59c96fb60f1b8da0ddb0cbf93 --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=e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-10 05:29:36,022 truncating revision to first 12 chars 2015-11-10 05:29:36,022 Setting DEBUG logging. 2015-11-10 05:29:36,022 attempt 1/10 2015-11-10 05:29:36,023 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7ae90a04b0fd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-10 05:29:36,253 unpacking tar archive at: mozilla-inbound-7ae90a04b0fd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.513667 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:36.229652) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:36.229959) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:36.245582) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:36.245831) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-10 05:29:36.246440) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-11-10 05:29:36.246724) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:29:36 INFO - MultiFileLogger online at 20151110 05:29:36 in /builds/slave/test-pgo 05:29:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 05:29:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:29:36 INFO - {'append_to_log': False, 05:29:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:29:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 05:29:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:29:36 INFO - 'branch': 'Mozilla-Inbound', 05:29:36 INFO - 'buildbot_json_path': 'buildprops.json', 05:29:36 INFO - 'config_files': ('talos/linux_config.py',), 05:29:36 INFO - 'default_actions': ('clobber', 05:29:36 INFO - 'read-buildbot-config', 05:29:36 INFO - 'download-and-extract', 05:29:36 INFO - 'populate-webroot', 05:29:36 INFO - 'create-virtualenv', 05:29:36 INFO - 'install', 05:29:36 INFO - 'run-tests'), 05:29:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:29:36 INFO - 'download_minidump_stackwalk': True, 05:29:36 INFO - 'download_symbols': 'ondemand', 05:29:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:29:36 INFO - 'tooltool.py': '/tools/tooltool.py', 05:29:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:29:36 INFO - '/tools/misc-python/virtualenv.py')}, 05:29:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:29:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:29:36 INFO - 'installer_path': 'installer.exe', 05:29:36 INFO - 'log_level': 'info', 05:29:36 INFO - 'log_name': 'talos', 05:29:36 INFO - 'log_to_console': True, 05:29:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:29:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:29:36 INFO - 'opt_config_files': (), 05:29:36 INFO - 'pip_index': False, 05:29:36 INFO - 'sps_profile': False, 05:29:36 INFO - 'sps_profile_interval': 0, 05:29:36 INFO - 'suite': 'dromaeojs', 05:29:36 INFO - 'system_bits': '64', 05:29:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:29:36 INFO - 'title': 'talos-linux64-ix-038', 05:29:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:29:36 INFO - 'use_talos_json': True, 05:29:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:29:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:29:36 INFO - 'work_dir': 'build'} 05:29:36 INFO - ##### 05:29:36 INFO - ##### Running clobber step. 05:29:36 INFO - ##### 05:29:36 INFO - Running pre-action listener: _resource_record_pre_action 05:29:36 INFO - Running main action method: clobber 05:29:36 INFO - rmtree: /builds/slave/test-pgo/build 05:29:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:29:37 INFO - Running post-action listener: _resource_record_post_action 05:29:37 INFO - ##### 05:29:37 INFO - ##### Running read-buildbot-config step. 05:29:37 INFO - ##### 05:29:37 INFO - Running pre-action listener: _resource_record_pre_action 05:29:37 INFO - Running main action method: read_buildbot_config 05:29:37 INFO - Using buildbot properties: 05:29:37 INFO - { 05:29:37 INFO - "properties": { 05:29:37 INFO - "buildnumber": 1229, 05:29:37 INFO - "product": "firefox", 05:29:37 INFO - "script_repo_revision": "production", 05:29:37 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 05:29:37 INFO - "repository": "", 05:29:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 05:29:37 INFO - "buildid": "20151110043005", 05:29:37 INFO - "slavename": "talos-linux64-ix-038", 05:29:37 INFO - "pgo_build": "True", 05:29:37 INFO - "basedir": "/builds/slave/test-pgo", 05:29:37 INFO - "project": "", 05:29:37 INFO - "platform": "ubuntu64_hw", 05:29:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:29:37 INFO - "slavebuilddir": "test", 05:29:37 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 05:29:37 INFO - "branch": "mozilla-inbound", 05:29:37 INFO - "repo_path": "integration/mozilla-inbound", 05:29:37 INFO - "stage_platform": "linux64-pgo", 05:29:37 INFO - "builduid": "8d9067d0bd08431a805c9ee0ee01f362", 05:29:37 INFO - "revision": "7ae90a04b0fd9ed59c96fb60f1b8da0ddb0cbf93" 05:29:37 INFO - }, 05:29:37 INFO - "sourcestamp": { 05:29:37 INFO - "repository": "", 05:29:37 INFO - "hasPatch": false, 05:29:37 INFO - "project": "", 05:29:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 05:29:37 INFO - "changes": [ 05:29:37 INFO - { 05:29:37 INFO - "category": null, 05:29:37 INFO - "files": [ 05:29:37 INFO - { 05:29:37 INFO - "url": null, 05:29:37 INFO - "name": "https://queue.taskcluster.net/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:29:37 INFO - } 05:29:37 INFO - ], 05:29:37 INFO - "repository": "", 05:29:37 INFO - "rev": "7ae90a04b0fd9ed59c96fb60f1b8da0ddb0cbf93", 05:29:37 INFO - "who": "sendchange", 05:29:37 INFO - "when": 1447162122, 05:29:37 INFO - "number": 6642611, 05:29:37 INFO - "comments": "", 05:29:37 INFO - "project": "", 05:29:37 INFO - "at": "Tue 10 Nov 2015 05:28:42", 05:29:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 05:29:37 INFO - "revlink": "", 05:29:37 INFO - "properties": [ 05:29:37 INFO - [ 05:29:37 INFO - "buildid", 05:29:37 INFO - "20151110043005", 05:29:37 INFO - "Change" 05:29:37 INFO - ], 05:29:37 INFO - [ 05:29:37 INFO - "builduid", 05:29:37 INFO - "8d9067d0bd08431a805c9ee0ee01f362", 05:29:37 INFO - "Change" 05:29:37 INFO - ], 05:29:37 INFO - [ 05:29:37 INFO - "pgo_build", 05:29:37 INFO - "True", 05:29:37 INFO - "Change" 05:29:37 INFO - ] 05:29:37 INFO - ], 05:29:37 INFO - "revision": "7ae90a04b0fd9ed59c96fb60f1b8da0ddb0cbf93" 05:29:37 INFO - } 05:29:37 INFO - ], 05:29:37 INFO - "revision": "7ae90a04b0fd9ed59c96fb60f1b8da0ddb0cbf93" 05:29:37 INFO - } 05:29:37 INFO - } 05:29:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:29:37 INFO - Running post-action listener: _resource_record_post_action 05:29:37 INFO - ##### 05:29:37 INFO - ##### Running download-and-extract step. 05:29:37 INFO - ##### 05:29:37 INFO - Running pre-action listener: _resource_record_pre_action 05:29:37 INFO - Running main action method: download_and_extract 05:29:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:29: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')]} 05:29:37 INFO - https://queue.taskcluster.net/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:29:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/test_packages.json 05:29:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/test_packages.json 05:29:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:29:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:29:45 INFO - Downloaded 1302 bytes. 05:29:45 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:29:45 INFO - Using the following test package requirements: 05:29:45 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:29:45 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:29:45 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:45 INFO - u'jsshell-linux-x86_64.zip'], 05:29:45 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:29:45 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:29:45 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:29:45 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:29:45 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:29:45 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:29:45 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:29:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:29: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')]} 05:29:45 INFO - https://queue.taskcluster.net/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:29:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:29:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:29:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/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 05:29:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/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 05:29:56 INFO - Downloaded 22427665 bytes. 05:29:56 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 05:29:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:29:56 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 05:29:57 INFO - Return code: 0 05:29:57 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 05:29:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:57 INFO - https://queue.taskcluster.net/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:29:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:29:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:29:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/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 05:29:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/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 05:30:01 INFO - Downloaded 22427665 bytes. 05:30:01 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 05:30:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:30:01 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 05:30:02 INFO - Return code: 0 05:30:02 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')]} 05:30:02 INFO - https://queue.taskcluster.net/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:30:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:30:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:30:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/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 05:30:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/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 05:30:03 INFO - Downloaded 11131618 bytes. 05:30:03 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 05:30:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:30:03 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 05:30:03 INFO - Return code: 0 05:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:03 INFO - https://queue.taskcluster.net/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:30:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:30:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:30:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/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 05:30:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B53YxGDiRZi5aQNgH862LQ/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 05:30:05 INFO - Downloaded 57139698 bytes. 05:30:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:30:05 INFO - mkdir: /builds/slave/test-pgo/properties 05:30:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:30:05 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:30:05 INFO - Contents: 05:30:05 INFO - build_url:https://queue.taskcluster.net/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:30:05 INFO - Running post-action listener: _resource_record_post_action 05:30:05 INFO - Running post-action listener: set_extra_try_arguments 05:30:05 INFO - ##### 05:30:05 INFO - ##### Running populate-webroot step. 05:30:05 INFO - ##### 05:30:05 INFO - Running pre-action listener: _resource_record_pre_action 05:30:05 INFO - Running main action method: populate_webroot 05:30:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:30:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:30:05 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:30:05 INFO - '../fennec_ids.txt'], 05:30:05 INFO - 'tests': ['tcheck2']}, 05:30:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:30:05 INFO - '--tppagecycles', 05:30:05 INFO - '7'], 05:30:05 INFO - 'tests': ['tsvgm']}}, 05:30:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:30:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:30:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:30:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:30:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:30:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:30:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:05 INFO - 'talos_options': ['--e10s'], 05:30:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:05 INFO - 'tests': ['damp', 'tps']}, 05:30:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:05 INFO - 'talos_options': ['--e10s'], 05:30:05 INFO - 'tests': ['damp', 'tps']}, 05:30:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:30:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:30:05 INFO - 'other': {'tests': ['a11yr', 05:30:05 INFO - 'ts_paint', 05:30:05 INFO - 'tpaint', 05:30:05 INFO - 'sessionrestore', 05:30:05 INFO - 'sessionrestore_no_auto_restore']}, 05:30:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:30:05 INFO - 'tests': ['a11yr', 05:30:05 INFO - 'ts_paint', 05:30:05 INFO - 'tpaint', 05:30:05 INFO - 'sessionrestore', 05:30:05 INFO - 'sessionrestore_no_auto_restore']}, 05:30:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:30:05 INFO - 'tests': ['a11yr', 05:30:05 INFO - 'ts_paint', 05:30:05 INFO - 'tpaint', 05:30:05 INFO - 'sessionrestore', 05:30:05 INFO - 'sessionrestore_no_auto_restore']}, 05:30:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:30:05 INFO - 'tests': ['a11yr', 05:30:05 INFO - 'ts_paint', 05:30:05 INFO - 'tpaint', 05:30:05 INFO - 'sessionrestore', 05:30:05 INFO - 'sessionrestore_no_auto_restore']}, 05:30:05 INFO - 'other_l64': {'tests': ['a11yr', 05:30:05 INFO - 'ts_paint', 05:30:05 INFO - 'tpaint', 05:30:05 INFO - 'sessionrestore', 05:30:05 INFO - 'sessionrestore_no_auto_restore']}, 05:30:05 INFO - 'other_nol64': {'tests': ['a11yr', 05:30:05 INFO - 'ts_paint', 05:30:05 INFO - 'tpaint', 05:30:05 INFO - 'sessionrestore', 05:30:05 INFO - 'sessionrestore_no_auto_restore']}, 05:30:05 INFO - 'svgr': {'tests': ['tsvgx', 05:30:05 INFO - 'tsvgr_opacity', 05:30:05 INFO - 'tart', 05:30:05 INFO - 'tscrollx', 05:30:05 INFO - 'cart']}, 05:30:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:30:05 INFO - 'tests': ['tsvgx', 05:30:05 INFO - 'tsvgr_opacity', 05:30:05 INFO - 'tart', 05:30:05 INFO - 'tscrollx', 05:30:05 INFO - 'cart']}, 05:30:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:05 INFO - 'tests': ['tp5o']}, 05:30:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:05 INFO - 'talos_options': ['--e10s'], 05:30:05 INFO - 'tests': ['tp5o']}, 05:30:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:05 INFO - 'talos_options': ['--xperf_path', 05:30:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:05 INFO - 'tests': ['tp5n']}, 05:30:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:05 INFO - 'talos_options': ['--e10s', 05:30:05 INFO - '--xperf_path', 05:30:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:05 INFO - 'tests': ['tp5n']}}, 05:30:05 INFO - 'talos.zip': {'path': '', 05:30:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:30:05 INFO - Running post-action listener: _resource_record_post_action 05:30:05 INFO - ##### 05:30:05 INFO - ##### Running create-virtualenv step. 05:30:05 INFO - ##### 05:30:05 INFO - Running pre-action listener: _resource_record_pre_action 05:30:05 INFO - Running main action method: create_virtualenv 05:30:05 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:30:05 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 05:30:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:30:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:30:05 INFO - Using real prefix '/usr' 05:30:05 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:30:05 INFO - Installing distribute.............................................................................................................................................................................................done. 05:30:07 INFO - Installing pip.................done. 05:30:07 INFO - Return code: 0 05:30:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:30: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')]} 05:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:07 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 0x7fedd1befc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe883d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf118c0>, '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 0xebe420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebe8b0>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537', '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 05:30:07 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 05:30:07 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 05:30:07 INFO - Using env: {'DISPLAY': ':0', 05:30:07 INFO - 'HOME': '/home/cltbld', 05:30:07 INFO - 'LANG': 'en_US.UTF-8', 05:30:07 INFO - 'LANGUAGE': 'en_US:en', 05:30:07 INFO - 'LOGNAME': 'cltbld', 05:30:07 INFO - 'MAIL': '/var/mail/cltbld', 05:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:07 INFO - 'MOZ_NO_REMOTE': '1', 05:30:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:07 INFO - 'NO_EM_RESTART': '1', 05:30:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:07 INFO - 'SHELL': '/bin/bash', 05:30:07 INFO - 'SHLVL': '1', 05:30:07 INFO - 'TERM': 'linux', 05:30:07 INFO - 'TMOUT': '86400', 05:30:07 INFO - 'USER': 'cltbld', 05:30:07 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537', 05:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:07 INFO - '_': '/tools/buildbot/bin/python'} 05:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:08 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 05:30:08 INFO - Cleaning up... 05:30:08 INFO - Return code: 0 05:30:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fedd1befc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe883d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf118c0>, '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 0xebe420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebe8b0>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537', '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 05:30:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:30:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:30:08 INFO - Using env: {'DISPLAY': ':0', 05:30:08 INFO - 'HOME': '/home/cltbld', 05:30:08 INFO - 'LANG': 'en_US.UTF-8', 05:30:08 INFO - 'LANGUAGE': 'en_US:en', 05:30:08 INFO - 'LOGNAME': 'cltbld', 05:30:08 INFO - 'MAIL': '/var/mail/cltbld', 05:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:08 INFO - 'MOZ_NO_REMOTE': '1', 05:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:08 INFO - 'NO_EM_RESTART': '1', 05:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:08 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:08 INFO - 'SHELL': '/bin/bash', 05:30:08 INFO - 'SHLVL': '1', 05:30:08 INFO - 'TERM': 'linux', 05:30:08 INFO - 'TMOUT': '86400', 05:30:08 INFO - 'USER': 'cltbld', 05:30:08 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537', 05:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:08 INFO - '_': '/tools/buildbot/bin/python'} 05:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:08 INFO - Downloading/unpacking psutil>=0.7.1 05:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:09 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:30:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:30:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:30:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:10 INFO - Installing collected packages: psutil 05:30:10 INFO - Running setup.py install for psutil 05:30:10 INFO - building 'psutil._psutil_linux' extension 05:30:10 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 05:30:10 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 05:30:10 INFO - building 'psutil._psutil_posix' extension 05:30:10 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 05:30:10 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 05:30:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:10 INFO - Successfully installed psutil 05:30:10 INFO - Cleaning up... 05:30:10 INFO - Return code: 0 05:30:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fedd1befc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe883d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf118c0>, '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 0xebe420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebe8b0>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537', '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 05:30:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:30:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:30:10 INFO - Using env: {'DISPLAY': ':0', 05:30:10 INFO - 'HOME': '/home/cltbld', 05:30:10 INFO - 'LANG': 'en_US.UTF-8', 05:30:10 INFO - 'LANGUAGE': 'en_US:en', 05:30:10 INFO - 'LOGNAME': 'cltbld', 05:30:10 INFO - 'MAIL': '/var/mail/cltbld', 05:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:10 INFO - 'MOZ_NO_REMOTE': '1', 05:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:10 INFO - 'NO_EM_RESTART': '1', 05:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:10 INFO - 'SHELL': '/bin/bash', 05:30:10 INFO - 'SHLVL': '1', 05:30:10 INFO - 'TERM': 'linux', 05:30:10 INFO - 'TMOUT': '86400', 05:30:10 INFO - 'USER': 'cltbld', 05:30:10 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537', 05:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:10 INFO - '_': '/tools/buildbot/bin/python'} 05:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:30:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:30:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:30:12 INFO - Installing collected packages: mozsystemmonitor 05:30:12 INFO - Running setup.py install for mozsystemmonitor 05:30:12 INFO - Successfully installed mozsystemmonitor 05:30:12 INFO - Cleaning up... 05:30:12 INFO - Return code: 0 05:30:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:30:12 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')]} 05:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:12 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')]} 05:30:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:12 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 0x7fedd1befc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe883d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf118c0>, '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 0xebe420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebe8b0>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537', '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 05:30:12 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 05:30:12 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 05:30:12 INFO - Using env: {'DISPLAY': ':0', 05:30:12 INFO - 'HOME': '/home/cltbld', 05:30:12 INFO - 'LANG': 'en_US.UTF-8', 05:30:12 INFO - 'LANGUAGE': 'en_US:en', 05:30:12 INFO - 'LOGNAME': 'cltbld', 05:30:12 INFO - 'MAIL': '/var/mail/cltbld', 05:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:12 INFO - 'MOZ_NO_REMOTE': '1', 05:30:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:12 INFO - 'NO_EM_RESTART': '1', 05:30:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:12 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:12 INFO - 'SHELL': '/bin/bash', 05:30:12 INFO - 'SHLVL': '1', 05:30:12 INFO - 'TERM': 'linux', 05:30:12 INFO - 'TMOUT': '86400', 05:30:12 INFO - 'USER': 'cltbld', 05:30:12 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537', 05:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:12 INFO - '_': '/tools/buildbot/bin/python'} 05:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:12 INFO - Downloading/unpacking blobuploader==1.2.4 05:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:14 INFO - Downloading blobuploader-1.2.4.tar.gz 05:30:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:30:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:30:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:30:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:30:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:15 INFO - Downloading docopt-0.6.1.tar.gz 05:30:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:30:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:30:15 INFO - Installing collected packages: blobuploader, requests, docopt 05:30:15 INFO - Running setup.py install for blobuploader 05:30:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:30:15 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:30:15 INFO - Running setup.py install for requests 05:30:15 INFO - Running setup.py install for docopt 05:30:15 INFO - Successfully installed blobuploader requests docopt 05:30:15 INFO - Cleaning up... 05:30:15 INFO - Return code: 0 05:30:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:15 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 0x7fedd1befc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe883d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf118c0>, '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 0xebe420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebe8b0>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537', '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 05:30:15 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 05:30:15 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 05:30:15 INFO - Using env: {'DISPLAY': ':0', 05:30:15 INFO - 'HOME': '/home/cltbld', 05:30:15 INFO - 'LANG': 'en_US.UTF-8', 05:30:15 INFO - 'LANGUAGE': 'en_US:en', 05:30:15 INFO - 'LOGNAME': 'cltbld', 05:30:15 INFO - 'MAIL': '/var/mail/cltbld', 05:30:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:15 INFO - 'MOZ_NO_REMOTE': '1', 05:30:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:15 INFO - 'NO_EM_RESTART': '1', 05:30:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:15 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:15 INFO - 'SHELL': '/bin/bash', 05:30:15 INFO - 'SHLVL': '1', 05:30:15 INFO - 'TERM': 'linux', 05:30:15 INFO - 'TMOUT': '86400', 05:30:15 INFO - 'USER': 'cltbld', 05:30:15 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537', 05:30:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:15 INFO - '_': '/tools/buildbot/bin/python'} 05:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:30:16 INFO - Running setup.py (path:/tmp/pip-IcTEop-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:30:16 INFO - Running setup.py (path:/tmp/pip-o2hx1v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:30:16 INFO - Running setup.py (path:/tmp/pip-JVVzN6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:30:16 INFO - Running setup.py (path:/tmp/pip-my5oUY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:30:16 INFO - Running setup.py (path:/tmp/pip-4nx42h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:30:16 INFO - Running setup.py (path:/tmp/pip-bizLAY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:30:16 INFO - Running setup.py (path:/tmp/pip-zPIJsj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:30:16 INFO - Running setup.py (path:/tmp/pip-XKlmG_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:30:16 INFO - Running setup.py (path:/tmp/pip-Oq5bLz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:30:16 INFO - Running setup.py (path:/tmp/pip-DYgrx3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:30:16 INFO - Running setup.py (path:/tmp/pip-iZc5Ox-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:30:16 INFO - Running setup.py (path:/tmp/pip-2fY9Cq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:30:16 INFO - Running setup.py (path:/tmp/pip-k9Kzeu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:30:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:30:17 INFO - Running setup.py (path:/tmp/pip-QQg5lu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:30:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:30:17 INFO - Running setup.py (path:/tmp/pip-HKTFN2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:30:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:30:17 INFO - Running setup.py (path:/tmp/pip-fJN8bU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:30:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:30:17 INFO - Running setup.py (path:/tmp/pip-7yM89_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:30:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:30:17 INFO - Running setup.py install for manifestparser 05:30:17 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:30:17 INFO - Running setup.py install for mozcrash 05:30:17 INFO - Running setup.py install for mozdebug 05:30:17 INFO - Running setup.py install for mozdevice 05:30:17 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:30:17 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:30:17 INFO - Running setup.py install for mozfile 05:30:17 INFO - Running setup.py install for mozhttpd 05:30:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:30:17 INFO - Running setup.py install for mozinfo 05:30:18 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:30:18 INFO - Running setup.py install for mozInstall 05:30:18 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:30:18 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:30:18 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:30:18 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:30:18 INFO - Running setup.py install for mozleak 05:30:18 INFO - Running setup.py install for mozlog 05:30:18 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:30:18 INFO - Running setup.py install for moznetwork 05:30:18 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:30:18 INFO - Running setup.py install for mozprocess 05:30:18 INFO - Running setup.py install for mozprofile 05:30:18 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:30:18 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:30:18 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:30:18 INFO - Running setup.py install for mozrunner 05:30:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:30:18 INFO - Running setup.py install for mozscreenshot 05:30:18 INFO - Running setup.py install for moztest 05:30:18 INFO - Running setup.py install for mozversion 05:30:19 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:30:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:30:19 INFO - Cleaning up... 05:30:19 INFO - Return code: 0 05:30:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:19 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 0x7fedd1befc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe883d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf118c0>, '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 0xebe420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebe8b0>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537', '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 05:30:19 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 05:30:19 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 05:30:19 INFO - Using env: {'DISPLAY': ':0', 05:30:19 INFO - 'HOME': '/home/cltbld', 05:30:19 INFO - 'LANG': 'en_US.UTF-8', 05:30:19 INFO - 'LANGUAGE': 'en_US:en', 05:30:19 INFO - 'LOGNAME': 'cltbld', 05:30:19 INFO - 'MAIL': '/var/mail/cltbld', 05:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:19 INFO - 'MOZ_NO_REMOTE': '1', 05:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:19 INFO - 'NO_EM_RESTART': '1', 05:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:19 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:19 INFO - 'SHELL': '/bin/bash', 05:30:19 INFO - 'SHLVL': '1', 05:30:19 INFO - 'TERM': 'linux', 05:30:19 INFO - 'TMOUT': '86400', 05:30:19 INFO - 'USER': 'cltbld', 05:30:19 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537', 05:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:19 INFO - '_': '/tools/buildbot/bin/python'} 05:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:30:19 INFO - Running setup.py (path:/tmp/pip-mXjneS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:30:19 INFO - Running setup.py (path:/tmp/pip-svUsCC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:30:19 INFO - Running setup.py (path:/tmp/pip-r2gLFe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:30:19 INFO - Running setup.py (path:/tmp/pip-4mndP2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:30:19 INFO - Running setup.py (path:/tmp/pip-ruQkBR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:30:19 INFO - Running setup.py (path:/tmp/pip-nyQgta-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:30:19 INFO - Running setup.py (path:/tmp/pip-wXzZEC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:30:19 INFO - Running setup.py (path:/tmp/pip-EpoEjL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:30:19 INFO - Running setup.py (path:/tmp/pip-ExBfzs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:30:19 INFO - Running setup.py (path:/tmp/pip-IJSO_d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:30:20 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)) 05:30:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:30:20 INFO - Running setup.py (path:/tmp/pip-vBflka-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:30:20 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)) 05:30:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:30:20 INFO - Running setup.py (path:/tmp/pip-5gJ8nj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:30:20 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)) 05:30:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:30:20 INFO - Running setup.py (path:/tmp/pip-4F7Kwp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:30:20 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)) 05:30:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:30:20 INFO - Running setup.py (path:/tmp/pip-q2krIt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:30:20 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)) 05:30:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:30:20 INFO - Running setup.py (path:/tmp/pip-4ofF6Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:30:20 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)) 05:30:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:30:20 INFO - Running setup.py (path:/tmp/pip-qjOqpy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:30:20 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)) 05:30:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:30:20 INFO - Running setup.py (path:/tmp/pip-bdwoPd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:30:20 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)) 05:30:20 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)) 05:30:20 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)) 05:30:20 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)) 05:30:20 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)) 05:30:20 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)) 05:30:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:30:20 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 05:30:20 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 05:30:20 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 05:30:20 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 05:30:20 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 05:30:20 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 05:30:22 INFO - Downloading blessings-1.5.1.tar.gz 05:30:22 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 05:30:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:30:22 INFO - Installing collected packages: blessings 05:30:22 INFO - Running setup.py install for blessings 05:30:22 INFO - Successfully installed blessings 05:30:22 INFO - Cleaning up... 05:30:22 INFO - Return code: 0 05:30:22 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:30:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:30:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:30:22 INFO - Reading from file tmpfile_stdout 05:30:22 INFO - Current package versions: 05:30:22 INFO - argparse == 1.2.1 05:30:22 INFO - blessings == 1.5.1 05:30:22 INFO - blobuploader == 1.2.4 05:30:22 INFO - docopt == 0.6.1 05:30:22 INFO - manifestparser == 1.1 05:30:22 INFO - mozInstall == 1.12 05:30:22 INFO - mozcrash == 0.16 05:30:22 INFO - mozdebug == 0.1 05:30:22 INFO - mozdevice == 0.47 05:30:22 INFO - mozfile == 1.2 05:30:22 INFO - mozhttpd == 0.7 05:30:22 INFO - mozinfo == 0.9 05:30:22 INFO - mozleak == 0.1 05:30:22 INFO - mozlog == 3.0 05:30:22 INFO - moznetwork == 0.27 05:30:22 INFO - mozprocess == 0.22 05:30:22 INFO - mozprofile == 0.27 05:30:22 INFO - mozrunner == 6.11 05:30:22 INFO - mozscreenshot == 0.1 05:30:22 INFO - mozsystemmonitor == 0.0 05:30:22 INFO - moztest == 0.7 05:30:22 INFO - mozversion == 1.4 05:30:22 INFO - psutil == 3.1.1 05:30:22 INFO - requests == 1.2.3 05:30:22 INFO - wsgiref == 0.1.2 05:30:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:22 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 0x7fedd1befc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe883d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf118c0>, '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 0xebe420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebe8b0>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537', '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 05:30:22 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 05:30:22 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 05:30:22 INFO - Using env: {'DISPLAY': ':0', 05:30:22 INFO - 'HOME': '/home/cltbld', 05:30:22 INFO - 'LANG': 'en_US.UTF-8', 05:30:22 INFO - 'LANGUAGE': 'en_US:en', 05:30:22 INFO - 'LOGNAME': 'cltbld', 05:30:22 INFO - 'MAIL': '/var/mail/cltbld', 05:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:22 INFO - 'MOZ_NO_REMOTE': '1', 05:30:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:22 INFO - 'NO_EM_RESTART': '1', 05:30:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:22 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:22 INFO - 'SHELL': '/bin/bash', 05:30:22 INFO - 'SHLVL': '1', 05:30:22 INFO - 'TERM': 'linux', 05:30:22 INFO - 'TMOUT': '86400', 05:30:22 INFO - 'USER': 'cltbld', 05:30:22 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537', 05:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:22 INFO - '_': '/tools/buildbot/bin/python'} 05:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:23 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)) 05:30:23 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)) 05:30:23 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)) 05:30:23 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)) 05:30:23 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)) 05:30:23 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)) 05:30:23 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)) 05:30:23 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)) 05:30:23 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)) 05:30:23 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)) 05:30:23 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)) 05:30:23 INFO - Cleaning up... 05:30:23 INFO - Return code: 0 05:30:23 INFO - Running post-action listener: _resource_record_post_action 05:30:23 INFO - Running post-action listener: _start_resource_monitoring 05:30:23 INFO - Starting resource monitoring. 05:30:23 INFO - ##### 05:30:23 INFO - ##### Running install step. 05:30:23 INFO - ##### 05:30:23 INFO - Running pre-action listener: _resource_record_pre_action 05:30:23 INFO - Running main action method: install 05:30:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:30:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:30:23 INFO - Reading from file tmpfile_stdout 05:30:23 INFO - Detecting whether we're running mozinstall >=1.0... 05:30:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:30:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:30:23 INFO - Reading from file tmpfile_stdout 05:30:23 INFO - Output received: 05:30:23 INFO - Usage: mozinstall [options] installer 05:30:23 INFO - Options: 05:30:23 INFO - -h, --help show this help message and exit 05:30:23 INFO - -d DEST, --destination=DEST 05:30:23 INFO - Directory to install application into. [default: 05:30:23 INFO - "/builds/slave/test-pgo"] 05:30:23 INFO - --app=APP Application being installed. [default: firefox] 05:30:23 INFO - mkdir: /builds/slave/test-pgo/build/application 05:30:23 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'] 05:30:23 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 05:30:37 INFO - Reading from file tmpfile_stdout 05:30:37 INFO - Output received: 05:30:37 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:30:37 INFO - Running post-action listener: _resource_record_post_action 05:30:37 INFO - ##### 05:30:37 INFO - ##### Running run-tests step. 05:30:37 INFO - ##### 05:30:37 INFO - Running pre-action listener: _resource_record_pre_action 05:30:37 INFO - Running main action method: run_tests 05:30:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:30:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:30:37 INFO - Python 2.7.3 05:30:37 INFO - Return code: 0 05:30:37 INFO - grabbing minidump binary from tooltool 05:30: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')]} 05:30:37 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 0xf118c0>, '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 0xebe420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebe8b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:30:37 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 05:30:37 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 05:30:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:30:37 INFO - Return code: 0 05:30:37 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:30:37 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:30:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:30:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:30:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:30:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:30:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost 05:30:37 INFO - Using env: {'DISPLAY': ':0', 05:30:37 INFO - 'HOME': '/home/cltbld', 05:30:37 INFO - 'LANG': 'en_US.UTF-8', 05:30:37 INFO - 'LANGUAGE': 'en_US:en', 05:30:37 INFO - 'LOGNAME': 'cltbld', 05:30:37 INFO - 'MAIL': '/var/mail/cltbld', 05:30:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:30:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:37 INFO - 'MOZ_NO_REMOTE': '1', 05:30:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:37 INFO - 'NO_EM_RESTART': '1', 05:30:37 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:37 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:37 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:30:37 INFO - 'SHELL': '/bin/bash', 05:30:37 INFO - 'SHLVL': '1', 05:30:37 INFO - 'TERM': 'linux', 05:30:37 INFO - 'TMOUT': '86400', 05:30:37 INFO - 'USER': 'cltbld', 05:30:37 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537', 05:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:37 INFO - '_': '/tools/buildbot/bin/python'} 05:30:37 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost'] with output_timeout 3600 05:30:37 INFO - mozversion INFO | application_buildid: 20151110043005 05:30:37 INFO - mozversion INFO | application_changeset: 7ae90a04b0fd9ed59c96fb60f1b8da0ddb0cbf93 05:30:37 INFO - mozversion INFO | application_display_name: Nightly 05:30:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:30:37 INFO - mozversion INFO | application_name: Firefox 05:30:37 INFO - mozversion INFO | application_remotingname: firefox 05:30:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:30:37 INFO - mozversion INFO | application_vendor: Mozilla 05:30:37 INFO - mozversion INFO | application_version: 45.0a1 05:30:37 INFO - mozversion INFO | platform_buildid: 20151110043005 05:30:37 INFO - mozversion INFO | platform_changeset: 7ae90a04b0fd9ed59c96fb60f1b8da0ddb0cbf93 05:30:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:30:37 INFO - mozversion INFO | platform_version: 45.0a1 05:30:37 INFO - 2015-11-10 05:30:37,979 DEBUG : using testdate: 1447162237 05:30:37 INFO - 2015-11-10 05:30:37,979 DEBUG : actual date: 1447162237 05:30:38 INFO - 2015-11-10 05:30:38,057 INFO : starting webserver on 'localhost:36253' 05:30:38 INFO - 2015-11-10 05:30:38,058 INFO : Starting test suite talos-linux64-ix-038 05:30:38 INFO - 2015-11-10 05:30:38,059 INFO : Starting test dromaeo_css 05:30:38 INFO - 2015-11-10 05:30:38,059 DEBUG : operating with platform_type : linux_ 05:30:38 INFO - 2015-11-10 05:30:38,059 INFO : Initialising browser for dromaeo_css test... 05:30:38 INFO - 2015-11-10 05:30:38,074 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoLBVTp/profile http://localhost:36253/getInfo.html 05:30:43 INFO - 2015-11-10 05:30:43,381 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:30:43 INFO - 2015-11-10 05:30:43,382 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:30:43 INFO - 2015-11-10 05:30:43,382 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:30:43 INFO - 2015-11-10 05:30:43,382 DEBUG : BROWSER_OUTPUT: __metrics 05:30:43 INFO - 2015-11-10 05:30:43,559 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:30:44 INFO - 2015-11-10 05:30:44,895 INFO : Browser initialized. 05:30:44 INFO - 2015-11-10 05:30:44,895 INFO : Running cycle 1/1 for dromaeo_css test... 05:30:44 INFO - 2015-11-10 05:30:44,896 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoLBVTp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:30:56 INFO - 2015-11-10 05:30:56,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 139452416 05:30:56 INFO - 2015-11-10 05:30:56,655 DEBUG : BROWSER_OUTPUT: 05:31:48 INFO - 2015-11-10 05:31:48,086 DEBUG : BROWSER_OUTPUT: 1447162308082 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] 05:33:56 INFO - 2015-11-10 05:33:56,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36253/tests/dromaeo/cssquery-ext.html) 05:33:57 INFO - 2015-11-10 05:33:57,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 241025024 05:33:57 INFO - 2015-11-10 05:33:57,571 DEBUG : BROWSER_OUTPUT: 05:36:59 INFO - 2015-11-10 05:36:59,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/dromaeo/cssquery-ext.html (next: http://localhost:36253/tests/dromaeo/cssquery-jquery.html) 05:37:00 INFO - 2015-11-10 05:37:00,502 DEBUG : BROWSER_OUTPUT: RSS: Main: 222031872 05:37:00 INFO - 2015-11-10 05:37:00,503 DEBUG : BROWSER_OUTPUT: 05:40:02 INFO - 2015-11-10 05:40:02,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36253/tests/dromaeo/cssquery-mootools.html) 05:40:02 INFO - 2015-11-10 05:40:02,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 202629120 05:40:02 INFO - 2015-11-10 05:40:02,979 DEBUG : BROWSER_OUTPUT: 05:43:04 INFO - 2015-11-10 05:43:04,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36253/tests/dromaeo/cssquery-prototype.html) 05:43:05 INFO - 2015-11-10 05:43:05,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 198971392 05:43:05 INFO - 2015-11-10 05:43:05,462 DEBUG : BROWSER_OUTPUT: 05:46:07 INFO - 2015-11-10 05:46:07,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36253/tests/dromaeo/cssquery-yui.html) 05:46:08 INFO - 2015-11-10 05:46:08,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 201363456 05:46:08 INFO - 2015-11-10 05:46:08,472 DEBUG : BROWSER_OUTPUT: 05:49:10 INFO - 2015-11-10 05:49:10,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/dromaeo/cssquery-yui.html (next: http://localhost:36253/tests/dromaeo/cssquery-dojo.html) 05:49:11 INFO - 2015-11-10 05:49:11,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 274939904 05:49:11 INFO - 2015-11-10 05:49:11,174 DEBUG : BROWSER_OUTPUT: 05:49:11 INFO - 2015-11-10 05:49:11,176 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:49:11 INFO - 2015-11-10 05:49:11,176 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:49:11 INFO - 2015-11-10 05:49:11,176 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:49:11 INFO - 2015-11-10 05:49:11,176 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:49:11 INFO - 2015-11-10 05:49:11,178 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3175.190326466751;3210.518422236663;3249.5288183213434;3262.820544870033;3276.115448828816;5255.684658920468;5362.35651721794;5375.408705042447;5401.810936617214;5449.100898351772;5417.810376636819;5437.619366644337;5439.156930675742;5461.044317244487;5473.397926228112;4934.925976110361;5010.4739002404585;5017.523335283151;5188.740562971836;5199.272101905736;4812.446568644598;5114.846554603368;5143.074246635604;5172.146595811687;5215.217717342391;4892.461829198785;4980.850574482772;5060.316857224301;5074.619403544712;5121.206213036985;4946.480619534969;4950.4059512858685;4962.87592810179;4984;4994.126027945095;4781.115493633689;4893.657443978923;4953.479884612136;4972.129877271499;5031.396232452093;5234.214867769827;5336.626436149471;5341.732913354355;5348.224507446437;5350.759215835296;5900.852478688067;5909.645421274738;5915.112733090028;5917.408259174092;5963.850903727398;5733.942660573424;5809.070548712228;5860.472557469848;5928.614640048426;5934.139549765303;5430.076886929192;5439.129739241703;5442.2380866678695;5475.589330800166;5621.606487545873;5895.4399332063385;5898.970505147447;5899.262592175978;5905.881882362329;5943.524518038546;5613.158026296088;5726.570507211975;5766.452187042224;5834.445727655866;5965.492933100648;6012.699365031818;6013.759449622054;6018.21763170785;6021.909671354933;6029.638221706711;5951.077582974646;5966.373530779206;5969.194158788595;5973;5998.070299103646;5715.199872017921;5845.1232315153065;5848.736806843703;5934.37689042653;5984.431479009487;4536.342230376643;4539.977300113478;4540.88647783808;4543.636509079266;4575.611073058827;3892.2020985697864;4043.696722745806;4046.615571520701;4060.167665628539;4090.611391917763;5498.037843377393;5504.504594586507;5532.7786888524815;5584.5811564132855;5597.80407685729;5893.174955506232;5895.29256489224;5899.203607512931;5900.586958912835;5911.852203694942;5339.199120131933;5451.3458384994055;5558.610897237155;5559.944400555943;5568.025595520849;5065.6200784941275;5117.053345131163;5135.075686376488;5136.691798492027;5178.0420622184265;6074.119252708332;6080.8783824324155;6082.60463069899;6093.421124993119;6121.602095863755;5643.1535269709875;5743.224664670383;5886.823395298148;5901.881962360643;5943.346231914399;6088.799964253613;6090.254001114731;6095.067532273641;6105.178419689978;6129.8467538310115;5789.768409263583;5790.044642633919;5791.652500849962;5794.5364370851075;5859.2382990211;5745.569082318759;5838.854028649318;5848.356680765028;5865.94134058654;5954.166416701752;5766.798162064308;5793.710314484343;5800.477956983892;5805.8548536286935;5809.82570522885;5789.305283366023;5794.072948328248;5795.82612521625;5802.303723553201;5805.042168042226;5506.476884695948;5605.299337582802;5637.295338082739;5666.03677374839;5712.028955077563;5771.884562308646;5781.595288329945;5812.622179558315;5812.796552120655;5833.300003999547;5467.07059799843;5693;5697.971510142423;5701.315842098975;5702.857428564153 05:49:11 INFO - 2015-11-10 05:49:11,179 DEBUG : BROWSER_OUTPUT: |1;ext.html;542.6174546944404;550.5898105911097;551.0373770620853;590.2474345209858;595.5265563876718;30053.699463005392;39194.804025979865;39860.40209396854;39883.40174897375;39893;42162.578374216246;42478;42658.78670606643;42706;42831;7447.590382528959;7535.058117735283;8687.826243475127;8858.512781796999;8864.778380540505;10346.224033197503;10435.373877567332;10620.681379558626;10620.946895265513;10623.57505699775;10097.646582369618;10116;10202.693919182437;10213.693589192337;10220.437875916821;7377.077865266869;7510.061242344707;10100.696979090639;10301.175905927545;10304.536295866705;9969;10081.790185177826;10086.79826403475;10090.34412763168;10090.64682736108;26518.337041573923;36333;36708.26583468316;36830.8158459206;36874.81562592197;2476.232367965936;2548.7706106450323;3054.6639869614323;3064.5096784514594;3106.8038805060214;29980.250493737614;30292.54561181584;30509.847450762827;30673.233169170726;30831.229219269473;3028.37918226763;3033.59046528718;3098.3183699586057;3109.5024796032526;3121.2352973521633;292402;292617;294638;295820;296180;59616.70191649014;59780.70109649511;59959.40040599625;59974;60226.69886650539;61025.38974610286;61305;61330.69334653298;61343.38656613466;61522.38477615256;11906.702332441586;12011.099167562294;12022.338771367484;12037.157398982163;12044.759104817855;9719.368241064309;9780.55987480565;9812;9815.36200146988;9817.754556136153;18963.81036189648;19870;20003.299884503973;20009.899455529794;20023.699644505345;7625.923740762632;7664.65509052094;7745.690172393041;7807.882881756778;7817;746.4438992950287;836.4855613797471;944.3483996042709;945.9716208513618;947.976300592477;26763.598546021825;27384.315392115357;27884.442311153663;27977.580336294974;28186.2953426166;902.634433054614;936.8875734911718;981.646607221414;992.3648864726581;1004.5379125602304;13504.864951350557;14838.554843354717;14885.181315027778;15120.092794432368;15278.541643750705;396287;400233;402537;403890;403936;45017.324740128926;45153.32270015952;45346.31980520295;45380.54619453829;45549.54450455519;1079.3901445683164;1087.2497976396262;1100.2353364411817;1102.0742576236;1178.4991378664033;27831.582526261718;28471.572926405704;28580.714192857806;28923.710762892944;29014.419711605227;45597.77201113973;46151.3077303834;46193.30710039285;46275.3058704113;46278.76860615675;341603;341642;343839;344404;344544;27566.310842229104;27975;31211.219719507193;31264.374712505167;32880.1779955503;40712;42402.363964541175;47331.526684732715;48845.77885552889;49124.50875491199;36813;36826.63173368232;37157;39870.80064599658;40839.7958010208;36763.63236367709;37388.25223495569;37421.43867842039;37642.05894852651;37775.62224377721;33952.320953580296;34597.30805383828;36844.63155368519;37935.24129517449;38774.80612596919;32383.676163238066;33492.49761253534;33648.49527257044;33736.831315843265;33911.66088339085;25634.487310254062;25644.358891027874;25678;25792.09727659523;25982.870085650207 05:49:11 INFO - 2015-11-10 05:49:11,183 DEBUG : BROWSER_OUTPUT: |2;jquery.html;327.7427219632589;328.8388689542125;329.89156434380493;335.5922554096772;336.0623859432184;13887.166769993808;14374.712505749878;16916.91541542292;17093.23080461379;17941.820581794178;14589.12465252083;14594.927025364885;14626.853731462683;14640.926795366035;14684.779728304084;5369.812056578011;5435.402105768362;5523.6685798851995;5526.806561770339;5531.142672885689;3776.055986003499;3880.708946828985;5497.615166938316;5916.5266778657815;6093.756249750005;5986.8802623947495;6010.1585777990895;6015.398460153993;6018.60879042863;6044.274687037561;5540.722963851791;5584.106542953108;5585.078462053756;5585.8603534911545;5586.469285417919;5176.378834539879;5236.685798852043;5236.7905283788605;5240.52835244826;5244.449332820037;11438.885611143865;12778.424970876333;12996.350182490933;13368.933155334258;13377;1767.5050985724017;1861.6941716108981;1863.6272745450965;1871.1766822598013;1890.139986306241;9971.501424928798;10076.647317343857;10080.092791648787;10103;10221.846672299922;1661.1777170300659;1664.0847533856331;1683.309842964391;1691.8815682902202;1696.151924037981;56204.43795562033;56933.71533142349;57186.14220786691;57697.423025769625;61367.38632613706;6828.453723702092;6838.452923766087;6851;6937.895931561031;6979.267176946449;8249.422540422112;8252;8267.793305167299;8268.958655206685;8272.420930534925;4991.450940396553;5003.524665156804;5016.021875734197;5061.367329083864;5083.2375143727995;4903.313536104948;4925.482824303468;4938.160512712776;4945.629077819178;4948;3183.3315003849452;3217.790843595206;3234.450143475615;3238.562794022777;3239.530268111158;1081.3944191252924;1125.1336470917347;1126.571902676994;1149.040551139791;1184.1296646964474;420.968626864184;434.8543238015237;437.0494175168995;444.7776111944028;456.9246074397687;10301.9484902575;11548.59579914699;11672.88327116735;11761.294322340687;12203.633890983285;447.16603534408097;449.0905915521096;459.967802253839;461.91916414627303;472.9996058336662;6416.32628573993;6502.934970650233;6557.2131344239;6562.343765623495;6653.2681405045405;518734;520502;521028;523265;523306;73486.63256683682;77101.22898771052;79214.60392698;79615.60192199002;80176;411.1653343712269;421.55947035348134;422.5478737750577;423.45585922090584;423.4770058977222;9825.9017409825;9867.16129129032;9952.850707239253;9957.302988790716;10093.293469457361;34337;34445.65554344424;34816.47775283423;35152.12119697028;35487.82256088703;47843.76078119587;48908.51091489182;50083;50807.74596126996;51010.74494627503;7999.320057795153;8079.394045446497;8275.213854683796;8284.46151000183;8381.287590554872;11870.050395968474;12014.579489717818;12083.275003499819;12093.879061209274;12179.391030448265;10608.840867387149;10679.252452328263;10738.302010369302;10852.891471085188;10866.07638350749;10452.529636166239;10561.155107591221;10647.520861561094;10649.840252396065;10703.250772445854;9223.953880230556;9659.71020869375;10869.945650271698;10890.29213101146;10949.56201751921;7874.448788584744;8235.711750088958;8325.666973321;8383.035950865484;8384.161583841567;10381.896181038093;10492.632757853438;10681.89318106809;10818.891811082103;10821.783564328827 05:49:11 INFO - 2015-11-10 05:49:11,183 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1098.4233277529302;1364.16785760686;1420.0982376191118;1510.131674287285;1731.2469075951954;6609.801705948823;7265.382442492388;7468.589227592493;7474.028376311072;7478;7034.648267586613;7180.784576462702;7182.676779544933;7224.783256502314;7225.205227424979;1941.9417417477498;1989.214260367154;2159.6544552871505;2177.6406892862738;2211.0824008036648;2248.741394739601;2249.2352600115955;2253.4028482452163;2255.402318385621;2256.593813113639;2185.912563497458;2215.435064058671;2254.729432468106;2255.3684968208845;2256.4020534558354;1891.5933074389004;1920.1167462967053;2142.8071473567375;2201.4936564590075;2203.6143674856994;2208;2209.602271591113;2243.596152692515;2247.011315021385;2257.8193744500563;7511.924880751232;7572.4320675948975;7586.886196707053;7587.393008559302;7592.924070759277;4384.978075109604;4431.689781715281;4448.421705178306;4466.665000125004;4470;2991.1774262077884;2991.311998240395;2997.8201307921595;3018.5623084652602;3129.640091389474;966.1932286540676;969.5540051576284;970.9174720148795;1007.3603261928655;1045.9947700261525;9669.226461883032;9685.564149613285;9692.612295508172;9694.079062489052;9699;3936.9015774605864;3963.147923196527;4005.1388951375593;4094.549599544048;4145.709800313949;8435.409521333571;8453.577321133918;8456.577171141418;8460.111688272766;8463.153684631488;4362.716423432466;4369.2790689536505;4373.278409062533;4377.058932329501;4377.890552736207;4020.396940458896;4025.798710064485;4033.0119120815;4039.1921615676983;4039.8586049488126;3676.963230367662;3746.606606306353;3748;3767.453719210699;3780.432935059763;1203.8435003449495;1218.250775772911;1223.3271700564653;1233.0333118675699;1234.493857518431;907.8275127725711;1254.140913474273;1261.8422697162855;1291.12203701482;1291.838520184977;6531.804045878631;6660.800175994728;6932.688029038705;6933.5493192942295;6935.930640693528;613.8741557980603;621.7046902721171;627.5920651576512;680.5950459476603;680.6120511308606;5581.441855814386;5685.545156387479;5714.028615135437;5720.599558030981;5724.4561766632105;8595.398322117391;8726.738197854074;8727.258183054511;8729.694460693845;8752.387332886765;8405.495670259805;8627.482351058956;8755.649774008969;8768.78078048054;8769.473831570127;6603.075569420285;6666.633335166515;6672.599644021374;6677.065210870482;6683.064370988066;6546.705398257185;6560.179977502812;6601.108850305147;6642.368974947372;6652.467802575879;7721.073471183494;7833.020872390951;7856.921430785619;7863.646135924012;7878.251566101211;7849.568273744999;8042.195780421911;8054.114047454893;8055.959720201596;8074.3944204183745;6546.18172728409;6605.504587156079;6605.933940660532;6613.636250006296;6621.106150669791;7073.646317684198;7146.606936618536;7161.6061116637;7188.856222875618;7194.064771579661;6809.080774095433;6834.2140653825445;6848.1097457330225;6859.279775623687;6915.757948471779;6440.581362211441;6492.253390859923;6504.0243963405865;6514.54398192122;6542.509311801538;6017.18767966319;6137.7851775187655;6747.257801641914;6863.176418829573;6895.275996020547;6182.350853160354;6271.560990730605;6303.086052522451;6313.589616674902;6314.968425157845;6302.464290535172;6348.93651063502;6356.396142366468;6360.427561519486;6363.204599425072 05:49:11 INFO - 2015-11-10 05:49:11,183 DEBUG : BROWSER_OUTPUT: |4;prototype.html;306.13669452144944;323.51957343345134;328.4695217224182;328.92605642577007;330.0971842012095;5762.683052432115;5858.941410585893;5870.61840980336;5874.530037596993;5882.294124705036;5688.033034384154;5762.078067509199;5780.913286300709;5807.8257652270395;5809.593328467009;4457.977710111461;4460.107978404316;4461.39771130898;4468.977655111737;4478.619317358029;4361.629261512775;4422.535633758457;4454.910901781963;4464.374987501752;4530.886727831814;4454.844080457185;4458.9967257367;4476.843310484133;4493.168763778695;4494.1910456117885;4462.598366147063;4462.839661687968;4464.508904020571;4472.642188624902;4473.709208901411;3932.1152740633415;3935.232629637222;3941.684665226775;3942.3889297158985;3947.210557888405;5416.620836541444;5507.531859791922;5514.80698175566;5535.086710692731;5537.723113844332;5105.157648987913;5105.897882042375;5114.590832733373;5117.309163262949;5117.48825117489;5910.7931222407005;6143.600665956743;6148.631082135086;6149.754009839601;6152.72312745923;4093.3655283431117;4125.876223713293;4135.441715368417;4139.482564679415;4140.523839758436;6261.686915654199;6344.175257216532;6347.682615869234;6350.936490635081;6352.80941571749;4339.479262488521;4340.327249276304;4341.34879768031;4343.305071188594;4344.152890186383;4291.570842915746;4391.60475557195;4391.6486681065435;4392.494863090786;4410.867673969786;5078.898422031539;5080.085584594808;5080.263361812516;5084.49155084496;5085.567726743268;6054.485368743618;6072.635641861414;6073.696315184223;6083.726232319556;6114.908276375858;1537.4311504743093;1537.592537977437;1539.692061587687;1541.599184212113;1542.0362273579012;1030.3920686794677;1043.1133536494071;1046.1839764983324;1068.257560995101;1068.551208492435;5996.430339117776;6017.217761690952;6033.155358249848;6033.276006879115;6038.879222415527;6401.679916004181;6409.327020662857;6409.487241020707;6412.967935160387;6416.486681065504;6017.849553761191;6028.577999540078;6028.879422411527;6034.366391528826;6037.154798328237;3515.6835884770494;3554.804485753308;3567.839447224881;3574.1779390740276;3585.6055833858254;6659.300773418819;6665.066890635315;6665.366790154928;6669.433098186709;6677.332266773284;6503.739850406026;6512.869742605121;6519.348065193538;6530.771423000172;6534.869302613921;6486.383793539606;6638.103855979381;6649.401553860176;6650.401463868275;6739.831504212336;6213.37866213375;6292.182016337847;6480.384363485461;6490.675466226764;6491.7403303869205;6267.467265282502;6336.873262534816;6344.873102538016;6359.20509936258;6364.586301890362;6556.213254409311;6621.735130594722;6630.9668451657435;6634.402903738686;6634.5024123191915;4197.706160568731;4280.571942805695;4313.029568347222;4330.761808100585;4333.956660433355;6426.196725409324;6430.967845160744;6442.2591401989375;6461.256955449995;6464.967675161594;6292.779752708633;6298.307186209605;6307.558470906993;6312.5581209314905;6319.778807741707;6157.692115394123;6285.402886725754;6292.874142517216;6299.464545513682;6309.148264984352;6131.356207598138;6139.29398119222;6148.354422785543;6149.938500614937;6155.630662160284;6252.09344645033;6254.437100660963;6259.937400625936;6263.248410190807;6263.718132684131;6022.427869352405;6118.388161184024;6119.84700382494;6121.663308518075;6121.693915304128 05:49:11 INFO - 2015-11-10 05:49:11,184 DEBUG : BROWSER_OUTPUT: |5;yui.html;715.5170260074452;720.8990741296218;726.6838925067593;728.9343959043687;745.5750222373249;13079.54221602244;13407.664808379772;13415.195088294697;13425.395857186426;13446.126001809875;12967.481300747959;13482.325883705824;13531.661708457294;13537.255450950219;13540.322983850818;648.9286178520359;661.3882159002903;776.4991580430619;777.4518964130289;794.9006374203225;790.3005839831761;796.1799346672907;800.4996876951905;801.2308184143201;802;824.8020475085966;835.7826964989085;836.7447928381841;837.2004735477605;837.7403005068448;667.2026927821231;681.8840797064486;805.8227190018187;822.596927505518;824.6742536698031;604.2386592892942;605.794030029792;607.4957785038407;607.6931149769338;607.6931149769382;13384.464621415133;13469.86530134696;13526.256055916921;13539.458421663121;13564.186148831002;11651.825222621668;12116.151869369147;12560.560380386643;12639.684007899785;12668.049896257817;9519.476428796414;9574;9616.951915240448;9676.17752491039;9961.551730172087;3459.187091033605;3482.8432720527635;3505.1762835733584;3512.6311737267474;3527.7354198434964;48932.75533622345;49053.50946490525;49286.50713492891;49342.50657493415;49617;9524.761880952892;9807.411555306704;9891.258155638356;9958.950205248928;10066.798664026825;18157.36449224271;18159.63680726378;18161.36435224787;18170.54573635643;18173.182206800724;7472.14070381913;7549;7634.274743899321;7647.770566883002;7649.732259370895;4293.034067334887;4300.591443812833;4310.892227694333;4316.395704601358;4418.469783625921;2843.24653966699;2882.077735124782;2882.106546970446;2885.2786803299177;2886.696896825803;435.2969953525097;436.559075333915;440.1175642836157;444.1849206705731;449.47860481840905;497.9502049794992;516.6022162934595;573.2347316332742;586.5249148189895;664.5016237821634;8652.95673521641;8721.738347849574;8783.604737786814;9043.095690430904;9152.771180720536;522.725569076238;572.2103497173956;609.2688773471851;634.2800920954658;643.6009674002055;3595.6224596417;3751.1372384351207;3949.960500395017;3978.8806335809973;4045.4134150548007;61574.38425615687;62527;62578.687106564175;62602;62724.372756271856;52641.736791316565;54537.72731136398;54786.45213547813;54806.177907331425;55028.174577381375;47573.76213118982;48033.27950080752;48040.27939580909;48400;49497.75251123794;7692.230776922263;7709.190534993969;7725.961370193113;7763.961180194063;7963.641636126504;35701.82149089238;35980.820095899355;36484.08789780277;37315.81342093272;37633.43549846809;47096.529034709216;48635;48843.75578122087;49004;49530.75234623804;7536.0956685198125;7583;7633.160352361347;7727.49771264866;7945.324647404804;10307.896921030693;10846.620368287387;11951.22317049389;12201.816972745239;12437.37813109359;11115.11079113685;11194.720131996764;11331.886681133083;11404.714882128013;11652.53389864396;11130.833037504606;11257.155713321697;11276.436178191221;11366.829497557377;11646.767064658829;10762.192835537522;11111.38887361203;11206.215564910704;11309.321440713584;11423;9291.117343852324;9386.718398447785;9436.433813971184;9468.431894086378;9644.565994530403;8475.788105297417;8747.60635771379;8864.867026994729;8893.911060889308;8943.731688049369 05:49:11 INFO - 2015-11-10 05:49:11,184 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:49:11 INFO - 2015-11-10 05:49:11,184 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:49:11 INFO - 2015-11-10 05:49:11,184 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,833 05:49:11 INFO - 2015-11-10 05:49:11,184 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:49:11 INFO - 2015-11-10 05:49:11,184 DEBUG : BROWSER_OUTPUT: __startTimestamp1447163351174__endTimestamp 05:49:11 INFO - 2015-11-10 05:49:11,184 DEBUG : BROWSER_OUTPUT: 05:49:11 INFO - 2015-11-10 05:49:11,185 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:49:11 INFO - 2015-11-10 05:49:11,185 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:49:11 INFO - 2015-11-10 05:49:11,185 DEBUG : BROWSER_OUTPUT: 05:49:11 INFO - 2015-11-10 05:49:11,185 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5461.82 Median:5693.00 stddev:613.65 (10.8%) stddev-sans-first:588.73 05:49:11 INFO - 2015-11-10 05:49:11,186 DEBUG : BROWSER_OUTPUT: Values: 3175.2 3210.5 3249.5 3262.8 3276.1 5255.7 5362.4 5375.4 5401.8 5449.1 5417.8 5437.6 5439.2 5461.0 5473.4 4934.9 5010.5 5017.5 5188.7 5199.3 4812.4 5114.8 5143.1 5172.1 5215.2 4892.5 4980.9 5060.3 5074.6 5121.2 4946.5 4950.4 4962.9 4984.0 4994.1 4781.1 4893.7 4953.5 4972.1 5031.4 5234.2 5336.6 5341.7 5348.2 5350.8 5900.9 5909.6 5915.1 5917.4 5963.9 5733.9 5809.1 5860.5 5928.6 5934.1 5430.1 5439.1 5442.2 5475.6 5621.6 5895.4 5899.0 5899.3 5905.9 5943.5 5613.2 5726.6 5766.5 5834.4 5965.5 6012.7 6013.8 6018.2 6021.9 6029.6 5951.1 5966.4 5969.2 5973.0 5998.1 5715.2 5845.1 5848.7 5934.4 5984.4 4536.3 4540.0 4540.9 4543.6 4575.6 3892.2 4043.7 4046.6 4060.2 4090.6 5498.0 5504.5 5532.8 5584.6 5597.8 5893.2 5895.3 5899.2 5900.6 5911.9 5339.2 5451.3 5558.6 5559.9 5568.0 5065.6 5117.1 5135.1 5136.7 5178.0 6074.1 6080.9 6082.6 6093.4 6121.6 5643.2 5743.2 5886.8 5901.9 5943.3 6088.8 6090.3 6095.1 6105.2 6129.8 5789.8 5790.0 5791.7 5794.5 5859.2 5745.6 5838.9 5848.4 5865.9 5954.2 5766.8 5793.7 5800.5 5805.9 5809.8 5789.3 5794.1 5795.8 5802.3 5805.0 5506.5 5605.3 5637.3 5666.0 5712.0 5771.9 5781.6 5812.6 5812.8 5833.3 5467.1 5693.0 5698.0 5701.3 5702.9 05:49:11 INFO - 2015-11-10 05:49:11,186 DEBUG : BROWSER_OUTPUT: 05:49:11 INFO - 2015-11-10 05:49:11,186 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50610.56 Median:189570.65 stddev:91880.11 (48.5%) stddev-sans-first:92060.95 05:49:11 INFO - 2015-11-10 05:49:11,186 DEBUG : BROWSER_OUTPUT: Values: 542.6 550.6 551.0 590.2 595.5 30053.7 39194.8 39860.4 39883.4 39893.0 42162.6 42478.0 42658.8 42706.0 42831.0 7447.6 7535.1 8687.8 8858.5 8864.8 10346.2 10435.4 10620.7 10620.9 10623.6 10097.6 10116.0 10202.7 10213.7 10220.4 7377.1 7510.1 10100.7 10301.2 10304.5 9969.0 10081.8 10086.8 10090.3 10090.6 26518.3 36333.0 36708.3 36830.8 36874.8 2476.2 2548.8 3054.7 3064.5 3106.8 29980.3 30292.5 30509.8 30673.2 30831.2 3028.4 3033.6 3098.3 3109.5 3121.2 292402.0 292617.0 294638.0 295820.0 296180.0 59616.7 59780.7 59959.4 59974.0 60226.7 61025.4 61305.0 61330.7 61343.4 61522.4 11906.7 12011.1 12022.3 12037.2 12044.8 9719.4 9780.6 9812.0 9815.4 9817.8 18963.8 19870.0 20003.3 20009.9 20023.7 7625.9 7664.7 7745.7 7807.9 7817.0 746.4 836.5 944.3 946.0 948.0 26763.6 27384.3 27884.4 27977.6 28186.3 902.6 936.9 981.6 992.4 1004.5 13504.9 14838.6 14885.2 15120.1 15278.5 396287.0 400233.0 402537.0 403890.0 403936.0 45017.3 45153.3 45346.3 45380.5 45549.5 1079.4 1087.2 1100.2 1102.1 1178.5 27831.6 28471.6 28580.7 28923.7 29014.4 45597.8 46151.3 46193.3 46275.3 46278.8 341603.0 341642.0 343839.0 344404.0 344544.0 27566.3 27975.0 31211.2 31264.4 32880.2 40712.0 42402.4 47331.5 48845.8 49124.5 36813.0 36826.6 37157.0 39870.8 40839.8 36763.6 37388.3 37421.4 37642.1 37775.6 33952.3 34597.3 36844.6 37935.2 38774.8 32383.7 33492.5 33648.5 33736.8 33911.7 25634.5 25644.4 25678.0 25792.1 25982.9 05:49:11 INFO - 2015-11-10 05:49:11,186 DEBUG : BROWSER_OUTPUT: 05:49:11 INFO - 2015-11-10 05:49:11,187 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26556.93 Median:453.01 stddev:85488.08 (18871.2%) stddev-sans-first:85705.21 05:49:11 INFO - 2015-11-10 05:49:11,187 DEBUG : BROWSER_OUTPUT: Values: 327.7 328.8 329.9 335.6 336.1 13887.2 14374.7 16916.9 17093.2 17941.8 14589.1 14594.9 14626.9 14640.9 14684.8 5369.8 5435.4 5523.7 5526.8 5531.1 3776.1 3880.7 5497.6 5916.5 6093.8 5986.9 6010.2 6015.4 6018.6 6044.3 5540.7 5584.1 5585.1 5585.9 5586.5 5176.4 5236.7 5236.8 5240.5 5244.4 11438.9 12778.4 12996.4 13368.9 13377.0 1767.5 1861.7 1863.6 1871.2 1890.1 9971.5 10076.6 10080.1 10103.0 10221.8 1661.2 1664.1 1683.3 1691.9 1696.2 56204.4 56933.7 57186.1 57697.4 61367.4 6828.5 6838.5 6851.0 6937.9 6979.3 8249.4 8252.0 8267.8 8269.0 8272.4 4991.5 5003.5 5016.0 5061.4 5083.2 4903.3 4925.5 4938.2 4945.6 4948.0 3183.3 3217.8 3234.5 3238.6 3239.5 1081.4 1125.1 1126.6 1149.0 1184.1 421.0 434.9 437.0 444.8 456.9 10301.9 11548.6 11672.9 11761.3 12203.6 447.2 449.1 460.0 461.9 473.0 6416.3 6502.9 6557.2 6562.3 6653.3 518734.0 520502.0 521028.0 523265.0 523306.0 73486.6 77101.2 79214.6 79615.6 80176.0 411.2 421.6 422.5 423.5 423.5 9825.9 9867.2 9952.9 9957.3 10093.3 34337.0 34445.7 34816.5 35152.1 35487.8 47843.8 48908.5 50083.0 50807.7 51010.7 7999.3 8079.4 8275.2 8284.5 8381.3 11870.1 12014.6 12083.3 12093.9 12179.4 10608.8 10679.3 10738.3 10852.9 10866.1 10452.5 10561.2 10647.5 10649.8 10703.3 9224.0 9659.7 10869.9 10890.3 10949.6 7874.4 8235.7 8325.7 8383.0 8384.2 10381.9 10492.6 10681.9 10818.9 10821.8 05:49:11 INFO - 2015-11-10 05:49:11,187 DEBUG : BROWSER_OUTPUT: 05:49:11 INFO - 2015-11-10 05:49:11,187 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5149.40 Median:6401.89 stddev:2623.31 (41.0%) stddev-sans-first:2612.99 05:49:11 INFO - 2015-11-10 05:49:11,187 DEBUG : BROWSER_OUTPUT: Values: 1098.4 1364.2 1420.1 1510.1 1731.2 6609.8 7265.4 7468.6 7474.0 7478.0 7034.6 7180.8 7182.7 7224.8 7225.2 1941.9 1989.2 2159.7 2177.6 2211.1 2248.7 2249.2 2253.4 2255.4 2256.6 2185.9 2215.4 2254.7 2255.4 2256.4 1891.6 1920.1 2142.8 2201.5 2203.6 2208.0 2209.6 2243.6 2247.0 2257.8 7511.9 7572.4 7586.9 7587.4 7592.9 4385.0 4431.7 4448.4 4466.7 4470.0 2991.2 2991.3 2997.8 3018.6 3129.6 966.2 969.6 970.9 1007.4 1046.0 9669.2 9685.6 9692.6 9694.1 9699.0 3936.9 3963.1 4005.1 4094.5 4145.7 8435.4 8453.6 8456.6 8460.1 8463.2 4362.7 4369.3 4373.3 4377.1 4377.9 4020.4 4025.8 4033.0 4039.2 4039.9 3677.0 3746.6 3748.0 3767.5 3780.4 1203.8 1218.3 1223.3 1233.0 1234.5 907.8 1254.1 1261.8 1291.1 1291.8 6531.8 6660.8 6932.7 6933.5 6935.9 613.9 621.7 627.6 680.6 680.6 5581.4 5685.5 5714.0 5720.6 5724.5 8595.4 8726.7 8727.3 8729.7 8752.4 8405.5 8627.5 8755.6 8768.8 8769.5 6603.1 6666.6 6672.6 6677.1 6683.1 6546.7 6560.2 6601.1 6642.4 6652.5 7721.1 7833.0 7856.9 7863.6 7878.3 7849.6 8042.2 8054.1 8056.0 8074.4 6546.2 6605.5 6605.9 6613.6 6621.1 7073.6 7146.6 7161.6 7188.9 7194.1 6809.1 6834.2 6848.1 6859.3 6915.8 6440.6 6492.3 6504.0 6514.5 6542.5 6017.2 6137.8 6747.3 6863.2 6895.3 6182.4 6271.6 6303.1 6313.6 6315.0 6302.5 6348.9 6356.4 6360.4 6363.2 05:49:11 INFO - 2015-11-10 05:49:11,187 DEBUG : BROWSER_OUTPUT: 05:49:11 INFO - 2015-11-10 05:49:11,188 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5177.35 Median:5953.61 stddev:1569.89 (26.4%) stddev-sans-first:1531.13 05:49:11 INFO - 2015-11-10 05:49:11,188 DEBUG : BROWSER_OUTPUT: Values: 306.1 323.5 328.5 328.9 330.1 5762.7 5858.9 5870.6 5874.5 5882.3 5688.0 5762.1 5780.9 5807.8 5809.6 4458.0 4460.1 4461.4 4469.0 4478.6 4361.6 4422.5 4454.9 4464.4 4530.9 4454.8 4459.0 4476.8 4493.2 4494.2 4462.6 4462.8 4464.5 4472.6 4473.7 3932.1 3935.2 3941.7 3942.4 3947.2 5416.6 5507.5 5514.8 5535.1 5537.7 5105.2 5105.9 5114.6 5117.3 5117.5 5910.8 6143.6 6148.6 6149.8 6152.7 4093.4 4125.9 4135.4 4139.5 4140.5 6261.7 6344.2 6347.7 6350.9 6352.8 4339.5 4340.3 4341.3 4343.3 4344.2 4291.6 4391.6 4391.6 4392.5 4410.9 5078.9 5080.1 5080.3 5084.5 5085.6 6054.5 6072.6 6073.7 6083.7 6114.9 1537.4 1537.6 1539.7 1541.6 1542.0 1030.4 1043.1 1046.2 1068.3 1068.6 5996.4 6017.2 6033.2 6033.3 6038.9 6401.7 6409.3 6409.5 6413.0 6416.5 6017.8 6028.6 6028.9 6034.4 6037.2 3515.7 3554.8 3567.8 3574.2 3585.6 6659.3 6665.1 6665.4 6669.4 6677.3 6503.7 6512.9 6519.3 6530.8 6534.9 6486.4 6638.1 6649.4 6650.4 6739.8 6213.4 6292.2 6480.4 6490.7 6491.7 6267.5 6336.9 6344.9 6359.2 6364.6 6556.2 6621.7 6631.0 6634.4 6634.5 4197.7 4280.6 4313.0 4330.8 4334.0 6426.2 6431.0 6442.3 6461.3 6465.0 6292.8 6298.3 6307.6 6312.6 6319.8 6157.7 6285.4 6292.9 6299.5 6309.1 6131.4 6139.3 6148.4 6149.9 6155.6 6252.1 6254.4 6259.9 6263.2 6263.7 6022.4 6118.4 6119.8 6121.7 6121.7 05:49:11 INFO - 2015-11-10 05:49:11,188 DEBUG : BROWSER_OUTPUT: 05:49:11 INFO - 2015-11-10 05:49:11,188 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14055.59 Median:25057.48 stddev:17055.14 (68.1%) stddev-sans-first:17073.57 05:49:11 INFO - 2015-11-10 05:49:11,188 DEBUG : BROWSER_OUTPUT: Values: 715.5 720.9 726.7 728.9 745.6 13079.5 13407.7 13415.2 13425.4 13446.1 12967.5 13482.3 13531.7 13537.3 13540.3 648.9 661.4 776.5 777.5 794.9 790.3 796.2 800.5 801.2 802.0 824.8 835.8 836.7 837.2 837.7 667.2 681.9 805.8 822.6 824.7 604.2 605.8 607.5 607.7 607.7 13384.5 13469.9 13526.3 13539.5 13564.2 11651.8 12116.2 12560.6 12639.7 12668.0 9519.5 9574.0 9617.0 9676.2 9961.6 3459.2 3482.8 3505.2 3512.6 3527.7 48932.8 49053.5 49286.5 49342.5 49617.0 9524.8 9807.4 9891.3 9959.0 10066.8 18157.4 18159.6 18161.4 18170.5 18173.2 7472.1 7549.0 7634.3 7647.8 7649.7 4293.0 4300.6 4310.9 4316.4 4418.5 2843.2 2882.1 2882.1 2885.3 2886.7 435.3 436.6 440.1 444.2 449.5 498.0 516.6 573.2 586.5 664.5 8653.0 8721.7 8783.6 9043.1 9152.8 522.7 572.2 609.3 634.3 643.6 3595.6 3751.1 3950.0 3978.9 4045.4 61574.4 62527.0 62578.7 62602.0 62724.4 52641.7 54537.7 54786.5 54806.2 55028.2 47573.8 48033.3 48040.3 48400.0 49497.8 7692.2 7709.2 7726.0 7764.0 7963.6 35701.8 35980.8 36484.1 37315.8 37633.4 47096.5 48635.0 48843.8 49004.0 49530.8 7536.1 7583.0 7633.2 7727.5 7945.3 10307.9 10846.6 11951.2 12201.8 12437.4 11115.1 11194.7 11331.9 11404.7 11652.5 11130.8 11257.2 11276.4 11366.8 11646.8 10762.2 11111.4 11206.2 11309.3 11423.0 9291.1 9386.7 9436.4 9468.4 9644.6 8475.8 8747.6 8864.9 8893.9 8943.7 05:49:11 INFO - 2015-11-10 05:49:11,189 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:49:11 INFO - 2015-11-10 05:49:11,189 DEBUG : BROWSER_OUTPUT: 05:49:11 INFO - 2015-11-10 05:49:11,937 INFO : Browser exited with error code: 0 05:49:11 INFO - 2015-11-10 05:49:11,956 INFO : Completed test dromaeo_css (00:18:33) 05:49:11 INFO - 2015-11-10 05:49:11,956 INFO : Starting test kraken 05:49:11 INFO - 2015-11-10 05:49:11,956 DEBUG : operating with platform_type : linux_ 05:49:11 INFO - 2015-11-10 05:49:11,956 INFO : Initialising browser for kraken test... 05:49:11 INFO - 2015-11-10 05:49:11,962 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6SM5lx/profile http://localhost:36253/getInfo.html 05:49:15 INFO - 2015-11-10 05:49:15,941 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:49:15 INFO - 2015-11-10 05:49:15,941 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:49:15 INFO - 2015-11-10 05:49:15,941 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:49:15 INFO - 2015-11-10 05:49:15,941 DEBUG : BROWSER_OUTPUT: __metrics 05:49:16 INFO - 2015-11-10 05:49:16,090 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:49:17 INFO - 2015-11-10 05:49:17,432 INFO : Browser initialized. 05:49:17 INFO - 2015-11-10 05:49:17,432 INFO : Running cycle 1/1 for kraken test... 05:49:17 INFO - 2015-11-10 05:49:17,433 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6SM5lx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:49:29 INFO - 2015-11-10 05:49:29,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 140541952 05:49:29 INFO - 2015-11-10 05:49:29,188 DEBUG : BROWSER_OUTPUT: 05:49:31 INFO - 2015-11-10 05:49:31,628 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36253/tests/kraken/driver.html?testName=audio-beat-detection) 05:49:32 INFO - 2015-11-10 05:49:32,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 181067776 05:49:32 INFO - 2015-11-10 05:49:32,217 DEBUG : BROWSER_OUTPUT: 05:49:34 INFO - 2015-11-10 05:49:34,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36253/tests/kraken/driver.html?testName=audio-dft) 05:49:35 INFO - 2015-11-10 05:49:35,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 170819584 05:49:35 INFO - 2015-11-10 05:49:35,353 DEBUG : BROWSER_OUTPUT: 05:49:38 INFO - 2015-11-10 05:49:38,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36253/tests/kraken/driver.html?testName=audio-fft) 05:49:38 INFO - 2015-11-10 05:49:38,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 151453696 05:49:38 INFO - 2015-11-10 05:49:38,762 DEBUG : BROWSER_OUTPUT: 05:49:40 INFO - 2015-11-10 05:49:40,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36253/tests/kraken/driver.html?testName=audio-oscillator) 05:49:41 INFO - 2015-11-10 05:49:41,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 153595904 05:49:41 INFO - 2015-11-10 05:49:41,299 DEBUG : BROWSER_OUTPUT: 05:49:43 INFO - 2015-11-10 05:49:43,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36253/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:49:44 INFO - 2015-11-10 05:49:44,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 156819456 05:49:44 INFO - 2015-11-10 05:49:44,026 DEBUG : BROWSER_OUTPUT: 05:49:46 INFO - 2015-11-10 05:49:46,929 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36253/tests/kraken/driver.html?testName=imaging-darkroom) 05:49:47 INFO - 2015-11-10 05:49:47,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 154865664 05:49:47 INFO - 2015-11-10 05:49:47,498 DEBUG : BROWSER_OUTPUT: 05:49:50 INFO - 2015-11-10 05:49:50,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36253/tests/kraken/driver.html?testName=imaging-desaturate) 05:49:51 INFO - 2015-11-10 05:49:51,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 155549696 05:49:51 INFO - 2015-11-10 05:49:51,486 DEBUG : BROWSER_OUTPUT: 05:49:54 INFO - 2015-11-10 05:49:54,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36253/tests/kraken/driver.html?testName=json-parse-financial) 05:49:54 INFO - 2015-11-10 05:49:54,845 DEBUG : BROWSER_OUTPUT: RSS: Main: 155549696 05:49:54 INFO - 2015-11-10 05:49:54,845 DEBUG : BROWSER_OUTPUT: 05:49:56 INFO - 2015-11-10 05:49:56,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36253/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:49:56 INFO - 2015-11-10 05:49:56,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 166916096 05:49:56 INFO - 2015-11-10 05:49:56,954 DEBUG : BROWSER_OUTPUT: 05:49:58 INFO - 2015-11-10 05:49:58,764 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36253/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:49:59 INFO - 2015-11-10 05:49:59,365 DEBUG : BROWSER_OUTPUT: RSS: Main: 164556800 05:49:59 INFO - 2015-11-10 05:49:59,365 DEBUG : BROWSER_OUTPUT: 05:50:01 INFO - 2015-11-10 05:50:01,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36253/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:50:02 INFO - 2015-11-10 05:50:02,013 DEBUG : BROWSER_OUTPUT: RSS: Main: 178429952 05:50:02 INFO - 2015-11-10 05:50:02,013 DEBUG : BROWSER_OUTPUT: 05:50:04 INFO - 2015-11-10 05:50:04,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:50:04 INFO - 2015-11-10 05:50:04,992 DEBUG : BROWSER_OUTPUT: RSS: Main: 188235776 05:50:04 INFO - 2015-11-10 05:50:04,993 DEBUG : BROWSER_OUTPUT: 05:50:07 INFO - 2015-11-10 05:50:07,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:50:08 INFO - 2015-11-10 05:50:08,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 185991168 05:50:08 INFO - 2015-11-10 05:50:08,081 DEBUG : BROWSER_OUTPUT: 05:50:09 INFO - 2015-11-10 05:50:09,714 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36253/tests/kraken/driver.html?testName=ai-astar) 05:50:09 INFO - 2015-11-10 05:50:09,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 246599680 05:50:09 INFO - 2015-11-10 05:50:09,961 DEBUG : BROWSER_OUTPUT: 05:50:09 INFO - 2015-11-10 05:50:09,962 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:50:09 INFO - 2015-11-10 05:50:09,962 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:50:09 INFO - 2015-11-10 05:50:09,963 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:50:09 INFO - 2015-11-10 05:50:09,963 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:50:09 INFO - 2015-11-10 05:50:09,963 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;104;109;109;111;100;110;110;108 05:50:09 INFO - 2015-11-10 05:50:09,963 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;124;149;166;126;155;146;123;162;123 05:50:09 INFO - 2015-11-10 05:50:09,964 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;160;160;161;161;162;160;161 05:50:09 INFO - 2015-11-10 05:50:09,964 DEBUG : BROWSER_OUTPUT: |3;audio-fft;69;71;84;95;73;71;70;129;91;71 05:50:09 INFO - 2015-11-10 05:50:09,964 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;138;93;91;89;131;89;90;139 05:50:09 INFO - 2015-11-10 05:50:09,964 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;109;109;109;109;110;109;109 05:50:09 INFO - 2015-11-10 05:50:09,965 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;145;145;145;145;145;146;144;146;145 05:50:09 INFO - 2015-11-10 05:50:09,965 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;95;96;96;97;97;96;95 05:50:09 INFO - 2015-11-10 05:50:09,965 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;56;56;56;56;57;57;63;54;53 05:50:09 INFO - 2015-11-10 05:50:09,966 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;68;68;67;67;67;67;67;67 05:50:09 INFO - 2015-11-10 05:50:09,966 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;85;85;86;92;92;86;85;85 05:50:09 INFO - 2015-11-10 05:50:09,966 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;112;118;125;119;109;117;126;112;120;114 05:50:09 INFO - 2015-11-10 05:50:09,966 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;145;142;148;144;149;147;143;142;134 05:50:09 INFO - 2015-11-10 05:50:09,967 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;65;65;64;65;64;63;64;66;65 05:50:09 INFO - 2015-11-10 05:50:09,967 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:50:09 INFO - 2015-11-10 05:50:09,967 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:50:09 INFO - 2015-11-10 05:50:09,967 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,948 05:50:09 INFO - 2015-11-10 05:50:09,968 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:50:09 INFO - 2015-11-10 05:50:09,968 DEBUG : BROWSER_OUTPUT: __startTimestamp1447163409961__endTimestamp 05:50:09 INFO - 2015-11-10 05:50:09,968 DEBUG : BROWSER_OUTPUT: 05:50:09 INFO - 2015-11-10 05:50:09,970 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:50:09 INFO - 2015-11-10 05:50:09,970 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:50:09 INFO - 2015-11-10 05:50:09,970 DEBUG : BROWSER_OUTPUT: 05:50:09 INFO - 2015-11-10 05:50:09,970 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.52 (3.2%) stddev-sans-first:3.67 05:50:09 INFO - 2015-11-10 05:50:09,970 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 104.0 109.0 109.0 111.0 100.0 110.0 110.0 108.0 05:50:09 INFO - 2015-11-10 05:50:09,970 DEBUG : BROWSER_OUTPUT: 05:50:09 INFO - 2015-11-10 05:50:09,970 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.30 Median:149.00 stddev:16.87 (11.3%) stddev-sans-first:17.71 05:50:09 INFO - 2015-11-10 05:50:09,971 DEBUG : BROWSER_OUTPUT: Values: 149.0 124.0 149.0 166.0 126.0 155.0 146.0 123.0 162.0 123.0 05:50:09 INFO - 2015-11-10 05:50:09,971 DEBUG : BROWSER_OUTPUT: 05:50:09 INFO - 2015-11-10 05:50:09,971 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 05:50:09 INFO - 2015-11-10 05:50:09,971 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 160.0 160.0 161.0 161.0 162.0 160.0 161.0 05:50:09 INFO - 2015-11-10 05:50:09,971 DEBUG : BROWSER_OUTPUT: 05:50:09 INFO - 2015-11-10 05:50:09,971 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.40 Median:72.00 stddev:18.91 (26.3%) stddev-sans-first:19.43 05:50:09 INFO - 2015-11-10 05:50:09,971 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 84.0 95.0 73.0 71.0 70.0 129.0 91.0 71.0 05:50:09 INFO - 2015-11-10 05:50:09,971 DEBUG : BROWSER_OUTPUT: 05:50:09 INFO - 2015-11-10 05:50:09,971 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.00 Median:90.00 stddev:22.21 (24.7%) stddev-sans-first:22.97 05:50:09 INFO - 2015-11-10 05:50:09,972 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 138.0 93.0 91.0 89.0 131.0 89.0 90.0 139.0 05:50:09 INFO - 2015-11-10 05:50:09,972 DEBUG : BROWSER_OUTPUT: 05:50:09 INFO - 2015-11-10 05:50:09,972 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 05:50:09 INFO - 2015-11-10 05:50:09,972 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 05:50:09 INFO - 2015-11-10 05:50:09,972 DEBUG : BROWSER_OUTPUT: 05:50:09 INFO - 2015-11-10 05:50:09,972 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.82 (0.6%) stddev-sans-first:0.60 05:50:09 INFO - 2015-11-10 05:50:09,972 DEBUG : BROWSER_OUTPUT: Values: 147.0 145.0 145.0 145.0 145.0 145.0 146.0 144.0 146.0 145.0 05:50:09 INFO - 2015-11-10 05:50:09,972 DEBUG : BROWSER_OUTPUT: 05:50:09 INFO - 2015-11-10 05:50:09,973 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 05:50:09 INFO - 2015-11-10 05:50:09,973 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 95.0 96.0 96.0 97.0 97.0 96.0 95.0 05:50:09 INFO - 2015-11-10 05:50:09,973 DEBUG : BROWSER_OUTPUT: 05:50:09 INFO - 2015-11-10 05:50:09,973 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:2.67 (4.8%) stddev-sans-first:2.79 05:50:09 INFO - 2015-11-10 05:50:09,973 DEBUG : BROWSER_OUTPUT: Values: 55.0 56.0 56.0 56.0 56.0 57.0 57.0 63.0 54.0 53.0 05:50:09 INFO - 2015-11-10 05:50:09,973 DEBUG : BROWSER_OUTPUT: 05:50:09 INFO - 2015-11-10 05:50:09,973 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 05:50:09 INFO - 2015-11-10 05:50:09,973 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 68.0 68.0 67.0 67.0 67.0 67.0 67.0 67.0 05:50:09 INFO - 2015-11-10 05:50:09,973 DEBUG : BROWSER_OUTPUT: 05:50:09 INFO - 2015-11-10 05:50:09,974 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:85.50 stddev:2.95 (3.5%) stddev-sans-first:2.99 05:50:09 INFO - 2015-11-10 05:50:09,974 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 85.0 85.0 86.0 92.0 92.0 86.0 85.0 85.0 05:50:09 INFO - 2015-11-10 05:50:09,974 DEBUG : BROWSER_OUTPUT: 05:50:09 INFO - 2015-11-10 05:50:09,974 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.20 Median:118.50 stddev:5.59 (4.7%) stddev-sans-first:5.61 05:50:09 INFO - 2015-11-10 05:50:09,974 DEBUG : BROWSER_OUTPUT: Values: 112.0 118.0 125.0 119.0 109.0 117.0 126.0 112.0 120.0 114.0 05:50:09 INFO - 2015-11-10 05:50:09,974 DEBUG : BROWSER_OUTPUT: 05:50:09 INFO - 2015-11-10 05:50:09,974 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:145.00 stddev:4.23 (2.9%) stddev-sans-first:4.47 05:50:09 INFO - 2015-11-10 05:50:09,974 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 142.0 148.0 144.0 149.0 147.0 143.0 142.0 134.0 05:50:09 INFO - 2015-11-10 05:50:09,974 DEBUG : BROWSER_OUTPUT: 05:50:09 INFO - 2015-11-10 05:50:09,975 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:0.95 (1.5%) stddev-sans-first:0.88 05:50:09 INFO - 2015-11-10 05:50:09,975 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 65.0 64.0 65.0 64.0 63.0 64.0 66.0 65.0 05:50:09 INFO - 2015-11-10 05:50:09,975 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:50:09 INFO - 2015-11-10 05:50:09,975 DEBUG : BROWSER_OUTPUT: 05:50:10 INFO - 2015-11-10 05:50:10,873 INFO : Browser exited with error code: 0 05:50:10 INFO - 2015-11-10 05:50:10,923 INFO : Completed test kraken (00:00:58) 05:50:10 INFO - 2015-11-10 05:50:10,923 INFO : Starting test v8_7 05:50:10 INFO - 2015-11-10 05:50:10,923 DEBUG : operating with platform_type : linux_ 05:50:10 INFO - 2015-11-10 05:50:10,923 INFO : Initialising browser for v8_7 test... 05:50:10 INFO - 2015-11-10 05:50:10,929 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8O1jcx/profile http://localhost:36253/getInfo.html 05:50:15 INFO - 2015-11-10 05:50:15,146 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:50:15 INFO - 2015-11-10 05:50:15,146 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:50:15 INFO - 2015-11-10 05:50:15,146 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:50:15 INFO - 2015-11-10 05:50:15,147 DEBUG : BROWSER_OUTPUT: __metrics 05:50:15 INFO - 2015-11-10 05:50:15,349 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:50:16 INFO - 2015-11-10 05:50:16,700 INFO : Browser initialized. 05:50:16 INFO - 2015-11-10 05:50:16,700 INFO : Running cycle 1/1 for v8_7 test... 05:50:16 INFO - 2015-11-10 05:50:16,701 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8O1jcx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:50:28 INFO - 2015-11-10 05:50:28,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 139726848 05:50:28 INFO - 2015-11-10 05:50:28,449 DEBUG : BROWSER_OUTPUT: 05:50:49 INFO - 2015-11-10 05:50:49,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36253/tests/v8_7/run.html (next: http://localhost:36253/tests/v8_7/run.html) 05:50:50 INFO - 2015-11-10 05:50:50,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 618024960 05:50:50 INFO - 2015-11-10 05:50:50,147 DEBUG : BROWSER_OUTPUT: 05:50:50 INFO - 2015-11-10 05:50:50,147 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:50:50 INFO - 2015-11-10 05:50:50,147 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:50:50 INFO - 2015-11-10 05:50:50,147 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:50:50 INFO - 2015-11-10 05:50:50,147 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:50:50 INFO - 2015-11-10 05:50:50,147 DEBUG : BROWSER_OUTPUT: |0;Richards;170.590242238144 05:50:50 INFO - 2015-11-10 05:50:50,147 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.7608990505716 05:50:50 INFO - 2015-11-10 05:50:50,147 DEBUG : BROWSER_OUTPUT: |2;Encrypt;286.20492272467084 05:50:50 INFO - 2015-11-10 05:50:50,147 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 05:50:50 INFO - 2015-11-10 05:50:50,147 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1108.6474501108648 05:50:50 INFO - 2015-11-10 05:50:50,148 DEBUG : BROWSER_OUTPUT: |5;Earley;794.2811755361398 05:50:50 INFO - 2015-11-10 05:50:50,148 DEBUG : BROWSER_OUTPUT: |6;Boyer;11662.790697674418 05:50:50 INFO - 2015-11-10 05:50:50,148 DEBUG : BROWSER_OUTPUT: |7;RegExp;26128.20512820513 05:50:50 INFO - 2015-11-10 05:50:50,148 DEBUG : BROWSER_OUTPUT: |8;Splay;641.025641025641 05:50:50 INFO - 2015-11-10 05:50:50,148 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 05:50:50 INFO - 2015-11-10 05:50:50,148 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:50:50 INFO - 2015-11-10 05:50:50,148 DEBUG : BROWSER_OUTPUT: __startTimestamp1447163450144__endTimestamp 05:50:50 INFO - 2015-11-10 05:50:50,148 DEBUG : BROWSER_OUTPUT: 05:50:50 INFO - 2015-11-10 05:50:50,148 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:50:50 INFO - 2015-11-10 05:50:50,148 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:50:50 INFO - 2015-11-10 05:50:50,148 DEBUG : BROWSER_OUTPUT: 05:50:50 INFO - 2015-11-10 05:50:50,148 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.59 Median:170.59 stddev:0.00 (0.0%) 05:50:50 INFO - 2015-11-10 05:50:50,148 DEBUG : BROWSER_OUTPUT: Values: 170.6 05:50:50 INFO - 2015-11-10 05:50:50,148 DEBUG : BROWSER_OUTPUT: 05:50:50 INFO - 2015-11-10 05:50:50,148 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.76 Median:193.76 stddev:0.00 (0.0%) 05:50:50 INFO - 2015-11-10 05:50:50,149 DEBUG : BROWSER_OUTPUT: Values: 193.8 05:50:50 INFO - 2015-11-10 05:50:50,149 DEBUG : BROWSER_OUTPUT: 05:50:50 INFO - 2015-11-10 05:50:50,149 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:286.20 Median:286.20 stddev:0.00 (0.0%) 05:50:50 INFO - 2015-11-10 05:50:50,149 DEBUG : BROWSER_OUTPUT: Values: 286.2 05:50:50 INFO - 2015-11-10 05:50:50,149 DEBUG : BROWSER_OUTPUT: 05:50:50 INFO - 2015-11-10 05:50:50,149 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 05:50:50 INFO - 2015-11-10 05:50:50,149 DEBUG : BROWSER_OUTPUT: Values: 5035.2 05:50:50 INFO - 2015-11-10 05:50:50,149 DEBUG : BROWSER_OUTPUT: 05:50:50 INFO - 2015-11-10 05:50:50,149 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1108.65 Median:1108.65 stddev:0.00 (0.0%) 05:50:50 INFO - 2015-11-10 05:50:50,150 DEBUG : BROWSER_OUTPUT: Values: 1108.6 05:50:50 INFO - 2015-11-10 05:50:50,150 DEBUG : BROWSER_OUTPUT: 05:50:50 INFO - 2015-11-10 05:50:50,150 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 05:50:50 INFO - 2015-11-10 05:50:50,150 DEBUG : BROWSER_OUTPUT: Values: 794.3 05:50:50 INFO - 2015-11-10 05:50:50,150 DEBUG : BROWSER_OUTPUT: 05:50:50 INFO - 2015-11-10 05:50:50,150 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11662.79 Median:11662.79 stddev:0.00 (0.0%) 05:50:50 INFO - 2015-11-10 05:50:50,150 DEBUG : BROWSER_OUTPUT: Values: 11662.8 05:50:50 INFO - 2015-11-10 05:50:50,151 DEBUG : BROWSER_OUTPUT: 05:50:50 INFO - 2015-11-10 05:50:50,151 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26128.21 Median:26128.21 stddev:0.00 (0.0%) 05:50:50 INFO - 2015-11-10 05:50:50,151 DEBUG : BROWSER_OUTPUT: Values: 26128.2 05:50:50 INFO - 2015-11-10 05:50:50,151 DEBUG : BROWSER_OUTPUT: 05:50:50 INFO - 2015-11-10 05:50:50,151 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:641.03 Median:641.03 stddev:0.00 (0.0%) 05:50:50 INFO - 2015-11-10 05:50:50,151 DEBUG : BROWSER_OUTPUT: Values: 641.0 05:50:50 INFO - 2015-11-10 05:50:50,151 DEBUG : BROWSER_OUTPUT: 05:50:50 INFO - 2015-11-10 05:50:50,152 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 05:50:50 INFO - 2015-11-10 05:50:50,152 DEBUG : BROWSER_OUTPUT: Values: 4817.3 05:50:50 INFO - 2015-11-10 05:50:50,152 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:50:50 INFO - 2015-11-10 05:50:50,152 DEBUG : BROWSER_OUTPUT: 05:50:51 INFO - 2015-11-10 05:50:51,029 INFO : Browser exited with error code: 0 05:50:51 INFO - 2015-11-10 05:50:51,046 INFO : Completed test v8_7 (00:00:40) 05:50:51 INFO - 2015-11-10 05:50:51,099 INFO : Completed test suite (00:20:13) 05:50:51 INFO - 2015-11-10 05:50:51,099 DEBUG : Working with test: dromaeo_css 05:50:51 INFO - 2015-11-10 05:50:51,099 DEBUG : Generating results file: dromaeo_css 05:50:51 INFO - 2015-11-10 05:50:51,101 DEBUG : Working with test: kraken 05:50:51 INFO - 2015-11-10 05:50:51,101 DEBUG : Generating results file: kraken 05:50:51 INFO - 2015-11-10 05:50:51,101 INFO : javascript benchmark 05:50:51 INFO - 2015-11-10 05:50:51,101 DEBUG : Working with test: v8_7 05:50:51 INFO - 2015-11-10 05:50:51,101 DEBUG : Generating results file: v8_7 05:50:51 INFO - 2015-11-10 05:50:51,102 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:50:51 INFO - 2015-11-10 05:50:51,236 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 05:50:51 INFO - 2015-11-10 05:50:51,236 DEBUG : process_Request line: dromaeo_css 6598.02 graph.html#tests=[[72,63,35]] 05:50:51 INFO - 2015-11-10 05:50:51,236 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:50:51 INFO - 2015-11-10 05:50:51,355 DEBUG : process_Request line: kraken 1483.90 graph.html#tests=[[232,63,35]] 05:50:51 INFO - 2015-11-10 05:50:51,355 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:50:51 INFO - 2015-11-10 05:50:51,386 DEBUG : process_Request line: v8_7 20883.58 graph.html#tests=[[230,63,35]] 05:50:51 INFO - 2015-11-10 05:50:51,387 INFO : javascript benchmark 05:50:51 INFO - 2015-11-10 05:50:51,391 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [327.7427219632589, 328.8388689542125, 329.89156434380493, 335.5922554096772, 336.0623859432184, 13887.166769993808, 14374.712505749878, 16916.91541542292, 17093.23080461379, 17941.820581794178, 14589.12465252083, 14594.927025364885, 14626.853731462683, 14640.926795366035, 14684.779728304084, 5369.812056578011, 5435.402105768362, 5523.6685798851995, 5526.806561770339, 5531.142672885689, 3776.055986003499, 3880.708946828985, 5497.615166938316, 5916.5266778657815, 6093.756249750005, 5986.8802623947495, 6010.1585777990895, 6015.398460153993, 6018.60879042863, 6044.274687037561, 5540.722963851791, 5584.106542953108, 5585.078462053756, 5585.8603534911545, 5586.469285417919, 5176.378834539879, 5236.685798852043, 5236.7905283788605, 5240.52835244826, 5244.449332820037, 11438.885611143865, 12778.424970876333, 12996.350182490933, 13368.933155334258, 13377.0, 1767.5050985724017, 1861.6941716108981, 1863.6272745450965, 1871.1766822598013, 1890.139986306241, 9971.501424928798, 10076.647317343857, 10080.092791648787, 10103.0, 10221.846672299922, 1661.1777170300659, 1664.0847533856331, 1683.309842964391, 1691.8815682902202, 1696.151924037981, 56204.43795562033, 56933.71533142349, 57186.14220786691, 57697.423025769625, 61367.38632613706, 6828.453723702092, 6838.452923766087, 6851.0, 6937.895931561031, 6979.267176946449, 8249.422540422112, 8252.0, 8267.793305167299, 8268.958655206685, 8272.420930534925, 4991.450940396553, 5003.524665156804, 5016.021875734197, 5061.367329083864, 5083.2375143727995, 4903.313536104948, 4925.482824303468, 4938.160512712776, 4945.629077819178, 4948.0, 3183.3315003849452, 3217.790843595206, 3234.450143475615, 3238.562794022777, 3239.530268111158, 1081.3944191252924, 1125.1336470917347, 1126.571902676994, 1149.040551139791, 1184.1296646964474, 420.968626864184, 434.8543238015237, 437.0494175168995, 444.7776111944028, 456.9246074397687, 10301.9484902575, 11548.59579914699, 11672.88327116735, 11761.294322340687, 12203.633890983285, 447.16603534408097, 449.0905915521096, 459.967802253839, 461.91916414627303, 472.9996058336662, 6416.32628573993, 6502.934970650233, 6557.2131344239, 6562.343765623495, 6653.2681405045405, 518734.0, 520502.0, 521028.0, 523265.0, 523306.0, 73486.63256683682, 77101.22898771052, 79214.60392698, 79615.60192199002, 80176.0, 411.1653343712269, 421.55947035348134, 422.5478737750577, 423.45585922090584, 423.4770058977222, 9825.9017409825, 9867.16129129032, 9952.850707239253, 9957.302988790716, 10093.293469457361, 34337.0, 34445.65554344424, 34816.47775283423, 35152.12119697028, 35487.82256088703, 47843.76078119587, 48908.51091489182, 50083.0, 50807.74596126996, 51010.74494627503, 7999.320057795153, 8079.394045446497, 8275.213854683796, 8284.46151000183, 8381.287590554872, 11870.050395968474, 12014.579489717818, 12083.275003499819, 12093.879061209274, 12179.391030448265, 10608.840867387149, 10679.252452328263, 10738.302010369302, 10852.891471085188, 10866.07638350749, 10452.529636166239, 10561.155107591221, 10647.520861561094, 10649.840252396065, 10703.250772445854, 9223.953880230556, 9659.71020869375, 10869.945650271698, 10890.29213101146, 10949.56201751921, 7874.448788584744, 8235.711750088958, 8325.666973321, 8383.035950865484, 8384.161583841567, 10381.896181038093, 10492.632757853438, 10681.89318106809, 10818.891811082103, 10821.783564328827], "dojo.html": [3175.190326466751, 3210.518422236663, 3249.5288183213434, 3262.820544870033, 3276.115448828816, 5255.684658920468, 5362.35651721794, 5375.408705042447, 5401.810936617214, 5449.100898351772, 5417.810376636819, 5437.619366644337, 5439.156930675742, 5461.044317244487, 5473.397926228112, 4934.925976110361, 5010.4739002404585, 5017.523335283151, 5188.740562971836, 5199.272101905736, 4812.446568644598, 5114.846554603368, 5143.074246635604, 5172.146595811687, 5215.217717342391, 4892.461829198785, 4980.850574482772, 5060.316857224301, 5074.619403544712, 5121.206213036985, 4946.480619534969, 4950.4059512858685, 4962.87592810179, 4984.0, 4994.126027945095, 4781.115493633689, 4893.657443978923, 4953.479884612136, 4972.129877271499, 5031.396232452093, 5234.214867769827, 5336.626436149471, 5341.732913354355, 5348.224507446437, 5350.759215835296, 5900.852478688067, 5909.645421274738, 5915.112733090028, 5917.408259174092, 5963.850903727398, 5733.942660573424, 5809.070548712228, 5860.472557469848, 5928.614640048426, 5934.139549765303, 5430.076886929192, 5439.129739241703, 5442.2380866678695, 5475.589330800166, 5621.606487545873, 5895.4399332063385, 5898.970505147447, 5899.262592175978, 5905.881882362329, 5943.524518038546, 5613.158026296088, 5726.570507211975, 5766.452187042224, 5834.445727655866, 5965.492933100648, 6012.699365031818, 6013.759449622054, 6018.21763170785, 6021.909671354933, 6029.638221706711, 5951.077582974646, 5966.373530779206, 5969.194158788595, 5973.0, 5998.070299103646, 5715.199872017921, 5845.1232315153065, 5848.736806843703, 5934.37689042653, 5984.431479009487, 4536.342230376643, 4539.977300113478, 4540.88647783808, 4543.636509079266, 4575.611073058827, 3892.2020985697864, 4043.696722745806, 4046.615571520701, 4060.167665628539, 4090.611391917763, 5498.037843377393, 5504.504594586507, 5532.7786888524815, 5584.5811564132855, 5597.80407685729, 5893.174955506232, 5895.29256489224, 5899.203607512931, 5900.586958912835, 5911.852203694942, 5339.199120131933, 5451.3458384994055, 5558.610897237155, 5559.944400555943, 5568.025595520849, 5065.6200784941275, 5117.053345131163, 5135.075686376488, 5136.691798492027, 5178.0420622184265, 6074.119252708332, 6080.8783824324155, 6082.60463069899, 6093.421124993119, 6121.602095863755, 5643.1535269709875, 5743.224664670383, 5886.823395298148, 5901.881962360643, 5943.346231914399, 6088.799964253613, 6090.254001114731, 6095.067532273641, 6105.178419689978, 6129.8467538310115, 5789.768409263583, 5790.044642633919, 5791.652500849962, 5794.5364370851075, 5859.2382990211, 5745.569082318759, 5838.854028649318, 5848.356680765028, 5865.94134058654, 5954.166416701752, 5766.798162064308, 5793.710314484343, 5800.477956983892, 5805.8548536286935, 5809.82570522885, 5789.305283366023, 5794.072948328248, 5795.82612521625, 5802.303723553201, 5805.042168042226, 5506.476884695948, 5605.299337582802, 5637.295338082739, 5666.03677374839, 5712.028955077563, 5771.884562308646, 5781.595288329945, 5812.622179558315, 5812.796552120655, 5833.300003999547, 5467.07059799843, 5693.0, 5697.971510142423, 5701.315842098975, 5702.857428564153], "mootools.html": [1098.4233277529302, 1364.16785760686, 1420.0982376191118, 1510.131674287285, 1731.2469075951954, 6609.801705948823, 7265.382442492388, 7468.589227592493, 7474.028376311072, 7478.0, 7034.648267586613, 7180.784576462702, 7182.676779544933, 7224.783256502314, 7225.205227424979, 1941.9417417477498, 1989.214260367154, 2159.6544552871505, 2177.6406892862738, 2211.0824008036648, 2248.741394739601, 2249.2352600115955, 2253.4028482452163, 2255.402318385621, 2256.593813113639, 2185.912563497458, 2215.435064058671, 2254.729432468106, 2255.3684968208845, 2256.4020534558354, 1891.5933074389004, 1920.1167462967053, 2142.8071473567375, 2201.4936564590075, 2203.6143674856994, 2208.0, 2209.602271591113, 2243.596152692515, 2247.011315021385, 2257.8193744500563, 7511.924880751232, 7572.4320675948975, 7586.886196707053, 7587.393008559302, 7592.924070759277, 4384.978075109604, 4431.689781715281, 4448.421705178306, 4466.665000125004, 4470.0, 2991.1774262077884, 2991.311998240395, 2997.8201307921595, 3018.5623084652602, 3129.640091389474, 966.1932286540676, 969.5540051576284, 970.9174720148795, 1007.3603261928655, 1045.9947700261525, 9669.226461883032, 9685.564149613285, 9692.612295508172, 9694.079062489052, 9699.0, 3936.9015774605864, 3963.147923196527, 4005.1388951375593, 4094.549599544048, 4145.709800313949, 8435.409521333571, 8453.577321133918, 8456.577171141418, 8460.111688272766, 8463.153684631488, 4362.716423432466, 4369.2790689536505, 4373.278409062533, 4377.058932329501, 4377.890552736207, 4020.396940458896, 4025.798710064485, 4033.0119120815, 4039.1921615676983, 4039.8586049488126, 3676.963230367662, 3746.606606306353, 3748.0, 3767.453719210699, 3780.432935059763, 1203.8435003449495, 1218.250775772911, 1223.3271700564653, 1233.0333118675699, 1234.493857518431, 907.8275127725711, 1254.140913474273, 1261.8422697162855, 1291.12203701482, 1291.838520184977, 6531.804045878631, 6660.800175994728, 6932.688029038705, 6933.5493192942295, 6935.930640693528, 613.8741557980603, 621.7046902721171, 627.5920651576512, 680.5950459476603, 680.6120511308606, 5581.441855814386, 5685.545156387479, 5714.028615135437, 5720.599558030981, 5724.4561766632105, 8595.398322117391, 8726.738197854074, 8727.258183054511, 8729.694460693845, 8752.387332886765, 8405.495670259805, 8627.482351058956, 8755.649774008969, 8768.78078048054, 8769.473831570127, 6603.075569420285, 6666.633335166515, 6672.599644021374, 6677.065210870482, 6683.064370988066, 6546.705398257185, 6560.179977502812, 6601.108850305147, 6642.368974947372, 6652.467802575879, 7721.073471183494, 7833.020872390951, 7856.921430785619, 7863.646135924012, 7878.251566101211, 7849.568273744999, 8042.195780421911, 8054.114047454893, 8055.959720201596, 8074.3944204183745, 6546.18172728409, 6605.504587156079, 6605.933940660532, 6613.636250006296, 6621.106150669791, 7073.646317684198, 7146.606936618536, 7161.6061116637, 7188.856222875618, 7194.064771579661, 6809.080774095433, 6834.2140653825445, 6848.1097457330225, 6859.279775623687, 6915.757948471779, 6440.581362211441, 6492.253390859923, 6504.0243963405865, 6514.54398192122, 6542.509311801538, 6017.18767966319, 6137.7851775187655, 6747.257801641914, 6863.176418829573, 6895.275996020547, 6182.350853160354, 6271.560990730605, 6303.086052522451, 6313.589616674902, 6314.968425157845, 6302.464290535172, 6348.93651063502, 6356.396142366468, 6360.427561519486, 6363.204599425072], "ext.html": [542.6174546944404, 550.5898105911097, 551.0373770620853, 590.2474345209858, 595.5265563876718, 30053.699463005392, 39194.804025979865, 39860.40209396854, 39883.40174897375, 39893.0, 42162.578374216246, 42478.0, 42658.78670606643, 42706.0, 42831.0, 7447.590382528959, 7535.058117735283, 8687.826243475127, 8858.512781796999, 8864.778380540505, 10346.224033197503, 10435.373877567332, 10620.681379558626, 10620.946895265513, 10623.57505699775, 10097.646582369618, 10116.0, 10202.693919182437, 10213.693589192337, 10220.437875916821, 7377.077865266869, 7510.061242344707, 10100.696979090639, 10301.175905927545, 10304.536295866705, 9969.0, 10081.790185177826, 10086.79826403475, 10090.34412763168, 10090.64682736108, 26518.337041573923, 36333.0, 36708.26583468316, 36830.8158459206, 36874.81562592197, 2476.232367965936, 2548.7706106450323, 3054.6639869614323, 3064.5096784514594, 3106.8038805060214, 29980.250493737614, 30292.54561181584, 30509.847450762827, 30673.233169170726, 30831.229219269473, 3028.37918226763, 3033.59046528718, 3098.3183699586057, 3109.5024796032526, 3121.2352973521633, 292402.0, 292617.0, 294638.0, 295820.0, 296180.0, 59616.70191649014, 59780.70109649511, 59959.40040599625, 59974.0, 60226.69886650539, 61025.38974610286, 61305.0, 61330.69334653298, 61343.38656613466, 61522.38477615256, 11906.702332441586, 12011.099167562294, 12022.338771367484, 12037.157398982163, 12044.759104817855, 9719.368241064309, 9780.55987480565, 9812.0, 9815.36200146988, 9817.754556136153, 18963.81036189648, 19870.0, 20003.299884503973, 20009.899455529794, 20023.699644505345, 7625.923740762632, 7664.65509052094, 7745.690172393041, 7807.882881756778, 7817.0, 746.4438992950287, 836.4855613797471, 944.3483996042709, 945.9716208513618, 947.976300592477, 26763.598546021825, 27384.315392115357, 27884.442311153663, 27977.580336294974, 28186.2953426166, 902.634433054614, 936.8875734911718, 981.646607221414, 992.3648864726581, 1004.5379125602304, 13504.864951350557, 14838.554843354717, 14885.181315027778, 15120.092794432368, 15278.541643750705, 396287.0, 400233.0, 402537.0, 403890.0, 403936.0, 45017.324740128926, 45153.32270015952, 45346.31980520295, 45380.54619453829, 45549.54450455519, 1079.3901445683164, 1087.2497976396262, 1100.2353364411817, 1102.0742576236, 1178.4991378664033, 27831.582526261718, 28471.572926405704, 28580.714192857806, 28923.710762892944, 29014.419711605227, 45597.77201113973, 46151.3077303834, 46193.30710039285, 46275.3058704113, 46278.76860615675, 341603.0, 341642.0, 343839.0, 344404.0, 344544.0, 27566.310842229104, 27975.0, 31211.219719507193, 31264.374712505167, 32880.1779955503, 40712.0, 42402.363964541175, 47331.526684732715, 48845.77885552889, 49124.50875491199, 36813.0, 36826.63173368232, 37157.0, 39870.80064599658, 40839.7958010208, 36763.63236367709, 37388.25223495569, 37421.43867842039, 37642.05894852651, 37775.62224377721, 33952.320953580296, 34597.30805383828, 36844.63155368519, 37935.24129517449, 38774.80612596919, 32383.676163238066, 33492.49761253534, 33648.49527257044, 33736.831315843265, 33911.66088339085, 25634.487310254062, 25644.358891027874, 25678.0, 25792.09727659523, 25982.870085650207], "prototype.html": [306.13669452144944, 323.51957343345134, 328.4695217224182, 328.92605642577007, 330.0971842012095, 5762.683052432115, 5858.941410585893, 5870.61840980336, 5874.530037596993, 5882.294124705036, 5688.033034384154, 5762.078067509199, 5780.913286300709, 5807.8257652270395, 5809.593328467009, 4457.977710111461, 4460.107978404316, 4461.39771130898, 4468.977655111737, 4478.619317358029, 4361.629261512775, 4422.535633758457, 4454.910901781963, 4464.374987501752, 4530.886727831814, 4454.844080457185, 4458.9967257367, 4476.843310484133, 4493.168763778695, 4494.1910456117885, 4462.598366147063, 4462.839661687968, 4464.508904020571, 4472.642188624902, 4473.709208901411, 3932.1152740633415, 3935.232629637222, 3941.684665226775, 3942.3889297158985, 3947.210557888405, 5416.620836541444, 5507.531859791922, 5514.80698175566, 5535.086710692731, 5537.723113844332, 5105.157648987913, 5105.897882042375, 5114.590832733373, 5117.309163262949, 5117.48825117489, 5910.7931222407005, 6143.600665956743, 6148.631082135086, 6149.754009839601, 6152.72312745923, 4093.3655283431117, 4125.876223713293, 4135.441715368417, 4139.482564679415, 4140.523839758436, 6261.686915654199, 6344.175257216532, 6347.682615869234, 6350.936490635081, 6352.80941571749, 4339.479262488521, 4340.327249276304, 4341.34879768031, 4343.305071188594, 4344.152890186383, 4291.570842915746, 4391.60475557195, 4391.6486681065435, 4392.494863090786, 4410.867673969786, 5078.898422031539, 5080.085584594808, 5080.263361812516, 5084.49155084496, 5085.567726743268, 6054.485368743618, 6072.635641861414, 6073.696315184223, 6083.726232319556, 6114.908276375858, 1537.4311504743093, 1537.592537977437, 1539.692061587687, 1541.599184212113, 1542.0362273579012, 1030.3920686794677, 1043.1133536494071, 1046.1839764983324, 1068.257560995101, 1068.551208492435, 5996.430339117776, 6017.217761690952, 6033.155358249848, 6033.276006879115, 6038.879222415527, 6401.679916004181, 6409.327020662857, 6409.487241020707, 6412.967935160387, 6416.486681065504, 6017.849553761191, 6028.577999540078, 6028.879422411527, 6034.366391528826, 6037.154798328237, 3515.6835884770494, 3554.804485753308, 3567.839447224881, 3574.1779390740276, 3585.6055833858254, 6659.300773418819, 6665.066890635315, 6665.366790154928, 6669.433098186709, 6677.332266773284, 6503.739850406026, 6512.869742605121, 6519.348065193538, 6530.771423000172, 6534.869302613921, 6486.383793539606, 6638.103855979381, 6649.401553860176, 6650.401463868275, 6739.831504212336, 6213.37866213375, 6292.182016337847, 6480.384363485461, 6490.675466226764, 6491.7403303869205, 6267.467265282502, 6336.873262534816, 6344.873102538016, 6359.20509936258, 6364.586301890362, 6556.213254409311, 6621.735130594722, 6630.9668451657435, 6634.402903738686, 6634.5024123191915, 4197.706160568731, 4280.571942805695, 4313.029568347222, 4330.761808100585, 4333.956660433355, 6426.196725409324, 6430.967845160744, 6442.2591401989375, 6461.256955449995, 6464.967675161594, 6292.779752708633, 6298.307186209605, 6307.558470906993, 6312.5581209314905, 6319.778807741707, 6157.692115394123, 6285.402886725754, 6292.874142517216, 6299.464545513682, 6309.148264984352, 6131.356207598138, 6139.29398119222, 6148.354422785543, 6149.938500614937, 6155.630662160284, 6252.09344645033, 6254.437100660963, 6259.937400625936, 6263.248410190807, 6263.718132684131, 6022.427869352405, 6118.388161184024, 6119.84700382494, 6121.663308518075, 6121.693915304128], "yui.html": [715.5170260074452, 720.8990741296218, 726.6838925067593, 728.9343959043687, 745.5750222373249, 13079.54221602244, 13407.664808379772, 13415.195088294697, 13425.395857186426, 13446.126001809875, 12967.481300747959, 13482.325883705824, 13531.661708457294, 13537.255450950219, 13540.322983850818, 648.9286178520359, 661.3882159002903, 776.4991580430619, 777.4518964130289, 794.9006374203225, 790.3005839831761, 796.1799346672907, 800.4996876951905, 801.2308184143201, 802.0, 824.8020475085966, 835.7826964989085, 836.7447928381841, 837.2004735477605, 837.7403005068448, 667.2026927821231, 681.8840797064486, 805.8227190018187, 822.596927505518, 824.6742536698031, 604.2386592892942, 605.794030029792, 607.4957785038407, 607.6931149769338, 607.6931149769382, 13384.464621415133, 13469.86530134696, 13526.256055916921, 13539.458421663121, 13564.186148831002, 11651.825222621668, 12116.151869369147, 12560.560380386643, 12639.684007899785, 12668.049896257817, 9519.476428796414, 9574.0, 9616.951915240448, 9676.17752491039, 9961.551730172087, 3459.187091033605, 3482.8432720527635, 3505.1762835733584, 3512.6311737267474, 3527.7354198434964, 48932.75533622345, 49053.50946490525, 49286.50713492891, 49342.50657493415, 49617.0, 9524.761880952892, 9807.411555306704, 9891.258155638356, 9958.950205248928, 10066.798664026825, 18157.36449224271, 18159.63680726378, 18161.36435224787, 18170.54573635643, 18173.182206800724, 7472.14070381913, 7549.0, 7634.274743899321, 7647.770566883002, 7649.732259370895, 4293.034067334887, 4300.591443812833, 4310.892227694333, 4316.395704601358, 4418.469783625921, 2843.24653966699, 2882.077735124782, 2882.106546970446, 2885.2786803299177, 2886.696896825803, 435.2969953525097, 436.559075333915, 440.1175642836157, 444.1849206705731, 449.47860481840905, 497.9502049794992, 516.6022162934595, 573.2347316332742, 586.5249148189895, 664.5016237821634, 8652.95673521641, 8721.738347849574, 8783.604737786814, 9043.095690430904, 9152.771180720536, 522.725569076238, 572.2103497173956, 609.2688773471851, 634.2800920954658, 643.6009674002055, 3595.6224596417, 3751.1372384351207, 3949.960500395017, 3978.8806335809973, 4045.4134150548007, 61574.38425615687, 62527.0, 62578.687106564175, 62602.0, 62724.372756271856, 52641.736791316565, 54537.72731136398, 54786.45213547813, 54806.177907331425, 55028.174577381375, 47573.76213118982, 48033.27950080752, 48040.27939580909, 48400.0, 49497.75251123794, 7692.230776922263, 7709.190534993969, 7725.961370193113, 7763.961180194063, 7963.641636126504, 35701.82149089238, 35980.820095899355, 36484.08789780277, 37315.81342093272, 37633.43549846809, 47096.529034709216, 48635.0, 48843.75578122087, 49004.0, 49530.75234623804, 7536.0956685198125, 7583.0, 7633.160352361347, 7727.49771264866, 7945.324647404804, 10307.896921030693, 10846.620368287387, 11951.22317049389, 12201.816972745239, 12437.37813109359, 11115.11079113685, 11194.720131996764, 11331.886681133083, 11404.714882128013, 11652.53389864396, 11130.833037504606, 11257.155713321697, 11276.436178191221, 11366.829497557377, 11646.767064658829, 10762.192835537522, 11111.38887361203, 11206.215564910704, 11309.321440713584, 11423.0, 9291.117343852324, 9386.718398447785, 9436.433813971184, 9468.431894086378, 9644.565994530403, 8475.788105297417, 8747.60635771379, 8864.867026994729, 8893.911060889308, 8943.731688049369]}, "summary": {"lowerIsBetter": false, "suite": 6598.013370709189, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6951.288853482398, "unit": "ms", "value": 6951.288853482398}, "dojo.html": {"lowerIsBetter": false, "filtered": 5421.3877330989435, "unit": "ms", "value": 5421.3877330989435}, "mootools.html": {"lowerIsBetter": false, "filtered": 4222.826501871488, "unit": "ms", "value": 4222.826501871488}, "ext.html": {"lowerIsBetter": false, "filtered": 18264.88734968145, "unit": "ms", "value": 18264.88734968145}, "prototype.html": {"lowerIsBetter": false, "filtered": 4665.005006723572, "unit": "ms", "value": 4665.005006723572}, "yui.html": {"lowerIsBetter": false, "filtered": 6084.042654402134, "unit": "ms", "value": 6084.042654402134}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-038"}, "testrun": {"date": 1447162237, "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": "20151110043005", "branch": "Mozilla-Inbound", "revision": "7ae90a04b0fd9ed59c96fb60f1b8da0ddb0cbf93"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 161.0, 160.0, 160.0, 160.0, 161.0, 161.0, 162.0, 160.0, 161.0], "ai-astar": [110.0, 111.0, 104.0, 109.0, 109.0, 111.0, 100.0, 110.0, 110.0, 108.0], "imaging-gaussian-blur": [110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "audio-beat-detection": [149.0, 124.0, 149.0, 166.0, 126.0, 155.0, 146.0, 123.0, 162.0, 123.0], "json-stringify-tinderbox": [67.0, 67.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0], "stanford-crypto-pbkdf2": [145.0, 145.0, 142.0, 148.0, 144.0, 149.0, 147.0, 143.0, 142.0, 134.0], "json-parse-financial": [55.0, 56.0, 56.0, 56.0, 56.0, 57.0, 57.0, 63.0, 54.0, 53.0], "stanford-crypto-sha256-iterative": [66.0, 65.0, 65.0, 64.0, 65.0, 64.0, 63.0, 64.0, 66.0, 65.0], "audio-fft": [69.0, 71.0, 84.0, 95.0, 73.0, 71.0, 70.0, 129.0, 91.0, 71.0], "imaging-darkroom": [147.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 144.0, 146.0, 145.0], "stanford-crypto-ccm": [112.0, 118.0, 125.0, 119.0, 109.0, 117.0, 126.0, 112.0, 120.0, 114.0], "audio-oscillator": [90.0, 90.0, 138.0, 93.0, 91.0, 89.0, 131.0, 89.0, 90.0, 139.0], "stanford-crypto-aes": [84.0, 85.0, 85.0, 85.0, 86.0, 92.0, 92.0, 86.0, 85.0, 85.0], "imaging-desaturate": [96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 97.0, 97.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1483.9, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 82.4, "unit": "ms", "value": 82.4}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 143.9, "unit": "ms", "value": 143.9}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 142.3, "unit": "ms", "value": 142.3}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 117.2, "unit": "ms", "value": 117.2}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.3, "unit": "ms", "value": 145.3}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 56.3, "unit": "ms", "value": 56.3}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.0, "unit": "ms", "value": 104.0}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.2, "unit": "ms", "value": 108.2}, "audio-dft": {"lowerIsBetter": true, "filtered": 160.7, "unit": "ms", "value": 160.7}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 64.7, "unit": "ms", "value": 64.7}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 67.2, "unit": "ms", "value": 67.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.3, "unit": "ms", "value": 109.3}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.5, "unit": "ms", "value": 86.5}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.9, "unit": "ms", "value": 95.9}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-038"}, "testrun": {"date": 1447162237, "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": "20151110043005", "branch": "Mozilla-Inbound", "revision": "7ae90a04b0fd9ed59c96fb60f1b8da0ddb0cbf93"}}, {"talos_counters": {}, "results": {"DeltaBlue": [193.7608990505716], "Encrypt": [286.20492272467084], "NavierStokes": [4817.307692307692], "Decrypt": [5035.175879396985], "Splay": [641.025641025641], "Richards": [170.590242238144], "RegExp": [26128.20512820513], "Earley": [794.2811755361398], "Boyer": [11662.790697674418], "RayTrace": [1108.6474501108648]}, "summary": {"lowerIsBetter": false, "suite": 20883.58162265469, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 341.234998, "unit": "score", "value": 341.234998}, "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.864290419161705, "unit": "score", "value": 52.864290419161705}, "Splay": {"lowerIsBetter": false, "filtered": 127.12596000000005, "unit": "score", "value": 127.12596000000005}, "RegExp": {"lowerIsBetter": false, "filtered": 34.86596172718352, "unit": "score", "value": 34.86596172718352}, "Richards": {"lowerIsBetter": false, "filtered": 206.940324, "unit": "score", "value": 206.940324}, "Earley": {"lowerIsBetter": false, "filtered": 839.0769169999999, "unit": "score", "value": 839.0769169999999}, "Boyer": {"lowerIsBetter": false, "filtered": 57.14438484546362, "unit": "score", "value": 57.14438484546362}, "RayTrace": {"lowerIsBetter": false, "filtered": 667.4700779999998, "unit": "score", "value": 667.4700779999998}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-038"}, "testrun": {"date": 1447162237, "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": "20151110043005", "branch": "Mozilla-Inbound", "revision": "7ae90a04b0fd9ed59c96fb60f1b8da0ddb0cbf93"}}] 05:50:51 INFO - RETURN: dromaeo_css: 6598.02 05:50:51 INFO - RETURN: kraken: 1483.90 05:50:51 INFO - RETURN: v8_7: 20883.58 05:50:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20883.58"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1483.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6598.02"}}} 05:50:51 INFO - Return code: 0 05:50:51 INFO - # TBPL SUCCESS # 05:50:51 INFO - Running post-action listener: _resource_record_post_action 05:50:51 INFO - Running post-run listener: _resource_record_post_run 05:50:52 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 16384; Write bytes: 506011648; Read time: 56; Write time: 525728 05:50:52 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 164028416; Read time: 0; Write time: 250216 05:50:52 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 16384; Write bytes: 330907648; Read time: 56; Write time: 266084 05:50:52 INFO - Running post-run listener: _upload_blobber_files 05:50:52 INFO - Blob upload gear active. 05:50:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:50:52 INFO - Copying logs to upload dir... 05:50:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1276.052160 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-11-10 05:50:52.322324) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-10 05:50:52.326385) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/B53YxGDiRZi5aQNgH862LQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010034 build_url: 'https://queue.taskcluster.net/v1/task/B53YxGDiRZi5aQNgH862LQ/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-10 05:50:52.378564) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:50:52.378955) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1447162146.42004-1471635537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:50:52.430481) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-10 05:50:52.430882) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-10 05:50:52.431230) ========= ========= Total master_lag: 0.25 =========