builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1448106515.13 results: success (0) buildid: 20151121023031 builduid: bd78d66cbdc741e89fe4cb6b94a47594 revision: 25f0df4054c3bc997b0e99e0e1e786bf062db3cb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 03:48:35.131162) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 03:48:35.131696) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 03:48:35.131993) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007493 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 03:48:35.158137) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 03:48:35.158443) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 03:48:35.174660) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 03:48:35.174962) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 03:48:35.235576) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 03:48:35.235887) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 03:48:35.236289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 03:48:35.236621) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-21 03:48:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.7M=0s 2015-11-21 03:48:35 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175527 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 03:48:35.431130) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 03:48:35.431429) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020355 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 03:48:35.481213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-21 03:48:35.481598) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 25f0df4054c3bc997b0e99e0e1e786bf062db3cb --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 25f0df4054c3bc997b0e99e0e1e786bf062db3cb --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-21 03:48:35,787 truncating revision to first 12 chars 2015-11-21 03:48:35,788 Setting DEBUG logging. 2015-11-21 03:48:35,788 attempt 1/10 2015-11-21 03:48:35,788 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/25f0df4054c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-21 03:48:36,368 unpacking tar archive at: b2g-inbound-25f0df4054c3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.122503 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-21 03:48:36.617234) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 03:48:36.617581) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 03:48:36.625923) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 03:48:36.626338) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 03:48:36.626813) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-21 03:48:36.627569) ========= /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=a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:48:37 INFO - MultiFileLogger online at 20151121 03:48:37 in /builds/slave/test-pgo 03:48:37 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 03:48:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:48:37 INFO - {'append_to_log': False, 03:48:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:48:37 INFO - 'blob_upload_branch': 'B2G-Inbound', 03:48:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:48:37 INFO - 'branch': 'B2G-Inbound', 03:48:37 INFO - 'buildbot_json_path': 'buildprops.json', 03:48:37 INFO - 'config_files': ('talos/linux_config.py',), 03:48:37 INFO - 'default_actions': ('clobber', 03:48:37 INFO - 'read-buildbot-config', 03:48:37 INFO - 'download-and-extract', 03:48:37 INFO - 'populate-webroot', 03:48:37 INFO - 'create-virtualenv', 03:48:37 INFO - 'install', 03:48:37 INFO - 'run-tests'), 03:48:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:48:37 INFO - 'download_minidump_stackwalk': True, 03:48:37 INFO - 'download_symbols': 'ondemand', 03:48:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:48:37 INFO - 'tooltool.py': '/tools/tooltool.py', 03:48:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:48:37 INFO - '/tools/misc-python/virtualenv.py')}, 03:48:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:48:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:48:37 INFO - 'installer_path': 'installer.exe', 03:48:37 INFO - 'log_level': 'info', 03:48:37 INFO - 'log_name': 'talos', 03:48:37 INFO - 'log_to_console': True, 03:48:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:48:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:48:37 INFO - 'opt_config_files': (), 03:48:37 INFO - 'pip_index': False, 03:48:37 INFO - 'sps_profile': False, 03:48:37 INFO - 'sps_profile_interval': 0, 03:48:37 INFO - 'suite': 'dromaeojs', 03:48:37 INFO - 'system_bits': '64', 03:48:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:48:37 INFO - 'title': 'talos-linux64-ix-033', 03:48:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:48:37 INFO - 'use_talos_json': True, 03:48:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:48:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:48:37 INFO - 'work_dir': 'build'} 03:48:37 INFO - ##### 03:48:37 INFO - ##### Running clobber step. 03:48:37 INFO - ##### 03:48:37 INFO - Running pre-action listener: _resource_record_pre_action 03:48:37 INFO - Running main action method: clobber 03:48:37 INFO - rmtree: /builds/slave/test-pgo/build 03:48:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:48:37 INFO - Running post-action listener: _resource_record_post_action 03:48:37 INFO - ##### 03:48:37 INFO - ##### Running read-buildbot-config step. 03:48:37 INFO - ##### 03:48:37 INFO - Running pre-action listener: _resource_record_pre_action 03:48:37 INFO - Running main action method: read_buildbot_config 03:48:37 INFO - Using buildbot properties: 03:48:37 INFO - { 03:48:37 INFO - "properties": { 03:48:37 INFO - "buildnumber": 990, 03:48:37 INFO - "product": "firefox", 03:48:37 INFO - "script_repo_revision": "production", 03:48:37 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 03:48:37 INFO - "repository": "", 03:48:37 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 03:48:37 INFO - "buildid": "20151121023031", 03:48:37 INFO - "slavename": "talos-linux64-ix-033", 03:48:37 INFO - "pgo_build": "True", 03:48:37 INFO - "basedir": "/builds/slave/test-pgo", 03:48:37 INFO - "project": "", 03:48:37 INFO - "platform": "ubuntu64_hw", 03:48:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:48:37 INFO - "slavebuilddir": "test", 03:48:37 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 03:48:37 INFO - "branch": "b2g-inbound", 03:48:37 INFO - "repo_path": "integration/b2g-inbound", 03:48:37 INFO - "stage_platform": "linux64-pgo", 03:48:37 INFO - "builduid": "bd78d66cbdc741e89fe4cb6b94a47594", 03:48:37 INFO - "revision": "25f0df4054c3bc997b0e99e0e1e786bf062db3cb" 03:48:37 INFO - }, 03:48:37 INFO - "sourcestamp": { 03:48:37 INFO - "repository": "", 03:48:37 INFO - "hasPatch": false, 03:48:37 INFO - "project": "", 03:48:37 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 03:48:37 INFO - "changes": [ 03:48:37 INFO - { 03:48:37 INFO - "category": null, 03:48:37 INFO - "files": [ 03:48:37 INFO - { 03:48:37 INFO - "url": null, 03:48:37 INFO - "name": "https://queue.taskcluster.net/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:48:37 INFO - } 03:48:37 INFO - ], 03:48:37 INFO - "repository": "", 03:48:37 INFO - "rev": "25f0df4054c3bc997b0e99e0e1e786bf062db3cb", 03:48:37 INFO - "who": "sendchange", 03:48:37 INFO - "when": 1448106442, 03:48:37 INFO - "number": 6692240, 03:48:37 INFO - "comments": "", 03:48:37 INFO - "project": "", 03:48:37 INFO - "at": "Sat 21 Nov 2015 03:47:22", 03:48:37 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 03:48:37 INFO - "revlink": "", 03:48:37 INFO - "properties": [ 03:48:37 INFO - [ 03:48:37 INFO - "buildid", 03:48:37 INFO - "20151121023031", 03:48:37 INFO - "Change" 03:48:37 INFO - ], 03:48:37 INFO - [ 03:48:37 INFO - "builduid", 03:48:37 INFO - "bd78d66cbdc741e89fe4cb6b94a47594", 03:48:37 INFO - "Change" 03:48:37 INFO - ], 03:48:37 INFO - [ 03:48:37 INFO - "pgo_build", 03:48:37 INFO - "True", 03:48:37 INFO - "Change" 03:48:37 INFO - ] 03:48:37 INFO - ], 03:48:37 INFO - "revision": "25f0df4054c3bc997b0e99e0e1e786bf062db3cb" 03:48:37 INFO - } 03:48:37 INFO - ], 03:48:37 INFO - "revision": "25f0df4054c3bc997b0e99e0e1e786bf062db3cb" 03:48:37 INFO - } 03:48:37 INFO - } 03:48:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:48:37 INFO - Running post-action listener: _resource_record_post_action 03:48:37 INFO - ##### 03:48:37 INFO - ##### Running download-and-extract step. 03:48:37 INFO - ##### 03:48:37 INFO - Running pre-action listener: _resource_record_pre_action 03:48:37 INFO - Running main action method: download_and_extract 03:48:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:37 INFO - https://queue.taskcluster.net/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:48:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/test_packages.json 03:48:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/test_packages.json 03:48:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:48:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:48:38 INFO - Downloaded 1302 bytes. 03:48:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:48:38 INFO - Using the following test package requirements: 03:48:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:48:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:48:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:38 INFO - u'jsshell-linux-x86_64.zip'], 03:48:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:48:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:48:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:48:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:48:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:48:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:48:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:48:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:38 INFO - https://queue.taskcluster.net/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:48:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:48:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:48:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:48:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:48:40 INFO - Downloaded 22522798 bytes. 03:48:40 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 03:48:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:48:40 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 03:48:41 INFO - Return code: 0 03:48:41 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 03:48:41 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')]} 03:48:41 INFO - https://queue.taskcluster.net/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:48:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:48:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:48:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:48:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:48:43 INFO - Downloaded 22522798 bytes. 03:48:43 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 03:48:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:48:43 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 03:48:44 INFO - Return code: 0 03:48:44 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')]} 03:48:44 INFO - https://queue.taskcluster.net/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:48:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:48:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:48:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:48:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:48:45 INFO - Downloaded 11130997 bytes. 03:48:45 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 03:48:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:48:45 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 03:48:46 INFO - Return code: 0 03:48: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')]} 03:48:46 INFO - https://queue.taskcluster.net/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:48:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:48:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:48:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:48:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:48:48 INFO - Downloaded 57441366 bytes. 03:48:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:48:48 INFO - mkdir: /builds/slave/test-pgo/properties 03:48:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:48:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:48:48 INFO - Contents: 03:48:48 INFO - build_url:https://queue.taskcluster.net/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:48:48 INFO - Running post-action listener: _resource_record_post_action 03:48:48 INFO - Running post-action listener: set_extra_try_arguments 03:48:48 INFO - ##### 03:48:48 INFO - ##### Running populate-webroot step. 03:48:48 INFO - ##### 03:48:48 INFO - Running pre-action listener: _resource_record_pre_action 03:48:48 INFO - Running main action method: populate_webroot 03:48:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:48:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:48:48 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:48:48 INFO - '../fennec_ids.txt'], 03:48:48 INFO - 'tests': ['tcheck2']}, 03:48:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:48:48 INFO - '--tppagecycles', 03:48:48 INFO - '7'], 03:48:48 INFO - 'tests': ['tsvgm']}}, 03:48:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:48:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:48:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:48:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:48:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:48:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:48:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:48:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:48 INFO - 'talos_options': ['--e10s'], 03:48:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:48:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:48 INFO - 'tests': ['damp', 'tps']}, 03:48:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:48 INFO - 'talos_options': ['--e10s'], 03:48:48 INFO - 'tests': ['damp', 'tps']}, 03:48:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:48:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:48:48 INFO - 'other': {'tests': ['a11yr', 03:48:48 INFO - 'ts_paint', 03:48:48 INFO - 'tpaint', 03:48:48 INFO - 'sessionrestore', 03:48:48 INFO - 'sessionrestore_no_auto_restore']}, 03:48:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:48:48 INFO - 'tests': ['a11yr', 03:48:48 INFO - 'ts_paint', 03:48:48 INFO - 'tpaint', 03:48:48 INFO - 'sessionrestore', 03:48:48 INFO - 'sessionrestore_no_auto_restore']}, 03:48:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:48:48 INFO - 'tests': ['a11yr', 03:48:48 INFO - 'ts_paint', 03:48:48 INFO - 'tpaint', 03:48:48 INFO - 'sessionrestore', 03:48:48 INFO - 'sessionrestore_no_auto_restore']}, 03:48:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:48:48 INFO - 'tests': ['a11yr', 03:48:48 INFO - 'ts_paint', 03:48:48 INFO - 'tpaint', 03:48:48 INFO - 'sessionrestore', 03:48:48 INFO - 'sessionrestore_no_auto_restore']}, 03:48:48 INFO - 'other_l64': {'tests': ['a11yr', 03:48:48 INFO - 'ts_paint', 03:48:48 INFO - 'tpaint', 03:48:48 INFO - 'sessionrestore', 03:48:48 INFO - 'sessionrestore_no_auto_restore']}, 03:48:48 INFO - 'other_nol64': {'tests': ['a11yr', 03:48:48 INFO - 'ts_paint', 03:48:48 INFO - 'tpaint', 03:48:48 INFO - 'sessionrestore', 03:48:48 INFO - 'sessionrestore_no_auto_restore']}, 03:48:48 INFO - 'svgr': {'tests': ['tsvgx', 03:48:48 INFO - 'tsvgr_opacity', 03:48:48 INFO - 'tart', 03:48:48 INFO - 'tscrollx', 03:48:48 INFO - 'cart']}, 03:48:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:48:48 INFO - 'tests': ['tsvgx', 03:48:48 INFO - 'tsvgr_opacity', 03:48:48 INFO - 'tart', 03:48:48 INFO - 'tscrollx', 03:48:48 INFO - 'cart']}, 03:48:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:48 INFO - 'tests': ['tp5o']}, 03:48:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:48 INFO - 'talos_options': ['--e10s'], 03:48:48 INFO - 'tests': ['tp5o']}, 03:48:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:48 INFO - 'talos_options': ['--xperf_path', 03:48:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:48:48 INFO - 'tests': ['tp5n']}, 03:48:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:48 INFO - 'talos_options': ['--e10s', 03:48:48 INFO - '--xperf_path', 03:48:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:48:48 INFO - 'tests': ['tp5n']}}, 03:48:48 INFO - 'talos.zip': {'path': '', 03:48:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:48:48 INFO - Running post-action listener: _resource_record_post_action 03:48:48 INFO - ##### 03:48:48 INFO - ##### Running create-virtualenv step. 03:48:48 INFO - ##### 03:48:48 INFO - Running pre-action listener: _resource_record_pre_action 03:48:48 INFO - Running main action method: create_virtualenv 03:48:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:48:48 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 03:48:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:48:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:48:48 INFO - Using real prefix '/usr' 03:48:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:48:49 INFO - Installing distribute.............................................................................................................................................................................................done. 03:48:51 INFO - Installing pip.................done. 03:48:51 INFO - Return code: 0 03:48:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:48: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')]} 03:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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')]} 03:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:51 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 0x7fd49cff9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c176c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0dd70>, '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 0x2d0eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0efb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568', '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 03:48:51 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 03:48:51 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 03:48:51 INFO - Using env: {'DISPLAY': ':0', 03:48:51 INFO - 'HOME': '/home/cltbld', 03:48:51 INFO - 'LANG': 'en_US.UTF-8', 03:48:51 INFO - 'LANGUAGE': 'en_US:en', 03:48:51 INFO - 'LOGNAME': 'cltbld', 03:48:51 INFO - 'MAIL': '/var/mail/cltbld', 03:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:51 INFO - 'MOZ_NO_REMOTE': '1', 03:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:51 INFO - 'NO_EM_RESTART': '1', 03:48:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:51 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:51 INFO - 'SHELL': '/bin/bash', 03:48:51 INFO - 'SHLVL': '1', 03:48:51 INFO - 'TERM': 'linux', 03:48:51 INFO - 'TMOUT': '86400', 03:48:51 INFO - 'USER': 'cltbld', 03:48:51 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568', 03:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:51 INFO - '_': '/tools/buildbot/bin/python'} 03:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:51 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 03:48:51 INFO - Cleaning up... 03:48:51 INFO - Return code: 0 03:48:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:48: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')]} 03:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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')]} 03:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:51 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 0x7fd49cff9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c176c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0dd70>, '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 0x2d0eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0efb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568', '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 03:48:51 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 03:48:51 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 03:48:51 INFO - Using env: {'DISPLAY': ':0', 03:48:51 INFO - 'HOME': '/home/cltbld', 03:48:51 INFO - 'LANG': 'en_US.UTF-8', 03:48:51 INFO - 'LANGUAGE': 'en_US:en', 03:48:51 INFO - 'LOGNAME': 'cltbld', 03:48:51 INFO - 'MAIL': '/var/mail/cltbld', 03:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:51 INFO - 'MOZ_NO_REMOTE': '1', 03:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:51 INFO - 'NO_EM_RESTART': '1', 03:48:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:51 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:51 INFO - 'SHELL': '/bin/bash', 03:48:51 INFO - 'SHLVL': '1', 03:48:51 INFO - 'TERM': 'linux', 03:48:51 INFO - 'TMOUT': '86400', 03:48:51 INFO - 'USER': 'cltbld', 03:48:51 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568', 03:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:51 INFO - '_': '/tools/buildbot/bin/python'} 03:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:51 INFO - Downloading/unpacking psutil>=0.7.1 03:48:51 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 03:48:51 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 03:48:51 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 03:48:51 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 03:48:51 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 03:48:51 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 03:48:53 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:48:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:48:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:48:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:53 INFO - Installing collected packages: psutil 03:48:53 INFO - Running setup.py install for psutil 03:48:53 INFO - building 'psutil._psutil_linux' extension 03:48:53 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 03:48:53 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 03:48:53 INFO - building 'psutil._psutil_posix' extension 03:48:53 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 03:48:53 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 03:48:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:53 INFO - Successfully installed psutil 03:48:53 INFO - Cleaning up... 03:48:53 INFO - Return code: 0 03:48:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:48:53 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')]} 03:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:53 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')]} 03:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:53 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 0x7fd49cff9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c176c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0dd70>, '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 0x2d0eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0efb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568', '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 03:48:53 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 03:48:53 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 03:48:53 INFO - Using env: {'DISPLAY': ':0', 03:48:53 INFO - 'HOME': '/home/cltbld', 03:48:53 INFO - 'LANG': 'en_US.UTF-8', 03:48:53 INFO - 'LANGUAGE': 'en_US:en', 03:48:53 INFO - 'LOGNAME': 'cltbld', 03:48:53 INFO - 'MAIL': '/var/mail/cltbld', 03:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:53 INFO - 'MOZ_NO_REMOTE': '1', 03:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:53 INFO - 'NO_EM_RESTART': '1', 03:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:53 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:53 INFO - 'SHELL': '/bin/bash', 03:48:53 INFO - 'SHLVL': '1', 03:48:53 INFO - 'TERM': 'linux', 03:48:53 INFO - 'TMOUT': '86400', 03:48:53 INFO - 'USER': 'cltbld', 03:48:53 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568', 03:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:53 INFO - '_': '/tools/buildbot/bin/python'} 03:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:48:53 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 03:48:53 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 03:48:53 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 03:48:53 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 03:48:53 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 03:48:53 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 03:48:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:48:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:48:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:48:55 INFO - Installing collected packages: mozsystemmonitor 03:48:55 INFO - Running setup.py install for mozsystemmonitor 03:48:55 INFO - Successfully installed mozsystemmonitor 03:48:55 INFO - Cleaning up... 03:48:55 INFO - Return code: 0 03:48:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:48:55 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')]} 03:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:55 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')]} 03:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:55 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 0x7fd49cff9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c176c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0dd70>, '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 0x2d0eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0efb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568', '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 03:48:55 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 03:48:55 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 03:48:55 INFO - Using env: {'DISPLAY': ':0', 03:48:55 INFO - 'HOME': '/home/cltbld', 03:48:55 INFO - 'LANG': 'en_US.UTF-8', 03:48:55 INFO - 'LANGUAGE': 'en_US:en', 03:48:55 INFO - 'LOGNAME': 'cltbld', 03:48:55 INFO - 'MAIL': '/var/mail/cltbld', 03:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:55 INFO - 'MOZ_NO_REMOTE': '1', 03:48:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:55 INFO - 'NO_EM_RESTART': '1', 03:48:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:55 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:55 INFO - 'SHELL': '/bin/bash', 03:48:55 INFO - 'SHLVL': '1', 03:48:55 INFO - 'TERM': 'linux', 03:48:55 INFO - 'TMOUT': '86400', 03:48:55 INFO - 'USER': 'cltbld', 03:48:55 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568', 03:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:55 INFO - '_': '/tools/buildbot/bin/python'} 03:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:56 INFO - Downloading/unpacking blobuploader==1.2.4 03:48:56 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 03:48:56 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 03:48:56 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 03:48:56 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 03:48:56 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 03:48:56 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 03:48:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:48:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:48:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:48:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:48:57 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 03:48:57 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 03:48:57 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 03:48:57 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 03:48:57 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 03:48:57 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 03:48:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:48:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:48:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48:58 INFO - Downloading docopt-0.6.1.tar.gz 03:48:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:48:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:48:58 INFO - Installing collected packages: blobuploader, requests, docopt 03:48:58 INFO - Running setup.py install for blobuploader 03:48:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:48:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:48:58 INFO - Running setup.py install for requests 03:48:58 INFO - Running setup.py install for docopt 03:48:58 INFO - Successfully installed blobuploader requests docopt 03:48:58 INFO - Cleaning up... 03:48:59 INFO - Return code: 0 03:48:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:48:59 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')]} 03:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:59 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')]} 03:48:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:59 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 0x7fd49cff9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c176c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0dd70>, '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 0x2d0eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0efb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568', '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 03:48:59 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 03:48:59 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 03:48:59 INFO - Using env: {'DISPLAY': ':0', 03:48:59 INFO - 'HOME': '/home/cltbld', 03:48:59 INFO - 'LANG': 'en_US.UTF-8', 03:48:59 INFO - 'LANGUAGE': 'en_US:en', 03:48:59 INFO - 'LOGNAME': 'cltbld', 03:48:59 INFO - 'MAIL': '/var/mail/cltbld', 03:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:59 INFO - 'MOZ_NO_REMOTE': '1', 03:48:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:59 INFO - 'NO_EM_RESTART': '1', 03:48:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:59 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:59 INFO - 'SHELL': '/bin/bash', 03:48:59 INFO - 'SHLVL': '1', 03:48:59 INFO - 'TERM': 'linux', 03:48:59 INFO - 'TMOUT': '86400', 03:48:59 INFO - 'USER': 'cltbld', 03:48:59 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568', 03:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:59 INFO - '_': '/tools/buildbot/bin/python'} 03:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:48:59 INFO - Running setup.py (path:/tmp/pip-p4QaU4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:48:59 INFO - Running setup.py (path:/tmp/pip-N5Xd8v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:48:59 INFO - Running setup.py (path:/tmp/pip-8HaASX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:48:59 INFO - Running setup.py (path:/tmp/pip-jhx_FJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:48:59 INFO - Running setup.py (path:/tmp/pip-YEpmwO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:48:59 INFO - Running setup.py (path:/tmp/pip-1OpS2T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:48:59 INFO - Running setup.py (path:/tmp/pip-iuWrMy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:48:59 INFO - Running setup.py (path:/tmp/pip-iFbdvz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:48:59 INFO - Running setup.py (path:/tmp/pip-44FTst-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:48:59 INFO - Running setup.py (path:/tmp/pip-9HCwMp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:48:59 INFO - Running setup.py (path:/tmp/pip-L98RXq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:49:00 INFO - Running setup.py (path:/tmp/pip-3Q0rc1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:49:00 INFO - Running setup.py (path:/tmp/pip-vzkTFL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:49:00 INFO - Running setup.py (path:/tmp/pip-kvWunc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:49:00 INFO - Running setup.py (path:/tmp/pip-pp3ZD1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:49:00 INFO - Running setup.py (path:/tmp/pip-JPZrY_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:49:00 INFO - Running setup.py (path:/tmp/pip-ZPpkqH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:49:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:49:00 INFO - Running setup.py install for manifestparser 03:49:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:49:00 INFO - Running setup.py install for mozcrash 03:49:00 INFO - Running setup.py install for mozdebug 03:49:00 INFO - Running setup.py install for mozdevice 03:49:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:49:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:49:00 INFO - Running setup.py install for mozfile 03:49:00 INFO - Running setup.py install for mozhttpd 03:49:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:49:01 INFO - Running setup.py install for mozinfo 03:49:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:49:01 INFO - Running setup.py install for mozInstall 03:49:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:49:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:49:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:49:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:49:01 INFO - Running setup.py install for mozleak 03:49:01 INFO - Running setup.py install for mozlog 03:49:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:49:01 INFO - Running setup.py install for moznetwork 03:49:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:49:01 INFO - Running setup.py install for mozprocess 03:49:01 INFO - Running setup.py install for mozprofile 03:49:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:49:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:49:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:49:01 INFO - Running setup.py install for mozrunner 03:49:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:49:01 INFO - Running setup.py install for mozscreenshot 03:49:02 INFO - Running setup.py install for moztest 03:49:02 INFO - Running setup.py install for mozversion 03:49:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:49:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:49:02 INFO - Cleaning up... 03:49:02 INFO - Return code: 0 03:49:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:49: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')]} 03:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49: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')]} 03:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49: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', '-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 0x7fd49cff9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c176c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0dd70>, '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 0x2d0eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0efb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568', '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 03:49:02 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 03:49:02 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 03:49:02 INFO - Using env: {'DISPLAY': ':0', 03:49:02 INFO - 'HOME': '/home/cltbld', 03:49:02 INFO - 'LANG': 'en_US.UTF-8', 03:49:02 INFO - 'LANGUAGE': 'en_US:en', 03:49:02 INFO - 'LOGNAME': 'cltbld', 03:49:02 INFO - 'MAIL': '/var/mail/cltbld', 03:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:02 INFO - 'MOZ_NO_REMOTE': '1', 03:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:02 INFO - 'NO_EM_RESTART': '1', 03:49:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:02 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:02 INFO - 'SHELL': '/bin/bash', 03:49:02 INFO - 'SHLVL': '1', 03:49:02 INFO - 'TERM': 'linux', 03:49:02 INFO - 'TMOUT': '86400', 03:49:02 INFO - 'USER': 'cltbld', 03:49:02 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568', 03:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:02 INFO - '_': '/tools/buildbot/bin/python'} 03:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:49:02 INFO - Running setup.py (path:/tmp/pip-dbvDME-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:49:02 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)) 03:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:49:02 INFO - Running setup.py (path:/tmp/pip-21ZZuN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:49:02 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)) 03:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:49:02 INFO - Running setup.py (path:/tmp/pip-AZxcHM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:49:02 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)) 03:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:49:02 INFO - Running setup.py (path:/tmp/pip-7ceyO0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:49:02 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)) 03:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:49:02 INFO - Running setup.py (path:/tmp/pip-mXvV40-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:49:02 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)) 03:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:49:02 INFO - Running setup.py (path:/tmp/pip-C_S5du-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:49:02 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)) 03:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:49:02 INFO - Running setup.py (path:/tmp/pip-jutRFH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:49:02 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)) 03:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:49:02 INFO - Running setup.py (path:/tmp/pip-FX4n2c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:49:03 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)) 03:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:49:03 INFO - Running setup.py (path:/tmp/pip-SHVMlS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:49:03 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)) 03:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:49:03 INFO - Running setup.py (path:/tmp/pip-h4NGoc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:49:03 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)) 03:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:49:03 INFO - Running setup.py (path:/tmp/pip-Td5Xld-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:49:03 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)) 03:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:49:03 INFO - Running setup.py (path:/tmp/pip-YNV6vp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:49:03 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)) 03:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:49:03 INFO - Running setup.py (path:/tmp/pip-bZigv7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:49:03 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)) 03:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:49:03 INFO - Running setup.py (path:/tmp/pip-hLMwQu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:49:03 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)) 03:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:49:03 INFO - Running setup.py (path:/tmp/pip-7MUYeK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:49:03 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)) 03:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:49:03 INFO - Running setup.py (path:/tmp/pip-KwErMZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:49:03 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)) 03:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:49:03 INFO - Running setup.py (path:/tmp/pip-gDXqRr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:49:03 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)) 03:49:03 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)) 03:49:03 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)) 03:49:03 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)) 03:49:03 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)) 03:49:03 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)) 03:49:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:49:03 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 03:49:03 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 03:49:03 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 03:49:03 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 03:49:03 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 03:49:03 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 03:49:05 INFO - Downloading blessings-1.5.1.tar.gz 03:49:05 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 03:49:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:49:05 INFO - Installing collected packages: blessings 03:49:05 INFO - Running setup.py install for blessings 03:49:05 INFO - Successfully installed blessings 03:49:05 INFO - Cleaning up... 03:49:05 INFO - Return code: 0 03:49:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:49:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:49:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:49:05 INFO - Reading from file tmpfile_stdout 03:49:05 INFO - Current package versions: 03:49:05 INFO - argparse == 1.2.1 03:49:05 INFO - blessings == 1.5.1 03:49:05 INFO - blobuploader == 1.2.4 03:49:05 INFO - docopt == 0.6.1 03:49:05 INFO - manifestparser == 1.1 03:49:05 INFO - mozInstall == 1.12 03:49:05 INFO - mozcrash == 0.16 03:49:05 INFO - mozdebug == 0.1 03:49:05 INFO - mozdevice == 0.47 03:49:05 INFO - mozfile == 1.2 03:49:05 INFO - mozhttpd == 0.7 03:49:05 INFO - mozinfo == 0.9 03:49:05 INFO - mozleak == 0.1 03:49:05 INFO - mozlog == 3.0 03:49:05 INFO - moznetwork == 0.27 03:49:05 INFO - mozprocess == 0.22 03:49:05 INFO - mozprofile == 0.27 03:49:05 INFO - mozrunner == 6.11 03:49:05 INFO - mozscreenshot == 0.1 03:49:05 INFO - mozsystemmonitor == 0.0 03:49:05 INFO - moztest == 0.7 03:49:05 INFO - mozversion == 1.4 03:49:05 INFO - psutil == 3.1.1 03:49:05 INFO - requests == 1.2.3 03:49:05 INFO - wsgiref == 0.1.2 03:49:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:49: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')]} 03:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49: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')]} 03:49:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:05 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 0x7fd49cff9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c176c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0dd70>, '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 0x2d0eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0efb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568', '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 03:49:05 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 03:49:05 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 03:49:05 INFO - Using env: {'DISPLAY': ':0', 03:49:05 INFO - 'HOME': '/home/cltbld', 03:49:05 INFO - 'LANG': 'en_US.UTF-8', 03:49:05 INFO - 'LANGUAGE': 'en_US:en', 03:49:05 INFO - 'LOGNAME': 'cltbld', 03:49:05 INFO - 'MAIL': '/var/mail/cltbld', 03:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:05 INFO - 'MOZ_NO_REMOTE': '1', 03:49:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:05 INFO - 'NO_EM_RESTART': '1', 03:49:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:05 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:05 INFO - 'SHELL': '/bin/bash', 03:49:05 INFO - 'SHLVL': '1', 03:49:05 INFO - 'TERM': 'linux', 03:49:05 INFO - 'TMOUT': '86400', 03:49:05 INFO - 'USER': 'cltbld', 03:49:05 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568', 03:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:05 INFO - '_': '/tools/buildbot/bin/python'} 03:49:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:05 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)) 03:49:05 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)) 03:49:05 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)) 03:49:05 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)) 03:49:05 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)) 03:49:05 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)) 03:49:05 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)) 03:49:05 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)) 03:49:05 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)) 03:49:05 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)) 03:49:05 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)) 03:49:05 INFO - Cleaning up... 03:49:06 INFO - Return code: 0 03:49:06 INFO - Running post-action listener: _resource_record_post_action 03:49:06 INFO - Running post-action listener: _start_resource_monitoring 03:49:06 INFO - Starting resource monitoring. 03:49:06 INFO - ##### 03:49:06 INFO - ##### Running install step. 03:49:06 INFO - ##### 03:49:06 INFO - Running pre-action listener: _resource_record_pre_action 03:49:06 INFO - Running main action method: install 03:49:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:49:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:49:06 INFO - Reading from file tmpfile_stdout 03:49:06 INFO - Detecting whether we're running mozinstall >=1.0... 03:49:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:49:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:49:06 INFO - Reading from file tmpfile_stdout 03:49:06 INFO - Output received: 03:49:06 INFO - Usage: mozinstall [options] installer 03:49:06 INFO - Options: 03:49:06 INFO - -h, --help show this help message and exit 03:49:06 INFO - -d DEST, --destination=DEST 03:49:06 INFO - Directory to install application into. [default: 03:49:06 INFO - "/builds/slave/test-pgo"] 03:49:06 INFO - --app=APP Application being installed. [default: firefox] 03:49:06 INFO - mkdir: /builds/slave/test-pgo/build/application 03:49:06 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'] 03:49:06 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 03:49:23 INFO - Reading from file tmpfile_stdout 03:49:23 INFO - Output received: 03:49:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:49:23 INFO - Running post-action listener: _resource_record_post_action 03:49:23 INFO - ##### 03:49:23 INFO - ##### Running run-tests step. 03:49:23 INFO - ##### 03:49:23 INFO - Running pre-action listener: _resource_record_pre_action 03:49:23 INFO - Running main action method: run_tests 03:49:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:49:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:49:23 INFO - Python 2.7.3 03:49:23 INFO - Return code: 0 03:49:23 INFO - grabbing minidump binary from tooltool 03:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:23 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 0x2d0dd70>, '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 0x2d0eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0efb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:49:23 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 03:49:23 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 03:49:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:49:23 INFO - Return code: 0 03:49:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:49:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:49:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:49:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:49:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:49:23 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/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:49:23 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/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost 03:49:23 INFO - Using env: {'DISPLAY': ':0', 03:49:23 INFO - 'HOME': '/home/cltbld', 03:49:23 INFO - 'LANG': 'en_US.UTF-8', 03:49:23 INFO - 'LANGUAGE': 'en_US:en', 03:49:23 INFO - 'LOGNAME': 'cltbld', 03:49:23 INFO - 'MAIL': '/var/mail/cltbld', 03:49:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:49:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:23 INFO - 'MOZ_NO_REMOTE': '1', 03:49:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:49:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:23 INFO - 'NO_EM_RESTART': '1', 03:49:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:23 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:49:23 INFO - 'SHELL': '/bin/bash', 03:49:23 INFO - 'SHLVL': '1', 03:49:23 INFO - 'TERM': 'linux', 03:49:23 INFO - 'TMOUT': '86400', 03:49:23 INFO - 'USER': 'cltbld', 03:49:23 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568', 03:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:23 INFO - '_': '/tools/buildbot/bin/python'} 03:49:23 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/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] with output_timeout 3600 03:49:23 INFO - mozversion INFO | application_buildid: 20151121023031 03:49:23 INFO - mozversion INFO | application_changeset: 25f0df4054c3bc997b0e99e0e1e786bf062db3cb 03:49:23 INFO - mozversion INFO | application_display_name: Nightly 03:49:23 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:49:23 INFO - mozversion INFO | application_name: Firefox 03:49:23 INFO - mozversion INFO | application_remotingname: firefox 03:49:23 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 03:49:23 INFO - mozversion INFO | application_vendor: Mozilla 03:49:23 INFO - mozversion INFO | application_version: 45.0a1 03:49:23 INFO - mozversion INFO | platform_buildid: 20151121023031 03:49:23 INFO - mozversion INFO | platform_changeset: 25f0df4054c3bc997b0e99e0e1e786bf062db3cb 03:49:23 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 03:49:23 INFO - mozversion INFO | platform_version: 45.0a1 03:49:23 INFO - 2015-11-21 03:49:23,287 DEBUG : using testdate: 1448106563 03:49:23 INFO - 2015-11-21 03:49:23,287 DEBUG : actual date: 1448106563 03:49:23 INFO - 2015-11-21 03:49:23,295 INFO : starting webserver on 'localhost:33211' 03:49:23 INFO - 2015-11-21 03:49:23,295 INFO : Starting test suite talos-linux64-ix-033 03:49:23 INFO - 2015-11-21 03:49:23,295 INFO : Starting test dromaeo_css 03:49:23 INFO - 2015-11-21 03:49:23,296 DEBUG : operating with platform_type : linux_ 03:49:23 INFO - 2015-11-21 03:49:23,296 INFO : Initialising browser for dromaeo_css test... 03:49:23 INFO - 2015-11-21 03:49:23,303 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpa6aXbQ/profile http://localhost:33211/getInfo.html 03:49:29 INFO - 2015-11-21 03:49:29,326 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:49:29 INFO - 2015-11-21 03:49:29,326 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:49:29 INFO - 2015-11-21 03:49:29,326 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:49:29 INFO - 2015-11-21 03:49:29,326 DEBUG : BROWSER_OUTPUT: __metrics 03:49:29 INFO - 2015-11-21 03:49:29,504 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:49:31 INFO - 2015-11-21 03:49:31,371 INFO : Browser initialized. 03:49:31 INFO - 2015-11-21 03:49:31,372 INFO : Running cycle 1/1 for dromaeo_css test... 03:49:31 INFO - 2015-11-21 03:49:31,372 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpa6aXbQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:49:43 INFO - 2015-11-21 03:49:43,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 140902400 03:49:43 INFO - 2015-11-21 03:49:43,146 DEBUG : BROWSER_OUTPUT: 03:50:34 INFO - 2015-11-21 03:50:34,817 DEBUG : BROWSER_OUTPUT: 1448106634810 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] 03:52:43 INFO - 2015-11-21 03:52:43,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33211/tests/dromaeo/cssquery-ext.html) 03:52:44 INFO - 2015-11-21 03:52:44,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 255700992 03:52:44 INFO - 2015-11-21 03:52:44,965 DEBUG : BROWSER_OUTPUT: 03:55:47 INFO - 2015-11-21 03:55:47,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/dromaeo/cssquery-ext.html (next: http://localhost:33211/tests/dromaeo/cssquery-jquery.html) 03:55:48 INFO - 2015-11-21 03:55:48,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 228274176 03:55:48 INFO - 2015-11-21 03:55:48,029 DEBUG : BROWSER_OUTPUT: 03:58:50 INFO - 2015-11-21 03:58:50,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33211/tests/dromaeo/cssquery-mootools.html) 03:58:50 INFO - 2015-11-21 03:58:50,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 221782016 03:58:50 INFO - 2015-11-21 03:58:50,596 DEBUG : BROWSER_OUTPUT: 04:01:52 INFO - 2015-11-21 04:01:52,439 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33211/tests/dromaeo/cssquery-prototype.html) 04:01:53 INFO - 2015-11-21 04:01:53,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 205111296 04:01:53 INFO - 2015-11-21 04:01:53,025 DEBUG : BROWSER_OUTPUT: 04:04:55 INFO - 2015-11-21 04:04:55,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33211/tests/dromaeo/cssquery-yui.html) 04:04:56 INFO - 2015-11-21 04:04:56,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 207720448 04:04:56 INFO - 2015-11-21 04:04:56,205 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2015-11-21 04:07:58,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/dromaeo/cssquery-yui.html (next: http://localhost:33211/tests/dromaeo/cssquery-dojo.html) 04:07:58 INFO - 2015-11-21 04:07:58,889 DEBUG : BROWSER_OUTPUT: RSS: Main: 249409536 04:07:58 INFO - 2015-11-21 04:07:58,889 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2015-11-21 04:07:58,890 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:07:58 INFO - 2015-11-21 04:07:58,890 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:07:58 INFO - 2015-11-21 04:07:58,890 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:07:58 INFO - 2015-11-21 04:07:58,890 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:07:58 INFO - 2015-11-21 04:07:58,891 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3125.2186953261685;3204.3270913108245;3206.5831441912546;3239.028291512547;3254.593175853017;5153.871153221171;5221.503957124067;5372.543333816626;5416.052190866598;5447.319085114361;5274.129768588178;5288.92066619001;5305.867353316169;5309.123994540906;5380.596455265852;4737.1946769049255;4826.565609095181;4843.370361852954;4887.193613053842;4927.3348098006845;4926.778294976734;4938.777755001016;4995.650304478688;5053.393592768873;5099.464556221599;4773.284007398884;5006.724630145341;5022;5094.108531007059;5116.872078198056;4875.024995000978;4903.53416425439;4949.282354058641;4976.651634385595;5008.499150084999;4914.950850491521;4922.606191504671;4925.581325587294;4928.704277743347;4970.776315065831;5168.689878607295;5213.061648903196;5218.6868787872845;5224;5229.424763276036;5560.193771903051;5636.689982050985;5717.799877004327;5766.308043034863;5775.971120144414;5820.097884827816;5828.388019258002;5832.1834943108;5839.240898683186;5841.269841269841;5203.427622961472;5449.482299181611;5451.727413629303;5457.290552228224;5466.890662186774;5805.796797112165;5817.127430885401;5819.272590926134;5996.040633498619;5999.730012149464;5728.79949201776;5742.684152371659;5743.59794814359;5743.770249190069;5748.626339287933;5601.467860553241;5806.9419305806405;5817.069268917037;5825.03886858672;5827;5635;5746.741396637078;5763.769449222068;5827.621204621686;5831.183634291117;5729.512991395778;5735.082386818089;5736.42635736423;5741.770329186786;5743.655380677173;4336.82652693895;4417.1386579616665;4471.28459446487;4479.7984090716;4516.458025037016;3897.1231472918935;3947.348687466536;3983.1635356574866;3992.5807790182193;4013.1171142348635;5445.156000819879;5481.232627432163;5481.780728770885;5484.725763711798;5490.176473529003;5657.264555607827;5779.566532510079;5806.274215723035;5807.390224026501;5817.360090390053;5334.413214546396;5411.053065713484;5442.700651464128;5459.317585301837;5468.207109969032;5091;5095.643304968691;5102.08162530748;5103.770330335144;5152.175651895679;5663.122216056436;5803.82588522345;6069.544784141207;6075.878482430327;6078.149059131725;5724.74238659253;5789.56578256624;5800.535957123504;5803.39064398249;5839.065749480063;5902.439268269508;5921.555883308855;5924.940750592439;5929.525637948867;5944.138099975393;5468.425815289337;5523.944760552343;5649.4633009864;5651.406602306699;5669.149627555899;5752.1659359391815;5873.4126587342635;5878.2358293421585;5883.970580147072;5908.675022873783;5671.262735844314;5724.942750572441;5725.456081672234;5725.914111288251;5730.656160630376;5453.345598528043;5516.393196748274;5580.441955804549;5703.714814259353;5724.484796368347;5535.086710692691;5613.803516876889;5613.943860561342;5618.269624948731;5661.801836935688;5644.52021578154;5681.005823980704;5683.261176047087;5692.7722891083895;5745.454181852718;5297.8145764898045;5395.028894798974;5402.054640437829;5580.079286917776;5586.050371436947 04:07:58 INFO - 2015-11-21 04:07:58,895 DEBUG : BROWSER_OUTPUT: |1;ext.html;565.3103214078824;567.6168586204313;573.7704918032789;591.7839988404234;593.4925638579017;28622.570661440095;28961.131166065;29114.272143196406;29179.562306565393;37831;41766.164676706525;42439.36340954888;42471.57528424715;42477.362839557434;42486.15027699444;8449.746507604781;8583.656653733844;8602.440841345324;8612.741617751446;8618.310535157172;7482.401407887383;7626.542407455543;8448.957755211215;10397.948010259937;10596.152307815357;10261.486925653724;10350.327228730108;10364.637237696683;10373.533191006385;10377.325473844214;7651.9234807651765;10263.640772572962;10357.135715571194;10364.170866330713;10372.325798823053;7487.251274872524;10318.7420314492;10547.261691681586;10559.683209503728;10560.313579617301;38317.233655327014;38755.61244387576;38767.612323876965;38767.806160969296;38803;3027.7880548361622;3032.9848350758325;3268.4933835255574;3584.6415358464205;3700.777953322809;28590.428191436054;28756.568651470243;28931.421371572662;29081.70918290811;29366.853165734035;3834.8657796976972;3896.5129358830145;3976.1252524444576;3982.064214909494;4077.2660921034203;280067;280514.5974270136;280532;280862;280998;52093.218601721004;55474;55863.44136558582;55913.440865591634;55947.720261398434;49259;57342.42657573454;58068;58287.4171258282;58406;14649.707005859824;14886;14891.851081489263;14945.476908308157;14955.102693838187;11268.661940141808;11402.372869492257;11403.828942565868;11407.201495895208;11411.771764564663;17304.307827687004;17982;18081.54796130081;18161.36435224787;18265.08674566293;7044.189918159374;7178.820529486805;7232.915062740631;7246;7279.636018199175;784.6351446577255;791.0783936713664;822.0833770346021;840.6133178737726;985.6303886042734;21926.561468770535;22253.22113726012;22272.888635557043;22286.331410057723;22290.331290061324;928.5960607135918;946.2760987844305;962.4946902876046;1041.505284989639;1117.921745477825;13138.4087716053;13142.540011099756;13310.933445332712;13441.932790335986;13504.932475337757;311090;313397;314947;315000;315622;49566.25650615244;49689.503104968484;49815.01479881601;49854.50145498571;49914.251286230734;1081.2701426537055;1146.558574948634;1164.2490593567102;1217.8721234270452;1243.1173866554666;25675.871620641778;25785.097521586653;26410.735892640827;27277;28243.2939176514;46713.2993005112;47197;47462.52537474581;47508.28737569008;47526.52473475221;287996;292801;298324;304827;304829;28845;28945.710542895144;29012;29165;29179.562306565844;38196.80901595474;39198.216035679696;39490.40764388479;39790.40314395229;39827.80086099667;33663.83168084144;34601.134971625914;34766.82616586901;35119;36373.27253454969;34426.48360274648;35019;35054.824725876206;35346.823265883504;35348.29303413866;33977.49033764446;34579.30841383108;34676.133096672784;34884.65115348814;34922.47616285707;30892.845535772176;31592.36815263728;32187.195320117185;32215;32297.51553726649;24132.43139196017;24468.51062978695;24580.385490362885;24782.504349913263;24817.25548233556 04:07:58 INFO - 2015-11-21 04:07:58,896 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.8392771469694;335.88076232937306;353.14362670523974;353.2722591461588;354.13767476195466;14047.297635118255;14392.568222953329;16093.195340232985;16601.33594656214;18356.72464913024;16157.515274541782;16179.19104044796;16182.676346473092;16223.26995285212;16224.269907854145;5485.204645326426;5713.8571535711735;5719.942800572004;5720.485156335929;5723.8569035774235;4334.696571240014;5682.943170568304;6120.26556813183;6655.567388119756;6668.099806526129;6501.447376972963;6598.307177746339;6619.30497297784;6637.601743895358;6647.302033286508;6620.437262832665;6655.267920528738;6655.800325990228;6659.334066593375;6661.833454163636;6258.374162583751;6351.047342898556;6357.936420635827;6410.903836442457;6427.42153206209;21515.35453936369;21947.890260548756;22036.669449958263;22054.33836984893;22055.44861378462;1039.5841663334652;1924.3745782620565;1996.3911007142815;2165.073084954392;2461.249318957717;14073.5074272401;14127;14159;14481.275936203254;14590.927045364811;1927.6410130857712;1981.2075169931998;1986.7218589397496;1993.6710442776925;2005.4886004069015;62156;68664.6566767168;68765.3123468764;70716.64641676759;71031;14777.413952558474;15219.162946038074;15230.771538426932;15236;15262.236888155549;23660.64509032366;23738.762612374;23975.28074157778;24027.51944961091;24085;8738.475691458532;8754.299656027502;8823.779405514784;8841.60212790426;8987.325950553735;7441.144268409203;7463.104427468738;7479.476436649491;7491.925080749232;7509.586972716553;6678.83302917431;7472.738454154079;7532.096148462219;7539.886901696479;7545.7358992435;1787.0350010994177;1807.9638407231782;1813.3109418420916;1820.2173065581926;2225.0654725015534;400.9498812648419;817.313456696366;835.3275613131487;855.170484629908;912.8219997100501;9154.40496367734;9824.705258842247;10422;10868.836967445495;10871.510782014828;420.80222295521054;430.3759548654401;449.1062785057777;466.1609103613482;823.6705317872779;8384.077751447336;8866.42368246062;8996.640134394682;9007.279417646572;9082.59128339213;556473;556569;571385;571854;572054;76424.65027448026;77851.99332060142;78558;79087.60456197683;79651;1082.8754693210224;1091.5524634899812;1095.6603452929617;1102.4377567440663;1120.915931305139;10077.050464583339;10400.947995259976;14159.292035397983;14229.217393043482;14649.633759156106;32853.17867053343;35328.11679707925;35350.82324588361;35409;37806.62193378031;46391.3041304374;46622;48827.51172488229;48874.75562622164;52041.47958520366;14188.148711077369;14295.57113286603;14581;14588.927055364655;14947.626309342353;17774.20016099253;18008.09959502046;18053.72919406236;18097.728534072263;18435.446936591925;14770.039947403384;14803.851961480248;15003.624909377353;15075.849241507445;15230;8506.106858779738;8695.391322607356;14614.196219208046;15343.309551070006;15369.846301537289;8671.739847804576;9745.658901938397;9769.85345219808;10062.295639305179;10089.545970431202;14290.642044063028;14477.565673029825;14499.202543859767;14751.557453276419;14846.18345990981;14718.63203419923;14797.778033329294;14987.700245994802;15430.768538471708;15506.9224653876 04:07:58 INFO - 2015-11-21 04:07:58,898 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1445.83372912115;1572.5125211184532;1625.2848746551517;1632.3715369582715;1650.7523871419285;6454.741810327587;6921.653917304134;7200.819979500515;7212.350888420041;7215.098112735908;7274.818129546751;7387.150477695053;7399.963000185005;7401.962990185055;7414.073240844895;1914.2343062774933;1947.3087054095804;1948.6882098864185;2244.5286489837154;2264.4338915271182;2263.128695452246;2312.225404489498;2312.6415405612156;2313.4794671199015;2313.90744370225;2235.0836157175563;2267.6031694453486;2284.314705588325;2284.5088306014286;2286.188403116886;1946.4549926020736;1980.6137803128395;2151.333086743107;2161.7513985891665;2240.529488807352;2208.2491952736145;2236.4185311818883;2252.177955046396;2253.966190507144;2254.8872556372116;7572.129205141424;7644.770656880302;7645.006149200624;7646.4265180111715;7652.273034061755;4550.317452382169;4580.175568397687;4623;4629.865682907709;4663.067386522709;2988.342564635798;2998.625171853518;3020.6828283030186;3033.8028028178096;3159.7788154829173;1000.974975625608;1008.6850677694708;1011.640867492037;1028.711960651019;1066.2909165404997;10477.31897426665;10480.371177729285;10482.213833962407;10497.475126243733;10499.68500944973;4109.815058322323;4215.388768628593;4256.616904478612;4261.2542805009;4267.359896015622;8949.060348663426;9007.549622518847;9021.594028268744;9043.864342034874;9045.68340108093;4647.1635105680625;4672.556107169813;4695.577398034194;4698.553637404441;4701.435827700698;4253.340732186516;4254.489461264668;4254.659627229814;4255.936160957588;4256.2764330063965;3561.9821900890847;3588.085038315213;3603.873864414733;3606.9639303606627;3643.817809109587;1188.1089183112665;1189.2685998111272;1205.9095567832449;1206.8129439936824;1212.3150420012664;952.3714348529937;979.9559019844124;980.1913421427352;1050.2685402262757;1250.2935841249664;7040.119985001875;7095.396891264197;7131.750388736369;7136.0723105995885;7136.964315178391;447.16826702333634;450.49994506098204;450.59446498151925;450.9774511274489;468.1035816411602;5535.363433205152;5600.467955544217;5655.406182350876;5672.546196304285;5674.319081710221;8893.64425422976;8996.190342869173;9173.357864949523;9174.633014679472;9193.448393096436;8842.867356989651;8903.06517815633;8953.283737301;8964.103589641114;8969.37214394986;6998.68505917235;7001.754938577125;7024.508284420143;7042.225355210922;7082.433405327562;6679.098321726505;6726.6636668167375;6765.1205343305055;6772.018057381553;6780.69486873082;8013.519188848688;8017.679292828221;8102.797430064295;8206.794830129056;8265.917340826514;7969.521828690297;8165.38759593021;8291.046529649167;8345.66617335324;8351.373646976379;6659.800205993828;6694.364035416627;6724.7646332378135;6726;6730.831729206809;7318.3047610476915;7380.630968451664;7401;7404.777856664308;7413.406927445683;6667.133272674521;6820.215675197416;6835.863282734417;6932.376086152271;6957.582545047313;6034.487068599218;6169.413905678954;6528.9020664689115;6664.633445160563;6785.762498312535;6727.293634168342;6771.93228067713;6785.796426107225;6808.693608787517;6839.179298484214;5881.941180588139;6231.22109736283;6420.711068002044;6434.806955791334;6438.484921206386;6455.225372955276;6485.708143133476;6503.6097834130105;6504.089427480062;6506.869862602627 04:07:58 INFO - 2015-11-21 04:07:58,901 DEBUG : BROWSER_OUTPUT: |4;prototype.html;325.6092688773472;326.9427850126229;334.8074856957249;334.9681780230877;339.20964153522294;5930.229070220876;6050.152978583002;6070.635761854281;6108.664023478706;6135.233095863017;5867.237259156314;5982.312034116078;5994;6021.066734656135;6035.879282414349;4628.791704373311;4635.420572428447;4655.55772201642;4663.300504924255;4663.790129444166;4449.354843547683;4525.909481810362;4568.977155114219;4581.129585378767;4658.673892827504;4450.888727781815;4547.045120524694;4562.156001139783;4588.174128656857;4592.724436533818;4577.656675749316;4581.702189357681;4582.793774280165;4584.770761461947;4590.586847183753;3968.464257325253;3993.820278087493;3993.9815347086596;3997.2605068062503;3998.4002399639994;5595.608307418483;5706.115552089433;5721.456461636138;5736.971315143439;5760.9711951440395;5365;5414.242006119146;5414.512693857571;5419.756110975016;5423;6188.783392581283;6400.295967443578;6432.292447830735;6444.935550644481;6445.4199122079235;4334.609885110355;4400.09797991411;4450.643948484146;4466.062126953344;4484.977575112136;6575.145231119972;6605.405513503808;6671.865782816933;6686.665666716644;6690.799276021728;4620.838270660511;4621.884452888705;4625.306204069417;4625.676202665781;4631.745254010994;4506.774661266923;4644.698094623838;4654.115718013567;4682.086993036393;4686.718796872198;5364.704941228192;5370.4361042090795;5373.38206106295;5373.838784836461;5377.569794416438;6482.448991835652;6488.124103246096;6488.253850807123;6489.318621544764;6492.318306577836;1648.3900956646119;1665.7168281392192;1666.7749853769828;1667.624784423495;1670.089801058426;1106.1151079136819;1108.0581505720234;1131.2420678145497;1139.0432037088885;1152.124385467051;6179.938200618026;6228.937710622836;6231.40801623845;6233.812985610439;6239.407256310643;6625.13873196491;6625.834354141089;6640.269570347258;6646.368594983469;6651.439195909609;6170.444659980533;6189.938100618936;6219.502439804804;6221.720022598994;6239.251289845248;3599.3161299353037;3623.202895363069;3633.364161271767;3640.7087433005295;3643.216708407705;6931.514793964374;6939.271376505495;6945.305469453015;6945.965270173718;6959.8956015659805;6787.830304242433;6909.412699920463;6920.031195632616;6925.065116209247;6930.618815965069;6964.79105626832;6984.825379365557;6989.196242431982;6991.370776630128;6996.405305549085;6418.550701450854;6537.1501704778075;6557.180352455943;6754.898676519954;6763.628000460022;6617.139771829631;6653.401193892573;6658.234303055211;6662.766803161866;6669.399754022162;6934.098567186234;6936.549124306904;6938.375546200866;6941.167059952636;6953.130858642669;4356.390105385312;4506.954930450785;4516.706414083074;4517.344984977226;4550.590446859798;6659.567128136656;6666.066750654815;6668.466522678077;6670.099536562502;6674.332566743481;6473.8705225896165;6482.740690372332;6483.610983341015;6489.772857949949;6490.286068532552;6338;6452.935470645421;6453.967730161319;6528.836779080561;6552.57408268461;6418.518611104279;6427.550071495138;6429.292777794532;6431.774887879089;6433.260175079926;6584.637844918576;6586.341365863375;6587.571807832475;6592.538522303393;6594;6220.440160385587;6405.071264666504;6414.839629009125;6430.807075787547;6434.099226108255 04:07:58 INFO - 2015-11-21 04:07:58,901 DEBUG : BROWSER_OUTPUT: |5;yui.html;629.7908016608112;651.7555916531301;692.6155983429195;702.0837806662304;703.8345988692656;13070.869291307095;13351.198928064323;13381.933090334534;13385.397657105417;13436.059475836695;12804.871951280484;14151.71696566068;14430.711385772305;14439.639009024753;14449.63875903103;632.9398707122816;637.7927173668576;639.5363361562853;756.3193126186421;765.2653452685429;750.4671683104975;760.9657565409542;763.1986414265027;765.6210175962906;765.9042619672513;787.3661702329622;796.4623878881761;796.8685166947475;797.5095316380414;797.6490344248512;652.451940370089;659.3044338223173;731.7987553422798;765.4221063097326;790.7074382478462;550.606316483712;551.7903196785196;552.1303946284578;552.3151292397439;556.4657928388751;13415.195088294733;13577.11748736329;13610.523631672844;13614.591562253148;13620.659483512893;11213.887861121366;11401.657950261506;11819.586314478953;11935.224210426295;12217.389130543526;10177.796444071151;10318.277720559563;10403.427811470367;10454.425006624633;10529.736756581071;3563.2339047104997;3627.3289441453417;3627.4014787560022;3656.0494271489606;3657.817109144532;50270.24594631083;50940.99999999963;51011.23483147756;51014.74492627513;51024.48975510272;8994.550272486349;9110.635574576943;9116.954415227881;9171.770705732277;9773.12041916231;17397.13014349303;17475.825241747672;17540.386086486913;17545.894492660707;17566;7315.597642129627;7319.377852882458;7323.523970941872;7489.251074892467;7601.809954751065;4030.1536677298095;4187.685923555685;4256.276433006335;4269.935950960738;4282.464691913511;3064.55563943227;3087.0893086539527;3089.7991630543943;3090.629124505074;3097.1947293703797;515.3995595131704;529.1401472607014;530.7558523079426;543.7118327286545;544.316882312695;516.4499807704782;547.6905548365161;620.534599050712;623.1494010675486;635.4510061307649;8497.235248827636;9024.593893274818;9039.322050846213;9071.909280907239;9239.404547293105;462.49818946442815;502.7461132128252;539.5926075812815;673.7504452095487;688.2051230828401;4068.4304197412384;4188.727732697365;4244.257254980428;4301.333293339538;4354.738715677006;55927.440725593035;56263.43736562582;57257.42742572604;57595;57659.67552433584;49171.262431062845;49762;50016.24975625369;50042;50278.24582631263;44796.77601611971;45171.09657806825;45356.54643453589;46060.53939460563;46507.30239046417;8543.401961862859;8630.309575234092;8741.34439916996;8806.471611703319;8824.029356770621;33824;33976.83011584926;34744;35067.142614312914;35305.646943530235;43502.56497435112;43504.782476087414;44343.77828110839;44377.55622443734;44536;10566.207534435101;10625.362478251329;10819.524147269103;11027.448627568428;11152.330860148093;11545.769084618429;11722.41387930583;11924;11937.164398492023;12356.62930112098;10673.146148308271;10860.239783215415;10894.182936279652;10965.122790176927;11123.83314250303;10673.733156670834;10765.407902565434;10815.56737730482;10832.783344333227;10916.836247456136;11057.06014988735;11089.778204435705;11197.44012799373;11277.32336059839;11519.712007199887;5695.629784064023;9914.553845076845;10093.243006774668;10109.898901011189;10191.439470829175;9203.038879785385;9475.620975160917;9718.854217186888;9755.637511602605;9902.108810207115 04:07:58 INFO - 2015-11-21 04:07:58,901 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:07:58 INFO - 2015-11-21 04:07:58,902 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:07:58 INFO - 2015-11-21 04:07:58,902 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,921 04:07:58 INFO - 2015-11-21 04:07:58,902 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:07:58 INFO - 2015-11-21 04:07:58,902 DEBUG : BROWSER_OUTPUT: __startTimestamp1448107678888__endTimestamp 04:07:58 INFO - 2015-11-21 04:07:58,902 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2015-11-21 04:07:58,902 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:07:58 INFO - 2015-11-21 04:07:58,902 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:07:58 INFO - 2015-11-21 04:07:58,903 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2015-11-21 04:07:58,903 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5362.68 Median:5535.09 stddev:591.46 (10.7%) stddev-sans-first:566.63 04:07:58 INFO - 2015-11-21 04:07:58,903 DEBUG : BROWSER_OUTPUT: Values: 3125.2 3204.3 3206.6 3239.0 3254.6 5153.9 5221.5 5372.5 5416.1 5447.3 5274.1 5288.9 5305.9 5309.1 5380.6 4737.2 4826.6 4843.4 4887.2 4927.3 4926.8 4938.8 4995.7 5053.4 5099.5 4773.3 5006.7 5022.0 5094.1 5116.9 4875.0 4903.5 4949.3 4976.7 5008.5 4915.0 4922.6 4925.6 4928.7 4970.8 5168.7 5213.1 5218.7 5224.0 5229.4 5560.2 5636.7 5717.8 5766.3 5776.0 5820.1 5828.4 5832.2 5839.2 5841.3 5203.4 5449.5 5451.7 5457.3 5466.9 5805.8 5817.1 5819.3 5996.0 5999.7 5728.8 5742.7 5743.6 5743.8 5748.6 5601.5 5806.9 5817.1 5825.0 5827.0 5635.0 5746.7 5763.8 5827.6 5831.2 5729.5 5735.1 5736.4 5741.8 5743.7 4336.8 4417.1 4471.3 4479.8 4516.5 3897.1 3947.3 3983.2 3992.6 4013.1 5445.2 5481.2 5481.8 5484.7 5490.2 5657.3 5779.6 5806.3 5807.4 5817.4 5334.4 5411.1 5442.7 5459.3 5468.2 5091.0 5095.6 5102.1 5103.8 5152.2 5663.1 5803.8 6069.5 6075.9 6078.1 5724.7 5789.6 5800.5 5803.4 5839.1 5902.4 5921.6 5924.9 5929.5 5944.1 5468.4 5523.9 5649.5 5651.4 5669.1 5752.2 5873.4 5878.2 5884.0 5908.7 5671.3 5724.9 5725.5 5725.9 5730.7 5453.3 5516.4 5580.4 5703.7 5724.5 5535.1 5613.8 5613.9 5618.3 5661.8 5644.5 5681.0 5683.3 5692.8 5745.5 5297.8 5395.0 5402.1 5580.1 5586.1 04:07:58 INFO - 2015-11-21 04:07:58,903 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2015-11-21 04:07:58,903 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45630.59 Median:32201.10 stddev:77916.05 (242.0%) stddev-sans-first:78061.16 04:07:58 INFO - 2015-11-21 04:07:58,904 DEBUG : BROWSER_OUTPUT: Values: 565.3 567.6 573.8 591.8 593.5 28622.6 28961.1 29114.3 29179.6 37831.0 41766.2 42439.4 42471.6 42477.4 42486.2 8449.7 8583.7 8602.4 8612.7 8618.3 7482.4 7626.5 8449.0 10397.9 10596.2 10261.5 10350.3 10364.6 10373.5 10377.3 7651.9 10263.6 10357.1 10364.2 10372.3 7487.3 10318.7 10547.3 10559.7 10560.3 38317.2 38755.6 38767.6 38767.8 38803.0 3027.8 3033.0 3268.5 3584.6 3700.8 28590.4 28756.6 28931.4 29081.7 29366.9 3834.9 3896.5 3976.1 3982.1 4077.3 280067.0 280514.6 280532.0 280862.0 280998.0 52093.2 55474.0 55863.4 55913.4 55947.7 49259.0 57342.4 58068.0 58287.4 58406.0 14649.7 14886.0 14891.9 14945.5 14955.1 11268.7 11402.4 11403.8 11407.2 11411.8 17304.3 17982.0 18081.5 18161.4 18265.1 7044.2 7178.8 7232.9 7246.0 7279.6 784.6 791.1 822.1 840.6 985.6 21926.6 22253.2 22272.9 22286.3 22290.3 928.6 946.3 962.5 1041.5 1117.9 13138.4 13142.5 13310.9 13441.9 13504.9 311090.0 313397.0 314947.0 315000.0 315622.0 49566.3 49689.5 49815.0 49854.5 49914.3 1081.3 1146.6 1164.2 1217.9 1243.1 25675.9 25785.1 26410.7 27277.0 28243.3 46713.3 47197.0 47462.5 47508.3 47526.5 287996.0 292801.0 298324.0 304827.0 304829.0 28845.0 28945.7 29012.0 29165.0 29179.6 38196.8 39198.2 39490.4 39790.4 39827.8 33663.8 34601.1 34766.8 35119.0 36373.3 34426.5 35019.0 35054.8 35346.8 35348.3 33977.5 34579.3 34676.1 34884.7 34922.5 30892.8 31592.4 32187.2 32215.0 32297.5 24132.4 24468.5 24580.4 24782.5 24817.3 04:07:58 INFO - 2015-11-21 04:07:58,904 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2015-11-21 04:07:58,905 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30501.34 Median:344.51 stddev:92327.69 (26799.5%) stddev-sans-first:92558.90 04:07:58 INFO - 2015-11-21 04:07:58,906 DEBUG : BROWSER_OUTPUT: Values: 334.8 335.9 353.1 353.3 354.1 14047.3 14392.6 16093.2 16601.3 18356.7 16157.5 16179.2 16182.7 16223.3 16224.3 5485.2 5713.9 5719.9 5720.5 5723.9 4334.7 5682.9 6120.3 6655.6 6668.1 6501.4 6598.3 6619.3 6637.6 6647.3 6620.4 6655.3 6655.8 6659.3 6661.8 6258.4 6351.0 6357.9 6410.9 6427.4 21515.4 21947.9 22036.7 22054.3 22055.4 1039.6 1924.4 1996.4 2165.1 2461.2 14073.5 14127.0 14159.0 14481.3 14590.9 1927.6 1981.2 1986.7 1993.7 2005.5 62156.0 68664.7 68765.3 70716.6 71031.0 14777.4 15219.2 15230.8 15236.0 15262.2 23660.6 23738.8 23975.3 24027.5 24085.0 8738.5 8754.3 8823.8 8841.6 8987.3 7441.1 7463.1 7479.5 7491.9 7509.6 6678.8 7472.7 7532.1 7539.9 7545.7 1787.0 1808.0 1813.3 1820.2 2225.1 400.9 817.3 835.3 855.2 912.8 9154.4 9824.7 10422.0 10868.8 10871.5 420.8 430.4 449.1 466.2 823.7 8384.1 8866.4 8996.6 9007.3 9082.6 556473.0 556569.0 571385.0 571854.0 572054.0 76424.7 77852.0 78558.0 79087.6 79651.0 1082.9 1091.6 1095.7 1102.4 1120.9 10077.1 10400.9 14159.3 14229.2 14649.6 32853.2 35328.1 35350.8 35409.0 37806.6 46391.3 46622.0 48827.5 48874.8 52041.5 14188.1 14295.6 14581.0 14588.9 14947.6 17774.2 18008.1 18053.7 18097.7 18435.4 14770.0 14803.9 15003.6 15075.8 15230.0 8506.1 8695.4 14614.2 15343.3 15369.8 8671.7 9745.7 9769.9 10062.3 10089.5 14290.6 14477.6 14499.2 14751.6 14846.2 14718.6 14797.8 14987.7 15430.8 15506.9 04:07:58 INFO - 2015-11-21 04:07:58,906 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2015-11-21 04:07:58,906 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5277.76 Median:6325.97 stddev:2749.21 (43.5%) stddev-sans-first:2741.83 04:07:58 INFO - 2015-11-21 04:07:58,906 DEBUG : BROWSER_OUTPUT: Values: 1445.8 1572.5 1625.3 1632.4 1650.8 6454.7 6921.7 7200.8 7212.4 7215.1 7274.8 7387.2 7400.0 7402.0 7414.1 1914.2 1947.3 1948.7 2244.5 2264.4 2263.1 2312.2 2312.6 2313.5 2313.9 2235.1 2267.6 2284.3 2284.5 2286.2 1946.5 1980.6 2151.3 2161.8 2240.5 2208.2 2236.4 2252.2 2254.0 2254.9 7572.1 7644.8 7645.0 7646.4 7652.3 4550.3 4580.2 4623.0 4629.9 4663.1 2988.3 2998.6 3020.7 3033.8 3159.8 1001.0 1008.7 1011.6 1028.7 1066.3 10477.3 10480.4 10482.2 10497.5 10499.7 4109.8 4215.4 4256.6 4261.3 4267.4 8949.1 9007.5 9021.6 9043.9 9045.7 4647.2 4672.6 4695.6 4698.6 4701.4 4253.3 4254.5 4254.7 4255.9 4256.3 3562.0 3588.1 3603.9 3607.0 3643.8 1188.1 1189.3 1205.9 1206.8 1212.3 952.4 980.0 980.2 1050.3 1250.3 7040.1 7095.4 7131.8 7136.1 7137.0 447.2 450.5 450.6 451.0 468.1 5535.4 5600.5 5655.4 5672.5 5674.3 8893.6 8996.2 9173.4 9174.6 9193.4 8842.9 8903.1 8953.3 8964.1 8969.4 6998.7 7001.8 7024.5 7042.2 7082.4 6679.1 6726.7 6765.1 6772.0 6780.7 8013.5 8017.7 8102.8 8206.8 8265.9 7969.5 8165.4 8291.0 8345.7 8351.4 6659.8 6694.4 6724.8 6726.0 6730.8 7318.3 7380.6 7401.0 7404.8 7413.4 6667.1 6820.2 6835.9 6932.4 6957.6 6034.5 6169.4 6528.9 6664.6 6785.8 6727.3 6771.9 6785.8 6808.7 6839.2 5881.9 6231.2 6420.7 6434.8 6438.5 6455.2 6485.7 6503.6 6504.1 6506.9 04:07:58 INFO - 2015-11-21 04:07:58,906 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2015-11-21 04:07:58,906 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5400.08 Median:6175.19 stddev:1637.87 (26.5%) stddev-sans-first:1597.57 04:07:58 INFO - 2015-11-21 04:07:58,907 DEBUG : BROWSER_OUTPUT: Values: 325.6 326.9 334.8 335.0 339.2 5930.2 6050.2 6070.6 6108.7 6135.2 5867.2 5982.3 5994.0 6021.1 6035.9 4628.8 4635.4 4655.6 4663.3 4663.8 4449.4 4525.9 4569.0 4581.1 4658.7 4450.9 4547.0 4562.2 4588.2 4592.7 4577.7 4581.7 4582.8 4584.8 4590.6 3968.5 3993.8 3994.0 3997.3 3998.4 5595.6 5706.1 5721.5 5737.0 5761.0 5365.0 5414.2 5414.5 5419.8 5423.0 6188.8 6400.3 6432.3 6444.9 6445.4 4334.6 4400.1 4450.6 4466.1 4485.0 6575.1 6605.4 6671.9 6686.7 6690.8 4620.8 4621.9 4625.3 4625.7 4631.7 4506.8 4644.7 4654.1 4682.1 4686.7 5364.7 5370.4 5373.4 5373.8 5377.6 6482.4 6488.1 6488.3 6489.3 6492.3 1648.4 1665.7 1666.8 1667.6 1670.1 1106.1 1108.1 1131.2 1139.0 1152.1 6179.9 6228.9 6231.4 6233.8 6239.4 6625.1 6625.8 6640.3 6646.4 6651.4 6170.4 6189.9 6219.5 6221.7 6239.3 3599.3 3623.2 3633.4 3640.7 3643.2 6931.5 6939.3 6945.3 6946.0 6959.9 6787.8 6909.4 6920.0 6925.1 6930.6 6964.8 6984.8 6989.2 6991.4 6996.4 6418.6 6537.2 6557.2 6754.9 6763.6 6617.1 6653.4 6658.2 6662.8 6669.4 6934.1 6936.5 6938.4 6941.2 6953.1 4356.4 4507.0 4516.7 4517.3 4550.6 6659.6 6666.1 6668.5 6670.1 6674.3 6473.9 6482.7 6483.6 6489.8 6490.3 6338.0 6452.9 6454.0 6528.8 6552.6 6418.5 6427.6 6429.3 6431.8 6433.3 6584.6 6586.3 6587.6 6592.5 6594.0 6220.4 6405.1 6414.8 6430.8 6434.1 04:07:58 INFO - 2015-11-21 04:07:58,907 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2015-11-21 04:07:58,907 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13673.64 Median:45708.54 stddev:15916.66 (34.8%) stddev-sans-first:15931.17 04:07:58 INFO - 2015-11-21 04:07:58,908 DEBUG : BROWSER_OUTPUT: Values: 629.8 651.8 692.6 702.1 703.8 13070.9 13351.2 13381.9 13385.4 13436.1 12804.9 14151.7 14430.7 14439.6 14449.6 632.9 637.8 639.5 756.3 765.3 750.5 761.0 763.2 765.6 765.9 787.4 796.5 796.9 797.5 797.6 652.5 659.3 731.8 765.4 790.7 550.6 551.8 552.1 552.3 556.5 13415.2 13577.1 13610.5 13614.6 13620.7 11213.9 11401.7 11819.6 11935.2 12217.4 10177.8 10318.3 10403.4 10454.4 10529.7 3563.2 3627.3 3627.4 3656.0 3657.8 50270.2 50941.0 51011.2 51014.7 51024.5 8994.6 9110.6 9117.0 9171.8 9773.1 17397.1 17475.8 17540.4 17545.9 17566.0 7315.6 7319.4 7323.5 7489.3 7601.8 4030.2 4187.7 4256.3 4269.9 4282.5 3064.6 3087.1 3089.8 3090.6 3097.2 515.4 529.1 530.8 543.7 544.3 516.4 547.7 620.5 623.1 635.5 8497.2 9024.6 9039.3 9071.9 9239.4 462.5 502.7 539.6 673.8 688.2 4068.4 4188.7 4244.3 4301.3 4354.7 55927.4 56263.4 57257.4 57595.0 57659.7 49171.3 49762.0 50016.2 50042.0 50278.2 44796.8 45171.1 45356.5 46060.5 46507.3 8543.4 8630.3 8741.3 8806.5 8824.0 33824.0 33976.8 34744.0 35067.1 35305.6 43502.6 43504.8 44343.8 44377.6 44536.0 10566.2 10625.4 10819.5 11027.4 11152.3 11545.8 11722.4 11924.0 11937.2 12356.6 10673.1 10860.2 10894.2 10965.1 11123.8 10673.7 10765.4 10815.6 10832.8 10916.8 11057.1 11089.8 11197.4 11277.3 11519.7 5695.6 9914.6 10093.2 10109.9 10191.4 9203.0 9475.6 9718.9 9755.6 9902.1 04:07:58 INFO - 2015-11-21 04:07:58,908 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:07:58 INFO - 2015-11-21 04:07:58,908 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-21 04:07:59,649 INFO : Browser exited with error code: 0 04:07:59 INFO - 2015-11-21 04:07:59,665 INFO : Completed test dromaeo_css (00:18:36) 04:07:59 INFO - 2015-11-21 04:07:59,665 INFO : Starting test kraken 04:07:59 INFO - 2015-11-21 04:07:59,665 DEBUG : operating with platform_type : linux_ 04:07:59 INFO - 2015-11-21 04:07:59,665 INFO : Initialising browser for kraken test... 04:07:59 INFO - 2015-11-21 04:07:59,672 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHmACi_/profile http://localhost:33211/getInfo.html 04:08:04 INFO - 2015-11-21 04:08:04,358 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:08:04 INFO - 2015-11-21 04:08:04,358 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:08:04 INFO - 2015-11-21 04:08:04,358 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:08:04 INFO - 2015-11-21 04:08:04,358 DEBUG : BROWSER_OUTPUT: __metrics 04:08:04 INFO - 2015-11-21 04:08:04,515 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:08:06 INFO - 2015-11-21 04:08:06,092 INFO : Browser initialized. 04:08:06 INFO - 2015-11-21 04:08:06,092 INFO : Running cycle 1/1 for kraken test... 04:08:06 INFO - 2015-11-21 04:08:06,092 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHmACi_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:08:17 INFO - 2015-11-21 04:08:17,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 141750272 04:08:17 INFO - 2015-11-21 04:08:17,865 DEBUG : BROWSER_OUTPUT: 04:08:20 INFO - 2015-11-21 04:08:20,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33211/tests/kraken/driver.html?testName=audio-beat-detection) 04:08:20 INFO - 2015-11-21 04:08:20,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 178937856 04:08:20 INFO - 2015-11-21 04:08:20,922 DEBUG : BROWSER_OUTPUT: 04:08:23 INFO - 2015-11-21 04:08:23,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33211/tests/kraken/driver.html?testName=audio-dft) 04:08:24 INFO - 2015-11-21 04:08:24,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 166801408 04:08:24 INFO - 2015-11-21 04:08:24,128 DEBUG : BROWSER_OUTPUT: 04:08:27 INFO - 2015-11-21 04:08:27,087 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33211/tests/kraken/driver.html?testName=audio-fft) 04:08:27 INFO - 2015-11-21 04:08:27,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 151531520 04:08:27 INFO - 2015-11-21 04:08:27,641 DEBUG : BROWSER_OUTPUT: 04:08:29 INFO - 2015-11-21 04:08:29,626 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33211/tests/kraken/driver.html?testName=audio-oscillator) 04:08:30 INFO - 2015-11-21 04:08:30,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 153989120 04:08:30 INFO - 2015-11-21 04:08:30,192 DEBUG : BROWSER_OUTPUT: 04:08:32 INFO - 2015-11-21 04:08:32,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33211/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:08:32 INFO - 2015-11-21 04:08:32,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 155766784 04:08:32 INFO - 2015-11-21 04:08:32,920 DEBUG : BROWSER_OUTPUT: 04:08:35 INFO - 2015-11-21 04:08:35,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33211/tests/kraken/driver.html?testName=imaging-darkroom) 04:08:36 INFO - 2015-11-21 04:08:36,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 154906624 04:08:36 INFO - 2015-11-21 04:08:36,400 DEBUG : BROWSER_OUTPUT: 04:08:39 INFO - 2015-11-21 04:08:39,851 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33211/tests/kraken/driver.html?testName=imaging-desaturate) 04:08:40 INFO - 2015-11-21 04:08:40,427 DEBUG : BROWSER_OUTPUT: RSS: Main: 157454336 04:08:40 INFO - 2015-11-21 04:08:40,427 DEBUG : BROWSER_OUTPUT: 04:08:43 INFO - 2015-11-21 04:08:43,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33211/tests/kraken/driver.html?testName=json-parse-financial) 04:08:43 INFO - 2015-11-21 04:08:43,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 156168192 04:08:43 INFO - 2015-11-21 04:08:43,756 DEBUG : BROWSER_OUTPUT: 04:08:45 INFO - 2015-11-21 04:08:45,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33211/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:08:45 INFO - 2015-11-21 04:08:45,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 168419328 04:08:45 INFO - 2015-11-21 04:08:45,871 DEBUG : BROWSER_OUTPUT: 04:08:47 INFO - 2015-11-21 04:08:47,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33211/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:08:48 INFO - 2015-11-21 04:08:48,275 DEBUG : BROWSER_OUTPUT: RSS: Main: 167284736 04:08:48 INFO - 2015-11-21 04:08:48,276 DEBUG : BROWSER_OUTPUT: 04:08:50 INFO - 2015-11-21 04:08:50,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33211/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:08:50 INFO - 2015-11-21 04:08:50,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 171032576 04:08:50 INFO - 2015-11-21 04:08:50,874 DEBUG : BROWSER_OUTPUT: 04:08:53 INFO - 2015-11-21 04:08:53,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33211/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:08:53 INFO - 2015-11-21 04:08:53,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 181727232 04:08:53 INFO - 2015-11-21 04:08:53,900 DEBUG : BROWSER_OUTPUT: 04:08:56 INFO - 2015-11-21 04:08:56,548 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33211/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:08:57 INFO - 2015-11-21 04:08:57,114 DEBUG : BROWSER_OUTPUT: RSS: Main: 179789824 04:08:57 INFO - 2015-11-21 04:08:57,114 DEBUG : BROWSER_OUTPUT: 04:08:58 INFO - 2015-11-21 04:08:58,764 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33211/tests/kraken/driver.html?testName=ai-astar) 04:08:59 INFO - 2015-11-21 04:08:59,014 DEBUG : BROWSER_OUTPUT: RSS: Main: 238571520 04:08:59 INFO - 2015-11-21 04:08:59,014 DEBUG : BROWSER_OUTPUT: 04:08:59 INFO - 2015-11-21 04:08:59,018 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:08:59 INFO - 2015-11-21 04:08:59,018 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:08:59 INFO - 2015-11-21 04:08:59,018 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:08:59 INFO - 2015-11-21 04:08:59,018 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:08:59 INFO - 2015-11-21 04:08:59,019 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;111;104;108;110;111;99;109;110;109 04:08:59 INFO - 2015-11-21 04:08:59,019 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;122;164;172;129;157;156;130;171;123 04:08:59 INFO - 2015-11-21 04:08:59,019 DEBUG : BROWSER_OUTPUT: |2;audio-dft;167;164;164;162;164;163;168;166;165;165 04:08:59 INFO - 2015-11-21 04:08:59,019 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;74;94;72;73;72;105;91;74 04:08:59 INFO - 2015-11-21 04:08:59,019 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;89;141;89;90;90;134;89;91;134 04:08:59 INFO - 2015-11-21 04:08:59,019 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;110;110;110;109;109;109 04:08:59 INFO - 2015-11-21 04:08:59,019 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;147;145;147;145;146;146;147;145 04:08:59 INFO - 2015-11-21 04:08:59,020 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;96;96;96;95;95;96 04:08:59 INFO - 2015-11-21 04:08:59,020 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;58;58;57;60;58;59;66;56;57 04:08:59 INFO - 2015-11-21 04:08:59,020 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;69;69;69;71;69;68 04:08:59 INFO - 2015-11-21 04:08:59,020 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;83;84;85;84;84;86;85;86;86 04:08:59 INFO - 2015-11-21 04:08:59,020 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;124;120;129;132;119;132;123;132;115 04:08:59 INFO - 2015-11-21 04:08:59,020 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;153;142;154;153;158;143;166;151;169;155 04:08:59 INFO - 2015-11-21 04:08:59,020 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;66;67;69;68;66;66;67;66;66 04:08:59 INFO - 2015-11-21 04:08:59,021 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:08:59 INFO - 2015-11-21 04:08:59,021 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:08:59 INFO - 2015-11-21 04:08:59,021 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,910 04:08:59 INFO - 2015-11-21 04:08:59,021 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:08:59 INFO - 2015-11-21 04:08:59,021 DEBUG : BROWSER_OUTPUT: __startTimestamp1448107739016__endTimestamp 04:08:59 INFO - 2015-11-21 04:08:59,021 DEBUG : BROWSER_OUTPUT: 04:08:59 INFO - 2015-11-21 04:08:59,022 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:08:59 INFO - 2015-11-21 04:08:59,022 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:08:59 INFO - 2015-11-21 04:08:59,022 DEBUG : BROWSER_OUTPUT: 04:08:59 INFO - 2015-11-21 04:08:59,022 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.90 Median:110.00 stddev:3.73 (3.4%) stddev-sans-first:3.95 04:08:59 INFO - 2015-11-21 04:08:59,022 DEBUG : BROWSER_OUTPUT: Values: 108.0 111.0 104.0 108.0 110.0 111.0 99.0 109.0 110.0 109.0 04:08:59 INFO - 2015-11-21 04:08:59,023 DEBUG : BROWSER_OUTPUT: 04:08:59 INFO - 2015-11-21 04:08:59,023 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.10 Median:156.50 stddev:19.68 (12.6%) stddev-sans-first:20.87 04:08:59 INFO - 2015-11-21 04:08:59,023 DEBUG : BROWSER_OUTPUT: Values: 147.0 122.0 164.0 172.0 129.0 157.0 156.0 130.0 171.0 123.0 04:08:59 INFO - 2015-11-21 04:08:59,023 DEBUG : BROWSER_OUTPUT: 04:08:59 INFO - 2015-11-21 04:08:59,023 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.80 Median:165.00 stddev:1.81 (1.1%) stddev-sans-first:1.74 04:08:59 INFO - 2015-11-21 04:08:59,023 DEBUG : BROWSER_OUTPUT: Values: 167.0 164.0 164.0 162.0 164.0 163.0 168.0 166.0 165.0 165.0 04:08:59 INFO - 2015-11-21 04:08:59,023 DEBUG : BROWSER_OUTPUT: 04:08:59 INFO - 2015-11-21 04:08:59,023 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.80 Median:73.50 stddev:12.18 (16.6%) stddev-sans-first:12.50 04:08:59 INFO - 2015-11-21 04:08:59,023 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 74.0 94.0 72.0 73.0 72.0 105.0 91.0 74.0 04:08:59 INFO - 2015-11-21 04:08:59,023 DEBUG : BROWSER_OUTPUT: 04:08:59 INFO - 2015-11-21 04:08:59,023 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.70 Median:89.50 stddev:22.61 (25.3%) stddev-sans-first:23.43 04:08:59 INFO - 2015-11-21 04:08:59,024 DEBUG : BROWSER_OUTPUT: Values: 90.0 89.0 141.0 89.0 90.0 90.0 134.0 89.0 91.0 134.0 04:08:59 INFO - 2015-11-21 04:08:59,024 DEBUG : BROWSER_OUTPUT: 04:08:59 INFO - 2015-11-21 04:08:59,024 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:08:59 INFO - 2015-11-21 04:08:59,024 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 110.0 110.0 110.0 109.0 109.0 109.0 04:08:59 INFO - 2015-11-21 04:08:59,024 DEBUG : BROWSER_OUTPUT: 04:08:59 INFO - 2015-11-21 04:08:59,024 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 04:08:59 INFO - 2015-11-21 04:08:59,024 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 147.0 145.0 147.0 145.0 146.0 146.0 147.0 145.0 04:08:59 INFO - 2015-11-21 04:08:59,024 DEBUG : BROWSER_OUTPUT: 04:08:59 INFO - 2015-11-21 04:08:59,024 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:08:59 INFO - 2015-11-21 04:08:59,024 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 04:08:59 INFO - 2015-11-21 04:08:59,024 DEBUG : BROWSER_OUTPUT: 04:08:59 INFO - 2015-11-21 04:08:59,024 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.70 Median:58.00 stddev:2.79 (4.8%) stddev-sans-first:2.95 04:08:59 INFO - 2015-11-21 04:08:59,025 DEBUG : BROWSER_OUTPUT: Values: 58.0 58.0 58.0 57.0 60.0 58.0 59.0 66.0 56.0 57.0 04:08:59 INFO - 2015-11-21 04:08:59,025 DEBUG : BROWSER_OUTPUT: 04:08:59 INFO - 2015-11-21 04:08:59,025 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 04:08:59 INFO - 2015-11-21 04:08:59,025 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 69.0 69.0 69.0 71.0 69.0 68.0 04:08:59 INFO - 2015-11-21 04:08:59,025 DEBUG : BROWSER_OUTPUT: 04:08:59 INFO - 2015-11-21 04:08:59,025 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.50 stddev:1.10 (1.3%) stddev-sans-first:1.09 04:08:59 INFO - 2015-11-21 04:08:59,025 DEBUG : BROWSER_OUTPUT: Values: 86.0 83.0 84.0 85.0 84.0 84.0 86.0 85.0 86.0 86.0 04:08:59 INFO - 2015-11-21 04:08:59,026 DEBUG : BROWSER_OUTPUT: 04:08:59 INFO - 2015-11-21 04:08:59,026 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:126.50 stddev:6.70 (5.3%) stddev-sans-first:6.41 04:08:59 INFO - 2015-11-21 04:08:59,026 DEBUG : BROWSER_OUTPUT: Values: 116.0 124.0 120.0 129.0 132.0 119.0 132.0 123.0 132.0 115.0 04:08:59 INFO - 2015-11-21 04:08:59,026 DEBUG : BROWSER_OUTPUT: 04:08:59 INFO - 2015-11-21 04:08:59,026 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.40 Median:154.50 stddev:8.57 (5.5%) stddev-sans-first:9.07 04:08:59 INFO - 2015-11-21 04:08:59,026 DEBUG : BROWSER_OUTPUT: Values: 153.0 142.0 154.0 153.0 158.0 143.0 166.0 151.0 169.0 155.0 04:08:59 INFO - 2015-11-21 04:08:59,027 DEBUG : BROWSER_OUTPUT: 04:08:59 INFO - 2015-11-21 04:08:59,027 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:1.17 (1.8%) stddev-sans-first:1.09 04:08:59 INFO - 2015-11-21 04:08:59,027 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 67.0 69.0 68.0 66.0 66.0 67.0 66.0 66.0 04:08:59 INFO - 2015-11-21 04:08:59,027 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:08:59 INFO - 2015-11-21 04:08:59,027 DEBUG : BROWSER_OUTPUT: 04:09:00 INFO - 2015-11-21 04:09:00,009 INFO : Browser exited with error code: 0 04:09:00 INFO - 2015-11-21 04:09:00,057 INFO : Completed test kraken (00:01:00) 04:09:00 INFO - 2015-11-21 04:09:00,057 INFO : Starting test v8_7 04:09:00 INFO - 2015-11-21 04:09:00,057 DEBUG : operating with platform_type : linux_ 04:09:00 INFO - 2015-11-21 04:09:00,058 INFO : Initialising browser for v8_7 test... 04:09:00 INFO - 2015-11-21 04:09:00,063 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDZ_4wy/profile http://localhost:33211/getInfo.html 04:09:04 INFO - 2015-11-21 04:09:04,913 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:09:04 INFO - 2015-11-21 04:09:04,913 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:09:04 INFO - 2015-11-21 04:09:04,913 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:09:04 INFO - 2015-11-21 04:09:04,913 DEBUG : BROWSER_OUTPUT: __metrics 04:09:05 INFO - 2015-11-21 04:09:05,111 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:09:06 INFO - 2015-11-21 04:09:06,885 INFO : Browser initialized. 04:09:06 INFO - 2015-11-21 04:09:06,885 INFO : Running cycle 1/1 for v8_7 test... 04:09:06 INFO - 2015-11-21 04:09:06,886 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDZ_4wy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:09:18 INFO - 2015-11-21 04:09:18,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 142155776 04:09:18 INFO - 2015-11-21 04:09:18,674 DEBUG : BROWSER_OUTPUT: 04:09:40 INFO - 2015-11-21 04:09:40,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33211/tests/v8_7/run.html (next: http://localhost:33211/tests/v8_7/run.html) 04:09:40 INFO - 2015-11-21 04:09:40,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 619528192 04:09:40 INFO - 2015-11-21 04:09:40,351 DEBUG : BROWSER_OUTPUT: 04:09:40 INFO - 2015-11-21 04:09:40,353 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:09:40 INFO - 2015-11-21 04:09:40,353 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:09:40 INFO - 2015-11-21 04:09:40,353 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:09:40 INFO - 2015-11-21 04:09:40,353 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:09:40 INFO - 2015-11-21 04:09:40,353 DEBUG : BROWSER_OUTPUT: |0;Richards;162.94606485253382 04:09:40 INFO - 2015-11-21 04:09:40,353 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.23671497584542 04:09:40 INFO - 2015-11-21 04:09:40,354 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.0078962210942 04:09:40 INFO - 2015-11-21 04:09:40,354 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 04:09:40 INFO - 2015-11-21 04:09:40,354 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1964.6365422396857 04:09:40 INFO - 2015-11-21 04:09:40,354 DEBUG : BROWSER_OUTPUT: |5;Earley;779.423226812159 04:09:40 INFO - 2015-11-21 04:09:40,354 DEBUG : BROWSER_OUTPUT: |6;Boyer;12192.77108433735 04:09:40 INFO - 2015-11-21 04:09:40,355 DEBUG : BROWSER_OUTPUT: |7;RegExp;26230.76923076923 04:09:40 INFO - 2015-11-21 04:09:40,355 DEBUG : BROWSER_OUTPUT: |8;Splay;632.9113924050633 04:09:40 INFO - 2015-11-21 04:09:40,355 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 04:09:40 INFO - 2015-11-21 04:09:40,355 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:09:40 INFO - 2015-11-21 04:09:40,355 DEBUG : BROWSER_OUTPUT: __startTimestamp1448107780351__endTimestamp 04:09:40 INFO - 2015-11-21 04:09:40,355 DEBUG : BROWSER_OUTPUT: 04:09:40 INFO - 2015-11-21 04:09:40,356 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:09:40 INFO - 2015-11-21 04:09:40,356 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:09:40 INFO - 2015-11-21 04:09:40,356 DEBUG : BROWSER_OUTPUT: 04:09:40 INFO - 2015-11-21 04:09:40,356 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.95 Median:162.95 stddev:0.00 (0.0%) 04:09:40 INFO - 2015-11-21 04:09:40,356 DEBUG : BROWSER_OUTPUT: Values: 162.9 04:09:40 INFO - 2015-11-21 04:09:40,356 DEBUG : BROWSER_OUTPUT: 04:09:40 INFO - 2015-11-21 04:09:40,357 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.24 Median:193.24 stddev:0.00 (0.0%) 04:09:40 INFO - 2015-11-21 04:09:40,357 DEBUG : BROWSER_OUTPUT: Values: 193.2 04:09:40 INFO - 2015-11-21 04:09:40,357 DEBUG : BROWSER_OUTPUT: 04:09:40 INFO - 2015-11-21 04:09:40,357 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.01 Median:282.01 stddev:0.00 (0.0%) 04:09:40 INFO - 2015-11-21 04:09:40,357 DEBUG : BROWSER_OUTPUT: Values: 282.0 04:09:40 INFO - 2015-11-21 04:09:40,357 DEBUG : BROWSER_OUTPUT: 04:09:40 INFO - 2015-11-21 04:09:40,358 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 04:09:40 INFO - 2015-11-21 04:09:40,358 DEBUG : BROWSER_OUTPUT: Values: 5040.2 04:09:40 INFO - 2015-11-21 04:09:40,358 DEBUG : BROWSER_OUTPUT: 04:09:40 INFO - 2015-11-21 04:09:40,358 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1964.64 Median:1964.64 stddev:0.00 (0.0%) 04:09:40 INFO - 2015-11-21 04:09:40,358 DEBUG : BROWSER_OUTPUT: Values: 1964.6 04:09:40 INFO - 2015-11-21 04:09:40,358 DEBUG : BROWSER_OUTPUT: 04:09:40 INFO - 2015-11-21 04:09:40,359 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:779.42 Median:779.42 stddev:0.00 (0.0%) 04:09:40 INFO - 2015-11-21 04:09:40,359 DEBUG : BROWSER_OUTPUT: Values: 779.4 04:09:40 INFO - 2015-11-21 04:09:40,359 DEBUG : BROWSER_OUTPUT: 04:09:40 INFO - 2015-11-21 04:09:40,359 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12192.77 Median:12192.77 stddev:0.00 (0.0%) 04:09:40 INFO - 2015-11-21 04:09:40,359 DEBUG : BROWSER_OUTPUT: Values: 12192.8 04:09:40 INFO - 2015-11-21 04:09:40,360 DEBUG : BROWSER_OUTPUT: 04:09:40 INFO - 2015-11-21 04:09:40,360 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26230.77 Median:26230.77 stddev:0.00 (0.0%) 04:09:40 INFO - 2015-11-21 04:09:40,360 DEBUG : BROWSER_OUTPUT: Values: 26230.8 04:09:40 INFO - 2015-11-21 04:09:40,360 DEBUG : BROWSER_OUTPUT: 04:09:40 INFO - 2015-11-21 04:09:40,360 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:632.91 Median:632.91 stddev:0.00 (0.0%) 04:09:40 INFO - 2015-11-21 04:09:40,360 DEBUG : BROWSER_OUTPUT: Values: 632.9 04:09:40 INFO - 2015-11-21 04:09:40,361 DEBUG : BROWSER_OUTPUT: 04:09:40 INFO - 2015-11-21 04:09:40,362 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 04:09:40 INFO - 2015-11-21 04:09:40,362 DEBUG : BROWSER_OUTPUT: Values: 4845.4 04:09:40 INFO - 2015-11-21 04:09:40,362 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:09:40 INFO - 2015-11-21 04:09:40,362 DEBUG : BROWSER_OUTPUT: 04:09:41 INFO - 2015-11-21 04:09:41,357 INFO : Browser exited with error code: 0 04:09:41 INFO - 2015-11-21 04:09:41,371 INFO : Completed test v8_7 (00:00:41) 04:09:41 INFO - 2015-11-21 04:09:41,849 INFO : Completed test suite (00:20:18) 04:09:41 INFO - 2015-11-21 04:09:41,849 DEBUG : Working with test: dromaeo_css 04:09:41 INFO - 2015-11-21 04:09:41,849 DEBUG : Generating results file: dromaeo_css 04:09:41 INFO - 2015-11-21 04:09:41,850 DEBUG : Working with test: kraken 04:09:41 INFO - 2015-11-21 04:09:41,850 DEBUG : Generating results file: kraken 04:09:41 INFO - 2015-11-21 04:09:41,850 INFO : javascript benchmark 04:09:41 INFO - 2015-11-21 04:09:41,851 DEBUG : Working with test: v8_7 04:09:41 INFO - 2015-11-21 04:09:41,851 DEBUG : Generating results file: v8_7 04:09:41 INFO - 2015-11-21 04:09:41,851 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:09:41 INFO - 2015-11-21 04:09:41,899 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 04:09:41 INFO - 2015-11-21 04:09:41,899 DEBUG : process_Request line: dromaeo_css 6943.22 graph.html#tests=[[72,201,35]] 04:09:41 INFO - 2015-11-21 04:09:41,899 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:09:42 INFO - 2015-11-21 04:09:42,030 DEBUG : process_Request line: kraken 1511.90 graph.html#tests=[[232,201,35]] 04:09:42 INFO - 2015-11-21 04:09:42,030 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:09:42 INFO - 2015-11-21 04:09:42,059 DEBUG : process_Request line: v8_7 19799.08 graph.html#tests=[[230,201,35]] 04:09:42 INFO - 2015-11-21 04:09:42,060 INFO : javascript benchmark 04:09:42 INFO - 2015-11-21 04:09:42,064 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3125.2186953261685, 3204.3270913108245, 3206.5831441912546, 3239.028291512547, 3254.593175853017, 5153.871153221171, 5221.503957124067, 5372.543333816626, 5416.052190866598, 5447.319085114361, 5274.129768588178, 5288.92066619001, 5305.867353316169, 5309.123994540906, 5380.596455265852, 4737.1946769049255, 4826.565609095181, 4843.370361852954, 4887.193613053842, 4927.3348098006845, 4926.778294976734, 4938.777755001016, 4995.650304478688, 5053.393592768873, 5099.464556221599, 4773.284007398884, 5006.724630145341, 5022.0, 5094.108531007059, 5116.872078198056, 4875.024995000978, 4903.53416425439, 4949.282354058641, 4976.651634385595, 5008.499150084999, 4914.950850491521, 4922.606191504671, 4925.581325587294, 4928.704277743347, 4970.776315065831, 5168.689878607295, 5213.061648903196, 5218.6868787872845, 5224.0, 5229.424763276036, 5560.193771903051, 5636.689982050985, 5717.799877004327, 5766.308043034863, 5775.971120144414, 5820.097884827816, 5828.388019258002, 5832.1834943108, 5839.240898683186, 5841.269841269841, 5203.427622961472, 5449.482299181611, 5451.727413629303, 5457.290552228224, 5466.890662186774, 5805.796797112165, 5817.127430885401, 5819.272590926134, 5996.040633498619, 5999.730012149464, 5728.79949201776, 5742.684152371659, 5743.59794814359, 5743.770249190069, 5748.626339287933, 5601.467860553241, 5806.9419305806405, 5817.069268917037, 5825.03886858672, 5827.0, 5635.0, 5746.741396637078, 5763.769449222068, 5827.621204621686, 5831.183634291117, 5729.512991395778, 5735.082386818089, 5736.42635736423, 5741.770329186786, 5743.655380677173, 4336.82652693895, 4417.1386579616665, 4471.28459446487, 4479.7984090716, 4516.458025037016, 3897.1231472918935, 3947.348687466536, 3983.1635356574866, 3992.5807790182193, 4013.1171142348635, 5445.156000819879, 5481.232627432163, 5481.780728770885, 5484.725763711798, 5490.176473529003, 5657.264555607827, 5779.566532510079, 5806.274215723035, 5807.390224026501, 5817.360090390053, 5334.413214546396, 5411.053065713484, 5442.700651464128, 5459.317585301837, 5468.207109969032, 5091.0, 5095.643304968691, 5102.08162530748, 5103.770330335144, 5152.175651895679, 5663.122216056436, 5803.82588522345, 6069.544784141207, 6075.878482430327, 6078.149059131725, 5724.74238659253, 5789.56578256624, 5800.535957123504, 5803.39064398249, 5839.065749480063, 5902.439268269508, 5921.555883308855, 5924.940750592439, 5929.525637948867, 5944.138099975393, 5468.425815289337, 5523.944760552343, 5649.4633009864, 5651.406602306699, 5669.149627555899, 5752.1659359391815, 5873.4126587342635, 5878.2358293421585, 5883.970580147072, 5908.675022873783, 5671.262735844314, 5724.942750572441, 5725.456081672234, 5725.914111288251, 5730.656160630376, 5453.345598528043, 5516.393196748274, 5580.441955804549, 5703.714814259353, 5724.484796368347, 5535.086710692691, 5613.803516876889, 5613.943860561342, 5618.269624948731, 5661.801836935688, 5644.52021578154, 5681.005823980704, 5683.261176047087, 5692.7722891083895, 5745.454181852718, 5297.8145764898045, 5395.028894798974, 5402.054640437829, 5580.079286917776, 5586.050371436947], "unit": "ms", "name": "dojo.html", "value": 5324.520000297351}, {"lowerIsBetter": false, "replicates": [565.3103214078824, 567.6168586204313, 573.7704918032789, 591.7839988404234, 593.4925638579017, 28622.570661440095, 28961.131166065, 29114.272143196406, 29179.562306565393, 37831.0, 41766.164676706525, 42439.36340954888, 42471.57528424715, 42477.362839557434, 42486.15027699444, 8449.746507604781, 8583.656653733844, 8602.440841345324, 8612.741617751446, 8618.310535157172, 7482.401407887383, 7626.542407455543, 8448.957755211215, 10397.948010259937, 10596.152307815357, 10261.486925653724, 10350.327228730108, 10364.637237696683, 10373.533191006385, 10377.325473844214, 7651.9234807651765, 10263.640772572962, 10357.135715571194, 10364.170866330713, 10372.325798823053, 7487.251274872524, 10318.7420314492, 10547.261691681586, 10559.683209503728, 10560.313579617301, 38317.233655327014, 38755.61244387576, 38767.612323876965, 38767.806160969296, 38803.0, 3027.7880548361622, 3032.9848350758325, 3268.4933835255574, 3584.6415358464205, 3700.777953322809, 28590.428191436054, 28756.568651470243, 28931.421371572662, 29081.70918290811, 29366.853165734035, 3834.8657796976972, 3896.5129358830145, 3976.1252524444576, 3982.064214909494, 4077.2660921034203, 280067.0, 280514.5974270136, 280532.0, 280862.0, 280998.0, 52093.218601721004, 55474.0, 55863.44136558582, 55913.440865591634, 55947.720261398434, 49259.0, 57342.42657573454, 58068.0, 58287.4171258282, 58406.0, 14649.707005859824, 14886.0, 14891.851081489263, 14945.476908308157, 14955.102693838187, 11268.661940141808, 11402.372869492257, 11403.828942565868, 11407.201495895208, 11411.771764564663, 17304.307827687004, 17982.0, 18081.54796130081, 18161.36435224787, 18265.08674566293, 7044.189918159374, 7178.820529486805, 7232.915062740631, 7246.0, 7279.636018199175, 784.6351446577255, 791.0783936713664, 822.0833770346021, 840.6133178737726, 985.6303886042734, 21926.561468770535, 22253.22113726012, 22272.888635557043, 22286.331410057723, 22290.331290061324, 928.5960607135918, 946.2760987844305, 962.4946902876046, 1041.505284989639, 1117.921745477825, 13138.4087716053, 13142.540011099756, 13310.933445332712, 13441.932790335986, 13504.932475337757, 311090.0, 313397.0, 314947.0, 315000.0, 315622.0, 49566.25650615244, 49689.503104968484, 49815.01479881601, 49854.50145498571, 49914.251286230734, 1081.2701426537055, 1146.558574948634, 1164.2490593567102, 1217.8721234270452, 1243.1173866554666, 25675.871620641778, 25785.097521586653, 26410.735892640827, 27277.0, 28243.2939176514, 46713.2993005112, 47197.0, 47462.52537474581, 47508.28737569008, 47526.52473475221, 287996.0, 292801.0, 298324.0, 304827.0, 304829.0, 28845.0, 28945.710542895144, 29012.0, 29165.0, 29179.562306565844, 38196.80901595474, 39198.216035679696, 39490.40764388479, 39790.40314395229, 39827.80086099667, 33663.83168084144, 34601.134971625914, 34766.82616586901, 35119.0, 36373.27253454969, 34426.48360274648, 35019.0, 35054.824725876206, 35346.823265883504, 35348.29303413866, 33977.49033764446, 34579.30841383108, 34676.133096672784, 34884.65115348814, 34922.47616285707, 30892.845535772176, 31592.36815263728, 32187.195320117185, 32215.0, 32297.51553726649, 24132.43139196017, 24468.51062978695, 24580.385490362885, 24782.504349913263, 24817.25548233556], "unit": "ms", "name": "ext.html", "value": 17806.26178357972}, {"lowerIsBetter": false, "replicates": [334.8392771469694, 335.88076232937306, 353.14362670523974, 353.2722591461588, 354.13767476195466, 14047.297635118255, 14392.568222953329, 16093.195340232985, 16601.33594656214, 18356.72464913024, 16157.515274541782, 16179.19104044796, 16182.676346473092, 16223.26995285212, 16224.269907854145, 5485.204645326426, 5713.8571535711735, 5719.942800572004, 5720.485156335929, 5723.8569035774235, 4334.696571240014, 5682.943170568304, 6120.26556813183, 6655.567388119756, 6668.099806526129, 6501.447376972963, 6598.307177746339, 6619.30497297784, 6637.601743895358, 6647.302033286508, 6620.437262832665, 6655.267920528738, 6655.800325990228, 6659.334066593375, 6661.833454163636, 6258.374162583751, 6351.047342898556, 6357.936420635827, 6410.903836442457, 6427.42153206209, 21515.35453936369, 21947.890260548756, 22036.669449958263, 22054.33836984893, 22055.44861378462, 1039.5841663334652, 1924.3745782620565, 1996.3911007142815, 2165.073084954392, 2461.249318957717, 14073.5074272401, 14127.0, 14159.0, 14481.275936203254, 14590.927045364811, 1927.6410130857712, 1981.2075169931998, 1986.7218589397496, 1993.6710442776925, 2005.4886004069015, 62156.0, 68664.6566767168, 68765.3123468764, 70716.64641676759, 71031.0, 14777.413952558474, 15219.162946038074, 15230.771538426932, 15236.0, 15262.236888155549, 23660.64509032366, 23738.762612374, 23975.28074157778, 24027.51944961091, 24085.0, 8738.475691458532, 8754.299656027502, 8823.779405514784, 8841.60212790426, 8987.325950553735, 7441.144268409203, 7463.104427468738, 7479.476436649491, 7491.925080749232, 7509.586972716553, 6678.83302917431, 7472.738454154079, 7532.096148462219, 7539.886901696479, 7545.7358992435, 1787.0350010994177, 1807.9638407231782, 1813.3109418420916, 1820.2173065581926, 2225.0654725015534, 400.9498812648419, 817.313456696366, 835.3275613131487, 855.170484629908, 912.8219997100501, 9154.40496367734, 9824.705258842247, 10422.0, 10868.836967445495, 10871.510782014828, 420.80222295521054, 430.3759548654401, 449.1062785057777, 466.1609103613482, 823.6705317872779, 8384.077751447336, 8866.42368246062, 8996.640134394682, 9007.279417646572, 9082.59128339213, 556473.0, 556569.0, 571385.0, 571854.0, 572054.0, 76424.65027448026, 77851.99332060142, 78558.0, 79087.60456197683, 79651.0, 1082.8754693210224, 1091.5524634899812, 1095.6603452929617, 1102.4377567440663, 1120.915931305139, 10077.050464583339, 10400.947995259976, 14159.292035397983, 14229.217393043482, 14649.633759156106, 32853.17867053343, 35328.11679707925, 35350.82324588361, 35409.0, 37806.62193378031, 46391.3041304374, 46622.0, 48827.51172488229, 48874.75562622164, 52041.47958520366, 14188.148711077369, 14295.57113286603, 14581.0, 14588.927055364655, 14947.626309342353, 17774.20016099253, 18008.09959502046, 18053.72919406236, 18097.728534072263, 18435.446936591925, 14770.039947403384, 14803.851961480248, 15003.624909377353, 15075.849241507445, 15230.0, 8506.106858779738, 8695.391322607356, 14614.196219208046, 15343.309551070006, 15369.846301537289, 8671.739847804576, 9745.658901938397, 9769.85345219808, 10062.295639305179, 10089.545970431202, 14290.642044063028, 14477.565673029825, 14499.202543859767, 14751.557453276419, 14846.18345990981, 14718.63203419923, 14797.778033329294, 14987.700245994802, 15430.768538471708, 15506.9224653876], "unit": "ms", "name": "jquery.html", "value": 9352.783682441137}, {"lowerIsBetter": false, "replicates": [1445.83372912115, 1572.5125211184532, 1625.2848746551517, 1632.3715369582715, 1650.7523871419285, 6454.741810327587, 6921.653917304134, 7200.819979500515, 7212.350888420041, 7215.098112735908, 7274.818129546751, 7387.150477695053, 7399.963000185005, 7401.962990185055, 7414.073240844895, 1914.2343062774933, 1947.3087054095804, 1948.6882098864185, 2244.5286489837154, 2264.4338915271182, 2263.128695452246, 2312.225404489498, 2312.6415405612156, 2313.4794671199015, 2313.90744370225, 2235.0836157175563, 2267.6031694453486, 2284.314705588325, 2284.5088306014286, 2286.188403116886, 1946.4549926020736, 1980.6137803128395, 2151.333086743107, 2161.7513985891665, 2240.529488807352, 2208.2491952736145, 2236.4185311818883, 2252.177955046396, 2253.966190507144, 2254.8872556372116, 7572.129205141424, 7644.770656880302, 7645.006149200624, 7646.4265180111715, 7652.273034061755, 4550.317452382169, 4580.175568397687, 4623.0, 4629.865682907709, 4663.067386522709, 2988.342564635798, 2998.625171853518, 3020.6828283030186, 3033.8028028178096, 3159.7788154829173, 1000.974975625608, 1008.6850677694708, 1011.640867492037, 1028.711960651019, 1066.2909165404997, 10477.31897426665, 10480.371177729285, 10482.213833962407, 10497.475126243733, 10499.68500944973, 4109.815058322323, 4215.388768628593, 4256.616904478612, 4261.2542805009, 4267.359896015622, 8949.060348663426, 9007.549622518847, 9021.594028268744, 9043.864342034874, 9045.68340108093, 4647.1635105680625, 4672.556107169813, 4695.577398034194, 4698.553637404441, 4701.435827700698, 4253.340732186516, 4254.489461264668, 4254.659627229814, 4255.936160957588, 4256.2764330063965, 3561.9821900890847, 3588.085038315213, 3603.873864414733, 3606.9639303606627, 3643.817809109587, 1188.1089183112665, 1189.2685998111272, 1205.9095567832449, 1206.8129439936824, 1212.3150420012664, 952.3714348529937, 979.9559019844124, 980.1913421427352, 1050.2685402262757, 1250.2935841249664, 7040.119985001875, 7095.396891264197, 7131.750388736369, 7136.0723105995885, 7136.964315178391, 447.16826702333634, 450.49994506098204, 450.59446498151925, 450.9774511274489, 468.1035816411602, 5535.363433205152, 5600.467955544217, 5655.406182350876, 5672.546196304285, 5674.319081710221, 8893.64425422976, 8996.190342869173, 9173.357864949523, 9174.633014679472, 9193.448393096436, 8842.867356989651, 8903.06517815633, 8953.283737301, 8964.103589641114, 8969.37214394986, 6998.68505917235, 7001.754938577125, 7024.508284420143, 7042.225355210922, 7082.433405327562, 6679.098321726505, 6726.6636668167375, 6765.1205343305055, 6772.018057381553, 6780.69486873082, 8013.519188848688, 8017.679292828221, 8102.797430064295, 8206.794830129056, 8265.917340826514, 7969.521828690297, 8165.38759593021, 8291.046529649167, 8345.66617335324, 8351.373646976379, 6659.800205993828, 6694.364035416627, 6724.7646332378135, 6726.0, 6730.831729206809, 7318.3047610476915, 7380.630968451664, 7401.0, 7404.777856664308, 7413.406927445683, 6667.133272674521, 6820.215675197416, 6835.863282734417, 6932.376086152271, 6957.582545047313, 6034.487068599218, 6169.413905678954, 6528.9020664689115, 6664.633445160563, 6785.762498312535, 6727.293634168342, 6771.93228067713, 6785.796426107225, 6808.693608787517, 6839.179298484214, 5881.941180588139, 6231.22109736283, 6420.711068002044, 6434.806955791334, 6438.484921206386, 6455.225372955276, 6485.708143133476, 6503.6097834130105, 6504.089427480062, 6506.869862602627], "unit": "ms", "name": "mootools.html", "value": 4261.029126922681}, {"lowerIsBetter": false, "replicates": [325.6092688773472, 326.9427850126229, 334.8074856957249, 334.9681780230877, 339.20964153522294, 5930.229070220876, 6050.152978583002, 6070.635761854281, 6108.664023478706, 6135.233095863017, 5867.237259156314, 5982.312034116078, 5994.0, 6021.066734656135, 6035.879282414349, 4628.791704373311, 4635.420572428447, 4655.55772201642, 4663.300504924255, 4663.790129444166, 4449.354843547683, 4525.909481810362, 4568.977155114219, 4581.129585378767, 4658.673892827504, 4450.888727781815, 4547.045120524694, 4562.156001139783, 4588.174128656857, 4592.724436533818, 4577.656675749316, 4581.702189357681, 4582.793774280165, 4584.770761461947, 4590.586847183753, 3968.464257325253, 3993.820278087493, 3993.9815347086596, 3997.2605068062503, 3998.4002399639994, 5595.608307418483, 5706.115552089433, 5721.456461636138, 5736.971315143439, 5760.9711951440395, 5365.0, 5414.242006119146, 5414.512693857571, 5419.756110975016, 5423.0, 6188.783392581283, 6400.295967443578, 6432.292447830735, 6444.935550644481, 6445.4199122079235, 4334.609885110355, 4400.09797991411, 4450.643948484146, 4466.062126953344, 4484.977575112136, 6575.145231119972, 6605.405513503808, 6671.865782816933, 6686.665666716644, 6690.799276021728, 4620.838270660511, 4621.884452888705, 4625.306204069417, 4625.676202665781, 4631.745254010994, 4506.774661266923, 4644.698094623838, 4654.115718013567, 4682.086993036393, 4686.718796872198, 5364.704941228192, 5370.4361042090795, 5373.38206106295, 5373.838784836461, 5377.569794416438, 6482.448991835652, 6488.124103246096, 6488.253850807123, 6489.318621544764, 6492.318306577836, 1648.3900956646119, 1665.7168281392192, 1666.7749853769828, 1667.624784423495, 1670.089801058426, 1106.1151079136819, 1108.0581505720234, 1131.2420678145497, 1139.0432037088885, 1152.124385467051, 6179.938200618026, 6228.937710622836, 6231.40801623845, 6233.812985610439, 6239.407256310643, 6625.13873196491, 6625.834354141089, 6640.269570347258, 6646.368594983469, 6651.439195909609, 6170.444659980533, 6189.938100618936, 6219.502439804804, 6221.720022598994, 6239.251289845248, 3599.3161299353037, 3623.202895363069, 3633.364161271767, 3640.7087433005295, 3643.216708407705, 6931.514793964374, 6939.271376505495, 6945.305469453015, 6945.965270173718, 6959.8956015659805, 6787.830304242433, 6909.412699920463, 6920.031195632616, 6925.065116209247, 6930.618815965069, 6964.79105626832, 6984.825379365557, 6989.196242431982, 6991.370776630128, 6996.405305549085, 6418.550701450854, 6537.1501704778075, 6557.180352455943, 6754.898676519954, 6763.628000460022, 6617.139771829631, 6653.401193892573, 6658.234303055211, 6662.766803161866, 6669.399754022162, 6934.098567186234, 6936.549124306904, 6938.375546200866, 6941.167059952636, 6953.130858642669, 4356.390105385312, 4506.954930450785, 4516.706414083074, 4517.344984977226, 4550.590446859798, 6659.567128136656, 6666.066750654815, 6668.466522678077, 6670.099536562502, 6674.332566743481, 6473.8705225896165, 6482.740690372332, 6483.610983341015, 6489.772857949949, 6490.286068532552, 6338.0, 6452.935470645421, 6453.967730161319, 6528.836779080561, 6552.57408268461, 6418.518611104279, 6427.550071495138, 6429.292777794532, 6431.774887879089, 6433.260175079926, 6584.637844918576, 6586.341365863375, 6587.571807832475, 6592.538522303393, 6594.0, 6220.440160385587, 6405.071264666504, 6414.839629009125, 6430.807075787547, 6434.099226108255], "unit": "ms", "name": "prototype.html", "value": 4868.160460221375}, {"lowerIsBetter": false, "replicates": [629.7908016608112, 651.7555916531301, 692.6155983429195, 702.0837806662304, 703.8345988692656, 13070.869291307095, 13351.198928064323, 13381.933090334534, 13385.397657105417, 13436.059475836695, 12804.871951280484, 14151.71696566068, 14430.711385772305, 14439.639009024753, 14449.63875903103, 632.9398707122816, 637.7927173668576, 639.5363361562853, 756.3193126186421, 765.2653452685429, 750.4671683104975, 760.9657565409542, 763.1986414265027, 765.6210175962906, 765.9042619672513, 787.3661702329622, 796.4623878881761, 796.8685166947475, 797.5095316380414, 797.6490344248512, 652.451940370089, 659.3044338223173, 731.7987553422798, 765.4221063097326, 790.7074382478462, 550.606316483712, 551.7903196785196, 552.1303946284578, 552.3151292397439, 556.4657928388751, 13415.195088294733, 13577.11748736329, 13610.523631672844, 13614.591562253148, 13620.659483512893, 11213.887861121366, 11401.657950261506, 11819.586314478953, 11935.224210426295, 12217.389130543526, 10177.796444071151, 10318.277720559563, 10403.427811470367, 10454.425006624633, 10529.736756581071, 3563.2339047104997, 3627.3289441453417, 3627.4014787560022, 3656.0494271489606, 3657.817109144532, 50270.24594631083, 50940.99999999963, 51011.23483147756, 51014.74492627513, 51024.48975510272, 8994.550272486349, 9110.635574576943, 9116.954415227881, 9171.770705732277, 9773.12041916231, 17397.13014349303, 17475.825241747672, 17540.386086486913, 17545.894492660707, 17566.0, 7315.597642129627, 7319.377852882458, 7323.523970941872, 7489.251074892467, 7601.809954751065, 4030.1536677298095, 4187.685923555685, 4256.276433006335, 4269.935950960738, 4282.464691913511, 3064.55563943227, 3087.0893086539527, 3089.7991630543943, 3090.629124505074, 3097.1947293703797, 515.3995595131704, 529.1401472607014, 530.7558523079426, 543.7118327286545, 544.316882312695, 516.4499807704782, 547.6905548365161, 620.534599050712, 623.1494010675486, 635.4510061307649, 8497.235248827636, 9024.593893274818, 9039.322050846213, 9071.909280907239, 9239.404547293105, 462.49818946442815, 502.7461132128252, 539.5926075812815, 673.7504452095487, 688.2051230828401, 4068.4304197412384, 4188.727732697365, 4244.257254980428, 4301.333293339538, 4354.738715677006, 55927.440725593035, 56263.43736562582, 57257.42742572604, 57595.0, 57659.67552433584, 49171.262431062845, 49762.0, 50016.24975625369, 50042.0, 50278.24582631263, 44796.77601611971, 45171.09657806825, 45356.54643453589, 46060.53939460563, 46507.30239046417, 8543.401961862859, 8630.309575234092, 8741.34439916996, 8806.471611703319, 8824.029356770621, 33824.0, 33976.83011584926, 34744.0, 35067.142614312914, 35305.646943530235, 43502.56497435112, 43504.782476087414, 44343.77828110839, 44377.55622443734, 44536.0, 10566.207534435101, 10625.362478251329, 10819.524147269103, 11027.448627568428, 11152.330860148093, 11545.769084618429, 11722.41387930583, 11924.0, 11937.164398492023, 12356.62930112098, 10673.146148308271, 10860.239783215415, 10894.182936279652, 10965.122790176927, 11123.83314250303, 10673.733156670834, 10765.407902565434, 10815.56737730482, 10832.783344333227, 10916.836247456136, 11057.06014988735, 11089.778204435705, 11197.44012799373, 11277.32336059839, 11519.712007199887, 5695.629784064023, 9914.553845076845, 10093.243006774668, 10109.898901011189, 10191.439470829175, 9203.038879785385, 9475.620975160917, 9718.854217186888, 9755.637511602605, 9902.108810207115], "unit": "ms", "name": "yui.html", "value": 6090.483598844073}], "name": "dromaeo_css", "value": 6943.2179667622895}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 104.0, 108.0, 110.0, 111.0, 99.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [147.0, 122.0, 164.0, 172.0, 129.0, 157.0, 156.0, 130.0, 171.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [167.0, 164.0, 164.0, 162.0, 164.0, 163.0, 168.0, 166.0, 165.0, 165.0], "unit": "ms", "name": "audio-dft", "value": 164.8}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 74.0, 94.0, 72.0, 73.0, 72.0, 105.0, 91.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [90.0, 89.0, 141.0, 89.0, 90.0, 90.0, 134.0, 89.0, 91.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 103.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 147.0, 145.0, 147.0, 145.0, 146.0, 146.0, 147.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 58.0, 57.0, 60.0, 58.0, 59.0, 66.0, 56.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 58.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 71.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 84.0, 85.0, 84.0, 84.0, 86.0, 85.0, 86.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [116.0, 124.0, 120.0, 129.0, 132.0, 119.0, 132.0, 123.0, 132.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [153.0, 142.0, 154.0, 153.0, 158.0, 143.0, 166.0, 151.0, 169.0, 155.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 154.4}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 67.0, 69.0, 68.0, 66.0, 66.0, 67.0, 66.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1511.9000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.94606485253382], "unit": "score", "name": "Richards", "value": 216.64837400000005}, {"lowerIsBetter": false, "replicates": [193.23671497584542], "unit": "score", "name": "DeltaBlue", "value": 342.16064999999986}, {"lowerIsBetter": false, "replicates": [282.0078962210942], "unit": "score", "name": "Encrypt", "value": 943.8778259999998}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1964.6365422396857], "unit": "score", "name": "RayTrace", "value": 376.654401}, {"lowerIsBetter": false, "replicates": [779.423226812159], "unit": "score", "name": "Earley", "value": 855.072029}, {"lowerIsBetter": false, "replicates": [12192.77108433735], "unit": "score", "name": "Boyer", "value": 54.66050296442688}, {"lowerIsBetter": false, "replicates": [26230.76923076923], "unit": "score", "name": "RegExp", "value": 34.729633431085055}, {"lowerIsBetter": false, "replicates": [632.9113924050633], "unit": "score", "name": "Splay", "value": 128.75577999999996}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19799.082933245558}]} 04:09:42 INFO - RETURN: dromaeo_css: 6943.22 04:09:42 INFO - RETURN: kraken: 1511.90 04:09:42 INFO - RETURN: v8_7: 19799.08 04:09:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19799.08"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1511.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6943.22"}}} 04:09:42 INFO - Return code: 0 04:09:42 INFO - # TBPL SUCCESS # 04:09:42 INFO - Running post-action listener: _resource_record_post_action 04:09:42 INFO - Running post-run listener: _resource_record_post_run 04:09:43 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 513298432; Read time: 1084; Write time: 1292248 04:09:43 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 0; Write bytes: 213065728; Read time: 0; Write time: 608212 04:09:43 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 280555520; Read time: 1084; Write time: 569068 04:09:43 INFO - Running post-run listener: _upload_blobber_files 04:09:43 INFO - Blob upload gear active. 04:09:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:09:43 INFO - Copying logs to upload dir... 04:09:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.382828 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-21 04:09:43.031458) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-21 04:09:43.034484) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010044 build_url: 'https://queue.taskcluster.net/v1/task/CgqEXA5PTbqU6NgKHc2J-A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-21 04:09:43.086008) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:09:43.086360) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a194aa7faa1be204aaca7d660000020b-1448096193.673524-627572568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004683 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 04:09:43.136094) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 04:09:43.136451) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 04:09:43.136736) ========= ========= Total master_lag: 0.24 =========