builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1447479545.37 results: success (0) buildid: 20151113193353 builduid: 207270d4c79f4cc383dcd46db76b6655 revision: ee68d52994d9aee5e4a6289ee1fff316c8cbdeba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 21:39:05.367075) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 21:39:05.367884) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 21:39:05.368262) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007476 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 21:39:05.393666) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 21:39:05.394025) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 21:39:05.425879) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 21:39:05.426250) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004618 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 21:39:05.475394) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 21:39:05.475694) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 21:39:05.476072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 21:39:05.476351) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-13 21:39:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 61.3M=0s 2015-11-13 21:39:06 (61.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.184878 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 21:39:05.673270) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 21:39:05.673585) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017244 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 21:39:05.723818) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 21:39:05.724188) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ee68d52994d9aee5e4a6289ee1fff316c8cbdeba --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ee68d52994d9aee5e4a6289ee1fff316c8cbdeba --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=2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-13 21:39:06,569 truncating revision to first 12 chars 2015-11-13 21:39:06,569 Setting DEBUG logging. 2015-11-13 21:39:06,569 attempt 1/10 2015-11-13 21:39:06,569 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/ee68d52994d9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 21:39:07,442 unpacking tar archive at: mozilla-inbound-ee68d52994d9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.154900 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 21:39:06.892892) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 21:39:06.893292) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 21:39:06.903087) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 21:39:06.903389) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 21:39:06.903792) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 7 secs) (at 2015-11-13 21:39:06.904087) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:39:07 INFO - MultiFileLogger online at 20151113 21:39:07 in /builds/slave/test-pgo 21:39:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:39:07 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:39:07 INFO - {'append_to_log': False, 21:39:07 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:39:07 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:39:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:39:07 INFO - 'branch': 'Mozilla-Inbound', 21:39:07 INFO - 'buildbot_json_path': 'buildprops.json', 21:39:07 INFO - 'config_files': ('talos/linux_config.py',), 21:39:07 INFO - 'default_actions': ('clobber', 21:39:07 INFO - 'read-buildbot-config', 21:39:07 INFO - 'download-and-extract', 21:39:07 INFO - 'populate-webroot', 21:39:07 INFO - 'create-virtualenv', 21:39:07 INFO - 'install', 21:39:07 INFO - 'run-tests'), 21:39:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:39:07 INFO - 'download_minidump_stackwalk': True, 21:39:07 INFO - 'download_symbols': 'ondemand', 21:39:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:39:07 INFO - 'tooltool.py': '/tools/tooltool.py', 21:39:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:39:07 INFO - '/tools/misc-python/virtualenv.py')}, 21:39:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:39:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:39:07 INFO - 'installer_path': 'installer.exe', 21:39:07 INFO - 'log_level': 'info', 21:39:07 INFO - 'log_name': 'talos', 21:39:07 INFO - 'log_to_console': True, 21:39:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:39:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:39:07 INFO - 'opt_config_files': (), 21:39:07 INFO - 'pip_index': False, 21:39:07 INFO - 'sps_profile': False, 21:39:07 INFO - 'sps_profile_interval': 0, 21:39:07 INFO - 'suite': 'dromaeojs-e10s', 21:39:07 INFO - 'system_bits': '64', 21:39:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:39:07 INFO - 'title': 'talos-linux64-ix-032', 21:39:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:39:07 INFO - 'use_talos_json': True, 21:39:07 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:39:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:39:07 INFO - 'work_dir': 'build'} 21:39:07 INFO - ##### 21:39:07 INFO - ##### Running clobber step. 21:39:07 INFO - ##### 21:39:07 INFO - Running pre-action listener: _resource_record_pre_action 21:39:07 INFO - Running main action method: clobber 21:39:07 INFO - rmtree: /builds/slave/test-pgo/build 21:39:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:39:08 INFO - Running post-action listener: _resource_record_post_action 21:39:08 INFO - ##### 21:39:08 INFO - ##### Running read-buildbot-config step. 21:39:08 INFO - ##### 21:39:08 INFO - Running pre-action listener: _resource_record_pre_action 21:39:08 INFO - Running main action method: read_buildbot_config 21:39:08 INFO - Using buildbot properties: 21:39:08 INFO - { 21:39:08 INFO - "properties": { 21:39:08 INFO - "buildnumber": 150, 21:39:08 INFO - "product": "firefox", 21:39:08 INFO - "script_repo_revision": "production", 21:39:08 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 21:39:08 INFO - "repository": "", 21:39:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 21:39:08 INFO - "buildid": "20151113193353", 21:39:08 INFO - "slavename": "talos-linux64-ix-032", 21:39:08 INFO - "pgo_build": "True", 21:39:08 INFO - "basedir": "/builds/slave/test-pgo", 21:39:08 INFO - "project": "", 21:39:08 INFO - "platform": "ubuntu64_hw", 21:39:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:39:08 INFO - "slavebuilddir": "test", 21:39:08 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:39:08 INFO - "branch": "mozilla-inbound", 21:39:08 INFO - "repo_path": "integration/mozilla-inbound", 21:39:08 INFO - "stage_platform": "linux64-pgo", 21:39:08 INFO - "builduid": "207270d4c79f4cc383dcd46db76b6655", 21:39:08 INFO - "revision": "ee68d52994d9aee5e4a6289ee1fff316c8cbdeba" 21:39:08 INFO - }, 21:39:08 INFO - "sourcestamp": { 21:39:08 INFO - "repository": "", 21:39:08 INFO - "hasPatch": false, 21:39:08 INFO - "project": "", 21:39:08 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 21:39:08 INFO - "changes": [ 21:39:08 INFO - { 21:39:08 INFO - "category": null, 21:39:08 INFO - "files": [ 21:39:08 INFO - { 21:39:08 INFO - "url": null, 21:39:08 INFO - "name": "https://queue.taskcluster.net/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 21:39:08 INFO - } 21:39:08 INFO - ], 21:39:08 INFO - "repository": "", 21:39:08 INFO - "rev": "ee68d52994d9aee5e4a6289ee1fff316c8cbdeba", 21:39:08 INFO - "who": "sendchange", 21:39:08 INFO - "when": 1447479437, 21:39:08 INFO - "number": 6661642, 21:39:08 INFO - "comments": "", 21:39:08 INFO - "project": "", 21:39:08 INFO - "at": "Fri 13 Nov 2015 21:37:17", 21:39:08 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 21:39:08 INFO - "revlink": "", 21:39:08 INFO - "properties": [ 21:39:08 INFO - [ 21:39:08 INFO - "buildid", 21:39:08 INFO - "20151113193353", 21:39:08 INFO - "Change" 21:39:08 INFO - ], 21:39:08 INFO - [ 21:39:08 INFO - "builduid", 21:39:08 INFO - "207270d4c79f4cc383dcd46db76b6655", 21:39:08 INFO - "Change" 21:39:08 INFO - ], 21:39:08 INFO - [ 21:39:08 INFO - "pgo_build", 21:39:08 INFO - "True", 21:39:08 INFO - "Change" 21:39:08 INFO - ] 21:39:08 INFO - ], 21:39:08 INFO - "revision": "ee68d52994d9aee5e4a6289ee1fff316c8cbdeba" 21:39:08 INFO - } 21:39:08 INFO - ], 21:39:08 INFO - "revision": "ee68d52994d9aee5e4a6289ee1fff316c8cbdeba" 21:39:08 INFO - } 21:39:08 INFO - } 21:39:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 21:39:08 INFO - Running post-action listener: _resource_record_post_action 21:39:08 INFO - ##### 21:39:08 INFO - ##### Running download-and-extract step. 21:39:08 INFO - ##### 21:39:08 INFO - Running pre-action listener: _resource_record_pre_action 21:39:08 INFO - Running main action method: download_and_extract 21:39:08 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:08 INFO - https://queue.taskcluster.net/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:39:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/test_packages.json 21:39:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/test_packages.json 21:39:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:39:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:39:08 INFO - Downloaded 1302 bytes. 21:39:08 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:39:08 INFO - Using the following test package requirements: 21:39:08 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:39:08 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:39:08 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:08 INFO - u'jsshell-linux-x86_64.zip'], 21:39:08 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:39:08 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:39:08 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:39:08 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:39:08 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:39:08 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:39:08 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:39:08 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:08 INFO - https://queue.taskcluster.net/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:39:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:39:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:39:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/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 21:39:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/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 21:39:09 INFO - Downloaded 22468681 bytes. 21:39:09 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 21:39:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:39:09 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 21:39:10 INFO - Return code: 0 21:39:10 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 21:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:10 INFO - https://queue.taskcluster.net/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:39:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:39:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:39:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/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 21:39:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/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 21:39:12 INFO - Downloaded 22468681 bytes. 21:39:12 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 21:39:12 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:39:12 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 21:39:13 INFO - Return code: 0 21:39: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')]} 21:39:13 INFO - https://queue.taskcluster.net/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:39:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:39:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:39:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/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 21:39:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/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 21:39:14 INFO - Downloaded 11131693 bytes. 21:39:14 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 21:39:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:39:14 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 21:39:14 INFO - Return code: 0 21:39:14 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')]} 21:39:14 INFO - https://queue.taskcluster.net/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:39:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:39:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:39:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/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 21:39:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/up9eNI0WSx6Sv1j19JHlnQ/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 21:39:15 INFO - Downloaded 57161249 bytes. 21:39:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:39:15 INFO - mkdir: /builds/slave/test-pgo/properties 21:39:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:39:15 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:39:15 INFO - Contents: 21:39:15 INFO - build_url:https://queue.taskcluster.net/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:39:15 INFO - Running post-action listener: _resource_record_post_action 21:39:15 INFO - Running post-action listener: set_extra_try_arguments 21:39:15 INFO - ##### 21:39:15 INFO - ##### Running populate-webroot step. 21:39:15 INFO - ##### 21:39:15 INFO - Running pre-action listener: _resource_record_pre_action 21:39:15 INFO - Running main action method: populate_webroot 21:39:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:39:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:39:15 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:39:15 INFO - '../fennec_ids.txt'], 21:39:15 INFO - 'tests': ['tcheck2']}, 21:39:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:39:15 INFO - '--tppagecycles', 21:39:15 INFO - '7'], 21:39:15 INFO - 'tests': ['tsvgm']}}, 21:39:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:39:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:39:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:39:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:39:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:39:15 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:39:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:39:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:15 INFO - 'talos_options': ['--e10s'], 21:39:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:39:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:15 INFO - 'tests': ['damp', 'tps']}, 21:39:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:15 INFO - 'talos_options': ['--e10s'], 21:39:15 INFO - 'tests': ['damp', 'tps']}, 21:39:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:39:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:39:15 INFO - 'other': {'tests': ['a11yr', 21:39:15 INFO - 'ts_paint', 21:39:15 INFO - 'tpaint', 21:39:15 INFO - 'sessionrestore', 21:39:15 INFO - 'sessionrestore_no_auto_restore']}, 21:39:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:39:15 INFO - 'tests': ['a11yr', 21:39:15 INFO - 'ts_paint', 21:39:15 INFO - 'tpaint', 21:39:15 INFO - 'sessionrestore', 21:39:15 INFO - 'sessionrestore_no_auto_restore']}, 21:39:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:39:15 INFO - 'tests': ['a11yr', 21:39:15 INFO - 'ts_paint', 21:39:15 INFO - 'tpaint', 21:39:15 INFO - 'sessionrestore', 21:39:15 INFO - 'sessionrestore_no_auto_restore']}, 21:39:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:39:15 INFO - 'tests': ['a11yr', 21:39:15 INFO - 'ts_paint', 21:39:15 INFO - 'tpaint', 21:39:15 INFO - 'sessionrestore', 21:39:15 INFO - 'sessionrestore_no_auto_restore']}, 21:39:15 INFO - 'other_l64': {'tests': ['a11yr', 21:39:15 INFO - 'ts_paint', 21:39:15 INFO - 'tpaint', 21:39:15 INFO - 'sessionrestore', 21:39:15 INFO - 'sessionrestore_no_auto_restore']}, 21:39:15 INFO - 'other_nol64': {'tests': ['a11yr', 21:39:15 INFO - 'ts_paint', 21:39:15 INFO - 'tpaint', 21:39:15 INFO - 'sessionrestore', 21:39:15 INFO - 'sessionrestore_no_auto_restore']}, 21:39:15 INFO - 'svgr': {'tests': ['tsvgx', 21:39:15 INFO - 'tsvgr_opacity', 21:39:15 INFO - 'tart', 21:39:15 INFO - 'tscrollx', 21:39:15 INFO - 'cart']}, 21:39:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:39:15 INFO - 'tests': ['tsvgx', 21:39:15 INFO - 'tsvgr_opacity', 21:39:15 INFO - 'tart', 21:39:15 INFO - 'tscrollx', 21:39:15 INFO - 'cart']}, 21:39:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:15 INFO - 'tests': ['tp5o']}, 21:39:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:15 INFO - 'talos_options': ['--e10s'], 21:39:15 INFO - 'tests': ['tp5o']}, 21:39:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:15 INFO - 'talos_options': ['--xperf_path', 21:39:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:39:15 INFO - 'tests': ['tp5n']}, 21:39:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:15 INFO - 'talos_options': ['--e10s', 21:39:15 INFO - '--xperf_path', 21:39:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:39:15 INFO - 'tests': ['tp5n']}}, 21:39:15 INFO - 'talos.zip': {'path': '', 21:39:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:39:15 INFO - Running post-action listener: _resource_record_post_action 21:39:15 INFO - ##### 21:39:15 INFO - ##### Running create-virtualenv step. 21:39:15 INFO - ##### 21:39:15 INFO - Running pre-action listener: _resource_record_pre_action 21:39:15 INFO - Running main action method: create_virtualenv 21:39:15 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:39:15 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 21:39:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:39:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:39:15 INFO - Using real prefix '/usr' 21:39:15 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:39:16 INFO - Installing distribute.............................................................................................................................................................................................done. 21:39:18 INFO - Installing pip.................done. 21:39:18 INFO - Return code: 0 21:39:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:39:18 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')]} 21:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:18 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')]} 21:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:18 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 0x7f2a6d61cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf953d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e8c0>, '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 0xfcb420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcb8b0>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058', '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 21:39:18 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 21:39:18 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 21:39:18 INFO - Using env: {'DISPLAY': ':0', 21:39:18 INFO - 'HOME': '/home/cltbld', 21:39:18 INFO - 'LANG': 'en_US.UTF-8', 21:39:18 INFO - 'LANGUAGE': 'en_US:en', 21:39:18 INFO - 'LOGNAME': 'cltbld', 21:39:18 INFO - 'MAIL': '/var/mail/cltbld', 21:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:18 INFO - 'MOZ_NO_REMOTE': '1', 21:39:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:18 INFO - 'NO_EM_RESTART': '1', 21:39:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:39:18 INFO - 'PWD': '/builds/slave/test-pgo', 21:39:18 INFO - 'SHELL': '/bin/bash', 21:39:18 INFO - 'SHLVL': '1', 21:39:18 INFO - 'TERM': 'linux', 21:39:18 INFO - 'TMOUT': '86400', 21:39:18 INFO - 'USER': 'cltbld', 21:39:18 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058', 21:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:18 INFO - '_': '/tools/buildbot/bin/python'} 21:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:18 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 21:39:18 INFO - Cleaning up... 21:39:18 INFO - Return code: 0 21:39:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:39:18 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')]} 21:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:18 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')]} 21:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:18 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 0x7f2a6d61cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf953d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e8c0>, '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 0xfcb420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcb8b0>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058', '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 21:39:18 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 21:39:18 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 21:39:18 INFO - Using env: {'DISPLAY': ':0', 21:39:18 INFO - 'HOME': '/home/cltbld', 21:39:18 INFO - 'LANG': 'en_US.UTF-8', 21:39:18 INFO - 'LANGUAGE': 'en_US:en', 21:39:18 INFO - 'LOGNAME': 'cltbld', 21:39:18 INFO - 'MAIL': '/var/mail/cltbld', 21:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:18 INFO - 'MOZ_NO_REMOTE': '1', 21:39:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:18 INFO - 'NO_EM_RESTART': '1', 21:39:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:39:18 INFO - 'PWD': '/builds/slave/test-pgo', 21:39:18 INFO - 'SHELL': '/bin/bash', 21:39:18 INFO - 'SHLVL': '1', 21:39:18 INFO - 'TERM': 'linux', 21:39:18 INFO - 'TMOUT': '86400', 21:39:18 INFO - 'USER': 'cltbld', 21:39:18 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058', 21:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:18 INFO - '_': '/tools/buildbot/bin/python'} 21:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:19 INFO - Downloading/unpacking psutil>=0.7.1 21:39:19 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 21:39:19 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 21:39:19 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 21:39:19 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 21:39:19 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 21:39:19 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 21:39:20 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:39:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:39:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:39:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:39:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:39:20 INFO - Installing collected packages: psutil 21:39:20 INFO - Running setup.py install for psutil 21:39:20 INFO - building 'psutil._psutil_linux' extension 21:39:20 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 21:39:21 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 21:39:21 INFO - building 'psutil._psutil_posix' extension 21:39:21 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 21:39:21 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 21:39:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:39:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:39:21 INFO - Successfully installed psutil 21:39:21 INFO - Cleaning up... 21:39:21 INFO - Return code: 0 21:39:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:39:21 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')]} 21:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:21 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')]} 21:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:21 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 0x7f2a6d61cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf953d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e8c0>, '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 0xfcb420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcb8b0>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058', '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 21:39:21 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 21:39:21 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 21:39:21 INFO - Using env: {'DISPLAY': ':0', 21:39:21 INFO - 'HOME': '/home/cltbld', 21:39:21 INFO - 'LANG': 'en_US.UTF-8', 21:39:21 INFO - 'LANGUAGE': 'en_US:en', 21:39:21 INFO - 'LOGNAME': 'cltbld', 21:39:21 INFO - 'MAIL': '/var/mail/cltbld', 21:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:21 INFO - 'MOZ_NO_REMOTE': '1', 21:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:21 INFO - 'NO_EM_RESTART': '1', 21:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:39:21 INFO - 'PWD': '/builds/slave/test-pgo', 21:39:21 INFO - 'SHELL': '/bin/bash', 21:39:21 INFO - 'SHLVL': '1', 21:39:21 INFO - 'TERM': 'linux', 21:39:21 INFO - 'TMOUT': '86400', 21:39:21 INFO - 'USER': 'cltbld', 21:39:21 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058', 21:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:21 INFO - '_': '/tools/buildbot/bin/python'} 21:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:39:21 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 21:39:21 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 21:39:21 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 21:39:21 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 21:39:21 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 21:39:21 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 21:39:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:39:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:39:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:39:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:39:23 INFO - Installing collected packages: mozsystemmonitor 21:39:23 INFO - Running setup.py install for mozsystemmonitor 21:39:23 INFO - Successfully installed mozsystemmonitor 21:39:23 INFO - Cleaning up... 21:39:23 INFO - Return code: 0 21:39:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:39:23 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')]} 21:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:23 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')]} 21:39:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:23 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 0x7f2a6d61cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf953d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e8c0>, '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 0xfcb420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcb8b0>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058', '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 21:39:23 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 21:39:23 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 21:39:23 INFO - Using env: {'DISPLAY': ':0', 21:39:23 INFO - 'HOME': '/home/cltbld', 21:39:23 INFO - 'LANG': 'en_US.UTF-8', 21:39:23 INFO - 'LANGUAGE': 'en_US:en', 21:39:23 INFO - 'LOGNAME': 'cltbld', 21:39:23 INFO - 'MAIL': '/var/mail/cltbld', 21:39:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:23 INFO - 'MOZ_NO_REMOTE': '1', 21:39:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:23 INFO - 'NO_EM_RESTART': '1', 21:39:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:39:23 INFO - 'PWD': '/builds/slave/test-pgo', 21:39:23 INFO - 'SHELL': '/bin/bash', 21:39:23 INFO - 'SHLVL': '1', 21:39:23 INFO - 'TERM': 'linux', 21:39:23 INFO - 'TMOUT': '86400', 21:39:23 INFO - 'USER': 'cltbld', 21:39:23 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058', 21:39:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:23 INFO - '_': '/tools/buildbot/bin/python'} 21:39:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:23 INFO - Downloading/unpacking blobuploader==1.2.4 21:39:23 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 21:39:23 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 21:39:23 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 21:39:23 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 21:39:23 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 21:39:23 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 21:39:25 INFO - Downloading blobuploader-1.2.4.tar.gz 21:39:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:39:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:39:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:39:25 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 21:39:25 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 21:39:25 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 21:39:25 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 21:39:25 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 21:39:25 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 21:39:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:39:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:39:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:39:25 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 21:39:25 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 21:39:25 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 21:39:25 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 21:39:25 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 21:39:25 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 21:39:25 INFO - Downloading docopt-0.6.1.tar.gz 21:39:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:39:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:39:25 INFO - Installing collected packages: blobuploader, requests, docopt 21:39:25 INFO - Running setup.py install for blobuploader 21:39:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:39:26 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:39:26 INFO - Running setup.py install for requests 21:39:26 INFO - Running setup.py install for docopt 21:39:26 INFO - Successfully installed blobuploader requests docopt 21:39:26 INFO - Cleaning up... 21:39:26 INFO - Return code: 0 21:39:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:39:26 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')]} 21:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:26 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')]} 21:39:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:26 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 0x7f2a6d61cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf953d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e8c0>, '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 0xfcb420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcb8b0>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058', '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 21:39:26 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 21:39:26 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 21:39:26 INFO - Using env: {'DISPLAY': ':0', 21:39:26 INFO - 'HOME': '/home/cltbld', 21:39:26 INFO - 'LANG': 'en_US.UTF-8', 21:39:26 INFO - 'LANGUAGE': 'en_US:en', 21:39:26 INFO - 'LOGNAME': 'cltbld', 21:39:26 INFO - 'MAIL': '/var/mail/cltbld', 21:39:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:26 INFO - 'MOZ_NO_REMOTE': '1', 21:39:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:26 INFO - 'NO_EM_RESTART': '1', 21:39:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:39:26 INFO - 'PWD': '/builds/slave/test-pgo', 21:39:26 INFO - 'SHELL': '/bin/bash', 21:39:26 INFO - 'SHLVL': '1', 21:39:26 INFO - 'TERM': 'linux', 21:39:26 INFO - 'TMOUT': '86400', 21:39:26 INFO - 'USER': 'cltbld', 21:39:26 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058', 21:39:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:26 INFO - '_': '/tools/buildbot/bin/python'} 21:39:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:39:26 INFO - Running setup.py (path:/tmp/pip-rIS2AG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:39:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:39:26 INFO - Running setup.py (path:/tmp/pip-9FTwlU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:39:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:39:26 INFO - Running setup.py (path:/tmp/pip-WOtnbk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:39:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:39:26 INFO - Running setup.py (path:/tmp/pip-R04zL8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:39:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:39:27 INFO - Running setup.py (path:/tmp/pip-QgNe3t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:39:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:39:27 INFO - Running setup.py (path:/tmp/pip-vwroCR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:39:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:39:27 INFO - Running setup.py (path:/tmp/pip-dzWRhs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:39:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:39:27 INFO - Running setup.py (path:/tmp/pip-XDKPCn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:39:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:39:27 INFO - Running setup.py (path:/tmp/pip-VCyqDe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:39:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:39:27 INFO - Running setup.py (path:/tmp/pip-6Z2TGT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:39:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:39:27 INFO - Running setup.py (path:/tmp/pip-MgLnKL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:39:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:39:27 INFO - Running setup.py (path:/tmp/pip-30iCyU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:39:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:39:27 INFO - Running setup.py (path:/tmp/pip-Me_xW1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:39:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:39:27 INFO - Running setup.py (path:/tmp/pip-ReTwv0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:39:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:39:27 INFO - Running setup.py (path:/tmp/pip-zBTMaj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:39:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:39:27 INFO - Running setup.py (path:/tmp/pip-tnodsX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:39:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:39:27 INFO - Running setup.py (path:/tmp/pip-29hXfi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:39:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:39:27 INFO - Running setup.py install for manifestparser 21:39:28 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:39:28 INFO - Running setup.py install for mozcrash 21:39:28 INFO - Running setup.py install for mozdebug 21:39:28 INFO - Running setup.py install for mozdevice 21:39:28 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:39:28 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:39:28 INFO - Running setup.py install for mozfile 21:39:28 INFO - Running setup.py install for mozhttpd 21:39:28 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:39:28 INFO - Running setup.py install for mozinfo 21:39:28 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:39:28 INFO - Running setup.py install for mozInstall 21:39:28 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:39:28 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:39:28 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:39:28 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:39:28 INFO - Running setup.py install for mozleak 21:39:28 INFO - Running setup.py install for mozlog 21:39:29 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:39:29 INFO - Running setup.py install for moznetwork 21:39:29 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:39:29 INFO - Running setup.py install for mozprocess 21:39:29 INFO - Running setup.py install for mozprofile 21:39:29 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:39:29 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:39:29 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:39:29 INFO - Running setup.py install for mozrunner 21:39:29 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:39:29 INFO - Running setup.py install for mozscreenshot 21:39:29 INFO - Running setup.py install for moztest 21:39:29 INFO - Running setup.py install for mozversion 21:39:29 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:39:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:39:29 INFO - Cleaning up... 21:39:29 INFO - Return code: 0 21:39:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:29 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 0x7f2a6d61cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf953d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e8c0>, '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 0xfcb420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcb8b0>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058', '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 21:39:29 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 21:39:29 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 21:39:29 INFO - Using env: {'DISPLAY': ':0', 21:39:29 INFO - 'HOME': '/home/cltbld', 21:39:29 INFO - 'LANG': 'en_US.UTF-8', 21:39:29 INFO - 'LANGUAGE': 'en_US:en', 21:39:29 INFO - 'LOGNAME': 'cltbld', 21:39:29 INFO - 'MAIL': '/var/mail/cltbld', 21:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:29 INFO - 'MOZ_NO_REMOTE': '1', 21:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:29 INFO - 'NO_EM_RESTART': '1', 21:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:39:29 INFO - 'PWD': '/builds/slave/test-pgo', 21:39:29 INFO - 'SHELL': '/bin/bash', 21:39:29 INFO - 'SHLVL': '1', 21:39:29 INFO - 'TERM': 'linux', 21:39:29 INFO - 'TMOUT': '86400', 21:39:29 INFO - 'USER': 'cltbld', 21:39:29 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058', 21:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:29 INFO - '_': '/tools/buildbot/bin/python'} 21:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:39:30 INFO - Running setup.py (path:/tmp/pip-3uraKu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:39:30 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)) 21:39:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:39:30 INFO - Running setup.py (path:/tmp/pip-TIC5hA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:39:30 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)) 21:39:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:39:30 INFO - Running setup.py (path:/tmp/pip-OgiGmV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:39:30 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)) 21:39:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:39:30 INFO - Running setup.py (path:/tmp/pip-HVeTGx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:39:30 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)) 21:39:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:39:30 INFO - Running setup.py (path:/tmp/pip-zdekPr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:39:30 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)) 21:39:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:39:30 INFO - Running setup.py (path:/tmp/pip-6ti_Xu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:39:30 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)) 21:39:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:39:30 INFO - Running setup.py (path:/tmp/pip-9l4ihL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:39:30 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)) 21:39:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:39:30 INFO - Running setup.py (path:/tmp/pip-QJ_xHV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:39:30 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)) 21:39:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:39:30 INFO - Running setup.py (path:/tmp/pip-_2L0ua-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:39:30 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)) 21:39:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:39:30 INFO - Running setup.py (path:/tmp/pip-67AwJs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:39:30 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)) 21:39:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:39:30 INFO - Running setup.py (path:/tmp/pip-zKGP6C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:39:30 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)) 21:39:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:39:30 INFO - Running setup.py (path:/tmp/pip-q36Ck6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:39:30 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)) 21:39:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:39:30 INFO - Running setup.py (path:/tmp/pip-ERuyOm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:39:30 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)) 21:39:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:39:30 INFO - Running setup.py (path:/tmp/pip-KiVJ9Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:39:31 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)) 21:39:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:39:31 INFO - Running setup.py (path:/tmp/pip-dVh8cK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:39:31 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)) 21:39:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:39:31 INFO - Running setup.py (path:/tmp/pip-ONfmeG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:39:31 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)) 21:39:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:39:31 INFO - Running setup.py (path:/tmp/pip-Xa7TCo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:39:31 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)) 21:39:31 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)) 21:39:31 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)) 21:39:31 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)) 21:39:31 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)) 21:39:31 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)) 21:39:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:39:31 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 21:39:31 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 21:39:31 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 21:39:31 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 21:39:31 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 21:39:31 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 21:39:32 INFO - Downloading blessings-1.5.1.tar.gz 21:39:32 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 21:39:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:39:32 INFO - Installing collected packages: blessings 21:39:32 INFO - Running setup.py install for blessings 21:39:33 INFO - Successfully installed blessings 21:39:33 INFO - Cleaning up... 21:39:33 INFO - Return code: 0 21:39:33 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:39:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:39:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:39:33 INFO - Reading from file tmpfile_stdout 21:39:33 INFO - Current package versions: 21:39:33 INFO - argparse == 1.2.1 21:39:33 INFO - blessings == 1.5.1 21:39:33 INFO - blobuploader == 1.2.4 21:39:33 INFO - docopt == 0.6.1 21:39:33 INFO - manifestparser == 1.1 21:39:33 INFO - mozInstall == 1.12 21:39:33 INFO - mozcrash == 0.16 21:39:33 INFO - mozdebug == 0.1 21:39:33 INFO - mozdevice == 0.47 21:39:33 INFO - mozfile == 1.2 21:39:33 INFO - mozhttpd == 0.7 21:39:33 INFO - mozinfo == 0.9 21:39:33 INFO - mozleak == 0.1 21:39:33 INFO - mozlog == 3.0 21:39:33 INFO - moznetwork == 0.27 21:39:33 INFO - mozprocess == 0.22 21:39:33 INFO - mozprofile == 0.27 21:39:33 INFO - mozrunner == 6.11 21:39:33 INFO - mozscreenshot == 0.1 21:39:33 INFO - mozsystemmonitor == 0.0 21:39:33 INFO - moztest == 0.7 21:39:33 INFO - mozversion == 1.4 21:39:33 INFO - psutil == 3.1.1 21:39:33 INFO - requests == 1.2.3 21:39:33 INFO - wsgiref == 0.1.2 21:39:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:33 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 0x7f2a6d61cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf953d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e8c0>, '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 0xfcb420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcb8b0>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058', '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 21:39:33 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 21:39:33 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 21:39:33 INFO - Using env: {'DISPLAY': ':0', 21:39:33 INFO - 'HOME': '/home/cltbld', 21:39:33 INFO - 'LANG': 'en_US.UTF-8', 21:39:33 INFO - 'LANGUAGE': 'en_US:en', 21:39:33 INFO - 'LOGNAME': 'cltbld', 21:39:33 INFO - 'MAIL': '/var/mail/cltbld', 21:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:33 INFO - 'MOZ_NO_REMOTE': '1', 21:39:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:33 INFO - 'NO_EM_RESTART': '1', 21:39:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:39:33 INFO - 'PWD': '/builds/slave/test-pgo', 21:39:33 INFO - 'SHELL': '/bin/bash', 21:39:33 INFO - 'SHLVL': '1', 21:39:33 INFO - 'TERM': 'linux', 21:39:33 INFO - 'TMOUT': '86400', 21:39:33 INFO - 'USER': 'cltbld', 21:39:33 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058', 21:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:33 INFO - '_': '/tools/buildbot/bin/python'} 21:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:33 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)) 21:39:33 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)) 21:39:33 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)) 21:39:33 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)) 21:39:33 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)) 21:39:33 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)) 21:39:33 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)) 21:39:33 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)) 21:39:33 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)) 21:39:33 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)) 21:39:33 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)) 21:39:33 INFO - Cleaning up... 21:39:33 INFO - Return code: 0 21:39:33 INFO - Running post-action listener: _resource_record_post_action 21:39:33 INFO - Running post-action listener: _start_resource_monitoring 21:39:33 INFO - Starting resource monitoring. 21:39:33 INFO - ##### 21:39:33 INFO - ##### Running install step. 21:39:33 INFO - ##### 21:39:33 INFO - Running pre-action listener: _resource_record_pre_action 21:39:33 INFO - Running main action method: install 21:39:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:39:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:39:33 INFO - Reading from file tmpfile_stdout 21:39:33 INFO - Detecting whether we're running mozinstall >=1.0... 21:39:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:39:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:39:33 INFO - Reading from file tmpfile_stdout 21:39:33 INFO - Output received: 21:39:33 INFO - Usage: mozinstall [options] installer 21:39:33 INFO - Options: 21:39:33 INFO - -h, --help show this help message and exit 21:39:33 INFO - -d DEST, --destination=DEST 21:39:33 INFO - Directory to install application into. [default: 21:39:33 INFO - "/builds/slave/test-pgo"] 21:39:33 INFO - --app=APP Application being installed. [default: firefox] 21:39:33 INFO - mkdir: /builds/slave/test-pgo/build/application 21:39:33 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'] 21:39:33 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 21:39:48 INFO - Reading from file tmpfile_stdout 21:39:48 INFO - Output received: 21:39:48 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:39:48 INFO - Running post-action listener: _resource_record_post_action 21:39:48 INFO - ##### 21:39:48 INFO - ##### Running run-tests step. 21:39:48 INFO - ##### 21:39:48 INFO - Running pre-action listener: _resource_record_pre_action 21:39:48 INFO - Running main action method: run_tests 21:39:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:39:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:39:48 INFO - Python 2.7.3 21:39:48 INFO - Return code: 0 21:39:48 INFO - grabbing minidump binary from tooltool 21:39:48 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')]} 21:39:48 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 0x101e8c0>, '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 0xfcb420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcb8b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:39:48 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 21:39:48 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 21:39:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:39:48 INFO - Return code: 0 21:39:48 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:39:48 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:39:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:39:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:39:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:39:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 21:39:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost 21:39:48 INFO - Using env: {'DISPLAY': ':0', 21:39:48 INFO - 'HOME': '/home/cltbld', 21:39:48 INFO - 'LANG': 'en_US.UTF-8', 21:39:48 INFO - 'LANGUAGE': 'en_US:en', 21:39:48 INFO - 'LOGNAME': 'cltbld', 21:39:48 INFO - 'MAIL': '/var/mail/cltbld', 21:39:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:39:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:48 INFO - 'MOZ_NO_REMOTE': '1', 21:39:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:48 INFO - 'NO_EM_RESTART': '1', 21:39:48 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:39:48 INFO - 'PWD': '/builds/slave/test-pgo', 21:39:48 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:39:48 INFO - 'SHELL': '/bin/bash', 21:39:48 INFO - 'SHLVL': '1', 21:39:48 INFO - 'TERM': 'linux', 21:39:48 INFO - 'TMOUT': '86400', 21:39:48 INFO - 'USER': 'cltbld', 21:39:48 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058', 21:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:48 INFO - '_': '/tools/buildbot/bin/python'} 21:39:48 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost'] with output_timeout 3600 21:39:48 INFO - mozversion INFO | application_buildid: 20151113193353 21:39:48 INFO - mozversion INFO | application_changeset: ee68d52994d9aee5e4a6289ee1fff316c8cbdeba 21:39:48 INFO - mozversion INFO | application_display_name: Nightly 21:39:48 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:39:48 INFO - mozversion INFO | application_name: Firefox 21:39:48 INFO - mozversion INFO | application_remotingname: firefox 21:39:48 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:39:48 INFO - mozversion INFO | application_vendor: Mozilla 21:39:48 INFO - mozversion INFO | application_version: 45.0a1 21:39:48 INFO - mozversion INFO | platform_buildid: 20151113193353 21:39:48 INFO - mozversion INFO | platform_changeset: ee68d52994d9aee5e4a6289ee1fff316c8cbdeba 21:39:48 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:39:48 INFO - mozversion INFO | platform_version: 45.0a1 21:39:48 INFO - 2015-11-13 21:39:48,515 DEBUG : using testdate: 1447479588 21:39:48 INFO - 2015-11-13 21:39:48,515 DEBUG : actual date: 1447479588 21:39:48 INFO - 2015-11-13 21:39:48,561 INFO : starting webserver on 'localhost:34920' 21:39:48 INFO - 2015-11-13 21:39:48,562 INFO : Starting test suite talos-linux64-ix-032.e 21:39:48 INFO - 2015-11-13 21:39:48,563 INFO : Starting test dromaeo_css 21:39:48 INFO - 2015-11-13 21:39:48,563 DEBUG : operating with platform_type : linux_ 21:39:48 INFO - 2015-11-13 21:39:48,563 INFO : Initialising browser for dromaeo_css test... 21:39:48 INFO - 2015-11-13 21:39:48,573 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7JTo0z/profile http://localhost:34920/getInfo.html 21:39:58 INFO - 2015-11-13 21:39:58,812 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:39:58 INFO - 2015-11-13 21:39:58,813 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:39:58 INFO - 2015-11-13 21:39:58,813 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:39:58 INFO - 2015-11-13 21:39:58,813 DEBUG : BROWSER_OUTPUT: __metrics 21:40:00 INFO - 2015-11-13 21:40:00,112 INFO : Browser initialized. 21:40:00 INFO - 2015-11-13 21:40:00,112 INFO : Running cycle 1/1 for dromaeo_css test... 21:40:00 INFO - 2015-11-13 21:40:00,113 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7JTo0z/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:40:11 INFO - 2015-11-13 21:40:11,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 141582336 21:40:11 INFO - 2015-11-13 21:40:11,876 DEBUG : BROWSER_OUTPUT: 21:41:01 INFO - 2015-11-13 21:41:01,500 DEBUG : BROWSER_OUTPUT: 1447479661498 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] 21:43:10 INFO - 2015-11-13 21:43:10,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34920/tests/dromaeo/cssquery-ext.html) 21:43:11 INFO - 2015-11-13 21:43:11,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 146571264 21:43:11 INFO - 2015-11-13 21:43:11,113 DEBUG : BROWSER_OUTPUT: 21:46:12 INFO - 2015-11-13 21:46:12,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/dromaeo/cssquery-ext.html (next: http://localhost:34920/tests/dromaeo/cssquery-jquery.html) 21:46:13 INFO - 2015-11-13 21:46:13,531 DEBUG : BROWSER_OUTPUT: RSS: Main: 143138816 21:46:13 INFO - 2015-11-13 21:46:13,531 DEBUG : BROWSER_OUTPUT: 21:49:15 INFO - 2015-11-13 21:49:15,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34920/tests/dromaeo/cssquery-mootools.html) 21:49:15 INFO - 2015-11-13 21:49:15,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 141422592 21:49:15 INFO - 2015-11-13 21:49:15,790 DEBUG : BROWSER_OUTPUT: 21:52:17 INFO - 2015-11-13 21:52:17,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34920/tests/dromaeo/cssquery-prototype.html) 21:52:17 INFO - 2015-11-13 21:52:17,997 DEBUG : BROWSER_OUTPUT: RSS: Main: 140132352 21:52:17 INFO - 2015-11-13 21:52:17,997 DEBUG : BROWSER_OUTPUT: 21:55:20 INFO - 2015-11-13 21:55:20,240 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34920/tests/dromaeo/cssquery-yui.html) 21:55:20 INFO - 2015-11-13 21:55:20,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 139948032 21:55:20 INFO - 2015-11-13 21:55:20,843 DEBUG : BROWSER_OUTPUT: 21:58:23 INFO - 2015-11-13 21:58:23,147 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/dromaeo/cssquery-yui.html (next: http://localhost:34920/tests/dromaeo/cssquery-dojo.html) 21:58:23 INFO - 2015-11-13 21:58:23,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 143810560 21:58:23 INFO - 2015-11-13 21:58:23,398 DEBUG : BROWSER_OUTPUT: 21:58:23 INFO - 2015-11-13 21:58:23,398 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:58:23 INFO - 2015-11-13 21:58:23,398 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:58:23 INFO - 2015-11-13 21:58:23,399 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:58:23 INFO - 2015-11-13 21:58:23,399 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:58:23 INFO - 2015-11-13 21:58:23,400 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3229.1442767666567;3241.465158248889;3277.573915390999;3281.5733954585908;3285.1458620758613;5392.083345831208;5410.026195284852;5423.864403389917;5436.1030429979055;5442.2380866678695;5406.107992181295;5418.512333889949;5535.25274087998;5555.583331250152;5567.972160139194;4670.392848929651;4934.21052631579;5129.0767661820855;5139.691618502883;5152.819651312205;4909.975450122744;5105.18317069269;5131.179011358184;5132.204508301219;5176.275321454999;4910.680805747633;4958.033183529214;4970.378702662168;5025.346704928336;5033.874153146164;5016.673916195472;5036.697798132087;5045.974770126162;5066.746662666888;5087.669301495391;4931.580815630676;4991.7753701083175;5036.06832735945;5044.041632089891;5045.192769156954;5286.682799032071;5297.152455607123;5297.629165958385;5307.203919412081;5341.519263266325;5935.317438494585;5952.761889524414;5966.343702192756;5971.134185543072;5988.461038506512;5793.565482588822;5858.12128180772;5904.291485021782;6014.639121652671;6016.127661489103;5620.156976453564;5628.690422026787;5637.9718101409235;5644.238027866227;5647.37878833328;6036.667983260875;6060.121282414113;6065.727042283108;6068.757249709962;6072.119542666289;5667.603267771216;5739.7704091836695;5832.416758324133;5835.824925252249;5973.283206015306;5959.22530071088;5962.1056841473255;5969.194158788508;5976.671283079386;5983.760649574056;5911.733971971272;5931.288245410578;5931.347551769388;5946.762129514771;5947.851303717442;5753.309602847685;5844.298684157929;5980.55145864062;6075.848103797441;6107.664078475637;4551.362809206714;4561.361409402686;4564.863054108382;4573.108243892476;4591.724496530219;3981;4058.9797051014557;4063.512378514597;4092.897677558085;4094.0174358153827;5586.832395028156;5618.157276408489;5648.237487939158;5672.205891175238;5701.372848986608;5906.26171728534;5936.821895343147;5938.287405511366;5938.792142275;5941.138534912414;5590.580706447033;5637.661740295595;5662.405447428043;5675.744591493392;5689.743961521742;5044.319016932667;5111.591072714174;5126.512981266774;5136.43499215086;5174.534291913746;6128.1726966858905;6137.662428566382;6149.108379285068;6153.907691384633;6157.353477884758;5829.795957141479;5924.703764811656;5956.076808094752;5959.225300711053;5959.791407300897;6109.938900610937;6114.847128821637;6161.168242287234;6179.412955769195;6187.504999599932;5814.505767009682;5935.792247271324;5943.851403714942;5953;5957.553183511167;5854.414558544111;5865.530757539472;5972.223610930551;6016.187814644967;6050.515958723379;5816.883662326814;5877.706114694162;5881.147233651182;5883.794067207627;5883.882322353615;5832.708364581838;5851.1515830205235;5867.501262392574;5874.706264686663;5881.73532191061;5552.167174923794;5654.6889921054735;5711.914321285267;5735.426457354231;5798.6810725410505;5757.913631295618;5773.1051686988585;5790.305163380422;5852.707364631837;5854.0340843760305;5682.6306290091015;5700.2304688868135;5706.058500347396;5710.714464276686;5710.914336284876 21:58:23 INFO - 2015-11-13 21:58:23,404 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.3622709362232;585.6720236667466;594.1207013619843;615.8799034188332;619.5879739972918;31148;31842;40031.99920001998;40044.398224071;40078.19843603126;43321.78339108308;43961.34057989133;44150.33774493377;44155.55844441555;44269;8698.91301086989;8876.911230887674;8877.556122193897;8878.467291962503;8892.333075019367;8653.913460865373;8741.694040708577;8744;8749;8776;8683.522406267653;8722.563871806417;8740.038595754462;8759.080296568864;8805.119488051208;8699.695510657097;8713.782155446133;8724.738257852274;8809.207171354577;8810.163034511743;8597.484150950962;8698.130186981314;8728.694495692684;8736.388452808305;8739.431936924144;39768.60231397678;40206.19587608261;40332;40347;40768.38847417291;3270.280538281574;3373.662633736631;3390.440577304742;3424.931501369959;3696.759710618828;29989.400211995857;30607;30639.234019149477;30680.232994175323;30977.845110774528;3272.836358182105;3378.341223461426;3412.6587341265677;3420.435628121357;3439.8968030959113;280094;280449;280503;280624;282072.58963705256;56263.43736562664;56793.14810277849;57069;58144;65378;61250.69374653188;61393.386066138766;61502;61508.384916150266;61936.38063619306;16295.266712997944;16508.25712842901;16538.751918721227;16542.503724888273;16590.08754518513;12181.756364872654;12237.938810305892;12266.938665306616;12294.446749896277;12311.322877241659;19766.70349944752;20165.596688066158;20315.492112697302;20343.389698309074;20460;7796;7820.475007373508;8044.235797599219;8094.635741391651;8134.674613015532;967.4243824924159;968.5254225429488;987.5852142100335;1062.617457715222;1138.2430683595317;28604.427911441653;28775.85612071968;28982.710172898;29019.10600559497;29085.709142908723;998.9300748947504;1006.3659894266711;1059.5604417490842;1101.8292164714483;1125.5104029747085;14945.850541494447;15092.396304147931;15174.696506069817;15286.923565382102;15326.157061361731;314993;318870;319425;320371;323594;53328;53349;53629.7318513405;53738;53982.730086349315;1315.414640484975;1317.1109501086728;1320.2672516753294;1321.4317843327462;1347.818044563991;27699.307517311423;28528.714712852605;28825.855870720512;28852.134435966953;28905.42189156163;47708.7614561925;48032.75983620199;48069.75965120152;48125.278120828916;48328.758356207996;287808;289780;289828;290206;291477;32880;33060;33135.33729325448;33497.33005339928;33523.83238083794;40333.39499907562;40381.596184037786;41169;41352.58647413608;41391.37912931369;35891.64108358883;36598.8170059148;36939.44590831194;37270;37826;36534.45198321974;36600.01399006735;37217.44173837449;37261.25477490489;37386.252274953804;35454;36834.07914802151;36993.63006369902;37074.443883341235;37075;33357.499637504974;36376.27247455089;36514.45228321524;36693.816530917175;37270.813645931594;25148.74851251464;25578.360540986625;25649.871750641127;25730.614040789027;26217 21:58:23 INFO - 2015-11-13 21:58:23,404 DEBUG : BROWSER_OUTPUT: |2;jquery.html;324.68343365218914;345.1182229403875;347.3071222910294;349.11673466130696;351.565816216972;12591.874081259184;12974.221546707204;16847.831521684795;17291.481255562336;18872.150753216105;11143.944280278587;11154.442277886114;11163;11233.157513186503;11438.542458301657;4401.515833258347;4516.209663308924;4528.388667529891;4534.251848445003;4541.069080838437;4480.932786008212;4748.881277968044;4844.031193761261;4845.37010188675;4855.393075865517;4734.692245004064;4799.18413869643;4808.062427826575;4808.591269742076;4812.205986012304;4816.868036011534;4833.758312084382;4838.153323168449;4858.246971719389;4865.489123642002;4166.0626359068965;4194.454720886296;4268.676710219842;4283.2932566126865;4317.503487098961;12249.816252756216;12384.442700078427;12547.623571292785;12742.936285318607;12751.681207969783;2046.4270004398793;2053.620080285152;2063.535704466498;2101.8423618228694;2115.8942052897446;10125.240606954509;10175.59297628094;10240.334378265388;10409.3754374737;10412.42731649759;1698.770665960092;1740.4952563756494;1745.6209594420393;1797.3170195325692;1797.5146710388121;60200.397996019914;61408.69295653538;62746.37253627451;63484.36515634831;63610.68194658997;6944.722211111499;7028.402585780266;7048.154221493453;7123.501354905107;7211.675474603656;8541.658333666584;8563.33015062057;8578;8584.141585841491;8618.353623478139;5703.40114288002;5706;5745.339285982165;5793.449622285961;5807.5063619591965;5709.115087161496;5709.7716091356715;5726.914096288559;5772.451617096369;5774.595778295479;3257.397381484433;3259.9022029339158;3265.526498657729;3278.098522906172;3297.6207736110655;1177.5407591039502;1181.078758568318;1181.2321990705939;1191.1780871198846;1228.0912125027414;433.1380552700104;481.2732773512022;484.56147186796005;492.1289317907284;493.11731999720814;11190.38452885083;11350.375729334966;11532.25040372373;11671.88328116708;12190.390480476119;484.9927251091236;497.2789455289844;506.1269310439536;508.1869009584635;512.7538781384956;6371.840703982438;6402.743890244431;6473.838154046187;6481.870362592722;6519.706613202417;557041;560641;563972;565943;566398;75426;78544;78940.60529697315;78950.6052469734;79173.20826791774;556.1268807971446;562.5345973738353;563.5069314349944;564.3904583050296;565.9971700141556;10750.73123171927;10872.67381978542;10948.507317170906;11115.944420277847;11233.438328083726;34250.50271766253;37187.6281237195;37297.81351093227;38046.048848779;39144.80427597958;46972.29541556811;47273.29090063583;48220;48342;48668;6972.4073453757;7051.717931282691;7104.431645468453;13236.470541178245;13628.523001694894;9877;18456.538586535444;18705.625887481903;18734.90632546883;19176.616467670847;8219.794505137419;8527.658893644184;8722.825543489222;9238.95380523093;9342.065793420603;9166.770830729285;9252.629894804133;9297.535123243946;9342.719718408458;9515.904840951502;9115.954420227856;9466.905330946878;9662.033796620282;9707.9029209707;9725.80548389014;14308.713825723635;14403.567892963229;14536.491222807152;14600.85399145995;14620;15523.534293971199;15591.688166236838;15890.68218635644;16012.839871601602;16033 21:58:23 INFO - 2015-11-13 21:58:23,405 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1490.2176357412357;1493.1936754152757;1613.3627217249193;1709.3846215362466;1770.7520947067412;7441.255874412556;7525.962370188141;7656;7672.386209103272;7703.268189521993;7293.525920815143;7332.560046397207;7400.370968467687;7429.517081389719;7476.514026588282;2178.0416616688644;2203.063697928382;2207.878566678832;2210.546837898227;2217.966730499044;2189.5839790439763;2193.254293540196;2232.910683572655;2249.134083377903;2255.436140964759;2176.075168053571;2201.8678879267213;2207.9779202208015;2228.231260215231;2228.832837537191;2199.417154454071;2226.4545186429345;2232.787885150908;2235.7540670526228;2240.047979608668;2167.837412194092;2219.8002179803734;2232.6539386395134;2235.7428895677044;2242.338510139513;7422.480426370156;7470.775876723707;7497.550146991198;7507.662155203029;7508.0990281166605;4495.213337665896;4579.702319349231;4602.401687780601;4605.078984203173;4609.723416595015;2951.0851635992913;2963.273997870514;3014.954775678367;3017.0647099399257;3031.8180909145303;959.0531221620053;977.0815433492494;977.0815433492494;979.6669132494915;998.1515711645117;10024.398536087858;10089.545970431349;10117.645882394154;10131.44277064761;10131.544080516394;3943.073377756225;3972.1261322509004;3988.4216788565495;4010.859619913289;4020.2562525932794;8378.287845533197;8392;8403.159684031549;8405.243528082501;8422.915770842335;4422.137683151819;4455.086707225011;4461.13007963444;4471.709338892962;4479.686421950498;4102.405151253051;4107.075907920754;4117;4132.8140233689555;4139.0480189555965;3294.011796461052;3320.8007519548905;3338.4157772389735;3338.9332213355597;3351.162209447638;975.9707208783748;993.1707024634367;999.7450650084182;1011.4942528735633;1011.5094179323022;1038.5378506564657;1055.3298655353906;1110.5446766825562;1198.5026214121042;1332.2073366347008;7095.113110861143;7129.073220481408;7172.067631208014;7195;7223.783286501413;1088.3089238333714;1101.1026013798728;1105.4583254205381;1113.7549739057395;1122.2424863217295;5491.917621235684;5509.00837849183;5548.195511650869;5559.999200143932;5586.441355864381;8820.558972051373;8874.64501419936;9110.908890911007;9124.17882390588;9194.632214711337;8979.551022448852;9013.729588112366;9029.77425564366;9080.40977336471;9122.407043542149;6873.931260687429;6942.479314051366;7029.156501219886;7074.823129421806;7131.643417829087;6869.931300687129;6884.277150899084;6896.137982752156;6903.723851046103;6916.170059592881;7753.92246077532;8000.51996880189;8012.198780121941;8028.638711258124;8126.146754590919;8040.276375126266;8189.426740128372;8247.835043299221;8251.876221856557;8288.254057134887;6305.211848518935;6327.050942358683;6355.650439225887;6405.135306733531;6411.0383442484;7273.781786546412;7360.926390736024;7363.77908662741;7372.96313518429;7395;6901.585904845725;6955.269696681776;6963.234044255027;7075.363217310467;7079.539829911039;6390.52071094679;6775.424088952297;6856.040154378491;6871.244163142151;6926;6883.242843287335;6906.551074180162;6910.965445172742;6944.236134025152;6994.405475534637;5809.622374545641;5926.762929482772;5964.612300200473;6010.759569617341;6204.348543403058;6261.154744109487;6380.776672816429;6382.776602818879;6408.967955160194;6418.967905160631 21:58:23 INFO - 2015-11-13 21:58:23,406 DEBUG : BROWSER_OUTPUT: |4;prototype.html;306.0710742895312;309.1482964432987;310.4721972646499;311.73502522855574;312.40954595813906;6264.84337891553;6370.840728981778;6374.968125159374;6417.197850268716;6422.0045892886565;6306.747730090802;6316.052592111186;6319.241690997075;6328.557001009931;6334.873302533946;4610.354550362952;4663.417072865892;4704.082703872755;4723.929141062887;4725.102230576197;4670.836520721776;4698.694584851991;4700.341952126705;4702.882427939295;4734.857954261378;4667;4667.953320466786;4676.3453116563705;4680.625549955996;4689.788959496831;4657.04530571232;4665.930011049837;4672.579467847893;4676.018036212399;4687.062587482517;3840.7503512271614;3992.3811809169333;4007.499062617173;4017.8392864285393;4019.457373254632;5916.378780228057;5975.52195824333;5983.653677922476;5998;6012.549058820606;5427.267318911975;5430.56555475561;5448.101063324547;5454.836354909359;5462.918056229159;6660.067590537328;6708.530402871801;6716.6305853178055;6719.462443004548;6727.798166055026;4338.783060846945;4370.060437006027;4411.117776444692;4423;4424.048829501673;6905.689243984033;6970.58176509406;6987.196472405688;6991.126109236346;7018.263082376379;4502.932456013163;4530.29780384041;4531.773411329486;4534.841280555164;4553.2942393929;4500.932486012713;4565.292379681155;4574.428196475441;4575.107853968444;4585.403897493305;5368.463153684678;5405.729713514387;5412.052890744104;5429.511343979061;5434.91847622286;6729.327067293231;6767.018782276542;6773.559718618274;6777.118974533378;6784.0841486399695;1589.9761503577456;1596.4013494939397;1600.439846053895;1601.6076061364806;1602.9679406411806;1026.1739299863532;1026.3277553202665;1041.1358572384902;1046.4453839465095;1049.9737506562244;6544.640044797487;6555.541112122106;6567.737290508326;6588.769393071219;6593.076969224312;6938.271481494471;6993.2657071007825;7009.4392448603985;7011.719531218694;7031.542949708252;6432.35676432353;6473.126127972758;6564.573302735403;6570.671466426659;6578.80263592093;3814.904627384338;3827.1962887793875;3829.8276577554075;3833.6549710526187;3834.424836274525;7159.642017899084;7265.055542779405;7349.081364829396;7350.228226036296;7363.889541656879;7246.5289756165685;7274.818129546804;7281.1262648482525;7283.781486555412;7292.161401438902;7162.856742865113;7280.96359518199;7295.161056478467;7313.561186328731;7332.266773322732;7010.088688470466;7026.016357710027;7056.682449289691;7076.540024898365;7085.326893945067;6939.722411103701;6963.825904352431;6972.895406569007;6974.163100427981;6980.371766541036;7139.964705117833;7275.163356214103;7298.708051677873;7324.5971471567445;7339.889901651586;4521.299198624219;4547.840825571221;4549.158405694957;4551.249043907718;4554.43069616298;6997.615131167835;7046.682899269443;7051.330123638246;7061.622983518165;7073.257307982588;6603.966980165068;6771.28901465339;6778.423833974168;6783.525153239226;6795.864082718417;6753.2233793112455;6759.526833121831;6764.661766911733;6786.3892249697765;6789.762358317435;6626.966865165643;6663.600183988976;6675.732970681119;6678.83302917431;6680.565763225375;6684.665766711742;6760.560563563353;6811.4550835934;6823.078884350549;6828.829279268058;6603.306652801387;6612.537122401578;6619.735210591522;6623.801285961429;6639.468842492685 21:58:23 INFO - 2015-11-13 21:58:23,407 DEBUG : BROWSER_OUTPUT: |5;yui.html;706.4066184405102;722.931321524455;752.2928447259576;837.8743188521721;854.6666799948022;13733.313334333281;14078.929605351985;14107.929460352696;14139.08095973761;14145.929270353634;12267.263964162157;12444.813327800068;12485.250884946887;12496.875031249685;12510.562130325441;820.261764412028;835.4736515994915;836.564986207172;838.5849004742661;841.9579021048954;827.123249355685;835.9164083591622;836.1513064239771;836.9246767790897;836.9288610468118;861.0657436681208;862.9601330396888;866.956652167389;872.2585802068255;873.8645509945968;858.4934888415802;861.6639510590875;865.7792262972964;865.9090795466449;868.6264906090379;627.7489004398232;629.9307076221612;631.5768435148461;634.6636282770139;635.6694518850172;12463.563775267912;12465.813012804816;12611.117221794479;12635.11554191207;12669.873301266962;10918.617848375348;10995.450227488673;11037.779244415147;11164;11208.21542492026;9986.35088719231;9999;10040.397576145455;10058.89941100587;10439.112675422522;3529.993951723772;3546.733994950389;3579.0873327301633;3614.168741189515;3697.0757310672334;44782.104357912656;45343.09313813738;46205;46450.76774616105;50741.49258507405;7184.281571842774;7215.855682886313;7218.133823941055;7370.041894553781;7411.740589079464;11740.70648233801;11833.349165795791;11842.230255033568;11853.170278080624;11891.04871610269;6545.738170473128;6629.767958121539;6686.899696504556;6769.120014398195;6816.48876334267;4396.758178300224;4414.735115893057;4461.375407442961;4488.1248156609145;4558.020025694492;2649.7085320614715;2650.880710368038;2663.8668066596592;2669.8531580762856;2670.452557225764;409.3103121240719;411.4058025152534;414.9585041495887;417.2489518866029;424.60511724096887;598.796409220867;637.6939069246788;670.4033410264868;674.8481591641842;678.725116327888;8513.702020429255;9075.909240907506;9160.450372977642;9302.720918372459;9306.208972237435;530.3715097609345;535.7107162132482;548.2187882267752;616.9850595769933;617.197643064015;3743.6256374362347;3873.4189871519498;3888.8250028748776;3932.0956180078742;4012.959870401317;54690;54740.178897316575;54918;55152;55439.168412473846;47562;48724.75637621789;49119;49305.75347123313;49633.75183124061;40153;43887;48484.757576211894;52647.73676131595;52715.472845271055;8413.915860841313;8522.147785221676;8532.829343413221;8572.52851093196;8673.164314757216;34883.47674784931;35296.64703353036;35780.28439431145;35868;36099;45056.77471612621;45330.32004519869;45547.31679024751;47939.28091078567;48741.268880967524;7752.4573279869865;7782.182870798485;7832.608369581612;7836.84326313482;7932.246436588515;11697;12086.939565302117;12137.69655758613;12292.815607765711;13061.34693265352;10976.506057227285;10999.945000275267;11038.337699738042;11212.327260364404;11533.82699259495;11627;11836.526538938346;12032.518699251932;12062.457189426672;12235.388230588613;10251.58993640246;10816.454374608453;11058;11150.386728729998;11404.144689148181;9615.471149086588;9701.563429645541;9767.779027621547;9861.704148875546;10269.281150319406;8786.209241168326;8844.292456603327;9007.189352958265;9803.16673082796;9836.606535738776 21:58:23 INFO - 2015-11-13 21:58:23,407 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:58:23 INFO - 2015-11-13 21:58:23,407 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:58:23 INFO - 2015-11-13 21:58:23,407 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,283 21:58:23 INFO - 2015-11-13 21:58:23,408 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:58:23 INFO - 2015-11-13 21:58:23,408 DEBUG : BROWSER_OUTPUT: __startTimestamp1447480703397__endTimestamp 21:58:23 INFO - 2015-11-13 21:58:23,408 DEBUG : BROWSER_OUTPUT: 21:58:23 INFO - 2015-11-13 21:58:23,408 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:58:23 INFO - 2015-11-13 21:58:23,408 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:58:23 INFO - 2015-11-13 21:58:23,408 DEBUG : BROWSER_OUTPUT: 21:58:23 INFO - 2015-11-13 21:58:23,408 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5510.99 Median:5710.91 stddev:626.72 (11.0%) stddev-sans-first:602.54 21:58:23 INFO - 2015-11-13 21:58:23,408 DEBUG : BROWSER_OUTPUT: Values: 3229.1 3241.5 3277.6 3281.6 3285.1 5392.1 5410.0 5423.9 5436.1 5442.2 5406.1 5418.5 5535.3 5555.6 5568.0 4670.4 4934.2 5129.1 5139.7 5152.8 4910.0 5105.2 5131.2 5132.2 5176.3 4910.7 4958.0 4970.4 5025.3 5033.9 5016.7 5036.7 5046.0 5066.7 5087.7 4931.6 4991.8 5036.1 5044.0 5045.2 5286.7 5297.2 5297.6 5307.2 5341.5 5935.3 5952.8 5966.3 5971.1 5988.5 5793.6 5858.1 5904.3 6014.6 6016.1 5620.2 5628.7 5638.0 5644.2 5647.4 6036.7 6060.1 6065.7 6068.8 6072.1 5667.6 5739.8 5832.4 5835.8 5973.3 5959.2 5962.1 5969.2 5976.7 5983.8 5911.7 5931.3 5931.3 5946.8 5947.9 5753.3 5844.3 5980.6 6075.8 6107.7 4551.4 4561.4 4564.9 4573.1 4591.7 3981.0 4059.0 4063.5 4092.9 4094.0 5586.8 5618.2 5648.2 5672.2 5701.4 5906.3 5936.8 5938.3 5938.8 5941.1 5590.6 5637.7 5662.4 5675.7 5689.7 5044.3 5111.6 5126.5 5136.4 5174.5 6128.2 6137.7 6149.1 6153.9 6157.4 5829.8 5924.7 5956.1 5959.2 5959.8 6109.9 6114.8 6161.2 6179.4 6187.5 5814.5 5935.8 5943.9 5953.0 5957.6 5854.4 5865.5 5972.2 6016.2 6050.5 5816.9 5877.7 5881.1 5883.8 5883.9 5832.7 5851.2 5867.5 5874.7 5881.7 5552.2 5654.7 5711.9 5735.4 5798.7 5757.9 5773.1 5790.3 5852.7 5854.0 5682.6 5700.2 5706.1 5710.7 5710.9 21:58:23 INFO - 2015-11-13 21:58:23,409 DEBUG : BROWSER_OUTPUT: 21:58:23 INFO - 2015-11-13 21:58:23,409 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47055.14 Median:36763.95 stddev:77575.71 (211.0%) stddev-sans-first:77714.77 21:58:23 INFO - 2015-11-13 21:58:23,410 DEBUG : BROWSER_OUTPUT: Values: 557.4 585.7 594.1 615.9 619.6 31148.0 31842.0 40032.0 40044.4 40078.2 43321.8 43961.3 44150.3 44155.6 44269.0 8698.9 8876.9 8877.6 8878.5 8892.3 8653.9 8741.7 8744.0 8749.0 8776.0 8683.5 8722.6 8740.0 8759.1 8805.1 8699.7 8713.8 8724.7 8809.2 8810.2 8597.5 8698.1 8728.7 8736.4 8739.4 39768.6 40206.2 40332.0 40347.0 40768.4 3270.3 3373.7 3390.4 3424.9 3696.8 29989.4 30607.0 30639.2 30680.2 30977.8 3272.8 3378.3 3412.7 3420.4 3439.9 280094.0 280449.0 280503.0 280624.0 282072.6 56263.4 56793.1 57069.0 58144.0 65378.0 61250.7 61393.4 61502.0 61508.4 61936.4 16295.3 16508.3 16538.8 16542.5 16590.1 12181.8 12237.9 12266.9 12294.4 12311.3 19766.7 20165.6 20315.5 20343.4 20460.0 7796.0 7820.5 8044.2 8094.6 8134.7 967.4 968.5 987.6 1062.6 1138.2 28604.4 28775.9 28982.7 29019.1 29085.7 998.9 1006.4 1059.6 1101.8 1125.5 14945.9 15092.4 15174.7 15286.9 15326.2 314993.0 318870.0 319425.0 320371.0 323594.0 53328.0 53349.0 53629.7 53738.0 53982.7 1315.4 1317.1 1320.3 1321.4 1347.8 27699.3 28528.7 28825.9 28852.1 28905.4 47708.8 48032.8 48069.8 48125.3 48328.8 287808.0 289780.0 289828.0 290206.0 291477.0 32880.0 33060.0 33135.3 33497.3 33523.8 40333.4 40381.6 41169.0 41352.6 41391.4 35891.6 36598.8 36939.4 37270.0 37826.0 36534.5 36600.0 37217.4 37261.3 37386.3 35454.0 36834.1 36993.6 37074.4 37075.0 33357.5 36376.3 36514.5 36693.8 37270.8 25148.7 25578.4 25649.9 25730.6 26217.0 21:58:23 INFO - 2015-11-13 21:58:23,410 DEBUG : BROWSER_OUTPUT: 21:58:23 INFO - 2015-11-13 21:58:23,410 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28115.58 Median:4741.79 stddev:92203.39 (1944.5%) stddev-sans-first:92438.43 21:58:23 INFO - 2015-11-13 21:58:23,410 DEBUG : BROWSER_OUTPUT: Values: 324.7 345.1 347.3 349.1 351.6 12591.9 12974.2 16847.8 17291.5 18872.2 11143.9 11154.4 11163.0 11233.2 11438.5 4401.5 4516.2 4528.4 4534.3 4541.1 4480.9 4748.9 4844.0 4845.4 4855.4 4734.7 4799.2 4808.1 4808.6 4812.2 4816.9 4833.8 4838.2 4858.2 4865.5 4166.1 4194.5 4268.7 4283.3 4317.5 12249.8 12384.4 12547.6 12742.9 12751.7 2046.4 2053.6 2063.5 2101.8 2115.9 10125.2 10175.6 10240.3 10409.4 10412.4 1698.8 1740.5 1745.6 1797.3 1797.5 60200.4 61408.7 62746.4 63484.4 63610.7 6944.7 7028.4 7048.2 7123.5 7211.7 8541.7 8563.3 8578.0 8584.1 8618.4 5703.4 5706.0 5745.3 5793.4 5807.5 5709.1 5709.8 5726.9 5772.5 5774.6 3257.4 3259.9 3265.5 3278.1 3297.6 1177.5 1181.1 1181.2 1191.2 1228.1 433.1 481.3 484.6 492.1 493.1 11190.4 11350.4 11532.3 11671.9 12190.4 485.0 497.3 506.1 508.2 512.8 6371.8 6402.7 6473.8 6481.9 6519.7 557041.0 560641.0 563972.0 565943.0 566398.0 75426.0 78544.0 78940.6 78950.6 79173.2 556.1 562.5 563.5 564.4 566.0 10750.7 10872.7 10948.5 11115.9 11233.4 34250.5 37187.6 37297.8 38046.0 39144.8 46972.3 47273.3 48220.0 48342.0 48668.0 6972.4 7051.7 7104.4 13236.5 13628.5 9877.0 18456.5 18705.6 18734.9 19176.6 8219.8 8527.7 8722.8 9239.0 9342.1 9166.8 9252.6 9297.5 9342.7 9515.9 9116.0 9466.9 9662.0 9707.9 9725.8 14308.7 14403.6 14536.5 14600.9 14620.0 15523.5 15591.7 15890.7 16012.8 16033.0 21:58:23 INFO - 2015-11-13 21:58:23,410 DEBUG : BROWSER_OUTPUT: 21:58:23 INFO - 2015-11-13 21:58:23,410 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5249.48 Median:6368.21 stddev:2699.85 (42.4%) stddev-sans-first:2692.64 21:58:23 INFO - 2015-11-13 21:58:23,410 DEBUG : BROWSER_OUTPUT: Values: 1490.2 1493.2 1613.4 1709.4 1770.8 7441.3 7526.0 7656.0 7672.4 7703.3 7293.5 7332.6 7400.4 7429.5 7476.5 2178.0 2203.1 2207.9 2210.5 2218.0 2189.6 2193.3 2232.9 2249.1 2255.4 2176.1 2201.9 2208.0 2228.2 2228.8 2199.4 2226.5 2232.8 2235.8 2240.0 2167.8 2219.8 2232.7 2235.7 2242.3 7422.5 7470.8 7497.6 7507.7 7508.1 4495.2 4579.7 4602.4 4605.1 4609.7 2951.1 2963.3 3015.0 3017.1 3031.8 959.1 977.1 977.1 979.7 998.2 10024.4 10089.5 10117.6 10131.4 10131.5 3943.1 3972.1 3988.4 4010.9 4020.3 8378.3 8392.0 8403.2 8405.2 8422.9 4422.1 4455.1 4461.1 4471.7 4479.7 4102.4 4107.1 4117.0 4132.8 4139.0 3294.0 3320.8 3338.4 3338.9 3351.2 976.0 993.2 999.7 1011.5 1011.5 1038.5 1055.3 1110.5 1198.5 1332.2 7095.1 7129.1 7172.1 7195.0 7223.8 1088.3 1101.1 1105.5 1113.8 1122.2 5491.9 5509.0 5548.2 5560.0 5586.4 8820.6 8874.6 9110.9 9124.2 9194.6 8979.6 9013.7 9029.8 9080.4 9122.4 6873.9 6942.5 7029.2 7074.8 7131.6 6869.9 6884.3 6896.1 6903.7 6916.2 7753.9 8000.5 8012.2 8028.6 8126.1 8040.3 8189.4 8247.8 8251.9 8288.3 6305.2 6327.1 6355.7 6405.1 6411.0 7273.8 7360.9 7363.8 7373.0 7395.0 6901.6 6955.3 6963.2 7075.4 7079.5 6390.5 6775.4 6856.0 6871.2 6926.0 6883.2 6906.6 6911.0 6944.2 6994.4 5809.6 5926.8 5964.6 6010.8 6204.3 6261.2 6380.8 6382.8 6409.0 6419.0 21:58:23 INFO - 2015-11-13 21:58:23,410 DEBUG : BROWSER_OUTPUT: 21:58:23 INFO - 2015-11-13 21:58:23,412 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5593.00 Median:6452.74 stddev:1768.37 (27.4%) stddev-sans-first:1728.23 21:58:23 INFO - 2015-11-13 21:58:23,412 DEBUG : BROWSER_OUTPUT: Values: 306.1 309.1 310.5 311.7 312.4 6264.8 6370.8 6375.0 6417.2 6422.0 6306.7 6316.1 6319.2 6328.6 6334.9 4610.4 4663.4 4704.1 4723.9 4725.1 4670.8 4698.7 4700.3 4702.9 4734.9 4667.0 4668.0 4676.3 4680.6 4689.8 4657.0 4665.9 4672.6 4676.0 4687.1 3840.8 3992.4 4007.5 4017.8 4019.5 5916.4 5975.5 5983.7 5998.0 6012.5 5427.3 5430.6 5448.1 5454.8 5462.9 6660.1 6708.5 6716.6 6719.5 6727.8 4338.8 4370.1 4411.1 4423.0 4424.0 6905.7 6970.6 6987.2 6991.1 7018.3 4502.9 4530.3 4531.8 4534.8 4553.3 4500.9 4565.3 4574.4 4575.1 4585.4 5368.5 5405.7 5412.1 5429.5 5434.9 6729.3 6767.0 6773.6 6777.1 6784.1 1590.0 1596.4 1600.4 1601.6 1603.0 1026.2 1026.3 1041.1 1046.4 1050.0 6544.6 6555.5 6567.7 6588.8 6593.1 6938.3 6993.3 7009.4 7011.7 7031.5 6432.4 6473.1 6564.6 6570.7 6578.8 3814.9 3827.2 3829.8 3833.7 3834.4 7159.6 7265.1 7349.1 7350.2 7363.9 7246.5 7274.8 7281.1 7283.8 7292.2 7162.9 7281.0 7295.2 7313.6 7332.3 7010.1 7026.0 7056.7 7076.5 7085.3 6939.7 6963.8 6972.9 6974.2 6980.4 7140.0 7275.2 7298.7 7324.6 7339.9 4521.3 4547.8 4549.2 4551.2 4554.4 6997.6 7046.7 7051.3 7061.6 7073.3 6604.0 6771.3 6778.4 6783.5 6795.9 6753.2 6759.5 6764.7 6786.4 6789.8 6627.0 6663.6 6675.7 6678.8 6680.6 6684.7 6760.6 6811.5 6823.1 6828.8 6603.3 6612.5 6619.7 6623.8 6639.5 21:58:23 INFO - 2015-11-13 21:58:23,412 DEBUG : BROWSER_OUTPUT: 21:58:23 INFO - 2015-11-13 21:58:23,412 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13282.38 Median:48604.76 stddev:15800.27 (32.5%) stddev-sans-first:15816.37 21:58:23 INFO - 2015-11-13 21:58:23,412 DEBUG : BROWSER_OUTPUT: Values: 706.4 722.9 752.3 837.9 854.7 13733.3 14078.9 14107.9 14139.1 14145.9 12267.3 12444.8 12485.3 12496.9 12510.6 820.3 835.5 836.6 838.6 842.0 827.1 835.9 836.2 836.9 836.9 861.1 863.0 867.0 872.3 873.9 858.5 861.7 865.8 865.9 868.6 627.7 629.9 631.6 634.7 635.7 12463.6 12465.8 12611.1 12635.1 12669.9 10918.6 10995.5 11037.8 11164.0 11208.2 9986.4 9999.0 10040.4 10058.9 10439.1 3530.0 3546.7 3579.1 3614.2 3697.1 44782.1 45343.1 46205.0 46450.8 50741.5 7184.3 7215.9 7218.1 7370.0 7411.7 11740.7 11833.3 11842.2 11853.2 11891.0 6545.7 6629.8 6686.9 6769.1 6816.5 4396.8 4414.7 4461.4 4488.1 4558.0 2649.7 2650.9 2663.9 2669.9 2670.5 409.3 411.4 415.0 417.2 424.6 598.8 637.7 670.4 674.8 678.7 8513.7 9075.9 9160.5 9302.7 9306.2 530.4 535.7 548.2 617.0 617.2 3743.6 3873.4 3888.8 3932.1 4013.0 54690.0 54740.2 54918.0 55152.0 55439.2 47562.0 48724.8 49119.0 49305.8 49633.8 40153.0 43887.0 48484.8 52647.7 52715.5 8413.9 8522.1 8532.8 8572.5 8673.2 34883.5 35296.6 35780.3 35868.0 36099.0 45056.8 45330.3 45547.3 47939.3 48741.3 7752.5 7782.2 7832.6 7836.8 7932.2 11697.0 12086.9 12137.7 12292.8 13061.3 10976.5 10999.9 11038.3 11212.3 11533.8 11627.0 11836.5 12032.5 12062.5 12235.4 10251.6 10816.5 11058.0 11150.4 11404.1 9615.5 9701.6 9767.8 9861.7 10269.3 8786.2 8844.3 9007.2 9803.2 9836.6 21:58:23 INFO - 2015-11-13 21:58:23,412 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:58:23 INFO - 2015-11-13 21:58:23,412 DEBUG : BROWSER_OUTPUT: 21:58:24 INFO - 2015-11-13 21:58:24,148 INFO : Browser exited with error code: 0 21:58:24 INFO - 2015-11-13 21:58:24,167 INFO : Completed test dromaeo_css (00:18:35) 21:58:24 INFO - 2015-11-13 21:58:24,167 INFO : Starting test kraken 21:58:24 INFO - 2015-11-13 21:58:24,167 DEBUG : operating with platform_type : linux_ 21:58:24 INFO - 2015-11-13 21:58:24,167 INFO : Initialising browser for kraken test... 21:58:24 INFO - 2015-11-13 21:58:24,173 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp65fDxu/profile http://localhost:34920/getInfo.html 21:58:29 INFO - 2015-11-13 21:58:29,783 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:58:29 INFO - 2015-11-13 21:58:29,784 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:58:29 INFO - 2015-11-13 21:58:29,784 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:58:29 INFO - 2015-11-13 21:58:29,784 DEBUG : BROWSER_OUTPUT: __metrics 21:58:30 INFO - 2015-11-13 21:58:30,980 INFO : Browser initialized. 21:58:30 INFO - 2015-11-13 21:58:30,980 INFO : Running cycle 1/1 for kraken test... 21:58:30 INFO - 2015-11-13 21:58:30,981 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp65fDxu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:58:42 INFO - 2015-11-13 21:58:42,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 142012416 21:58:42 INFO - 2015-11-13 21:58:42,760 DEBUG : BROWSER_OUTPUT: 21:58:45 INFO - 2015-11-13 21:58:45,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34920/tests/kraken/driver.html?testName=audio-beat-detection) 21:58:45 INFO - 2015-11-13 21:58:45,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 141774848 21:58:45 INFO - 2015-11-13 21:58:45,870 DEBUG : BROWSER_OUTPUT: 21:58:48 INFO - 2015-11-13 21:58:48,512 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34920/tests/kraken/driver.html?testName=audio-dft) 21:58:49 INFO - 2015-11-13 21:58:49,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 141746176 21:58:49 INFO - 2015-11-13 21:58:49,100 DEBUG : BROWSER_OUTPUT: 21:58:51 INFO - 2015-11-13 21:58:51,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34920/tests/kraken/driver.html?testName=audio-fft) 21:58:52 INFO - 2015-11-13 21:58:52,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 137646080 21:58:52 INFO - 2015-11-13 21:58:52,540 DEBUG : BROWSER_OUTPUT: 21:58:54 INFO - 2015-11-13 21:58:54,491 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34920/tests/kraken/driver.html?testName=audio-oscillator) 21:58:55 INFO - 2015-11-13 21:58:55,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 137408512 21:58:55 INFO - 2015-11-13 21:58:55,074 DEBUG : BROWSER_OUTPUT: 21:58:57 INFO - 2015-11-13 21:58:57,272 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34920/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:58:57 INFO - 2015-11-13 21:58:57,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 137453568 21:58:57 INFO - 2015-11-13 21:58:57,862 DEBUG : BROWSER_OUTPUT: 21:59:00 INFO - 2015-11-13 21:59:00,881 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34920/tests/kraken/driver.html?testName=imaging-darkroom) 21:59:01 INFO - 2015-11-13 21:59:01,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 138686464 21:59:01 INFO - 2015-11-13 21:59:01,467 DEBUG : BROWSER_OUTPUT: 21:59:04 INFO - 2015-11-13 21:59:04,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34920/tests/kraken/driver.html?testName=imaging-desaturate) 21:59:05 INFO - 2015-11-13 21:59:05,489 DEBUG : BROWSER_OUTPUT: RSS: Main: 139972608 21:59:05 INFO - 2015-11-13 21:59:05,489 DEBUG : BROWSER_OUTPUT: 21:59:08 INFO - 2015-11-13 21:59:08,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34920/tests/kraken/driver.html?testName=json-parse-financial) 21:59:08 INFO - 2015-11-13 21:59:08,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 139792384 21:59:08 INFO - 2015-11-13 21:59:08,919 DEBUG : BROWSER_OUTPUT: 21:59:10 INFO - 2015-11-13 21:59:10,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34920/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:59:11 INFO - 2015-11-13 21:59:11,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 139440128 21:59:11 INFO - 2015-11-13 21:59:11,078 DEBUG : BROWSER_OUTPUT: 21:59:12 INFO - 2015-11-13 21:59:12,909 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34920/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:59:13 INFO - 2015-11-13 21:59:13,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 139112448 21:59:13 INFO - 2015-11-13 21:59:13,517 DEBUG : BROWSER_OUTPUT: 21:59:15 INFO - 2015-11-13 21:59:15,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34920/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:59:16 INFO - 2015-11-13 21:59:16,197 DEBUG : BROWSER_OUTPUT: RSS: Main: 139415552 21:59:16 INFO - 2015-11-13 21:59:16,197 DEBUG : BROWSER_OUTPUT: 21:59:18 INFO - 2015-11-13 21:59:18,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34920/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:59:19 INFO - 2015-11-13 21:59:19,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 139165696 21:59:19 INFO - 2015-11-13 21:59:19,266 DEBUG : BROWSER_OUTPUT: 21:59:21 INFO - 2015-11-13 21:59:21,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34920/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:59:22 INFO - 2015-11-13 21:59:22,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 140103680 21:59:22 INFO - 2015-11-13 21:59:22,427 DEBUG : BROWSER_OUTPUT: 21:59:24 INFO - 2015-11-13 21:59:24,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34920/tests/kraken/driver.html?testName=ai-astar) 21:59:24 INFO - 2015-11-13 21:59:24,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 140550144 21:59:24 INFO - 2015-11-13 21:59:24,351 DEBUG : BROWSER_OUTPUT: 21:59:24 INFO - 2015-11-13 21:59:24,353 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:59:24 INFO - 2015-11-13 21:59:24,353 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:59:24 INFO - 2015-11-13 21:59:24,353 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:59:24 INFO - 2015-11-13 21:59:24,353 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:59:24 INFO - 2015-11-13 21:59:24,353 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;108;112;112;113;124;112;117;113;112 21:59:24 INFO - 2015-11-13 21:59:24,353 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;127;157;163;126;151;154;129;169;125 21:59:24 INFO - 2015-11-13 21:59:24,353 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;161;162;161;165;162;163;164;174;160 21:59:24 INFO - 2015-11-13 21:59:24,354 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;73;73;73;131;73;73;73;73 21:59:24 INFO - 2015-11-13 21:59:24,354 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;95;132;89;91;91;139;91;92;137 21:59:24 INFO - 2015-11-13 21:59:24,354 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;111;111;110 21:59:24 INFO - 2015-11-13 21:59:24,355 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;147;148;146;147;147;147;147;146 21:59:24 INFO - 2015-11-13 21:59:24,355 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;97;96;97;102;96;96;96;97 21:59:24 INFO - 2015-11-13 21:59:24,356 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;62;62;62;62;66;62;60;64;59 21:59:24 INFO - 2015-11-13 21:59:24,356 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;70;69;69;69;69;69;69 21:59:24 INFO - 2015-11-13 21:59:24,356 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;84;85;87;86;86;94;86;84;87 21:59:24 INFO - 2015-11-13 21:59:24,356 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;124;119;122;127;125;130;117;119;116 21:59:24 INFO - 2015-11-13 21:59:24,356 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;151;156;153;149;138;162;155;142;152 21:59:24 INFO - 2015-11-13 21:59:24,356 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;66;73;71;67;69;69;66;67 21:59:24 INFO - 2015-11-13 21:59:24,356 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:59:24 INFO - 2015-11-13 21:59:24,356 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:59:24 INFO - 2015-11-13 21:59:24,357 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,721 21:59:24 INFO - 2015-11-13 21:59:24,357 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:59:24 INFO - 2015-11-13 21:59:24,357 DEBUG : BROWSER_OUTPUT: __startTimestamp1447480764352__endTimestamp 21:59:24 INFO - 2015-11-13 21:59:24,357 DEBUG : BROWSER_OUTPUT: 21:59:24 INFO - 2015-11-13 21:59:24,360 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:59:24 INFO - 2015-11-13 21:59:24,361 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:59:24 INFO - 2015-11-13 21:59:24,361 DEBUG : BROWSER_OUTPUT: 21:59:24 INFO - 2015-11-13 21:59:24,361 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.50 Median:112.50 stddev:4.28 (3.8%) stddev-sans-first:4.50 21:59:24 INFO - 2015-11-13 21:59:24,361 DEBUG : BROWSER_OUTPUT: Values: 112.0 108.0 112.0 112.0 113.0 124.0 112.0 117.0 113.0 112.0 21:59:24 INFO - 2015-11-13 21:59:24,361 DEBUG : BROWSER_OUTPUT: 21:59:24 INFO - 2015-11-13 21:59:24,362 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.70 Median:155.00 stddev:17.06 (11.0%) stddev-sans-first:17.68 21:59:24 INFO - 2015-11-13 21:59:24,362 DEBUG : BROWSER_OUTPUT: Values: 156.0 127.0 157.0 163.0 126.0 151.0 154.0 129.0 169.0 125.0 21:59:24 INFO - 2015-11-13 21:59:24,362 DEBUG : BROWSER_OUTPUT: 21:59:24 INFO - 2015-11-13 21:59:24,362 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:3.98 (2.4%) stddev-sans-first:4.22 21:59:24 INFO - 2015-11-13 21:59:24,362 DEBUG : BROWSER_OUTPUT: Values: 163.0 161.0 162.0 161.0 165.0 162.0 163.0 164.0 174.0 160.0 21:59:24 INFO - 2015-11-13 21:59:24,362 DEBUG : BROWSER_OUTPUT: 21:59:24 INFO - 2015-11-13 21:59:24,363 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.70 Median:73.00 stddev:18.38 (25.2%) stddev-sans-first:19.38 21:59:24 INFO - 2015-11-13 21:59:24,363 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 73.0 73.0 131.0 73.0 73.0 73.0 73.0 21:59:24 INFO - 2015-11-13 21:59:24,363 DEBUG : BROWSER_OUTPUT: 21:59:24 INFO - 2015-11-13 21:59:24,363 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.80 Median:91.00 stddev:21.65 (23.8%) stddev-sans-first:22.38 21:59:24 INFO - 2015-11-13 21:59:24,363 DEBUG : BROWSER_OUTPUT: Values: 91.0 95.0 132.0 89.0 91.0 91.0 139.0 91.0 92.0 137.0 21:59:24 INFO - 2015-11-13 21:59:24,364 DEBUG : BROWSER_OUTPUT: 21:59:24 INFO - 2015-11-13 21:59:24,364 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:59:24 INFO - 2015-11-13 21:59:24,364 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 111.0 110.0 21:59:24 INFO - 2015-11-13 21:59:24,365 DEBUG : BROWSER_OUTPUT: 21:59:24 INFO - 2015-11-13 21:59:24,365 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 21:59:24 INFO - 2015-11-13 21:59:24,365 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 147.0 148.0 146.0 147.0 147.0 147.0 147.0 146.0 21:59:24 INFO - 2015-11-13 21:59:24,365 DEBUG : BROWSER_OUTPUT: 21:59:24 INFO - 2015-11-13 21:59:24,366 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.00 Median:96.50 stddev:1.83 (1.9%) stddev-sans-first:1.94 21:59:24 INFO - 2015-11-13 21:59:24,366 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 97.0 96.0 97.0 102.0 96.0 96.0 96.0 97.0 21:59:24 INFO - 2015-11-13 21:59:24,366 DEBUG : BROWSER_OUTPUT: 21:59:24 INFO - 2015-11-13 21:59:24,366 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.00 stddev:1.93 (3.1%) stddev-sans-first:2.03 21:59:24 INFO - 2015-11-13 21:59:24,367 DEBUG : BROWSER_OUTPUT: Values: 63.0 62.0 62.0 62.0 62.0 66.0 62.0 60.0 64.0 59.0 21:59:24 INFO - 2015-11-13 21:59:24,367 DEBUG : BROWSER_OUTPUT: 21:59:24 INFO - 2015-11-13 21:59:24,367 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 21:59:24 INFO - 2015-11-13 21:59:24,367 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 70.0 69.0 69.0 69.0 69.0 69.0 69.0 21:59:24 INFO - 2015-11-13 21:59:24,367 DEBUG : BROWSER_OUTPUT: 21:59:24 INFO - 2015-11-13 21:59:24,367 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.00 stddev:2.88 (3.3%) stddev-sans-first:3.00 21:59:24 INFO - 2015-11-13 21:59:24,367 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 85.0 87.0 86.0 86.0 94.0 86.0 84.0 87.0 21:59:24 INFO - 2015-11-13 21:59:24,367 DEBUG : BROWSER_OUTPUT: 21:59:24 INFO - 2015-11-13 21:59:24,368 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:123.00 stddev:5.02 (4.1%) stddev-sans-first:4.76 21:59:24 INFO - 2015-11-13 21:59:24,368 DEBUG : BROWSER_OUTPUT: Values: 115.0 124.0 119.0 122.0 127.0 125.0 130.0 117.0 119.0 116.0 21:59:24 INFO - 2015-11-13 21:59:24,368 DEBUG : BROWSER_OUTPUT: 21:59:24 INFO - 2015-11-13 21:59:24,368 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:152.50 stddev:7.66 (5.0%) stddev-sans-first:7.25 21:59:24 INFO - 2015-11-13 21:59:24,369 DEBUG : BROWSER_OUTPUT: Values: 140.0 151.0 156.0 153.0 149.0 138.0 162.0 155.0 142.0 152.0 21:59:24 INFO - 2015-11-13 21:59:24,370 DEBUG : BROWSER_OUTPUT: 21:59:24 INFO - 2015-11-13 21:59:24,370 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:2.26 (3.3%) stddev-sans-first:2.40 21:59:24 INFO - 2015-11-13 21:59:24,370 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 66.0 73.0 71.0 67.0 69.0 69.0 66.0 67.0 21:59:24 INFO - 2015-11-13 21:59:24,370 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:59:24 INFO - 2015-11-13 21:59:24,370 DEBUG : BROWSER_OUTPUT: 21:59:25 INFO - 2015-11-13 21:59:25,248 INFO : Browser exited with error code: 0 21:59:25 INFO - 2015-11-13 21:59:25,301 INFO : Completed test kraken (00:01:01) 21:59:25 INFO - 2015-11-13 21:59:25,301 INFO : Starting test v8_7 21:59:25 INFO - 2015-11-13 21:59:25,301 DEBUG : operating with platform_type : linux_ 21:59:25 INFO - 2015-11-13 21:59:25,302 INFO : Initialising browser for v8_7 test... 21:59:25 INFO - 2015-11-13 21:59:25,307 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGfNNWA/profile http://localhost:34920/getInfo.html 21:59:30 INFO - 2015-11-13 21:59:30,745 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:59:30 INFO - 2015-11-13 21:59:30,745 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:59:30 INFO - 2015-11-13 21:59:30,745 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:59:30 INFO - 2015-11-13 21:59:30,745 DEBUG : BROWSER_OUTPUT: __metrics 21:59:31 INFO - 2015-11-13 21:59:31,968 INFO : Browser initialized. 21:59:31 INFO - 2015-11-13 21:59:31,968 INFO : Running cycle 1/1 for v8_7 test... 21:59:31 INFO - 2015-11-13 21:59:31,969 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGfNNWA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:59:43 INFO - 2015-11-13 21:59:43,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 141295616 21:59:43 INFO - 2015-11-13 21:59:43,784 DEBUG : BROWSER_OUTPUT: 22:00:05 INFO - 2015-11-13 22:00:05,139 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34920/tests/v8_7/run.html (next: http://localhost:34920/tests/v8_7/run.html) 22:00:05 INFO - 2015-11-13 22:00:05,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 138854400 22:00:05 INFO - 2015-11-13 22:00:05,398 DEBUG : BROWSER_OUTPUT: 22:00:05 INFO - 2015-11-13 22:00:05,398 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:00:05 INFO - 2015-11-13 22:00:05,398 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:00:05 INFO - 2015-11-13 22:00:05,398 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:00:05 INFO - 2015-11-13 22:00:05,398 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:00:05 INFO - 2015-11-13 22:00:05,398 DEBUG : BROWSER_OUTPUT: |0;Richards;163.5322976287817 22:00:05 INFO - 2015-11-13 22:00:05,399 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.79342723004694 22:00:05 INFO - 2015-11-13 22:00:05,399 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.135788585887 22:00:05 INFO - 2015-11-13 22:00:05,399 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 22:00:05 INFO - 2015-11-13 22:00:05,399 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1070.6638115631692 22:00:05 INFO - 2015-11-13 22:00:05,399 DEBUG : BROWSER_OUTPUT: |5;Earley;729.3946024799417 22:00:05 INFO - 2015-11-13 22:00:05,399 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 22:00:05 INFO - 2015-11-13 22:00:05,400 DEBUG : BROWSER_OUTPUT: |7;RegExp;25350 22:00:05 INFO - 2015-11-13 22:00:05,400 DEBUG : BROWSER_OUTPUT: |8;Splay;626.1740763932373 22:00:05 INFO - 2015-11-13 22:00:05,400 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 22:00:05 INFO - 2015-11-13 22:00:05,400 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:00:05 INFO - 2015-11-13 22:00:05,400 DEBUG : BROWSER_OUTPUT: __startTimestamp1447480805391__endTimestamp 22:00:05 INFO - 2015-11-13 22:00:05,400 DEBUG : BROWSER_OUTPUT: 22:00:05 INFO - 2015-11-13 22:00:05,400 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:00:05 INFO - 2015-11-13 22:00:05,401 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:00:05 INFO - 2015-11-13 22:00:05,401 DEBUG : BROWSER_OUTPUT: 22:00:05 INFO - 2015-11-13 22:00:05,401 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.53 Median:163.53 stddev:0.00 (0.0%) 22:00:05 INFO - 2015-11-13 22:00:05,401 DEBUG : BROWSER_OUTPUT: Values: 163.5 22:00:05 INFO - 2015-11-13 22:00:05,401 DEBUG : BROWSER_OUTPUT: 22:00:05 INFO - 2015-11-13 22:00:05,401 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.79 Median:187.79 stddev:0.00 (0.0%) 22:00:05 INFO - 2015-11-13 22:00:05,401 DEBUG : BROWSER_OUTPUT: Values: 187.8 22:00:05 INFO - 2015-11-13 22:00:05,401 DEBUG : BROWSER_OUTPUT: 22:00:05 INFO - 2015-11-13 22:00:05,402 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.14 Median:281.14 stddev:0.00 (0.0%) 22:00:05 INFO - 2015-11-13 22:00:05,402 DEBUG : BROWSER_OUTPUT: Values: 281.1 22:00:05 INFO - 2015-11-13 22:00:05,402 DEBUG : BROWSER_OUTPUT: 22:00:05 INFO - 2015-11-13 22:00:05,402 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 22:00:05 INFO - 2015-11-13 22:00:05,402 DEBUG : BROWSER_OUTPUT: Values: 5050.5 22:00:05 INFO - 2015-11-13 22:00:05,402 DEBUG : BROWSER_OUTPUT: 22:00:05 INFO - 2015-11-13 22:00:05,402 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1070.66 Median:1070.66 stddev:0.00 (0.0%) 22:00:05 INFO - 2015-11-13 22:00:05,403 DEBUG : BROWSER_OUTPUT: Values: 1070.7 22:00:05 INFO - 2015-11-13 22:00:05,403 DEBUG : BROWSER_OUTPUT: 22:00:05 INFO - 2015-11-13 22:00:05,403 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:729.39 Median:729.39 stddev:0.00 (0.0%) 22:00:05 INFO - 2015-11-13 22:00:05,403 DEBUG : BROWSER_OUTPUT: Values: 729.4 22:00:05 INFO - 2015-11-13 22:00:05,403 DEBUG : BROWSER_OUTPUT: 22:00:05 INFO - 2015-11-13 22:00:05,403 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 22:00:05 INFO - 2015-11-13 22:00:05,403 DEBUG : BROWSER_OUTPUT: Values: 12195.1 22:00:05 INFO - 2015-11-13 22:00:05,403 DEBUG : BROWSER_OUTPUT: 22:00:05 INFO - 2015-11-13 22:00:05,404 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25350.00 Median:25350.00 stddev:0.00 (0.0%) 22:00:05 INFO - 2015-11-13 22:00:05,404 DEBUG : BROWSER_OUTPUT: Values: 25350.0 22:00:05 INFO - 2015-11-13 22:00:05,404 DEBUG : BROWSER_OUTPUT: 22:00:05 INFO - 2015-11-13 22:00:05,404 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:626.17 Median:626.17 stddev:0.00 (0.0%) 22:00:05 INFO - 2015-11-13 22:00:05,404 DEBUG : BROWSER_OUTPUT: Values: 626.2 22:00:05 INFO - 2015-11-13 22:00:05,404 DEBUG : BROWSER_OUTPUT: 22:00:05 INFO - 2015-11-13 22:00:05,404 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 22:00:05 INFO - 2015-11-13 22:00:05,404 DEBUG : BROWSER_OUTPUT: Values: 4840.6 22:00:05 INFO - 2015-11-13 22:00:05,404 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:00:05 INFO - 2015-11-13 22:00:05,404 DEBUG : BROWSER_OUTPUT: 22:00:06 INFO - 2015-11-13 22:00:06,304 INFO : Browser exited with error code: 0 22:00:06 INFO - 2015-11-13 22:00:06,318 INFO : Completed test v8_7 (00:00:41) 22:00:06 INFO - 2015-11-13 22:00:06,432 INFO : Completed test suite (00:20:17) 22:00:06 INFO - 2015-11-13 22:00:06,432 DEBUG : Working with test: dromaeo_css 22:00:06 INFO - 2015-11-13 22:00:06,432 DEBUG : Generating results file: dromaeo_css 22:00:06 INFO - 2015-11-13 22:00:06,433 DEBUG : Working with test: kraken 22:00:06 INFO - 2015-11-13 22:00:06,433 DEBUG : Generating results file: kraken 22:00:06 INFO - 2015-11-13 22:00:06,434 INFO : javascript benchmark 22:00:06 INFO - 2015-11-13 22:00:06,434 DEBUG : Working with test: v8_7 22:00:06 INFO - 2015-11-13 22:00:06,434 DEBUG : Generating results file: v8_7 22:00:06 INFO - 2015-11-13 22:00:06,434 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:00:07 INFO - 2015-11-13 22:00:07,108 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 22:00:07 INFO - 2015-11-13 22:00:07,108 DEBUG : process_Request line: dromaeo_css 6757.25 graph.html#tests=[[72,63,43]] 22:00:07 INFO - 2015-11-13 22:00:07,108 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:00:07 INFO - 2015-11-13 22:00:07,242 DEBUG : process_Request line: kraken 1517.60 graph.html#tests=[[232,63,43]] 22:00:07 INFO - 2015-11-13 22:00:07,242 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:00:07 INFO - 2015-11-13 22:00:07,349 DEBUG : process_Request line: v8_7 21333.32 graph.html#tests=[[230,63,43]] 22:00:07 INFO - 2015-11-13 22:00:07,350 INFO : javascript benchmark 22:00:07 INFO - 2015-11-13 22:00:07,354 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [324.68343365218914, 345.1182229403875, 347.3071222910294, 349.11673466130696, 351.565816216972, 12591.874081259184, 12974.221546707204, 16847.831521684795, 17291.481255562336, 18872.150753216105, 11143.944280278587, 11154.442277886114, 11163.0, 11233.157513186503, 11438.542458301657, 4401.515833258347, 4516.209663308924, 4528.388667529891, 4534.251848445003, 4541.069080838437, 4480.932786008212, 4748.881277968044, 4844.031193761261, 4845.37010188675, 4855.393075865517, 4734.692245004064, 4799.18413869643, 4808.062427826575, 4808.591269742076, 4812.205986012304, 4816.868036011534, 4833.758312084382, 4838.153323168449, 4858.246971719389, 4865.489123642002, 4166.0626359068965, 4194.454720886296, 4268.676710219842, 4283.2932566126865, 4317.503487098961, 12249.816252756216, 12384.442700078427, 12547.623571292785, 12742.936285318607, 12751.681207969783, 2046.4270004398793, 2053.620080285152, 2063.535704466498, 2101.8423618228694, 2115.8942052897446, 10125.240606954509, 10175.59297628094, 10240.334378265388, 10409.3754374737, 10412.42731649759, 1698.770665960092, 1740.4952563756494, 1745.6209594420393, 1797.3170195325692, 1797.5146710388121, 60200.397996019914, 61408.69295653538, 62746.37253627451, 63484.36515634831, 63610.68194658997, 6944.722211111499, 7028.402585780266, 7048.154221493453, 7123.501354905107, 7211.675474603656, 8541.658333666584, 8563.33015062057, 8578.0, 8584.141585841491, 8618.353623478139, 5703.40114288002, 5706.0, 5745.339285982165, 5793.449622285961, 5807.5063619591965, 5709.115087161496, 5709.7716091356715, 5726.914096288559, 5772.451617096369, 5774.595778295479, 3257.397381484433, 3259.9022029339158, 3265.526498657729, 3278.098522906172, 3297.6207736110655, 1177.5407591039502, 1181.078758568318, 1181.2321990705939, 1191.1780871198846, 1228.0912125027414, 433.1380552700104, 481.2732773512022, 484.56147186796005, 492.1289317907284, 493.11731999720814, 11190.38452885083, 11350.375729334966, 11532.25040372373, 11671.88328116708, 12190.390480476119, 484.9927251091236, 497.2789455289844, 506.1269310439536, 508.1869009584635, 512.7538781384956, 6371.840703982438, 6402.743890244431, 6473.838154046187, 6481.870362592722, 6519.706613202417, 557041.0, 560641.0, 563972.0, 565943.0, 566398.0, 75426.0, 78544.0, 78940.60529697315, 78950.6052469734, 79173.20826791774, 556.1268807971446, 562.5345973738353, 563.5069314349944, 564.3904583050296, 565.9971700141556, 10750.73123171927, 10872.67381978542, 10948.507317170906, 11115.944420277847, 11233.438328083726, 34250.50271766253, 37187.6281237195, 37297.81351093227, 38046.048848779, 39144.80427597958, 46972.29541556811, 47273.29090063583, 48220.0, 48342.0, 48668.0, 6972.4073453757, 7051.717931282691, 7104.431645468453, 13236.470541178245, 13628.523001694894, 9877.0, 18456.538586535444, 18705.625887481903, 18734.90632546883, 19176.616467670847, 8219.794505137419, 8527.658893644184, 8722.825543489222, 9238.95380523093, 9342.065793420603, 9166.770830729285, 9252.629894804133, 9297.535123243946, 9342.719718408458, 9515.904840951502, 9115.954420227856, 9466.905330946878, 9662.033796620282, 9707.9029209707, 9725.80548389014, 14308.713825723635, 14403.567892963229, 14536.491222807152, 14600.85399145995, 14620.0, 15523.534293971199, 15591.688166236838, 15890.68218635644, 16012.839871601602, 16033.0], "dojo.html": [3229.1442767666567, 3241.465158248889, 3277.573915390999, 3281.5733954585908, 3285.1458620758613, 5392.083345831208, 5410.026195284852, 5423.864403389917, 5436.1030429979055, 5442.2380866678695, 5406.107992181295, 5418.512333889949, 5535.25274087998, 5555.583331250152, 5567.972160139194, 4670.392848929651, 4934.21052631579, 5129.0767661820855, 5139.691618502883, 5152.819651312205, 4909.975450122744, 5105.18317069269, 5131.179011358184, 5132.204508301219, 5176.275321454999, 4910.680805747633, 4958.033183529214, 4970.378702662168, 5025.346704928336, 5033.874153146164, 5016.673916195472, 5036.697798132087, 5045.974770126162, 5066.746662666888, 5087.669301495391, 4931.580815630676, 4991.7753701083175, 5036.06832735945, 5044.041632089891, 5045.192769156954, 5286.682799032071, 5297.152455607123, 5297.629165958385, 5307.203919412081, 5341.519263266325, 5935.317438494585, 5952.761889524414, 5966.343702192756, 5971.134185543072, 5988.461038506512, 5793.565482588822, 5858.12128180772, 5904.291485021782, 6014.639121652671, 6016.127661489103, 5620.156976453564, 5628.690422026787, 5637.9718101409235, 5644.238027866227, 5647.37878833328, 6036.667983260875, 6060.121282414113, 6065.727042283108, 6068.757249709962, 6072.119542666289, 5667.603267771216, 5739.7704091836695, 5832.416758324133, 5835.824925252249, 5973.283206015306, 5959.22530071088, 5962.1056841473255, 5969.194158788508, 5976.671283079386, 5983.760649574056, 5911.733971971272, 5931.288245410578, 5931.347551769388, 5946.762129514771, 5947.851303717442, 5753.309602847685, 5844.298684157929, 5980.55145864062, 6075.848103797441, 6107.664078475637, 4551.362809206714, 4561.361409402686, 4564.863054108382, 4573.108243892476, 4591.724496530219, 3981.0, 4058.9797051014557, 4063.512378514597, 4092.897677558085, 4094.0174358153827, 5586.832395028156, 5618.157276408489, 5648.237487939158, 5672.205891175238, 5701.372848986608, 5906.26171728534, 5936.821895343147, 5938.287405511366, 5938.792142275, 5941.138534912414, 5590.580706447033, 5637.661740295595, 5662.405447428043, 5675.744591493392, 5689.743961521742, 5044.319016932667, 5111.591072714174, 5126.512981266774, 5136.43499215086, 5174.534291913746, 6128.1726966858905, 6137.662428566382, 6149.108379285068, 6153.907691384633, 6157.353477884758, 5829.795957141479, 5924.703764811656, 5956.076808094752, 5959.225300711053, 5959.791407300897, 6109.938900610937, 6114.847128821637, 6161.168242287234, 6179.412955769195, 6187.504999599932, 5814.505767009682, 5935.792247271324, 5943.851403714942, 5953.0, 5957.553183511167, 5854.414558544111, 5865.530757539472, 5972.223610930551, 6016.187814644967, 6050.515958723379, 5816.883662326814, 5877.706114694162, 5881.147233651182, 5883.794067207627, 5883.882322353615, 5832.708364581838, 5851.1515830205235, 5867.501262392574, 5874.706264686663, 5881.73532191061, 5552.167174923794, 5654.6889921054735, 5711.914321285267, 5735.426457354231, 5798.6810725410505, 5757.913631295618, 5773.1051686988585, 5790.305163380422, 5852.707364631837, 5854.0340843760305, 5682.6306290091015, 5700.2304688868135, 5706.058500347396, 5710.714464276686, 5710.914336284876], "mootools.html": [1490.2176357412357, 1493.1936754152757, 1613.3627217249193, 1709.3846215362466, 1770.7520947067412, 7441.255874412556, 7525.962370188141, 7656.0, 7672.386209103272, 7703.268189521993, 7293.525920815143, 7332.560046397207, 7400.370968467687, 7429.517081389719, 7476.514026588282, 2178.0416616688644, 2203.063697928382, 2207.878566678832, 2210.546837898227, 2217.966730499044, 2189.5839790439763, 2193.254293540196, 2232.910683572655, 2249.134083377903, 2255.436140964759, 2176.075168053571, 2201.8678879267213, 2207.9779202208015, 2228.231260215231, 2228.832837537191, 2199.417154454071, 2226.4545186429345, 2232.787885150908, 2235.7540670526228, 2240.047979608668, 2167.837412194092, 2219.8002179803734, 2232.6539386395134, 2235.7428895677044, 2242.338510139513, 7422.480426370156, 7470.775876723707, 7497.550146991198, 7507.662155203029, 7508.0990281166605, 4495.213337665896, 4579.702319349231, 4602.401687780601, 4605.078984203173, 4609.723416595015, 2951.0851635992913, 2963.273997870514, 3014.954775678367, 3017.0647099399257, 3031.8180909145303, 959.0531221620053, 977.0815433492494, 977.0815433492494, 979.6669132494915, 998.1515711645117, 10024.398536087858, 10089.545970431349, 10117.645882394154, 10131.44277064761, 10131.544080516394, 3943.073377756225, 3972.1261322509004, 3988.4216788565495, 4010.859619913289, 4020.2562525932794, 8378.287845533197, 8392.0, 8403.159684031549, 8405.243528082501, 8422.915770842335, 4422.137683151819, 4455.086707225011, 4461.13007963444, 4471.709338892962, 4479.686421950498, 4102.405151253051, 4107.075907920754, 4117.0, 4132.8140233689555, 4139.0480189555965, 3294.011796461052, 3320.8007519548905, 3338.4157772389735, 3338.9332213355597, 3351.162209447638, 975.9707208783748, 993.1707024634367, 999.7450650084182, 1011.4942528735633, 1011.5094179323022, 1038.5378506564657, 1055.3298655353906, 1110.5446766825562, 1198.5026214121042, 1332.2073366347008, 7095.113110861143, 7129.073220481408, 7172.067631208014, 7195.0, 7223.783286501413, 1088.3089238333714, 1101.1026013798728, 1105.4583254205381, 1113.7549739057395, 1122.2424863217295, 5491.917621235684, 5509.00837849183, 5548.195511650869, 5559.999200143932, 5586.441355864381, 8820.558972051373, 8874.64501419936, 9110.908890911007, 9124.17882390588, 9194.632214711337, 8979.551022448852, 9013.729588112366, 9029.77425564366, 9080.40977336471, 9122.407043542149, 6873.931260687429, 6942.479314051366, 7029.156501219886, 7074.823129421806, 7131.643417829087, 6869.931300687129, 6884.277150899084, 6896.137982752156, 6903.723851046103, 6916.170059592881, 7753.92246077532, 8000.51996880189, 8012.198780121941, 8028.638711258124, 8126.146754590919, 8040.276375126266, 8189.426740128372, 8247.835043299221, 8251.876221856557, 8288.254057134887, 6305.211848518935, 6327.050942358683, 6355.650439225887, 6405.135306733531, 6411.0383442484, 7273.781786546412, 7360.926390736024, 7363.77908662741, 7372.96313518429, 7395.0, 6901.585904845725, 6955.269696681776, 6963.234044255027, 7075.363217310467, 7079.539829911039, 6390.52071094679, 6775.424088952297, 6856.040154378491, 6871.244163142151, 6926.0, 6883.242843287335, 6906.551074180162, 6910.965445172742, 6944.236134025152, 6994.405475534637, 5809.622374545641, 5926.762929482772, 5964.612300200473, 6010.759569617341, 6204.348543403058, 6261.154744109487, 6380.776672816429, 6382.776602818879, 6408.967955160194, 6418.967905160631], "ext.html": [557.3622709362232, 585.6720236667466, 594.1207013619843, 615.8799034188332, 619.5879739972918, 31148.0, 31842.0, 40031.99920001998, 40044.398224071, 40078.19843603126, 43321.78339108308, 43961.34057989133, 44150.33774493377, 44155.55844441555, 44269.0, 8698.91301086989, 8876.911230887674, 8877.556122193897, 8878.467291962503, 8892.333075019367, 8653.913460865373, 8741.694040708577, 8744.0, 8749.0, 8776.0, 8683.522406267653, 8722.563871806417, 8740.038595754462, 8759.080296568864, 8805.119488051208, 8699.695510657097, 8713.782155446133, 8724.738257852274, 8809.207171354577, 8810.163034511743, 8597.484150950962, 8698.130186981314, 8728.694495692684, 8736.388452808305, 8739.431936924144, 39768.60231397678, 40206.19587608261, 40332.0, 40347.0, 40768.38847417291, 3270.280538281574, 3373.662633736631, 3390.440577304742, 3424.931501369959, 3696.759710618828, 29989.400211995857, 30607.0, 30639.234019149477, 30680.232994175323, 30977.845110774528, 3272.836358182105, 3378.341223461426, 3412.6587341265677, 3420.435628121357, 3439.8968030959113, 280094.0, 280449.0, 280503.0, 280624.0, 282072.58963705256, 56263.43736562664, 56793.14810277849, 57069.0, 58144.0, 65378.0, 61250.69374653188, 61393.386066138766, 61502.0, 61508.384916150266, 61936.38063619306, 16295.266712997944, 16508.25712842901, 16538.751918721227, 16542.503724888273, 16590.08754518513, 12181.756364872654, 12237.938810305892, 12266.938665306616, 12294.446749896277, 12311.322877241659, 19766.70349944752, 20165.596688066158, 20315.492112697302, 20343.389698309074, 20460.0, 7796.0, 7820.475007373508, 8044.235797599219, 8094.635741391651, 8134.674613015532, 967.4243824924159, 968.5254225429488, 987.5852142100335, 1062.617457715222, 1138.2430683595317, 28604.427911441653, 28775.85612071968, 28982.710172898, 29019.10600559497, 29085.709142908723, 998.9300748947504, 1006.3659894266711, 1059.5604417490842, 1101.8292164714483, 1125.5104029747085, 14945.850541494447, 15092.396304147931, 15174.696506069817, 15286.923565382102, 15326.157061361731, 314993.0, 318870.0, 319425.0, 320371.0, 323594.0, 53328.0, 53349.0, 53629.7318513405, 53738.0, 53982.730086349315, 1315.414640484975, 1317.1109501086728, 1320.2672516753294, 1321.4317843327462, 1347.818044563991, 27699.307517311423, 28528.714712852605, 28825.855870720512, 28852.134435966953, 28905.42189156163, 47708.7614561925, 48032.75983620199, 48069.75965120152, 48125.278120828916, 48328.758356207996, 287808.0, 289780.0, 289828.0, 290206.0, 291477.0, 32880.0, 33060.0, 33135.33729325448, 33497.33005339928, 33523.83238083794, 40333.39499907562, 40381.596184037786, 41169.0, 41352.58647413608, 41391.37912931369, 35891.64108358883, 36598.8170059148, 36939.44590831194, 37270.0, 37826.0, 36534.45198321974, 36600.01399006735, 37217.44173837449, 37261.25477490489, 37386.252274953804, 35454.0, 36834.07914802151, 36993.63006369902, 37074.443883341235, 37075.0, 33357.499637504974, 36376.27247455089, 36514.45228321524, 36693.816530917175, 37270.813645931594, 25148.74851251464, 25578.360540986625, 25649.871750641127, 25730.614040789027, 26217.0], "prototype.html": [306.0710742895312, 309.1482964432987, 310.4721972646499, 311.73502522855574, 312.40954595813906, 6264.84337891553, 6370.840728981778, 6374.968125159374, 6417.197850268716, 6422.0045892886565, 6306.747730090802, 6316.052592111186, 6319.241690997075, 6328.557001009931, 6334.873302533946, 4610.354550362952, 4663.417072865892, 4704.082703872755, 4723.929141062887, 4725.102230576197, 4670.836520721776, 4698.694584851991, 4700.341952126705, 4702.882427939295, 4734.857954261378, 4667.0, 4667.953320466786, 4676.3453116563705, 4680.625549955996, 4689.788959496831, 4657.04530571232, 4665.930011049837, 4672.579467847893, 4676.018036212399, 4687.062587482517, 3840.7503512271614, 3992.3811809169333, 4007.499062617173, 4017.8392864285393, 4019.457373254632, 5916.378780228057, 5975.52195824333, 5983.653677922476, 5998.0, 6012.549058820606, 5427.267318911975, 5430.56555475561, 5448.101063324547, 5454.836354909359, 5462.918056229159, 6660.067590537328, 6708.530402871801, 6716.6305853178055, 6719.462443004548, 6727.798166055026, 4338.783060846945, 4370.060437006027, 4411.117776444692, 4423.0, 4424.048829501673, 6905.689243984033, 6970.58176509406, 6987.196472405688, 6991.126109236346, 7018.263082376379, 4502.932456013163, 4530.29780384041, 4531.773411329486, 4534.841280555164, 4553.2942393929, 4500.932486012713, 4565.292379681155, 4574.428196475441, 4575.107853968444, 4585.403897493305, 5368.463153684678, 5405.729713514387, 5412.052890744104, 5429.511343979061, 5434.91847622286, 6729.327067293231, 6767.018782276542, 6773.559718618274, 6777.118974533378, 6784.0841486399695, 1589.9761503577456, 1596.4013494939397, 1600.439846053895, 1601.6076061364806, 1602.9679406411806, 1026.1739299863532, 1026.3277553202665, 1041.1358572384902, 1046.4453839465095, 1049.9737506562244, 6544.640044797487, 6555.541112122106, 6567.737290508326, 6588.769393071219, 6593.076969224312, 6938.271481494471, 6993.2657071007825, 7009.4392448603985, 7011.719531218694, 7031.542949708252, 6432.35676432353, 6473.126127972758, 6564.573302735403, 6570.671466426659, 6578.80263592093, 3814.904627384338, 3827.1962887793875, 3829.8276577554075, 3833.6549710526187, 3834.424836274525, 7159.642017899084, 7265.055542779405, 7349.081364829396, 7350.228226036296, 7363.889541656879, 7246.5289756165685, 7274.818129546804, 7281.1262648482525, 7283.781486555412, 7292.161401438902, 7162.856742865113, 7280.96359518199, 7295.161056478467, 7313.561186328731, 7332.266773322732, 7010.088688470466, 7026.016357710027, 7056.682449289691, 7076.540024898365, 7085.326893945067, 6939.722411103701, 6963.825904352431, 6972.895406569007, 6974.163100427981, 6980.371766541036, 7139.964705117833, 7275.163356214103, 7298.708051677873, 7324.5971471567445, 7339.889901651586, 4521.299198624219, 4547.840825571221, 4549.158405694957, 4551.249043907718, 4554.43069616298, 6997.615131167835, 7046.682899269443, 7051.330123638246, 7061.622983518165, 7073.257307982588, 6603.966980165068, 6771.28901465339, 6778.423833974168, 6783.525153239226, 6795.864082718417, 6753.2233793112455, 6759.526833121831, 6764.661766911733, 6786.3892249697765, 6789.762358317435, 6626.966865165643, 6663.600183988976, 6675.732970681119, 6678.83302917431, 6680.565763225375, 6684.665766711742, 6760.560563563353, 6811.4550835934, 6823.078884350549, 6828.829279268058, 6603.306652801387, 6612.537122401578, 6619.735210591522, 6623.801285961429, 6639.468842492685], "yui.html": [706.4066184405102, 722.931321524455, 752.2928447259576, 837.8743188521721, 854.6666799948022, 13733.313334333281, 14078.929605351985, 14107.929460352696, 14139.08095973761, 14145.929270353634, 12267.263964162157, 12444.813327800068, 12485.250884946887, 12496.875031249685, 12510.562130325441, 820.261764412028, 835.4736515994915, 836.564986207172, 838.5849004742661, 841.9579021048954, 827.123249355685, 835.9164083591622, 836.1513064239771, 836.9246767790897, 836.9288610468118, 861.0657436681208, 862.9601330396888, 866.956652167389, 872.2585802068255, 873.8645509945968, 858.4934888415802, 861.6639510590875, 865.7792262972964, 865.9090795466449, 868.6264906090379, 627.7489004398232, 629.9307076221612, 631.5768435148461, 634.6636282770139, 635.6694518850172, 12463.563775267912, 12465.813012804816, 12611.117221794479, 12635.11554191207, 12669.873301266962, 10918.617848375348, 10995.450227488673, 11037.779244415147, 11164.0, 11208.21542492026, 9986.35088719231, 9999.0, 10040.397576145455, 10058.89941100587, 10439.112675422522, 3529.993951723772, 3546.733994950389, 3579.0873327301633, 3614.168741189515, 3697.0757310672334, 44782.104357912656, 45343.09313813738, 46205.0, 46450.76774616105, 50741.49258507405, 7184.281571842774, 7215.855682886313, 7218.133823941055, 7370.041894553781, 7411.740589079464, 11740.70648233801, 11833.349165795791, 11842.230255033568, 11853.170278080624, 11891.04871610269, 6545.738170473128, 6629.767958121539, 6686.899696504556, 6769.120014398195, 6816.48876334267, 4396.758178300224, 4414.735115893057, 4461.375407442961, 4488.1248156609145, 4558.020025694492, 2649.7085320614715, 2650.880710368038, 2663.8668066596592, 2669.8531580762856, 2670.452557225764, 409.3103121240719, 411.4058025152534, 414.9585041495887, 417.2489518866029, 424.60511724096887, 598.796409220867, 637.6939069246788, 670.4033410264868, 674.8481591641842, 678.725116327888, 8513.702020429255, 9075.909240907506, 9160.450372977642, 9302.720918372459, 9306.208972237435, 530.3715097609345, 535.7107162132482, 548.2187882267752, 616.9850595769933, 617.197643064015, 3743.6256374362347, 3873.4189871519498, 3888.8250028748776, 3932.0956180078742, 4012.959870401317, 54690.0, 54740.178897316575, 54918.0, 55152.0, 55439.168412473846, 47562.0, 48724.75637621789, 49119.0, 49305.75347123313, 49633.75183124061, 40153.0, 43887.0, 48484.757576211894, 52647.73676131595, 52715.472845271055, 8413.915860841313, 8522.147785221676, 8532.829343413221, 8572.52851093196, 8673.164314757216, 34883.47674784931, 35296.64703353036, 35780.28439431145, 35868.0, 36099.0, 45056.77471612621, 45330.32004519869, 45547.31679024751, 47939.28091078567, 48741.268880967524, 7752.4573279869865, 7782.182870798485, 7832.608369581612, 7836.84326313482, 7932.246436588515, 11697.0, 12086.939565302117, 12137.69655758613, 12292.815607765711, 13061.34693265352, 10976.506057227285, 10999.945000275267, 11038.337699738042, 11212.327260364404, 11533.82699259495, 11627.0, 11836.526538938346, 12032.518699251932, 12062.457189426672, 12235.388230588613, 10251.58993640246, 10816.454374608453, 11058.0, 11150.386728729998, 11404.144689148181, 9615.471149086588, 9701.563429645541, 9767.779027621547, 9861.704148875546, 10269.281150319406, 8786.209241168326, 8844.292456603327, 9007.189352958265, 9803.16673082796, 9836.606535738776]}, "summary": {"lowerIsBetter": false, "suite": 6757.254972930556, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7204.168648027271, "unit": "ms", "value": 7204.168648027271}, "dojo.html": {"lowerIsBetter": false, "filtered": 5469.218513257345, "unit": "ms", "value": 5469.218513257345}, "mootools.html": {"lowerIsBetter": false, "filtered": 4321.919315379393, "unit": "ms", "value": 4321.919315379393}, "ext.html": {"lowerIsBetter": false, "filtered": 18717.26977685315, "unit": "ms", "value": 18717.26977685315}, "prototype.html": {"lowerIsBetter": false, "filtered": 4994.1241270023265, "unit": "ms", "value": 4994.1241270023265}, "yui.html": {"lowerIsBetter": false, "filtered": 5979.940659248874, "unit": "ms", "value": 5979.940659248874}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-032.e"}, "testrun": {"date": 1447479588, "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": "20151113193353", "branch": "Mozilla-Inbound", "revision": "ee68d52994d9aee5e4a6289ee1fff316c8cbdeba"}}, {"talos_counters": {}, "results": {"audio-dft": [163.0, 161.0, 162.0, 161.0, 165.0, 162.0, 163.0, 164.0, 174.0, 160.0], "ai-astar": [112.0, 108.0, 112.0, 112.0, 113.0, 124.0, 112.0, 117.0, 113.0, 112.0], "imaging-gaussian-blur": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0], "audio-beat-detection": [156.0, 127.0, 157.0, 163.0, 126.0, 151.0, 154.0, 129.0, 169.0, 125.0], "json-stringify-tinderbox": [69.0, 70.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0], "stanford-crypto-pbkdf2": [140.0, 151.0, 156.0, 153.0, 149.0, 138.0, 162.0, 155.0, 142.0, 152.0], "json-parse-financial": [63.0, 62.0, 62.0, 62.0, 62.0, 66.0, 62.0, 60.0, 64.0, 59.0], "stanford-crypto-sha256-iterative": [68.0, 67.0, 66.0, 73.0, 71.0, 67.0, 69.0, 69.0, 66.0, 67.0], "audio-fft": [73.0, 72.0, 73.0, 73.0, 73.0, 131.0, 73.0, 73.0, 73.0, 73.0], "imaging-darkroom": [148.0, 146.0, 147.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0], "stanford-crypto-ccm": [115.0, 124.0, 119.0, 122.0, 127.0, 125.0, 130.0, 117.0, 119.0, 116.0], "audio-oscillator": [91.0, 95.0, 132.0, 89.0, 91.0, 91.0, 139.0, 91.0, 92.0, 137.0], "stanford-crypto-aes": [85.0, 84.0, 85.0, 87.0, 86.0, 86.0, 94.0, 86.0, 84.0, 87.0], "imaging-desaturate": [97.0, 96.0, 97.0, 96.0, 97.0, 102.0, 96.0, 96.0, 96.0, 97.0]}, "summary": {"lowerIsBetter": true, "suite": 1517.6000000000001, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 78.7, "unit": "ms", "value": 78.7}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 149.8, "unit": "ms", "value": 149.8}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.7, "unit": "ms", "value": 145.7}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 121.4, "unit": "ms", "value": 121.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.9, "unit": "ms", "value": 146.9}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 62.2, "unit": "ms", "value": 62.2}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.8, "unit": "ms", "value": 104.8}, "ai-astar": {"lowerIsBetter": true, "filtered": 113.5, "unit": "ms", "value": 113.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 163.5, "unit": "ms", "value": 163.5}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 68.3, "unit": "ms", "value": 68.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.2, "unit": "ms", "value": 69.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.2, "unit": "ms", "value": 110.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.4, "unit": "ms", "value": 86.4}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 97.0, "unit": "ms", "value": 97.0}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-032.e"}, "testrun": {"date": 1447479588, "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": "20151113193353", "branch": "Mozilla-Inbound", "revision": "ee68d52994d9aee5e4a6289ee1fff316c8cbdeba"}}, {"talos_counters": {}, "results": {"DeltaBlue": [187.79342723004694], "Encrypt": [281.135788585887], "NavierStokes": [4840.579710144928], "Decrypt": [5050.50505050505], "Splay": [626.1740763932373], "Richards": [163.5322976287817], "RegExp": [25350.0], "Earley": [729.3946024799417], "Boyer": [12195.121951219513], "RayTrace": [1070.6638115631692]}, "summary": {"lowerIsBetter": false, "suite": 21333.323795381904, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 352.0783499999999, "unit": "score", "value": 352.0783499999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 946.8058169999996, "unit": "score", "value": 946.8058169999996}, "NavierStokes": {"lowerIsBetter": false, "filtered": 306.5748502994012, "unit": "score", "value": 306.5748502994012}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.70383799999996, "unit": "score", "value": 52.70383799999996}, "Splay": {"lowerIsBetter": false, "filtered": 130.141127, "unit": "score", "value": 130.141127}, "RegExp": {"lowerIsBetter": false, "filtered": 35.936291913214966, "unit": "score", "value": 35.936291913214966}, "Richards": {"lowerIsBetter": false, "filtered": 215.87172999999993, "unit": "score", "value": 215.87172999999993}, "Earley": {"lowerIsBetter": false, "filtered": 913.7207730000002, "unit": "score", "value": 913.7207730000002}, "Boyer": {"lowerIsBetter": false, "filtered": 54.64996600000001, "unit": "score", "value": 54.64996600000001}, "RayTrace": {"lowerIsBetter": false, "filtered": 691.1497260000002, "unit": "score", "value": 691.1497260000002}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-032.e"}, "testrun": {"date": 1447479588, "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": "20151113193353", "branch": "Mozilla-Inbound", "revision": "ee68d52994d9aee5e4a6289ee1fff316c8cbdeba"}}] 22:00:07 INFO - RETURN: dromaeo_css: 6757.25 22:00:07 INFO - RETURN: kraken: 1517.60 22:00:07 INFO - RETURN: v8_7: 21333.32 22:00:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21333.32"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1517.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6757.25"}}} 22:00:07 INFO - Return code: 0 22:00:07 INFO - # TBPL SUCCESS # 22:00:07 INFO - Running post-action listener: _resource_record_post_action 22:00:07 INFO - Running post-run listener: _resource_record_post_run 22:00:08 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 513708032; Read time: 200; Write time: 1142232 22:00:08 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 99688448; Read time: 0; Write time: 166424 22:00:08 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 386543616; Read time: 200; Write time: 897280 22:00:08 INFO - Running post-run listener: _upload_blobber_files 22:00:08 INFO - Blob upload gear active. 22:00:08 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:00:08 INFO - Copying logs to upload dir... 22:00:08 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1260.836811 ========= master_lag: 307.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 7 secs) (at 2015-11-13 22:05:14.773356) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 22:05:14.777290) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010138 build_url: 'https://queue.taskcluster.net/v1/task/up9eNI0WSx6Sv1j19JHlnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.32 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 22:05:15.111412) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:05:15.111853) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1447474274.654974-558677058 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004577 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:05:15.154999) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2015-11-13 22:05:15.155406) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2015-11-13 22:05:17.739560) ========= ========= Total master_lag: 307.52 =========