builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1447546055.47 results: success (0) buildid: 20151114133002 builduid: cdee54cee26a442aa912e25185459385 revision: 51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:35.466350) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:35.466746) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:35.467036) ========= 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=a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006484 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:35.528577) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:35.528867) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:35.594618) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:35.594896) ========= 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=a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004725 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:35.643435) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:35.643718) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:35.644094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:35.644376) ========= 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=a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-14 16:07: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.6M=0s 2015-11-14 16:07:36 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.189681 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:35.847207) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:35.847489) ========= 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=a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019276 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:35.899767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:35.900132) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d --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=a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-14 16:07:36,245 truncating revision to first 12 chars 2015-11-14 16:07:36,245 Setting DEBUG logging. 2015-11-14 16:07:36,245 attempt 1/10 2015-11-14 16:07:36,245 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/51fa3e0d4f7b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-14 16:07:36,491 unpacking tar archive at: mozilla-central-51fa3e0d4f7b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.528487 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:36.441332) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:36.441641) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:36.450406) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:36.450726) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 16:07:36.451168) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-11-14 16:07:36.451458) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:07:36 INFO - MultiFileLogger online at 20151114 16:07:36 in /builds/slave/test-pgo 16:07:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:07:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:07:36 INFO - {'append_to_log': False, 16:07:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:07:36 INFO - 'blob_upload_branch': 'Firefox', 16:07:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:07:36 INFO - 'branch': 'Firefox', 16:07:36 INFO - 'buildbot_json_path': 'buildprops.json', 16:07:36 INFO - 'config_files': ('talos/linux_config.py',), 16:07:36 INFO - 'default_actions': ('clobber', 16:07:36 INFO - 'read-buildbot-config', 16:07:36 INFO - 'download-and-extract', 16:07:36 INFO - 'populate-webroot', 16:07:36 INFO - 'create-virtualenv', 16:07:36 INFO - 'install', 16:07:36 INFO - 'run-tests'), 16:07:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:07:36 INFO - 'download_minidump_stackwalk': True, 16:07:36 INFO - 'download_symbols': 'ondemand', 16:07:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:07:36 INFO - 'tooltool.py': '/tools/tooltool.py', 16:07:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:07:36 INFO - '/tools/misc-python/virtualenv.py')}, 16:07:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:07:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:07:36 INFO - 'installer_path': 'installer.exe', 16:07:36 INFO - 'log_level': 'info', 16:07:36 INFO - 'log_name': 'talos', 16:07:36 INFO - 'log_to_console': True, 16:07:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:07:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:07:36 INFO - 'opt_config_files': (), 16:07:36 INFO - 'pip_index': False, 16:07:36 INFO - 'sps_profile': False, 16:07:36 INFO - 'sps_profile_interval': 0, 16:07:36 INFO - 'suite': 'dromaeojs', 16:07:36 INFO - 'system_bits': '64', 16:07:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:07:36 INFO - 'title': 'talos-linux64-ix-033', 16:07:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:07:36 INFO - 'use_talos_json': True, 16:07:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:07:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:07:36 INFO - 'work_dir': 'build'} 16:07:36 INFO - ##### 16:07:36 INFO - ##### Running clobber step. 16:07:36 INFO - ##### 16:07:36 INFO - Running pre-action listener: _resource_record_pre_action 16:07:36 INFO - Running main action method: clobber 16:07:36 INFO - rmtree: /builds/slave/test-pgo/build 16:07:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:07:37 INFO - Running post-action listener: _resource_record_post_action 16:07:37 INFO - ##### 16:07:37 INFO - ##### Running read-buildbot-config step. 16:07:37 INFO - ##### 16:07:37 INFO - Running pre-action listener: _resource_record_pre_action 16:07:37 INFO - Running main action method: read_buildbot_config 16:07:37 INFO - Using buildbot properties: 16:07:37 INFO - { 16:07:37 INFO - "properties": { 16:07:37 INFO - "buildnumber": 552, 16:07:37 INFO - "product": "firefox", 16:07:37 INFO - "script_repo_revision": "production", 16:07:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:07:37 INFO - "repository": "", 16:07:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 16:07:37 INFO - "buildid": "20151114133002", 16:07:37 INFO - "slavename": "talos-linux64-ix-033", 16:07:37 INFO - "pgo_build": "True", 16:07:37 INFO - "basedir": "/builds/slave/test-pgo", 16:07:37 INFO - "project": "", 16:07:37 INFO - "platform": "ubuntu64_hw", 16:07:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:07:37 INFO - "slavebuilddir": "test", 16:07:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 16:07:37 INFO - "branch": "mozilla-central", 16:07:37 INFO - "repo_path": "mozilla-central", 16:07:37 INFO - "stage_platform": "linux64-pgo", 16:07:37 INFO - "builduid": "cdee54cee26a442aa912e25185459385", 16:07:37 INFO - "revision": "51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d" 16:07:37 INFO - }, 16:07:37 INFO - "sourcestamp": { 16:07:37 INFO - "repository": "", 16:07:37 INFO - "hasPatch": false, 16:07:37 INFO - "project": "", 16:07:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 16:07:37 INFO - "changes": [ 16:07:37 INFO - { 16:07:37 INFO - "category": null, 16:07:37 INFO - "files": [ 16:07:37 INFO - { 16:07:37 INFO - "url": null, 16:07:37 INFO - "name": "https://queue.taskcluster.net/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 16:07:37 INFO - } 16:07:37 INFO - ], 16:07:37 INFO - "repository": "", 16:07:37 INFO - "rev": "51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d", 16:07:37 INFO - "who": "sendchange", 16:07:37 INFO - "when": 1447546029, 16:07:37 INFO - "number": 6662838, 16:07:37 INFO - "comments": "", 16:07:37 INFO - "project": "", 16:07:37 INFO - "at": "Sat 14 Nov 2015 16:07:09", 16:07:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 16:07:37 INFO - "revlink": "", 16:07:37 INFO - "properties": [ 16:07:37 INFO - [ 16:07:37 INFO - "buildid", 16:07:37 INFO - "20151114133002", 16:07:37 INFO - "Change" 16:07:37 INFO - ], 16:07:37 INFO - [ 16:07:37 INFO - "builduid", 16:07:37 INFO - "cdee54cee26a442aa912e25185459385", 16:07:37 INFO - "Change" 16:07:37 INFO - ], 16:07:37 INFO - [ 16:07:37 INFO - "pgo_build", 16:07:37 INFO - "True", 16:07:37 INFO - "Change" 16:07:37 INFO - ] 16:07:37 INFO - ], 16:07:37 INFO - "revision": "51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d" 16:07:37 INFO - } 16:07:37 INFO - ], 16:07:37 INFO - "revision": "51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d" 16:07:37 INFO - } 16:07:37 INFO - } 16:07:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 16:07:37 INFO - Running post-action listener: _resource_record_post_action 16:07:37 INFO - ##### 16:07:37 INFO - ##### Running download-and-extract step. 16:07:37 INFO - ##### 16:07:37 INFO - Running pre-action listener: _resource_record_pre_action 16:07:37 INFO - Running main action method: download_and_extract 16:07:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:07: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')]} 16:07:37 INFO - https://queue.taskcluster.net/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:07:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/test_packages.json 16:07:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/test_packages.json 16:07:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:07:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:07:46 INFO - Downloaded 1302 bytes. 16:07:46 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:07:46 INFO - Using the following test package requirements: 16:07:46 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:07:46 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:07:46 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:46 INFO - u'jsshell-linux-x86_64.zip'], 16:07:46 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:07:46 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:07:46 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:07:46 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:07:46 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:07:46 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:07:46 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:07:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:46 INFO - https://queue.taskcluster.net/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:07:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:07:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:07:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/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 16:07:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/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 16:07:48 INFO - Downloaded 22462265 bytes. 16:07:48 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 16:07:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:07:48 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 16:07:49 INFO - Return code: 0 16:07:49 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 16:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:49 INFO - https://queue.taskcluster.net/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:07:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:07:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:07:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/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 16:07:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/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 16:07:55 INFO - Downloaded 22462265 bytes. 16:07:55 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 16:07:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:07:55 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 16:07:56 INFO - Return code: 0 16:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:56 INFO - https://queue.taskcluster.net/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:07:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:07:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:07:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/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 16:07:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/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 16:07:57 INFO - Downloaded 11131693 bytes. 16:07:57 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 16:07:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:07:57 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 16:07:57 INFO - Return code: 0 16:07: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')]} 16:07:57 INFO - https://queue.taskcluster.net/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:07:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:07:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:07:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/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 16:07:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mA6LGwDrSqaHYGoGMkeu5w/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 16:07:59 INFO - Downloaded 57130679 bytes. 16:07:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:07:59 INFO - mkdir: /builds/slave/test-pgo/properties 16:07:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:07:59 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:07:59 INFO - Contents: 16:07:59 INFO - build_url:https://queue.taskcluster.net/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:07:59 INFO - Running post-action listener: _resource_record_post_action 16:07:59 INFO - Running post-action listener: set_extra_try_arguments 16:07:59 INFO - ##### 16:07:59 INFO - ##### Running populate-webroot step. 16:07:59 INFO - ##### 16:07:59 INFO - Running pre-action listener: _resource_record_pre_action 16:07:59 INFO - Running main action method: populate_webroot 16:07:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:07:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:07:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:07:59 INFO - '../fennec_ids.txt'], 16:07:59 INFO - 'tests': ['tcheck2']}, 16:07:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:07:59 INFO - '--tppagecycles', 16:07:59 INFO - '7'], 16:07:59 INFO - 'tests': ['tsvgm']}}, 16:07:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:07:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:07:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:07:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:07:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:07:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:07:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:07:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:59 INFO - 'talos_options': ['--e10s'], 16:07:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:07:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:59 INFO - 'tests': ['damp', 'tps']}, 16:07:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:59 INFO - 'talos_options': ['--e10s'], 16:07:59 INFO - 'tests': ['damp', 'tps']}, 16:07:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:07:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:07:59 INFO - 'other': {'tests': ['a11yr', 16:07:59 INFO - 'ts_paint', 16:07:59 INFO - 'tpaint', 16:07:59 INFO - 'sessionrestore', 16:07:59 INFO - 'sessionrestore_no_auto_restore']}, 16:07:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:07:59 INFO - 'tests': ['a11yr', 16:07:59 INFO - 'ts_paint', 16:07:59 INFO - 'tpaint', 16:07:59 INFO - 'sessionrestore', 16:07:59 INFO - 'sessionrestore_no_auto_restore']}, 16:07:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:07:59 INFO - 'tests': ['a11yr', 16:07:59 INFO - 'ts_paint', 16:07:59 INFO - 'tpaint', 16:07:59 INFO - 'sessionrestore', 16:07:59 INFO - 'sessionrestore_no_auto_restore']}, 16:07:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:07:59 INFO - 'tests': ['a11yr', 16:07:59 INFO - 'ts_paint', 16:07:59 INFO - 'tpaint', 16:07:59 INFO - 'sessionrestore', 16:07:59 INFO - 'sessionrestore_no_auto_restore']}, 16:07:59 INFO - 'other_l64': {'tests': ['a11yr', 16:07:59 INFO - 'ts_paint', 16:07:59 INFO - 'tpaint', 16:07:59 INFO - 'sessionrestore', 16:07:59 INFO - 'sessionrestore_no_auto_restore']}, 16:07:59 INFO - 'other_nol64': {'tests': ['a11yr', 16:07:59 INFO - 'ts_paint', 16:07:59 INFO - 'tpaint', 16:07:59 INFO - 'sessionrestore', 16:07:59 INFO - 'sessionrestore_no_auto_restore']}, 16:07:59 INFO - 'svgr': {'tests': ['tsvgx', 16:07:59 INFO - 'tsvgr_opacity', 16:07:59 INFO - 'tart', 16:07:59 INFO - 'tscrollx', 16:07:59 INFO - 'cart']}, 16:07:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:07:59 INFO - 'tests': ['tsvgx', 16:07:59 INFO - 'tsvgr_opacity', 16:07:59 INFO - 'tart', 16:07:59 INFO - 'tscrollx', 16:07:59 INFO - 'cart']}, 16:07:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:59 INFO - 'tests': ['tp5o']}, 16:07:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:59 INFO - 'talos_options': ['--e10s'], 16:07:59 INFO - 'tests': ['tp5o']}, 16:07:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:59 INFO - 'talos_options': ['--xperf_path', 16:07:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:07:59 INFO - 'tests': ['tp5n']}, 16:07:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:59 INFO - 'talos_options': ['--e10s', 16:07:59 INFO - '--xperf_path', 16:07:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:07:59 INFO - 'tests': ['tp5n']}}, 16:07:59 INFO - 'talos.zip': {'path': '', 16:07:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:07:59 INFO - Running post-action listener: _resource_record_post_action 16:07:59 INFO - ##### 16:07:59 INFO - ##### Running create-virtualenv step. 16:07:59 INFO - ##### 16:07:59 INFO - Running pre-action listener: _resource_record_pre_action 16:07:59 INFO - Running main action method: create_virtualenv 16:07:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:07:59 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 16:07:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:07:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:07:59 INFO - Using real prefix '/usr' 16:07:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:07:59 INFO - Installing distribute.............................................................................................................................................................................................done. 16:08:01 INFO - Installing pip.................done. 16:08:01 INFO - Return code: 0 16:08:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:01 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 0x7f7f0cf78c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acb3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548c0>, '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 0x1b01420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b018b0>, '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': 'a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152', '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 16:08:01 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 16:08:01 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 16:08:01 INFO - Using env: {'DISPLAY': ':0', 16:08:01 INFO - 'HOME': '/home/cltbld', 16:08:01 INFO - 'LANG': 'en_US.UTF-8', 16:08:01 INFO - 'LANGUAGE': 'en_US:en', 16:08:01 INFO - 'LOGNAME': 'cltbld', 16:08:01 INFO - 'MAIL': '/var/mail/cltbld', 16:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:01 INFO - 'MOZ_NO_REMOTE': '1', 16:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:01 INFO - 'NO_EM_RESTART': '1', 16:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:08:01 INFO - 'PWD': '/builds/slave/test-pgo', 16:08:01 INFO - 'SHELL': '/bin/bash', 16:08:01 INFO - 'SHLVL': '1', 16:08:01 INFO - 'TERM': 'linux', 16:08:01 INFO - 'TMOUT': '86400', 16:08:01 INFO - 'USER': 'cltbld', 16:08:01 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152', 16:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:01 INFO - '_': '/tools/buildbot/bin/python'} 16:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:02 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 16:08:02 INFO - Cleaning up... 16:08:02 INFO - Return code: 0 16:08:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:08: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')]} 16:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08: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')]} 16:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:02 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 0x7f7f0cf78c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acb3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548c0>, '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 0x1b01420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b018b0>, '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': 'a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152', '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 16:08:02 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 16:08:02 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 16:08:02 INFO - Using env: {'DISPLAY': ':0', 16:08:02 INFO - 'HOME': '/home/cltbld', 16:08:02 INFO - 'LANG': 'en_US.UTF-8', 16:08:02 INFO - 'LANGUAGE': 'en_US:en', 16:08:02 INFO - 'LOGNAME': 'cltbld', 16:08:02 INFO - 'MAIL': '/var/mail/cltbld', 16:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:02 INFO - 'MOZ_NO_REMOTE': '1', 16:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:02 INFO - 'NO_EM_RESTART': '1', 16:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:08:02 INFO - 'PWD': '/builds/slave/test-pgo', 16:08:02 INFO - 'SHELL': '/bin/bash', 16:08:02 INFO - 'SHLVL': '1', 16:08:02 INFO - 'TERM': 'linux', 16:08:02 INFO - 'TMOUT': '86400', 16:08:02 INFO - 'USER': 'cltbld', 16:08:02 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152', 16:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:02 INFO - '_': '/tools/buildbot/bin/python'} 16:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:02 INFO - Downloading/unpacking psutil>=0.7.1 16:08:02 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 16:08:02 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 16:08:02 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 16:08:02 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 16:08:02 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 16:08:02 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 16:08:03 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:08:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:08:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:08:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:08:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:08:04 INFO - Installing collected packages: psutil 16:08:04 INFO - Running setup.py install for psutil 16:08:04 INFO - building 'psutil._psutil_linux' extension 16:08:04 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 16:08:04 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 16:08:04 INFO - building 'psutil._psutil_posix' extension 16:08:04 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 16:08:04 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 16:08:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:08:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:08:04 INFO - Successfully installed psutil 16:08:04 INFO - Cleaning up... 16:08:04 INFO - Return code: 0 16:08:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f7f0cf78c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acb3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548c0>, '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 0x1b01420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b018b0>, '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': 'a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152', '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 16:08:04 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 16:08:04 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 16:08:04 INFO - Using env: {'DISPLAY': ':0', 16:08:04 INFO - 'HOME': '/home/cltbld', 16:08:04 INFO - 'LANG': 'en_US.UTF-8', 16:08:04 INFO - 'LANGUAGE': 'en_US:en', 16:08:04 INFO - 'LOGNAME': 'cltbld', 16:08:04 INFO - 'MAIL': '/var/mail/cltbld', 16:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:04 INFO - 'MOZ_NO_REMOTE': '1', 16:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:04 INFO - 'NO_EM_RESTART': '1', 16:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:08:04 INFO - 'PWD': '/builds/slave/test-pgo', 16:08:04 INFO - 'SHELL': '/bin/bash', 16:08:04 INFO - 'SHLVL': '1', 16:08:04 INFO - 'TERM': 'linux', 16:08:04 INFO - 'TMOUT': '86400', 16:08:04 INFO - 'USER': 'cltbld', 16:08:04 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152', 16:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:04 INFO - '_': '/tools/buildbot/bin/python'} 16:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:08:04 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 16:08:04 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 16:08:04 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 16:08:04 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 16:08:04 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 16:08:04 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 16:08:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:08:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:08:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:08:06 INFO - Installing collected packages: mozsystemmonitor 16:08:06 INFO - Running setup.py install for mozsystemmonitor 16:08:06 INFO - Successfully installed mozsystemmonitor 16:08:06 INFO - Cleaning up... 16:08:06 INFO - Return code: 0 16:08:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:06 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 0x7f7f0cf78c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acb3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548c0>, '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 0x1b01420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b018b0>, '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': 'a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152', '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 16:08:06 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 16:08:06 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 16:08:06 INFO - Using env: {'DISPLAY': ':0', 16:08:06 INFO - 'HOME': '/home/cltbld', 16:08:06 INFO - 'LANG': 'en_US.UTF-8', 16:08:06 INFO - 'LANGUAGE': 'en_US:en', 16:08:06 INFO - 'LOGNAME': 'cltbld', 16:08:06 INFO - 'MAIL': '/var/mail/cltbld', 16:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:06 INFO - 'MOZ_NO_REMOTE': '1', 16:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:06 INFO - 'NO_EM_RESTART': '1', 16:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:08:06 INFO - 'PWD': '/builds/slave/test-pgo', 16:08:06 INFO - 'SHELL': '/bin/bash', 16:08:06 INFO - 'SHLVL': '1', 16:08:06 INFO - 'TERM': 'linux', 16:08:06 INFO - 'TMOUT': '86400', 16:08:06 INFO - 'USER': 'cltbld', 16:08:06 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152', 16:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:06 INFO - '_': '/tools/buildbot/bin/python'} 16:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:06 INFO - Downloading/unpacking blobuploader==1.2.4 16:08:06 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 16:08:06 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 16:08:06 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 16:08:06 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 16:08:06 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 16:08:06 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 16:08:08 INFO - Downloading blobuploader-1.2.4.tar.gz 16:08:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:08:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:08:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:08: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 16:08: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 16:08: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 16:08: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 16:08: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 16:08: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 16:08:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:08:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:08:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:08: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 16:08: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 16:08: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 16:08: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 16:08: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 16:08: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 16:08:09 INFO - Downloading docopt-0.6.1.tar.gz 16:08:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:08:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:08:09 INFO - Installing collected packages: blobuploader, requests, docopt 16:08:09 INFO - Running setup.py install for blobuploader 16:08:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:08:09 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:08:09 INFO - Running setup.py install for requests 16:08:09 INFO - Running setup.py install for docopt 16:08:09 INFO - Successfully installed blobuploader requests docopt 16:08:09 INFO - Cleaning up... 16:08:09 INFO - Return code: 0 16:08:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:09 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 0x7f7f0cf78c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acb3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548c0>, '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 0x1b01420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b018b0>, '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': 'a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152', '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 16:08:09 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 16:08:09 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 16:08:09 INFO - Using env: {'DISPLAY': ':0', 16:08:09 INFO - 'HOME': '/home/cltbld', 16:08:09 INFO - 'LANG': 'en_US.UTF-8', 16:08:09 INFO - 'LANGUAGE': 'en_US:en', 16:08:09 INFO - 'LOGNAME': 'cltbld', 16:08:09 INFO - 'MAIL': '/var/mail/cltbld', 16:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:09 INFO - 'MOZ_NO_REMOTE': '1', 16:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:09 INFO - 'NO_EM_RESTART': '1', 16:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:08:09 INFO - 'PWD': '/builds/slave/test-pgo', 16:08:09 INFO - 'SHELL': '/bin/bash', 16:08:09 INFO - 'SHLVL': '1', 16:08:09 INFO - 'TERM': 'linux', 16:08:09 INFO - 'TMOUT': '86400', 16:08:09 INFO - 'USER': 'cltbld', 16:08:09 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152', 16:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:09 INFO - '_': '/tools/buildbot/bin/python'} 16:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:08:09 INFO - Running setup.py (path:/tmp/pip-rk7PsQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:08:10 INFO - Running setup.py (path:/tmp/pip-WLlCL4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:08:10 INFO - Running setup.py (path:/tmp/pip-rTIA8d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:08:10 INFO - Running setup.py (path:/tmp/pip-c2MaBY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:08:10 INFO - Running setup.py (path:/tmp/pip-6U61wE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:08:10 INFO - Running setup.py (path:/tmp/pip-g837gE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:08:10 INFO - Running setup.py (path:/tmp/pip-oqgke7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:08:10 INFO - Running setup.py (path:/tmp/pip-aJH9n0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:08:10 INFO - Running setup.py (path:/tmp/pip-FfrBI2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:08:10 INFO - Running setup.py (path:/tmp/pip-fJiS23-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:08:10 INFO - Running setup.py (path:/tmp/pip-Sa5r8X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:08:10 INFO - Running setup.py (path:/tmp/pip-OiUH0h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:08:10 INFO - Running setup.py (path:/tmp/pip-AWION8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:08:10 INFO - Running setup.py (path:/tmp/pip-BQx3jx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:08:11 INFO - Running setup.py (path:/tmp/pip-t7cTjK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:08:11 INFO - Running setup.py (path:/tmp/pip-qsUVDq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:08:11 INFO - Running setup.py (path:/tmp/pip-mXKUYp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:08:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:08:11 INFO - Running setup.py install for manifestparser 16:08:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:08:11 INFO - Running setup.py install for mozcrash 16:08:11 INFO - Running setup.py install for mozdebug 16:08:11 INFO - Running setup.py install for mozdevice 16:08:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:08:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:08:11 INFO - Running setup.py install for mozfile 16:08:11 INFO - Running setup.py install for mozhttpd 16:08:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:08:11 INFO - Running setup.py install for mozinfo 16:08:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:08:11 INFO - Running setup.py install for mozInstall 16:08:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:08:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:08:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:08:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:08:12 INFO - Running setup.py install for mozleak 16:08:12 INFO - Running setup.py install for mozlog 16:08:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:08:12 INFO - Running setup.py install for moznetwork 16:08:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:08:12 INFO - Running setup.py install for mozprocess 16:08:12 INFO - Running setup.py install for mozprofile 16:08:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:08:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:08:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:08:12 INFO - Running setup.py install for mozrunner 16:08:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:08:12 INFO - Running setup.py install for mozscreenshot 16:08:12 INFO - Running setup.py install for moztest 16:08:12 INFO - Running setup.py install for mozversion 16:08:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:08:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:08:13 INFO - Cleaning up... 16:08:13 INFO - Return code: 0 16:08:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:13 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 0x7f7f0cf78c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acb3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548c0>, '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 0x1b01420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b018b0>, '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': 'a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152', '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 16:08:13 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 16:08:13 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 16:08:13 INFO - Using env: {'DISPLAY': ':0', 16:08:13 INFO - 'HOME': '/home/cltbld', 16:08:13 INFO - 'LANG': 'en_US.UTF-8', 16:08:13 INFO - 'LANGUAGE': 'en_US:en', 16:08:13 INFO - 'LOGNAME': 'cltbld', 16:08:13 INFO - 'MAIL': '/var/mail/cltbld', 16:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:13 INFO - 'MOZ_NO_REMOTE': '1', 16:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:13 INFO - 'NO_EM_RESTART': '1', 16:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:08:13 INFO - 'PWD': '/builds/slave/test-pgo', 16:08:13 INFO - 'SHELL': '/bin/bash', 16:08:13 INFO - 'SHLVL': '1', 16:08:13 INFO - 'TERM': 'linux', 16:08:13 INFO - 'TMOUT': '86400', 16:08:13 INFO - 'USER': 'cltbld', 16:08:13 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152', 16:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:13 INFO - '_': '/tools/buildbot/bin/python'} 16:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:08:13 INFO - Running setup.py (path:/tmp/pip-A0973g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:08:13 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)) 16:08:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:08:13 INFO - Running setup.py (path:/tmp/pip-5rGrPW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:08:13 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)) 16:08:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:08:13 INFO - Running setup.py (path:/tmp/pip-Bs06XI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:08:13 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)) 16:08:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:08:13 INFO - Running setup.py (path:/tmp/pip-tc2TRP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:08:13 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)) 16:08:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:08:13 INFO - Running setup.py (path:/tmp/pip-oB9hUs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:08:13 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)) 16:08:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:08:13 INFO - Running setup.py (path:/tmp/pip-xzD29s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:08:13 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)) 16:08:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:08:13 INFO - Running setup.py (path:/tmp/pip-CJak7D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:08:13 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)) 16:08:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:08:13 INFO - Running setup.py (path:/tmp/pip-ktM9va-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:08:13 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)) 16:08:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:08:13 INFO - Running setup.py (path:/tmp/pip-k2NRjT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:08:13 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)) 16:08:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:08:13 INFO - Running setup.py (path:/tmp/pip-CRqFfH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:08:13 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)) 16:08:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:08:13 INFO - Running setup.py (path:/tmp/pip-pSXyFL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:08:14 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)) 16:08:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:08:14 INFO - Running setup.py (path:/tmp/pip-NGOv9X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:08:14 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)) 16:08:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:08:14 INFO - Running setup.py (path:/tmp/pip-kuj40R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:08:14 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)) 16:08:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:08:14 INFO - Running setup.py (path:/tmp/pip-y5nq2T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:08:14 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)) 16:08:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:08:14 INFO - Running setup.py (path:/tmp/pip-R7P8fb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:08:14 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)) 16:08:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:08:14 INFO - Running setup.py (path:/tmp/pip-aubJ6o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:08:14 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)) 16:08:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:08:14 INFO - Running setup.py (path:/tmp/pip-8MZp4z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:08:14 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)) 16:08:14 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)) 16:08:14 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)) 16:08:14 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)) 16:08:14 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)) 16:08:14 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)) 16:08:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:16 INFO - Downloading blessings-1.5.1.tar.gz 16:08:16 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 16:08:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:08:16 INFO - Installing collected packages: blessings 16:08:16 INFO - Running setup.py install for blessings 16:08:16 INFO - Successfully installed blessings 16:08:16 INFO - Cleaning up... 16:08:16 INFO - Return code: 0 16:08:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:08:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:08:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:08:16 INFO - Reading from file tmpfile_stdout 16:08:16 INFO - Current package versions: 16:08:16 INFO - argparse == 1.2.1 16:08:16 INFO - blessings == 1.5.1 16:08:16 INFO - blobuploader == 1.2.4 16:08:16 INFO - docopt == 0.6.1 16:08:16 INFO - manifestparser == 1.1 16:08:16 INFO - mozInstall == 1.12 16:08:16 INFO - mozcrash == 0.16 16:08:16 INFO - mozdebug == 0.1 16:08:16 INFO - mozdevice == 0.47 16:08:16 INFO - mozfile == 1.2 16:08:16 INFO - mozhttpd == 0.7 16:08:16 INFO - mozinfo == 0.9 16:08:16 INFO - mozleak == 0.1 16:08:16 INFO - mozlog == 3.0 16:08:16 INFO - moznetwork == 0.27 16:08:16 INFO - mozprocess == 0.22 16:08:16 INFO - mozprofile == 0.27 16:08:16 INFO - mozrunner == 6.11 16:08:16 INFO - mozscreenshot == 0.1 16:08:16 INFO - mozsystemmonitor == 0.0 16:08:16 INFO - moztest == 0.7 16:08:16 INFO - mozversion == 1.4 16:08:16 INFO - psutil == 3.1.1 16:08:16 INFO - requests == 1.2.3 16:08:16 INFO - wsgiref == 0.1.2 16:08:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:16 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 0x7f7f0cf78c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acb3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548c0>, '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 0x1b01420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b018b0>, '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': 'a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152', '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 16:08:16 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 16:08:16 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 16:08:16 INFO - Using env: {'DISPLAY': ':0', 16:08:16 INFO - 'HOME': '/home/cltbld', 16:08:16 INFO - 'LANG': 'en_US.UTF-8', 16:08:16 INFO - 'LANGUAGE': 'en_US:en', 16:08:16 INFO - 'LOGNAME': 'cltbld', 16:08:16 INFO - 'MAIL': '/var/mail/cltbld', 16:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:16 INFO - 'MOZ_NO_REMOTE': '1', 16:08:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:16 INFO - 'NO_EM_RESTART': '1', 16:08:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:08:16 INFO - 'PWD': '/builds/slave/test-pgo', 16:08:16 INFO - 'SHELL': '/bin/bash', 16:08:16 INFO - 'SHLVL': '1', 16:08:16 INFO - 'TERM': 'linux', 16:08:16 INFO - 'TMOUT': '86400', 16:08:16 INFO - 'USER': 'cltbld', 16:08:16 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152', 16:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:16 INFO - '_': '/tools/buildbot/bin/python'} 16:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:16 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)) 16:08:16 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)) 16:08:16 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)) 16:08:16 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)) 16:08:16 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)) 16:08:16 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)) 16:08:16 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)) 16:08:16 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)) 16:08:16 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)) 16:08:16 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)) 16:08:16 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)) 16:08:16 INFO - Cleaning up... 16:08:16 INFO - Return code: 0 16:08:16 INFO - Running post-action listener: _resource_record_post_action 16:08:16 INFO - Running post-action listener: _start_resource_monitoring 16:08:16 INFO - Starting resource monitoring. 16:08:16 INFO - ##### 16:08:16 INFO - ##### Running install step. 16:08:16 INFO - ##### 16:08:16 INFO - Running pre-action listener: _resource_record_pre_action 16:08:16 INFO - Running main action method: install 16:08:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:08:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:08:17 INFO - Reading from file tmpfile_stdout 16:08:17 INFO - Detecting whether we're running mozinstall >=1.0... 16:08:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:08:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:08:17 INFO - Reading from file tmpfile_stdout 16:08:17 INFO - Output received: 16:08:17 INFO - Usage: mozinstall [options] installer 16:08:17 INFO - Options: 16:08:17 INFO - -h, --help show this help message and exit 16:08:17 INFO - -d DEST, --destination=DEST 16:08:17 INFO - Directory to install application into. [default: 16:08:17 INFO - "/builds/slave/test-pgo"] 16:08:17 INFO - --app=APP Application being installed. [default: firefox] 16:08:17 INFO - mkdir: /builds/slave/test-pgo/build/application 16:08:17 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'] 16:08:17 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 16:08:31 INFO - Reading from file tmpfile_stdout 16:08:31 INFO - Output received: 16:08:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:08:31 INFO - Running post-action listener: _resource_record_post_action 16:08:31 INFO - ##### 16:08:31 INFO - ##### Running run-tests step. 16:08:31 INFO - ##### 16:08:31 INFO - Running pre-action listener: _resource_record_pre_action 16:08:31 INFO - Running main action method: run_tests 16:08:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:08:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:08:31 INFO - Python 2.7.3 16:08:31 INFO - Return code: 0 16:08:31 INFO - grabbing minidump binary from tooltool 16:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548c0>, '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 0x1b01420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b018b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:08:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 16:08:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:08:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:08:31 INFO - Return code: 0 16:08:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:08:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:08:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:08:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:08:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:08:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 16:08:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost 16:08:31 INFO - Using env: {'DISPLAY': ':0', 16:08:31 INFO - 'HOME': '/home/cltbld', 16:08:31 INFO - 'LANG': 'en_US.UTF-8', 16:08:31 INFO - 'LANGUAGE': 'en_US:en', 16:08:31 INFO - 'LOGNAME': 'cltbld', 16:08:31 INFO - 'MAIL': '/var/mail/cltbld', 16:08:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:08:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:31 INFO - 'MOZ_NO_REMOTE': '1', 16:08:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:08:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:31 INFO - 'NO_EM_RESTART': '1', 16:08:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:08:31 INFO - 'PWD': '/builds/slave/test-pgo', 16:08:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:08:31 INFO - 'SHELL': '/bin/bash', 16:08:31 INFO - 'SHLVL': '1', 16:08:31 INFO - 'TERM': 'linux', 16:08:31 INFO - 'TMOUT': '86400', 16:08:31 INFO - 'USER': 'cltbld', 16:08:31 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152', 16:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:31 INFO - '_': '/tools/buildbot/bin/python'} 16:08:31 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] with output_timeout 3600 16:08:31 INFO - mozversion INFO | application_buildid: 20151114133002 16:08:31 INFO - mozversion INFO | application_changeset: 51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d 16:08:31 INFO - mozversion INFO | application_display_name: Nightly 16:08:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:08:31 INFO - mozversion INFO | application_name: Firefox 16:08:31 INFO - mozversion INFO | application_remotingname: firefox 16:08:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 16:08:31 INFO - mozversion INFO | application_vendor: Mozilla 16:08:31 INFO - mozversion INFO | application_version: 45.0a1 16:08:31 INFO - mozversion INFO | platform_buildid: 20151114133002 16:08:31 INFO - mozversion INFO | platform_changeset: 51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d 16:08:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 16:08:31 INFO - mozversion INFO | platform_version: 45.0a1 16:08:31 INFO - 2015-11-14 16:08:31,721 DEBUG : using testdate: 1447546111 16:08:31 INFO - 2015-11-14 16:08:31,722 DEBUG : actual date: 1447546111 16:08:31 INFO - 2015-11-14 16:08:31,729 INFO : starting webserver on 'localhost:51059' 16:08:31 INFO - 2015-11-14 16:08:31,730 INFO : Starting test suite talos-linux64-ix-033 16:08:31 INFO - 2015-11-14 16:08:31,730 INFO : Starting test dromaeo_css 16:08:31 INFO - 2015-11-14 16:08:31,730 DEBUG : operating with platform_type : linux_ 16:08:31 INFO - 2015-11-14 16:08:31,730 INFO : Initialising browser for dromaeo_css test... 16:08:31 INFO - 2015-11-14 16:08:31,738 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpP03tmb/profile http://localhost:51059/getInfo.html 16:08:40 INFO - 2015-11-14 16:08:40,720 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:08:40 INFO - 2015-11-14 16:08:40,720 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:08:40 INFO - 2015-11-14 16:08:40,720 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:08:40 INFO - 2015-11-14 16:08:40,720 DEBUG : BROWSER_OUTPUT: __metrics 16:08:40 INFO - 2015-11-14 16:08:40,877 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:08:42 INFO - 2015-11-14 16:08:42,459 INFO : Browser initialized. 16:08:42 INFO - 2015-11-14 16:08:42,459 INFO : Running cycle 1/1 for dromaeo_css test... 16:08:42 INFO - 2015-11-14 16:08:42,460 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpP03tmb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:08:54 INFO - 2015-11-14 16:08:54,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 141348864 16:08:54 INFO - 2015-11-14 16:08:54,291 DEBUG : BROWSER_OUTPUT: 16:09:45 INFO - 2015-11-14 16:09:45,840 DEBUG : BROWSER_OUTPUT: 1447546185837 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] 16:11:54 INFO - 2015-11-14 16:11:54,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51059/tests/dromaeo/cssquery-ext.html) 16:11:55 INFO - 2015-11-14 16:11:55,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 231124992 16:11:55 INFO - 2015-11-14 16:11:55,648 DEBUG : BROWSER_OUTPUT: 16:14:57 INFO - 2015-11-14 16:14:57,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/dromaeo/cssquery-ext.html (next: http://localhost:51059/tests/dromaeo/cssquery-jquery.html) 16:14:58 INFO - 2015-11-14 16:14:58,382 DEBUG : BROWSER_OUTPUT: RSS: Main: 216784896 16:14:58 INFO - 2015-11-14 16:14:58,382 DEBUG : BROWSER_OUTPUT: 16:18:00 INFO - 2015-11-14 16:18:00,339 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51059/tests/dromaeo/cssquery-mootools.html) 16:18:00 INFO - 2015-11-14 16:18:00,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 211238912 16:18:00 INFO - 2015-11-14 16:18:00,909 DEBUG : BROWSER_OUTPUT: 16:21:02 INFO - 2015-11-14 16:21:02,643 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51059/tests/dromaeo/cssquery-prototype.html) 16:21:03 INFO - 2015-11-14 16:21:03,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 195620864 16:21:03 INFO - 2015-11-14 16:21:03,211 DEBUG : BROWSER_OUTPUT: 16:24:05 INFO - 2015-11-14 16:24:05,625 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51059/tests/dromaeo/cssquery-yui.html) 16:24:06 INFO - 2015-11-14 16:24:06,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 203661312 16:24:06 INFO - 2015-11-14 16:24:06,187 DEBUG : BROWSER_OUTPUT: 16:27:08 INFO - 2015-11-14 16:27:08,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/dromaeo/cssquery-yui.html (next: http://localhost:51059/tests/dromaeo/cssquery-dojo.html) 16:27:08 INFO - 2015-11-14 16:27:08,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 268083200 16:27:08 INFO - 2015-11-14 16:27:08,956 DEBUG : BROWSER_OUTPUT: 16:27:08 INFO - 2015-11-14 16:27:08,956 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:27:08 INFO - 2015-11-14 16:27:08,956 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:27:08 INFO - 2015-11-14 16:27:08,956 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:27:08 INFO - 2015-11-14 16:27:08,956 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:27:08 INFO - 2015-11-14 16:27:08,957 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3184.2039490127463;3246.983765081174;3290.161008942719;3297.4888892221716;3308.321794032224;5255.395629502608;5369.114096174137;5427.2673189119505;5452.182172674101;5492.231087647728;5411.134218525037;5471.534919531835;5529.668219906808;5532.7786888524515;5551.8889622207535;4885.9511404886025;4915.385576802891;4979.850604481871;5084.440711521748;5118.385793704742;5069.797208111671;5107.259447380127;5118.129917913963;5128.692278463304;5146.6140039497;4835.1296766582;4915.9754201229125;4926.75366231687;5016.724080175589;5019.071471777733;4959.950400495985;4981.252812078217;4999.675021123651;4999.825006124768;5002.774875130628;4839.637027222937;4939.333190019373;4943.307936888838;4965.180745177042;5005.399352077774;5226.686398816083;5291.259223708684;5298.761555729963;5301.549368303698;5331.653442526263;5882.499987501024;5906.025505791539;5919.644821310692;5922.792702255443;5924.407559244084;5710.486056254916;5830.387809280007;5930.881382372371;5943.583949123563;5955.970220148914;5414.3502779665905;5422.078246698032;5481.479259470304;5523.447655234485;5526.226328314039;5960.076188190751;5989.2812862456785;5994.940050599438;6040.033594624839;6041.697915104315;5701.857453563694;5797.739101740432;5801.622894511843;5828.5337173026055;5857.384974577608;5823.94176058234;5950;5952.583319167703;5956.702164891738;6005.249343832021;5857.736401861926;5860.589758716934;5862.794802181903;5872.853178670567;5875.206847075676;5707.486326230576;5712.971435142881;5834;5877.353491115974;5888.705564721747;4511.052678937394;4533.274676051816;4541.182587134282;4550.2492088804975;4563.201439748031;4027.335489644176;4032.2540330039037;4033.435319055276;4043.1711499142607;4062.390641403813;5378.97310513445;5470.343558772893;5530.308711411074;5603.075492543766;5606.775728970877;5888.116782482662;5941.851453713605;5952.7023648817385;5961.642301461926;5972;5640.266765320564;5642.125470552071;5653.293338332708;5654.491095801398;5659.886802264014;4993.50064993505;5026.472220416877;5091.439941606421;5109.386873575195;5164.173732202829;6116.724747386378;6126.23422072241;6127.387261273837;6136.8772624547255;6142.385761423822;5901.409859014064;5904.527637789052;5906.616069955439;5907.70461476933;5921.763129474945;5978.312494063239;6098.603590766586;6128.816135515942;6225.657588832658;6241.96879015602;5699.772009119589;5721.084626459747;5723.198752174782;5723.771049158154;5779;5679.659220446786;5812.82561523155;5822.417758224144;5824.534037276923;5834.095715164156;5682.431756824284;5765.942340576708;5868.383819699041;5872.94127058741;5925.4370834770625;5822.388649191774;5846.853828654318;5848.210491583582;5849.093390524476;5857.765689372548;5488.094464413327;5585.581081418829;5736.4550367715;5767;5772.365039845529;5736.168255602997;5856.502197313276;5872.442117998783;5881.500072493886;5891.204687367322;5644.322681278109;5659.405762394889;5673.914891276717;5678.233438485751;5681.801136960186 16:27:08 INFO - 2015-11-14 16:27:08,959 DEBUG : BROWSER_OUTPUT: |1;ext.html;517.6997341541904;551.4292707048206;551.8041095411129;566.674162356645;567.0586825869058;31785;32501.187470313223;38070.42894356587;38108.61891381085;38306.42540361897;43193;44060.3390949136;44265;44271.335929961075;44297;7682.692692292301;8829.646814127444;9002.504862232574;9014;9016.549172541347;7758.262965018314;10503.947480262588;10731.08785753208;10739.78520429591;10742.624008159715;10472.947635261813;10560.630377936774;10564.049235568797;10576.735581610445;10577.947110264438;7868.960655196687;8031.477953932976;10457.163426925828;10486.79026419475;10598.31110977784;10297.639582614647;10427.791444171075;10430.582776688923;10438.112760415373;10453.111485523663;40484.79757601223;40986.59013409857;41001;41011.38482922759;41019.58980410187;2907.185987923385;2928.560715892612;2961.304093538017;2963.9851800741076;2984.820910745362;30382.240443988856;30449.847750761106;30574.847125764452;30841;30933.381332373225;2911.0870006787386;2985.4476921769324;2993.4611769881412;3018.6377634683977;3047.2686555226805;299715;299953;301107;301163.49418252986;301358;55277.447225528034;56220.43779562234;59309.70345148333;59359;64287.35712642907;60722.39277607256;60874;61022.694886525285;61026.69486652538;61187.69406152941;15324.387024518894;15510.767338489932;15511.5346539604;15535.300911459011;15538.922305388402;11622.418879056013;11632.243904146204;11634.6509604712;11646.126540509496;11650.611624616933;19099.96120522421;19263.133159007877;19372.321968731027;19406.611867762567;19409.805901941083;7591.58246296459;7965.960170199112;7989.2809647132035;7996.80007999793;8055.436119471698;960.7694153403133;1008.8436292374694;1127.5095333529941;1134.234391785558;1136.8237923121928;28847.278818029718;29332.12003639894;29565.55651665227;29583;29638.703612964026;991.861139440479;1035.8394448860438;1049.9422531760674;1072.940988245654;1090.4493230918495;13660.316984150753;14416.279186040656;14433;14516.346764395628;14699.191544465157;320631;325511;325757;325773;326064;52338.476615234125;52648.473515264355;52656.73671631694;52663;52741.208881866805;1332.9600111996656;1336.6324260828155;1337.6054064051127;1359.632899117233;1474.351285434427;26613.20160395191;27311.317217068936;27634.3091422708;27643;27858.16425507238;41758;45017.32474012958;45097;45371.86570335768;45447.31829022501;199622;286849;289984.9506772158;291369;291451;30112.84943575268;30807.845960770053;30855;30870.382592347578;30879.536806948363;41176.58823411728;41764.12061457181;42001.579984199765;42515.149697006505;42871.35692964546;35471.29057418889;35614;35908;35957.28085438329;36932;35205.82397087998;36228;36514;36550.8172459136;36677;33040.83479582587;33457.49813752747;34048.319033618696;34092.829535852165;34134;28624.284392890346;30734;30961;31107.222319442197;31219.84390078035;25154.62268065944;25201.24396268115;25343.74656253414;25449.491010180063;25551.616725748758 16:27:08 INFO - 2015-11-14 16:27:08,962 DEBUG : BROWSER_OUTPUT: |2;jquery.html;339.8997295797739;342.224860690536;348.25473486738383;349.26828294722554;352.37101773334604;13915.930420347884;14366.56900292993;17256.482305530837;17352.739708904362;17711.202995865202;15832.366705331802;15965.12191829449;16447.917760411212;16466.83533164668;16477.91761041196;4400.295952647577;4551.954480455202;4559.065391594731;4560.680752347337;4563.452385713719;3560.875369362073;3651.8539258429764;4497.775111244441;4896.804127834882;5036.395632524084;4935.555799978001;4938.629602779788;4970.130227210242;4980.8505744827535;4984.1526940420035;4845.466998630148;4911.607071434277;4956.801727930879;4960.479149689267;4962.826301079463;4354.8693539193555;4363.869083927487;4370.235208838472;4370.7159034662645;4373.606375426227;13783.724325513534;14318.85681143196;14597.6350591235;14626.561203163923;14631.122132672073;1841.7697787776528;1864.9813501864944;1939.486036200408;1960.8333291670226;2051.866628669132;9882.752931176778;10047;10072.647457338959;10325.638602648947;10481.737956551071;1698.1169791708367;1707;1715.4510556621885;1719.217755921053;1723.7242041273462;54113;58708;62167.68916155436;62925.37074629241;64242.3575764241;7120.1099862517185;7139.143302803697;7180.7845764627145;7224.458165637493;7225.458090643223;8600.526971016528;8609.5695215239;8630.136986301319;8630.352723545759;8639.308855291561;5440.401555828935;5504.394516603171;5519.724013799294;5526.171074338881;5711.6001879868845;5566.693831839207;5567.109262517978;5581.553475721932;5596.468335508121;5605.5515558755205;3291.835408229579;3301.4717645176656;3304.8347582620772;3312.93374132516;3324.335132973415;1144.9427528623535;1145.6963904565298;1189.131933688395;1213.7329787446747;1218.5125949620224;380.4806439210458;402.986488980215;418.32440608417187;472.4779119073443;494.1130670446557;9864.408135511892;10374.740631484123;10661.626843060456;10749.247552671239;10964.177686673373;416.0410254363721;417.35518623726415;422.145156058983;427.48456720924395;429.5403917807978;5781.595288329777;5878.5003274721275;5882.088276317178;5914.9112763308585;5918.348981612019;496552;499927;505026;516646;519446;81966.18033819705;82053.58973205095;83383.58308208542;84423;84564;453.25665907911053;459.1734877220989;565.197419664078;579.8405438504445;580.642904613668;10909.672709818718;10929.726756831144;11060.059894908702;11095.889041109485;11229.3262404256;34985.65014349824;36375.27249455049;36485.16905724967;36671.63328366682;37539.62460375361;42436.575634243265;43214;44796.32805507855;45088.09823803571;45311.54688453073;7365.373943214887;7621.466497345133;7681.078270607562;7689.2695193958725;7691.615419228904;11192.664220073411;11491.655250342503;11592.246503977214;11639.88360116388;11919.940400297943;8142.8778568322705;10466.581336746445;10710.785784284426;10808.351498909777;10811;9950.45272510019;9953.950230248802;9962.651307204213;10170.796584068425;10224.59101635956;9342.813143737223;9565.04349565038;10149.34029288094;10203.336783109075;10271.332363396356;8420.536870472182;8455.74632761018;8521.360897932556;8633.96392432912;8634.222919937236;10522.736931576772;10848;11127.72180695489;11243.60647377338;11250.606228781953 16:27:08 INFO - 2015-11-14 16:27:08,963 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1485.8217013958324;1505.1871989125873;1542.4061736231554;1684;1794.7666803315558;6512.088307636935;7320.597367144805;7389.187189409167;7425.814354641137;7448.180700122982;7505.362044226247;7577.924220757791;7597.544147351163;7606.04924384452;7614.238576142383;1840.2638944422272;1877.9671180850546;2054.4247610669036;2085.5620319732834;2105.3999610111123;2091.7594476635154;2096.3815674376096;2099.401670523901;2102.737157855268;2105.8104770570644;2010.1456880825663;2030.7969203079722;2043.3257025181729;2069.689546568012;2072.2229164063474;1995.2318357432493;2014.1439888047669;2027.1182035814468;2052.035543294649;2054.9486262843398;2104.98947505263;2117.4177101297114;2119.6926445665445;2120.6076875777876;2122.755883073451;7575.242475752436;7640.808979775495;7646.885296720554;7652.846943061108;7654.3543138224995;4412.492563355223;4457.598816106533;4464.374987501752;4508.864734057984;4512.864614061584;2597.2208337498864;2888.364559796841;2992.0724575381482;2997.610310659622;3005.4740420426338;872.7643536245179;921.4010892919589;928.5914197753035;954.5609019850876;964.4020707161604;10576.68269951895;10593.947030264799;10606.628767993083;10608.840867386996;10625;4192.05678722285;4227.809748561261;4284.293091639907;4285.05728739683;4322.546132656026;9200.447973121634;9201.217896478875;9210.539473026322;9210.76973075665;9214.677486287948;4572.839950601713;4616.0998605272325;4616.399868017136;4618.930716039262;4621;4202.054537728986;4207.26372884744;4207.305794543927;4209.431726716854;4210.136921930997;3604.981975090108;3641.5630124385243;3641.8543258269374;3666.9633303666624;3683.3369993401443;1158.525004748066;1160.9419529023514;1195.1633856300625;1200.6458094862037;1220.7619514194646;1213.4478812140455;1214.6173955204083;1235.604606525921;1247.2765795838393;1254.1158483269273;6620.933790662032;6661.100751398596;6676.799696009128;6684.2981486944145;6690.565113267622;449.4449355046515;475.0664943386263;475.2704598441376;485.6818783696684;485.87367284506286;5452.727363631802;5488.313960754906;5494.2582751328855;5499.395066542677;5508.724563771875;9142.908570914338;9174.357794954289;9280.396774209656;9318.068193180628;9353;9199.080091990747;9201.493917834583;9211.170994610384;9288.210502107262;9325.906740932503;7085.716571337089;7233.746818861315;7243.9637801811705;7271.600061996535;7296.452766042568;6853.348931851466;6869.896951545831;6878.931210688029;6889.965550172217;6896.689648965708;8037.598120094089;8156.469829461066;8273.172682731678;8273.627686754231;8285.4200205985;8301.377396695152;8526.872096918427;8537;8561;8584.098669639598;6372.139761132188;6441.710123044568;6447.4197322241225;6864.828379290358;6936.375726184668;7137.750178743719;7193.208747037717;7241.058662373857;7253.3834624055435;7256.963715181601;6656.068150459037;6805.93194068053;6849.726010959505;6951.721931122698;6959.965200173967;6731.394174524316;6738.7304507819135;6792.1849378072975;6853.93763966586;6856.657167141722;6684.4318232950745;6719.328067193242;6740.460763138839;6758.628275444898;6765.492588055817;6285.402886725754;6328.683565821782;6329.683515824282;6345.4923606112325;6348.079528468438;5806.390329015392;6244.2819075806865;6266.373362663697;6276.152719382825;6293.056041593798 16:27:08 INFO - 2015-11-14 16:27:08,965 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.7314580304824;307.15838602229894;310.3018209029682;310.4752967484951;316.2536414062813;5915.231019967409;6015.578909476339;6024.457798798107;6071.848203794902;6072.817815465538;5852.67810270435;5884.146798714184;5942.227510423639;5978.22283103196;5981.252343457068;4551.704139230939;4560.498345182027;4560.589546940775;4565.999999999992;4589.472210695762;4366.519682834885;4456.064226512436;4563.338315944186;4564.954350456503;4578.519255478177;4463.531329210435;4535.501094879561;4536.364908912738;4551.5676010778925;4568.2462393705;4548.272276435754;4565.1098035883015;4565.908681826361;4570.063137056912;4572.268437050056;3960.821763020671;3969.861054863066;3977.5226972763166;3979.621935916083;3987.9601203987877;5449.591280653967;5593.74828132735;5637;5641.435856414367;5651.632643878134;5260.395054568736;5262.578993680497;5275.076861549252;5279.102552566034;5283.947160528384;6258.092576576417;6266.185395898549;6271.843203919893;6294.213223347082;6300.779472718478;4208.915821683579;4268.359746038119;4320.20076285885;4386.517483076891;4406.603405693471;6576.76981305652;6586.27550969393;6587.242467116295;6599.175103112111;6612.107365505643;4463.754493502824;4501.369808226851;4510.097980403867;4512.05246898155;4516.209663308973;4478.664100192498;4559.156556037144;4562.84030058953;4563.26987681976;4569.977150114228;5222.869428264248;5224.634275600672;5228.947710522846;5230.189320655304;5279.656822306538;6353.428191462791;6354.682265886687;6405.327440618761;6406.583572067801;6407.167068281186;1588.2455833479005;1616.4180894877834;1617.3288085444644;1618.1504710027095;1618.522535851903;1041.073444634276;1069.4599227390274;1074.0762943868267;1090.432974853072;1100.5652767156928;6067.575269731076;6074.179985701962;6080.391960803884;6083.087536869505;6091.939080609137;6568.704408301638;6573.967130164318;6579.2104947406615;6592.077109204715;6592.406683398422;6029.216201893726;6171.228596425447;6171.660558669317;6173.036942267737;6182.350853160443;3525.8237088146;3566.661167189113;3570.4644303354703;3572.678458938708;3573.3389322974813;6814.182298124257;6839.965800170968;6852.246252912176;6859.657017149123;6861.725530978805;6604.438622717027;6745.5952642841585;6746.797596072126;6751.493637977172;6752.797416077526;6840.31596840322;6840.657967101724;6858.828529286708;6864.725410983605;6870.862582748317;6534.411902928569;6539.11721917535;6543.952967525173;6546.410823025951;6546.639934803631;6275.6548389839;6416.230052393743;6437.871242575028;6589.868202635825;6596.406323430914;6888.138982627172;6907.309269073053;6914.446844252348;6921.411680007256;6933;4448.799804008892;4454.354118652842;4455.26488129455;4457.977710111429;4461.486929003207;6502.414782669583;6613.2394774601535;6619.3380661933425;6624.8012559623285;6630.867382652416;6419;6422.807315780534;6429.517786165963;6433.099366088658;6441.452476539546;6370.108184854032;6418.646974416265;6425.357464253537;6432.935670643234;6437.935620643733;6138.631682099089;6345.587536810092;6345.90481142774;6353.110564521063;6360.077788720517;6381.840453988688;6450.451711604566;6462.741490340334;6468.450181734605;6469.514786390945;6177.444030037318;6232.781852635136;6280.842978925563;6291.748330066746;6302.936970630235 16:27:08 INFO - 2015-11-14 16:27:08,968 DEBUG : BROWSER_OUTPUT: |5;yui.html;658.3548122839617;662.3012721578734;677.1772296659558;699.6431819771918;733.8128777161822;13512.932435337834;13782.517611883586;13814.240216788072;13862.653433664163;13880.652983675413;13508.797368039488;13556.186628802254;13576.932115339434;13619.727605447884;13621.182729036265;647.8412788866723;660.8083655739854;797.3621103117512;815.8449894520052;816.94281400302;814.8655471847168;823.2426167925523;825.3809642767924;825.6325934958945;825.9545724985123;702.8313204830855;854.3378881366959;857.6826574167567;859.0292968945083;860.2172023458654;710.073354272674;830.6303694855792;854.3293514591047;855.4268640011207;856.340617724355;619.5198720991268;623.6975067092457;624.9406306400884;624.9812505624839;625.383996763188;13325.733485330336;13379.665508362368;13413.329333533382;13448.663783405394;13569.45722171112;11211.15916306272;11300.547978080867;11773.234739741974;12177.634670959886;12643.747125057447;9168.03735607765;9587.185089267421;9609.663661771805;9633.807323853554;9645.951770241174;3479.947800782965;3558.2590372822037;3601.0817241603486;3634.4184930411006;3677.4667673187237;49795.75102124502;50792;50897.491025090014;50924.236136457985;51099.48900511022;9564.66523671668;9637.277204209713;9660.420374777395;9686.07982241686;10016.098551130433;19206.807931920503;19224.30859679618;19233.422997310103;19273.132709028127;19275.132619032178;7227.638618069181;7276.454265930077;7385.113786345565;7450.366718828852;7606.20134885829;3977.76133431995;4009.8596549121226;4037.152198038386;4039.838406463767;4067.3695577185586;2975.0925967579665;3003.189138932476;3009.4282086403514;3013.89451369201;3017.5926249956415;418.3223178450929;426.9295566231599;432.85715713814363;435.4796018757554;436.8689393182033;574.675308450724;578.4071326889972;599.3526990849872;611.9296280927662;617.2716194890073;7685.346745526693;7694.538327700356;7743.341815945708;7888.408369372205;7943.841123177504;482.3271536206972;525.7923120367434;573.117309637846;595.9821205363846;650.0736450557936;4066.3290557058344;4223.134257477272;4261.680373971964;4291.6566674665955;4318.632916202158;61519.69240153771;61893.69053154706;63228.36771632317;63616;63726;55181.448185518435;55237.72381138069;55370;55645.72177139088;56668;47831.5216847834;47908.76045619819;47970;47990.5200947993;48996.26505602419;8443.746687599381;8476;8601.182887625666;8648.745931839721;8753.255973242345;34998.47502287417;35409.29181416409;36446.817765911;36747.99999999893;37291.81354093212;44788.32817507675;45331.093378132915;45358.31962520499;46557.76721116373;46806;10828.350298982086;10954.123670106213;11183.776324473627;11334.319940803578;11435.256708313933;11468.31190128595;11677.357745324089;11732.824007639721;11774.52901883915;12182.269063856196;11037.172212084286;11355.432228388712;11465;11494.195406321478;11822.881771182178;10960.451977401257;11202.43987800623;11267.26762760418;11305.547778088785;11675.532978681098;10842.132629389787;11369.715757106138;11370.94314528422;11623.1282653803;11635.243709158878;8715.433496822687;8869.201771840566;8967.145033910752;9303.76740581491;9410.24718022543;8480.491170529787;8596.957015215134;8661.393702440768;9526.428414295164;9755.365901216399 16:27:08 INFO - 2015-11-14 16:27:08,969 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:27:08 INFO - 2015-11-14 16:27:08,969 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:27:08 INFO - 2015-11-14 16:27:08,969 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,733 16:27:08 INFO - 2015-11-14 16:27:08,969 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:27:08 INFO - 2015-11-14 16:27:08,969 DEBUG : BROWSER_OUTPUT: __startTimestamp1447547228955__endTimestamp 16:27:08 INFO - 2015-11-14 16:27:08,969 DEBUG : BROWSER_OUTPUT: 16:27:08 INFO - 2015-11-14 16:27:08,969 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:27:08 INFO - 2015-11-14 16:27:08,969 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:27:08 INFO - 2015-11-14 16:27:08,969 DEBUG : BROWSER_OUTPUT: 16:27:08 INFO - 2015-11-14 16:27:08,970 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5467.32 Median:5681.80 stddev:615.77 (10.8%) stddev-sans-first:591.04 16:27:08 INFO - 2015-11-14 16:27:08,970 DEBUG : BROWSER_OUTPUT: Values: 3184.2 3247.0 3290.2 3297.5 3308.3 5255.4 5369.1 5427.3 5452.2 5492.2 5411.1 5471.5 5529.7 5532.8 5551.9 4886.0 4915.4 4979.9 5084.4 5118.4 5069.8 5107.3 5118.1 5128.7 5146.6 4835.1 4916.0 4926.8 5016.7 5019.1 4960.0 4981.3 4999.7 4999.8 5002.8 4839.6 4939.3 4943.3 4965.2 5005.4 5226.7 5291.3 5298.8 5301.5 5331.7 5882.5 5906.0 5919.6 5922.8 5924.4 5710.5 5830.4 5930.9 5943.6 5956.0 5414.4 5422.1 5481.5 5523.4 5526.2 5960.1 5989.3 5994.9 6040.0 6041.7 5701.9 5797.7 5801.6 5828.5 5857.4 5823.9 5950.0 5952.6 5956.7 6005.2 5857.7 5860.6 5862.8 5872.9 5875.2 5707.5 5713.0 5834.0 5877.4 5888.7 4511.1 4533.3 4541.2 4550.2 4563.2 4027.3 4032.3 4033.4 4043.2 4062.4 5379.0 5470.3 5530.3 5603.1 5606.8 5888.1 5941.9 5952.7 5961.6 5972.0 5640.3 5642.1 5653.3 5654.5 5659.9 4993.5 5026.5 5091.4 5109.4 5164.2 6116.7 6126.2 6127.4 6136.9 6142.4 5901.4 5904.5 5906.6 5907.7 5921.8 5978.3 6098.6 6128.8 6225.7 6242.0 5699.8 5721.1 5723.2 5723.8 5779.0 5679.7 5812.8 5822.4 5824.5 5834.1 5682.4 5765.9 5868.4 5872.9 5925.4 5822.4 5846.9 5848.2 5849.1 5857.8 5488.1 5585.6 5736.5 5767.0 5772.4 5736.2 5856.5 5872.4 5881.5 5891.2 5644.3 5659.4 5673.9 5678.2 5681.8 16:27:08 INFO - 2015-11-14 16:27:08,970 DEBUG : BROWSER_OUTPUT: 16:27:08 INFO - 2015-11-14 16:27:08,970 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46803.28 Median:30770.92 stddev:78601.51 (255.4%) stddev-sans-first:78745.18 16:27:08 INFO - 2015-11-14 16:27:08,970 DEBUG : BROWSER_OUTPUT: Values: 517.7 551.4 551.8 566.7 567.1 31785.0 32501.2 38070.4 38108.6 38306.4 43193.0 44060.3 44265.0 44271.3 44297.0 7682.7 8829.6 9002.5 9014.0 9016.5 7758.3 10503.9 10731.1 10739.8 10742.6 10472.9 10560.6 10564.0 10576.7 10577.9 7869.0 8031.5 10457.2 10486.8 10598.3 10297.6 10427.8 10430.6 10438.1 10453.1 40484.8 40986.6 41001.0 41011.4 41019.6 2907.2 2928.6 2961.3 2964.0 2984.8 30382.2 30449.8 30574.8 30841.0 30933.4 2911.1 2985.4 2993.5 3018.6 3047.3 299715.0 299953.0 301107.0 301163.5 301358.0 55277.4 56220.4 59309.7 59359.0 64287.4 60722.4 60874.0 61022.7 61026.7 61187.7 15324.4 15510.8 15511.5 15535.3 15538.9 11622.4 11632.2 11634.7 11646.1 11650.6 19100.0 19263.1 19372.3 19406.6 19409.8 7591.6 7966.0 7989.3 7996.8 8055.4 960.8 1008.8 1127.5 1134.2 1136.8 28847.3 29332.1 29565.6 29583.0 29638.7 991.9 1035.8 1049.9 1072.9 1090.4 13660.3 14416.3 14433.0 14516.3 14699.2 320631.0 325511.0 325757.0 325773.0 326064.0 52338.5 52648.5 52656.7 52663.0 52741.2 1333.0 1336.6 1337.6 1359.6 1474.4 26613.2 27311.3 27634.3 27643.0 27858.2 41758.0 45017.3 45097.0 45371.9 45447.3 199622.0 286849.0 289985.0 291369.0 291451.0 30112.8 30807.8 30855.0 30870.4 30879.5 41176.6 41764.1 42001.6 42515.1 42871.4 35471.3 35614.0 35908.0 35957.3 36932.0 35205.8 36228.0 36514.0 36550.8 36677.0 33040.8 33457.5 34048.3 34092.8 34134.0 28624.3 30734.0 30961.0 31107.2 31219.8 25154.6 25201.2 25343.7 25449.5 25551.6 16:27:08 INFO - 2015-11-14 16:27:08,970 DEBUG : BROWSER_OUTPUT: 16:27:08 INFO - 2015-11-14 16:27:08,970 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26247.78 Median:4367.05 stddev:83372.60 (1909.1%) stddev-sans-first:83583.78 16:27:08 INFO - 2015-11-14 16:27:08,971 DEBUG : BROWSER_OUTPUT: Values: 339.9 342.2 348.3 349.3 352.4 13915.9 14366.6 17256.5 17352.7 17711.2 15832.4 15965.1 16447.9 16466.8 16477.9 4400.3 4552.0 4559.1 4560.7 4563.5 3560.9 3651.9 4497.8 4896.8 5036.4 4935.6 4938.6 4970.1 4980.9 4984.2 4845.5 4911.6 4956.8 4960.5 4962.8 4354.9 4363.9 4370.2 4370.7 4373.6 13783.7 14318.9 14597.6 14626.6 14631.1 1841.8 1865.0 1939.5 1960.8 2051.9 9882.8 10047.0 10072.6 10325.6 10481.7 1698.1 1707.0 1715.5 1719.2 1723.7 54113.0 58708.0 62167.7 62925.4 64242.4 7120.1 7139.1 7180.8 7224.5 7225.5 8600.5 8609.6 8630.1 8630.4 8639.3 5440.4 5504.4 5519.7 5526.2 5711.6 5566.7 5567.1 5581.6 5596.5 5605.6 3291.8 3301.5 3304.8 3312.9 3324.3 1144.9 1145.7 1189.1 1213.7 1218.5 380.5 403.0 418.3 472.5 494.1 9864.4 10374.7 10661.6 10749.2 10964.2 416.0 417.4 422.1 427.5 429.5 5781.6 5878.5 5882.1 5914.9 5918.3 496552.0 499927.0 505026.0 516646.0 519446.0 81966.2 82053.6 83383.6 84423.0 84564.0 453.3 459.2 565.2 579.8 580.6 10909.7 10929.7 11060.1 11095.9 11229.3 34985.7 36375.3 36485.2 36671.6 37539.6 42436.6 43214.0 44796.3 45088.1 45311.5 7365.4 7621.5 7681.1 7689.3 7691.6 11192.7 11491.7 11592.2 11639.9 11919.9 8142.9 10466.6 10710.8 10808.4 10811.0 9950.5 9954.0 9962.7 10170.8 10224.6 9342.8 9565.0 10149.3 10203.3 10271.3 8420.5 8455.7 8521.4 8634.0 8634.2 10522.7 10848.0 11127.7 11243.6 11250.6 16:27:08 INFO - 2015-11-14 16:27:08,971 DEBUG : BROWSER_OUTPUT: 16:27:08 INFO - 2015-11-14 16:27:08,971 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5283.82 Median:6310.87 stddev:2816.58 (44.6%) stddev-sans-first:2810.02 16:27:08 INFO - 2015-11-14 16:27:08,971 DEBUG : BROWSER_OUTPUT: Values: 1485.8 1505.2 1542.4 1684.0 1794.8 6512.1 7320.6 7389.2 7425.8 7448.2 7505.4 7577.9 7597.5 7606.0 7614.2 1840.3 1878.0 2054.4 2085.6 2105.4 2091.8 2096.4 2099.4 2102.7 2105.8 2010.1 2030.8 2043.3 2069.7 2072.2 1995.2 2014.1 2027.1 2052.0 2054.9 2105.0 2117.4 2119.7 2120.6 2122.8 7575.2 7640.8 7646.9 7652.8 7654.4 4412.5 4457.6 4464.4 4508.9 4512.9 2597.2 2888.4 2992.1 2997.6 3005.5 872.8 921.4 928.6 954.6 964.4 10576.7 10593.9 10606.6 10608.8 10625.0 4192.1 4227.8 4284.3 4285.1 4322.5 9200.4 9201.2 9210.5 9210.8 9214.7 4572.8 4616.1 4616.4 4618.9 4621.0 4202.1 4207.3 4207.3 4209.4 4210.1 3605.0 3641.6 3641.9 3667.0 3683.3 1158.5 1160.9 1195.2 1200.6 1220.8 1213.4 1214.6 1235.6 1247.3 1254.1 6620.9 6661.1 6676.8 6684.3 6690.6 449.4 475.1 475.3 485.7 485.9 5452.7 5488.3 5494.3 5499.4 5508.7 9142.9 9174.4 9280.4 9318.1 9353.0 9199.1 9201.5 9211.2 9288.2 9325.9 7085.7 7233.7 7244.0 7271.6 7296.5 6853.3 6869.9 6878.9 6890.0 6896.7 8037.6 8156.5 8273.2 8273.6 8285.4 8301.4 8526.9 8537.0 8561.0 8584.1 6372.1 6441.7 6447.4 6864.8 6936.4 7137.8 7193.2 7241.1 7253.4 7257.0 6656.1 6805.9 6849.7 6951.7 6960.0 6731.4 6738.7 6792.2 6853.9 6856.7 6684.4 6719.3 6740.5 6758.6 6765.5 6285.4 6328.7 6329.7 6345.5 6348.1 5806.4 6244.3 6266.4 6276.2 6293.1 16:27:08 INFO - 2015-11-14 16:27:08,972 DEBUG : BROWSER_OUTPUT: 16:27:08 INFO - 2015-11-14 16:27:08,972 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5317.50 Median:6072.33 stddev:1619.87 (26.7%) stddev-sans-first:1579.97 16:27:08 INFO - 2015-11-14 16:27:08,972 DEBUG : BROWSER_OUTPUT: Values: 296.7 307.2 310.3 310.5 316.3 5915.2 6015.6 6024.5 6071.8 6072.8 5852.7 5884.1 5942.2 5978.2 5981.3 4551.7 4560.5 4560.6 4566.0 4589.5 4366.5 4456.1 4563.3 4565.0 4578.5 4463.5 4535.5 4536.4 4551.6 4568.2 4548.3 4565.1 4565.9 4570.1 4572.3 3960.8 3969.9 3977.5 3979.6 3988.0 5449.6 5593.7 5637.0 5641.4 5651.6 5260.4 5262.6 5275.1 5279.1 5283.9 6258.1 6266.2 6271.8 6294.2 6300.8 4208.9 4268.4 4320.2 4386.5 4406.6 6576.8 6586.3 6587.2 6599.2 6612.1 4463.8 4501.4 4510.1 4512.1 4516.2 4478.7 4559.2 4562.8 4563.3 4570.0 5222.9 5224.6 5228.9 5230.2 5279.7 6353.4 6354.7 6405.3 6406.6 6407.2 1588.2 1616.4 1617.3 1618.2 1618.5 1041.1 1069.5 1074.1 1090.4 1100.6 6067.6 6074.2 6080.4 6083.1 6091.9 6568.7 6574.0 6579.2 6592.1 6592.4 6029.2 6171.2 6171.7 6173.0 6182.4 3525.8 3566.7 3570.5 3572.7 3573.3 6814.2 6840.0 6852.2 6859.7 6861.7 6604.4 6745.6 6746.8 6751.5 6752.8 6840.3 6840.7 6858.8 6864.7 6870.9 6534.4 6539.1 6544.0 6546.4 6546.6 6275.7 6416.2 6437.9 6589.9 6596.4 6888.1 6907.3 6914.4 6921.4 6933.0 4448.8 4454.4 4455.3 4458.0 4461.5 6502.4 6613.2 6619.3 6624.8 6630.9 6419.0 6422.8 6429.5 6433.1 6441.5 6370.1 6418.6 6425.4 6432.9 6437.9 6138.6 6345.6 6345.9 6353.1 6360.1 6381.8 6450.5 6462.7 6468.5 6469.5 6177.4 6232.8 6280.8 6291.7 6302.9 16:27:08 INFO - 2015-11-14 16:27:08,972 DEBUG : BROWSER_OUTPUT: 16:27:08 INFO - 2015-11-14 16:27:08,972 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14168.92 Median:24739.30 stddev:17058.28 (69.0%) stddev-sans-first:17075.96 16:27:08 INFO - 2015-11-14 16:27:08,973 DEBUG : BROWSER_OUTPUT: Values: 658.4 662.3 677.2 699.6 733.8 13512.9 13782.5 13814.2 13862.7 13880.7 13508.8 13556.2 13576.9 13619.7 13621.2 647.8 660.8 797.4 815.8 816.9 814.9 823.2 825.4 825.6 826.0 702.8 854.3 857.7 859.0 860.2 710.1 830.6 854.3 855.4 856.3 619.5 623.7 624.9 625.0 625.4 13325.7 13379.7 13413.3 13448.7 13569.5 11211.2 11300.5 11773.2 12177.6 12643.7 9168.0 9587.2 9609.7 9633.8 9646.0 3479.9 3558.3 3601.1 3634.4 3677.5 49795.8 50792.0 50897.5 50924.2 51099.5 9564.7 9637.3 9660.4 9686.1 10016.1 19206.8 19224.3 19233.4 19273.1 19275.1 7227.6 7276.5 7385.1 7450.4 7606.2 3977.8 4009.9 4037.2 4039.8 4067.4 2975.1 3003.2 3009.4 3013.9 3017.6 418.3 426.9 432.9 435.5 436.9 574.7 578.4 599.4 611.9 617.3 7685.3 7694.5 7743.3 7888.4 7943.8 482.3 525.8 573.1 596.0 650.1 4066.3 4223.1 4261.7 4291.7 4318.6 61519.7 61893.7 63228.4 63616.0 63726.0 55181.4 55237.7 55370.0 55645.7 56668.0 47831.5 47908.8 47970.0 47990.5 48996.3 8443.7 8476.0 8601.2 8648.7 8753.3 34998.5 35409.3 36446.8 36748.0 37291.8 44788.3 45331.1 45358.3 46557.8 46806.0 10828.4 10954.1 11183.8 11334.3 11435.3 11468.3 11677.4 11732.8 11774.5 12182.3 11037.2 11355.4 11465.0 11494.2 11822.9 10960.5 11202.4 11267.3 11305.5 11675.5 10842.1 11369.7 11370.9 11623.1 11635.2 8715.4 8869.2 8967.1 9303.8 9410.2 8480.5 8597.0 8661.4 9526.4 9755.4 16:27:08 INFO - 2015-11-14 16:27:08,973 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:27:08 INFO - 2015-11-14 16:27:08,973 DEBUG : BROWSER_OUTPUT: 16:27:09 INFO - 2015-11-14 16:27:09,733 INFO : Browser exited with error code: 0 16:27:09 INFO - 2015-11-14 16:27:09,757 INFO : Completed test dromaeo_css (00:18:38) 16:27:09 INFO - 2015-11-14 16:27:09,757 INFO : Starting test kraken 16:27:09 INFO - 2015-11-14 16:27:09,757 DEBUG : operating with platform_type : linux_ 16:27:09 INFO - 2015-11-14 16:27:09,757 INFO : Initialising browser for kraken test... 16:27:09 INFO - 2015-11-14 16:27:09,763 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuXcxVy/profile http://localhost:51059/getInfo.html 16:27:14 INFO - 2015-11-14 16:27:14,069 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:27:14 INFO - 2015-11-14 16:27:14,069 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:27:14 INFO - 2015-11-14 16:27:14,070 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:27:14 INFO - 2015-11-14 16:27:14,070 DEBUG : BROWSER_OUTPUT: __metrics 16:27:14 INFO - 2015-11-14 16:27:14,252 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:27:15 INFO - 2015-11-14 16:27:15,832 INFO : Browser initialized. 16:27:15 INFO - 2015-11-14 16:27:15,832 INFO : Running cycle 1/1 for kraken test... 16:27:15 INFO - 2015-11-14 16:27:15,833 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuXcxVy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:27:27 INFO - 2015-11-14 16:27:27,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 141549568 16:27:27 INFO - 2015-11-14 16:27:27,578 DEBUG : BROWSER_OUTPUT: 16:27:30 INFO - 2015-11-14 16:27:30,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51059/tests/kraken/driver.html?testName=audio-beat-detection) 16:27:30 INFO - 2015-11-14 16:27:30,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 181538816 16:27:30 INFO - 2015-11-14 16:27:30,627 DEBUG : BROWSER_OUTPUT: 16:27:33 INFO - 2015-11-14 16:27:33,204 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51059/tests/kraken/driver.html?testName=audio-dft) 16:27:33 INFO - 2015-11-14 16:27:33,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 169185280 16:27:33 INFO - 2015-11-14 16:27:33,770 DEBUG : BROWSER_OUTPUT: 16:27:36 INFO - 2015-11-14 16:27:36,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51059/tests/kraken/driver.html?testName=audio-fft) 16:27:37 INFO - 2015-11-14 16:27:37,197 DEBUG : BROWSER_OUTPUT: RSS: Main: 151142400 16:27:37 INFO - 2015-11-14 16:27:37,197 DEBUG : BROWSER_OUTPUT: 16:27:39 INFO - 2015-11-14 16:27:39,189 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51059/tests/kraken/driver.html?testName=audio-oscillator) 16:27:39 INFO - 2015-11-14 16:27:39,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 155127808 16:27:39 INFO - 2015-11-14 16:27:39,749 DEBUG : BROWSER_OUTPUT: 16:27:41 INFO - 2015-11-14 16:27:41,937 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51059/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:27:42 INFO - 2015-11-14 16:27:42,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 154652672 16:27:42 INFO - 2015-11-14 16:27:42,498 DEBUG : BROWSER_OUTPUT: 16:27:45 INFO - 2015-11-14 16:27:45,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51059/tests/kraken/driver.html?testName=imaging-darkroom) 16:27:46 INFO - 2015-11-14 16:27:46,024 DEBUG : BROWSER_OUTPUT: RSS: Main: 155910144 16:27:46 INFO - 2015-11-14 16:27:46,025 DEBUG : BROWSER_OUTPUT: 16:27:49 INFO - 2015-11-14 16:27:49,427 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51059/tests/kraken/driver.html?testName=imaging-desaturate) 16:27:49 INFO - 2015-11-14 16:27:49,998 DEBUG : BROWSER_OUTPUT: RSS: Main: 155795456 16:27:49 INFO - 2015-11-14 16:27:49,998 DEBUG : BROWSER_OUTPUT: 16:27:52 INFO - 2015-11-14 16:27:52,776 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51059/tests/kraken/driver.html?testName=json-parse-financial) 16:27:53 INFO - 2015-11-14 16:27:53,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 156430336 16:27:53 INFO - 2015-11-14 16:27:53,345 DEBUG : BROWSER_OUTPUT: 16:27:54 INFO - 2015-11-14 16:27:54,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51059/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:27:55 INFO - 2015-11-14 16:27:55,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 165818368 16:27:55 INFO - 2015-11-14 16:27:55,469 DEBUG : BROWSER_OUTPUT: 16:27:57 INFO - 2015-11-14 16:27:57,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51059/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:27:57 INFO - 2015-11-14 16:27:57,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 164876288 16:27:57 INFO - 2015-11-14 16:27:57,871 DEBUG : BROWSER_OUTPUT: 16:27:59 INFO - 2015-11-14 16:27:59,943 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51059/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:28:00 INFO - 2015-11-14 16:28:00,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 174686208 16:28:00 INFO - 2015-11-14 16:28:00,509 DEBUG : BROWSER_OUTPUT: 16:28:02 INFO - 2015-11-14 16:28:02,916 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:28:03 INFO - 2015-11-14 16:28:03,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 180555776 16:28:03 INFO - 2015-11-14 16:28:03,497 DEBUG : BROWSER_OUTPUT: 16:28:06 INFO - 2015-11-14 16:28:06,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:28:06 INFO - 2015-11-14 16:28:06,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 179494912 16:28:06 INFO - 2015-11-14 16:28:06,628 DEBUG : BROWSER_OUTPUT: 16:28:08 INFO - 2015-11-14 16:28:08,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51059/tests/kraken/driver.html?testName=ai-astar) 16:28:08 INFO - 2015-11-14 16:28:08,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 237379584 16:28:08 INFO - 2015-11-14 16:28:08,523 DEBUG : BROWSER_OUTPUT: 16:28:08 INFO - 2015-11-14 16:28:08,526 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:28:08 INFO - 2015-11-14 16:28:08,526 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:28:08 INFO - 2015-11-14 16:28:08,527 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:28:08 INFO - 2015-11-14 16:28:08,527 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:28:08 INFO - 2015-11-14 16:28:08,527 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;103;110;112;112;99;109;113;111 16:28:08 INFO - 2015-11-14 16:28:08,527 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;124;151;166;124;150;156;125;168;122 16:28:08 INFO - 2015-11-14 16:28:08,527 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;162;162;167;160;162;161;163 16:28:08 INFO - 2015-11-14 16:28:08,527 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;81;97;74;72;71;122;93;72 16:28:08 INFO - 2015-11-14 16:28:08,527 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;138;91;91;91;135;91;92;139 16:28:08 INFO - 2015-11-14 16:28:08,528 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;111;109;109;110;109;109;109 16:28:08 INFO - 2015-11-14 16:28:08,528 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;145;145;146;145;145;145;145 16:28:08 INFO - 2015-11-14 16:28:08,528 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;96;96;95;96;95;95 16:28:08 INFO - 2015-11-14 16:28:08,528 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;58;57;55;57;59;57;64;55;55 16:28:08 INFO - 2015-11-14 16:28:08,528 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;68;70;69;70;70;69;69 16:28:08 INFO - 2015-11-14 16:28:08,528 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;93;88;87;85;92;85;87;86;87;85 16:28:08 INFO - 2015-11-14 16:28:08,528 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;118;119;113;114;135;121;118;128;119 16:28:08 INFO - 2015-11-14 16:28:08,529 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;140;153;151;154;139;149;148;144;150 16:28:08 INFO - 2015-11-14 16:28:08,529 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;68;68;66;65;65;68;65;65 16:28:08 INFO - 2015-11-14 16:28:08,529 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:28:08 INFO - 2015-11-14 16:28:08,529 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:28:08 INFO - 2015-11-14 16:28:08,529 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,917 16:28:08 INFO - 2015-11-14 16:28:08,529 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:28:08 INFO - 2015-11-14 16:28:08,529 DEBUG : BROWSER_OUTPUT: __startTimestamp1447547288525__endTimestamp 16:28:08 INFO - 2015-11-14 16:28:08,530 DEBUG : BROWSER_OUTPUT: 16:28:08 INFO - 2015-11-14 16:28:08,533 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:28:08 INFO - 2015-11-14 16:28:08,533 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:28:08 INFO - 2015-11-14 16:28:08,533 DEBUG : BROWSER_OUTPUT: 16:28:08 INFO - 2015-11-14 16:28:08,533 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.80 Median:111.50 stddev:4.42 (4.0%) stddev-sans-first:4.68 16:28:08 INFO - 2015-11-14 16:28:08,534 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 103.0 110.0 112.0 112.0 99.0 109.0 113.0 111.0 16:28:08 INFO - 2015-11-14 16:28:08,534 DEBUG : BROWSER_OUTPUT: 16:28:08 INFO - 2015-11-14 16:28:08,534 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.20 Median:153.50 stddev:18.49 (12.0%) stddev-sans-first:19.11 16:28:08 INFO - 2015-11-14 16:28:08,534 DEBUG : BROWSER_OUTPUT: Values: 156.0 124.0 151.0 166.0 124.0 150.0 156.0 125.0 168.0 122.0 16:28:08 INFO - 2015-11-14 16:28:08,534 DEBUG : BROWSER_OUTPUT: 16:28:08 INFO - 2015-11-14 16:28:08,535 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:2.02 (1.2%) stddev-sans-first:2.12 16:28:08 INFO - 2015-11-14 16:28:08,535 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 162.0 162.0 167.0 160.0 162.0 161.0 163.0 16:28:08 INFO - 2015-11-14 16:28:08,535 DEBUG : BROWSER_OUTPUT: 16:28:08 INFO - 2015-11-14 16:28:08,535 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.50 Median:73.00 stddev:16.83 (23.1%) stddev-sans-first:17.33 16:28:08 INFO - 2015-11-14 16:28:08,535 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 81.0 97.0 74.0 72.0 71.0 122.0 93.0 72.0 16:28:08 INFO - 2015-11-14 16:28:08,535 DEBUG : BROWSER_OUTPUT: 16:28:08 INFO - 2015-11-14 16:28:08,536 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.10 Median:91.00 stddev:22.27 (24.5%) stddev-sans-first:23.11 16:28:08 INFO - 2015-11-14 16:28:08,536 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 138.0 91.0 91.0 91.0 135.0 91.0 92.0 139.0 16:28:08 INFO - 2015-11-14 16:28:08,536 DEBUG : BROWSER_OUTPUT: 16:28:08 INFO - 2015-11-14 16:28:08,536 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 16:28:08 INFO - 2015-11-14 16:28:08,536 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 111.0 109.0 109.0 110.0 109.0 109.0 109.0 16:28:08 INFO - 2015-11-14 16:28:08,536 DEBUG : BROWSER_OUTPUT: 16:28:08 INFO - 2015-11-14 16:28:08,537 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 16:28:08 INFO - 2015-11-14 16:28:08,537 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 16:28:08 INFO - 2015-11-14 16:28:08,537 DEBUG : BROWSER_OUTPUT: 16:28:08 INFO - 2015-11-14 16:28:08,537 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:28:08 INFO - 2015-11-14 16:28:08,537 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 16:28:08 INFO - 2015-11-14 16:28:08,537 DEBUG : BROWSER_OUTPUT: 16:28:08 INFO - 2015-11-14 16:28:08,537 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.50 stddev:2.72 (4.7%) stddev-sans-first:2.83 16:28:08 INFO - 2015-11-14 16:28:08,537 DEBUG : BROWSER_OUTPUT: Values: 59.0 58.0 57.0 55.0 57.0 59.0 57.0 64.0 55.0 55.0 16:28:08 INFO - 2015-11-14 16:28:08,537 DEBUG : BROWSER_OUTPUT: 16:28:08 INFO - 2015-11-14 16:28:08,538 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 16:28:08 INFO - 2015-11-14 16:28:08,538 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 68.0 70.0 69.0 70.0 70.0 69.0 69.0 16:28:08 INFO - 2015-11-14 16:28:08,538 DEBUG : BROWSER_OUTPUT: 16:28:08 INFO - 2015-11-14 16:28:08,538 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:87.00 stddev:2.84 (3.3%) stddev-sans-first:2.20 16:28:08 INFO - 2015-11-14 16:28:08,538 DEBUG : BROWSER_OUTPUT: Values: 93.0 88.0 87.0 85.0 92.0 85.0 87.0 86.0 87.0 85.0 16:28:08 INFO - 2015-11-14 16:28:08,538 DEBUG : BROWSER_OUTPUT: 16:28:08 INFO - 2015-11-14 16:28:08,538 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:119.00 stddev:6.61 (5.6%) stddev-sans-first:6.91 16:28:08 INFO - 2015-11-14 16:28:08,538 DEBUG : BROWSER_OUTPUT: Values: 117.0 118.0 119.0 113.0 114.0 135.0 121.0 118.0 128.0 119.0 16:28:08 INFO - 2015-11-14 16:28:08,538 DEBUG : BROWSER_OUTPUT: 16:28:08 INFO - 2015-11-14 16:28:08,539 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.60 Median:149.50 stddev:5.93 (4.0%) stddev-sans-first:5.41 16:28:08 INFO - 2015-11-14 16:28:08,539 DEBUG : BROWSER_OUTPUT: Values: 138.0 140.0 153.0 151.0 154.0 139.0 149.0 148.0 144.0 150.0 16:28:08 INFO - 2015-11-14 16:28:08,539 DEBUG : BROWSER_OUTPUT: 16:28:08 INFO - 2015-11-14 16:28:08,539 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.34 (2.0%) stddev-sans-first:1.39 16:28:08 INFO - 2015-11-14 16:28:08,539 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 68.0 68.0 66.0 65.0 65.0 68.0 65.0 65.0 16:28:08 INFO - 2015-11-14 16:28:08,539 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:28:08 INFO - 2015-11-14 16:28:08,539 DEBUG : BROWSER_OUTPUT: 16:28:09 INFO - 2015-11-14 16:28:09,717 INFO : Browser exited with error code: 0 16:28:09 INFO - 2015-11-14 16:28:09,766 INFO : Completed test kraken (00:01:00) 16:28:09 INFO - 2015-11-14 16:28:09,766 INFO : Starting test v8_7 16:28:09 INFO - 2015-11-14 16:28:09,766 DEBUG : operating with platform_type : linux_ 16:28:09 INFO - 2015-11-14 16:28:09,767 INFO : Initialising browser for v8_7 test... 16:28:09 INFO - 2015-11-14 16:28:09,773 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdTAvUv/profile http://localhost:51059/getInfo.html 16:28:13 INFO - 2015-11-14 16:28:13,996 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:28:13 INFO - 2015-11-14 16:28:13,997 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:28:13 INFO - 2015-11-14 16:28:13,997 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:28:13 INFO - 2015-11-14 16:28:13,997 DEBUG : BROWSER_OUTPUT: __metrics 16:28:14 INFO - 2015-11-14 16:28:14,146 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:28:15 INFO - 2015-11-14 16:28:15,778 INFO : Browser initialized. 16:28:15 INFO - 2015-11-14 16:28:15,779 INFO : Running cycle 1/1 for v8_7 test... 16:28:15 INFO - 2015-11-14 16:28:15,779 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdTAvUv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:28:27 INFO - 2015-11-14 16:28:27,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 141348864 16:28:27 INFO - 2015-11-14 16:28:27,573 DEBUG : BROWSER_OUTPUT: 16:28:48 INFO - 2015-11-14 16:28:48,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51059/tests/v8_7/run.html (next: http://localhost:51059/tests/v8_7/run.html) 16:28:49 INFO - 2015-11-14 16:28:49,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 570568704 16:28:49 INFO - 2015-11-14 16:28:49,177 DEBUG : BROWSER_OUTPUT: 16:28:49 INFO - 2015-11-14 16:28:49,179 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:28:49 INFO - 2015-11-14 16:28:49,179 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:28:49 INFO - 2015-11-14 16:28:49,179 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:28:49 INFO - 2015-11-14 16:28:49,179 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:28:49 INFO - 2015-11-14 16:28:49,179 DEBUG : BROWSER_OUTPUT: |0;Richards;163.8001638001638 16:28:49 INFO - 2015-11-14 16:28:49,179 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.72336303758235 16:28:49 INFO - 2015-11-14 16:28:49,180 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.7142857142857 16:28:49 INFO - 2015-11-14 16:28:49,180 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 16:28:49 INFO - 2015-11-14 16:28:49,180 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1107.4197120708748 16:28:49 INFO - 2015-11-14 16:28:49,180 DEBUG : BROWSER_OUTPUT: |5;Earley;807.7544426494346 16:28:49 INFO - 2015-11-14 16:28:49,180 DEBUG : BROWSER_OUTPUT: |6;Boyer;12317.073170731708 16:28:49 INFO - 2015-11-14 16:28:49,180 DEBUG : BROWSER_OUTPUT: |7;RegExp;26076.923076923078 16:28:49 INFO - 2015-11-14 16:28:49,181 DEBUG : BROWSER_OUTPUT: |8;Splay;651.8904823989569 16:28:49 INFO - 2015-11-14 16:28:49,181 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 16:28:49 INFO - 2015-11-14 16:28:49,181 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:28:49 INFO - 2015-11-14 16:28:49,181 DEBUG : BROWSER_OUTPUT: __startTimestamp1447547329177__endTimestamp 16:28:49 INFO - 2015-11-14 16:28:49,181 DEBUG : BROWSER_OUTPUT: 16:28:49 INFO - 2015-11-14 16:28:49,181 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:28:49 INFO - 2015-11-14 16:28:49,181 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:28:49 INFO - 2015-11-14 16:28:49,181 DEBUG : BROWSER_OUTPUT: 16:28:49 INFO - 2015-11-14 16:28:49,182 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.80 Median:163.80 stddev:0.00 (0.0%) 16:28:49 INFO - 2015-11-14 16:28:49,182 DEBUG : BROWSER_OUTPUT: Values: 163.8 16:28:49 INFO - 2015-11-14 16:28:49,182 DEBUG : BROWSER_OUTPUT: 16:28:49 INFO - 2015-11-14 16:28:49,182 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.72 Median:193.72 stddev:0.00 (0.0%) 16:28:49 INFO - 2015-11-14 16:28:49,182 DEBUG : BROWSER_OUTPUT: Values: 193.7 16:28:49 INFO - 2015-11-14 16:28:49,182 DEBUG : BROWSER_OUTPUT: 16:28:49 INFO - 2015-11-14 16:28:49,182 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.71 Median:285.71 stddev:0.00 (0.0%) 16:28:49 INFO - 2015-11-14 16:28:49,182 DEBUG : BROWSER_OUTPUT: Values: 285.7 16:28:49 INFO - 2015-11-14 16:28:49,182 DEBUG : BROWSER_OUTPUT: 16:28:49 INFO - 2015-11-14 16:28:49,182 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 16:28:49 INFO - 2015-11-14 16:28:49,182 DEBUG : BROWSER_OUTPUT: Values: 5035.2 16:28:49 INFO - 2015-11-14 16:28:49,183 DEBUG : BROWSER_OUTPUT: 16:28:49 INFO - 2015-11-14 16:28:49,183 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1107.42 Median:1107.42 stddev:0.00 (0.0%) 16:28:49 INFO - 2015-11-14 16:28:49,183 DEBUG : BROWSER_OUTPUT: Values: 1107.4 16:28:49 INFO - 2015-11-14 16:28:49,183 DEBUG : BROWSER_OUTPUT: 16:28:49 INFO - 2015-11-14 16:28:49,183 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:807.75 Median:807.75 stddev:0.00 (0.0%) 16:28:49 INFO - 2015-11-14 16:28:49,183 DEBUG : BROWSER_OUTPUT: Values: 807.8 16:28:49 INFO - 2015-11-14 16:28:49,184 DEBUG : BROWSER_OUTPUT: 16:28:49 INFO - 2015-11-14 16:28:49,184 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12317.07 Median:12317.07 stddev:0.00 (0.0%) 16:28:49 INFO - 2015-11-14 16:28:49,184 DEBUG : BROWSER_OUTPUT: Values: 12317.1 16:28:49 INFO - 2015-11-14 16:28:49,184 DEBUG : BROWSER_OUTPUT: 16:28:49 INFO - 2015-11-14 16:28:49,184 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26076.92 Median:26076.92 stddev:0.00 (0.0%) 16:28:49 INFO - 2015-11-14 16:28:49,185 DEBUG : BROWSER_OUTPUT: Values: 26076.9 16:28:49 INFO - 2015-11-14 16:28:49,185 DEBUG : BROWSER_OUTPUT: 16:28:49 INFO - 2015-11-14 16:28:49,185 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:651.89 Median:651.89 stddev:0.00 (0.0%) 16:28:49 INFO - 2015-11-14 16:28:49,185 DEBUG : BROWSER_OUTPUT: Values: 651.9 16:28:49 INFO - 2015-11-14 16:28:49,185 DEBUG : BROWSER_OUTPUT: 16:28:49 INFO - 2015-11-14 16:28:49,185 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 16:28:49 INFO - 2015-11-14 16:28:49,185 DEBUG : BROWSER_OUTPUT: Values: 4817.3 16:28:49 INFO - 2015-11-14 16:28:49,185 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:28:49 INFO - 2015-11-14 16:28:49,186 DEBUG : BROWSER_OUTPUT: 16:28:50 INFO - 2015-11-14 16:28:50,070 INFO : Browser exited with error code: 0 16:28:50 INFO - 2015-11-14 16:28:50,084 INFO : Completed test v8_7 (00:00:40) 16:28:50 INFO - 2015-11-14 16:28:50,233 INFO : Completed test suite (00:20:18) 16:28:50 INFO - 2015-11-14 16:28:50,233 DEBUG : Working with test: dromaeo_css 16:28:50 INFO - 2015-11-14 16:28:50,234 DEBUG : Generating results file: dromaeo_css 16:28:50 INFO - 2015-11-14 16:28:50,235 DEBUG : Working with test: kraken 16:28:50 INFO - 2015-11-14 16:28:50,235 DEBUG : Generating results file: kraken 16:28:50 INFO - 2015-11-14 16:28:50,235 INFO : javascript benchmark 16:28:50 INFO - 2015-11-14 16:28:50,236 DEBUG : Working with test: v8_7 16:28:50 INFO - 2015-11-14 16:28:50,236 DEBUG : Generating results file: v8_7 16:28:50 INFO - 2015-11-14 16:28:50,236 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:28:50 INFO - 2015-11-14 16:28:50,282 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 16:28:50 INFO - 2015-11-14 16:28:50,283 DEBUG : process_Request line: dromaeo_css 6652.47 graph.html#tests=[[72,1,35]] 16:28:50 INFO - 2015-11-14 16:28:50,283 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:28:50 INFO - 2015-11-14 16:28:50,312 DEBUG : process_Request line: kraken 1500.00 graph.html#tests=[[232,1,35]] 16:28:50 INFO - 2015-11-14 16:28:50,312 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:28:50 INFO - 2015-11-14 16:28:50,338 DEBUG : process_Request line: v8_7 20796.17 graph.html#tests=[[230,1,35]] 16:28:50 INFO - 2015-11-14 16:28:50,339 INFO : javascript benchmark 16:28:50 INFO - 2015-11-14 16:28:50,343 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [339.8997295797739, 342.224860690536, 348.25473486738383, 349.26828294722554, 352.37101773334604, 13915.930420347884, 14366.56900292993, 17256.482305530837, 17352.739708904362, 17711.202995865202, 15832.366705331802, 15965.12191829449, 16447.917760411212, 16466.83533164668, 16477.91761041196, 4400.295952647577, 4551.954480455202, 4559.065391594731, 4560.680752347337, 4563.452385713719, 3560.875369362073, 3651.8539258429764, 4497.775111244441, 4896.804127834882, 5036.395632524084, 4935.555799978001, 4938.629602779788, 4970.130227210242, 4980.8505744827535, 4984.1526940420035, 4845.466998630148, 4911.607071434277, 4956.801727930879, 4960.479149689267, 4962.826301079463, 4354.8693539193555, 4363.869083927487, 4370.235208838472, 4370.7159034662645, 4373.606375426227, 13783.724325513534, 14318.85681143196, 14597.6350591235, 14626.561203163923, 14631.122132672073, 1841.7697787776528, 1864.9813501864944, 1939.486036200408, 1960.8333291670226, 2051.866628669132, 9882.752931176778, 10047.0, 10072.647457338959, 10325.638602648947, 10481.737956551071, 1698.1169791708367, 1707.0, 1715.4510556621885, 1719.217755921053, 1723.7242041273462, 54113.0, 58708.0, 62167.68916155436, 62925.37074629241, 64242.3575764241, 7120.1099862517185, 7139.143302803697, 7180.7845764627145, 7224.458165637493, 7225.458090643223, 8600.526971016528, 8609.5695215239, 8630.136986301319, 8630.352723545759, 8639.308855291561, 5440.401555828935, 5504.394516603171, 5519.724013799294, 5526.171074338881, 5711.6001879868845, 5566.693831839207, 5567.109262517978, 5581.553475721932, 5596.468335508121, 5605.5515558755205, 3291.835408229579, 3301.4717645176656, 3304.8347582620772, 3312.93374132516, 3324.335132973415, 1144.9427528623535, 1145.6963904565298, 1189.131933688395, 1213.7329787446747, 1218.5125949620224, 380.4806439210458, 402.986488980215, 418.32440608417187, 472.4779119073443, 494.1130670446557, 9864.408135511892, 10374.740631484123, 10661.626843060456, 10749.247552671239, 10964.177686673373, 416.0410254363721, 417.35518623726415, 422.145156058983, 427.48456720924395, 429.5403917807978, 5781.595288329777, 5878.5003274721275, 5882.088276317178, 5914.9112763308585, 5918.348981612019, 496552.0, 499927.0, 505026.0, 516646.0, 519446.0, 81966.18033819705, 82053.58973205095, 83383.58308208542, 84423.0, 84564.0, 453.25665907911053, 459.1734877220989, 565.197419664078, 579.8405438504445, 580.642904613668, 10909.672709818718, 10929.726756831144, 11060.059894908702, 11095.889041109485, 11229.3262404256, 34985.65014349824, 36375.27249455049, 36485.16905724967, 36671.63328366682, 37539.62460375361, 42436.575634243265, 43214.0, 44796.32805507855, 45088.09823803571, 45311.54688453073, 7365.373943214887, 7621.466497345133, 7681.078270607562, 7689.2695193958725, 7691.615419228904, 11192.664220073411, 11491.655250342503, 11592.246503977214, 11639.88360116388, 11919.940400297943, 8142.8778568322705, 10466.581336746445, 10710.785784284426, 10808.351498909777, 10811.0, 9950.45272510019, 9953.950230248802, 9962.651307204213, 10170.796584068425, 10224.59101635956, 9342.813143737223, 9565.04349565038, 10149.34029288094, 10203.336783109075, 10271.332363396356, 8420.536870472182, 8455.74632761018, 8521.360897932556, 8633.96392432912, 8634.222919937236, 10522.736931576772, 10848.0, 11127.72180695489, 11243.60647377338, 11250.606228781953], "dojo.html": [3184.2039490127463, 3246.983765081174, 3290.161008942719, 3297.4888892221716, 3308.321794032224, 5255.395629502608, 5369.114096174137, 5427.2673189119505, 5452.182172674101, 5492.231087647728, 5411.134218525037, 5471.534919531835, 5529.668219906808, 5532.7786888524515, 5551.8889622207535, 4885.9511404886025, 4915.385576802891, 4979.850604481871, 5084.440711521748, 5118.385793704742, 5069.797208111671, 5107.259447380127, 5118.129917913963, 5128.692278463304, 5146.6140039497, 4835.1296766582, 4915.9754201229125, 4926.75366231687, 5016.724080175589, 5019.071471777733, 4959.950400495985, 4981.252812078217, 4999.675021123651, 4999.825006124768, 5002.774875130628, 4839.637027222937, 4939.333190019373, 4943.307936888838, 4965.180745177042, 5005.399352077774, 5226.686398816083, 5291.259223708684, 5298.761555729963, 5301.549368303698, 5331.653442526263, 5882.499987501024, 5906.025505791539, 5919.644821310692, 5922.792702255443, 5924.407559244084, 5710.486056254916, 5830.387809280007, 5930.881382372371, 5943.583949123563, 5955.970220148914, 5414.3502779665905, 5422.078246698032, 5481.479259470304, 5523.447655234485, 5526.226328314039, 5960.076188190751, 5989.2812862456785, 5994.940050599438, 6040.033594624839, 6041.697915104315, 5701.857453563694, 5797.739101740432, 5801.622894511843, 5828.5337173026055, 5857.384974577608, 5823.94176058234, 5950.0, 5952.583319167703, 5956.702164891738, 6005.249343832021, 5857.736401861926, 5860.589758716934, 5862.794802181903, 5872.853178670567, 5875.206847075676, 5707.486326230576, 5712.971435142881, 5834.0, 5877.353491115974, 5888.705564721747, 4511.052678937394, 4533.274676051816, 4541.182587134282, 4550.2492088804975, 4563.201439748031, 4027.335489644176, 4032.2540330039037, 4033.435319055276, 4043.1711499142607, 4062.390641403813, 5378.97310513445, 5470.343558772893, 5530.308711411074, 5603.075492543766, 5606.775728970877, 5888.116782482662, 5941.851453713605, 5952.7023648817385, 5961.642301461926, 5972.0, 5640.266765320564, 5642.125470552071, 5653.293338332708, 5654.491095801398, 5659.886802264014, 4993.50064993505, 5026.472220416877, 5091.439941606421, 5109.386873575195, 5164.173732202829, 6116.724747386378, 6126.23422072241, 6127.387261273837, 6136.8772624547255, 6142.385761423822, 5901.409859014064, 5904.527637789052, 5906.616069955439, 5907.70461476933, 5921.763129474945, 5978.312494063239, 6098.603590766586, 6128.816135515942, 6225.657588832658, 6241.96879015602, 5699.772009119589, 5721.084626459747, 5723.198752174782, 5723.771049158154, 5779.0, 5679.659220446786, 5812.82561523155, 5822.417758224144, 5824.534037276923, 5834.095715164156, 5682.431756824284, 5765.942340576708, 5868.383819699041, 5872.94127058741, 5925.4370834770625, 5822.388649191774, 5846.853828654318, 5848.210491583582, 5849.093390524476, 5857.765689372548, 5488.094464413327, 5585.581081418829, 5736.4550367715, 5767.0, 5772.365039845529, 5736.168255602997, 5856.502197313276, 5872.442117998783, 5881.500072493886, 5891.204687367322, 5644.322681278109, 5659.405762394889, 5673.914891276717, 5678.233438485751, 5681.801136960186], "mootools.html": [1485.8217013958324, 1505.1871989125873, 1542.4061736231554, 1684.0, 1794.7666803315558, 6512.088307636935, 7320.597367144805, 7389.187189409167, 7425.814354641137, 7448.180700122982, 7505.362044226247, 7577.924220757791, 7597.544147351163, 7606.04924384452, 7614.238576142383, 1840.2638944422272, 1877.9671180850546, 2054.4247610669036, 2085.5620319732834, 2105.3999610111123, 2091.7594476635154, 2096.3815674376096, 2099.401670523901, 2102.737157855268, 2105.8104770570644, 2010.1456880825663, 2030.7969203079722, 2043.3257025181729, 2069.689546568012, 2072.2229164063474, 1995.2318357432493, 2014.1439888047669, 2027.1182035814468, 2052.035543294649, 2054.9486262843398, 2104.98947505263, 2117.4177101297114, 2119.6926445665445, 2120.6076875777876, 2122.755883073451, 7575.242475752436, 7640.808979775495, 7646.885296720554, 7652.846943061108, 7654.3543138224995, 4412.492563355223, 4457.598816106533, 4464.374987501752, 4508.864734057984, 4512.864614061584, 2597.2208337498864, 2888.364559796841, 2992.0724575381482, 2997.610310659622, 3005.4740420426338, 872.7643536245179, 921.4010892919589, 928.5914197753035, 954.5609019850876, 964.4020707161604, 10576.68269951895, 10593.947030264799, 10606.628767993083, 10608.840867386996, 10625.0, 4192.05678722285, 4227.809748561261, 4284.293091639907, 4285.05728739683, 4322.546132656026, 9200.447973121634, 9201.217896478875, 9210.539473026322, 9210.76973075665, 9214.677486287948, 4572.839950601713, 4616.0998605272325, 4616.399868017136, 4618.930716039262, 4621.0, 4202.054537728986, 4207.26372884744, 4207.305794543927, 4209.431726716854, 4210.136921930997, 3604.981975090108, 3641.5630124385243, 3641.8543258269374, 3666.9633303666624, 3683.3369993401443, 1158.525004748066, 1160.9419529023514, 1195.1633856300625, 1200.6458094862037, 1220.7619514194646, 1213.4478812140455, 1214.6173955204083, 1235.604606525921, 1247.2765795838393, 1254.1158483269273, 6620.933790662032, 6661.100751398596, 6676.799696009128, 6684.2981486944145, 6690.565113267622, 449.4449355046515, 475.0664943386263, 475.2704598441376, 485.6818783696684, 485.87367284506286, 5452.727363631802, 5488.313960754906, 5494.2582751328855, 5499.395066542677, 5508.724563771875, 9142.908570914338, 9174.357794954289, 9280.396774209656, 9318.068193180628, 9353.0, 9199.080091990747, 9201.493917834583, 9211.170994610384, 9288.210502107262, 9325.906740932503, 7085.716571337089, 7233.746818861315, 7243.9637801811705, 7271.600061996535, 7296.452766042568, 6853.348931851466, 6869.896951545831, 6878.931210688029, 6889.965550172217, 6896.689648965708, 8037.598120094089, 8156.469829461066, 8273.172682731678, 8273.627686754231, 8285.4200205985, 8301.377396695152, 8526.872096918427, 8537.0, 8561.0, 8584.098669639598, 6372.139761132188, 6441.710123044568, 6447.4197322241225, 6864.828379290358, 6936.375726184668, 7137.750178743719, 7193.208747037717, 7241.058662373857, 7253.3834624055435, 7256.963715181601, 6656.068150459037, 6805.93194068053, 6849.726010959505, 6951.721931122698, 6959.965200173967, 6731.394174524316, 6738.7304507819135, 6792.1849378072975, 6853.93763966586, 6856.657167141722, 6684.4318232950745, 6719.328067193242, 6740.460763138839, 6758.628275444898, 6765.492588055817, 6285.402886725754, 6328.683565821782, 6329.683515824282, 6345.4923606112325, 6348.079528468438, 5806.390329015392, 6244.2819075806865, 6266.373362663697, 6276.152719382825, 6293.056041593798], "ext.html": [517.6997341541904, 551.4292707048206, 551.8041095411129, 566.674162356645, 567.0586825869058, 31785.0, 32501.187470313223, 38070.42894356587, 38108.61891381085, 38306.42540361897, 43193.0, 44060.3390949136, 44265.0, 44271.335929961075, 44297.0, 7682.692692292301, 8829.646814127444, 9002.504862232574, 9014.0, 9016.549172541347, 7758.262965018314, 10503.947480262588, 10731.08785753208, 10739.78520429591, 10742.624008159715, 10472.947635261813, 10560.630377936774, 10564.049235568797, 10576.735581610445, 10577.947110264438, 7868.960655196687, 8031.477953932976, 10457.163426925828, 10486.79026419475, 10598.31110977784, 10297.639582614647, 10427.791444171075, 10430.582776688923, 10438.112760415373, 10453.111485523663, 40484.79757601223, 40986.59013409857, 41001.0, 41011.38482922759, 41019.58980410187, 2907.185987923385, 2928.560715892612, 2961.304093538017, 2963.9851800741076, 2984.820910745362, 30382.240443988856, 30449.847750761106, 30574.847125764452, 30841.0, 30933.381332373225, 2911.0870006787386, 2985.4476921769324, 2993.4611769881412, 3018.6377634683977, 3047.2686555226805, 299715.0, 299953.0, 301107.0, 301163.49418252986, 301358.0, 55277.447225528034, 56220.43779562234, 59309.70345148333, 59359.0, 64287.35712642907, 60722.39277607256, 60874.0, 61022.694886525285, 61026.69486652538, 61187.69406152941, 15324.387024518894, 15510.767338489932, 15511.5346539604, 15535.300911459011, 15538.922305388402, 11622.418879056013, 11632.243904146204, 11634.6509604712, 11646.126540509496, 11650.611624616933, 19099.96120522421, 19263.133159007877, 19372.321968731027, 19406.611867762567, 19409.805901941083, 7591.58246296459, 7965.960170199112, 7989.2809647132035, 7996.80007999793, 8055.436119471698, 960.7694153403133, 1008.8436292374694, 1127.5095333529941, 1134.234391785558, 1136.8237923121928, 28847.278818029718, 29332.12003639894, 29565.55651665227, 29583.0, 29638.703612964026, 991.861139440479, 1035.8394448860438, 1049.9422531760674, 1072.940988245654, 1090.4493230918495, 13660.316984150753, 14416.279186040656, 14433.0, 14516.346764395628, 14699.191544465157, 320631.0, 325511.0, 325757.0, 325773.0, 326064.0, 52338.476615234125, 52648.473515264355, 52656.73671631694, 52663.0, 52741.208881866805, 1332.9600111996656, 1336.6324260828155, 1337.6054064051127, 1359.632899117233, 1474.351285434427, 26613.20160395191, 27311.317217068936, 27634.3091422708, 27643.0, 27858.16425507238, 41758.0, 45017.32474012958, 45097.0, 45371.86570335768, 45447.31829022501, 199622.0, 286849.0, 289984.9506772158, 291369.0, 291451.0, 30112.84943575268, 30807.845960770053, 30855.0, 30870.382592347578, 30879.536806948363, 41176.58823411728, 41764.12061457181, 42001.579984199765, 42515.149697006505, 42871.35692964546, 35471.29057418889, 35614.0, 35908.0, 35957.28085438329, 36932.0, 35205.82397087998, 36228.0, 36514.0, 36550.8172459136, 36677.0, 33040.83479582587, 33457.49813752747, 34048.319033618696, 34092.829535852165, 34134.0, 28624.284392890346, 30734.0, 30961.0, 31107.222319442197, 31219.84390078035, 25154.62268065944, 25201.24396268115, 25343.74656253414, 25449.491010180063, 25551.616725748758], "prototype.html": [296.7314580304824, 307.15838602229894, 310.3018209029682, 310.4752967484951, 316.2536414062813, 5915.231019967409, 6015.578909476339, 6024.457798798107, 6071.848203794902, 6072.817815465538, 5852.67810270435, 5884.146798714184, 5942.227510423639, 5978.22283103196, 5981.252343457068, 4551.704139230939, 4560.498345182027, 4560.589546940775, 4565.999999999992, 4589.472210695762, 4366.519682834885, 4456.064226512436, 4563.338315944186, 4564.954350456503, 4578.519255478177, 4463.531329210435, 4535.501094879561, 4536.364908912738, 4551.5676010778925, 4568.2462393705, 4548.272276435754, 4565.1098035883015, 4565.908681826361, 4570.063137056912, 4572.268437050056, 3960.821763020671, 3969.861054863066, 3977.5226972763166, 3979.621935916083, 3987.9601203987877, 5449.591280653967, 5593.74828132735, 5637.0, 5641.435856414367, 5651.632643878134, 5260.395054568736, 5262.578993680497, 5275.076861549252, 5279.102552566034, 5283.947160528384, 6258.092576576417, 6266.185395898549, 6271.843203919893, 6294.213223347082, 6300.779472718478, 4208.915821683579, 4268.359746038119, 4320.20076285885, 4386.517483076891, 4406.603405693471, 6576.76981305652, 6586.27550969393, 6587.242467116295, 6599.175103112111, 6612.107365505643, 4463.754493502824, 4501.369808226851, 4510.097980403867, 4512.05246898155, 4516.209663308973, 4478.664100192498, 4559.156556037144, 4562.84030058953, 4563.26987681976, 4569.977150114228, 5222.869428264248, 5224.634275600672, 5228.947710522846, 5230.189320655304, 5279.656822306538, 6353.428191462791, 6354.682265886687, 6405.327440618761, 6406.583572067801, 6407.167068281186, 1588.2455833479005, 1616.4180894877834, 1617.3288085444644, 1618.1504710027095, 1618.522535851903, 1041.073444634276, 1069.4599227390274, 1074.0762943868267, 1090.432974853072, 1100.5652767156928, 6067.575269731076, 6074.179985701962, 6080.391960803884, 6083.087536869505, 6091.939080609137, 6568.704408301638, 6573.967130164318, 6579.2104947406615, 6592.077109204715, 6592.406683398422, 6029.216201893726, 6171.228596425447, 6171.660558669317, 6173.036942267737, 6182.350853160443, 3525.8237088146, 3566.661167189113, 3570.4644303354703, 3572.678458938708, 3573.3389322974813, 6814.182298124257, 6839.965800170968, 6852.246252912176, 6859.657017149123, 6861.725530978805, 6604.438622717027, 6745.5952642841585, 6746.797596072126, 6751.493637977172, 6752.797416077526, 6840.31596840322, 6840.657967101724, 6858.828529286708, 6864.725410983605, 6870.862582748317, 6534.411902928569, 6539.11721917535, 6543.952967525173, 6546.410823025951, 6546.639934803631, 6275.6548389839, 6416.230052393743, 6437.871242575028, 6589.868202635825, 6596.406323430914, 6888.138982627172, 6907.309269073053, 6914.446844252348, 6921.411680007256, 6933.0, 4448.799804008892, 4454.354118652842, 4455.26488129455, 4457.977710111429, 4461.486929003207, 6502.414782669583, 6613.2394774601535, 6619.3380661933425, 6624.8012559623285, 6630.867382652416, 6419.0, 6422.807315780534, 6429.517786165963, 6433.099366088658, 6441.452476539546, 6370.108184854032, 6418.646974416265, 6425.357464253537, 6432.935670643234, 6437.935620643733, 6138.631682099089, 6345.587536810092, 6345.90481142774, 6353.110564521063, 6360.077788720517, 6381.840453988688, 6450.451711604566, 6462.741490340334, 6468.450181734605, 6469.514786390945, 6177.444030037318, 6232.781852635136, 6280.842978925563, 6291.748330066746, 6302.936970630235], "yui.html": [658.3548122839617, 662.3012721578734, 677.1772296659558, 699.6431819771918, 733.8128777161822, 13512.932435337834, 13782.517611883586, 13814.240216788072, 13862.653433664163, 13880.652983675413, 13508.797368039488, 13556.186628802254, 13576.932115339434, 13619.727605447884, 13621.182729036265, 647.8412788866723, 660.8083655739854, 797.3621103117512, 815.8449894520052, 816.94281400302, 814.8655471847168, 823.2426167925523, 825.3809642767924, 825.6325934958945, 825.9545724985123, 702.8313204830855, 854.3378881366959, 857.6826574167567, 859.0292968945083, 860.2172023458654, 710.073354272674, 830.6303694855792, 854.3293514591047, 855.4268640011207, 856.340617724355, 619.5198720991268, 623.6975067092457, 624.9406306400884, 624.9812505624839, 625.383996763188, 13325.733485330336, 13379.665508362368, 13413.329333533382, 13448.663783405394, 13569.45722171112, 11211.15916306272, 11300.547978080867, 11773.234739741974, 12177.634670959886, 12643.747125057447, 9168.03735607765, 9587.185089267421, 9609.663661771805, 9633.807323853554, 9645.951770241174, 3479.947800782965, 3558.2590372822037, 3601.0817241603486, 3634.4184930411006, 3677.4667673187237, 49795.75102124502, 50792.0, 50897.491025090014, 50924.236136457985, 51099.48900511022, 9564.66523671668, 9637.277204209713, 9660.420374777395, 9686.07982241686, 10016.098551130433, 19206.807931920503, 19224.30859679618, 19233.422997310103, 19273.132709028127, 19275.132619032178, 7227.638618069181, 7276.454265930077, 7385.113786345565, 7450.366718828852, 7606.20134885829, 3977.76133431995, 4009.8596549121226, 4037.152198038386, 4039.838406463767, 4067.3695577185586, 2975.0925967579665, 3003.189138932476, 3009.4282086403514, 3013.89451369201, 3017.5926249956415, 418.3223178450929, 426.9295566231599, 432.85715713814363, 435.4796018757554, 436.8689393182033, 574.675308450724, 578.4071326889972, 599.3526990849872, 611.9296280927662, 617.2716194890073, 7685.346745526693, 7694.538327700356, 7743.341815945708, 7888.408369372205, 7943.841123177504, 482.3271536206972, 525.7923120367434, 573.117309637846, 595.9821205363846, 650.0736450557936, 4066.3290557058344, 4223.134257477272, 4261.680373971964, 4291.6566674665955, 4318.632916202158, 61519.69240153771, 61893.69053154706, 63228.36771632317, 63616.0, 63726.0, 55181.448185518435, 55237.72381138069, 55370.0, 55645.72177139088, 56668.0, 47831.5216847834, 47908.76045619819, 47970.0, 47990.5200947993, 48996.26505602419, 8443.746687599381, 8476.0, 8601.182887625666, 8648.745931839721, 8753.255973242345, 34998.47502287417, 35409.29181416409, 36446.817765911, 36747.99999999893, 37291.81354093212, 44788.32817507675, 45331.093378132915, 45358.31962520499, 46557.76721116373, 46806.0, 10828.350298982086, 10954.123670106213, 11183.776324473627, 11334.319940803578, 11435.256708313933, 11468.31190128595, 11677.357745324089, 11732.824007639721, 11774.52901883915, 12182.269063856196, 11037.172212084286, 11355.432228388712, 11465.0, 11494.195406321478, 11822.881771182178, 10960.451977401257, 11202.43987800623, 11267.26762760418, 11305.547778088785, 11675.532978681098, 10842.132629389787, 11369.715757106138, 11370.94314528422, 11623.1282653803, 11635.243709158878, 8715.433496822687, 8869.201771840566, 8967.145033910752, 9303.76740581491, 9410.24718022543, 8480.491170529787, 8596.957015215134, 8661.393702440768, 9526.428414295164, 9755.365901216399]}, "summary": {"lowerIsBetter": false, "suite": 6652.469973535365, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6899.6773746600065, "unit": "ms", "value": 6899.6773746600065}, "dojo.html": {"lowerIsBetter": false, "filtered": 5426.812546872367, "unit": "ms", "value": 5426.812546872367}, "mootools.html": {"lowerIsBetter": false, "filtered": 4239.91942303665, "unit": "ms", "value": 4239.91942303665}, "ext.html": {"lowerIsBetter": false, "filtered": 18511.809162091933, "unit": "ms", "value": 18511.809162091933}, "prototype.html": {"lowerIsBetter": false, "filtered": 4781.210506192715, "unit": "ms", "value": 4781.210506192715}, "yui.html": {"lowerIsBetter": false, "filtered": 6167.955098912307, "unit": "ms", "value": 6167.955098912307}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-033"}, "testrun": {"date": 1447546111, "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": "20151114133002", "branch": "Firefox", "revision": "51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 161.0, 160.0, 162.0, 162.0, 167.0, 160.0, 162.0, 161.0, 163.0], "ai-astar": [109.0, 110.0, 103.0, 110.0, 112.0, 112.0, 99.0, 109.0, 113.0, 111.0], "imaging-gaussian-blur": [110.0, 110.0, 110.0, 111.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "audio-beat-detection": [156.0, 124.0, 151.0, 166.0, 124.0, 150.0, 156.0, 125.0, 168.0, 122.0], "json-stringify-tinderbox": [69.0, 69.0, 68.0, 68.0, 70.0, 69.0, 70.0, 70.0, 69.0, 69.0], "stanford-crypto-pbkdf2": [138.0, 140.0, 153.0, 151.0, 154.0, 139.0, 149.0, 148.0, 144.0, 150.0], "json-parse-financial": [59.0, 58.0, 57.0, 55.0, 57.0, 59.0, 57.0, 64.0, 55.0, 55.0], "stanford-crypto-sha256-iterative": [67.0, 66.0, 68.0, 68.0, 66.0, 65.0, 65.0, 68.0, 65.0, 65.0], "audio-fft": [71.0, 72.0, 81.0, 97.0, 74.0, 72.0, 71.0, 122.0, 93.0, 72.0], "imaging-darkroom": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "stanford-crypto-ccm": [117.0, 118.0, 119.0, 113.0, 114.0, 135.0, 121.0, 118.0, 128.0, 119.0], "audio-oscillator": [92.0, 91.0, 138.0, 91.0, 91.0, 91.0, 135.0, 91.0, 92.0, 139.0], "stanford-crypto-aes": [93.0, 88.0, 87.0, 85.0, 92.0, 85.0, 87.0, 86.0, 87.0, 85.0], "imaging-desaturate": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1499.9999999999998, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 82.5, "unit": "ms", "value": 82.5}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 146.6, "unit": "ms", "value": 146.6}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.2, "unit": "ms", "value": 144.2}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 120.2, "unit": "ms", "value": 120.2}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.2, "unit": "ms", "value": 145.2}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 57.6, "unit": "ms", "value": 57.6}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 105.1, "unit": "ms", "value": 105.1}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.8, "unit": "ms", "value": 108.8}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.9, "unit": "ms", "value": 161.9}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 66.3, "unit": "ms", "value": 66.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.1, "unit": "ms", "value": 69.1}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.6, "unit": "ms", "value": 109.6}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 87.5, "unit": "ms", "value": 87.5}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.4, "unit": "ms", "value": 95.4}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-033"}, "testrun": {"date": 1447546111, "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": "20151114133002", "branch": "Firefox", "revision": "51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d"}}, {"talos_counters": {}, "results": {"DeltaBlue": [193.72336303758235], "Encrypt": [285.7142857142857], "NavierStokes": [4817.307692307692], "Decrypt": [5035.175879396985], "Splay": [651.8904823989569], "Richards": [163.8001638001638], "RegExp": [26076.923076923078], "Earley": [807.7544426494346], "Boyer": [12317.073170731708], "RayTrace": [1107.4197120708748]}, "summary": {"lowerIsBetter": false, "suite": 20796.169249452505, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 341.3011160000001, "unit": "score", "value": 341.3011160000001}, "Encrypt": {"lowerIsBetter": false, "filtered": 931.6335000000004, "unit": "score", "value": 931.6335000000004}, "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": 125.00719400000006, "unit": "score", "value": 125.00719400000006}, "RegExp": {"lowerIsBetter": false, "filtered": 34.934528023598794, "unit": "score", "value": 34.934528023598794}, "Richards": {"lowerIsBetter": false, "filtered": 215.5187099999999, "unit": "score", "value": 215.5187099999999}, "Earley": {"lowerIsBetter": false, "filtered": 825.0811940000001, "unit": "score", "value": 825.0811940000001}, "Boyer": {"lowerIsBetter": false, "filtered": 54.108877227722786, "unit": "score", "value": 54.108877227722786}, "RayTrace": {"lowerIsBetter": false, "filtered": 668.2100670000003, "unit": "score", "value": 668.2100670000003}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-033"}, "testrun": {"date": 1447546111, "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": "20151114133002", "branch": "Firefox", "revision": "51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d"}}] 16:28:50 INFO - RETURN: dromaeo_css: 6652.47 16:28:50 INFO - RETURN: kraken: 1500.00 16:28:50 INFO - RETURN: v8_7: 20796.17 16:28:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20796.17"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1500.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6652.47"}}} 16:28:50 INFO - Return code: 0 16:28:50 INFO - # TBPL SUCCESS # 16:28:50 INFO - Running post-action listener: _resource_record_post_action 16:28:50 INFO - Running post-run listener: _resource_record_post_run 16:28:51 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 8192; Write bytes: 504967168; Read time: 788; Write time: 1033676 16:28:51 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 51458048; Read time: 0; Write time: 39040 16:28:51 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 8192; Write bytes: 366587904; Read time: 788; Write time: 946136 16:28:51 INFO - Running post-run listener: _upload_blobber_files 16:28:51 INFO - Blob upload gear active. 16:28:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:28:51 INFO - Copying logs to upload dir... 16:28:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1274.788857 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-11-14 16:28:51.275448) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 16:28:51.279333) ========= 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=a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/mA6LGwDrSqaHYGoGMkeu5w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010036 build_url: 'https://queue.taskcluster.net/v1/task/mA6LGwDrSqaHYGoGMkeu5w/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-14 16:28:51.331626) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:28:51.332154) ========= 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=a194aa7faa1be204aaca7d660000020b-1447544970.592999-870746152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 16:28:51.382585) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 16:28:51.383393) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 16:28:51.383708) ========= ========= Total master_lag: 0.28 =========