builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1447351303.52 results: success (0) buildid: 20151112083142 builduid: 542b557b7213451eb993a93a43550810 revision: b62504059749d3ea58458c1122f957ef87b6d8b4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:43.518018) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:43.518521) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:43.518876) ========= 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=928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006677 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:43.540165) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:43.540556) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:43.553795) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:43.554176) ========= 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=928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.005402 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:43.604281) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:43.604964) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:43.605318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:43.605626) ========= 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=928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-12 10:01:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-11-12 10:01:43 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096912 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:43.715561) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:43.715895) ========= 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=928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015101 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:43.765881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:43.766318) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev b62504059749d3ea58458c1122f957ef87b6d8b4 --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/b2g-inbound --rev b62504059749d3ea58458c1122f957ef87b6d8b4 --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=928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-12 10:01:44,091 truncating revision to first 12 chars 2015-11-12 10:01:44,091 Setting DEBUG logging. 2015-11-12 10:01:44,091 attempt 1/10 2015-11-12 10:01:44,091 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/b62504059749?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 10:01:44,505 unpacking tar archive at: b2g-inbound-b62504059749/testing/mozharness/ program finished with exit code 0 elapsedTime=0.718885 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:44.500839) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:44.501200) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:44.509467) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:44.509775) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 10:01:44.510248) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2015-11-12 10:01:44.510556) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-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=928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:01:44 INFO - MultiFileLogger online at 20151112 10:01:44 in /builds/slave/test-pgo 10:01:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 10:01:44 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:01:44 INFO - {'append_to_log': False, 10:01:44 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:01:44 INFO - 'blob_upload_branch': 'B2G-Inbound', 10:01:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:01:44 INFO - 'branch': 'B2G-Inbound', 10:01:44 INFO - 'buildbot_json_path': 'buildprops.json', 10:01:44 INFO - 'config_files': ('talos/linux_config.py',), 10:01:44 INFO - 'default_actions': ('clobber', 10:01:44 INFO - 'read-buildbot-config', 10:01:44 INFO - 'download-and-extract', 10:01:44 INFO - 'populate-webroot', 10:01:44 INFO - 'create-virtualenv', 10:01:44 INFO - 'install', 10:01:44 INFO - 'run-tests'), 10:01:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:01:44 INFO - 'download_minidump_stackwalk': True, 10:01:44 INFO - 'download_symbols': 'ondemand', 10:01:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:01:44 INFO - 'tooltool.py': '/tools/tooltool.py', 10:01:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:01:44 INFO - '/tools/misc-python/virtualenv.py')}, 10:01:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:01:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:01:44 INFO - 'installer_path': 'installer.exe', 10:01:44 INFO - 'log_level': 'info', 10:01:44 INFO - 'log_name': 'talos', 10:01:44 INFO - 'log_to_console': True, 10:01:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:01:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:01:44 INFO - 'opt_config_files': (), 10:01:44 INFO - 'pip_index': False, 10:01:44 INFO - 'sps_profile': False, 10:01:44 INFO - 'sps_profile_interval': 0, 10:01:44 INFO - 'suite': 'dromaeojs', 10:01:44 INFO - 'system_bits': '64', 10:01:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:01:44 INFO - 'title': 'talos-linux64-ix-012', 10:01:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:01:44 INFO - 'use_talos_json': True, 10:01:44 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:01:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:01:44 INFO - 'work_dir': 'build'} 10:01:44 INFO - ##### 10:01:44 INFO - ##### Running clobber step. 10:01:44 INFO - ##### 10:01:44 INFO - Running pre-action listener: _resource_record_pre_action 10:01:44 INFO - Running main action method: clobber 10:01:44 INFO - rmtree: /builds/slave/test-pgo/build 10:01:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:01:45 INFO - Running post-action listener: _resource_record_post_action 10:01:45 INFO - ##### 10:01:45 INFO - ##### Running read-buildbot-config step. 10:01:45 INFO - ##### 10:01:45 INFO - Running pre-action listener: _resource_record_pre_action 10:01:45 INFO - Running main action method: read_buildbot_config 10:01:45 INFO - Using buildbot properties: 10:01:45 INFO - { 10:01:45 INFO - "properties": { 10:01:45 INFO - "buildnumber": 108, 10:01:45 INFO - "product": "firefox", 10:01:45 INFO - "script_repo_revision": "production", 10:01:45 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 10:01:45 INFO - "repository": "", 10:01:45 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 10:01:45 INFO - "buildid": "20151112083142", 10:01:45 INFO - "slavename": "talos-linux64-ix-012", 10:01:45 INFO - "pgo_build": "True", 10:01:45 INFO - "basedir": "/builds/slave/test-pgo", 10:01:45 INFO - "project": "", 10:01:45 INFO - "platform": "ubuntu64_hw", 10:01:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:01:45 INFO - "slavebuilddir": "test", 10:01:45 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 10:01:45 INFO - "branch": "b2g-inbound", 10:01:45 INFO - "repo_path": "integration/b2g-inbound", 10:01:45 INFO - "stage_platform": "linux64-pgo", 10:01:45 INFO - "builduid": "542b557b7213451eb993a93a43550810", 10:01:45 INFO - "revision": "b62504059749d3ea58458c1122f957ef87b6d8b4" 10:01:45 INFO - }, 10:01:45 INFO - "sourcestamp": { 10:01:45 INFO - "repository": "", 10:01:45 INFO - "hasPatch": false, 10:01:45 INFO - "project": "", 10:01:45 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 10:01:45 INFO - "changes": [ 10:01:45 INFO - { 10:01:45 INFO - "category": null, 10:01:45 INFO - "files": [ 10:01:45 INFO - { 10:01:45 INFO - "url": null, 10:01:45 INFO - "name": "https://queue.taskcluster.net/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:01:45 INFO - } 10:01:45 INFO - ], 10:01:45 INFO - "repository": "", 10:01:45 INFO - "rev": "b62504059749d3ea58458c1122f957ef87b6d8b4", 10:01:45 INFO - "who": "sendchange", 10:01:45 INFO - "when": 1447351266, 10:01:45 INFO - "number": 6654192, 10:01:45 INFO - "comments": "", 10:01:45 INFO - "project": "", 10:01:45 INFO - "at": "Thu 12 Nov 2015 10:01:06", 10:01:45 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 10:01:45 INFO - "revlink": "", 10:01:45 INFO - "properties": [ 10:01:45 INFO - [ 10:01:45 INFO - "buildid", 10:01:45 INFO - "20151112083142", 10:01:45 INFO - "Change" 10:01:45 INFO - ], 10:01:45 INFO - [ 10:01:45 INFO - "builduid", 10:01:45 INFO - "542b557b7213451eb993a93a43550810", 10:01:45 INFO - "Change" 10:01:45 INFO - ], 10:01:45 INFO - [ 10:01:45 INFO - "pgo_build", 10:01:45 INFO - "True", 10:01:45 INFO - "Change" 10:01:45 INFO - ] 10:01:45 INFO - ], 10:01:45 INFO - "revision": "b62504059749d3ea58458c1122f957ef87b6d8b4" 10:01:45 INFO - } 10:01:45 INFO - ], 10:01:45 INFO - "revision": "b62504059749d3ea58458c1122f957ef87b6d8b4" 10:01:45 INFO - } 10:01:45 INFO - } 10:01:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:01:45 INFO - Running post-action listener: _resource_record_post_action 10:01:45 INFO - ##### 10:01:45 INFO - ##### Running download-and-extract step. 10:01:45 INFO - ##### 10:01:45 INFO - Running pre-action listener: _resource_record_pre_action 10:01:45 INFO - Running main action method: download_and_extract 10:01:45 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:45 INFO - https://queue.taskcluster.net/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:01:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/test_packages.json 10:01:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/test_packages.json 10:01:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:01:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:01:46 INFO - Downloaded 1302 bytes. 10:01:46 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:01:46 INFO - Using the following test package requirements: 10:01:46 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:46 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:01:46 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:46 INFO - u'jsshell-linux-x86_64.zip'], 10:01:46 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:01:46 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:46 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:01:46 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:01:46 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:01:46 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:46 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:01:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:46 INFO - https://queue.taskcluster.net/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:01:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:01:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:01:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/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 10:01:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/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 10:01:47 INFO - Downloaded 22438476 bytes. 10:01:47 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 10:01:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:01:47 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 10:01:48 INFO - Return code: 0 10:01:48 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 10:01: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')]} 10:01:48 INFO - https://queue.taskcluster.net/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:01:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:01:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:01:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/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 10:01:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/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 10:01:50 INFO - Downloaded 22438476 bytes. 10:01:50 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 10:01:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:01:50 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 10:01:51 INFO - Return code: 0 10:01:51 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')]} 10:01:51 INFO - https://queue.taskcluster.net/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:01:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/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 10:01:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/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 10:01:52 INFO - Downloaded 11131693 bytes. 10:01:52 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 10:01:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:52 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 10:01:52 INFO - Return code: 0 10:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:52 INFO - https://queue.taskcluster.net/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:01:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:01:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:01:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/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 10:01:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/v2qEs_CSQUKWuds8S9cH_Q/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 10:01:55 INFO - Downloaded 57173249 bytes. 10:01:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:01:55 INFO - mkdir: /builds/slave/test-pgo/properties 10:01:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:01:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:01:55 INFO - Contents: 10:01:55 INFO - build_url:https://queue.taskcluster.net/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:01:55 INFO - Running post-action listener: _resource_record_post_action 10:01:55 INFO - Running post-action listener: set_extra_try_arguments 10:01:55 INFO - ##### 10:01:55 INFO - ##### Running populate-webroot step. 10:01:55 INFO - ##### 10:01:55 INFO - Running pre-action listener: _resource_record_pre_action 10:01:55 INFO - Running main action method: populate_webroot 10:01:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:01:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:01:55 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:01:55 INFO - '../fennec_ids.txt'], 10:01:55 INFO - 'tests': ['tcheck2']}, 10:01:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:01:55 INFO - '--tppagecycles', 10:01:55 INFO - '7'], 10:01:55 INFO - 'tests': ['tsvgm']}}, 10:01:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:01:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:01:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:01:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:01:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:01:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:01:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:55 INFO - 'talos_options': ['--e10s'], 10:01:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:55 INFO - 'tests': ['damp', 'tps']}, 10:01:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:55 INFO - 'talos_options': ['--e10s'], 10:01:55 INFO - 'tests': ['damp', 'tps']}, 10:01:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:01:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:01:55 INFO - 'other': {'tests': ['a11yr', 10:01:55 INFO - 'ts_paint', 10:01:55 INFO - 'tpaint', 10:01:55 INFO - 'sessionrestore', 10:01:55 INFO - 'sessionrestore_no_auto_restore']}, 10:01:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:01:55 INFO - 'tests': ['a11yr', 10:01:55 INFO - 'ts_paint', 10:01:55 INFO - 'tpaint', 10:01:55 INFO - 'sessionrestore', 10:01:55 INFO - 'sessionrestore_no_auto_restore']}, 10:01:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:01:55 INFO - 'tests': ['a11yr', 10:01:55 INFO - 'ts_paint', 10:01:55 INFO - 'tpaint', 10:01:55 INFO - 'sessionrestore', 10:01:55 INFO - 'sessionrestore_no_auto_restore']}, 10:01:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:01:55 INFO - 'tests': ['a11yr', 10:01:55 INFO - 'ts_paint', 10:01:55 INFO - 'tpaint', 10:01:55 INFO - 'sessionrestore', 10:01:55 INFO - 'sessionrestore_no_auto_restore']}, 10:01:55 INFO - 'other_l64': {'tests': ['a11yr', 10:01:55 INFO - 'ts_paint', 10:01:55 INFO - 'tpaint', 10:01:55 INFO - 'sessionrestore', 10:01:55 INFO - 'sessionrestore_no_auto_restore']}, 10:01:55 INFO - 'other_nol64': {'tests': ['a11yr', 10:01:55 INFO - 'ts_paint', 10:01:55 INFO - 'tpaint', 10:01:55 INFO - 'sessionrestore', 10:01:55 INFO - 'sessionrestore_no_auto_restore']}, 10:01:55 INFO - 'svgr': {'tests': ['tsvgx', 10:01:55 INFO - 'tsvgr_opacity', 10:01:55 INFO - 'tart', 10:01:55 INFO - 'tscrollx', 10:01:55 INFO - 'cart']}, 10:01:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:01:55 INFO - 'tests': ['tsvgx', 10:01:55 INFO - 'tsvgr_opacity', 10:01:55 INFO - 'tart', 10:01:55 INFO - 'tscrollx', 10:01:55 INFO - 'cart']}, 10:01:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:55 INFO - 'tests': ['tp5o']}, 10:01:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:55 INFO - 'talos_options': ['--e10s'], 10:01:55 INFO - 'tests': ['tp5o']}, 10:01:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:55 INFO - 'talos_options': ['--xperf_path', 10:01:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:55 INFO - 'tests': ['tp5n']}, 10:01:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:55 INFO - 'talos_options': ['--e10s', 10:01:55 INFO - '--xperf_path', 10:01:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:55 INFO - 'tests': ['tp5n']}}, 10:01:55 INFO - 'talos.zip': {'path': '', 10:01:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:01:55 INFO - Running post-action listener: _resource_record_post_action 10:01:55 INFO - ##### 10:01:55 INFO - ##### Running create-virtualenv step. 10:01:55 INFO - ##### 10:01:55 INFO - Running pre-action listener: _resource_record_pre_action 10:01:55 INFO - Running main action method: create_virtualenv 10:01:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:01:55 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 10:01:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:01:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:01:55 INFO - Using real prefix '/usr' 10:01:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:01:56 INFO - Installing distribute.............................................................................................................................................................................................done. 10:01:57 INFO - Installing pip.................done. 10:01:57 INFO - Return code: 0 10:01:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:57 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 0x7fb0a7517c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d516c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e126e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e48a90>, '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 0x1e9af70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9b2e0>, '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': '928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015', '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 10:01:57 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 10:01:57 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 10:01:57 INFO - Using env: {'DISPLAY': ':0', 10:01:57 INFO - 'HOME': '/home/cltbld', 10:01:57 INFO - 'LANG': 'en_US.UTF-8', 10:01:57 INFO - 'LANGUAGE': 'en_US:en', 10:01:57 INFO - 'LOGNAME': 'cltbld', 10:01:57 INFO - 'MAIL': '/var/mail/cltbld', 10:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:57 INFO - 'MOZ_NO_REMOTE': '1', 10:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:57 INFO - 'NO_EM_RESTART': '1', 10:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:57 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:57 INFO - 'SHELL': '/bin/bash', 10:01:57 INFO - 'SHLVL': '1', 10:01:57 INFO - 'TERM': 'linux', 10:01:57 INFO - 'TMOUT': '86400', 10:01:57 INFO - 'USER': 'cltbld', 10:01:57 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015', 10:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:57 INFO - '_': '/tools/buildbot/bin/python'} 10:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:58 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 10:01:58 INFO - Cleaning up... 10:01:58 INFO - Return code: 0 10:01:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb0a7517c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d516c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e126e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e48a90>, '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 0x1e9af70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9b2e0>, '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': '928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015', '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 10:01:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:01:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:01:58 INFO - Using env: {'DISPLAY': ':0', 10:01:58 INFO - 'HOME': '/home/cltbld', 10:01:58 INFO - 'LANG': 'en_US.UTF-8', 10:01:58 INFO - 'LANGUAGE': 'en_US:en', 10:01:58 INFO - 'LOGNAME': 'cltbld', 10:01:58 INFO - 'MAIL': '/var/mail/cltbld', 10:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:58 INFO - 'MOZ_NO_REMOTE': '1', 10:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:58 INFO - 'NO_EM_RESTART': '1', 10:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:58 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:58 INFO - 'SHELL': '/bin/bash', 10:01:58 INFO - 'SHLVL': '1', 10:01:58 INFO - 'TERM': 'linux', 10:01:58 INFO - 'TMOUT': '86400', 10:01:58 INFO - 'USER': 'cltbld', 10:01:58 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015', 10:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:58 INFO - '_': '/tools/buildbot/bin/python'} 10:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:58 INFO - Downloading/unpacking psutil>=0.7.1 10:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:02:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:02:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:02:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:00 INFO - Installing collected packages: psutil 10:02:00 INFO - Running setup.py install for psutil 10:02:00 INFO - building 'psutil._psutil_linux' extension 10:02:00 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 10:02:00 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 10:02:00 INFO - building 'psutil._psutil_posix' extension 10:02:00 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 10:02:00 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 10:02:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:00 INFO - Successfully installed psutil 10:02:00 INFO - Cleaning up... 10:02:00 INFO - Return code: 0 10:02:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:02:00 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')]} 10:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:00 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')]} 10:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:00 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 0x7fb0a7517c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d516c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e126e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e48a90>, '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 0x1e9af70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9b2e0>, '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': '928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015', '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 10:02:00 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 10:02:00 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 10:02:00 INFO - Using env: {'DISPLAY': ':0', 10:02:00 INFO - 'HOME': '/home/cltbld', 10:02:00 INFO - 'LANG': 'en_US.UTF-8', 10:02:00 INFO - 'LANGUAGE': 'en_US:en', 10:02:00 INFO - 'LOGNAME': 'cltbld', 10:02:00 INFO - 'MAIL': '/var/mail/cltbld', 10:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:00 INFO - 'MOZ_NO_REMOTE': '1', 10:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:00 INFO - 'NO_EM_RESTART': '1', 10:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:02:00 INFO - 'PWD': '/builds/slave/test-pgo', 10:02:00 INFO - 'SHELL': '/bin/bash', 10:02:00 INFO - 'SHLVL': '1', 10:02:00 INFO - 'TERM': 'linux', 10:02:00 INFO - 'TMOUT': '86400', 10:02:00 INFO - 'USER': 'cltbld', 10:02:00 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015', 10:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:00 INFO - '_': '/tools/buildbot/bin/python'} 10:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:02:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:02:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:02:02 INFO - Installing collected packages: mozsystemmonitor 10:02:02 INFO - Running setup.py install for mozsystemmonitor 10:02:02 INFO - Successfully installed mozsystemmonitor 10:02:02 INFO - Cleaning up... 10:02:02 INFO - Return code: 0 10:02:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb0a7517c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d516c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e126e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e48a90>, '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 0x1e9af70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9b2e0>, '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': '928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015', '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 10:02:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:02:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:02:02 INFO - Using env: {'DISPLAY': ':0', 10:02:02 INFO - 'HOME': '/home/cltbld', 10:02:02 INFO - 'LANG': 'en_US.UTF-8', 10:02:02 INFO - 'LANGUAGE': 'en_US:en', 10:02:02 INFO - 'LOGNAME': 'cltbld', 10:02:02 INFO - 'MAIL': '/var/mail/cltbld', 10:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:02 INFO - 'MOZ_NO_REMOTE': '1', 10:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:02 INFO - 'NO_EM_RESTART': '1', 10:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:02:02 INFO - 'PWD': '/builds/slave/test-pgo', 10:02:02 INFO - 'SHELL': '/bin/bash', 10:02:02 INFO - 'SHLVL': '1', 10:02:02 INFO - 'TERM': 'linux', 10:02:02 INFO - 'TMOUT': '86400', 10:02:02 INFO - 'USER': 'cltbld', 10:02:02 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015', 10:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:02 INFO - '_': '/tools/buildbot/bin/python'} 10:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:02 INFO - Downloading/unpacking blobuploader==1.2.4 10:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:04 INFO - Downloading blobuploader-1.2.4.tar.gz 10:02:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:02:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:02:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:02:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:02:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:05 INFO - Downloading docopt-0.6.1.tar.gz 10:02:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:02:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:02:05 INFO - Installing collected packages: blobuploader, requests, docopt 10:02:05 INFO - Running setup.py install for blobuploader 10:02:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:02:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:02:05 INFO - Running setup.py install for requests 10:02:05 INFO - Running setup.py install for docopt 10:02:05 INFO - Successfully installed blobuploader requests docopt 10:02:05 INFO - Cleaning up... 10:02:05 INFO - Return code: 0 10:02:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:02:05 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')]} 10:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:05 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')]} 10:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:05 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 0x7fb0a7517c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d516c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e126e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e48a90>, '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 0x1e9af70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9b2e0>, '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': '928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015', '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 10:02:05 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 10:02:05 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 10:02:05 INFO - Using env: {'DISPLAY': ':0', 10:02:05 INFO - 'HOME': '/home/cltbld', 10:02:05 INFO - 'LANG': 'en_US.UTF-8', 10:02:05 INFO - 'LANGUAGE': 'en_US:en', 10:02:05 INFO - 'LOGNAME': 'cltbld', 10:02:05 INFO - 'MAIL': '/var/mail/cltbld', 10:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:05 INFO - 'MOZ_NO_REMOTE': '1', 10:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:05 INFO - 'NO_EM_RESTART': '1', 10:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:02:05 INFO - 'PWD': '/builds/slave/test-pgo', 10:02:05 INFO - 'SHELL': '/bin/bash', 10:02:05 INFO - 'SHLVL': '1', 10:02:05 INFO - 'TERM': 'linux', 10:02:05 INFO - 'TMOUT': '86400', 10:02:05 INFO - 'USER': 'cltbld', 10:02:05 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015', 10:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:05 INFO - '_': '/tools/buildbot/bin/python'} 10:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:02:06 INFO - Running setup.py (path:/tmp/pip-OYL6yT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:02:06 INFO - Running setup.py (path:/tmp/pip-0yU4Xm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:02:06 INFO - Running setup.py (path:/tmp/pip-3P1sVK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:02:06 INFO - Running setup.py (path:/tmp/pip-jYn_zi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:02:06 INFO - Running setup.py (path:/tmp/pip-VEvSnz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:02:06 INFO - Running setup.py (path:/tmp/pip-HES6X6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:02:06 INFO - Running setup.py (path:/tmp/pip-y2fiFa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:02:06 INFO - Running setup.py (path:/tmp/pip-RMasZr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:02:06 INFO - Running setup.py (path:/tmp/pip-k9XGT4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:02:06 INFO - Running setup.py (path:/tmp/pip-aSmZt2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:02:06 INFO - Running setup.py (path:/tmp/pip-3ViO9y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:02:06 INFO - Running setup.py (path:/tmp/pip-xv9MI6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:02:07 INFO - Running setup.py (path:/tmp/pip-qNcMGi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:02:07 INFO - Running setup.py (path:/tmp/pip-TDKiQa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:02:07 INFO - Running setup.py (path:/tmp/pip-UmkWKq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:02:07 INFO - Running setup.py (path:/tmp/pip-2BWKSl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:02:07 INFO - Running setup.py (path:/tmp/pip-Nu1XlN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:02:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:02:07 INFO - Running setup.py install for manifestparser 10:02:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:02:07 INFO - Running setup.py install for mozcrash 10:02:07 INFO - Running setup.py install for mozdebug 10:02:07 INFO - Running setup.py install for mozdevice 10:02:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:02:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:02:07 INFO - Running setup.py install for mozfile 10:02:07 INFO - Running setup.py install for mozhttpd 10:02:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:02:07 INFO - Running setup.py install for mozinfo 10:02:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:02:08 INFO - Running setup.py install for mozInstall 10:02:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:02:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:02:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:02:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:02:08 INFO - Running setup.py install for mozleak 10:02:08 INFO - Running setup.py install for mozlog 10:02:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:02:08 INFO - Running setup.py install for moznetwork 10:02:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:02:08 INFO - Running setup.py install for mozprocess 10:02:08 INFO - Running setup.py install for mozprofile 10:02:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:02:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:02:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:02:08 INFO - Running setup.py install for mozrunner 10:02:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:02:08 INFO - Running setup.py install for mozscreenshot 10:02:08 INFO - Running setup.py install for moztest 10:02:09 INFO - Running setup.py install for mozversion 10:02:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:02:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:02:09 INFO - Cleaning up... 10:02:09 INFO - Return code: 0 10:02:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:09 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 0x7fb0a7517c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d516c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e126e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e48a90>, '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 0x1e9af70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9b2e0>, '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': '928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015', '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 10:02:09 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 10:02:09 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 10:02:09 INFO - Using env: {'DISPLAY': ':0', 10:02:09 INFO - 'HOME': '/home/cltbld', 10:02:09 INFO - 'LANG': 'en_US.UTF-8', 10:02:09 INFO - 'LANGUAGE': 'en_US:en', 10:02:09 INFO - 'LOGNAME': 'cltbld', 10:02:09 INFO - 'MAIL': '/var/mail/cltbld', 10:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:09 INFO - 'MOZ_NO_REMOTE': '1', 10:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:09 INFO - 'NO_EM_RESTART': '1', 10:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:02:09 INFO - 'PWD': '/builds/slave/test-pgo', 10:02:09 INFO - 'SHELL': '/bin/bash', 10:02:09 INFO - 'SHLVL': '1', 10:02:09 INFO - 'TERM': 'linux', 10:02:09 INFO - 'TMOUT': '86400', 10:02:09 INFO - 'USER': 'cltbld', 10:02:09 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015', 10:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:09 INFO - '_': '/tools/buildbot/bin/python'} 10:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:02:09 INFO - Running setup.py (path:/tmp/pip-S04UBd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:02:09 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)) 10:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:02:09 INFO - Running setup.py (path:/tmp/pip-WkbUce-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:02:09 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)) 10:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:02:09 INFO - Running setup.py (path:/tmp/pip-1flpBe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:02:09 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)) 10:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:02:09 INFO - Running setup.py (path:/tmp/pip-ENeMSW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:02:09 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)) 10:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:02:09 INFO - Running setup.py (path:/tmp/pip-6vq1B8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:02:09 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)) 10:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:02:09 INFO - Running setup.py (path:/tmp/pip-QZ5c15-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:02:09 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)) 10:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:02:09 INFO - Running setup.py (path:/tmp/pip-qPoCaK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:02:09 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)) 10:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:02:09 INFO - Running setup.py (path:/tmp/pip-U92bp3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:02:09 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)) 10:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:02:09 INFO - Running setup.py (path:/tmp/pip-FUekAd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:02:10 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)) 10:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:02:10 INFO - Running setup.py (path:/tmp/pip-Lh_7d7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:02:10 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)) 10:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:02:10 INFO - Running setup.py (path:/tmp/pip-YXtHLp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:02:10 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)) 10:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:02:10 INFO - Running setup.py (path:/tmp/pip-IMvzjz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:02:10 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)) 10:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:02:10 INFO - Running setup.py (path:/tmp/pip-sMb8M3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:02:10 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)) 10:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:02:10 INFO - Running setup.py (path:/tmp/pip-nyfLQW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:02:10 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)) 10:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:02:10 INFO - Running setup.py (path:/tmp/pip-tkmD_R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:02:10 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)) 10:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:02:10 INFO - Running setup.py (path:/tmp/pip-oUeJVE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:02:10 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)) 10:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:02:10 INFO - Running setup.py (path:/tmp/pip-2NnoeB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:02:10 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)) 10:02:10 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)) 10:02:10 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)) 10:02:10 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)) 10:02:10 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)) 10:02:10 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)) 10:02:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:12 INFO - Downloading blessings-1.5.1.tar.gz 10:02:12 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 10:02:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:02:12 INFO - Installing collected packages: blessings 10:02:12 INFO - Running setup.py install for blessings 10:02:12 INFO - Successfully installed blessings 10:02:12 INFO - Cleaning up... 10:02:12 INFO - Return code: 0 10:02:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:02:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:02:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:02:12 INFO - Reading from file tmpfile_stdout 10:02:12 INFO - Current package versions: 10:02:12 INFO - argparse == 1.2.1 10:02:12 INFO - blessings == 1.5.1 10:02:12 INFO - blobuploader == 1.2.4 10:02:12 INFO - docopt == 0.6.1 10:02:12 INFO - manifestparser == 1.1 10:02:12 INFO - mozInstall == 1.12 10:02:12 INFO - mozcrash == 0.16 10:02:12 INFO - mozdebug == 0.1 10:02:12 INFO - mozdevice == 0.47 10:02:12 INFO - mozfile == 1.2 10:02:12 INFO - mozhttpd == 0.7 10:02:12 INFO - mozinfo == 0.9 10:02:12 INFO - mozleak == 0.1 10:02:12 INFO - mozlog == 3.0 10:02:12 INFO - moznetwork == 0.27 10:02:12 INFO - mozprocess == 0.22 10:02:12 INFO - mozprofile == 0.27 10:02:12 INFO - mozrunner == 6.11 10:02:12 INFO - mozscreenshot == 0.1 10:02:12 INFO - mozsystemmonitor == 0.0 10:02:12 INFO - moztest == 0.7 10:02:12 INFO - mozversion == 1.4 10:02:12 INFO - psutil == 3.1.1 10:02:12 INFO - requests == 1.2.3 10:02:12 INFO - wsgiref == 0.1.2 10:02:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fb0a7517c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d516c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e126e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e48a90>, '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 0x1e9af70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9b2e0>, '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': '928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015', '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 10:02:12 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 10:02:12 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 10:02:12 INFO - Using env: {'DISPLAY': ':0', 10:02:12 INFO - 'HOME': '/home/cltbld', 10:02:12 INFO - 'LANG': 'en_US.UTF-8', 10:02:12 INFO - 'LANGUAGE': 'en_US:en', 10:02:12 INFO - 'LOGNAME': 'cltbld', 10:02:12 INFO - 'MAIL': '/var/mail/cltbld', 10:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:12 INFO - 'MOZ_NO_REMOTE': '1', 10:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:12 INFO - 'NO_EM_RESTART': '1', 10:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:02:12 INFO - 'PWD': '/builds/slave/test-pgo', 10:02:12 INFO - 'SHELL': '/bin/bash', 10:02:12 INFO - 'SHLVL': '1', 10:02:12 INFO - 'TERM': 'linux', 10:02:12 INFO - 'TMOUT': '86400', 10:02:12 INFO - 'USER': 'cltbld', 10:02:12 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015', 10:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:12 INFO - '_': '/tools/buildbot/bin/python'} 10:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:12 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)) 10:02:12 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)) 10:02:12 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)) 10:02:12 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)) 10:02:12 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)) 10:02:12 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)) 10:02:12 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)) 10:02:12 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)) 10:02:12 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)) 10:02:12 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)) 10:02:12 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)) 10:02:12 INFO - Cleaning up... 10:02:12 INFO - Return code: 0 10:02:12 INFO - Running post-action listener: _resource_record_post_action 10:02:12 INFO - Running post-action listener: _start_resource_monitoring 10:02:12 INFO - Starting resource monitoring. 10:02:12 INFO - ##### 10:02:12 INFO - ##### Running install step. 10:02:12 INFO - ##### 10:02:12 INFO - Running pre-action listener: _resource_record_pre_action 10:02:12 INFO - Running main action method: install 10:02:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:02:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:02:13 INFO - Reading from file tmpfile_stdout 10:02:13 INFO - Detecting whether we're running mozinstall >=1.0... 10:02:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:02:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:02:13 INFO - Reading from file tmpfile_stdout 10:02:13 INFO - Output received: 10:02:13 INFO - Usage: mozinstall [options] installer 10:02:13 INFO - Options: 10:02:13 INFO - -h, --help show this help message and exit 10:02:13 INFO - -d DEST, --destination=DEST 10:02:13 INFO - Directory to install application into. [default: 10:02:13 INFO - "/builds/slave/test-pgo"] 10:02:13 INFO - --app=APP Application being installed. [default: firefox] 10:02:13 INFO - mkdir: /builds/slave/test-pgo/build/application 10:02:13 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'] 10:02:13 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 10:02:27 INFO - Reading from file tmpfile_stdout 10:02:27 INFO - Output received: 10:02:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:02:27 INFO - Running post-action listener: _resource_record_post_action 10:02:27 INFO - ##### 10:02:27 INFO - ##### Running run-tests step. 10:02:27 INFO - ##### 10:02:27 INFO - Running pre-action listener: _resource_record_pre_action 10:02:27 INFO - Running main action method: run_tests 10:02:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:02:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:02:27 INFO - Python 2.7.3 10:02:27 INFO - Return code: 0 10:02:27 INFO - grabbing minidump binary from tooltool 10:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:27 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 0x1e48a90>, '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 0x1e9af70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9b2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:02:27 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 10:02:27 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 10:02:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:02:27 INFO - Return code: 0 10:02:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:02:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:02:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:02:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:02:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:02:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:02:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost 10:02:27 INFO - Using env: {'DISPLAY': ':0', 10:02:27 INFO - 'HOME': '/home/cltbld', 10:02:27 INFO - 'LANG': 'en_US.UTF-8', 10:02:27 INFO - 'LANGUAGE': 'en_US:en', 10:02:27 INFO - 'LOGNAME': 'cltbld', 10:02:27 INFO - 'MAIL': '/var/mail/cltbld', 10:02:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:02:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:27 INFO - 'MOZ_NO_REMOTE': '1', 10:02:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:27 INFO - 'NO_EM_RESTART': '1', 10:02:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:02:27 INFO - 'PWD': '/builds/slave/test-pgo', 10:02:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:02:27 INFO - 'SHELL': '/bin/bash', 10:02:27 INFO - 'SHLVL': '1', 10:02:27 INFO - 'TERM': 'linux', 10:02:27 INFO - 'TMOUT': '86400', 10:02:27 INFO - 'USER': 'cltbld', 10:02:27 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015', 10:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:27 INFO - '_': '/tools/buildbot/bin/python'} 10:02:27 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost'] with output_timeout 3600 10:02:27 INFO - mozversion INFO | application_buildid: 20151112083142 10:02:27 INFO - mozversion INFO | application_changeset: b62504059749d3ea58458c1122f957ef87b6d8b4 10:02:27 INFO - mozversion INFO | application_display_name: Nightly 10:02:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:02:27 INFO - mozversion INFO | application_name: Firefox 10:02:27 INFO - mozversion INFO | application_remotingname: firefox 10:02:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 10:02:27 INFO - mozversion INFO | application_vendor: Mozilla 10:02:27 INFO - mozversion INFO | application_version: 45.0a1 10:02:27 INFO - mozversion INFO | platform_buildid: 20151112083142 10:02:27 INFO - mozversion INFO | platform_changeset: b62504059749d3ea58458c1122f957ef87b6d8b4 10:02:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 10:02:27 INFO - mozversion INFO | platform_version: 45.0a1 10:02:27 INFO - 2015-11-12 10:02:27,907 DEBUG : using testdate: 1447351347 10:02:27 INFO - 2015-11-12 10:02:27,907 DEBUG : actual date: 1447351347 10:02:27 INFO - 2015-11-12 10:02:27,916 INFO : starting webserver on 'localhost:40789' 10:02:27 INFO - 2015-11-12 10:02:27,917 INFO : Starting test suite talos-linux64-ix-012 10:02:27 INFO - 2015-11-12 10:02:27,917 INFO : Starting test dromaeo_css 10:02:27 INFO - 2015-11-12 10:02:27,917 DEBUG : operating with platform_type : linux_ 10:02:27 INFO - 2015-11-12 10:02:27,918 INFO : Initialising browser for dromaeo_css test... 10:02:27 INFO - 2015-11-12 10:02:27,931 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_ux6wz/profile http://localhost:40789/getInfo.html 10:02:31 INFO - 2015-11-12 10:02:31,537 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:02:31 INFO - 2015-11-12 10:02:31,537 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:02:31 INFO - 2015-11-12 10:02:31,537 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:02:31 INFO - 2015-11-12 10:02:31,537 DEBUG : BROWSER_OUTPUT: __metrics 10:02:31 INFO - 2015-11-12 10:02:31,634 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:02:32 INFO - 2015-11-12 10:02:32,701 INFO : Browser initialized. 10:02:32 INFO - 2015-11-12 10:02:32,702 INFO : Running cycle 1/1 for dromaeo_css test... 10:02:32 INFO - 2015-11-12 10:02:32,702 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_ux6wz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:02:44 INFO - 2015-11-12 10:02:44,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 139333632 10:02:44 INFO - 2015-11-12 10:02:44,415 DEBUG : BROWSER_OUTPUT: 10:03:36 INFO - 2015-11-12 10:03:36,087 DEBUG : BROWSER_OUTPUT: 1447351416079 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] 10:05:44 INFO - 2015-11-12 10:05:44,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40789/tests/dromaeo/cssquery-ext.html) 10:05:45 INFO - 2015-11-12 10:05:45,464 DEBUG : BROWSER_OUTPUT: RSS: Main: 239894528 10:05:45 INFO - 2015-11-12 10:05:45,465 DEBUG : BROWSER_OUTPUT: 10:08:47 INFO - 2015-11-12 10:08:47,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/dromaeo/cssquery-ext.html (next: http://localhost:40789/tests/dromaeo/cssquery-jquery.html) 10:08:48 INFO - 2015-11-12 10:08:48,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 219226112 10:08:48 INFO - 2015-11-12 10:08:48,402 DEBUG : BROWSER_OUTPUT: 10:11:50 INFO - 2015-11-12 10:11:50,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40789/tests/dromaeo/cssquery-mootools.html) 10:11:50 INFO - 2015-11-12 10:11:50,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 212443136 10:11:50 INFO - 2015-11-12 10:11:50,870 DEBUG : BROWSER_OUTPUT: 10:14:52 INFO - 2015-11-12 10:14:52,718 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40789/tests/dromaeo/cssquery-prototype.html) 10:14:53 INFO - 2015-11-12 10:14:53,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 195751936 10:14:53 INFO - 2015-11-12 10:14:53,300 DEBUG : BROWSER_OUTPUT: 10:17:55 INFO - 2015-11-12 10:17:55,828 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40789/tests/dromaeo/cssquery-yui.html) 10:17:56 INFO - 2015-11-12 10:17:56,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 201060352 10:17:56 INFO - 2015-11-12 10:17:56,423 DEBUG : BROWSER_OUTPUT: 10:20:58 INFO - 2015-11-12 10:20:58,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/dromaeo/cssquery-yui.html (next: http://localhost:40789/tests/dromaeo/cssquery-dojo.html) 10:20:58 INFO - 2015-11-12 10:20:58,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 285216768 10:20:58 INFO - 2015-11-12 10:20:58,915 DEBUG : BROWSER_OUTPUT: 10:20:58 INFO - 2015-11-12 10:20:58,917 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:20:58 INFO - 2015-11-12 10:20:58,917 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:20:58 INFO - 2015-11-12 10:20:58,917 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:20:58 INFO - 2015-11-12 10:20:58,917 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:20:58 INFO - 2015-11-12 10:20:58,921 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3171.968280317197;3219.903402897914;3252.3657886712085;3261.853216605254;3273.8690452381898;5184.53339199472;5300.946990530094;5361.7587208575615;5365.275687782148;5421.701806400646;5345.919811202835;5349.090654588719;5406.702631355274;5407.594430417715;5463.836084917449;4860.368152140226;4905.460399356068;4932.7780249888665;4996.400431948171;5025.422076461217;4822.855314340575;5029.874253143683;5035.823746168885;5090.083784918713;5115.795368185287;4809.350737650408;4919.163742163841;4942.986687729007;4957.504249575014;4964.925526117111;4915.287283343895;4923.212286034253;4937.456879743226;4944.752762361867;4959.82640607577;4765.952340476586;4875.8781030474165;4911.238757992517;4915.16442204826;4974.626902982291;5215.713135777531;5284.603654725873;5285.339332583427;5301.098813201726;5312.946870531284;5832.591718579701;5838.211841401441;5840.912386314209;5843.941560584425;5848.093545500455;5656.773729050833;5751.626144300649;5772.6536407815665;5877.235959325303;5894.145348924425;5485.232067510512;5512.3936367;5512.751926163332;5513.724313784295;5516.724163791875;5963.850903727442;5966.582339236212;5983.611065280743;5986.850328741729;6030.185924900083;5524.033294173503;5629.774809007594;5689.431056894277;5771.249737534094;5794.594378393556;5793.246877905845;5796.159556864315;5800.53595712342;5803.564732644984;5804.709764511842;5783.88432231353;5785.1322301654245;5786.392428795;5786.71066446676;5795.478406943395;5585.8603534911135;5699.088145896637;5718.857028574235;5807.274090738658;5846.41535846412;4455.710378825366;4509.594136527729;4518.751468669189;4519.615832654261;4560.452745670541;3900.258950799339;4013.618706222904;4015.7188996769946;4029.516458024997;4050.696197785178;5450.672959622435;5505.146702261156;5510.862228444241;5529.391766905637;5569.972150139223;5841.678707671119;5848.5321174305955;5849.5027922626205;5856.092305692625;5883.588148829541;5336.1462166054025;5449.972750136303;5545.473180047889;5560.443955604407;5562.332520097614;5027.069992051483;5105.591552675852;5111;5115.97442012795;5145.3568303962;6081.726322315506;6104.236970378792;6110.022396416552;6111.54163437744;6111.694415279308;5689.914651280152;5718.456746609066;5828.504577110993;5837.737301821513;5864.384239654775;6108.221534911944;6120.3267640558615;6123.089961861626;6125.448709615977;6130.754769809158;5773.566982476247;5776.393478684678;5786.739596718242;5789.3921138279875;5825.475707186373;5670.092785154356;5702.429757024264;5799.565032622654;5835.79574714883;5836.124581312667;5608.242887210175;5687.374388817144;5689.1750696148;5689.914651280317;5700.942990570041;5670.74481648335;5678;5679.460451257124;5683.829485115453;5685.715714214355;5419.05166595852;5487.807926722546;5537.446255374592;5567.276254086943;5607.327120745374;5711.971440142773;5712.057510510719;5716.171155182558;5718.51392631631;5720.141978703062;5410.567154627542;5585.748641311069;5599.32808063035;5600.27196464457;5600.719964001865 10:20:58 INFO - 2015-11-12 10:20:58,921 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.9549636029118;589.1486801571731;602.4607975861603;608.3703367015138;615.1510914937388;31594.526082108787;41955;42321.365179522334;42362.15275694488;42470.57529424712;43526.56473435264;43815.78092109543;44198.33702494465;44224;44269.33595996055;7624.542527448343;7759.728409505668;8793.164649358318;8955.149260820212;10299.588016479369;10400.167986561095;10557.630482933098;10564.630237941674;10571.101456376216;10576.206784491156;10596.470176491182;10699.251052426333;10704.14366850654;10704.197185211102;10709.089727373183;7839.608019598997;8037.397195210353;10332.535035923402;10498;10512.421816800073;10066.597336106546;10214.28500005;10214.28500005;10216.693499195037;10222.0289072538;40373.394399084034;40754.592454075675;40804.79597602023;40828.183436331106;40839.59160408388;3377.189474526096;3578.5526809148596;3587.282543491286;3593.4609808528667;3935.8622448214173;30437.23906902323;30648.387032259452;31086.53370199449;31441.528377074133;31717.841410792797;3052.5115981443087;3069.8004629699;3073.754099672021;3116.3923035008183;3136.310011797401;281973;282477;282880;283170;283662;56506.717466413225;57702.42297577055;60997;65286;66844.66577667178;60921.69539152276;61544.69227653833;61718.69140654358;61763.69118154381;61970;15284.923575382052;15344.539663810103;15370.769438458432;15450.6137346565;15458;12022.579209727792;12099.334536600396;12122.939385303018;12138.45376958039;12244.877551224552;19501.80498195028;19819.702704459443;19949.501262468264;19997.700034499496;20025.29911453121;7666.8849967250535;7689.846203076019;7751.7674469766;7808.336291415293;7859.436992253934;945.9574319155655;955.9808803823885;975.8048390321823;1007.5919252702668;1045.7124290819934;29293;29347.266318342212;29424.84176029507;29435.85282073576;29744.851275743484;1027.8047171037479;1085.8099832529276;1116.832475128737;1148.6324376199536;1154.318951818431;14845;15071;15301.923490382476;15332.540023799082;15987.200639967956;293572;294784;295667;298141;298250;56108.438915611136;56760;56885;56885;56959.43040569624;1340.4973135074347;1360.6802401435655;1361.5847166614278;1396.7695330270392;1401.5234820161195;30176;31179.84410077935;31187.220319491287;31350.843245784537;31805.681943180272;44212.55787442213;45348.77325613351;49987.25019124789;51578.48421515887;51657.483425165265;438015;445609;445702;445858;446525;43127.784361078;43606;43865.78067109644;43997.120057598026;44004.33993490036;46923;47115.528844711116;47264;48083.27875081806;48542.757286213346;39008.2198356037;39635;41945.37081943834;42085;42690.78654606707;37951.62048379481;38104.23791524209;38159.42760858645;38485;39002.414963775;37042.8147859259;37816.24367512689;37893.24213515659;37999.62000379961;38040.61959380481;33621;33960;34661.48007779936;37598;38918.221635566566;26014.86992565025;26717.46565068649;26756.59865101986;26913.192604221906;27231.86384068067 10:20:58 INFO - 2015-11-12 10:20:58,924 DEBUG : BROWSER_OUTPUT: |2;jquery.html;347.7444078602228;350.0339064182855;351.4394540707571;352.2374060159754;352.50297081115633;14494.5651630451;14653.633659158526;16806.243719032642;17120.74318885216;17822.10889455527;15873.52379428619;16966.151692415362;17238.741418878726;17316.220770065345;17984.820151798478;5415.323084614433;5540.806071787489;5554.250176226218;5554.361248456418;5559.138333558305;3909.6090390960962;3993.4209539616736;5510.311211098613;5543.334799824007;5995.280566332024;6014.0678194879865;6022.578419510636;6074.969625151868;6083.817485475421;6083.878322433548;5871.823845284648;6030.306514750816;6056.303525094627;6056.909146362808;6063.272407311107;5172.379314482248;5271.973640131813;5282.709450980195;5293.073712100406;5295.364556253275;21051.68422473664;21088;21116.3665090046;21204.893975530023;21285.14859405622;2244.113575137828;2279.3731723775927;2296.8621882687094;2340.5552944940405;2802.7057158998214;12946.158499697489;13002.349882505838;13211.933940330333;13320.866791332059;13755.724885502334;1835.5411147213197;1836.1278392763463;1839.4941391117416;1861.2368928739288;1933.3426634944187;61853.381466185216;62702.059469108455;63213;63476.99999999954;63772;9531.666391676257;9672.08115229052;9881.505924703735;9897.505124743733;9969.052939970692;12691;12704.618861434172;12705.174163679516;12706.428210730539;12727.936360318325;7666.923330766733;7776.183500732454;7776.883346749803;7779.533228006338;7842.9215707842195;7664.195259497673;7681.308682218627;7723.189065148191;7731.420143489148;7759.068911730628;5905.616134951214;6003.879922401527;6008.609440386361;6019.187409699722;6083.057126145454;1622.691688579166;1661.3603762551263;1716.8111507734138;1747.1346990934876;1752.1764770557818;377.8110944527736;382.88704832074603;1011.7571782772081;1025.1337619711333;1045.9372437653765;9530.475823829618;10071.446070466194;10120.696379108638;10444.537764712946;10827.783444331228;447.8141571247896;457.6476113392669;484.0101991427539;498.60111910471477;506.8150125204274;6265.594123635227;6670.733170673216;6724.966375168093;6726.260111387744;6755.560888542229;485359;487052;495952;509709;509737;73769.6311518439;74640.62679686566;76790.23209767943;77069;77307;547.5537436988841;550.2489102375229;550.9228707980886;551.283331668829;552.326162082259;10975.835362469728;11195.160362972973;11404.600838970597;11633.234676103115;12099.75800484003;33371.33257334888;33463.66536334703;34068.318633627685;35418.8229058853;37144;47505.586745788874;48409.515904840504;48680;50522.49477505178;51554.48445515647;6651.7006734698025;7067.82330441743;7068.893966590403;7075.823104422225;7081.221065682874;12330.753384932072;12711.237325760483;12786.744265114832;12847;12853.550125745927;11012;11210.047145992681;11310.773784524099;11336.94331528337;11343.716407089889;10570.735731606772;10610.310329828537;11079.944600276947;11121.165912556753;11248;10686.465676715978;10769.838452423377;10780.784384312426;10788.298760580537;10816.351018938889;6760.560563563353;6871.03805467245;7021.719131234693;7028.437724982092;7033.191183014019;10697.518611662339;10755.677329680122;10832.67501974942;11105.94447027792;11226.887731122584 10:20:58 INFO - 2015-11-12 10:20:58,926 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1334.5262431836704;1452.1287227663402;1503.9022463539868;1596.7125917334881;1708.3166733306668;6775.62734049627;7346.449016323777;7533.28433798789;7548.92451075489;7553.735619253327;7332.120145582538;7401.111866576019;7469.626518674072;7481.438892083088;7483.925160748391;1973.2008536542724;2015.4860510569783;2231.241377931503;2312.1329501436962;2332.7550607186254;2284.6915666384994;2294.4608017116047;2295.781900719429;2297.6208925527267;2297.6783250344884;2212.314182603398;2258.785415385544;2261.1407665087245;2263.1173842201556;2263.694401255826;1957.383424221373;1993.083181736403;2207.172310383598;2250.223672832886;2254.413852398372;2260.1411463643876;2270.2281224383623;2290.3472510334473;2293.8279629027725;2334.8365614407;7481.700731970769;7553.093628764528;7554.660040298199;7562.962185189094;7564.773056808304;4480.932786008212;4562.840300589463;4583.289590113538;4584.518625544303;4587.7017993830295;2918.1099764571795;2961.1264676920146;3012.5330573761103;3020.6677265500775;3046.299351149248;959.9376040557341;963.330485312708;972.9854052189223;977.4917043137528;1018.5111146649575;10230.23273254509;10236.33463824849;10256.179505639531;10258.384496930208;10278.69163925076;4126.339785634284;4226.640735537452;4236.597523235288;4242.639375653042;4301;8751.56242187888;8805.339599530062;8809.11908809114;8826.911730882737;8837.337199710048;4616;4616.792244349012;4635.930461043087;4641.164590373698;4641.373414589055;4222.366645003274;4224.091820258659;4227.32362821947;4238.321868501025;4241.363795430649;3553.662402071799;3629.7822130672243;3642.9817850910576;3646.8176591170336;3678.65052819987;1184.336771407997;1187.2935603316014;1189.1259923956059;1196.216478206776;1203.12172114357;1016.3800081950004;1226.3500344817262;1227.6869398303375;1254.1973137192203;1258.282778816066;6299.055141728777;6451.741930322828;6955.200151982485;7200.279972002862;7214.6031968241205;697.083335413929;701.8175274428584;706.1808302369227;710.5665544018145;713.2368365848596;5313.256144139824;5333.12003519415;5340.118880384771;5362.91955620666;5369.033573956725;8686.695965641298;8722.040575536686;8755.474671519602;8817.030126686059;8817.470951742916;8600.526971016654;8647.610857511427;8689.522076285864;8727.083656216133;8731.995820480599;6738.764143254963;6880.0367948486255;6886.793396198122;6908.274631163656;6910.032595436643;6429.6142231466265;6491.870162596816;6496.577722448026;6499.837504062247;6502.512311576556;7455.627218639155;7698.615069246627;7810.804729881798;7824.100228473799;7851.05787305527;7879.251471110236;8023.518588884685;8128.674853005814;8133.8373232536205;8144.714934977247;6532.05285233648;6574.506911981525;6616.768413105518;6620.569662971891;6629.801105966829;7132.821679458055;7144.142702875688;7159.677814498465;7182.60495672743;7188.784336469915;6604.669766511752;6709.865802684017;6762.560433571802;6793.72825086991;6923.9653801730665;6570.720891676618;6597.340265973365;6637.800865974028;6680.198376194888;6747.763828265987;5855.970720146372;6630.668466576748;6664.733410663519;6680.699368528525;6682.866342673216;5722.570807189394;6133.44798968095;6141.539384546266;6160.229971253593;6164.815055548341;6097.969510152421;6161;6207.441330280297;6207.6585787782105;6216.564840461305 10:20:58 INFO - 2015-11-12 10:20:58,929 DEBUG : BROWSER_OUTPUT: |4;prototype.html;319.6112889495144;320.2570037512971;320.7882797353746;321.3155977767356;325.16108440224207;5674.120511320747;5680.091185410335;5704.11586204138;5726.026575482168;5743.885122297552;5570.944290557093;5647.463490968362;5665.971670141644;5668.234788303578;5672.744726487308;4258.765767882765;4307.353896915472;4371.584699453555;4377;4378.6934914555995;4340.175366680321;4391.297392417214;4400.075984043355;4402;4413.404190434282;4333.891652708676;4340.65274778017;4350.956490435103;4357.150355680644;4366.1049484855685;4327.307630779092;4357.106793107437;4358;4358.8038538265855;4364.825406983733;3818.3890577507464;3826.8086595670106;3828.2917660232947;3855.267499175176;3886.980565097185;5120.15517439622;5242.108841496916;5243.082460569385;5305.628605997582;5407.621466497347;4982.701037937735;5022.673526220784;5024.62315326352;5027.296178535008;5027.346444962168;5905.940940590625;5939.821805345847;5946.554008449383;5949.494292985101;5950.404959504058;4057.2088442753675;4085;4220.092680073768;4222.915541689149;4224.197402493516;6186.10301506279;6254.437100660917;6255.06174073888;6258.4680302174365;6272.529560283043;4222.155568886235;4229.703920725581;4233.70364074518;4235.512916014636;4241.4698162729655;4074.348104303297;4120.21715873983;4235.25882970479;4281.614654681031;4299;4949.455559888409;4969.453360130383;4969.503049695001;4969.875753106201;4976.950230497649;6025.096235564701;6032.125341825498;6032.306284777219;6035.124906888476;6036.63780173191;1524.390243902448;1558.088518216833;1558.4467514032583;1559.165846272239;1559.2749371542288;1010.525053224983;1025.2259544044198;1027.3938376357985;1031.28841099641;1037.8754549453963;5834.212381328466;5837.824865254049;5843.503302219359;5859.033259512218;5863.061910094364;6039.154518367344;6130.693465326716;6138.447539721357;6147.323794382614;6150.108234306001;5828.067509198508;5828.184054232411;5828.737706803204;5828.912566311508;5835.153902684172;3433.399155147889;3463.2207753255316;3472.097254713742;3479.9652003480146;3487.302539492112;6499.1876015498065;6525.902111468332;6533.052707357407;6533.346665333524;6612.702428390734;6427.58220715652;6457.61254324742;6459.838504037437;6460.547761656733;6463.806085817433;6512.837179070561;6561.343865613496;6568.113304703899;6572.342765723485;6581.440577550962;6203.286622038523;6218.968905155445;6262.091996660368;6268.153799237227;6281.403266689657;6171.753129874754;6187.504999600112;6219.253689557101;6238.812835614939;6239.96880015597;6484.383983521558;6484.513661475314;6489.967550162219;6495.512836537184;6502.382273683992;4234.894127646833;4251.426057482324;4305.07440900208;4307.978460107679;4311.504177019683;6093.207882975362;6110.236220472441;6184.628922264678;6186.752529898754;6196.845078873064;6076;6093.6039157454625;6093.725782339717;6110.114033465034;6110.877782444415;6015.428534289235;6019.638821670714;6024.33732289439;6029.939700602938;6044.063170208625;5889.646621202742;5971.193888825127;5972.70136493165;5987.2815262168815;6007.158997740407;6127.754889804358;6138.662373569497;6139.416755408229;6141.201643786279;6145.877082458415;5979.9967011051785;5985.311689155628;5989.8203053908455;5991.520678345809;5998.520118390606 10:20:58 INFO - 2015-11-12 10:20:58,929 DEBUG : BROWSER_OUTPUT: |5;yui.html;699.0562740300592;700.8528209076094;797.6649807081029;800.6637212370804;807.3662175192474;13495.730085398287;13715.93142034291;13727.725445491084;13746.175229486238;13746.72506549871;11463.59877404291;12009.759804803898;12750.617481475547;12924.224546527192;12973.675658108552;803.8151225218203;815.3232816762073;817.6811043692965;818.5170749257936;820.2781552234026;808.0828259924969;816.5141740664295;818.4107442641318;818.6152508321079;819.1317203764029;850.8851305073798;855.4268640011177;857.9742607721778;858.5964596639569;859.1623167411786;846.9830603387959;853.0105078109394;853.5390888919976;853.91887770662;854.2610641794834;625.9906101408437;627.5011365964024;628.2084573437456;628.4438272129153;628.5694299404922;12199.695007624792;12333.075019373493;12333.321667308295;12338.81491777624;12341.938290308492;10271.33236339643;10317.48412579368;10397.636082737068;10543.683689489328;10629.681109566647;9433.123786032085;9462.905370946271;9550.140487356102;9608.27937904653;9735.17251033663;3537.2925414917117;3550.840212190458;3593.3531964246426;3596.0829988352803;3632.3824949758605;46587.53412465866;46778.532214677754;47058.294125588145;47103.528964710255;47125.52874471246;8075.636596353178;8237.8352432951;8327.6668933242;8360.247577717913;8366.707165249309;16648.417305394494;16649.83350166507;16657.50027499177;16700.91649541769;16720.16399180036;7365.631718414165;7520.435967302475;7606.771796846104;7665.61671916402;7764.417668674872;4262.893427664271;4282.550332215135;4309.741415515079;4420.7126536775;4428.645708343325;2803.4393121375806;2842.8862845486365;2844.630198074237;2845.5020371434916;2846.51609226432;422.99365509517384;437.7111106669583;439.4462976649381;442.1488634378808;452.08678469491446;550.3478378121938;557.0474488624498;560.3077213986833;578.467809615155;617.5430181665625;7842.764717058498;8719.389642725075;8937.73186804397;8948.8657670135;8951.955240223888;557.4676184244037;583.294214001055;628.6259675493075;651.2250421997808;674.6289540752566;3697.722670799647;3812.1428607013154;3886.436466712311;3892.8637497687446;3953.644172024474;54530.45469545333;55194.44805551893;55248.72375638176;63171.368286316545;63722.044169337496;43054.354184687254;43106.35340469895;47999.5200048002;48392.27411588829;49454;45280.54719452829;45900.311495327594;46027.76986115048;46154.53845461569;50499.49500504948;7721.957535732829;7954.363650908029;8107.4324797263625;8148.796280093045;8478.872816907875;36883.44674829826;37197.25605487929;37234;37339.62660373362;38164.23671526498;41952;47696.7615161922;48147;48437.9452568429;48948.265776012675;7227.457940654577;7880.881786773089;7896.09194942566;7986.281234688906;8080.838383232185;9944.35361701487;10396.844047339448;11166.218364714718;11423.257488263236;11447.771044579229;10109;10476.476176191312;10956.233063685784;11232.157588181082;11252.381119038531;10346.948265258927;10655.680329590125;10692.091172250446;10754.838677419688;11025.887342030332;10439;10829.729256768644;10834.458277085956;10938.906109388998;11247.606333778278;8897.466152030898;9032.638694452411;9272.72181834546;9296.674616388394;9444.85832712496;8543.700970466003;8954.373193876627;9105.226055785333;9135.954320228357;9328.580213890256 10:20:58 INFO - 2015-11-12 10:20:58,930 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:20:58 INFO - 2015-11-12 10:20:58,931 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:20:58 INFO - 2015-11-12 10:20:58,931 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,860 10:20:58 INFO - 2015-11-12 10:20:58,931 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:20:58 INFO - 2015-11-12 10:20:58,931 DEBUG : BROWSER_OUTPUT: __startTimestamp1447352458916__endTimestamp 10:20:58 INFO - 2015-11-12 10:20:58,932 DEBUG : BROWSER_OUTPUT: 10:20:58 INFO - 2015-11-12 10:20:58,932 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:20:58 INFO - 2015-11-12 10:20:58,932 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:20:58 INFO - 2015-11-12 10:20:58,932 DEBUG : BROWSER_OUTPUT: 10:20:58 INFO - 2015-11-12 10:20:58,932 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5402.17 Median:5585.86 stddev:601.58 (10.8%) stddev-sans-first:577.42 10:20:58 INFO - 2015-11-12 10:20:58,932 DEBUG : BROWSER_OUTPUT: Values: 3172.0 3219.9 3252.4 3261.9 3273.9 5184.5 5300.9 5361.8 5365.3 5421.7 5345.9 5349.1 5406.7 5407.6 5463.8 4860.4 4905.5 4932.8 4996.4 5025.4 4822.9 5029.9 5035.8 5090.1 5115.8 4809.4 4919.2 4943.0 4957.5 4964.9 4915.3 4923.2 4937.5 4944.8 4959.8 4766.0 4875.9 4911.2 4915.2 4974.6 5215.7 5284.6 5285.3 5301.1 5312.9 5832.6 5838.2 5840.9 5843.9 5848.1 5656.8 5751.6 5772.7 5877.2 5894.1 5485.2 5512.4 5512.8 5513.7 5516.7 5963.9 5966.6 5983.6 5986.9 6030.2 5524.0 5629.8 5689.4 5771.2 5794.6 5793.2 5796.2 5800.5 5803.6 5804.7 5783.9 5785.1 5786.4 5786.7 5795.5 5585.9 5699.1 5718.9 5807.3 5846.4 4455.7 4509.6 4518.8 4519.6 4560.5 3900.3 4013.6 4015.7 4029.5 4050.7 5450.7 5505.1 5510.9 5529.4 5570.0 5841.7 5848.5 5849.5 5856.1 5883.6 5336.1 5450.0 5545.5 5560.4 5562.3 5027.1 5105.6 5111.0 5116.0 5145.4 6081.7 6104.2 6110.0 6111.5 6111.7 5689.9 5718.5 5828.5 5837.7 5864.4 6108.2 6120.3 6123.1 6125.4 6130.8 5773.6 5776.4 5786.7 5789.4 5825.5 5670.1 5702.4 5799.6 5835.8 5836.1 5608.2 5687.4 5689.2 5689.9 5700.9 5670.7 5678.0 5679.5 5683.8 5685.7 5419.1 5487.8 5537.4 5567.3 5607.3 5712.0 5712.1 5716.2 5718.5 5720.1 5410.6 5585.7 5599.3 5600.3 5600.7 10:20:58 INFO - 2015-11-12 10:20:58,933 DEBUG : BROWSER_OUTPUT: 10:20:58 INFO - 2015-11-12 10:20:58,933 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:51938.66 Median:19120.02 stddev:91778.20 (480.0%) stddev-sans-first:91954.60 10:20:58 INFO - 2015-11-12 10:20:58,934 DEBUG : BROWSER_OUTPUT: Values: 563.0 589.1 602.5 608.4 615.2 31594.5 41955.0 42321.4 42362.2 42470.6 43526.6 43815.8 44198.3 44224.0 44269.3 7624.5 7759.7 8793.2 8955.1 10299.6 10400.2 10557.6 10564.6 10571.1 10576.2 10596.5 10699.3 10704.1 10704.2 10709.1 7839.6 8037.4 10332.5 10498.0 10512.4 10066.6 10214.3 10214.3 10216.7 10222.0 40373.4 40754.6 40804.8 40828.2 40839.6 3377.2 3578.6 3587.3 3593.5 3935.9 30437.2 30648.4 31086.5 31441.5 31717.8 3052.5 3069.8 3073.8 3116.4 3136.3 281973.0 282477.0 282880.0 283170.0 283662.0 56506.7 57702.4 60997.0 65286.0 66844.7 60921.7 61544.7 61718.7 61763.7 61970.0 15284.9 15344.5 15370.8 15450.6 15458.0 12022.6 12099.3 12122.9 12138.5 12244.9 19501.8 19819.7 19949.5 19997.7 20025.3 7666.9 7689.8 7751.8 7808.3 7859.4 946.0 956.0 975.8 1007.6 1045.7 29293.0 29347.3 29424.8 29435.9 29744.9 1027.8 1085.8 1116.8 1148.6 1154.3 14845.0 15071.0 15301.9 15332.5 15987.2 293572.0 294784.0 295667.0 298141.0 298250.0 56108.4 56760.0 56885.0 56885.0 56959.4 1340.5 1360.7 1361.6 1396.8 1401.5 30176.0 31179.8 31187.2 31350.8 31805.7 44212.6 45348.8 49987.3 51578.5 51657.5 438015.0 445609.0 445702.0 445858.0 446525.0 43127.8 43606.0 43865.8 43997.1 44004.3 46923.0 47115.5 47264.0 48083.3 48542.8 39008.2 39635.0 41945.4 42085.0 42690.8 37951.6 38104.2 38159.4 38485.0 39002.4 37042.8 37816.2 37893.2 37999.6 38040.6 33621.0 33960.0 34661.5 37598.0 38918.2 26014.9 26717.5 26756.6 26913.2 27231.9 10:20:58 INFO - 2015-11-12 10:20:58,935 DEBUG : BROWSER_OUTPUT: 10:20:58 INFO - 2015-11-12 10:20:58,935 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26857.85 Median:2220.62 stddev:81513.13 (3670.7%) stddev-sans-first:81717.49 10:20:58 INFO - 2015-11-12 10:20:58,936 DEBUG : BROWSER_OUTPUT: Values: 347.7 350.0 351.4 352.2 352.5 14494.6 14653.6 16806.2 17120.7 17822.1 15873.5 16966.2 17238.7 17316.2 17984.8 5415.3 5540.8 5554.3 5554.4 5559.1 3909.6 3993.4 5510.3 5543.3 5995.3 6014.1 6022.6 6075.0 6083.8 6083.9 5871.8 6030.3 6056.3 6056.9 6063.3 5172.4 5272.0 5282.7 5293.1 5295.4 21051.7 21088.0 21116.4 21204.9 21285.1 2244.1 2279.4 2296.9 2340.6 2802.7 12946.2 13002.3 13211.9 13320.9 13755.7 1835.5 1836.1 1839.5 1861.2 1933.3 61853.4 62702.1 63213.0 63477.0 63772.0 9531.7 9672.1 9881.5 9897.5 9969.1 12691.0 12704.6 12705.2 12706.4 12727.9 7666.9 7776.2 7776.9 7779.5 7842.9 7664.2 7681.3 7723.2 7731.4 7759.1 5905.6 6003.9 6008.6 6019.2 6083.1 1622.7 1661.4 1716.8 1747.1 1752.2 377.8 382.9 1011.8 1025.1 1045.9 9530.5 10071.4 10120.7 10444.5 10827.8 447.8 457.6 484.0 498.6 506.8 6265.6 6670.7 6725.0 6726.3 6755.6 485359.0 487052.0 495952.0 509709.0 509737.0 73769.6 74640.6 76790.2 77069.0 77307.0 547.6 550.2 550.9 551.3 552.3 10975.8 11195.2 11404.6 11633.2 12099.8 33371.3 33463.7 34068.3 35418.8 37144.0 47505.6 48409.5 48680.0 50522.5 51554.5 6651.7 7067.8 7068.9 7075.8 7081.2 12330.8 12711.2 12786.7 12847.0 12853.6 11012.0 11210.0 11310.8 11336.9 11343.7 10570.7 10610.3 11079.9 11121.2 11248.0 10686.5 10769.8 10780.8 10788.3 10816.4 6760.6 6871.0 7021.7 7028.4 7033.2 10697.5 10755.7 10832.7 11105.9 11226.9 10:20:58 INFO - 2015-11-12 10:20:58,936 DEBUG : BROWSER_OUTPUT: 10:20:58 INFO - 2015-11-12 10:20:58,937 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5195.64 Median:6212.11 stddev:2653.66 (42.7%) stddev-sans-first:2645.23 10:20:58 INFO - 2015-11-12 10:20:58,938 DEBUG : BROWSER_OUTPUT: Values: 1334.5 1452.1 1503.9 1596.7 1708.3 6775.6 7346.4 7533.3 7548.9 7553.7 7332.1 7401.1 7469.6 7481.4 7483.9 1973.2 2015.5 2231.2 2312.1 2332.8 2284.7 2294.5 2295.8 2297.6 2297.7 2212.3 2258.8 2261.1 2263.1 2263.7 1957.4 1993.1 2207.2 2250.2 2254.4 2260.1 2270.2 2290.3 2293.8 2334.8 7481.7 7553.1 7554.7 7563.0 7564.8 4480.9 4562.8 4583.3 4584.5 4587.7 2918.1 2961.1 3012.5 3020.7 3046.3 959.9 963.3 973.0 977.5 1018.5 10230.2 10236.3 10256.2 10258.4 10278.7 4126.3 4226.6 4236.6 4242.6 4301.0 8751.6 8805.3 8809.1 8826.9 8837.3 4616.0 4616.8 4635.9 4641.2 4641.4 4222.4 4224.1 4227.3 4238.3 4241.4 3553.7 3629.8 3643.0 3646.8 3678.7 1184.3 1187.3 1189.1 1196.2 1203.1 1016.4 1226.4 1227.7 1254.2 1258.3 6299.1 6451.7 6955.2 7200.3 7214.6 697.1 701.8 706.2 710.6 713.2 5313.3 5333.1 5340.1 5362.9 5369.0 8686.7 8722.0 8755.5 8817.0 8817.5 8600.5 8647.6 8689.5 8727.1 8732.0 6738.8 6880.0 6886.8 6908.3 6910.0 6429.6 6491.9 6496.6 6499.8 6502.5 7455.6 7698.6 7810.8 7824.1 7851.1 7879.3 8023.5 8128.7 8133.8 8144.7 6532.1 6574.5 6616.8 6620.6 6629.8 7132.8 7144.1 7159.7 7182.6 7188.8 6604.7 6709.9 6762.6 6793.7 6924.0 6570.7 6597.3 6637.8 6680.2 6747.8 5856.0 6630.7 6664.7 6680.7 6682.9 5722.6 6133.4 6141.5 6160.2 6164.8 6098.0 6161.0 6207.4 6207.7 6216.6 10:20:58 INFO - 2015-11-12 10:20:58,938 DEBUG : BROWSER_OUTPUT: 10:20:58 INFO - 2015-11-12 10:20:58,938 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5055.76 Median:5828.13 stddev:1526.19 (26.2%) stddev-sans-first:1488.50 10:20:58 INFO - 2015-11-12 10:20:58,940 DEBUG : BROWSER_OUTPUT: Values: 319.6 320.3 320.8 321.3 325.2 5674.1 5680.1 5704.1 5726.0 5743.9 5570.9 5647.5 5666.0 5668.2 5672.7 4258.8 4307.4 4371.6 4377.0 4378.7 4340.2 4391.3 4400.1 4402.0 4413.4 4333.9 4340.7 4351.0 4357.2 4366.1 4327.3 4357.1 4358.0 4358.8 4364.8 3818.4 3826.8 3828.3 3855.3 3887.0 5120.2 5242.1 5243.1 5305.6 5407.6 4982.7 5022.7 5024.6 5027.3 5027.3 5905.9 5939.8 5946.6 5949.5 5950.4 4057.2 4085.0 4220.1 4222.9 4224.2 6186.1 6254.4 6255.1 6258.5 6272.5 4222.2 4229.7 4233.7 4235.5 4241.5 4074.3 4120.2 4235.3 4281.6 4299.0 4949.5 4969.5 4969.5 4969.9 4977.0 6025.1 6032.1 6032.3 6035.1 6036.6 1524.4 1558.1 1558.4 1559.2 1559.3 1010.5 1025.2 1027.4 1031.3 1037.9 5834.2 5837.8 5843.5 5859.0 5863.1 6039.2 6130.7 6138.4 6147.3 6150.1 5828.1 5828.2 5828.7 5828.9 5835.2 3433.4 3463.2 3472.1 3480.0 3487.3 6499.2 6525.9 6533.1 6533.3 6612.7 6427.6 6457.6 6459.8 6460.5 6463.8 6512.8 6561.3 6568.1 6572.3 6581.4 6203.3 6219.0 6262.1 6268.2 6281.4 6171.8 6187.5 6219.3 6238.8 6240.0 6484.4 6484.5 6490.0 6495.5 6502.4 4234.9 4251.4 4305.1 4308.0 4311.5 6093.2 6110.2 6184.6 6186.8 6196.8 6076.0 6093.6 6093.7 6110.1 6110.9 6015.4 6019.6 6024.3 6029.9 6044.1 5889.6 5971.2 5972.7 5987.3 6007.2 6127.8 6138.7 6139.4 6141.2 6145.9 5980.0 5985.3 5989.8 5991.5 5998.5 10:20:58 INFO - 2015-11-12 10:20:58,940 DEBUG : BROWSER_OUTPUT: 10:20:58 INFO - 2015-11-12 10:20:58,940 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13355.62 Median:48693.11 stddev:16000.98 (32.9%) stddev-sans-first:16017.63 10:20:58 INFO - 2015-11-12 10:20:58,940 DEBUG : BROWSER_OUTPUT: Values: 699.1 700.9 797.7 800.7 807.4 13495.7 13715.9 13727.7 13746.2 13746.7 11463.6 12009.8 12750.6 12924.2 12973.7 803.8 815.3 817.7 818.5 820.3 808.1 816.5 818.4 818.6 819.1 850.9 855.4 858.0 858.6 859.2 847.0 853.0 853.5 853.9 854.3 626.0 627.5 628.2 628.4 628.6 12199.7 12333.1 12333.3 12338.8 12341.9 10271.3 10317.5 10397.6 10543.7 10629.7 9433.1 9462.9 9550.1 9608.3 9735.2 3537.3 3550.8 3593.4 3596.1 3632.4 46587.5 46778.5 47058.3 47103.5 47125.5 8075.6 8237.8 8327.7 8360.2 8366.7 16648.4 16649.8 16657.5 16700.9 16720.2 7365.6 7520.4 7606.8 7665.6 7764.4 4262.9 4282.6 4309.7 4420.7 4428.6 2803.4 2842.9 2844.6 2845.5 2846.5 423.0 437.7 439.4 442.1 452.1 550.3 557.0 560.3 578.5 617.5 7842.8 8719.4 8937.7 8948.9 8952.0 557.5 583.3 628.6 651.2 674.6 3697.7 3812.1 3886.4 3892.9 3953.6 54530.5 55194.4 55248.7 63171.4 63722.0 43054.4 43106.4 47999.5 48392.3 49454.0 45280.5 45900.3 46027.8 46154.5 50499.5 7722.0 7954.4 8107.4 8148.8 8478.9 36883.4 37197.3 37234.0 37339.6 38164.2 41952.0 47696.8 48147.0 48437.9 48948.3 7227.5 7880.9 7896.1 7986.3 8080.8 9944.4 10396.8 11166.2 11423.3 11447.8 10109.0 10476.5 10956.2 11232.2 11252.4 10346.9 10655.7 10692.1 10754.8 11025.9 10439.0 10829.7 10834.5 10938.9 11247.6 8897.5 9032.6 9272.7 9296.7 9444.9 8543.7 8954.4 9105.2 9136.0 9328.6 10:20:58 INFO - 2015-11-12 10:20:58,940 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:20:58 INFO - 2015-11-12 10:20:58,941 DEBUG : BROWSER_OUTPUT: 10:20:59 INFO - 2015-11-12 10:20:59,577 INFO : Browser exited with error code: 0 10:20:59 INFO - 2015-11-12 10:20:59,594 INFO : Completed test dromaeo_css (00:18:31) 10:20:59 INFO - 2015-11-12 10:20:59,594 INFO : Starting test kraken 10:20:59 INFO - 2015-11-12 10:20:59,594 DEBUG : operating with platform_type : linux_ 10:20:59 INFO - 2015-11-12 10:20:59,594 INFO : Initialising browser for kraken test... 10:20:59 INFO - 2015-11-12 10:20:59,600 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwENvA4/profile http://localhost:40789/getInfo.html 10:21:03 INFO - 2015-11-12 10:21:03,322 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:21:03 INFO - 2015-11-12 10:21:03,322 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:21:03 INFO - 2015-11-12 10:21:03,322 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:21:03 INFO - 2015-11-12 10:21:03,322 DEBUG : BROWSER_OUTPUT: __metrics 10:21:03 INFO - 2015-11-12 10:21:03,463 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:21:04 INFO - 2015-11-12 10:21:04,620 INFO : Browser initialized. 10:21:04 INFO - 2015-11-12 10:21:04,620 INFO : Running cycle 1/1 for kraken test... 10:21:04 INFO - 2015-11-12 10:21:04,621 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwENvA4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:21:16 INFO - 2015-11-12 10:21:16,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 141336576 10:21:16 INFO - 2015-11-12 10:21:16,336 DEBUG : BROWSER_OUTPUT: 10:21:18 INFO - 2015-11-12 10:21:18,793 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40789/tests/kraken/driver.html?testName=audio-beat-detection) 10:21:19 INFO - 2015-11-12 10:21:19,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 179789824 10:21:19 INFO - 2015-11-12 10:21:19,374 DEBUG : BROWSER_OUTPUT: 10:21:21 INFO - 2015-11-12 10:21:21,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40789/tests/kraken/driver.html?testName=audio-dft) 10:21:22 INFO - 2015-11-12 10:21:22,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 170786816 10:21:22 INFO - 2015-11-12 10:21:22,535 DEBUG : BROWSER_OUTPUT: 10:21:25 INFO - 2015-11-12 10:21:25,460 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40789/tests/kraken/driver.html?testName=audio-fft) 10:21:26 INFO - 2015-11-12 10:21:26,021 DEBUG : BROWSER_OUTPUT: RSS: Main: 152002560 10:21:26 INFO - 2015-11-12 10:21:26,022 DEBUG : BROWSER_OUTPUT: 10:21:27 INFO - 2015-11-12 10:21:27,974 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40789/tests/kraken/driver.html?testName=audio-oscillator) 10:21:28 INFO - 2015-11-12 10:21:28,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 154234880 10:21:28 INFO - 2015-11-12 10:21:28,540 DEBUG : BROWSER_OUTPUT: 10:21:30 INFO - 2015-11-12 10:21:30,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40789/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:21:31 INFO - 2015-11-12 10:21:31,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 154890240 10:21:31 INFO - 2015-11-12 10:21:31,259 DEBUG : BROWSER_OUTPUT: 10:21:34 INFO - 2015-11-12 10:21:34,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40789/tests/kraken/driver.html?testName=imaging-darkroom) 10:21:34 INFO - 2015-11-12 10:21:34,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 154947584 10:21:34 INFO - 2015-11-12 10:21:34,739 DEBUG : BROWSER_OUTPUT: 10:21:38 INFO - 2015-11-12 10:21:38,125 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40789/tests/kraken/driver.html?testName=imaging-desaturate) 10:21:38 INFO - 2015-11-12 10:21:38,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 156352512 10:21:38 INFO - 2015-11-12 10:21:38,694 DEBUG : BROWSER_OUTPUT: 10:21:41 INFO - 2015-11-12 10:21:41,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40789/tests/kraken/driver.html?testName=json-parse-financial) 10:21:42 INFO - 2015-11-12 10:21:42,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 156364800 10:21:42 INFO - 2015-11-12 10:21:42,038 DEBUG : BROWSER_OUTPUT: 10:21:43 INFO - 2015-11-12 10:21:43,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40789/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:21:44 INFO - 2015-11-12 10:21:44,154 DEBUG : BROWSER_OUTPUT: RSS: Main: 165924864 10:21:44 INFO - 2015-11-12 10:21:44,154 DEBUG : BROWSER_OUTPUT: 10:21:45 INFO - 2015-11-12 10:21:45,956 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40789/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:21:46 INFO - 2015-11-12 10:21:46,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 166813696 10:21:46 INFO - 2015-11-12 10:21:46,550 DEBUG : BROWSER_OUTPUT: 10:21:48 INFO - 2015-11-12 10:21:48,602 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40789/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:21:49 INFO - 2015-11-12 10:21:49,169 DEBUG : BROWSER_OUTPUT: RSS: Main: 178089984 10:21:49 INFO - 2015-11-12 10:21:49,169 DEBUG : BROWSER_OUTPUT: 10:21:51 INFO - 2015-11-12 10:21:51,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40789/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:21:52 INFO - 2015-11-12 10:21:52,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 184012800 10:21:52 INFO - 2015-11-12 10:21:52,151 DEBUG : BROWSER_OUTPUT: 10:21:54 INFO - 2015-11-12 10:21:54,646 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40789/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:21:55 INFO - 2015-11-12 10:21:55,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 182079488 10:21:55 INFO - 2015-11-12 10:21:55,215 DEBUG : BROWSER_OUTPUT: 10:21:56 INFO - 2015-11-12 10:21:56,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40789/tests/kraken/driver.html?testName=ai-astar) 10:21:57 INFO - 2015-11-12 10:21:57,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 241713152 10:21:57 INFO - 2015-11-12 10:21:57,139 DEBUG : BROWSER_OUTPUT: 10:21:57 INFO - 2015-11-12 10:21:57,141 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:21:57 INFO - 2015-11-12 10:21:57,141 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:21:57 INFO - 2015-11-12 10:21:57,141 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:21:57 INFO - 2015-11-12 10:21:57,141 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:21:57 INFO - 2015-11-12 10:21:57,141 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;109;105;108;109;109;100;109;113;110 10:21:57 INFO - 2015-11-12 10:21:57,142 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;122;150;171;124;147;145;124;165;133 10:21:57 INFO - 2015-11-12 10:21:57,142 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;169;160;160;159;163;159;162;160;165 10:21:57 INFO - 2015-11-12 10:21:57,142 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;80;88;71;71;72;112;87;71 10:21:57 INFO - 2015-11-12 10:21:57,142 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;134;90;91;90;132;90;91;130 10:21:57 INFO - 2015-11-12 10:21:57,143 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;110;110;109;109;110;109;110 10:21:57 INFO - 2015-11-12 10:21:57,143 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;146;145;146;144;145;144;145 10:21:57 INFO - 2015-11-12 10:21:57,143 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;96;96;95;96;96;96 10:21:57 INFO - 2015-11-12 10:21:57,143 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;59;58;57;57;58;58;65;56;56 10:21:57 INFO - 2015-11-12 10:21:57,144 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;68;67;66;67;67;67;67;68 10:21:57 INFO - 2015-11-12 10:21:57,144 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;85;87;84;84;84;85;87;85 10:21:57 INFO - 2015-11-12 10:21:57,144 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;115;115;124;120;120;115;126;115;115 10:21:57 INFO - 2015-11-12 10:21:57,144 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;146;146;145;148;136;147;156;145;137 10:21:57 INFO - 2015-11-12 10:21:57,144 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;65;66;68;66;66;67;66;66;66 10:21:57 INFO - 2015-11-12 10:21:57,145 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:21:57 INFO - 2015-11-12 10:21:57,145 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:21:57 INFO - 2015-11-12 10:21:57,145 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,913 10:21:57 INFO - 2015-11-12 10:21:57,145 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:21:57 INFO - 2015-11-12 10:21:57,146 DEBUG : BROWSER_OUTPUT: __startTimestamp1447352517139__endTimestamp 10:21:57 INFO - 2015-11-12 10:21:57,146 DEBUG : BROWSER_OUTPUT: 10:21:57 INFO - 2015-11-12 10:21:57,147 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:21:57 INFO - 2015-11-12 10:21:57,148 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:21:57 INFO - 2015-11-12 10:21:57,148 DEBUG : BROWSER_OUTPUT: 10:21:57 INFO - 2015-11-12 10:21:57,148 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:109.00 stddev:3.45 (3.2%) stddev-sans-first:3.64 10:21:57 INFO - 2015-11-12 10:21:57,148 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 105.0 108.0 109.0 109.0 100.0 109.0 113.0 110.0 10:21:57 INFO - 2015-11-12 10:21:57,149 DEBUG : BROWSER_OUTPUT: 10:21:57 INFO - 2015-11-12 10:21:57,149 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.00 Median:148.50 stddev:17.78 (12.0%) stddev-sans-first:18.01 10:21:57 INFO - 2015-11-12 10:21:57,149 DEBUG : BROWSER_OUTPUT: Values: 159.0 122.0 150.0 171.0 124.0 147.0 145.0 124.0 165.0 133.0 10:21:57 INFO - 2015-11-12 10:21:57,149 DEBUG : BROWSER_OUTPUT: 10:21:57 INFO - 2015-11-12 10:21:57,149 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:161.00 stddev:3.20 (2.0%) stddev-sans-first:3.33 10:21:57 INFO - 2015-11-12 10:21:57,150 DEBUG : BROWSER_OUTPUT: Values: 160.0 169.0 160.0 160.0 159.0 163.0 159.0 162.0 160.0 165.0 10:21:57 INFO - 2015-11-12 10:21:57,150 DEBUG : BROWSER_OUTPUT: 10:21:57 INFO - 2015-11-12 10:21:57,150 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.50 Median:72.00 stddev:13.28 (18.4%) stddev-sans-first:13.80 10:21:57 INFO - 2015-11-12 10:21:57,150 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 80.0 88.0 71.0 71.0 72.0 112.0 87.0 71.0 10:21:57 INFO - 2015-11-12 10:21:57,150 DEBUG : BROWSER_OUTPUT: 10:21:57 INFO - 2015-11-12 10:21:57,150 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.20 Median:90.50 stddev:19.91 (22.0%) stddev-sans-first:20.70 10:21:57 INFO - 2015-11-12 10:21:57,150 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 134.0 90.0 91.0 90.0 132.0 90.0 91.0 130.0 10:21:57 INFO - 2015-11-12 10:21:57,151 DEBUG : BROWSER_OUTPUT: 10:21:57 INFO - 2015-11-12 10:21:57,151 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:21:57 INFO - 2015-11-12 10:21:57,151 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 110.0 109.0 109.0 110.0 109.0 110.0 10:21:57 INFO - 2015-11-12 10:21:57,151 DEBUG : BROWSER_OUTPUT: 10:21:57 INFO - 2015-11-12 10:21:57,151 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 10:21:57 INFO - 2015-11-12 10:21:57,151 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 146.0 145.0 146.0 144.0 145.0 144.0 145.0 10:21:57 INFO - 2015-11-12 10:21:57,151 DEBUG : BROWSER_OUTPUT: 10:21:57 INFO - 2015-11-12 10:21:57,152 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 10:21:57 INFO - 2015-11-12 10:21:57,152 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 10:21:57 INFO - 2015-11-12 10:21:57,152 DEBUG : BROWSER_OUTPUT: 10:21:57 INFO - 2015-11-12 10:21:57,152 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:2.57 (4.4%) stddev-sans-first:2.73 10:21:57 INFO - 2015-11-12 10:21:57,152 DEBUG : BROWSER_OUTPUT: Values: 58.0 59.0 58.0 57.0 57.0 58.0 58.0 65.0 56.0 56.0 10:21:57 INFO - 2015-11-12 10:21:57,152 DEBUG : BROWSER_OUTPUT: 10:21:57 INFO - 2015-11-12 10:21:57,152 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 10:21:57 INFO - 2015-11-12 10:21:57,152 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 68.0 67.0 66.0 67.0 67.0 67.0 67.0 68.0 10:21:57 INFO - 2015-11-12 10:21:57,153 DEBUG : BROWSER_OUTPUT: 10:21:57 INFO - 2015-11-12 10:21:57,153 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:1.14 (1.3%) stddev-sans-first:1.20 10:21:57 INFO - 2015-11-12 10:21:57,153 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 85.0 87.0 84.0 84.0 84.0 85.0 87.0 85.0 10:21:57 INFO - 2015-11-12 10:21:57,153 DEBUG : BROWSER_OUTPUT: 10:21:57 INFO - 2015-11-12 10:21:57,153 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:120.00 stddev:4.27 (3.6%) stddev-sans-first:4.36 10:21:57 INFO - 2015-11-12 10:21:57,153 DEBUG : BROWSER_OUTPUT: Values: 122.0 115.0 115.0 124.0 120.0 120.0 115.0 126.0 115.0 115.0 10:21:57 INFO - 2015-11-12 10:21:57,153 DEBUG : BROWSER_OUTPUT: 10:21:57 INFO - 2015-11-12 10:21:57,153 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.30 Median:146.00 stddev:6.15 (4.2%) stddev-sans-first:5.93 10:21:57 INFO - 2015-11-12 10:21:57,154 DEBUG : BROWSER_OUTPUT: Values: 137.0 146.0 146.0 145.0 148.0 136.0 147.0 156.0 145.0 137.0 10:21:57 INFO - 2015-11-12 10:21:57,154 DEBUG : BROWSER_OUTPUT: 10:21:57 INFO - 2015-11-12 10:21:57,154 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 10:21:57 INFO - 2015-11-12 10:21:57,154 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 66.0 68.0 66.0 66.0 67.0 66.0 66.0 66.0 10:21:57 INFO - 2015-11-12 10:21:57,154 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:21:57 INFO - 2015-11-12 10:21:57,154 DEBUG : BROWSER_OUTPUT: 10:21:58 INFO - 2015-11-12 10:21:58,030 INFO : Browser exited with error code: 0 10:21:58 INFO - 2015-11-12 10:21:58,086 INFO : Completed test kraken (00:00:58) 10:21:58 INFO - 2015-11-12 10:21:58,086 INFO : Starting test v8_7 10:21:58 INFO - 2015-11-12 10:21:58,086 DEBUG : operating with platform_type : linux_ 10:21:58 INFO - 2015-11-12 10:21:58,086 INFO : Initialising browser for v8_7 test... 10:21:58 INFO - 2015-11-12 10:21:58,093 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKPbulm/profile http://localhost:40789/getInfo.html 10:22:01 INFO - 2015-11-12 10:22:01,643 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:22:01 INFO - 2015-11-12 10:22:01,643 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:22:01 INFO - 2015-11-12 10:22:01,643 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:22:01 INFO - 2015-11-12 10:22:01,643 DEBUG : BROWSER_OUTPUT: __metrics 10:22:01 INFO - 2015-11-12 10:22:01,745 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:22:02 INFO - 2015-11-12 10:22:02,863 INFO : Browser initialized. 10:22:02 INFO - 2015-11-12 10:22:02,863 INFO : Running cycle 1/1 for v8_7 test... 10:22:02 INFO - 2015-11-12 10:22:02,864 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKPbulm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:22:14 INFO - 2015-11-12 10:22:14,612 DEBUG : BROWSER_OUTPUT: RSS: Main: 139685888 10:22:14 INFO - 2015-11-12 10:22:14,612 DEBUG : BROWSER_OUTPUT: 10:22:36 INFO - 2015-11-12 10:22:36,007 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40789/tests/v8_7/run.html (next: http://localhost:40789/tests/v8_7/run.html) 10:22:36 INFO - 2015-11-12 10:22:36,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 624345088 10:22:36 INFO - 2015-11-12 10:22:36,258 DEBUG : BROWSER_OUTPUT: 10:22:36 INFO - 2015-11-12 10:22:36,258 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:22:36 INFO - 2015-11-12 10:22:36,258 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:22:36 INFO - 2015-11-12 10:22:36,258 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:22:36 INFO - 2015-11-12 10:22:36,258 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:22:36 INFO - 2015-11-12 10:22:36,258 DEBUG : BROWSER_OUTPUT: |0;Richards;165.48072149594572 10:22:36 INFO - 2015-11-12 10:22:36,259 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;196.27085377821393 10:22:36 INFO - 2015-11-12 10:22:36,259 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.8776443682104 10:22:36 INFO - 2015-11-12 10:22:36,259 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5055.555555555556 10:22:36 INFO - 2015-11-12 10:22:36,259 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1103.7527593818984 10:22:36 INFO - 2015-11-12 10:22:36,259 DEBUG : BROWSER_OUTPUT: |5;Earley;800.640512409928 10:22:36 INFO - 2015-11-12 10:22:36,259 DEBUG : BROWSER_OUTPUT: |6;Boyer;11952.380952380952 10:22:36 INFO - 2015-11-12 10:22:36,260 DEBUG : BROWSER_OUTPUT: |7;RegExp;25794.871794871793 10:22:36 INFO - 2015-11-12 10:22:36,260 DEBUG : BROWSER_OUTPUT: |8;Splay;636.9426751592357 10:22:36 INFO - 2015-11-12 10:22:36,260 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 10:22:36 INFO - 2015-11-12 10:22:36,260 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:22:36 INFO - 2015-11-12 10:22:36,261 DEBUG : BROWSER_OUTPUT: __startTimestamp1447352556256__endTimestamp 10:22:36 INFO - 2015-11-12 10:22:36,261 DEBUG : BROWSER_OUTPUT: 10:22:36 INFO - 2015-11-12 10:22:36,261 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:22:36 INFO - 2015-11-12 10:22:36,261 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:22:36 INFO - 2015-11-12 10:22:36,261 DEBUG : BROWSER_OUTPUT: 10:22:36 INFO - 2015-11-12 10:22:36,261 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.48 Median:165.48 stddev:0.00 (0.0%) 10:22:36 INFO - 2015-11-12 10:22:36,262 DEBUG : BROWSER_OUTPUT: Values: 165.5 10:22:36 INFO - 2015-11-12 10:22:36,262 DEBUG : BROWSER_OUTPUT: 10:22:36 INFO - 2015-11-12 10:22:36,262 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:196.27 Median:196.27 stddev:0.00 (0.0%) 10:22:36 INFO - 2015-11-12 10:22:36,262 DEBUG : BROWSER_OUTPUT: Values: 196.3 10:22:36 INFO - 2015-11-12 10:22:36,262 DEBUG : BROWSER_OUTPUT: 10:22:36 INFO - 2015-11-12 10:22:36,262 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.88 Median:285.88 stddev:0.00 (0.0%) 10:22:36 INFO - 2015-11-12 10:22:36,263 DEBUG : BROWSER_OUTPUT: Values: 285.9 10:22:36 INFO - 2015-11-12 10:22:36,263 DEBUG : BROWSER_OUTPUT: 10:22:36 INFO - 2015-11-12 10:22:36,263 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5055.56 Median:5055.56 stddev:0.00 (0.0%) 10:22:36 INFO - 2015-11-12 10:22:36,263 DEBUG : BROWSER_OUTPUT: Values: 5055.6 10:22:36 INFO - 2015-11-12 10:22:36,263 DEBUG : BROWSER_OUTPUT: 10:22:36 INFO - 2015-11-12 10:22:36,263 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1103.75 Median:1103.75 stddev:0.00 (0.0%) 10:22:36 INFO - 2015-11-12 10:22:36,264 DEBUG : BROWSER_OUTPUT: Values: 1103.8 10:22:36 INFO - 2015-11-12 10:22:36,264 DEBUG : BROWSER_OUTPUT: 10:22:36 INFO - 2015-11-12 10:22:36,264 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:800.64 Median:800.64 stddev:0.00 (0.0%) 10:22:36 INFO - 2015-11-12 10:22:36,264 DEBUG : BROWSER_OUTPUT: Values: 800.6 10:22:36 INFO - 2015-11-12 10:22:36,264 DEBUG : BROWSER_OUTPUT: 10:22:36 INFO - 2015-11-12 10:22:36,264 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11952.38 Median:11952.38 stddev:0.00 (0.0%) 10:22:36 INFO - 2015-11-12 10:22:36,265 DEBUG : BROWSER_OUTPUT: Values: 11952.4 10:22:36 INFO - 2015-11-12 10:22:36,265 DEBUG : BROWSER_OUTPUT: 10:22:36 INFO - 2015-11-12 10:22:36,265 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25794.87 Median:25794.87 stddev:0.00 (0.0%) 10:22:36 INFO - 2015-11-12 10:22:36,265 DEBUG : BROWSER_OUTPUT: Values: 25794.9 10:22:36 INFO - 2015-11-12 10:22:36,265 DEBUG : BROWSER_OUTPUT: 10:22:36 INFO - 2015-11-12 10:22:36,266 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:636.94 Median:636.94 stddev:0.00 (0.0%) 10:22:36 INFO - 2015-11-12 10:22:36,266 DEBUG : BROWSER_OUTPUT: Values: 636.9 10:22:36 INFO - 2015-11-12 10:22:36,266 DEBUG : BROWSER_OUTPUT: 10:22:36 INFO - 2015-11-12 10:22:36,266 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 10:22:36 INFO - 2015-11-12 10:22:36,267 DEBUG : BROWSER_OUTPUT: Values: 4822.1 10:22:36 INFO - 2015-11-12 10:22:36,267 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:22:36 INFO - 2015-11-12 10:22:36,267 DEBUG : BROWSER_OUTPUT: 10:22:37 INFO - 2015-11-12 10:22:37,157 INFO : Browser exited with error code: 0 10:22:37 INFO - 2015-11-12 10:22:37,172 INFO : Completed test v8_7 (00:00:39) 10:22:37 INFO - 2015-11-12 10:22:37,288 INFO : Completed test suite (00:20:09) 10:22:37 INFO - 2015-11-12 10:22:37,288 DEBUG : Working with test: dromaeo_css 10:22:37 INFO - 2015-11-12 10:22:37,288 DEBUG : Generating results file: dromaeo_css 10:22:37 INFO - 2015-11-12 10:22:37,289 DEBUG : Working with test: kraken 10:22:37 INFO - 2015-11-12 10:22:37,289 DEBUG : Generating results file: kraken 10:22:37 INFO - 2015-11-12 10:22:37,289 INFO : javascript benchmark 10:22:37 INFO - 2015-11-12 10:22:37,289 DEBUG : Working with test: v8_7 10:22:37 INFO - 2015-11-12 10:22:37,290 DEBUG : Generating results file: v8_7 10:22:37 INFO - 2015-11-12 10:22:37,290 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:22:37 INFO - 2015-11-12 10:22:37,336 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 10:22:37 INFO - 2015-11-12 10:22:37,336 DEBUG : process_Request line: dromaeo_css 6788.55 graph.html#tests=[[72,201,35]] 10:22:37 INFO - 2015-11-12 10:22:37,336 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:22:37 INFO - 2015-11-12 10:22:37,365 DEBUG : process_Request line: kraken 1486.70 graph.html#tests=[[232,201,35]] 10:22:37 INFO - 2015-11-12 10:22:37,365 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:22:37 INFO - 2015-11-12 10:22:37,393 DEBUG : process_Request line: v8_7 20893.64 graph.html#tests=[[230,201,35]] 10:22:37 INFO - 2015-11-12 10:22:37,394 INFO : javascript benchmark 10:22:37 INFO - 2015-11-12 10:22:37,397 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [347.7444078602228, 350.0339064182855, 351.4394540707571, 352.2374060159754, 352.50297081115633, 14494.5651630451, 14653.633659158526, 16806.243719032642, 17120.74318885216, 17822.10889455527, 15873.52379428619, 16966.151692415362, 17238.741418878726, 17316.220770065345, 17984.820151798478, 5415.323084614433, 5540.806071787489, 5554.250176226218, 5554.361248456418, 5559.138333558305, 3909.6090390960962, 3993.4209539616736, 5510.311211098613, 5543.334799824007, 5995.280566332024, 6014.0678194879865, 6022.578419510636, 6074.969625151868, 6083.817485475421, 6083.878322433548, 5871.823845284648, 6030.306514750816, 6056.303525094627, 6056.909146362808, 6063.272407311107, 5172.379314482248, 5271.973640131813, 5282.709450980195, 5293.073712100406, 5295.364556253275, 21051.68422473664, 21088.0, 21116.3665090046, 21204.893975530023, 21285.14859405622, 2244.113575137828, 2279.3731723775927, 2296.8621882687094, 2340.5552944940405, 2802.7057158998214, 12946.158499697489, 13002.349882505838, 13211.933940330333, 13320.866791332059, 13755.724885502334, 1835.5411147213197, 1836.1278392763463, 1839.4941391117416, 1861.2368928739288, 1933.3426634944187, 61853.381466185216, 62702.059469108455, 63213.0, 63476.99999999954, 63772.0, 9531.666391676257, 9672.08115229052, 9881.505924703735, 9897.505124743733, 9969.052939970692, 12691.0, 12704.618861434172, 12705.174163679516, 12706.428210730539, 12727.936360318325, 7666.923330766733, 7776.183500732454, 7776.883346749803, 7779.533228006338, 7842.9215707842195, 7664.195259497673, 7681.308682218627, 7723.189065148191, 7731.420143489148, 7759.068911730628, 5905.616134951214, 6003.879922401527, 6008.609440386361, 6019.187409699722, 6083.057126145454, 1622.691688579166, 1661.3603762551263, 1716.8111507734138, 1747.1346990934876, 1752.1764770557818, 377.8110944527736, 382.88704832074603, 1011.7571782772081, 1025.1337619711333, 1045.9372437653765, 9530.475823829618, 10071.446070466194, 10120.696379108638, 10444.537764712946, 10827.783444331228, 447.8141571247896, 457.6476113392669, 484.0101991427539, 498.60111910471477, 506.8150125204274, 6265.594123635227, 6670.733170673216, 6724.966375168093, 6726.260111387744, 6755.560888542229, 485359.0, 487052.0, 495952.0, 509709.0, 509737.0, 73769.6311518439, 74640.62679686566, 76790.23209767943, 77069.0, 77307.0, 547.5537436988841, 550.2489102375229, 550.9228707980886, 551.283331668829, 552.326162082259, 10975.835362469728, 11195.160362972973, 11404.600838970597, 11633.234676103115, 12099.75800484003, 33371.33257334888, 33463.66536334703, 34068.318633627685, 35418.8229058853, 37144.0, 47505.586745788874, 48409.515904840504, 48680.0, 50522.49477505178, 51554.48445515647, 6651.7006734698025, 7067.82330441743, 7068.893966590403, 7075.823104422225, 7081.221065682874, 12330.753384932072, 12711.237325760483, 12786.744265114832, 12847.0, 12853.550125745927, 11012.0, 11210.047145992681, 11310.773784524099, 11336.94331528337, 11343.716407089889, 10570.735731606772, 10610.310329828537, 11079.944600276947, 11121.165912556753, 11248.0, 10686.465676715978, 10769.838452423377, 10780.784384312426, 10788.298760580537, 10816.351018938889, 6760.560563563353, 6871.03805467245, 7021.719131234693, 7028.437724982092, 7033.191183014019, 10697.518611662339, 10755.677329680122, 10832.67501974942, 11105.94447027792, 11226.887731122584], "dojo.html": [3171.968280317197, 3219.903402897914, 3252.3657886712085, 3261.853216605254, 3273.8690452381898, 5184.53339199472, 5300.946990530094, 5361.7587208575615, 5365.275687782148, 5421.701806400646, 5345.919811202835, 5349.090654588719, 5406.702631355274, 5407.594430417715, 5463.836084917449, 4860.368152140226, 4905.460399356068, 4932.7780249888665, 4996.400431948171, 5025.422076461217, 4822.855314340575, 5029.874253143683, 5035.823746168885, 5090.083784918713, 5115.795368185287, 4809.350737650408, 4919.163742163841, 4942.986687729007, 4957.504249575014, 4964.925526117111, 4915.287283343895, 4923.212286034253, 4937.456879743226, 4944.752762361867, 4959.82640607577, 4765.952340476586, 4875.8781030474165, 4911.238757992517, 4915.16442204826, 4974.626902982291, 5215.713135777531, 5284.603654725873, 5285.339332583427, 5301.098813201726, 5312.946870531284, 5832.591718579701, 5838.211841401441, 5840.912386314209, 5843.941560584425, 5848.093545500455, 5656.773729050833, 5751.626144300649, 5772.6536407815665, 5877.235959325303, 5894.145348924425, 5485.232067510512, 5512.3936367, 5512.751926163332, 5513.724313784295, 5516.724163791875, 5963.850903727442, 5966.582339236212, 5983.611065280743, 5986.850328741729, 6030.185924900083, 5524.033294173503, 5629.774809007594, 5689.431056894277, 5771.249737534094, 5794.594378393556, 5793.246877905845, 5796.159556864315, 5800.53595712342, 5803.564732644984, 5804.709764511842, 5783.88432231353, 5785.1322301654245, 5786.392428795, 5786.71066446676, 5795.478406943395, 5585.8603534911135, 5699.088145896637, 5718.857028574235, 5807.274090738658, 5846.41535846412, 4455.710378825366, 4509.594136527729, 4518.751468669189, 4519.615832654261, 4560.452745670541, 3900.258950799339, 4013.618706222904, 4015.7188996769946, 4029.516458024997, 4050.696197785178, 5450.672959622435, 5505.146702261156, 5510.862228444241, 5529.391766905637, 5569.972150139223, 5841.678707671119, 5848.5321174305955, 5849.5027922626205, 5856.092305692625, 5883.588148829541, 5336.1462166054025, 5449.972750136303, 5545.473180047889, 5560.443955604407, 5562.332520097614, 5027.069992051483, 5105.591552675852, 5111.0, 5115.97442012795, 5145.3568303962, 6081.726322315506, 6104.236970378792, 6110.022396416552, 6111.54163437744, 6111.694415279308, 5689.914651280152, 5718.456746609066, 5828.504577110993, 5837.737301821513, 5864.384239654775, 6108.221534911944, 6120.3267640558615, 6123.089961861626, 6125.448709615977, 6130.754769809158, 5773.566982476247, 5776.393478684678, 5786.739596718242, 5789.3921138279875, 5825.475707186373, 5670.092785154356, 5702.429757024264, 5799.565032622654, 5835.79574714883, 5836.124581312667, 5608.242887210175, 5687.374388817144, 5689.1750696148, 5689.914651280317, 5700.942990570041, 5670.74481648335, 5678.0, 5679.460451257124, 5683.829485115453, 5685.715714214355, 5419.05166595852, 5487.807926722546, 5537.446255374592, 5567.276254086943, 5607.327120745374, 5711.971440142773, 5712.057510510719, 5716.171155182558, 5718.51392631631, 5720.141978703062, 5410.567154627542, 5585.748641311069, 5599.32808063035, 5600.27196464457, 5600.719964001865], "mootools.html": [1334.5262431836704, 1452.1287227663402, 1503.9022463539868, 1596.7125917334881, 1708.3166733306668, 6775.62734049627, 7346.449016323777, 7533.28433798789, 7548.92451075489, 7553.735619253327, 7332.120145582538, 7401.111866576019, 7469.626518674072, 7481.438892083088, 7483.925160748391, 1973.2008536542724, 2015.4860510569783, 2231.241377931503, 2312.1329501436962, 2332.7550607186254, 2284.6915666384994, 2294.4608017116047, 2295.781900719429, 2297.6208925527267, 2297.6783250344884, 2212.314182603398, 2258.785415385544, 2261.1407665087245, 2263.1173842201556, 2263.694401255826, 1957.383424221373, 1993.083181736403, 2207.172310383598, 2250.223672832886, 2254.413852398372, 2260.1411463643876, 2270.2281224383623, 2290.3472510334473, 2293.8279629027725, 2334.8365614407, 7481.700731970769, 7553.093628764528, 7554.660040298199, 7562.962185189094, 7564.773056808304, 4480.932786008212, 4562.840300589463, 4583.289590113538, 4584.518625544303, 4587.7017993830295, 2918.1099764571795, 2961.1264676920146, 3012.5330573761103, 3020.6677265500775, 3046.299351149248, 959.9376040557341, 963.330485312708, 972.9854052189223, 977.4917043137528, 1018.5111146649575, 10230.23273254509, 10236.33463824849, 10256.179505639531, 10258.384496930208, 10278.69163925076, 4126.339785634284, 4226.640735537452, 4236.597523235288, 4242.639375653042, 4301.0, 8751.56242187888, 8805.339599530062, 8809.11908809114, 8826.911730882737, 8837.337199710048, 4616.0, 4616.792244349012, 4635.930461043087, 4641.164590373698, 4641.373414589055, 4222.366645003274, 4224.091820258659, 4227.32362821947, 4238.321868501025, 4241.363795430649, 3553.662402071799, 3629.7822130672243, 3642.9817850910576, 3646.8176591170336, 3678.65052819987, 1184.336771407997, 1187.2935603316014, 1189.1259923956059, 1196.216478206776, 1203.12172114357, 1016.3800081950004, 1226.3500344817262, 1227.6869398303375, 1254.1973137192203, 1258.282778816066, 6299.055141728777, 6451.741930322828, 6955.200151982485, 7200.279972002862, 7214.6031968241205, 697.083335413929, 701.8175274428584, 706.1808302369227, 710.5665544018145, 713.2368365848596, 5313.256144139824, 5333.12003519415, 5340.118880384771, 5362.91955620666, 5369.033573956725, 8686.695965641298, 8722.040575536686, 8755.474671519602, 8817.030126686059, 8817.470951742916, 8600.526971016654, 8647.610857511427, 8689.522076285864, 8727.083656216133, 8731.995820480599, 6738.764143254963, 6880.0367948486255, 6886.793396198122, 6908.274631163656, 6910.032595436643, 6429.6142231466265, 6491.870162596816, 6496.577722448026, 6499.837504062247, 6502.512311576556, 7455.627218639155, 7698.615069246627, 7810.804729881798, 7824.100228473799, 7851.05787305527, 7879.251471110236, 8023.518588884685, 8128.674853005814, 8133.8373232536205, 8144.714934977247, 6532.05285233648, 6574.506911981525, 6616.768413105518, 6620.569662971891, 6629.801105966829, 7132.821679458055, 7144.142702875688, 7159.677814498465, 7182.60495672743, 7188.784336469915, 6604.669766511752, 6709.865802684017, 6762.560433571802, 6793.72825086991, 6923.9653801730665, 6570.720891676618, 6597.340265973365, 6637.800865974028, 6680.198376194888, 6747.763828265987, 5855.970720146372, 6630.668466576748, 6664.733410663519, 6680.699368528525, 6682.866342673216, 5722.570807189394, 6133.44798968095, 6141.539384546266, 6160.229971253593, 6164.815055548341, 6097.969510152421, 6161.0, 6207.441330280297, 6207.6585787782105, 6216.564840461305], "ext.html": [562.9549636029118, 589.1486801571731, 602.4607975861603, 608.3703367015138, 615.1510914937388, 31594.526082108787, 41955.0, 42321.365179522334, 42362.15275694488, 42470.57529424712, 43526.56473435264, 43815.78092109543, 44198.33702494465, 44224.0, 44269.33595996055, 7624.542527448343, 7759.728409505668, 8793.164649358318, 8955.149260820212, 10299.588016479369, 10400.167986561095, 10557.630482933098, 10564.630237941674, 10571.101456376216, 10576.206784491156, 10596.470176491182, 10699.251052426333, 10704.14366850654, 10704.197185211102, 10709.089727373183, 7839.608019598997, 8037.397195210353, 10332.535035923402, 10498.0, 10512.421816800073, 10066.597336106546, 10214.28500005, 10214.28500005, 10216.693499195037, 10222.0289072538, 40373.394399084034, 40754.592454075675, 40804.79597602023, 40828.183436331106, 40839.59160408388, 3377.189474526096, 3578.5526809148596, 3587.282543491286, 3593.4609808528667, 3935.8622448214173, 30437.23906902323, 30648.387032259452, 31086.53370199449, 31441.528377074133, 31717.841410792797, 3052.5115981443087, 3069.8004629699, 3073.754099672021, 3116.3923035008183, 3136.310011797401, 281973.0, 282477.0, 282880.0, 283170.0, 283662.0, 56506.717466413225, 57702.42297577055, 60997.0, 65286.0, 66844.66577667178, 60921.69539152276, 61544.69227653833, 61718.69140654358, 61763.69118154381, 61970.0, 15284.923575382052, 15344.539663810103, 15370.769438458432, 15450.6137346565, 15458.0, 12022.579209727792, 12099.334536600396, 12122.939385303018, 12138.45376958039, 12244.877551224552, 19501.80498195028, 19819.702704459443, 19949.501262468264, 19997.700034499496, 20025.29911453121, 7666.8849967250535, 7689.846203076019, 7751.7674469766, 7808.336291415293, 7859.436992253934, 945.9574319155655, 955.9808803823885, 975.8048390321823, 1007.5919252702668, 1045.7124290819934, 29293.0, 29347.266318342212, 29424.84176029507, 29435.85282073576, 29744.851275743484, 1027.8047171037479, 1085.8099832529276, 1116.832475128737, 1148.6324376199536, 1154.318951818431, 14845.0, 15071.0, 15301.923490382476, 15332.540023799082, 15987.200639967956, 293572.0, 294784.0, 295667.0, 298141.0, 298250.0, 56108.438915611136, 56760.0, 56885.0, 56885.0, 56959.43040569624, 1340.4973135074347, 1360.6802401435655, 1361.5847166614278, 1396.7695330270392, 1401.5234820161195, 30176.0, 31179.84410077935, 31187.220319491287, 31350.843245784537, 31805.681943180272, 44212.55787442213, 45348.77325613351, 49987.25019124789, 51578.48421515887, 51657.483425165265, 438015.0, 445609.0, 445702.0, 445858.0, 446525.0, 43127.784361078, 43606.0, 43865.78067109644, 43997.120057598026, 44004.33993490036, 46923.0, 47115.528844711116, 47264.0, 48083.27875081806, 48542.757286213346, 39008.2198356037, 39635.0, 41945.37081943834, 42085.0, 42690.78654606707, 37951.62048379481, 38104.23791524209, 38159.42760858645, 38485.0, 39002.414963775, 37042.8147859259, 37816.24367512689, 37893.24213515659, 37999.62000379961, 38040.61959380481, 33621.0, 33960.0, 34661.48007779936, 37598.0, 38918.221635566566, 26014.86992565025, 26717.46565068649, 26756.59865101986, 26913.192604221906, 27231.86384068067], "prototype.html": [319.6112889495144, 320.2570037512971, 320.7882797353746, 321.3155977767356, 325.16108440224207, 5674.120511320747, 5680.091185410335, 5704.11586204138, 5726.026575482168, 5743.885122297552, 5570.944290557093, 5647.463490968362, 5665.971670141644, 5668.234788303578, 5672.744726487308, 4258.765767882765, 4307.353896915472, 4371.584699453555, 4377.0, 4378.6934914555995, 4340.175366680321, 4391.297392417214, 4400.075984043355, 4402.0, 4413.404190434282, 4333.891652708676, 4340.65274778017, 4350.956490435103, 4357.150355680644, 4366.1049484855685, 4327.307630779092, 4357.106793107437, 4358.0, 4358.8038538265855, 4364.825406983733, 3818.3890577507464, 3826.8086595670106, 3828.2917660232947, 3855.267499175176, 3886.980565097185, 5120.15517439622, 5242.108841496916, 5243.082460569385, 5305.628605997582, 5407.621466497347, 4982.701037937735, 5022.673526220784, 5024.62315326352, 5027.296178535008, 5027.346444962168, 5905.940940590625, 5939.821805345847, 5946.554008449383, 5949.494292985101, 5950.404959504058, 4057.2088442753675, 4085.0, 4220.092680073768, 4222.915541689149, 4224.197402493516, 6186.10301506279, 6254.437100660917, 6255.06174073888, 6258.4680302174365, 6272.529560283043, 4222.155568886235, 4229.703920725581, 4233.70364074518, 4235.512916014636, 4241.4698162729655, 4074.348104303297, 4120.21715873983, 4235.25882970479, 4281.614654681031, 4299.0, 4949.455559888409, 4969.453360130383, 4969.503049695001, 4969.875753106201, 4976.950230497649, 6025.096235564701, 6032.125341825498, 6032.306284777219, 6035.124906888476, 6036.63780173191, 1524.390243902448, 1558.088518216833, 1558.4467514032583, 1559.165846272239, 1559.2749371542288, 1010.525053224983, 1025.2259544044198, 1027.3938376357985, 1031.28841099641, 1037.8754549453963, 5834.212381328466, 5837.824865254049, 5843.503302219359, 5859.033259512218, 5863.061910094364, 6039.154518367344, 6130.693465326716, 6138.447539721357, 6147.323794382614, 6150.108234306001, 5828.067509198508, 5828.184054232411, 5828.737706803204, 5828.912566311508, 5835.153902684172, 3433.399155147889, 3463.2207753255316, 3472.097254713742, 3479.9652003480146, 3487.302539492112, 6499.1876015498065, 6525.902111468332, 6533.052707357407, 6533.346665333524, 6612.702428390734, 6427.58220715652, 6457.61254324742, 6459.838504037437, 6460.547761656733, 6463.806085817433, 6512.837179070561, 6561.343865613496, 6568.113304703899, 6572.342765723485, 6581.440577550962, 6203.286622038523, 6218.968905155445, 6262.091996660368, 6268.153799237227, 6281.403266689657, 6171.753129874754, 6187.504999600112, 6219.253689557101, 6238.812835614939, 6239.96880015597, 6484.383983521558, 6484.513661475314, 6489.967550162219, 6495.512836537184, 6502.382273683992, 4234.894127646833, 4251.426057482324, 4305.07440900208, 4307.978460107679, 4311.504177019683, 6093.207882975362, 6110.236220472441, 6184.628922264678, 6186.752529898754, 6196.845078873064, 6076.0, 6093.6039157454625, 6093.725782339717, 6110.114033465034, 6110.877782444415, 6015.428534289235, 6019.638821670714, 6024.33732289439, 6029.939700602938, 6044.063170208625, 5889.646621202742, 5971.193888825127, 5972.70136493165, 5987.2815262168815, 6007.158997740407, 6127.754889804358, 6138.662373569497, 6139.416755408229, 6141.201643786279, 6145.877082458415, 5979.9967011051785, 5985.311689155628, 5989.8203053908455, 5991.520678345809, 5998.520118390606], "yui.html": [699.0562740300592, 700.8528209076094, 797.6649807081029, 800.6637212370804, 807.3662175192474, 13495.730085398287, 13715.93142034291, 13727.725445491084, 13746.175229486238, 13746.72506549871, 11463.59877404291, 12009.759804803898, 12750.617481475547, 12924.224546527192, 12973.675658108552, 803.8151225218203, 815.3232816762073, 817.6811043692965, 818.5170749257936, 820.2781552234026, 808.0828259924969, 816.5141740664295, 818.4107442641318, 818.6152508321079, 819.1317203764029, 850.8851305073798, 855.4268640011177, 857.9742607721778, 858.5964596639569, 859.1623167411786, 846.9830603387959, 853.0105078109394, 853.5390888919976, 853.91887770662, 854.2610641794834, 625.9906101408437, 627.5011365964024, 628.2084573437456, 628.4438272129153, 628.5694299404922, 12199.695007624792, 12333.075019373493, 12333.321667308295, 12338.81491777624, 12341.938290308492, 10271.33236339643, 10317.48412579368, 10397.636082737068, 10543.683689489328, 10629.681109566647, 9433.123786032085, 9462.905370946271, 9550.140487356102, 9608.27937904653, 9735.17251033663, 3537.2925414917117, 3550.840212190458, 3593.3531964246426, 3596.0829988352803, 3632.3824949758605, 46587.53412465866, 46778.532214677754, 47058.294125588145, 47103.528964710255, 47125.52874471246, 8075.636596353178, 8237.8352432951, 8327.6668933242, 8360.247577717913, 8366.707165249309, 16648.417305394494, 16649.83350166507, 16657.50027499177, 16700.91649541769, 16720.16399180036, 7365.631718414165, 7520.435967302475, 7606.771796846104, 7665.61671916402, 7764.417668674872, 4262.893427664271, 4282.550332215135, 4309.741415515079, 4420.7126536775, 4428.645708343325, 2803.4393121375806, 2842.8862845486365, 2844.630198074237, 2845.5020371434916, 2846.51609226432, 422.99365509517384, 437.7111106669583, 439.4462976649381, 442.1488634378808, 452.08678469491446, 550.3478378121938, 557.0474488624498, 560.3077213986833, 578.467809615155, 617.5430181665625, 7842.764717058498, 8719.389642725075, 8937.73186804397, 8948.8657670135, 8951.955240223888, 557.4676184244037, 583.294214001055, 628.6259675493075, 651.2250421997808, 674.6289540752566, 3697.722670799647, 3812.1428607013154, 3886.436466712311, 3892.8637497687446, 3953.644172024474, 54530.45469545333, 55194.44805551893, 55248.72375638176, 63171.368286316545, 63722.044169337496, 43054.354184687254, 43106.35340469895, 47999.5200048002, 48392.27411588829, 49454.0, 45280.54719452829, 45900.311495327594, 46027.76986115048, 46154.53845461569, 50499.49500504948, 7721.957535732829, 7954.363650908029, 8107.4324797263625, 8148.796280093045, 8478.872816907875, 36883.44674829826, 37197.25605487929, 37234.0, 37339.62660373362, 38164.23671526498, 41952.0, 47696.7615161922, 48147.0, 48437.9452568429, 48948.265776012675, 7227.457940654577, 7880.881786773089, 7896.09194942566, 7986.281234688906, 8080.838383232185, 9944.35361701487, 10396.844047339448, 11166.218364714718, 11423.257488263236, 11447.771044579229, 10109.0, 10476.476176191312, 10956.233063685784, 11232.157588181082, 11252.381119038531, 10346.948265258927, 10655.680329590125, 10692.091172250446, 10754.838677419688, 11025.887342030332, 10439.0, 10829.729256768644, 10834.458277085956, 10938.906109388998, 11247.606333778278, 8897.466152030898, 9032.638694452411, 9272.72181834546, 9296.674616388394, 9444.85832712496, 8543.700970466003, 8954.373193876627, 9105.226055785333, 9135.954320228357, 9328.580213890256]}, "summary": {"lowerIsBetter": false, "suite": 6788.550761571131, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7966.763243156061, "unit": "ms", "value": 7966.763243156061}, "dojo.html": {"lowerIsBetter": false, "filtered": 5363.056029336084, "unit": "ms", "value": 5363.056029336084}, "mootools.html": {"lowerIsBetter": false, "filtered": 4270.72714106995, "unit": "ms", "value": 4270.72714106995}, "ext.html": {"lowerIsBetter": false, "filtered": 19686.063402694195, "unit": "ms", "value": 19686.063402694195}, "prototype.html": {"lowerIsBetter": false, "filtered": 4561.319593355268, "unit": "ms", "value": 4561.319593355268}, "yui.html": {"lowerIsBetter": false, "filtered": 5972.740636194759, "unit": "ms", "value": 5972.740636194759}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-012"}, "testrun": {"date": 1447351347, "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": "20151112083142", "branch": "B2G-Inbound", "revision": "b62504059749d3ea58458c1122f957ef87b6d8b4"}}, {"talos_counters": {}, "results": {"audio-dft": [160.0, 169.0, 160.0, 160.0, 159.0, 163.0, 159.0, 162.0, 160.0, 165.0], "ai-astar": [109.0, 109.0, 105.0, 108.0, 109.0, 109.0, 100.0, 109.0, 113.0, 110.0], "imaging-gaussian-blur": [110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0], "audio-beat-detection": [159.0, 122.0, 150.0, 171.0, 124.0, 147.0, 145.0, 124.0, 165.0, 133.0], "json-stringify-tinderbox": [68.0, 67.0, 68.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 68.0], "stanford-crypto-pbkdf2": [137.0, 146.0, 146.0, 145.0, 148.0, 136.0, 147.0, 156.0, 145.0, 137.0], "json-parse-financial": [58.0, 59.0, 58.0, 57.0, 57.0, 58.0, 58.0, 65.0, 56.0, 56.0], "stanford-crypto-sha256-iterative": [66.0, 65.0, 66.0, 68.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0], "audio-fft": [72.0, 71.0, 80.0, 88.0, 71.0, 71.0, 72.0, 112.0, 87.0, 71.0], "imaging-darkroom": [145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 144.0, 145.0, 144.0, 145.0], "stanford-crypto-ccm": [122.0, 115.0, 115.0, 124.0, 120.0, 120.0, 115.0, 126.0, 115.0, 115.0], "audio-oscillator": [92.0, 92.0, 134.0, 90.0, 91.0, 90.0, 132.0, 90.0, 91.0, 130.0], "stanford-crypto-aes": [85.0, 86.0, 85.0, 87.0, 84.0, 84.0, 84.0, 85.0, 87.0, 85.0], "imaging-desaturate": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1486.7000000000003, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.5, "unit": "ms", "value": 79.5}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 144.3, "unit": "ms", "value": 144.3}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.0, "unit": "ms", "value": 144.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 118.7, "unit": "ms", "value": 118.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.1, "unit": "ms", "value": 145.1}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 58.2, "unit": "ms", "value": 58.2}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.2, "unit": "ms", "value": 103.2}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.1, "unit": "ms", "value": 108.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.7, "unit": "ms", "value": 161.7}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 66.2, "unit": "ms", "value": 66.2}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 67.2, "unit": "ms", "value": 67.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.6, "unit": "ms", "value": 109.6}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.2, "unit": "ms", "value": 85.2}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.7, "unit": "ms", "value": 95.7}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-012"}, "testrun": {"date": 1447351347, "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": "20151112083142", "branch": "B2G-Inbound", "revision": "b62504059749d3ea58458c1122f957ef87b6d8b4"}}, {"talos_counters": {}, "results": {"DeltaBlue": [196.27085377821393], "Encrypt": [285.8776443682104], "NavierStokes": [4822.115384615385], "Decrypt": [5055.555555555556], "Splay": [636.9426751592357], "Richards": [165.48072149594572], "RegExp": [25794.871794871793], "Earley": [800.640512409928], "Boyer": [11952.380952380952], "RayTrace": [1103.7527593818984]}, "summary": {"lowerIsBetter": false, "suite": 20893.64457417544, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 336.87120999999996, "unit": "score", "value": 336.87120999999996}, "Encrypt": {"lowerIsBetter": false, "filtered": 931.1011380000001, "unit": "score", "value": 931.1011380000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.7487537387835, "unit": "score", "value": 307.7487537387835}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.65118681318681, "unit": "score", "value": 52.65118681318681}, "Splay": {"lowerIsBetter": false, "filtered": 127.94086999999998, "unit": "score", "value": 127.94086999999998}, "RegExp": {"lowerIsBetter": false, "filtered": 35.31651590457257, "unit": "score", "value": 35.31651590457257}, "Richards": {"lowerIsBetter": false, "filtered": 213.32998600000002, "unit": "score", "value": 213.32998600000002}, "Earley": {"lowerIsBetter": false, "filtered": 832.4122870000002, "unit": "score", "value": 832.4122870000002}, "Boyer": {"lowerIsBetter": false, "filtered": 55.75985258964142, "unit": "score", "value": 55.75985258964142}, "RayTrace": {"lowerIsBetter": false, "filtered": 670.4300340000001, "unit": "score", "value": 670.4300340000001}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-012"}, "testrun": {"date": 1447351347, "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": "20151112083142", "branch": "B2G-Inbound", "revision": "b62504059749d3ea58458c1122f957ef87b6d8b4"}}] 10:22:37 INFO - RETURN: dromaeo_css: 6788.55 10:22:37 INFO - RETURN: kraken: 1486.70 10:22:37 INFO - RETURN: v8_7: 20893.64 10:22:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20893.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1486.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6788.55"}}} 10:22:37 INFO - Return code: 0 10:22:37 INFO - # TBPL SUCCESS # 10:22:37 INFO - Running post-action listener: _resource_record_post_action 10:22:37 INFO - Running post-run listener: _resource_record_post_run 10:22:38 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 16384; Write bytes: 513757184; Read time: 244; Write time: 462496 10:22:38 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 4096; Write bytes: 243286016; Read time: 160; Write time: 330728 10:22:38 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 12288; Write bytes: 270462976; Read time: 84; Write time: 131768 10:22:38 INFO - Running post-run listener: _upload_blobber_files 10:22:38 INFO - Blob upload gear active. 10:22:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:22:38 INFO - Copying logs to upload dir... 10:22:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1253.828321 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2015-11-12 10:22:38.360106) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 10:22:38.364528) ========= 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=928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010040 build_url: 'https://queue.taskcluster.net/v1/task/v2qEs_CSQUKWuds8S9cH_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 10:22:38.420656) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:22:38.421023) ========= 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=928fd09416829678a2f67a56000001ac-1447350883.397214-1968675015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004391 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:22:38.471444) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 10:22:38.471832) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 10:22:38.472265) ========= ========= Total master_lag: 0.24 =========