builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1448365717.56 results: success (0) buildid: 20151124023019 builduid: c152c7a970aa418f8fc342d3b8530101 revision: 4d9b6b7b8550730abb8edc6acabacf6787873eb6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:37.560997) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:37.561354) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:37.561790) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009193 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:37.588279) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:37.588541) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:37.632103) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:37.632343) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.026847 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:37.683345) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:37.683603) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:37.683919) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:37.684231) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 03:48:37-- 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% 223M=0s 2015-11-24 03:48:37 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178603 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:37.877172) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:37.877670) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.098711 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:37.987520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:37.987868) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 4d9b6b7b8550730abb8edc6acabacf6787873eb6 --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 4d9b6b7b8550730abb8edc6acabacf6787873eb6 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 03:48:38,122 truncating revision to first 12 chars 2015-11-24 03:48:38,122 Setting DEBUG logging. 2015-11-24 03:48:38,122 attempt 1/10 2015-11-24 03:48:38,122 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/4d9b6b7b8550?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 03:48:38,507 unpacking tar archive at: b2g-inbound-4d9b6b7b8550/testing/mozharness/ program finished with exit code 0 elapsedTime=0.697093 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:38.697512) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:38.697810) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:38.706740) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:38.707004) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 03:48:38.707364) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-24 03:48:38.707643) ========= /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=e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:48:38 INFO - MultiFileLogger online at 20151124 03:48:38 in /builds/slave/test-pgo 03:48:38 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:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:48:38 INFO - {'append_to_log': False, 03:48:38 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:48:38 INFO - 'blob_upload_branch': 'B2G-Inbound', 03:48:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:48:38 INFO - 'branch': 'B2G-Inbound', 03:48:38 INFO - 'buildbot_json_path': 'buildprops.json', 03:48:38 INFO - 'config_files': ('talos/linux_config.py',), 03:48:38 INFO - 'default_actions': ('clobber', 03:48:38 INFO - 'read-buildbot-config', 03:48:38 INFO - 'download-and-extract', 03:48:38 INFO - 'populate-webroot', 03:48:38 INFO - 'create-virtualenv', 03:48:38 INFO - 'install', 03:48:38 INFO - 'run-tests'), 03:48:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:48:38 INFO - 'download_minidump_stackwalk': True, 03:48:38 INFO - 'download_symbols': 'ondemand', 03:48:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:48:38 INFO - 'tooltool.py': '/tools/tooltool.py', 03:48:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:48:38 INFO - '/tools/misc-python/virtualenv.py')}, 03:48:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:48:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:48:38 INFO - 'installer_path': 'installer.exe', 03:48:38 INFO - 'log_level': 'info', 03:48:38 INFO - 'log_name': 'talos', 03:48:38 INFO - 'log_to_console': True, 03:48:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:48:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:48:38 INFO - 'opt_config_files': (), 03:48:38 INFO - 'pip_index': False, 03:48:38 INFO - 'sps_profile': False, 03:48:38 INFO - 'sps_profile_interval': 0, 03:48:38 INFO - 'suite': 'dromaeojs', 03:48:38 INFO - 'system_bits': '64', 03:48:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:48:38 INFO - 'title': 'talos-linux64-ix-038', 03:48:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:48:38 INFO - 'use_talos_json': True, 03:48:38 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:48:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:48:38 INFO - 'work_dir': 'build'} 03:48:38 INFO - ##### 03:48:38 INFO - ##### Running clobber step. 03:48:38 INFO - ##### 03:48:38 INFO - Running pre-action listener: _resource_record_pre_action 03:48:38 INFO - Running main action method: clobber 03:48:38 INFO - rmtree: /builds/slave/test-pgo/build 03:48:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:48:40 INFO - Running post-action listener: _resource_record_post_action 03:48:40 INFO - ##### 03:48:40 INFO - ##### Running read-buildbot-config step. 03:48:40 INFO - ##### 03:48:40 INFO - Running pre-action listener: _resource_record_pre_action 03:48:40 INFO - Running main action method: read_buildbot_config 03:48:40 INFO - Using buildbot properties: 03:48:40 INFO - { 03:48:40 INFO - "properties": { 03:48:40 INFO - "buildnumber": 999, 03:48:40 INFO - "product": "firefox", 03:48:40 INFO - "script_repo_revision": "production", 03:48:40 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 03:48:40 INFO - "repository": "", 03:48:40 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 03:48:40 INFO - "buildid": "20151124023019", 03:48:40 INFO - "slavename": "talos-linux64-ix-038", 03:48:40 INFO - "pgo_build": "True", 03:48:40 INFO - "basedir": "/builds/slave/test-pgo", 03:48:40 INFO - "project": "", 03:48:40 INFO - "platform": "ubuntu64_hw", 03:48:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:48:40 INFO - "slavebuilddir": "test", 03:48:40 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 03:48:40 INFO - "branch": "b2g-inbound", 03:48:40 INFO - "repo_path": "integration/b2g-inbound", 03:48:40 INFO - "stage_platform": "linux64-pgo", 03:48:40 INFO - "builduid": "c152c7a970aa418f8fc342d3b8530101", 03:48:40 INFO - "revision": "4d9b6b7b8550730abb8edc6acabacf6787873eb6" 03:48:40 INFO - }, 03:48:40 INFO - "sourcestamp": { 03:48:40 INFO - "repository": "", 03:48:40 INFO - "hasPatch": false, 03:48:40 INFO - "project": "", 03:48:40 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 03:48:40 INFO - "changes": [ 03:48:40 INFO - { 03:48:40 INFO - "category": null, 03:48:40 INFO - "files": [ 03:48:40 INFO - { 03:48:40 INFO - "url": null, 03:48:40 INFO - "name": "https://queue.taskcluster.net/v1/task/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:48:40 INFO - } 03:48:40 INFO - ], 03:48:40 INFO - "repository": "", 03:48:40 INFO - "rev": "4d9b6b7b8550730abb8edc6acabacf6787873eb6", 03:48:40 INFO - "who": "sendchange", 03:48:40 INFO - "when": 1448365667, 03:48:40 INFO - "number": 6699764, 03:48:40 INFO - "comments": "", 03:48:40 INFO - "project": "", 03:48:40 INFO - "at": "Tue 24 Nov 2015 03:47:47", 03:48:40 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 03:48:40 INFO - "revlink": "", 03:48:40 INFO - "properties": [ 03:48:40 INFO - [ 03:48:40 INFO - "buildid", 03:48:40 INFO - "20151124023019", 03:48:40 INFO - "Change" 03:48:40 INFO - ], 03:48:40 INFO - [ 03:48:40 INFO - "builduid", 03:48:40 INFO - "c152c7a970aa418f8fc342d3b8530101", 03:48:40 INFO - "Change" 03:48:40 INFO - ], 03:48:40 INFO - [ 03:48:40 INFO - "pgo_build", 03:48:40 INFO - "True", 03:48:40 INFO - "Change" 03:48:40 INFO - ] 03:48:40 INFO - ], 03:48:40 INFO - "revision": "4d9b6b7b8550730abb8edc6acabacf6787873eb6" 03:48:40 INFO - } 03:48:40 INFO - ], 03:48:40 INFO - "revision": "4d9b6b7b8550730abb8edc6acabacf6787873eb6" 03:48:40 INFO - } 03:48:40 INFO - } 03:48:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:48:40 INFO - Running post-action listener: _resource_record_post_action 03:48:40 INFO - ##### 03:48:40 INFO - ##### Running download-and-extract step. 03:48:40 INFO - ##### 03:48:40 INFO - Running pre-action listener: _resource_record_pre_action 03:48:40 INFO - Running main action method: download_and_extract 03:48:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:48:40 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:40 INFO - https://queue.taskcluster.net/v1/task/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/test_packages.json 03:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/test_packages.json 03:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:48:41 INFO - Downloaded 1302 bytes. 03:48:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:48:41 INFO - Using the following test package requirements: 03:48:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:48:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:48:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:41 INFO - u'jsshell-linux-x86_64.zip'], 03:48:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:48:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:48:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:48:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:48:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:48:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:48:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:48:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 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/zfsvHXdVQymPb0pMkfBIwg/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/zfsvHXdVQymPb0pMkfBIwg/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/zfsvHXdVQymPb0pMkfBIwg/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/zfsvHXdVQymPb0pMkfBIwg/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/zfsvHXdVQymPb0pMkfBIwg/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 22525991 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 - 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: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/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.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/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:48:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:48:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfsvHXdVQymPb0pMkfBIwg/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:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfsvHXdVQymPb0pMkfBIwg/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:45 INFO - Downloaded 22525991 bytes. 03:48:45 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:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:48:45 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: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/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:48:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:48:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:48:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfsvHXdVQymPb0pMkfBIwg/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:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfsvHXdVQymPb0pMkfBIwg/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:48 INFO - Downloaded 11130997 bytes. 03:48:48 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:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:48:48 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:48 INFO - Return code: 0 03:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:48 INFO - https://queue.taskcluster.net/v1/task/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:48:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:48:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:48:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfsvHXdVQymPb0pMkfBIwg/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:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfsvHXdVQymPb0pMkfBIwg/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:50 INFO - Downloaded 57553262 bytes. 03:48:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:48:50 INFO - mkdir: /builds/slave/test-pgo/properties 03:48:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:48:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:48:50 INFO - Contents: 03:48:50 INFO - build_url:https://queue.taskcluster.net/v1/task/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:48:50 INFO - Running post-action listener: _resource_record_post_action 03:48:50 INFO - Running post-action listener: set_extra_try_arguments 03:48:50 INFO - ##### 03:48:50 INFO - ##### Running populate-webroot step. 03:48:50 INFO - ##### 03:48:50 INFO - Running pre-action listener: _resource_record_pre_action 03:48:50 INFO - Running main action method: populate_webroot 03:48:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:48:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:48:50 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:48:50 INFO - '../fennec_ids.txt'], 03:48:50 INFO - 'tests': ['tcheck2']}, 03:48:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:48:50 INFO - '--tppagecycles', 03:48:50 INFO - '7'], 03:48:50 INFO - 'tests': ['tsvgm']}}, 03:48:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:48:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:48:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:48:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:48:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:48:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:48:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:48:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:50 INFO - 'talos_options': ['--e10s'], 03:48:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:48:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:50 INFO - 'tests': ['damp', 'tps']}, 03:48:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:50 INFO - 'talos_options': ['--e10s'], 03:48:50 INFO - 'tests': ['damp', 'tps']}, 03:48:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:48:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:48:50 INFO - 'other': {'tests': ['a11yr', 03:48:50 INFO - 'ts_paint', 03:48:50 INFO - 'tpaint', 03:48:50 INFO - 'sessionrestore', 03:48:50 INFO - 'sessionrestore_no_auto_restore']}, 03:48:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:48:50 INFO - 'tests': ['a11yr', 03:48:50 INFO - 'ts_paint', 03:48:50 INFO - 'tpaint', 03:48:50 INFO - 'sessionrestore', 03:48:50 INFO - 'sessionrestore_no_auto_restore']}, 03:48:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:48:50 INFO - 'tests': ['a11yr', 03:48:50 INFO - 'ts_paint', 03:48:50 INFO - 'tpaint', 03:48:50 INFO - 'sessionrestore', 03:48:50 INFO - 'sessionrestore_no_auto_restore']}, 03:48:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:48:50 INFO - 'tests': ['a11yr', 03:48:50 INFO - 'ts_paint', 03:48:50 INFO - 'tpaint', 03:48:50 INFO - 'sessionrestore', 03:48:50 INFO - 'sessionrestore_no_auto_restore']}, 03:48:50 INFO - 'other_l64': {'tests': ['a11yr', 03:48:50 INFO - 'ts_paint', 03:48:50 INFO - 'tpaint', 03:48:50 INFO - 'sessionrestore', 03:48:50 INFO - 'sessionrestore_no_auto_restore']}, 03:48:50 INFO - 'other_nol64': {'tests': ['a11yr', 03:48:50 INFO - 'ts_paint', 03:48:50 INFO - 'tpaint', 03:48:50 INFO - 'sessionrestore', 03:48:50 INFO - 'sessionrestore_no_auto_restore']}, 03:48:50 INFO - 'svgr': {'tests': ['tsvgx', 03:48:50 INFO - 'tsvgr_opacity', 03:48:50 INFO - 'tart', 03:48:50 INFO - 'tscrollx', 03:48:50 INFO - 'cart']}, 03:48:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:48:50 INFO - 'tests': ['tsvgx', 03:48:50 INFO - 'tsvgr_opacity', 03:48:50 INFO - 'tart', 03:48:50 INFO - 'tscrollx', 03:48:50 INFO - 'cart']}, 03:48:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:50 INFO - 'tests': ['tp5o']}, 03:48:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:50 INFO - 'talos_options': ['--e10s'], 03:48:50 INFO - 'tests': ['tp5o']}, 03:48:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:50 INFO - 'talos_options': ['--xperf_path', 03:48:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:48:50 INFO - 'tests': ['tp5n']}, 03:48:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:50 INFO - 'talos_options': ['--e10s', 03:48:50 INFO - '--xperf_path', 03:48:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:48:50 INFO - 'tests': ['tp5n']}}, 03:48:50 INFO - 'talos.zip': {'path': '', 03:48:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:48:50 INFO - Running post-action listener: _resource_record_post_action 03:48:50 INFO - ##### 03:48:50 INFO - ##### Running create-virtualenv step. 03:48:50 INFO - ##### 03:48:50 INFO - Running pre-action listener: _resource_record_pre_action 03:48:50 INFO - Running main action method: create_virtualenv 03:48:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:48:50 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:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:48:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:48:50 INFO - Using real prefix '/usr' 03:48:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:48:50 INFO - Installing distribute.............................................................................................................................................................................................done. 03:48:52 INFO - Installing pip.................done. 03:48:52 INFO - Return code: 0 03:48:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:52 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 0x7f5fb9280c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc226c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcd47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd18d70>, '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 0xd19b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd19fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488', '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:52 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:52 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:52 INFO - Using env: {'DISPLAY': ':0', 03:48:52 INFO - 'HOME': '/home/cltbld', 03:48:52 INFO - 'LANG': 'en_US.UTF-8', 03:48:52 INFO - 'LANGUAGE': 'en_US:en', 03:48:52 INFO - 'LOGNAME': 'cltbld', 03:48:52 INFO - 'MAIL': '/var/mail/cltbld', 03:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:52 INFO - 'MOZ_NO_REMOTE': '1', 03:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:52 INFO - 'NO_EM_RESTART': '1', 03:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:52 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:52 INFO - 'SHELL': '/bin/bash', 03:48:52 INFO - 'SHLVL': '1', 03:48:52 INFO - 'TERM': 'linux', 03:48:52 INFO - 'TMOUT': '86400', 03:48:52 INFO - 'USER': 'cltbld', 03:48:52 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488', 03:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:52 INFO - '_': '/tools/buildbot/bin/python'} 03:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:52 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:52 INFO - Cleaning up... 03:48:52 INFO - Return code: 0 03:48:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:52 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 0x7f5fb9280c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc226c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcd47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd18d70>, '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 0xd19b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd19fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488', '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:52 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:52 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:52 INFO - Using env: {'DISPLAY': ':0', 03:48:52 INFO - 'HOME': '/home/cltbld', 03:48:52 INFO - 'LANG': 'en_US.UTF-8', 03:48:52 INFO - 'LANGUAGE': 'en_US:en', 03:48:52 INFO - 'LOGNAME': 'cltbld', 03:48:52 INFO - 'MAIL': '/var/mail/cltbld', 03:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:52 INFO - 'MOZ_NO_REMOTE': '1', 03:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:52 INFO - 'NO_EM_RESTART': '1', 03:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:52 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:52 INFO - 'SHELL': '/bin/bash', 03:48:52 INFO - 'SHLVL': '1', 03:48:52 INFO - 'TERM': 'linux', 03:48:52 INFO - 'TMOUT': '86400', 03:48:52 INFO - 'USER': 'cltbld', 03:48:52 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488', 03:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:52 INFO - '_': '/tools/buildbot/bin/python'} 03:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:53 INFO - Downloading/unpacking psutil>=0.7.1 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 - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:48:55 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:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:48:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:55 INFO - Installing collected packages: psutil 03:48:55 INFO - Running setup.py install for psutil 03:48:55 INFO - building 'psutil._psutil_linux' extension 03:48:55 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:55 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:55 INFO - building 'psutil._psutil_posix' extension 03:48:55 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:55 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:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:55 INFO - Successfully installed psutil 03:48:55 INFO - Cleaning up... 03:48:56 INFO - Return code: 0 03:48:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:56 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 0x7f5fb9280c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc226c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcd47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd18d70>, '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 0xd19b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd19fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488', '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:56 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:56 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:56 INFO - Using env: {'DISPLAY': ':0', 03:48:56 INFO - 'HOME': '/home/cltbld', 03:48:56 INFO - 'LANG': 'en_US.UTF-8', 03:48:56 INFO - 'LANGUAGE': 'en_US:en', 03:48:56 INFO - 'LOGNAME': 'cltbld', 03:48:56 INFO - 'MAIL': '/var/mail/cltbld', 03:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:56 INFO - 'MOZ_NO_REMOTE': '1', 03:48:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:56 INFO - 'NO_EM_RESTART': '1', 03:48:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:56 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:56 INFO - 'SHELL': '/bin/bash', 03:48:56 INFO - 'SHLVL': '1', 03:48:56 INFO - 'TERM': 'linux', 03:48:56 INFO - 'TMOUT': '86400', 03:48:56 INFO - 'USER': 'cltbld', 03:48:56 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488', 03:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:56 INFO - '_': '/tools/buildbot/bin/python'} 03:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 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 mozsystemmonitor-0.0.tar.gz 03:48:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:48:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:48:57 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:57 INFO - Installing collected packages: mozsystemmonitor 03:48:57 INFO - Running setup.py install for mozsystemmonitor 03:48:59 INFO - Successfully installed mozsystemmonitor 03:48:59 INFO - Cleaning up... 03:49:00 INFO - Return code: 0 03:49:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5fb9280c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc226c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcd47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd18d70>, '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 0xd19b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd19fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488', '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:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:49:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:49:00 INFO - Using env: {'DISPLAY': ':0', 03:49:00 INFO - 'HOME': '/home/cltbld', 03:49:00 INFO - 'LANG': 'en_US.UTF-8', 03:49:00 INFO - 'LANGUAGE': 'en_US:en', 03:49:00 INFO - 'LOGNAME': 'cltbld', 03:49:00 INFO - 'MAIL': '/var/mail/cltbld', 03:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:00 INFO - 'MOZ_NO_REMOTE': '1', 03:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:00 INFO - 'NO_EM_RESTART': '1', 03:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:00 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:00 INFO - 'SHELL': '/bin/bash', 03:49:00 INFO - 'SHLVL': '1', 03:49:00 INFO - 'TERM': 'linux', 03:49:00 INFO - 'TMOUT': '86400', 03:49:00 INFO - 'USER': 'cltbld', 03:49:00 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488', 03:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:00 INFO - '_': '/tools/buildbot/bin/python'} 03:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:00 INFO - Downloading/unpacking blobuploader==1.2.4 03:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:03 INFO - Downloading blobuploader-1.2.4.tar.gz 03:49:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:49:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:49:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:49:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:49:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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:03 INFO - Downloading docopt-0.6.1.tar.gz 03:49:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:49:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:49:03 INFO - Installing collected packages: blobuploader, requests, docopt 03:49:03 INFO - Running setup.py install for blobuploader 03:49:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:49:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:49:03 INFO - Running setup.py install for requests 03:49:04 INFO - Running setup.py install for docopt 03:49:04 INFO - Successfully installed blobuploader requests docopt 03:49:04 INFO - Cleaning up... 03:49:04 INFO - Return code: 0 03:49:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:04 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 0x7f5fb9280c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc226c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcd47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd18d70>, '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 0xd19b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd19fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488', '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:04 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:49:04 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:49:04 INFO - Using env: {'DISPLAY': ':0', 03:49:04 INFO - 'HOME': '/home/cltbld', 03:49:04 INFO - 'LANG': 'en_US.UTF-8', 03:49:04 INFO - 'LANGUAGE': 'en_US:en', 03:49:04 INFO - 'LOGNAME': 'cltbld', 03:49:04 INFO - 'MAIL': '/var/mail/cltbld', 03:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:04 INFO - 'MOZ_NO_REMOTE': '1', 03:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:04 INFO - 'NO_EM_RESTART': '1', 03:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:04 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:04 INFO - 'SHELL': '/bin/bash', 03:49:04 INFO - 'SHLVL': '1', 03:49:04 INFO - 'TERM': 'linux', 03:49:04 INFO - 'TMOUT': '86400', 03:49:04 INFO - 'USER': 'cltbld', 03:49:04 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488', 03:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:04 INFO - '_': '/tools/buildbot/bin/python'} 03:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:49:04 INFO - Running setup.py (path:/tmp/pip-GfEYxe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:49:04 INFO - Running setup.py (path:/tmp/pip-0rqZ3M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:49:04 INFO - Running setup.py (path:/tmp/pip-X5NzuB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:49:04 INFO - Running setup.py (path:/tmp/pip-Lwdy3j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:49:04 INFO - Running setup.py (path:/tmp/pip-YcuYM1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:49:05 INFO - Running setup.py (path:/tmp/pip-Vqzopt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:49:05 INFO - Running setup.py (path:/tmp/pip-l6b7Du-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:49:05 INFO - Running setup.py (path:/tmp/pip-wWThOl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:49:05 INFO - Running setup.py (path:/tmp/pip-HAwxVV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:49:05 INFO - Running setup.py (path:/tmp/pip-BpiHUr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:49:05 INFO - Running setup.py (path:/tmp/pip-av27tS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:49:05 INFO - Running setup.py (path:/tmp/pip-eroOvA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:49:05 INFO - Running setup.py (path:/tmp/pip-ThE623-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:49:05 INFO - Running setup.py (path:/tmp/pip-rkje4R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:49:05 INFO - Running setup.py (path:/tmp/pip-I2norL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:49:05 INFO - Running setup.py (path:/tmp/pip-sXFcxs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:49:05 INFO - Running setup.py (path:/tmp/pip-M6Gedx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:49:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:49:05 INFO - Running setup.py install for manifestparser 03:49:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:49:06 INFO - Running setup.py install for mozcrash 03:49:06 INFO - Running setup.py install for mozdebug 03:49:06 INFO - Running setup.py install for mozdevice 03:49:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:49:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:49:06 INFO - Running setup.py install for mozfile 03:49:06 INFO - Running setup.py install for mozhttpd 03:49:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:49:06 INFO - Running setup.py install for mozinfo 03:49:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:49:06 INFO - Running setup.py install for mozInstall 03:49:06 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:49:06 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:49:06 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:49:06 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:49:06 INFO - Running setup.py install for mozleak 03:49:06 INFO - Running setup.py install for mozlog 03:49:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:49:06 INFO - Running setup.py install for moznetwork 03:49:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:49:07 INFO - Running setup.py install for mozprocess 03:49:07 INFO - Running setup.py install for mozprofile 03:49:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:49:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:49:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:49:07 INFO - Running setup.py install for mozrunner 03:49:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:49:07 INFO - Running setup.py install for mozscreenshot 03:49:07 INFO - Running setup.py install for moztest 03:49:07 INFO - Running setup.py install for mozversion 03:49:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:49:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:49:07 INFO - Cleaning up... 03:49:07 INFO - Return code: 0 03:49:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f5fb9280c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc226c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcd47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd18d70>, '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 0xd19b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd19fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488', '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:07 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:07 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:07 INFO - Using env: {'DISPLAY': ':0', 03:49:07 INFO - 'HOME': '/home/cltbld', 03:49:07 INFO - 'LANG': 'en_US.UTF-8', 03:49:07 INFO - 'LANGUAGE': 'en_US:en', 03:49:07 INFO - 'LOGNAME': 'cltbld', 03:49:07 INFO - 'MAIL': '/var/mail/cltbld', 03:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:07 INFO - 'MOZ_NO_REMOTE': '1', 03:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:07 INFO - 'NO_EM_RESTART': '1', 03:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:07 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:07 INFO - 'SHELL': '/bin/bash', 03:49:07 INFO - 'SHLVL': '1', 03:49:07 INFO - 'TERM': 'linux', 03:49:07 INFO - 'TMOUT': '86400', 03:49:07 INFO - 'USER': 'cltbld', 03:49:07 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488', 03:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:07 INFO - '_': '/tools/buildbot/bin/python'} 03:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:49:07 INFO - Running setup.py (path:/tmp/pip-A9MzU5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:49:07 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:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:49:07 INFO - Running setup.py (path:/tmp/pip-0_e4km-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:49:08 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:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:49:08 INFO - Running setup.py (path:/tmp/pip-t3i0dx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:49:08 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:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:49:08 INFO - Running setup.py (path:/tmp/pip-XCdmxm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:49:08 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:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:49:08 INFO - Running setup.py (path:/tmp/pip-jgzFRx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:49:08 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:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:49:08 INFO - Running setup.py (path:/tmp/pip-UYMenm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:49:08 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:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:49:08 INFO - Running setup.py (path:/tmp/pip-dtK6SR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:49:08 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:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:49:08 INFO - Running setup.py (path:/tmp/pip-B0eBvs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:49:08 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:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:49:08 INFO - Running setup.py (path:/tmp/pip-j3crPY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:49:08 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:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:49:08 INFO - Running setup.py (path:/tmp/pip-pzjxpU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:49:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:49:08 INFO - Running setup.py (path:/tmp/pip-RNo979-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:49:08 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:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:49:08 INFO - Running setup.py (path:/tmp/pip-7GuWhG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:49:08 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:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:49:08 INFO - Running setup.py (path:/tmp/pip-PXSU4O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:49:08 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:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:49:08 INFO - Running setup.py (path:/tmp/pip-Nb_oOa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:49:08 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:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:49:08 INFO - Running setup.py (path:/tmp/pip-zSV5aO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:49:08 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:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:49:08 INFO - Running setup.py (path:/tmp/pip-ciy7qv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:49:09 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:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:49:09 INFO - Running setup.py (path:/tmp/pip-FLxowE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:49:09 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:09 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:09 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:09 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:09 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:09 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:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:49:09 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:09 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:09 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:09 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:09 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:09 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:10 INFO - Downloading blessings-1.5.1.tar.gz 03:49:10 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:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:49:10 INFO - Installing collected packages: blessings 03:49:10 INFO - Running setup.py install for blessings 03:49:10 INFO - Successfully installed blessings 03:49:10 INFO - Cleaning up... 03:49:11 INFO - Return code: 0 03:49:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:49:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:49:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:49:11 INFO - Reading from file tmpfile_stdout 03:49:11 INFO - Current package versions: 03:49:11 INFO - argparse == 1.2.1 03:49:11 INFO - blessings == 1.5.1 03:49:11 INFO - blobuploader == 1.2.4 03:49:11 INFO - docopt == 0.6.1 03:49:11 INFO - manifestparser == 1.1 03:49:11 INFO - mozInstall == 1.12 03:49:11 INFO - mozcrash == 0.16 03:49:11 INFO - mozdebug == 0.1 03:49:11 INFO - mozdevice == 0.47 03:49:11 INFO - mozfile == 1.2 03:49:11 INFO - mozhttpd == 0.7 03:49:11 INFO - mozinfo == 0.9 03:49:11 INFO - mozleak == 0.1 03:49:11 INFO - mozlog == 3.1 03:49:11 INFO - moznetwork == 0.27 03:49:11 INFO - mozprocess == 0.22 03:49:11 INFO - mozprofile == 0.27 03:49:11 INFO - mozrunner == 6.11 03:49:11 INFO - mozscreenshot == 0.1 03:49:11 INFO - mozsystemmonitor == 0.0 03:49:11 INFO - moztest == 0.7 03:49:11 INFO - mozversion == 1.4 03:49:11 INFO - psutil == 3.1.1 03:49:11 INFO - requests == 1.2.3 03:49:11 INFO - wsgiref == 0.1.2 03:49:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:49:11 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:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:11 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:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:11 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 0x7f5fb9280c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc226c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcd47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd18d70>, '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 0xd19b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd19fb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488', '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:11 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:11 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:11 INFO - Using env: {'DISPLAY': ':0', 03:49:11 INFO - 'HOME': '/home/cltbld', 03:49:11 INFO - 'LANG': 'en_US.UTF-8', 03:49:11 INFO - 'LANGUAGE': 'en_US:en', 03:49:11 INFO - 'LOGNAME': 'cltbld', 03:49:11 INFO - 'MAIL': '/var/mail/cltbld', 03:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:11 INFO - 'MOZ_NO_REMOTE': '1', 03:49:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:11 INFO - 'NO_EM_RESTART': '1', 03:49:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:11 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:11 INFO - 'SHELL': '/bin/bash', 03:49:11 INFO - 'SHLVL': '1', 03:49:11 INFO - 'TERM': 'linux', 03:49:11 INFO - 'TMOUT': '86400', 03:49:11 INFO - 'USER': 'cltbld', 03:49:11 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488', 03:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:11 INFO - '_': '/tools/buildbot/bin/python'} 03:49:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:11 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:11 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:11 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:11 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:11 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:11 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:11 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:11 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:11 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:11 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:11 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:11 INFO - Cleaning up... 03:49:11 INFO - Return code: 0 03:49:11 INFO - Running post-action listener: _resource_record_post_action 03:49:11 INFO - Running post-action listener: _start_resource_monitoring 03:49:11 INFO - Starting resource monitoring. 03:49:11 INFO - ##### 03:49:11 INFO - ##### Running install step. 03:49:11 INFO - ##### 03:49:11 INFO - Running pre-action listener: _resource_record_pre_action 03:49:11 INFO - Running main action method: install 03:49:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:49:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:49:11 INFO - Reading from file tmpfile_stdout 03:49:11 INFO - Detecting whether we're running mozinstall >=1.0... 03:49:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:49:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:49:11 INFO - Reading from file tmpfile_stdout 03:49:11 INFO - Output received: 03:49:11 INFO - Usage: mozinstall [options] installer 03:49:11 INFO - Options: 03:49:11 INFO - -h, --help show this help message and exit 03:49:11 INFO - -d DEST, --destination=DEST 03:49:11 INFO - Directory to install application into. [default: 03:49:11 INFO - "/builds/slave/test-pgo"] 03:49:11 INFO - --app=APP Application being installed. [default: firefox] 03:49:11 INFO - mkdir: /builds/slave/test-pgo/build/application 03:49:11 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:11 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:26 INFO - Reading from file tmpfile_stdout 03:49:26 INFO - Output received: 03:49:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:49:26 INFO - Running post-action listener: _resource_record_post_action 03:49:26 INFO - ##### 03:49:26 INFO - ##### Running run-tests step. 03:49:26 INFO - ##### 03:49:26 INFO - Running pre-action listener: _resource_record_pre_action 03:49:26 INFO - Running main action method: run_tests 03:49:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:49:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:49:26 INFO - Python 2.7.3 03:49:26 INFO - Return code: 0 03:49:26 INFO - grabbing minidump binary from tooltool 03:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:26 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 0xd18d70>, '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 0xd19b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd19fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:49:26 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:26 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:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:49:26 INFO - Return code: 0 03:49:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:49:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:49:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:49:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:49:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:49:26 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/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:49:26 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/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost 03:49:26 INFO - Using env: {'DISPLAY': ':0', 03:49:26 INFO - 'HOME': '/home/cltbld', 03:49:26 INFO - 'LANG': 'en_US.UTF-8', 03:49:26 INFO - 'LANGUAGE': 'en_US:en', 03:49:26 INFO - 'LOGNAME': 'cltbld', 03:49:26 INFO - 'MAIL': '/var/mail/cltbld', 03:49:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:49:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:26 INFO - 'MOZ_NO_REMOTE': '1', 03:49:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:26 INFO - 'NO_EM_RESTART': '1', 03:49:26 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:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:26 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:49:26 INFO - 'SHELL': '/bin/bash', 03:49:26 INFO - 'SHLVL': '1', 03:49:26 INFO - 'TERM': 'linux', 03:49:26 INFO - 'TMOUT': '86400', 03:49:26 INFO - 'USER': 'cltbld', 03:49:26 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488', 03:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:26 INFO - '_': '/tools/buildbot/bin/python'} 03:49:26 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/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost'] with output_timeout 3600 03:49:26 INFO - mozversion INFO | application_buildid: 20151124023019 03:49:26 INFO - mozversion INFO | application_changeset: 4d9b6b7b8550730abb8edc6acabacf6787873eb6 03:49:26 INFO - mozversion INFO | application_display_name: Nightly 03:49:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:49:26 INFO - mozversion INFO | application_name: Firefox 03:49:26 INFO - mozversion INFO | application_remotingname: firefox 03:49:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 03:49:26 INFO - mozversion INFO | application_vendor: Mozilla 03:49:26 INFO - mozversion INFO | application_version: 45.0a1 03:49:26 INFO - mozversion INFO | platform_buildid: 20151124023019 03:49:26 INFO - mozversion INFO | platform_changeset: 4d9b6b7b8550730abb8edc6acabacf6787873eb6 03:49:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 03:49:26 INFO - mozversion INFO | platform_version: 45.0a1 03:49:26 INFO - 2015-11-24 03:49:26,493 DEBUG : using testdate: 1448365766 03:49:26 INFO - 2015-11-24 03:49:26,493 DEBUG : actual date: 1448365766 03:49:26 INFO - 2015-11-24 03:49:26,502 INFO : starting webserver on 'localhost:52897' 03:49:26 INFO - 2015-11-24 03:49:26,503 INFO : Starting test suite talos-linux64-ix-038 03:49:26 INFO - 2015-11-24 03:49:26,503 INFO : Starting test dromaeo_css 03:49:26 INFO - 2015-11-24 03:49:26,504 DEBUG : operating with platform_type : linux_ 03:49:26 INFO - 2015-11-24 03:49:26,504 INFO : Initialising browser for dromaeo_css test... 03:49:26 INFO - 2015-11-24 03:49:26,521 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpe4AQAl/profile http://localhost:52897/getInfo.html 03:49:30 INFO - 2015-11-24 03:49:30,901 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:49:30 INFO - 2015-11-24 03:49:30,901 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:49:30 INFO - 2015-11-24 03:49:30,901 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:49:30 INFO - 2015-11-24 03:49:30,901 DEBUG : BROWSER_OUTPUT: __metrics 03:49:31 INFO - 2015-11-24 03:49:31,002 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:32 INFO - 2015-11-24 03:49:32,541 INFO : Browser initialized. 03:49:32 INFO - 2015-11-24 03:49:32,542 INFO : Running cycle 1/1 for dromaeo_css test... 03:49:32 INFO - 2015-11-24 03:49:32,542 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpe4AQAl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:49:44 INFO - 2015-11-24 03:49:44,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 140259328 03:49:44 INFO - 2015-11-24 03:49:44,323 DEBUG : BROWSER_OUTPUT: 03:50:35 INFO - 2015-11-24 03:50:35,973 DEBUG : BROWSER_OUTPUT: 1448365835965 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:44 INFO - 2015-11-24 03:52:44,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52897/tests/dromaeo/cssquery-ext.html) 03:52:46 INFO - 2015-11-24 03:52:46,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 246583296 03:52:46 INFO - 2015-11-24 03:52:46,042 DEBUG : BROWSER_OUTPUT: 03:55:48 INFO - 2015-11-24 03:55:48,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/dromaeo/cssquery-ext.html (next: http://localhost:52897/tests/dromaeo/cssquery-jquery.html) 03:55:49 INFO - 2015-11-24 03:55:49,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 222126080 03:55:49 INFO - 2015-11-24 03:55:49,041 DEBUG : BROWSER_OUTPUT: 03:58:51 INFO - 2015-11-24 03:58:51,004 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52897/tests/dromaeo/cssquery-mootools.html) 03:58:51 INFO - 2015-11-24 03:58:51,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 212566016 03:58:51 INFO - 2015-11-24 03:58:51,586 DEBUG : BROWSER_OUTPUT: 04:01:53 INFO - 2015-11-24 04:01:53,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52897/tests/dromaeo/cssquery-prototype.html) 04:01:53 INFO - 2015-11-24 04:01:53,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 200798208 04:01:53 INFO - 2015-11-24 04:01:53,990 DEBUG : BROWSER_OUTPUT: 04:04:56 INFO - 2015-11-24 04:04:56,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52897/tests/dromaeo/cssquery-yui.html) 04:04:57 INFO - 2015-11-24 04:04:57,076 DEBUG : BROWSER_OUTPUT: RSS: Main: 201883648 04:04:57 INFO - 2015-11-24 04:04:57,077 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-24 04:07:59,629 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/dromaeo/cssquery-yui.html (next: http://localhost:52897/tests/dromaeo/cssquery-dojo.html) 04:07:59 INFO - 2015-11-24 04:07:59,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 265084928 04:07:59 INFO - 2015-11-24 04:07:59,879 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-24 04:07:59,880 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:07:59 INFO - 2015-11-24 04:07:59,881 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:07:59 INFO - 2015-11-24 04:07:59,881 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:07:59 INFO - 2015-11-24 04:07:59,881 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:07:59 INFO - 2015-11-24 04:07:59,881 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3183.713465788079;3258.348330333934;3267.803931764093;3269.2971011232567;3295.0938491914726;5313.787448502056;5437.728113594324;5454.318210223722;5514.090175121105;5525.894821035794;5388.0570900092525;5437.293151890259;5484.177373393993;5536.363318218396;5549.139883318092;4957.7521123943925;5009.198528235483;5013.498650134994;5055.696658200502;5081.263216833557;5047.31861198739;5058.291839142523;5121.795128194868;5123.975204959004;5128.230765385185;4886.291487734276;4947.134251505972;5020.623453241022;5060.418051924003;5105.234214867763;5013.047520971004;5017.422996355429;5024.67339622927;5026.170681837492;5070.72111033893;4972.975135124338;4994.600431965434;5005.899882002376;5024.949750502485;5027.730110174346;5122.564582010534;5156.432792392834;5245.370555533361;5263.210518422229;5307.044731948247;5875.647461152302;5876.647401155944;5884.411558844081;5891.970540147315;5897.3218079920925;5759.337676167211;5988.19159413478;5990;6007.609505382136;6013.218281623404;5508.944910550883;5533.529649979757;5538.889222215574;5542.501174894279;5544.362398324204;5916.881662366729;6036.426539478743;6057.545684073712;6059.484943779828;6061.636301821904;5769.278840144982;5805.10020946754;5828.708564571754;5861.9706901465215;5868;5752.913706294409;5876.206712093813;5879.941200588025;5921.822345329647;5940.732667029994;5726.9713651431475;5809.244798176294;5825.7378417971295;5826.592138550345;5860.970695146582;5872.911906321408;5909.261342332208;5914.9112763308585;5915.615484993462;5923.8152369525405;4418.690691651618;4433;4454.77726113693;4543.818247270072;4559.088182363541;3978.6618137458063;3988.74073185242;3997.160596274815;4006.979965100156;4039.1921615676983;5512.39363669996;5514.145307477347;5514.310711161105;5532.585056120807;5538.556915446835;5791.652500849962;5845.298564172326;5850.093235548412;5912.793052243237;5916.970415147983;5389.245505629215;5535.640183388067;5550.27846379968;5576.804811831566;5578;5139.691618502902;5161.380634323905;5162.070827251056;5162.380514338303;5210.921836172461;5824.912626310609;5960.3443621202505;6112.572119951649;6134.018557030854;6143.692815359214;5802.854928626818;5820.243368362086;5926.703664816828;5937.643741375531;5948;5957.49361304294;5974.6713930732485;5978.551608629457;5989.940100598938;6012.8797424052145;5709.571782116275;5739.770409183753;5760.654360738369;5764.221830052889;5787.536997040311;5731.598788084961;5793.507551857971;5834.03738383179;5882.794102206402;5899.587028908107;5727.942720572908;5742.397048309867;5748.597598168088;5756.251687280795;5763.423657634203;5721.628094173865;5737.770489180386;5747.568932330176;5749.396313387034;5755.1367294906095;5493.450654934474;5551.833444996657;5613.045782216951;5624.606277560531;5775.451332123442;5795.76816927335;5857.7949771757785;5881.588288819741;5883.382244864228;5910.7635694573455;5703.714814259353;5747.597668163356;5749.281339832521;5751.48236658686;5763.884722305615 04:07:59 INFO - 2015-11-24 04:07:59,882 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.150345722773;574.6753084507255;587.5270407322109;601.2304250559284;610.5359926455893;30974.380512389765;31771.205719857015;31772.682273177263;31796.523052154236;39025.41461878074;41959.370609440884;42451.363229551505;42609;42672;42717.572824271745;8699.217070463641;8849.292056635453;8870.467771933672;8872;8874.156955089256;7742.922570774276;7913.881291780628;10576.153907687405;10790.136789056896;10794.298370605924;10394.272400931937;10556.683299500988;10563.366198028105;10568.471576421187;10574.947125264363;7782.221777822229;7952.443328966975;10417.895821041768;10535.63125290615;10554;7587.886181707278;10501.422421766876;10761;10787.6224332148;10802.189835762349;39219.803900980594;39592.60407395918;39719;39760.20479590392;39870.401943970865;3088.922776930572;3125.1874512626882;3139.686031396865;3157.2896098377682;3313.4035873542753;29721.108366748816;29945.70054299451;30365.544516832266;30407;31673;3837.6354246346555;3848.1918797052654;3854.6530812227033;3855.61443855615;3986.641202291779;281677;282287;282297;282777;283363.58318208484;55884.161737573966;56906.430935690114;58632.70683646554;58897;59022;60760.39239607636;62015.37984620096;62116;62364;62389.68805155945;14468.27658617086;14886.702265954837;14905.478308259158;14910.254487275593;14919.925400373146;11400.771984560262;11445.198836081394;11491.827622585668;11500.424978751029;11518.654440366803;18736.718949215774;19204;19275.590551181103;19289.421317360222;19297.324593639154;7397.852042959218;7490.775276741707;7545.245475452521;7591.962040189874;7666.731664391719;853.3727710133047;920;987.7678745494803;1010.7927874785798;1010.8678280325935;25662.615060774104;27090;27607.171784846487;27631;27680.169594912186;971.9951400242953;976.1751320134475;1013.8783345998528;1033.565902321027;1087.22263581538;14387;14623.461511716663;14668.046576972463;14762.335694893756;14779.92610036943;308146;311720;313022;313089;313184;51810.74094629503;51995.74002129965;52072;52104.21843672348;52247;1246.9002479801595;1257.2959142880015;1263.9873601264053;1268.898488120948;1285.9742805143844;26666.600001000388;27330.24714477579;27562.5865612012;27658;27768.722312776612;44850.551494485946;45447;45473;45485;45518;302315;305270;305468;305584;305624;27106.593401099395;27599.310017248925;30592.388152237276;31056.378872422876;31589.36821263608;38856.80571597124;39366.21267574575;39368;39615.80192099136;39802;32519.512207316435;32860.34279314352;34574.48138277877;35826.28347433089;36844.447333289485;26232.73767262303;30666.386672265984;33010.44031767132;37016.444753328185;38327.80836095801;34618;35353;36114;36159.45760813537;36456.27087458183;28945.131646050653;29795.10614681563;30029.399412012073;30239;30262.54606180953;23546.199787449765;23707.28878133659;25076.74923250744;25079.24762257135;25105.623415649145 04:07:59 INFO - 2015-11-24 04:07:59,885 DEBUG : BROWSER_OUTPUT: |2;jquery.html;330.1910319716693;347.1356322756337;351.61146932639423;351.9102628829648;353.34454586741595;14233.359498822552;14668.779968300458;16102.275397607107;17304.653906921852;18785.34251301205;16425.342986280535;16443.83556164438;16592.917035414837;16862.325506979738;16922.323107075703;5178.6892786432745;5322.2548843161985;5329.280547126146;5329.733513324319;5330.573554115662;3979.283728928792;4070.3690927906223;5231.476852314757;5756.65460072397;5956.285245770492;5841.824745257649;5877.177195192677;5883.264591926009;5908.645481271116;5909.054551271797;5696.08862581987;5768.826935191951;5803.013487707079;5807.970960145214;5815.38938411467;5015.32293140425;5016.272640467148;5032.0690672225755;5032.144535428986;5034.874128146789;20787.272445464336;21045.5790884183;21086.156553737834;21343.67984480234;21345.57308853814;2000.239908834648;2000.459875833517;2048.764392094913;2070.109852763311;2164.982458244638;12920;13341.266230357327;13345.666358341023;13477.932610336984;13911.582652520441;1725.4996051145154;1755.3768412213735;1765.0909781462558;1817.3457555280088;1819.790724066736;57427.42572574263;57488.71255643737;58323.70838145782;60550.39449605492;60868.39131608716;9230.07699230085;9246.90753092474;9303.53482325881;9359.110884465965;9430.481323527272;11551.942240288912;11577.189596728149;11604.071674266039;11631.47658355376;11703.23928944616;7373.88939165913;7452.888206676904;7564.130125035581;7564.735234266775;7625.6568454419685;7343.963280183565;7352.080989876265;7363.226861179606;7427.368673662691;7440.03279573652;5716.771329146787;5722.227499287626;5738.139279108167;5754.280714910637;5755.733738577506;1589.4675283780064;1628.902265864052;1633.3303345628235;1638.6394993101499;1659.775930249425;819.0703551469006;831.8170002599419;864.3560547392233;877.4252864373846;913.6482454255026;16283.83716162847;16378.754318685229;16556.42052528156;16906.661866762595;16946.661066778597;812.557156349779;850.715010471499;881.8809460722848;888.1562515610196;977.1516030770225;9413.576389062371;9684.95157524222;9993.150582200595;10055.748606284755;10060.144887684482;544279;546082;555213;564437;566355;60411.697941510014;60729.39270607326;65284;77085.61457192678;78177.218227817;1164.7262893220086;1178.0104712042098;1206.1677442564603;1213.1265488848014;1236.2335352081586;14679.119252844863;14699.706005880036;14805;14830.851691483378;15085.698286034438;32769.67230327666;32940.835295823366;32985.505217421276;33126;33383.66616333806;43941.12117757691;47104;48274;48310.27534586914;48857.755711221216;8992.370534062553;9427.434353938786;9467.100625440573;9557;9567.808643827224;11016;11026.173037022096;11081.501332439899;11097.778044439228;16952.576185594964;14220.573382798533;14753.631159221106;14758.852411476177;15005.32476038559;15012.673035679487;13657.38541765603;13781.448742050206;13884.166949983033;14078.718425631634;14196.716065678422;14351.282435878373;14377.712445750818;14771.187584682515;14804.555863323687;14822.62943426423;9254.583543740413;9489.715308540479;9559.426434413957;9713.757156071155;9775.169110625677;10241.74395640115;12635;14789.038712483654;15184.46854360092;15207 04:07:59 INFO - 2015-11-24 04:07:59,886 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1367.2685113464286;1420.9360578773958;1474.6460849396142;1598.4804938395018;1786.8659850511215;6861.142357205349;7470.962645186773;7752.651130699118;7763.922360776391;7773.222677732224;7605.80985475362;7727.884081738778;7730.304272615464;7731.690732370713;7734.961325193366;1976.8319692826055;2012.4868158619604;2275.6927814745004;2278.943026424336;2300.66640337151;2327.8836058197107;2331.557004169211;2336.5794157051723;2336.6611841283;2337.7895989360954;2268.739095004079;2327.522857814144;2327.8137748980125;2330.8601483910934;2331.3821837213154;1928.8842669439878;1962.7939066398037;2245.191730976847;2291.8166546676393;2293.931182064524;2283.862968221912;2284.7601001894895;2302.9424264393356;2305.8616483010906;2343.379004563792;7770.611469426506;7780.961095194488;7791.337736292422;7798.7270445534705;7803.921960780376;4722.858314250578;4808.230683090724;4812.566868981773;4829.444613869415;4844.128056949748;3062.2803641144314;3095.272610936428;3096.3033317503605;3102.379524095167;3242.1732458223237;998.4907697074472;1006.4414250091196;1024.3188279794003;1042.801867645145;1053.5469748008354;10702.46487675613;10827.296225745302;10850.620228291971;10864.456777161111;10865.293755905841;4105.137921036616;4179.665626749853;4208.810603522848;4222.282212023902;4271.017665936852;8703.695370662123;8750.69372571957;8757.255633271116;8763.737087887373;8765.693200738071;4774.331593576902;4786.353842231254;4787.784549695272;4791.95208047922;4793.736344501086;4420.58004489573;4423.778811059434;4429.867103986886;4432.401625780479;4439.200943830077;3481.1471189558215;3542.309249696336;3543.875964341236;3546.5034895114704;3582.98208508961;1065.5311662868314;1084.9240553161203;1090.7055095124272;1102.8400881872083;1104.618906477264;981.0434826044692;996.7009897030862;1001.5593139018808;1110.3005106782675;1336.6057013180941;7256.854862902818;7430.925690743024;7432.739854105081;7460.925390746023;7472.962635186789;477.61074724099745;486.6131425516723;487.63914703119434;487.70250147410053;487.92681097835606;5759.366469688331;5769.942300577024;5873.618214816023;5881.852953676193;5955.67243801595;8933;9102.726918192333;9108;9141.588628511732;9149.588268527932;8691.695790647296;8880.333974951904;8903.821923561492;8977.955110224408;8984.281257499384;7011.824704382431;7049.577025378391;7082.079329687108;7100;7115.395191408685;6689.49828762835;6748.763793267212;6797.388235058868;6798.048273241849;6823.454123670193;8005.279524842792;8029.478083924526;8059.758207253792;8143.877841832259;8182.959085204536;8174.264316211569;8257.504549727035;8310.252077313071;8336.374771892253;8338.082810890919;6864.7940561783225;6941.409980151744;6947.305269473214;6951.721931122901;6956.478264130109;7624.123225828879;7677.9232207677205;7711.884321735066;7715.57564333967;7719.691212351443;7181.389581885598;7211.1707153678;7253.746118885813;7361.558306501627;7365.668544915598;5880.8235752927485;6916.239213686591;6965.825854353681;7083.787486375417;7177.282271772781;6924.619145947021;7013.684384202825;7017.122859642544;7024.824379390556;7025.508214424941;6502;6605.57063790852;6679.966600166968;6683.097781799394;6690.431313338421;6520.18497687789;6581.6709164542535;6595.505337099833;6597;6610 04:07:59 INFO - 2015-11-24 04:07:59,889 DEBUG : BROWSER_OUTPUT: |4;prototype.html;319.3899651665319;325.8289398066016;330.78003127919925;332.70223150280486;336.36762885774755;5866.76532938683;5949.910751338728;5972.343042265347;5980.252468441445;6016.255285967064;5814.273215848019;5900.645961242329;5902.203202567652;5914.970425147868;5951.970240148804;4624.190766615837;4624.352590637313;4625.144348295559;4626.606738427237;4637.605803506706;4373.497047839492;4464.620507256887;4516.435445569304;4625.745583992879;4662.207424737802;4593.4947155813;4598.563136502044;4603.125406172833;4605.171069207541;4619.5611416915335;4589.2657174851865;4592.862214133581;4605.815767369318;4607.7004994675235;4609.631229501631;4032.0927791247027;4036.636702696742;4038.172174704179;4042.5957404259634;4056.0671045659665;5610.102383618642;5691;5702;5707.4577915098;5729.828105156852;5341;5350.946490535084;5359.464053594609;5364;5368.919466207971;6072.817815465543;6306.684665766693;6329.87340253197;6333.841653958688;6336.714847831859;4332.523422423531;4338.414314067592;4446.110777844412;4458.955410445887;4467.776611169461;6550.148480697527;6568.441682456997;6570.540062195648;6572.8356791080605;6584.111144995412;4558.361829343895;4565.109803588335;4566.931496027562;4573.382593349856;4573.588377046015;4254.149170165979;4417.8232870684815;4423.579759922803;4621.19129152397;4631.560001799824;5187.325647665779;5193.68837869729;5196.350456192976;5196.740162991835;5204.687718736888;6368.936310636927;6373.5857169283845;6375.234971803413;6375.713092910737;6393.840153996094;1546.1418912503443;1574.0634322578048;1575.7951466309535;1576.9842301576837;1577.510971598808;999.3853779925439;1004.5379125602159;1018.9847152292722;1020.505055048301;1025.6974192613197;6140;6187;6193.938060619426;6195.597286176384;6198.698273362645;6555.639439830759;6559.311272316433;6565.704543295563;6576.0793488911595;6577.2436169841085;6055.364186760415;6177.752889884444;6183.84540386494;6189.288231853305;6193.938060619426;3543.982280088583;3573.981415296628;3574.1243395367783;3574.6067932527403;3581.6776490116013;6674.966625166843;6754.628495432798;6757.763478278237;6760.1549806274215;6762.256151823295;6706.966465167643;6708;6712.194536655633;6715.093462382613;6719.563228390139;6676.098726671934;6791.864162716718;6818.249992500821;6851.246362900077;6851.554648947803;6326.588771729823;6425.389587989133;6454.354564543696;6585.242697089704;6624.072629831924;6464.870702586016;6499.967500162469;6508.15393998796;6516.152900122954;6543.149390579194;6763.053172555945;6786.796396108125;6787.898181527183;6788.49086318538;6796.116504854337;4392.5168231495145;4459.754713490789;4486.214912390384;4487.663425243055;4494.685372023927;6481.449076828522;6530.934690653223;6537.1174891389055;6540.50946179029;6542.934570654423;6360.141380913517;6366.299707032315;6367.490600752021;6372.107904893226;6382.425581697669;6162.414570615784;6320.652364119834;6360.4911607072245;6372.458341040878;6376.553641245068;6245.812625621239;6253.468455181361;6259.217597800275;6268.905966410416;6270.592411493239;6377.043443483514;6387.744490220339;6388.233411990591;6390;6402.295747467681;6180.072989051499;6261.874762504815;6261.9373806263175;6346.111544383883;6349.587276826992 04:07:59 INFO - 2015-11-24 04:07:59,890 DEBUG : BROWSER_OUTPUT: |5;yui.html;861.2378045429797;862.1766213266332;865.2818160926432;870.316801310971;882.3514716683238;12667.366631668414;12894.613161605155;12961.351932403366;13033.152845065064;13255.138416002954;13213.405396757145;13239.146519487256;13256.403461844217;13264.867351326484;13307.534236301732;665.6971078159438;679.8266442057269;815.2866242038217;837.6774941647479;837.736113124367;831.6881169561415;832.5753865528594;839.911809260028;840.2018082821313;840.6301227459898;869.9260562852165;884.1512148337604;884.3897710579679;884.5665623844302;884.712468447757;714.5319815520817;723.5513981331555;854.6239654552008;878.1087196495562;878.2447095497866;645.3578689204224;647.2233320015953;648.4423395879539;648.8929326661096;649.1204418013571;13591.728165436734;13751;13778.173309601356;13793;13793.586192414243;12215.26708397499;12267;12617.053720970964;12644.367781610883;12683.873161268362;10277.383356998604;10287.845682314772;10387;10451.216158788046;10672.946635266851;3616.584092829332;3645.1616128290375;3690.280395322913;3703.055720791208;3789.7915614641183;44466.33300500495;44570.108597827864;44863.775681121384;44866.55133448656;44909.55090449119;9758.9024109758;10082.747931301776;10212.693619191436;10239.129673977646;10521.21090918169;15522.844771552365;15536.300866461037;15566.688666226839;15568.688626227413;15571.688566228611;7554.7733567991945;7625.54246745186;7666.9616651917495;7806.882896756553;7893.802654933673;4318.287482565404;4324.17840610283;4324.935125973113;4390.890227744332;4412.889677758018;3192.7924684895406;3199.4241036613166;3238.2552013037134;3239.5302681111107;3241.303119829248;569.5073761196618;575.4331982996745;578.6383510306059;581.6335708503616;592.6384905207819;651.6253154436123;653.4641593893057;665.6838001949133;666.7462781625636;716.5843810589845;8110.878336824952;8358.498490090493;8524.786880327918;8621.094785047606;8659.583612357743;581.1050981488545;652.7682672651235;658.6048370977471;661.1504217081124;685.6948657847211;3885.7668539887695;4077.2660921033907;4261.424707664488;4277.593628605277;4304.80628371724;57425.42574574285;58627.41372586219;58656.70671646614;58709.70645146747;58769.412305877246;49995;50473.747631261605;50870.49129508658;50947.490525094276;51076.74461627668;47280.290795638095;47443.5255647446;47659.76170119127;47865.52134478611;48040.27939580909;8426.115257897833;8542.316614670686;8624.482531048157;8673.565380997128;8740.257078148428;34779;34858.47712284267;35442;35592.110197245274;35718.28563428769;44691.776541117084;44840.55159448364;45646;46071;46233.306500403196;9992.250581206294;10047;10066.094051535398;10201.38791672502;10215.94892025535;10993.340399576051;11170.385628790495;11183.161262905152;11318.037966772916;11652.592159274724;10390.116840068376;10508.316959397614;10583;10630.893691062991;10688.25182237236;10474.476276186313;10562.471876406302;10757.246992710436;11133.610323638633;11176.608818691308;7910.604469776373;10206.489675516343;10660.147188225079;11169.359473466173;11220.158488113588;9896.703098907044;10030.398176109456;10210.744731381776;10488.10851077667;10532.315399499008;7848.9215107848195;9102.772430689021;9108.544572771203;9677.177439917687;9739.853902191331 04:07:59 INFO - 2015-11-24 04:07:59,890 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:07:59 INFO - 2015-11-24 04:07:59,890 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:07:59 INFO - 2015-11-24 04:07:59,891 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,879 04:07:59 INFO - 2015-11-24 04:07:59,891 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:07:59 INFO - 2015-11-24 04:07:59,891 DEBUG : BROWSER_OUTPUT: __startTimestamp1448366879879__endTimestamp 04:07:59 INFO - 2015-11-24 04:07:59,891 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-24 04:07:59,891 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:07:59 INFO - 2015-11-24 04:07:59,891 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:07:59 INFO - 2015-11-24 04:07:59,891 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-24 04:07:59,892 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5458.65 Median:5726.97 stddev:607.14 (10.6%) stddev-sans-first:582.18 04:07:59 INFO - 2015-11-24 04:07:59,892 DEBUG : BROWSER_OUTPUT: Values: 3183.7 3258.3 3267.8 3269.3 3295.1 5313.8 5437.7 5454.3 5514.1 5525.9 5388.1 5437.3 5484.2 5536.4 5549.1 4957.8 5009.2 5013.5 5055.7 5081.3 5047.3 5058.3 5121.8 5124.0 5128.2 4886.3 4947.1 5020.6 5060.4 5105.2 5013.0 5017.4 5024.7 5026.2 5070.7 4973.0 4994.6 5005.9 5024.9 5027.7 5122.6 5156.4 5245.4 5263.2 5307.0 5875.6 5876.6 5884.4 5892.0 5897.3 5759.3 5988.2 5990.0 6007.6 6013.2 5508.9 5533.5 5538.9 5542.5 5544.4 5916.9 6036.4 6057.5 6059.5 6061.6 5769.3 5805.1 5828.7 5862.0 5868.0 5752.9 5876.2 5879.9 5921.8 5940.7 5727.0 5809.2 5825.7 5826.6 5861.0 5872.9 5909.3 5914.9 5915.6 5923.8 4418.7 4433.0 4454.8 4543.8 4559.1 3978.7 3988.7 3997.2 4007.0 4039.2 5512.4 5514.1 5514.3 5532.6 5538.6 5791.7 5845.3 5850.1 5912.8 5917.0 5389.2 5535.6 5550.3 5576.8 5578.0 5139.7 5161.4 5162.1 5162.4 5210.9 5824.9 5960.3 6112.6 6134.0 6143.7 5802.9 5820.2 5926.7 5937.6 5948.0 5957.5 5974.7 5978.6 5989.9 6012.9 5709.6 5739.8 5760.7 5764.2 5787.5 5731.6 5793.5 5834.0 5882.8 5899.6 5727.9 5742.4 5748.6 5756.3 5763.4 5721.6 5737.8 5747.6 5749.4 5755.1 5493.5 5551.8 5613.0 5624.6 5775.5 5795.8 5857.8 5881.6 5883.4 5910.8 5703.7 5747.6 5749.3 5751.5 5763.9 04:07:59 INFO - 2015-11-24 04:07:59,892 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-24 04:07:59,892 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46392.38 Median:313055.50 stddev:78452.32 (25.1%) stddev-sans-first:78596.92 04:07:59 INFO - 2015-11-24 04:07:59,892 DEBUG : BROWSER_OUTPUT: Values: 557.2 574.7 587.5 601.2 610.5 30974.4 31771.2 31772.7 31796.5 39025.4 41959.4 42451.4 42609.0 42672.0 42717.6 8699.2 8849.3 8870.5 8872.0 8874.2 7742.9 7913.9 10576.2 10790.1 10794.3 10394.3 10556.7 10563.4 10568.5 10574.9 7782.2 7952.4 10417.9 10535.6 10554.0 7587.9 10501.4 10761.0 10787.6 10802.2 39219.8 39592.6 39719.0 39760.2 39870.4 3088.9 3125.2 3139.7 3157.3 3313.4 29721.1 29945.7 30365.5 30407.0 31673.0 3837.6 3848.2 3854.7 3855.6 3986.6 281677.0 282287.0 282297.0 282777.0 283363.6 55884.2 56906.4 58632.7 58897.0 59022.0 60760.4 62015.4 62116.0 62364.0 62389.7 14468.3 14886.7 14905.5 14910.3 14919.9 11400.8 11445.2 11491.8 11500.4 11518.7 18736.7 19204.0 19275.6 19289.4 19297.3 7397.9 7490.8 7545.2 7592.0 7666.7 853.4 920.0 987.8 1010.8 1010.9 25662.6 27090.0 27607.2 27631.0 27680.2 972.0 976.2 1013.9 1033.6 1087.2 14387.0 14623.5 14668.0 14762.3 14779.9 308146.0 311720.0 313022.0 313089.0 313184.0 51810.7 51995.7 52072.0 52104.2 52247.0 1246.9 1257.3 1264.0 1268.9 1286.0 26666.6 27330.2 27562.6 27658.0 27768.7 44850.6 45447.0 45473.0 45485.0 45518.0 302315.0 305270.0 305468.0 305584.0 305624.0 27106.6 27599.3 30592.4 31056.4 31589.4 38856.8 39366.2 39368.0 39615.8 39802.0 32519.5 32860.3 34574.5 35826.3 36844.4 26232.7 30666.4 33010.4 37016.4 38327.8 34618.0 35353.0 36114.0 36159.5 36456.3 28945.1 29795.1 30029.4 30239.0 30262.5 23546.2 23707.3 25076.7 25079.2 25105.6 04:07:59 INFO - 2015-11-24 04:07:59,892 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-24 04:07:59,892 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28804.28 Median:352.63 stddev:90547.18 (25677.9%) stddev-sans-first:90775.94 04:07:59 INFO - 2015-11-24 04:07:59,894 DEBUG : BROWSER_OUTPUT: Values: 330.2 347.1 351.6 351.9 353.3 14233.4 14668.8 16102.3 17304.7 18785.3 16425.3 16443.8 16592.9 16862.3 16922.3 5178.7 5322.3 5329.3 5329.7 5330.6 3979.3 4070.4 5231.5 5756.7 5956.3 5841.8 5877.2 5883.3 5908.6 5909.1 5696.1 5768.8 5803.0 5808.0 5815.4 5015.3 5016.3 5032.1 5032.1 5034.9 20787.3 21045.6 21086.2 21343.7 21345.6 2000.2 2000.5 2048.8 2070.1 2165.0 12920.0 13341.3 13345.7 13477.9 13911.6 1725.5 1755.4 1765.1 1817.3 1819.8 57427.4 57488.7 58323.7 60550.4 60868.4 9230.1 9246.9 9303.5 9359.1 9430.5 11551.9 11577.2 11604.1 11631.5 11703.2 7373.9 7452.9 7564.1 7564.7 7625.7 7344.0 7352.1 7363.2 7427.4 7440.0 5716.8 5722.2 5738.1 5754.3 5755.7 1589.5 1628.9 1633.3 1638.6 1659.8 819.1 831.8 864.4 877.4 913.6 16283.8 16378.8 16556.4 16906.7 16946.7 812.6 850.7 881.9 888.2 977.2 9413.6 9685.0 9993.2 10055.7 10060.1 544279.0 546082.0 555213.0 564437.0 566355.0 60411.7 60729.4 65284.0 77085.6 78177.2 1164.7 1178.0 1206.2 1213.1 1236.2 14679.1 14699.7 14805.0 14830.9 15085.7 32769.7 32940.8 32985.5 33126.0 33383.7 43941.1 47104.0 48274.0 48310.3 48857.8 8992.4 9427.4 9467.1 9557.0 9567.8 11016.0 11026.2 11081.5 11097.8 16952.6 14220.6 14753.6 14758.9 15005.3 15012.7 13657.4 13781.4 13884.2 14078.7 14196.7 14351.3 14377.7 14771.2 14804.6 14822.6 9254.6 9489.7 9559.4 9713.8 9775.2 10241.7 12635.0 14789.0 15184.5 15207.0 04:07:59 INFO - 2015-11-24 04:07:59,894 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-24 04:07:59,894 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5397.51 Median:6588.59 stddev:2807.52 (42.6%) stddev-sans-first:2799.06 04:07:59 INFO - 2015-11-24 04:07:59,894 DEBUG : BROWSER_OUTPUT: Values: 1367.3 1420.9 1474.6 1598.5 1786.9 6861.1 7471.0 7752.7 7763.9 7773.2 7605.8 7727.9 7730.3 7731.7 7735.0 1976.8 2012.5 2275.7 2278.9 2300.7 2327.9 2331.6 2336.6 2336.7 2337.8 2268.7 2327.5 2327.8 2330.9 2331.4 1928.9 1962.8 2245.2 2291.8 2293.9 2283.9 2284.8 2302.9 2305.9 2343.4 7770.6 7781.0 7791.3 7798.7 7803.9 4722.9 4808.2 4812.6 4829.4 4844.1 3062.3 3095.3 3096.3 3102.4 3242.2 998.5 1006.4 1024.3 1042.8 1053.5 10702.5 10827.3 10850.6 10864.5 10865.3 4105.1 4179.7 4208.8 4222.3 4271.0 8703.7 8750.7 8757.3 8763.7 8765.7 4774.3 4786.4 4787.8 4792.0 4793.7 4420.6 4423.8 4429.9 4432.4 4439.2 3481.1 3542.3 3543.9 3546.5 3583.0 1065.5 1084.9 1090.7 1102.8 1104.6 981.0 996.7 1001.6 1110.3 1336.6 7256.9 7430.9 7432.7 7460.9 7473.0 477.6 486.6 487.6 487.7 487.9 5759.4 5769.9 5873.6 5881.9 5955.7 8933.0 9102.7 9108.0 9141.6 9149.6 8691.7 8880.3 8903.8 8978.0 8984.3 7011.8 7049.6 7082.1 7100.0 7115.4 6689.5 6748.8 6797.4 6798.0 6823.5 8005.3 8029.5 8059.8 8143.9 8183.0 8174.3 8257.5 8310.3 8336.4 8338.1 6864.8 6941.4 6947.3 6951.7 6956.5 7624.1 7677.9 7711.9 7715.6 7719.7 7181.4 7211.2 7253.7 7361.6 7365.7 5880.8 6916.2 6965.8 7083.8 7177.3 6924.6 7013.7 7017.1 7024.8 7025.5 6502.0 6605.6 6680.0 6683.1 6690.4 6520.2 6581.7 6595.5 6597.0 6610.0 04:07:59 INFO - 2015-11-24 04:07:59,894 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-24 04:07:59,894 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5310.88 Median:6106.41 stddev:1605.90 (26.3%) stddev-sans-first:1566.10 04:07:59 INFO - 2015-11-24 04:07:59,895 DEBUG : BROWSER_OUTPUT: Values: 319.4 325.8 330.8 332.7 336.4 5866.8 5949.9 5972.3 5980.3 6016.3 5814.3 5900.6 5902.2 5915.0 5952.0 4624.2 4624.4 4625.1 4626.6 4637.6 4373.5 4464.6 4516.4 4625.7 4662.2 4593.5 4598.6 4603.1 4605.2 4619.6 4589.3 4592.9 4605.8 4607.7 4609.6 4032.1 4036.6 4038.2 4042.6 4056.1 5610.1 5691.0 5702.0 5707.5 5729.8 5341.0 5350.9 5359.5 5364.0 5368.9 6072.8 6306.7 6329.9 6333.8 6336.7 4332.5 4338.4 4446.1 4459.0 4467.8 6550.1 6568.4 6570.5 6572.8 6584.1 4558.4 4565.1 4566.9 4573.4 4573.6 4254.1 4417.8 4423.6 4621.2 4631.6 5187.3 5193.7 5196.4 5196.7 5204.7 6368.9 6373.6 6375.2 6375.7 6393.8 1546.1 1574.1 1575.8 1577.0 1577.5 999.4 1004.5 1019.0 1020.5 1025.7 6140.0 6187.0 6193.9 6195.6 6198.7 6555.6 6559.3 6565.7 6576.1 6577.2 6055.4 6177.8 6183.8 6189.3 6193.9 3544.0 3574.0 3574.1 3574.6 3581.7 6675.0 6754.6 6757.8 6760.2 6762.3 6707.0 6708.0 6712.2 6715.1 6719.6 6676.1 6791.9 6818.2 6851.2 6851.6 6326.6 6425.4 6454.4 6585.2 6624.1 6464.9 6500.0 6508.2 6516.2 6543.1 6763.1 6786.8 6787.9 6788.5 6796.1 4392.5 4459.8 4486.2 4487.7 4494.7 6481.4 6530.9 6537.1 6540.5 6542.9 6360.1 6366.3 6367.5 6372.1 6382.4 6162.4 6320.7 6360.5 6372.5 6376.6 6245.8 6253.5 6259.2 6268.9 6270.6 6377.0 6387.7 6388.2 6390.0 6402.3 6180.1 6261.9 6261.9 6346.1 6349.6 04:07:59 INFO - 2015-11-24 04:07:59,895 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-24 04:07:59,896 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13612.98 Median:44865.16 stddev:15911.79 (35.5%) stddev-sans-first:15927.61 04:07:59 INFO - 2015-11-24 04:07:59,896 DEBUG : BROWSER_OUTPUT: Values: 861.2 862.2 865.3 870.3 882.4 12667.4 12894.6 12961.4 13033.2 13255.1 13213.4 13239.1 13256.4 13264.9 13307.5 665.7 679.8 815.3 837.7 837.7 831.7 832.6 839.9 840.2 840.6 869.9 884.2 884.4 884.6 884.7 714.5 723.6 854.6 878.1 878.2 645.4 647.2 648.4 648.9 649.1 13591.7 13751.0 13778.2 13793.0 13793.6 12215.3 12267.0 12617.1 12644.4 12683.9 10277.4 10287.8 10387.0 10451.2 10672.9 3616.6 3645.2 3690.3 3703.1 3789.8 44466.3 44570.1 44863.8 44866.6 44909.6 9758.9 10082.7 10212.7 10239.1 10521.2 15522.8 15536.3 15566.7 15568.7 15571.7 7554.8 7625.5 7667.0 7806.9 7893.8 4318.3 4324.2 4324.9 4390.9 4412.9 3192.8 3199.4 3238.3 3239.5 3241.3 569.5 575.4 578.6 581.6 592.6 651.6 653.5 665.7 666.7 716.6 8110.9 8358.5 8524.8 8621.1 8659.6 581.1 652.8 658.6 661.2 685.7 3885.8 4077.3 4261.4 4277.6 4304.8 57425.4 58627.4 58656.7 58709.7 58769.4 49995.0 50473.7 50870.5 50947.5 51076.7 47280.3 47443.5 47659.8 47865.5 48040.3 8426.1 8542.3 8624.5 8673.6 8740.3 34779.0 34858.5 35442.0 35592.1 35718.3 44691.8 44840.6 45646.0 46071.0 46233.3 9992.3 10047.0 10066.1 10201.4 10215.9 10993.3 11170.4 11183.2 11318.0 11652.6 10390.1 10508.3 10583.0 10630.9 10688.3 10474.5 10562.5 10757.2 11133.6 11176.6 7910.6 10206.5 10660.1 11169.4 11220.2 9896.7 10030.4 10210.7 10488.1 10532.3 7848.9 9102.8 9108.5 9677.2 9739.9 04:07:59 INFO - 2015-11-24 04:07:59,896 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:07:59 INFO - 2015-11-24 04:07:59,896 DEBUG : BROWSER_OUTPUT: 04:08:00 INFO - 2015-11-24 04:08:00,557 INFO : Browser exited with error code: 0 04:08:00 INFO - 2015-11-24 04:08:00,579 INFO : Completed test dromaeo_css (00:18:34) 04:08:00 INFO - 2015-11-24 04:08:00,579 INFO : Starting test kraken 04:08:00 INFO - 2015-11-24 04:08:00,579 DEBUG : operating with platform_type : linux_ 04:08:00 INFO - 2015-11-24 04:08:00,579 INFO : Initialising browser for kraken test... 04:08:00 INFO - 2015-11-24 04:08:00,585 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqJ3Fsw/profile http://localhost:52897/getInfo.html 04:08:04 INFO - 2015-11-24 04:08:04,518 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:08:04 INFO - 2015-11-24 04:08:04,518 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:08:04 INFO - 2015-11-24 04:08:04,519 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:08:04 INFO - 2015-11-24 04:08:04,519 DEBUG : BROWSER_OUTPUT: __metrics 04:08:04 INFO - 2015-11-24 04:08:04,683 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-24 04:08:06,105 INFO : Browser initialized. 04:08:06 INFO - 2015-11-24 04:08:06,106 INFO : Running cycle 1/1 for kraken test... 04:08:06 INFO - 2015-11-24 04:08:06,106 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqJ3Fsw/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-24 04:08:17,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 140787712 04:08:17 INFO - 2015-11-24 04:08:17,927 DEBUG : BROWSER_OUTPUT: 04:08:20 INFO - 2015-11-24 04:08:20,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52897/tests/kraken/driver.html?testName=audio-beat-detection) 04:08:20 INFO - 2015-11-24 04:08:20,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 180015104 04:08:20 INFO - 2015-11-24 04:08:20,975 DEBUG : BROWSER_OUTPUT: 04:08:23 INFO - 2015-11-24 04:08:23,591 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52897/tests/kraken/driver.html?testName=audio-dft) 04:08:24 INFO - 2015-11-24 04:08:24,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 169070592 04:08:24 INFO - 2015-11-24 04:08:24,165 DEBUG : BROWSER_OUTPUT: 04:08:27 INFO - 2015-11-24 04:08:27,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52897/tests/kraken/driver.html?testName=audio-fft) 04:08:27 INFO - 2015-11-24 04:08:27,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 151347200 04:08:27 INFO - 2015-11-24 04:08:27,574 DEBUG : BROWSER_OUTPUT: 04:08:29 INFO - 2015-11-24 04:08:29,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52897/tests/kraken/driver.html?testName=audio-oscillator) 04:08:30 INFO - 2015-11-24 04:08:30,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 153317376 04:08:30 INFO - 2015-11-24 04:08:30,111 DEBUG : BROWSER_OUTPUT: 04:08:32 INFO - 2015-11-24 04:08:32,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52897/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:08:32 INFO - 2015-11-24 04:08:32,845 DEBUG : BROWSER_OUTPUT: RSS: Main: 155131904 04:08:32 INFO - 2015-11-24 04:08:32,845 DEBUG : BROWSER_OUTPUT: 04:08:35 INFO - 2015-11-24 04:08:35,743 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52897/tests/kraken/driver.html?testName=imaging-darkroom) 04:08:36 INFO - 2015-11-24 04:08:36,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 156487680 04:08:36 INFO - 2015-11-24 04:08:36,312 DEBUG : BROWSER_OUTPUT: 04:08:39 INFO - 2015-11-24 04:08:39,698 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52897/tests/kraken/driver.html?testName=imaging-desaturate) 04:08:40 INFO - 2015-11-24 04:08:40,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 156835840 04:08:40 INFO - 2015-11-24 04:08:40,271 DEBUG : BROWSER_OUTPUT: 04:08:42 INFO - 2015-11-24 04:08:42,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52897/tests/kraken/driver.html?testName=json-parse-financial) 04:08:43 INFO - 2015-11-24 04:08:43,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 156876800 04:08:43 INFO - 2015-11-24 04:08:43,559 DEBUG : BROWSER_OUTPUT: 04:08:45 INFO - 2015-11-24 04:08:45,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52897/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:08:45 INFO - 2015-11-24 04:08:45,668 DEBUG : BROWSER_OUTPUT: RSS: Main: 165421056 04:08:45 INFO - 2015-11-24 04:08:45,668 DEBUG : BROWSER_OUTPUT: 04:08:47 INFO - 2015-11-24 04:08:47,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52897/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:08:48 INFO - 2015-11-24 04:08:48,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 165351424 04:08:48 INFO - 2015-11-24 04:08:48,060 DEBUG : BROWSER_OUTPUT: 04:08:50 INFO - 2015-11-24 04:08:50,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52897/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:08:50 INFO - 2015-11-24 04:08:50,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 169754624 04:08:50 INFO - 2015-11-24 04:08:50,697 DEBUG : BROWSER_OUTPUT: 04:08:53 INFO - 2015-11-24 04:08:53,077 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52897/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:08:53 INFO - 2015-11-24 04:08:53,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 179122176 04:08:53 INFO - 2015-11-24 04:08:53,659 DEBUG : BROWSER_OUTPUT: 04:08:56 INFO - 2015-11-24 04:08:56,193 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52897/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:08:56 INFO - 2015-11-24 04:08:56,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 176537600 04:08:56 INFO - 2015-11-24 04:08:56,764 DEBUG : BROWSER_OUTPUT: 04:08:58 INFO - 2015-11-24 04:08:58,438 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52897/tests/kraken/driver.html?testName=ai-astar) 04:08:58 INFO - 2015-11-24 04:08:58,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 235433984 04:08:58 INFO - 2015-11-24 04:08:58,688 DEBUG : BROWSER_OUTPUT: 04:08:58 INFO - 2015-11-24 04:08:58,688 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:08:58 INFO - 2015-11-24 04:08:58,688 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:08:58 INFO - 2015-11-24 04:08:58,688 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:08:58 INFO - 2015-11-24 04:08:58,688 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:08:58 INFO - 2015-11-24 04:08:58,688 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;104;110;109;110;100;110;110;103 04:08:58 INFO - 2015-11-24 04:08:58,688 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;121;149;175;126;155;155;123;169;132 04:08:58 INFO - 2015-11-24 04:08:58,688 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;161;159;161;159;160;162;162;160 04:08:58 INFO - 2015-11-24 04:08:58,689 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;81;92;77;71;71;102;96;71 04:08:58 INFO - 2015-11-24 04:08:58,689 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;133;93;94;94;138;93;93;134 04:08:58 INFO - 2015-11-24 04:08:58,689 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;110;109;110;109;110;110 04:08:58 INFO - 2015-11-24 04:08:58,689 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;145;145;145;145;145;145;146 04:08:58 INFO - 2015-11-24 04:08:58,689 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;96;96;95 04:08:58 INFO - 2015-11-24 04:08:58,689 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;58;60;58;59;58;57;58;58;56 04:08:58 INFO - 2015-11-24 04:08:58,689 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;67;68;68;68;68;68;69;68 04:08:58 INFO - 2015-11-24 04:08:58,689 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;85;84;84;92;86;85;86;86;84 04:08:58 INFO - 2015-11-24 04:08:58,689 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;117;115;116;122;114;123;129;115;122 04:08:58 INFO - 2015-11-24 04:08:58,689 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;141;161;151;149;136;149;154;149;137 04:08:58 INFO - 2015-11-24 04:08:58,689 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;68;68;66;68;66;69;66;69 04:08:58 INFO - 2015-11-24 04:08:58,689 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:08:58 INFO - 2015-11-24 04:08:58,689 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:08:58 INFO - 2015-11-24 04:08:58,689 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,906 04:08:58 INFO - 2015-11-24 04:08:58,689 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:08:58 INFO - 2015-11-24 04:08:58,690 DEBUG : BROWSER_OUTPUT: __startTimestamp1448366938686__endTimestamp 04:08:58 INFO - 2015-11-24 04:08:58,690 DEBUG : BROWSER_OUTPUT: 04:08:58 INFO - 2015-11-24 04:08:58,693 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:08:58 INFO - 2015-11-24 04:08:58,693 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:08:58 INFO - 2015-11-24 04:08:58,693 DEBUG : BROWSER_OUTPUT: 04:08:58 INFO - 2015-11-24 04:08:58,693 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.70 Median:110.00 stddev:3.86 (3.5%) stddev-sans-first:4.00 04:08:58 INFO - 2015-11-24 04:08:58,693 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 104.0 110.0 109.0 110.0 100.0 110.0 110.0 103.0 04:08:58 INFO - 2015-11-24 04:08:58,693 DEBUG : BROWSER_OUTPUT: 04:08:58 INFO - 2015-11-24 04:08:58,693 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.00 Median:152.00 stddev:19.10 (12.6%) stddev-sans-first:20.25 04:08:58 INFO - 2015-11-24 04:08:58,693 DEBUG : BROWSER_OUTPUT: Values: 145.0 121.0 149.0 175.0 126.0 155.0 155.0 123.0 169.0 132.0 04:08:58 INFO - 2015-11-24 04:08:58,693 DEBUG : BROWSER_OUTPUT: 04:08:58 INFO - 2015-11-24 04:08:58,694 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 04:08:58 INFO - 2015-11-24 04:08:58,694 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 161.0 159.0 161.0 159.0 160.0 162.0 162.0 160.0 04:08:58 INFO - 2015-11-24 04:08:58,694 DEBUG : BROWSER_OUTPUT: 04:08:58 INFO - 2015-11-24 04:08:58,694 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.30 Median:74.00 stddev:12.01 (16.2%) stddev-sans-first:12.26 04:08:58 INFO - 2015-11-24 04:08:58,694 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 81.0 92.0 77.0 71.0 71.0 102.0 96.0 71.0 04:08:58 INFO - 2015-11-24 04:08:58,694 DEBUG : BROWSER_OUTPUT: 04:08:58 INFO - 2015-11-24 04:08:58,694 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.80 Median:93.00 stddev:20.19 (21.7%) stddev-sans-first:20.88 04:08:58 INFO - 2015-11-24 04:08:58,694 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 133.0 93.0 94.0 94.0 138.0 93.0 93.0 134.0 04:08:58 INFO - 2015-11-24 04:08:58,694 DEBUG : BROWSER_OUTPUT: 04:08:58 INFO - 2015-11-24 04:08:58,694 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:58 INFO - 2015-11-24 04:08:58,695 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 110.0 109.0 110.0 109.0 110.0 110.0 04:08:58 INFO - 2015-11-24 04:08:58,695 DEBUG : BROWSER_OUTPUT: 04:08:58 INFO - 2015-11-24 04:08:58,695 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:08:58 INFO - 2015-11-24 04:08:58,695 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 04:08:58 INFO - 2015-11-24 04:08:58,695 DEBUG : BROWSER_OUTPUT: 04:08:58 INFO - 2015-11-24 04:08:58,695 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:08:58 INFO - 2015-11-24 04:08:58,695 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 04:08:58 INFO - 2015-11-24 04:08:58,695 DEBUG : BROWSER_OUTPUT: 04:08:58 INFO - 2015-11-24 04:08:58,695 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:1.05 (1.8%) stddev-sans-first:1.12 04:08:58 INFO - 2015-11-24 04:08:58,695 DEBUG : BROWSER_OUTPUT: Values: 58.0 58.0 60.0 58.0 59.0 58.0 57.0 58.0 58.0 56.0 04:08:58 INFO - 2015-11-24 04:08:58,695 DEBUG : BROWSER_OUTPUT: 04:08:58 INFO - 2015-11-24 04:08:58,696 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 04:08:58 INFO - 2015-11-24 04:08:58,696 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 68.0 68.0 68.0 68.0 68.0 69.0 68.0 04:08:58 INFO - 2015-11-24 04:08:58,696 DEBUG : BROWSER_OUTPUT: 04:08:58 INFO - 2015-11-24 04:08:58,696 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.00 stddev:3.06 (3.6%) stddev-sans-first:2.49 04:08:58 INFO - 2015-11-24 04:08:58,696 DEBUG : BROWSER_OUTPUT: Values: 92.0 85.0 84.0 84.0 92.0 86.0 85.0 86.0 86.0 84.0 04:08:58 INFO - 2015-11-24 04:08:58,696 DEBUG : BROWSER_OUTPUT: 04:08:58 INFO - 2015-11-24 04:08:58,696 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:121.50 stddev:4.79 (3.9%) stddev-sans-first:5.04 04:08:58 INFO - 2015-11-24 04:08:58,696 DEBUG : BROWSER_OUTPUT: Values: 121.0 117.0 115.0 116.0 122.0 114.0 123.0 129.0 115.0 122.0 04:08:58 INFO - 2015-11-24 04:08:58,696 DEBUG : BROWSER_OUTPUT: 04:08:58 INFO - 2015-11-24 04:08:58,696 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.50 Median:149.00 stddev:8.22 (5.5%) stddev-sans-first:8.13 04:08:58 INFO - 2015-11-24 04:08:58,696 DEBUG : BROWSER_OUTPUT: Values: 138.0 141.0 161.0 151.0 149.0 136.0 149.0 154.0 149.0 137.0 04:08:58 INFO - 2015-11-24 04:08:58,696 DEBUG : BROWSER_OUTPUT: 04:08:58 INFO - 2015-11-24 04:08:58,696 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.17 (1.7%) stddev-sans-first:1.24 04:08:58 INFO - 2015-11-24 04:08:58,696 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 68.0 68.0 66.0 68.0 66.0 69.0 66.0 69.0 04:08:58 INFO - 2015-11-24 04:08:58,696 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:08:58 INFO - 2015-11-24 04:08:58,696 DEBUG : BROWSER_OUTPUT: 04:08:59 INFO - 2015-11-24 04:08:59,585 INFO : Browser exited with error code: 0 04:08:59 INFO - 2015-11-24 04:08:59,639 INFO : Completed test kraken (00:00:59) 04:08:59 INFO - 2015-11-24 04:08:59,639 INFO : Starting test v8_7 04:08:59 INFO - 2015-11-24 04:08:59,639 DEBUG : operating with platform_type : linux_ 04:08:59 INFO - 2015-11-24 04:08:59,639 INFO : Initialising browser for v8_7 test... 04:08:59 INFO - 2015-11-24 04:08:59,645 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMLtsXg/profile http://localhost:52897/getInfo.html 04:09:03 INFO - 2015-11-24 04:09:03,561 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:09:03 INFO - 2015-11-24 04:09:03,561 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:09:03 INFO - 2015-11-24 04:09:03,561 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:09:03 INFO - 2015-11-24 04:09:03,561 DEBUG : BROWSER_OUTPUT: __metrics 04:09:03 INFO - 2015-11-24 04:09:03,670 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:05 INFO - 2015-11-24 04:09:05,215 INFO : Browser initialized. 04:09:05 INFO - 2015-11-24 04:09:05,216 INFO : Running cycle 1/1 for v8_7 test... 04:09:05 INFO - 2015-11-24 04:09:05,216 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMLtsXg/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:16 INFO - 2015-11-24 04:09:16,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 140079104 04:09:16 INFO - 2015-11-24 04:09:16,984 DEBUG : BROWSER_OUTPUT: 04:09:38 INFO - 2015-11-24 04:09:38,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52897/tests/v8_7/run.html (next: http://localhost:52897/tests/v8_7/run.html) 04:09:38 INFO - 2015-11-24 04:09:38,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 632946688 04:09:38 INFO - 2015-11-24 04:09:38,713 DEBUG : BROWSER_OUTPUT: 04:09:38 INFO - 2015-11-24 04:09:38,713 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:09:38 INFO - 2015-11-24 04:09:38,713 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:09:38 INFO - 2015-11-24 04:09:38,713 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:09:38 INFO - 2015-11-24 04:09:38,713 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:09:38 INFO - 2015-11-24 04:09:38,713 DEBUG : BROWSER_OUTPUT: |0;Richards;191.68104274487254 04:09:38 INFO - 2015-11-24 04:09:38,713 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.28793471925394 04:09:38 INFO - 2015-11-24 04:09:38,713 DEBUG : BROWSER_OUTPUT: |2;Encrypt;286.20492272467084 04:09:38 INFO - 2015-11-24 04:09:38,713 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5000 04:09:38 INFO - 2015-11-24 04:09:38,714 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1956.9471624266146 04:09:38 INFO - 2015-11-24 04:09:38,714 DEBUG : BROWSER_OUTPUT: |5;Earley;798.0845969672786 04:09:38 INFO - 2015-11-24 04:09:38,714 DEBUG : BROWSER_OUTPUT: |6;Boyer;12280.487804878048 04:09:38 INFO - 2015-11-24 04:09:38,714 DEBUG : BROWSER_OUTPUT: |7;RegExp;25641.02564102564 04:09:38 INFO - 2015-11-24 04:09:38,714 DEBUG : BROWSER_OUTPUT: |8;Splay;663.4799235181645 04:09:38 INFO - 2015-11-24 04:09:38,714 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 04:09:38 INFO - 2015-11-24 04:09:38,714 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:09:38 INFO - 2015-11-24 04:09:38,714 DEBUG : BROWSER_OUTPUT: __startTimestamp1448366978706__endTimestamp 04:09:38 INFO - 2015-11-24 04:09:38,714 DEBUG : BROWSER_OUTPUT: 04:09:38 INFO - 2015-11-24 04:09:38,714 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:09:38 INFO - 2015-11-24 04:09:38,714 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:09:38 INFO - 2015-11-24 04:09:38,714 DEBUG : BROWSER_OUTPUT: 04:09:38 INFO - 2015-11-24 04:09:38,714 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:191.68 Median:191.68 stddev:0.00 (0.0%) 04:09:38 INFO - 2015-11-24 04:09:38,714 DEBUG : BROWSER_OUTPUT: Values: 191.7 04:09:38 INFO - 2015-11-24 04:09:38,714 DEBUG : BROWSER_OUTPUT: 04:09:38 INFO - 2015-11-24 04:09:38,714 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.29 Median:194.29 stddev:0.00 (0.0%) 04:09:38 INFO - 2015-11-24 04:09:38,715 DEBUG : BROWSER_OUTPUT: Values: 194.3 04:09:38 INFO - 2015-11-24 04:09:38,715 DEBUG : BROWSER_OUTPUT: 04:09:38 INFO - 2015-11-24 04:09:38,715 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:286.20 Median:286.20 stddev:0.00 (0.0%) 04:09:38 INFO - 2015-11-24 04:09:38,715 DEBUG : BROWSER_OUTPUT: Values: 286.2 04:09:38 INFO - 2015-11-24 04:09:38,715 DEBUG : BROWSER_OUTPUT: 04:09:38 INFO - 2015-11-24 04:09:38,715 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5000.00 Median:5000.00 stddev:0.00 (0.0%) 04:09:38 INFO - 2015-11-24 04:09:38,715 DEBUG : BROWSER_OUTPUT: Values: 5000.0 04:09:38 INFO - 2015-11-24 04:09:38,715 DEBUG : BROWSER_OUTPUT: 04:09:38 INFO - 2015-11-24 04:09:38,715 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1956.95 Median:1956.95 stddev:0.00 (0.0%) 04:09:38 INFO - 2015-11-24 04:09:38,715 DEBUG : BROWSER_OUTPUT: Values: 1956.9 04:09:38 INFO - 2015-11-24 04:09:38,715 DEBUG : BROWSER_OUTPUT: 04:09:38 INFO - 2015-11-24 04:09:38,715 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:798.08 Median:798.08 stddev:0.00 (0.0%) 04:09:38 INFO - 2015-11-24 04:09:38,715 DEBUG : BROWSER_OUTPUT: Values: 798.1 04:09:38 INFO - 2015-11-24 04:09:38,715 DEBUG : BROWSER_OUTPUT: 04:09:38 INFO - 2015-11-24 04:09:38,715 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 04:09:38 INFO - 2015-11-24 04:09:38,716 DEBUG : BROWSER_OUTPUT: Values: 12280.5 04:09:38 INFO - 2015-11-24 04:09:38,716 DEBUG : BROWSER_OUTPUT: 04:09:38 INFO - 2015-11-24 04:09:38,716 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25641.03 Median:25641.03 stddev:0.00 (0.0%) 04:09:38 INFO - 2015-11-24 04:09:38,716 DEBUG : BROWSER_OUTPUT: Values: 25641.0 04:09:38 INFO - 2015-11-24 04:09:38,716 DEBUG : BROWSER_OUTPUT: 04:09:38 INFO - 2015-11-24 04:09:38,716 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:663.48 Median:663.48 stddev:0.00 (0.0%) 04:09:38 INFO - 2015-11-24 04:09:38,716 DEBUG : BROWSER_OUTPUT: Values: 663.5 04:09:38 INFO - 2015-11-24 04:09:38,716 DEBUG : BROWSER_OUTPUT: 04:09:38 INFO - 2015-11-24 04:09:38,716 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 04:09:38 INFO - 2015-11-24 04:09:38,716 DEBUG : BROWSER_OUTPUT: Values: 4845.4 04:09:38 INFO - 2015-11-24 04:09:38,716 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:09:38 INFO - 2015-11-24 04:09:38,716 DEBUG : BROWSER_OUTPUT: 04:09:39 INFO - 2015-11-24 04:09:39,573 INFO : Browser exited with error code: 0 04:09:39 INFO - 2015-11-24 04:09:39,588 INFO : Completed test v8_7 (00:00:39) 04:09:39 INFO - 2015-11-24 04:09:39,667 INFO : Completed test suite (00:20:13) 04:09:39 INFO - 2015-11-24 04:09:39,667 DEBUG : Working with test: dromaeo_css 04:09:39 INFO - 2015-11-24 04:09:39,667 DEBUG : Generating results file: dromaeo_css 04:09:39 INFO - 2015-11-24 04:09:39,668 DEBUG : Working with test: kraken 04:09:39 INFO - 2015-11-24 04:09:39,668 DEBUG : Generating results file: kraken 04:09:39 INFO - 2015-11-24 04:09:39,668 INFO : javascript benchmark 04:09:39 INFO - 2015-11-24 04:09:39,668 DEBUG : Working with test: v8_7 04:09:39 INFO - 2015-11-24 04:09:39,669 DEBUG : Generating results file: v8_7 04:09:39 INFO - 2015-11-24 04:09:39,669 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:09:39 INFO - 2015-11-24 04:09:39,724 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 04:09:39 INFO - 2015-11-24 04:09:39,724 DEBUG : process_Request line: dromaeo_css 6952.97 graph.html#tests=[[72,201,35]] 04:09:39 INFO - 2015-11-24 04:09:39,724 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:09:39 INFO - 2015-11-24 04:09:39,753 DEBUG : process_Request line: kraken 1495.00 graph.html#tests=[[232,201,35]] 04:09:39 INFO - 2015-11-24 04:09:39,753 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:09:39 INFO - 2015-11-24 04:09:39,783 DEBUG : process_Request line: v8_7 19355.66 graph.html#tests=[[230,201,35]] 04:09:39 INFO - 2015-11-24 04:09:39,784 INFO : javascript benchmark 04:09:39 INFO - 2015-11-24 04:09:39,788 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3183.713465788079, 3258.348330333934, 3267.803931764093, 3269.2971011232567, 3295.0938491914726, 5313.787448502056, 5437.728113594324, 5454.318210223722, 5514.090175121105, 5525.894821035794, 5388.0570900092525, 5437.293151890259, 5484.177373393993, 5536.363318218396, 5549.139883318092, 4957.7521123943925, 5009.198528235483, 5013.498650134994, 5055.696658200502, 5081.263216833557, 5047.31861198739, 5058.291839142523, 5121.795128194868, 5123.975204959004, 5128.230765385185, 4886.291487734276, 4947.134251505972, 5020.623453241022, 5060.418051924003, 5105.234214867763, 5013.047520971004, 5017.422996355429, 5024.67339622927, 5026.170681837492, 5070.72111033893, 4972.975135124338, 4994.600431965434, 5005.899882002376, 5024.949750502485, 5027.730110174346, 5122.564582010534, 5156.432792392834, 5245.370555533361, 5263.210518422229, 5307.044731948247, 5875.647461152302, 5876.647401155944, 5884.411558844081, 5891.970540147315, 5897.3218079920925, 5759.337676167211, 5988.19159413478, 5990.0, 6007.609505382136, 6013.218281623404, 5508.944910550883, 5533.529649979757, 5538.889222215574, 5542.501174894279, 5544.362398324204, 5916.881662366729, 6036.426539478743, 6057.545684073712, 6059.484943779828, 6061.636301821904, 5769.278840144982, 5805.10020946754, 5828.708564571754, 5861.9706901465215, 5868.0, 5752.913706294409, 5876.206712093813, 5879.941200588025, 5921.822345329647, 5940.732667029994, 5726.9713651431475, 5809.244798176294, 5825.7378417971295, 5826.592138550345, 5860.970695146582, 5872.911906321408, 5909.261342332208, 5914.9112763308585, 5915.615484993462, 5923.8152369525405, 4418.690691651618, 4433.0, 4454.77726113693, 4543.818247270072, 4559.088182363541, 3978.6618137458063, 3988.74073185242, 3997.160596274815, 4006.979965100156, 4039.1921615676983, 5512.39363669996, 5514.145307477347, 5514.310711161105, 5532.585056120807, 5538.556915446835, 5791.652500849962, 5845.298564172326, 5850.093235548412, 5912.793052243237, 5916.970415147983, 5389.245505629215, 5535.640183388067, 5550.27846379968, 5576.804811831566, 5578.0, 5139.691618502902, 5161.380634323905, 5162.070827251056, 5162.380514338303, 5210.921836172461, 5824.912626310609, 5960.3443621202505, 6112.572119951649, 6134.018557030854, 6143.692815359214, 5802.854928626818, 5820.243368362086, 5926.703664816828, 5937.643741375531, 5948.0, 5957.49361304294, 5974.6713930732485, 5978.551608629457, 5989.940100598938, 6012.8797424052145, 5709.571782116275, 5739.770409183753, 5760.654360738369, 5764.221830052889, 5787.536997040311, 5731.598788084961, 5793.507551857971, 5834.03738383179, 5882.794102206402, 5899.587028908107, 5727.942720572908, 5742.397048309867, 5748.597598168088, 5756.251687280795, 5763.423657634203, 5721.628094173865, 5737.770489180386, 5747.568932330176, 5749.396313387034, 5755.1367294906095, 5493.450654934474, 5551.833444996657, 5613.045782216951, 5624.606277560531, 5775.451332123442, 5795.76816927335, 5857.7949771757785, 5881.588288819741, 5883.382244864228, 5910.7635694573455, 5703.714814259353, 5747.597668163356, 5749.281339832521, 5751.48236658686, 5763.884722305615], "unit": "ms", "name": "dojo.html", "value": 5418.824018881307}, {"lowerIsBetter": false, "replicates": [557.150345722773, 574.6753084507255, 587.5270407322109, 601.2304250559284, 610.5359926455893, 30974.380512389765, 31771.205719857015, 31772.682273177263, 31796.523052154236, 39025.41461878074, 41959.370609440884, 42451.363229551505, 42609.0, 42672.0, 42717.572824271745, 8699.217070463641, 8849.292056635453, 8870.467771933672, 8872.0, 8874.156955089256, 7742.922570774276, 7913.881291780628, 10576.153907687405, 10790.136789056896, 10794.298370605924, 10394.272400931937, 10556.683299500988, 10563.366198028105, 10568.471576421187, 10574.947125264363, 7782.221777822229, 7952.443328966975, 10417.895821041768, 10535.63125290615, 10554.0, 7587.886181707278, 10501.422421766876, 10761.0, 10787.6224332148, 10802.189835762349, 39219.803900980594, 39592.60407395918, 39719.0, 39760.20479590392, 39870.401943970865, 3088.922776930572, 3125.1874512626882, 3139.686031396865, 3157.2896098377682, 3313.4035873542753, 29721.108366748816, 29945.70054299451, 30365.544516832266, 30407.0, 31673.0, 3837.6354246346555, 3848.1918797052654, 3854.6530812227033, 3855.61443855615, 3986.641202291779, 281677.0, 282287.0, 282297.0, 282777.0, 283363.58318208484, 55884.161737573966, 56906.430935690114, 58632.70683646554, 58897.0, 59022.0, 60760.39239607636, 62015.37984620096, 62116.0, 62364.0, 62389.68805155945, 14468.27658617086, 14886.702265954837, 14905.478308259158, 14910.254487275593, 14919.925400373146, 11400.771984560262, 11445.198836081394, 11491.827622585668, 11500.424978751029, 11518.654440366803, 18736.718949215774, 19204.0, 19275.590551181103, 19289.421317360222, 19297.324593639154, 7397.852042959218, 7490.775276741707, 7545.245475452521, 7591.962040189874, 7666.731664391719, 853.3727710133047, 920.0, 987.7678745494803, 1010.7927874785798, 1010.8678280325935, 25662.615060774104, 27090.0, 27607.171784846487, 27631.0, 27680.169594912186, 971.9951400242953, 976.1751320134475, 1013.8783345998528, 1033.565902321027, 1087.22263581538, 14387.0, 14623.461511716663, 14668.046576972463, 14762.335694893756, 14779.92610036943, 308146.0, 311720.0, 313022.0, 313089.0, 313184.0, 51810.74094629503, 51995.74002129965, 52072.0, 52104.21843672348, 52247.0, 1246.9002479801595, 1257.2959142880015, 1263.9873601264053, 1268.898488120948, 1285.9742805143844, 26666.600001000388, 27330.24714477579, 27562.5865612012, 27658.0, 27768.722312776612, 44850.551494485946, 45447.0, 45473.0, 45485.0, 45518.0, 302315.0, 305270.0, 305468.0, 305584.0, 305624.0, 27106.593401099395, 27599.310017248925, 30592.388152237276, 31056.378872422876, 31589.36821263608, 38856.80571597124, 39366.21267574575, 39368.0, 39615.80192099136, 39802.0, 32519.512207316435, 32860.34279314352, 34574.48138277877, 35826.28347433089, 36844.447333289485, 26232.73767262303, 30666.386672265984, 33010.44031767132, 37016.444753328185, 38327.80836095801, 34618.0, 35353.0, 36114.0, 36159.45760813537, 36456.27087458183, 28945.131646050653, 29795.10614681563, 30029.399412012073, 30239.0, 30262.54606180953, 23546.199787449765, 23707.28878133659, 25076.74923250744, 25079.24762257135, 25105.623415649145], "unit": "ms", "name": "ext.html", "value": 18279.32342877919}, {"lowerIsBetter": false, "replicates": [330.1910319716693, 347.1356322756337, 351.61146932639423, 351.9102628829648, 353.34454586741595, 14233.359498822552, 14668.779968300458, 16102.275397607107, 17304.653906921852, 18785.34251301205, 16425.342986280535, 16443.83556164438, 16592.917035414837, 16862.325506979738, 16922.323107075703, 5178.6892786432745, 5322.2548843161985, 5329.280547126146, 5329.733513324319, 5330.573554115662, 3979.283728928792, 4070.3690927906223, 5231.476852314757, 5756.65460072397, 5956.285245770492, 5841.824745257649, 5877.177195192677, 5883.264591926009, 5908.645481271116, 5909.054551271797, 5696.08862581987, 5768.826935191951, 5803.013487707079, 5807.970960145214, 5815.38938411467, 5015.32293140425, 5016.272640467148, 5032.0690672225755, 5032.144535428986, 5034.874128146789, 20787.272445464336, 21045.5790884183, 21086.156553737834, 21343.67984480234, 21345.57308853814, 2000.239908834648, 2000.459875833517, 2048.764392094913, 2070.109852763311, 2164.982458244638, 12920.0, 13341.266230357327, 13345.666358341023, 13477.932610336984, 13911.582652520441, 1725.4996051145154, 1755.3768412213735, 1765.0909781462558, 1817.3457555280088, 1819.790724066736, 57427.42572574263, 57488.71255643737, 58323.70838145782, 60550.39449605492, 60868.39131608716, 9230.07699230085, 9246.90753092474, 9303.53482325881, 9359.110884465965, 9430.481323527272, 11551.942240288912, 11577.189596728149, 11604.071674266039, 11631.47658355376, 11703.23928944616, 7373.88939165913, 7452.888206676904, 7564.130125035581, 7564.735234266775, 7625.6568454419685, 7343.963280183565, 7352.080989876265, 7363.226861179606, 7427.368673662691, 7440.03279573652, 5716.771329146787, 5722.227499287626, 5738.139279108167, 5754.280714910637, 5755.733738577506, 1589.4675283780064, 1628.902265864052, 1633.3303345628235, 1638.6394993101499, 1659.775930249425, 819.0703551469006, 831.8170002599419, 864.3560547392233, 877.4252864373846, 913.6482454255026, 16283.83716162847, 16378.754318685229, 16556.42052528156, 16906.661866762595, 16946.661066778597, 812.557156349779, 850.715010471499, 881.8809460722848, 888.1562515610196, 977.1516030770225, 9413.576389062371, 9684.95157524222, 9993.150582200595, 10055.748606284755, 10060.144887684482, 544279.0, 546082.0, 555213.0, 564437.0, 566355.0, 60411.697941510014, 60729.39270607326, 65284.0, 77085.61457192678, 78177.218227817, 1164.7262893220086, 1178.0104712042098, 1206.1677442564603, 1213.1265488848014, 1236.2335352081586, 14679.119252844863, 14699.706005880036, 14805.0, 14830.851691483378, 15085.698286034438, 32769.67230327666, 32940.835295823366, 32985.505217421276, 33126.0, 33383.66616333806, 43941.12117757691, 47104.0, 48274.0, 48310.27534586914, 48857.755711221216, 8992.370534062553, 9427.434353938786, 9467.100625440573, 9557.0, 9567.808643827224, 11016.0, 11026.173037022096, 11081.501332439899, 11097.778044439228, 16952.576185594964, 14220.573382798533, 14753.631159221106, 14758.852411476177, 15005.32476038559, 15012.673035679487, 13657.38541765603, 13781.448742050206, 13884.166949983033, 14078.718425631634, 14196.716065678422, 14351.282435878373, 14377.712445750818, 14771.187584682515, 14804.555863323687, 14822.62943426423, 9254.583543740413, 9489.715308540479, 9559.426434413957, 9713.757156071155, 9775.169110625677, 10241.74395640115, 12635.0, 14789.038712483654, 15184.46854360092, 15207.0], "unit": "ms", "name": "jquery.html", "value": 8762.237003645178}, {"lowerIsBetter": false, "replicates": [1367.2685113464286, 1420.9360578773958, 1474.6460849396142, 1598.4804938395018, 1786.8659850511215, 6861.142357205349, 7470.962645186773, 7752.651130699118, 7763.922360776391, 7773.222677732224, 7605.80985475362, 7727.884081738778, 7730.304272615464, 7731.690732370713, 7734.961325193366, 1976.8319692826055, 2012.4868158619604, 2275.6927814745004, 2278.943026424336, 2300.66640337151, 2327.8836058197107, 2331.557004169211, 2336.5794157051723, 2336.6611841283, 2337.7895989360954, 2268.739095004079, 2327.522857814144, 2327.8137748980125, 2330.8601483910934, 2331.3821837213154, 1928.8842669439878, 1962.7939066398037, 2245.191730976847, 2291.8166546676393, 2293.931182064524, 2283.862968221912, 2284.7601001894895, 2302.9424264393356, 2305.8616483010906, 2343.379004563792, 7770.611469426506, 7780.961095194488, 7791.337736292422, 7798.7270445534705, 7803.921960780376, 4722.858314250578, 4808.230683090724, 4812.566868981773, 4829.444613869415, 4844.128056949748, 3062.2803641144314, 3095.272610936428, 3096.3033317503605, 3102.379524095167, 3242.1732458223237, 998.4907697074472, 1006.4414250091196, 1024.3188279794003, 1042.801867645145, 1053.5469748008354, 10702.46487675613, 10827.296225745302, 10850.620228291971, 10864.456777161111, 10865.293755905841, 4105.137921036616, 4179.665626749853, 4208.810603522848, 4222.282212023902, 4271.017665936852, 8703.695370662123, 8750.69372571957, 8757.255633271116, 8763.737087887373, 8765.693200738071, 4774.331593576902, 4786.353842231254, 4787.784549695272, 4791.95208047922, 4793.736344501086, 4420.58004489573, 4423.778811059434, 4429.867103986886, 4432.401625780479, 4439.200943830077, 3481.1471189558215, 3542.309249696336, 3543.875964341236, 3546.5034895114704, 3582.98208508961, 1065.5311662868314, 1084.9240553161203, 1090.7055095124272, 1102.8400881872083, 1104.618906477264, 981.0434826044692, 996.7009897030862, 1001.5593139018808, 1110.3005106782675, 1336.6057013180941, 7256.854862902818, 7430.925690743024, 7432.739854105081, 7460.925390746023, 7472.962635186789, 477.61074724099745, 486.6131425516723, 487.63914703119434, 487.70250147410053, 487.92681097835606, 5759.366469688331, 5769.942300577024, 5873.618214816023, 5881.852953676193, 5955.67243801595, 8933.0, 9102.726918192333, 9108.0, 9141.588628511732, 9149.588268527932, 8691.695790647296, 8880.333974951904, 8903.821923561492, 8977.955110224408, 8984.281257499384, 7011.824704382431, 7049.577025378391, 7082.079329687108, 7100.0, 7115.395191408685, 6689.49828762835, 6748.763793267212, 6797.388235058868, 6798.048273241849, 6823.454123670193, 8005.279524842792, 8029.478083924526, 8059.758207253792, 8143.877841832259, 8182.959085204536, 8174.264316211569, 8257.504549727035, 8310.252077313071, 8336.374771892253, 8338.082810890919, 6864.7940561783225, 6941.409980151744, 6947.305269473214, 6951.721931122901, 6956.478264130109, 7624.123225828879, 7677.9232207677205, 7711.884321735066, 7715.57564333967, 7719.691212351443, 7181.389581885598, 7211.1707153678, 7253.746118885813, 7361.558306501627, 7365.668544915598, 5880.8235752927485, 6916.239213686591, 6965.825854353681, 7083.787486375417, 7177.282271772781, 6924.619145947021, 7013.684384202825, 7017.122859642544, 7024.824379390556, 7025.508214424941, 6502.0, 6605.57063790852, 6679.966600166968, 6683.097781799394, 6690.431313338421, 6520.18497687789, 6581.6709164542535, 6595.505337099833, 6597.0, 6610.0], "unit": "ms", "name": "mootools.html", "value": 4348.657616797684}, {"lowerIsBetter": false, "replicates": [319.3899651665319, 325.8289398066016, 330.78003127919925, 332.70223150280486, 336.36762885774755, 5866.76532938683, 5949.910751338728, 5972.343042265347, 5980.252468441445, 6016.255285967064, 5814.273215848019, 5900.645961242329, 5902.203202567652, 5914.970425147868, 5951.970240148804, 4624.190766615837, 4624.352590637313, 4625.144348295559, 4626.606738427237, 4637.605803506706, 4373.497047839492, 4464.620507256887, 4516.435445569304, 4625.745583992879, 4662.207424737802, 4593.4947155813, 4598.563136502044, 4603.125406172833, 4605.171069207541, 4619.5611416915335, 4589.2657174851865, 4592.862214133581, 4605.815767369318, 4607.7004994675235, 4609.631229501631, 4032.0927791247027, 4036.636702696742, 4038.172174704179, 4042.5957404259634, 4056.0671045659665, 5610.102383618642, 5691.0, 5702.0, 5707.4577915098, 5729.828105156852, 5341.0, 5350.946490535084, 5359.464053594609, 5364.0, 5368.919466207971, 6072.817815465543, 6306.684665766693, 6329.87340253197, 6333.841653958688, 6336.714847831859, 4332.523422423531, 4338.414314067592, 4446.110777844412, 4458.955410445887, 4467.776611169461, 6550.148480697527, 6568.441682456997, 6570.540062195648, 6572.8356791080605, 6584.111144995412, 4558.361829343895, 4565.109803588335, 4566.931496027562, 4573.382593349856, 4573.588377046015, 4254.149170165979, 4417.8232870684815, 4423.579759922803, 4621.19129152397, 4631.560001799824, 5187.325647665779, 5193.68837869729, 5196.350456192976, 5196.740162991835, 5204.687718736888, 6368.936310636927, 6373.5857169283845, 6375.234971803413, 6375.713092910737, 6393.840153996094, 1546.1418912503443, 1574.0634322578048, 1575.7951466309535, 1576.9842301576837, 1577.510971598808, 999.3853779925439, 1004.5379125602159, 1018.9847152292722, 1020.505055048301, 1025.6974192613197, 6140.0, 6187.0, 6193.938060619426, 6195.597286176384, 6198.698273362645, 6555.639439830759, 6559.311272316433, 6565.704543295563, 6576.0793488911595, 6577.2436169841085, 6055.364186760415, 6177.752889884444, 6183.84540386494, 6189.288231853305, 6193.938060619426, 3543.982280088583, 3573.981415296628, 3574.1243395367783, 3574.6067932527403, 3581.6776490116013, 6674.966625166843, 6754.628495432798, 6757.763478278237, 6760.1549806274215, 6762.256151823295, 6706.966465167643, 6708.0, 6712.194536655633, 6715.093462382613, 6719.563228390139, 6676.098726671934, 6791.864162716718, 6818.249992500821, 6851.246362900077, 6851.554648947803, 6326.588771729823, 6425.389587989133, 6454.354564543696, 6585.242697089704, 6624.072629831924, 6464.870702586016, 6499.967500162469, 6508.15393998796, 6516.152900122954, 6543.149390579194, 6763.053172555945, 6786.796396108125, 6787.898181527183, 6788.49086318538, 6796.116504854337, 4392.5168231495145, 4459.754713490789, 4486.214912390384, 4487.663425243055, 4494.685372023927, 6481.449076828522, 6530.934690653223, 6537.1174891389055, 6540.50946179029, 6542.934570654423, 6360.141380913517, 6366.299707032315, 6367.490600752021, 6372.107904893226, 6382.425581697669, 6162.414570615784, 6320.652364119834, 6360.4911607072245, 6372.458341040878, 6376.553641245068, 6245.812625621239, 6253.468455181361, 6259.217597800275, 6268.905966410416, 6270.592411493239, 6377.043443483514, 6387.744490220339, 6388.233411990591, 6390.0, 6402.295747467681, 6180.072989051499, 6261.874762504815, 6261.9373806263175, 6346.111544383883, 6349.587276826992], "unit": "ms", "name": "prototype.html", "value": 4779.594644155404}, {"lowerIsBetter": false, "replicates": [861.2378045429797, 862.1766213266332, 865.2818160926432, 870.316801310971, 882.3514716683238, 12667.366631668414, 12894.613161605155, 12961.351932403366, 13033.152845065064, 13255.138416002954, 13213.405396757145, 13239.146519487256, 13256.403461844217, 13264.867351326484, 13307.534236301732, 665.6971078159438, 679.8266442057269, 815.2866242038217, 837.6774941647479, 837.736113124367, 831.6881169561415, 832.5753865528594, 839.911809260028, 840.2018082821313, 840.6301227459898, 869.9260562852165, 884.1512148337604, 884.3897710579679, 884.5665623844302, 884.712468447757, 714.5319815520817, 723.5513981331555, 854.6239654552008, 878.1087196495562, 878.2447095497866, 645.3578689204224, 647.2233320015953, 648.4423395879539, 648.8929326661096, 649.1204418013571, 13591.728165436734, 13751.0, 13778.173309601356, 13793.0, 13793.586192414243, 12215.26708397499, 12267.0, 12617.053720970964, 12644.367781610883, 12683.873161268362, 10277.383356998604, 10287.845682314772, 10387.0, 10451.216158788046, 10672.946635266851, 3616.584092829332, 3645.1616128290375, 3690.280395322913, 3703.055720791208, 3789.7915614641183, 44466.33300500495, 44570.108597827864, 44863.775681121384, 44866.55133448656, 44909.55090449119, 9758.9024109758, 10082.747931301776, 10212.693619191436, 10239.129673977646, 10521.21090918169, 15522.844771552365, 15536.300866461037, 15566.688666226839, 15568.688626227413, 15571.688566228611, 7554.7733567991945, 7625.54246745186, 7666.9616651917495, 7806.882896756553, 7893.802654933673, 4318.287482565404, 4324.17840610283, 4324.935125973113, 4390.890227744332, 4412.889677758018, 3192.7924684895406, 3199.4241036613166, 3238.2552013037134, 3239.5302681111107, 3241.303119829248, 569.5073761196618, 575.4331982996745, 578.6383510306059, 581.6335708503616, 592.6384905207819, 651.6253154436123, 653.4641593893057, 665.6838001949133, 666.7462781625636, 716.5843810589845, 8110.878336824952, 8358.498490090493, 8524.786880327918, 8621.094785047606, 8659.583612357743, 581.1050981488545, 652.7682672651235, 658.6048370977471, 661.1504217081124, 685.6948657847211, 3885.7668539887695, 4077.2660921033907, 4261.424707664488, 4277.593628605277, 4304.80628371724, 57425.42574574285, 58627.41372586219, 58656.70671646614, 58709.70645146747, 58769.412305877246, 49995.0, 50473.747631261605, 50870.49129508658, 50947.490525094276, 51076.74461627668, 47280.290795638095, 47443.5255647446, 47659.76170119127, 47865.52134478611, 48040.27939580909, 8426.115257897833, 8542.316614670686, 8624.482531048157, 8673.565380997128, 8740.257078148428, 34779.0, 34858.47712284267, 35442.0, 35592.110197245274, 35718.28563428769, 44691.776541117084, 44840.55159448364, 45646.0, 46071.0, 46233.306500403196, 9992.250581206294, 10047.0, 10066.094051535398, 10201.38791672502, 10215.94892025535, 10993.340399576051, 11170.385628790495, 11183.161262905152, 11318.037966772916, 11652.592159274724, 10390.116840068376, 10508.316959397614, 10583.0, 10630.893691062991, 10688.25182237236, 10474.476276186313, 10562.471876406302, 10757.246992710436, 11133.610323638633, 11176.608818691308, 7910.604469776373, 10206.489675516343, 10660.147188225079, 11169.359473466173, 11220.158488113588, 9896.703098907044, 10030.398176109456, 10210.744731381776, 10488.10851077667, 10532.315399499008, 7848.9215107848195, 9102.772430689021, 9108.544572771203, 9677.177439917687, 9739.853902191331], "unit": "ms", "name": "yui.html", "value": 6262.6436522129425}], "name": "dromaeo_css", "value": 6952.972073393905}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 104.0, 110.0, 109.0, 110.0, 100.0, 110.0, 110.0, 103.0], "unit": "ms", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [145.0, 121.0, 149.0, 175.0, 126.0, 155.0, 155.0, 123.0, 169.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 159.0, 161.0, 159.0, 160.0, 162.0, 162.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 81.0, 92.0, 77.0, 71.0, 71.0, 102.0, 96.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 133.0, 93.0, 94.0, 94.0, 138.0, 93.0, 93.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 105.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 60.0, 58.0, 59.0, 58.0, 57.0, 58.0, 58.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [92.0, 85.0, 84.0, 84.0, 92.0, 86.0, 85.0, 86.0, 86.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [121.0, 117.0, 115.0, 116.0, 122.0, 114.0, 123.0, 129.0, 115.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [138.0, 141.0, 161.0, 151.0, 149.0, 136.0, 149.0, 154.0, 149.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 68.0, 66.0, 68.0, 66.0, 69.0, 66.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1495.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [191.68104274487254], "unit": "score", "name": "Richards", "value": 184.17053400000003}, {"lowerIsBetter": false, "replicates": [194.28793471925394], "unit": "score", "name": "DeltaBlue", "value": 340.309346}, {"lowerIsBetter": false, "replicates": [286.20492272467084], "unit": "score", "name": "Encrypt", "value": 930.036414}, {"lowerIsBetter": false, "replicates": [5000.0], "unit": "score", "name": "Decrypt", "value": 53.23619999999997}, {"lowerIsBetter": false, "replicates": [1956.9471624266146], "unit": "score", "name": "RayTrace", "value": 378.13437900000014}, {"lowerIsBetter": false, "replicates": [798.0845969672786], "unit": "score", "name": "Earley", "value": 835.078139}, {"lowerIsBetter": false, "replicates": [12280.487804878048], "unit": "score", "name": "Boyer", "value": 54.27007547169812}, {"lowerIsBetter": false, "replicates": [25641.02564102564], "unit": "score", "name": "RegExp", "value": 35.52841499999999}, {"lowerIsBetter": false, "replicates": [663.4799235181645], "unit": "score", "name": "Splay", "value": 122.8236109510086}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19355.658674273876}]} 04:09:39 INFO - RETURN: dromaeo_css: 6952.97 04:09:39 INFO - RETURN: kraken: 1495.00 04:09:39 INFO - RETURN: v8_7: 19355.66 04:09:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19355.66"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1495.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6952.97"}}} 04:09:39 INFO - Return code: 0 04:09:39 INFO - # TBPL SUCCESS # 04:09:39 INFO - Running post-action listener: _resource_record_post_action 04:09:39 INFO - Running post-run listener: _resource_record_post_run 04:09:40 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 593920; Write bytes: 257204224; Read time: 260; Write time: 219348 04:09:40 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 499712; Read time: 0; Write time: 96 04:09:40 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 593920; Write bytes: 256704512; Read time: 260; Write time: 219252 04:09:40 INFO - Running post-run listener: _upload_blobber_files 04:09:40 INFO - Blob upload gear active. 04:09:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:09:40 INFO - Copying logs to upload dir... 04:09:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.197083 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-24 04:09:40.931667) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 04:09:40.935579) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/zfsvHXdVQymPb0pMkfBIwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009365 build_url: 'https://queue.taskcluster.net/v1/task/zfsvHXdVQymPb0pMkfBIwg/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-24 04:09:40.987781) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:09:40.988302) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e8c3f5a4c0a512351e80f2ca000001d7-1448360761.675167-492802488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004660 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:09:41.041245) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 04:09:41.041983) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 04:09:41.042717) ========= ========= Total master_lag: 0.20 =========