builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1451306189.06 results: success (0) buildid: 20151228023000 builduid: d4bb97de80944f89baa0b8ddf5905624 revision: 8588045f46a432a1b955cbb4ce746e64431c1f7f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:29.063499) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:29.063962) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:29.064406) ========= 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=ccb4611811c763f2fad71465000001de-1451300952.898369-692960851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006287 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:29.108789) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:29.109296) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:29.192533) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:29.192808) ========= 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=ccb4611811c763f2fad71465000001de-1451300952.898369-692960851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009678 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:29.245468) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:29.245783) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:29.246182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:29.246517) ========= 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=ccb4611811c763f2fad71465000001de-1451300952.898369-692960851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-28 04:36:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2015-12-28 04:36:29 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182955 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:29.445465) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:29.445896) ========= 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=ccb4611811c763f2fad71465000001de-1451300952.898369-692960851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.063697 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:29.522812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:29.523391) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 8588045f46a432a1b955cbb4ce746e64431c1f7f --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 8588045f46a432a1b955cbb4ce746e64431c1f7f --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=ccb4611811c763f2fad71465000001de-1451300952.898369-692960851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-28 04:36:29,754 truncating revision to first 12 chars 2015-12-28 04:36:29,754 Setting DEBUG logging. 2015-12-28 04:36:29,754 attempt 1/10 2015-12-28 04:36:29,754 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/8588045f46a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-28 04:36:29,983 unpacking tar archive at: b2g-inbound-8588045f46a4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532342 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:30.071583) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:30.072129) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:30.084170) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:30.084445) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 04:36:30.084844) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-28 04:36:30.085132) ========= /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=ccb4611811c763f2fad71465000001de-1451300952.898369-692960851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:36:30 INFO - MultiFileLogger online at 20151228 04:36:30 in /builds/slave/test-pgo 04:36:30 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 04:36:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:36:30 INFO - {'append_to_log': False, 04:36:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:36:30 INFO - 'blob_upload_branch': 'B2G-Inbound', 04:36:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:36:30 INFO - 'branch': 'B2G-Inbound', 04:36:30 INFO - 'buildbot_json_path': 'buildprops.json', 04:36:30 INFO - 'config_files': ('talos/linux_config.py',), 04:36:30 INFO - 'default_actions': ('clobber', 04:36:30 INFO - 'read-buildbot-config', 04:36:30 INFO - 'download-and-extract', 04:36:30 INFO - 'populate-webroot', 04:36:30 INFO - 'create-virtualenv', 04:36:30 INFO - 'install', 04:36:30 INFO - 'run-tests'), 04:36:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:36:30 INFO - 'download_minidump_stackwalk': True, 04:36:30 INFO - 'download_symbols': 'ondemand', 04:36:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:36:30 INFO - 'tooltool.py': '/tools/tooltool.py', 04:36:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:36:30 INFO - '/tools/misc-python/virtualenv.py')}, 04:36:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:36:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:36:30 INFO - 'installer_path': 'installer.exe', 04:36:30 INFO - 'log_level': 'info', 04:36:30 INFO - 'log_name': 'talos', 04:36:30 INFO - 'log_to_console': True, 04:36:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:36:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:36:30 INFO - 'opt_config_files': (), 04:36:30 INFO - 'pip_index': False, 04:36:30 INFO - 'sps_profile': False, 04:36:30 INFO - 'sps_profile_interval': 0, 04:36:30 INFO - 'suite': 'dromaeojs', 04:36:30 INFO - 'system_bits': '64', 04:36:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:36:30 INFO - 'title': 'talos-linux64-ix-021', 04:36:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:36:30 INFO - 'use_talos_json': True, 04:36:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:36:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:36:30 INFO - 'work_dir': 'build'} 04:36:30 INFO - ##### 04:36:30 INFO - ##### Running clobber step. 04:36:30 INFO - ##### 04:36:30 INFO - Running pre-action listener: _resource_record_pre_action 04:36:30 INFO - Running main action method: clobber 04:36:30 INFO - rmtree: /builds/slave/test-pgo/build 04:36:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:36:31 INFO - Running post-action listener: _resource_record_post_action 04:36:31 INFO - ##### 04:36:31 INFO - ##### Running read-buildbot-config step. 04:36:31 INFO - ##### 04:36:31 INFO - Running pre-action listener: _resource_record_pre_action 04:36:31 INFO - Running main action method: read_buildbot_config 04:36:31 INFO - Using buildbot properties: 04:36:31 INFO - { 04:36:31 INFO - "project": "", 04:36:31 INFO - "product": "firefox", 04:36:31 INFO - "script_repo_revision": "production", 04:36:31 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 04:36:31 INFO - "repository": "", 04:36:31 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 04:36:31 INFO - "buildid": "20151228023000", 04:36:31 INFO - "pgo_build": "True", 04:36:31 INFO - "basedir": "/builds/slave/test-pgo", 04:36:31 INFO - "buildnumber": 157, 04:36:31 INFO - "slavename": "talos-linux64-ix-021", 04:36:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:36:31 INFO - "platform": "ubuntu64_hw", 04:36:31 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 04:36:31 INFO - "branch": "b2g-inbound", 04:36:31 INFO - "repo_path": "integration/b2g-inbound", 04:36:31 INFO - "revision": "8588045f46a432a1b955cbb4ce746e64431c1f7f", 04:36:31 INFO - "stage_platform": "linux64-pgo", 04:36:31 INFO - "builduid": "d4bb97de80944f89baa0b8ddf5905624", 04:36:31 INFO - "slavebuilddir": "test" 04:36:31 INFO - } 04:36:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:36:31 INFO - Running post-action listener: _resource_record_post_action 04:36:31 INFO - ##### 04:36:31 INFO - ##### Running download-and-extract step. 04:36:31 INFO - ##### 04:36:31 INFO - Running pre-action listener: _resource_record_pre_action 04:36:31 INFO - Running main action method: download_and_extract 04:36:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:31 INFO - https://queue.taskcluster.net/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:36:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/test_packages.json 04:36:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/test_packages.json 04:36:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:36:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:36:34 INFO - Downloaded 1302 bytes. 04:36:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:36:34 INFO - Using the following test package requirements: 04:36:34 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:36:34 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:36:34 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:34 INFO - u'jsshell-linux-x86_64.zip'], 04:36:34 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:36:34 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:36:34 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:36:34 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:36:34 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:36:34 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:36:34 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:36:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:36:34 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')]} 04:36:34 INFO - https://queue.taskcluster.net/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:36:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:36:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:36:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:36:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:36:37 INFO - Downloaded 23191538 bytes. 04:36:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:36:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:36:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:36:39 INFO - Return code: 0 04:36:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:36:39 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')]} 04:36:39 INFO - https://queue.taskcluster.net/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:36:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:36:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:36:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:36:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:36:43 INFO - Downloaded 23191538 bytes. 04:36:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:36:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:36:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:36:44 INFO - Return code: 0 04:36: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')]} 04:36:44 INFO - https://queue.taskcluster.net/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:36:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:36:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:36:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:36:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:36:45 INFO - Downloaded 11132270 bytes. 04:36:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 04:36:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:36:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:36:46 INFO - Return code: 0 04:36: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')]} 04:36:46 INFO - https://queue.taskcluster.net/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:36:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:36:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:36:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:36:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:36:48 INFO - Downloaded 54970379 bytes. 04:36:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:36:48 INFO - mkdir: /builds/slave/test-pgo/properties 04:36:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:36:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:36:48 INFO - Contents: 04:36:48 INFO - build_url:https://queue.taskcluster.net/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:36:48 INFO - Running post-action listener: _resource_record_post_action 04:36:48 INFO - Running post-action listener: set_extra_try_arguments 04:36:48 INFO - ##### 04:36:48 INFO - ##### Running populate-webroot step. 04:36:48 INFO - ##### 04:36:48 INFO - Running pre-action listener: _resource_record_pre_action 04:36:48 INFO - Running main action method: populate_webroot 04:36:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:36:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:36:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:36:48 INFO - '--tppagecycles', 04:36:48 INFO - '7'], 04:36:48 INFO - 'tests': ['tsvgm']}}, 04:36:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:36:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:36:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:36:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:36:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:36:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:36:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:48 INFO - 'talos_options': ['--e10s'], 04:36:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:48 INFO - 'tests': ['damp', 'tps']}, 04:36:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:48 INFO - 'talos_options': ['--e10s'], 04:36:48 INFO - 'tests': ['damp', 'tps']}, 04:36:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:36:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:36:48 INFO - 'other': {'tests': ['a11yr', 04:36:48 INFO - 'ts_paint', 04:36:48 INFO - 'tpaint', 04:36:48 INFO - 'sessionrestore', 04:36:48 INFO - 'sessionrestore_no_auto_restore']}, 04:36:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:36:48 INFO - 'tests': ['a11yr', 04:36:48 INFO - 'ts_paint', 04:36:48 INFO - 'tpaint', 04:36:48 INFO - 'sessionrestore', 04:36:48 INFO - 'sessionrestore_no_auto_restore']}, 04:36:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:36:48 INFO - 'tests': ['a11yr', 04:36:48 INFO - 'ts_paint', 04:36:48 INFO - 'tpaint', 04:36:48 INFO - 'sessionrestore', 04:36:48 INFO - 'sessionrestore_no_auto_restore']}, 04:36:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:36:48 INFO - 'tests': ['a11yr', 04:36:48 INFO - 'ts_paint', 04:36:48 INFO - 'tpaint', 04:36:48 INFO - 'sessionrestore', 04:36:48 INFO - 'sessionrestore_no_auto_restore']}, 04:36:48 INFO - 'other_l64': {'tests': ['a11yr', 04:36:48 INFO - 'ts_paint', 04:36:48 INFO - 'tpaint', 04:36:48 INFO - 'sessionrestore', 04:36:48 INFO - 'sessionrestore_no_auto_restore']}, 04:36:48 INFO - 'other_nol64': {'tests': ['a11yr', 04:36:48 INFO - 'ts_paint', 04:36:48 INFO - 'tpaint', 04:36:48 INFO - 'sessionrestore', 04:36:48 INFO - 'sessionrestore_no_auto_restore']}, 04:36:48 INFO - 'svgr': {'tests': ['tsvgx', 04:36:48 INFO - 'tsvgr_opacity', 04:36:48 INFO - 'tart', 04:36:48 INFO - 'tscrollx', 04:36:48 INFO - 'cart']}, 04:36:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:36:48 INFO - 'tests': ['tsvgx', 04:36:48 INFO - 'tsvgr_opacity', 04:36:48 INFO - 'tart', 04:36:48 INFO - 'tscrollx', 04:36:48 INFO - 'cart']}, 04:36:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:48 INFO - 'tests': ['tp5o']}, 04:36:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:48 INFO - 'talos_options': ['--e10s'], 04:36:48 INFO - 'tests': ['tp5o']}, 04:36:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:48 INFO - 'talos_options': ['--xperf_path', 04:36:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:48 INFO - 'tests': ['tp5n']}, 04:36:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:48 INFO - 'talos_options': ['--e10s', 04:36:48 INFO - '--xperf_path', 04:36:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:48 INFO - 'tests': ['tp5n']}}, 04:36:48 INFO - 'talos.zip': {'path': '', 04:36:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:36:48 INFO - Running post-action listener: _resource_record_post_action 04:36:48 INFO - ##### 04:36:48 INFO - ##### Running create-virtualenv step. 04:36:48 INFO - ##### 04:36:48 INFO - Running pre-action listener: _resource_record_pre_action 04:36:48 INFO - Running main action method: create_virtualenv 04:36:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:36:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 04:36:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:36:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:36:48 INFO - Using real prefix '/usr' 04:36:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:36:49 INFO - Installing distribute.............................................................................................................................................................................................done. 04:36:51 INFO - Installing pip.................done. 04:36:51 INFO - Return code: 0 04:36:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0558f24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1441660>, '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 0x1442560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1442a10>, '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': 'ccb4611811c763f2fad71465000001de-1451300952.898369-692960851', '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 04:36:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 04:36:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:36:51 INFO - Using env: {'DISPLAY': ':0', 04:36:51 INFO - 'HOME': '/home/cltbld', 04:36:51 INFO - 'LANG': 'en_US.UTF-8', 04:36:51 INFO - 'LANGUAGE': 'en_US:en', 04:36:51 INFO - 'LOGNAME': 'cltbld', 04:36:51 INFO - 'MAIL': '/var/mail/cltbld', 04:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:51 INFO - 'MOZ_NO_REMOTE': '1', 04:36:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:51 INFO - 'NO_EM_RESTART': '1', 04:36:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:36:51 INFO - 'PWD': '/builds/slave/test-pgo', 04:36:51 INFO - 'SHELL': '/bin/bash', 04:36:51 INFO - 'SHLVL': '1', 04:36:51 INFO - 'TERM': 'linux', 04:36:51 INFO - 'TMOUT': '86400', 04:36:51 INFO - 'USER': 'cltbld', 04:36:51 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451300952.898369-692960851', 04:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:51 INFO - '_': '/tools/buildbot/bin/python'} 04:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:36:51 INFO - Cleaning up... 04:36:51 INFO - Return code: 0 04:36:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0558f24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1441660>, '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 0x1442560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1442a10>, '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': 'ccb4611811c763f2fad71465000001de-1451300952.898369-692960851', '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 04:36:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 04:36:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:36:51 INFO - Using env: {'DISPLAY': ':0', 04:36:51 INFO - 'HOME': '/home/cltbld', 04:36:51 INFO - 'LANG': 'en_US.UTF-8', 04:36:51 INFO - 'LANGUAGE': 'en_US:en', 04:36:51 INFO - 'LOGNAME': 'cltbld', 04:36:51 INFO - 'MAIL': '/var/mail/cltbld', 04:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:51 INFO - 'MOZ_NO_REMOTE': '1', 04:36:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:51 INFO - 'NO_EM_RESTART': '1', 04:36:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:36:51 INFO - 'PWD': '/builds/slave/test-pgo', 04:36:51 INFO - 'SHELL': '/bin/bash', 04:36:51 INFO - 'SHLVL': '1', 04:36:51 INFO - 'TERM': 'linux', 04:36:51 INFO - 'TMOUT': '86400', 04:36:51 INFO - 'USER': 'cltbld', 04:36:51 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451300952.898369-692960851', 04:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:51 INFO - '_': '/tools/buildbot/bin/python'} 04:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:51 INFO - Downloading/unpacking psutil>=0.7.1 04:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:53 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:36:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:36:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:36:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:53 INFO - Installing collected packages: psutil 04:36:53 INFO - Running setup.py install for psutil 04:36:53 INFO - building 'psutil._psutil_linux' extension 04:36:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:36:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:36:53 INFO - building 'psutil._psutil_posix' extension 04:36:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:36:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:36:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:54 INFO - Successfully installed psutil 04:36:54 INFO - Cleaning up... 04:36:54 INFO - Return code: 0 04:36:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:36:54 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')]} 04:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:54 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')]} 04:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:54 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 0x7f0558f24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1441660>, '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 0x1442560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1442a10>, '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': 'ccb4611811c763f2fad71465000001de-1451300952.898369-692960851', '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 04:36:54 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 04:36:54 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 04:36:54 INFO - Using env: {'DISPLAY': ':0', 04:36:54 INFO - 'HOME': '/home/cltbld', 04:36:54 INFO - 'LANG': 'en_US.UTF-8', 04:36:54 INFO - 'LANGUAGE': 'en_US:en', 04:36:54 INFO - 'LOGNAME': 'cltbld', 04:36:54 INFO - 'MAIL': '/var/mail/cltbld', 04:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:54 INFO - 'MOZ_NO_REMOTE': '1', 04:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:54 INFO - 'NO_EM_RESTART': '1', 04:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:36:54 INFO - 'PWD': '/builds/slave/test-pgo', 04:36:54 INFO - 'SHELL': '/bin/bash', 04:36:54 INFO - 'SHLVL': '1', 04:36:54 INFO - 'TERM': 'linux', 04:36:54 INFO - 'TMOUT': '86400', 04:36:54 INFO - 'USER': 'cltbld', 04:36:54 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451300952.898369-692960851', 04:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:54 INFO - '_': '/tools/buildbot/bin/python'} 04:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:36:54 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 04:36:54 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 04:36:54 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 04:36:54 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 04:36:54 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 04:36:54 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 04:36:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:36:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:36:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:36:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:36:56 INFO - Installing collected packages: mozsystemmonitor 04:36:56 INFO - Running setup.py install for mozsystemmonitor 04:36:56 INFO - Successfully installed mozsystemmonitor 04:36:56 INFO - Cleaning up... 04:36:56 INFO - Return code: 0 04:36:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:36: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')]} 04:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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', '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 0x7f0558f24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1441660>, '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 0x1442560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1442a10>, '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': 'ccb4611811c763f2fad71465000001de-1451300952.898369-692960851', '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 04:36: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:36: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 blobuploader==1.2.4 04:36:56 INFO - Using env: {'DISPLAY': ':0', 04:36:56 INFO - 'HOME': '/home/cltbld', 04:36:56 INFO - 'LANG': 'en_US.UTF-8', 04:36:56 INFO - 'LANGUAGE': 'en_US:en', 04:36:56 INFO - 'LOGNAME': 'cltbld', 04:36:56 INFO - 'MAIL': '/var/mail/cltbld', 04:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:56 INFO - 'MOZ_NO_REMOTE': '1', 04:36:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:56 INFO - 'NO_EM_RESTART': '1', 04:36:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:36:56 INFO - 'PWD': '/builds/slave/test-pgo', 04:36:56 INFO - 'SHELL': '/bin/bash', 04:36:56 INFO - 'SHLVL': '1', 04:36:56 INFO - 'TERM': 'linux', 04:36:56 INFO - 'TMOUT': '86400', 04:36:56 INFO - 'USER': 'cltbld', 04:36:56 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451300952.898369-692960851', 04:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:56 INFO - '_': '/tools/buildbot/bin/python'} 04:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:56 INFO - Downloading/unpacking blobuploader==1.2.4 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36:58 INFO - Downloading blobuploader-1.2.4.tar.gz 04:36:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:36:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:36:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:36:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:36:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:58 INFO - Downloading docopt-0.6.1.tar.gz 04:36:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:36:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:36:59 INFO - Installing collected packages: blobuploader, requests, docopt 04:36:59 INFO - Running setup.py install for blobuploader 04:36:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:36:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:36:59 INFO - Running setup.py install for requests 04:36:59 INFO - Running setup.py install for docopt 04:36:59 INFO - Successfully installed blobuploader requests docopt 04:36:59 INFO - Cleaning up... 04:36:59 INFO - Return code: 0 04:36:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0558f24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1441660>, '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 0x1442560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1442a10>, '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': 'ccb4611811c763f2fad71465000001de-1451300952.898369-692960851', '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 04:36:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:36:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:36:59 INFO - Using env: {'DISPLAY': ':0', 04:36:59 INFO - 'HOME': '/home/cltbld', 04:36:59 INFO - 'LANG': 'en_US.UTF-8', 04:36:59 INFO - 'LANGUAGE': 'en_US:en', 04:36:59 INFO - 'LOGNAME': 'cltbld', 04:36:59 INFO - 'MAIL': '/var/mail/cltbld', 04:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:59 INFO - 'MOZ_NO_REMOTE': '1', 04:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:59 INFO - 'NO_EM_RESTART': '1', 04:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:36:59 INFO - 'PWD': '/builds/slave/test-pgo', 04:36:59 INFO - 'SHELL': '/bin/bash', 04:36:59 INFO - 'SHLVL': '1', 04:36:59 INFO - 'TERM': 'linux', 04:36:59 INFO - 'TMOUT': '86400', 04:36:59 INFO - 'USER': 'cltbld', 04:36:59 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451300952.898369-692960851', 04:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:59 INFO - '_': '/tools/buildbot/bin/python'} 04:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:36:59 INFO - Running setup.py (path:/tmp/pip-87jfCW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:36:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:36:59 INFO - Running setup.py (path:/tmp/pip-_0LKEg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:36:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:36:59 INFO - Running setup.py (path:/tmp/pip-aCAdku-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:37:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:37:00 INFO - Running setup.py (path:/tmp/pip-sKrXnZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:37:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:37:00 INFO - Running setup.py (path:/tmp/pip-BLTq1V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:37:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:37:00 INFO - Running setup.py (path:/tmp/pip-DNyz5r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:37:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:37:00 INFO - Running setup.py (path:/tmp/pip-QFn0bh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:37:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:37:00 INFO - Running setup.py (path:/tmp/pip-PgqjlP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:37:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:37:00 INFO - Running setup.py (path:/tmp/pip-81rDR7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:37:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:37:00 INFO - Running setup.py (path:/tmp/pip-eWsPDD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:37:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:37:00 INFO - Running setup.py (path:/tmp/pip-bLOMN3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:37:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:37:00 INFO - Running setup.py (path:/tmp/pip-1V89n1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:37:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:37:00 INFO - Running setup.py (path:/tmp/pip-UAb1MP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:37:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:37:00 INFO - Running setup.py (path:/tmp/pip-J6L7Cj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:37:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:37:00 INFO - Running setup.py (path:/tmp/pip-h3fd7t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:37:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:37:00 INFO - Running setup.py (path:/tmp/pip-Hd8J3P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:37:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:37:00 INFO - Running setup.py (path:/tmp/pip-m5YBNt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:37:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:37:01 INFO - Running setup.py install for manifestparser 04:37:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:37:01 INFO - Running setup.py install for mozcrash 04:37:01 INFO - Running setup.py install for mozdebug 04:37:01 INFO - Running setup.py install for mozdevice 04:37:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:37:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:37:01 INFO - Running setup.py install for mozfile 04:37:01 INFO - Running setup.py install for mozhttpd 04:37:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:37:01 INFO - Running setup.py install for mozinfo 04:37:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:37:01 INFO - Running setup.py install for mozInstall 04:37:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:37:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:37:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:37:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:37:01 INFO - Running setup.py install for mozleak 04:37:01 INFO - Running setup.py install for mozlog 04:37:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:37:02 INFO - Running setup.py install for moznetwork 04:37:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:37:02 INFO - Running setup.py install for mozprocess 04:37:02 INFO - Running setup.py install for mozprofile 04:37:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:37:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:37:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:37:02 INFO - Running setup.py install for mozrunner 04:37:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:37:02 INFO - Running setup.py install for mozscreenshot 04:37:02 INFO - Running setup.py install for moztest 04:37:02 INFO - Running setup.py install for mozversion 04:37:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:37:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:37:02 INFO - Cleaning up... 04:37:02 INFO - Return code: 0 04:37:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:37:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0558f24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1441660>, '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 0x1442560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1442a10>, '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': 'ccb4611811c763f2fad71465000001de-1451300952.898369-692960851', '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 04:37:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:37:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:37:02 INFO - Using env: {'DISPLAY': ':0', 04:37:02 INFO - 'HOME': '/home/cltbld', 04:37:02 INFO - 'LANG': 'en_US.UTF-8', 04:37:02 INFO - 'LANGUAGE': 'en_US:en', 04:37:02 INFO - 'LOGNAME': 'cltbld', 04:37:02 INFO - 'MAIL': '/var/mail/cltbld', 04:37:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:02 INFO - 'MOZ_NO_REMOTE': '1', 04:37:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:02 INFO - 'NO_EM_RESTART': '1', 04:37:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:37:02 INFO - 'PWD': '/builds/slave/test-pgo', 04:37:02 INFO - 'SHELL': '/bin/bash', 04:37:02 INFO - 'SHLVL': '1', 04:37:02 INFO - 'TERM': 'linux', 04:37:02 INFO - 'TMOUT': '86400', 04:37:02 INFO - 'USER': 'cltbld', 04:37:02 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451300952.898369-692960851', 04:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:02 INFO - '_': '/tools/buildbot/bin/python'} 04:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:37:03 INFO - Running setup.py (path:/tmp/pip-axyrcp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:37:03 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)) 04:37:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:37:03 INFO - Running setup.py (path:/tmp/pip-iChrsw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:37:03 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)) 04:37:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:37:03 INFO - Running setup.py (path:/tmp/pip-lBagSX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:37:03 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)) 04:37:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:37:03 INFO - Running setup.py (path:/tmp/pip-d74QMw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:37:03 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)) 04:37:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:37:03 INFO - Running setup.py (path:/tmp/pip-7v8SWu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:37:03 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)) 04:37:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:37:03 INFO - Running setup.py (path:/tmp/pip-kDiSTR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:37:03 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)) 04:37:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:37:03 INFO - Running setup.py (path:/tmp/pip-8ClArl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:37:03 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)) 04:37:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:37:03 INFO - Running setup.py (path:/tmp/pip-zE5rOV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 04:37:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:37:03 INFO - Running setup.py (path:/tmp/pip-0EEhWn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 04:37:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:37:03 INFO - Running setup.py (path:/tmp/pip-MOpyvO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:37:03 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)) 04:37:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:37:03 INFO - Running setup.py (path:/tmp/pip-FN2yMv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 04:37:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:37:03 INFO - Running setup.py (path:/tmp/pip-VWDSKB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 04:37:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:37:03 INFO - Running setup.py (path:/tmp/pip-mnLlDn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 04:37:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:37:03 INFO - Running setup.py (path:/tmp/pip-NAAujf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:37:04 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)) 04:37:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:37:04 INFO - Running setup.py (path:/tmp/pip-Quo89n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:37:04 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)) 04:37:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:37:04 INFO - Running setup.py (path:/tmp/pip-EetgaN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:37:04 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)) 04:37:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:37:04 INFO - Running setup.py (path:/tmp/pip-_Gt_D3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:37:04 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)) 04:37:04 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)) 04:37:04 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)) 04:37:04 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)) 04:37:04 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)) 04:37:04 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)) 04:37:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:05 INFO - Downloading blessings-1.5.1.tar.gz 04:37:05 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:37:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:37:05 INFO - Installing collected packages: blessings 04:37:05 INFO - Running setup.py install for blessings 04:37:06 INFO - Successfully installed blessings 04:37:06 INFO - Cleaning up... 04:37:06 INFO - Return code: 0 04:37:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:37:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:37:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:37:06 INFO - Reading from file tmpfile_stdout 04:37:06 INFO - Current package versions: 04:37:06 INFO - argparse == 1.2.1 04:37:06 INFO - blessings == 1.5.1 04:37:06 INFO - blobuploader == 1.2.4 04:37:06 INFO - docopt == 0.6.1 04:37:06 INFO - manifestparser == 1.1 04:37:06 INFO - mozInstall == 1.12 04:37:06 INFO - mozcrash == 0.16 04:37:06 INFO - mozdebug == 0.1 04:37:06 INFO - mozdevice == 0.47 04:37:06 INFO - mozfile == 1.2 04:37:06 INFO - mozhttpd == 0.7 04:37:06 INFO - mozinfo == 0.9 04:37:06 INFO - mozleak == 0.1 04:37:06 INFO - mozlog == 3.1 04:37:06 INFO - moznetwork == 0.27 04:37:06 INFO - mozprocess == 0.22 04:37:06 INFO - mozprofile == 0.28 04:37:06 INFO - mozrunner == 6.11 04:37:06 INFO - mozscreenshot == 0.1 04:37:06 INFO - mozsystemmonitor == 0.0 04:37:06 INFO - moztest == 0.7 04:37:06 INFO - mozversion == 1.4 04:37:06 INFO - psutil == 3.1.1 04:37:06 INFO - requests == 1.2.3 04:37:06 INFO - wsgiref == 0.1.2 04:37:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f0558f24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1441660>, '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 0x1442560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1442a10>, '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': 'ccb4611811c763f2fad71465000001de-1451300952.898369-692960851', '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 04:37:06 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 04:37:06 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 04:37:06 INFO - Using env: {'DISPLAY': ':0', 04:37:06 INFO - 'HOME': '/home/cltbld', 04:37:06 INFO - 'LANG': 'en_US.UTF-8', 04:37:06 INFO - 'LANGUAGE': 'en_US:en', 04:37:06 INFO - 'LOGNAME': 'cltbld', 04:37:06 INFO - 'MAIL': '/var/mail/cltbld', 04:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:06 INFO - 'MOZ_NO_REMOTE': '1', 04:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:06 INFO - 'NO_EM_RESTART': '1', 04:37:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:37:06 INFO - 'PWD': '/builds/slave/test-pgo', 04:37:06 INFO - 'SHELL': '/bin/bash', 04:37:06 INFO - 'SHLVL': '1', 04:37:06 INFO - 'TERM': 'linux', 04:37:06 INFO - 'TMOUT': '86400', 04:37:06 INFO - 'USER': 'cltbld', 04:37:06 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451300952.898369-692960851', 04:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:06 INFO - '_': '/tools/buildbot/bin/python'} 04:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.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 1)) 04:37:06 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 2)) 04:37:06 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 3)) 04:37:06 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 4)) 04:37:06 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 5)) 04:37:06 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 6)) 04:37:06 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 7)) 04:37:06 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 8)) 04:37:06 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 9)) 04:37:06 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.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:37:06 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 4)) 04:37:06 INFO - Cleaning up... 04:37:06 INFO - Return code: 0 04:37:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0558f24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1441660>, '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 0x1442560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1442a10>, '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': 'ccb4611811c763f2fad71465000001de-1451300952.898369-692960851', '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 04:37:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 04:37:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:37:06 INFO - Using env: {'DISPLAY': ':0', 04:37:06 INFO - 'HOME': '/home/cltbld', 04:37:06 INFO - 'LANG': 'en_US.UTF-8', 04:37:06 INFO - 'LANGUAGE': 'en_US:en', 04:37:06 INFO - 'LOGNAME': 'cltbld', 04:37:06 INFO - 'MAIL': '/var/mail/cltbld', 04:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:06 INFO - 'MOZ_NO_REMOTE': '1', 04:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:06 INFO - 'NO_EM_RESTART': '1', 04:37:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:37:06 INFO - 'PWD': '/builds/slave/test-pgo', 04:37:06 INFO - 'SHELL': '/bin/bash', 04:37:06 INFO - 'SHLVL': '1', 04:37:06 INFO - 'TERM': 'linux', 04:37:06 INFO - 'TMOUT': '86400', 04:37:06 INFO - 'USER': 'cltbld', 04:37:06 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451300952.898369-692960851', 04:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:06 INFO - '_': '/tools/buildbot/bin/python'} 04:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:06 INFO - Downloading/unpacking jsonschema 04:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:37:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:37:08 INFO - Downloading/unpacking functools32 (from jsonschema) 04:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:08 INFO - Downloading functools32-3.2.3-2.tar.gz 04:37:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:37:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:37:08 INFO - warning: no files found matching '*.txt' 04:37:08 INFO - no previously-included directories found matching 'build' 04:37:08 INFO - no previously-included directories found matching 'dist' 04:37:08 INFO - no previously-included directories found matching '.git*' 04:37:08 INFO - Installing collected packages: jsonschema, functools32 04:37:08 INFO - Running setup.py install for functools32 04:37:08 INFO - warning: no files found matching '*.txt' 04:37:08 INFO - no previously-included directories found matching 'build' 04:37:08 INFO - no previously-included directories found matching 'dist' 04:37:08 INFO - no previously-included directories found matching '.git*' 04:37:08 INFO - Successfully installed jsonschema functools32 04:37:08 INFO - Cleaning up... 04:37:08 INFO - Return code: 0 04:37:08 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:08 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0558f24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1441660>, '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 0x1442560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1442a10>, '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': 'ccb4611811c763f2fad71465000001de-1451300952.898369-692960851', '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 04:37:08 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', 'flake8'] in /builds/slave/test-pgo/build 04:37:08 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 flake8 04:37:08 INFO - Using env: {'DISPLAY': ':0', 04:37:08 INFO - 'HOME': '/home/cltbld', 04:37:08 INFO - 'LANG': 'en_US.UTF-8', 04:37:08 INFO - 'LANGUAGE': 'en_US:en', 04:37:08 INFO - 'LOGNAME': 'cltbld', 04:37:08 INFO - 'MAIL': '/var/mail/cltbld', 04:37:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:08 INFO - 'MOZ_NO_REMOTE': '1', 04:37:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:08 INFO - 'NO_EM_RESTART': '1', 04:37:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:37:08 INFO - 'PWD': '/builds/slave/test-pgo', 04:37:08 INFO - 'SHELL': '/bin/bash', 04:37:08 INFO - 'SHLVL': '1', 04:37:08 INFO - 'TERM': 'linux', 04:37:08 INFO - 'TMOUT': '86400', 04:37:08 INFO - 'USER': 'cltbld', 04:37:08 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451300952.898369-692960851', 04:37:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:08 INFO - '_': '/tools/buildbot/bin/python'} 04:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:09 INFO - Downloading/unpacking flake8 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:37:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:37:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:37:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:37:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:37:11 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 04:37:11 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 04:37:11 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 04:37:11 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 04:37:11 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 04:37:11 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 04:37:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:37:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:37:11 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 04:37:11 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 04:37:11 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 04:37:11 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 04:37:11 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 04:37:11 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 04:37:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:37:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:37:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:37:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:37:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:37:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:37:11 INFO - no previously-included directories found matching 'docs/_build' 04:37:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:37:11 INFO - Running setup.py install for pep8 04:37:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:37:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:37:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:37:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:37:11 INFO - no previously-included directories found matching 'docs/_build' 04:37:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:37:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:37:11 INFO - Cleaning up... 04:37:11 INFO - Return code: 0 04:37:11 INFO - Running post-action listener: _resource_record_post_action 04:37:11 INFO - Running post-action listener: _start_resource_monitoring 04:37:11 INFO - Starting resource monitoring. 04:37:11 INFO - ##### 04:37:11 INFO - ##### Running install step. 04:37:11 INFO - ##### 04:37:11 INFO - Running pre-action listener: _resource_record_pre_action 04:37:11 INFO - Running main action method: install 04:37:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:37:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:37:11 INFO - Reading from file tmpfile_stdout 04:37:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:37:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:37:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:37:12 INFO - Reading from file tmpfile_stdout 04:37:12 INFO - Output received: 04:37:12 INFO - Usage: mozinstall [options] installer 04:37:12 INFO - Options: 04:37:12 INFO - -h, --help show this help message and exit 04:37:12 INFO - -d DEST, --destination=DEST 04:37:12 INFO - Directory to install application into. [default: 04:37:12 INFO - "/builds/slave/test-pgo"] 04:37:12 INFO - --app=APP Application being installed. [default: firefox] 04:37:12 INFO - mkdir: /builds/slave/test-pgo/build/application 04:37:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:37:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:37:27 INFO - Reading from file tmpfile_stdout 04:37:27 INFO - Output received: 04:37:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:37:27 INFO - Running post-action listener: _resource_record_post_action 04:37:27 INFO - ##### 04:37:27 INFO - ##### Running run-tests step. 04:37:27 INFO - ##### 04:37:27 INFO - Running pre-action listener: _resource_record_pre_action 04:37:27 INFO - Running main action method: run_tests 04:37:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:37:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:37:27 INFO - Python 2.7.3 04:37:27 INFO - Return code: 0 04:37:27 INFO - grabbing minidump binary from tooltool 04:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1441660>, '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 0x1442560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1442a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:37:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 04:37:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:37:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:37:27 INFO - Return code: 0 04:37:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:37:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:37:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:37:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:37:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:37:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:37:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:37:28 INFO - Return code: 0 04:37:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 04:37:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 04:37:28 INFO - Using env: {'DISPLAY': ':0', 04:37:28 INFO - 'HOME': '/home/cltbld', 04:37:28 INFO - 'LANG': 'en_US.UTF-8', 04:37:28 INFO - 'LANGUAGE': 'en_US:en', 04:37:28 INFO - 'LOGNAME': 'cltbld', 04:37:28 INFO - 'MAIL': '/var/mail/cltbld', 04:37:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:37:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:37:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:28 INFO - 'MOZ_NO_REMOTE': '1', 04:37:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:37:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:28 INFO - 'NO_EM_RESTART': '1', 04:37:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:37:28 INFO - 'PWD': '/builds/slave/test-pgo', 04:37:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:37:28 INFO - 'SHELL': '/bin/bash', 04:37:28 INFO - 'SHLVL': '1', 04:37:28 INFO - 'TERM': 'linux', 04:37:28 INFO - 'TMOUT': '86400', 04:37:28 INFO - 'USER': 'cltbld', 04:37:28 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451300952.898369-692960851', 04:37:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:28 INFO - '_': '/tools/buildbot/bin/python'} 04:37:28 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:37:29 INFO - mozversion application_buildid: 20151228023000 04:37:29 INFO - mozversion application_changeset: 8588045f46a432a1b955cbb4ce746e64431c1f7f 04:37:29 INFO - mozversion application_display_name: Nightly 04:37:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:37:29 INFO - mozversion application_name: Firefox 04:37:29 INFO - mozversion application_remotingname: firefox 04:37:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 04:37:29 INFO - mozversion application_vendor: Mozilla 04:37:29 INFO - mozversion application_version: 46.0a1 04:37:29 INFO - mozversion platform_buildid: 20151228023000 04:37:29 INFO - mozversion platform_changeset: 8588045f46a432a1b955cbb4ce746e64431c1f7f 04:37:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 04:37:29 INFO - mozversion platform_version: 46.0a1 04:37:29 INFO - using testdate: 1451306249 04:37:29 INFO - actual date: 1451306249 04:37:29 INFO - starting webserver on 'localhost:50845' 04:37:29 INFO - SUITE-START | Running 3 tests 04:37:29 INFO - TEST-START | dromaeo_css 04:37:29 INFO - operating with platform_type : linux_ 04:37:29 INFO - Initialising browser for dromaeo_css test... 04:37:29 INFO - TEST-INFO | started process 14153 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQnB7wA/profile http://localhost:50845/getInfo.html) 04:37:34 INFO - PROCESS | 14153 | __metrics Screen width/height:1600/1200 04:37:34 INFO - PROCESS | 14153 | colorDepth:24 04:37:34 INFO - PROCESS | 14153 | Browser inner width/height: 1024/697 04:37:34 INFO - PROCESS | 14153 | __metrics 04:37:34 INFO - PROCESS | 14153 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:37:34 INFO - PROCESS | 14153 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:37:35 INFO - TEST-INFO | 14153: exit 0 04:37:35 INFO - Browser initialized. 04:37:35 INFO - Running cycle 1/1 for dromaeo_css test... 04:37:35 INFO - TEST-INFO | started process 14246 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQnB7wA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:47 INFO - PROCESS | 14246 | RSS: Main: 148602880 04:37:47 INFO - PROCESS | 14246 | 04:38:38 INFO - PROCESS | 14246 | 1451306318892 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] 04:40:47 INFO - PROCESS | 14246 | Cycle 1(1): loaded http://localhost:50845/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50845/tests/dromaeo/cssquery-ext.html) 04:40:48 INFO - PROCESS | 14246 | RSS: Main: 270606336 04:40:48 INFO - PROCESS | 14246 | 04:43:51 INFO - PROCESS | 14246 | Cycle 1(1): loaded http://localhost:50845/tests/dromaeo/cssquery-ext.html (next: http://localhost:50845/tests/dromaeo/cssquery-jquery.html) 04:43:51 INFO - PROCESS | 14246 | RSS: Main: 232546304 04:43:51 INFO - PROCESS | 14246 | 04:46:53 INFO - PROCESS | 14246 | Cycle 1(1): loaded http://localhost:50845/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50845/tests/dromaeo/cssquery-mootools.html) 04:46:54 INFO - PROCESS | 14246 | RSS: Main: 227573760 04:46:54 INFO - PROCESS | 14246 | 04:49:56 INFO - PROCESS | 14246 | Cycle 1(1): loaded http://localhost:50845/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50845/tests/dromaeo/cssquery-prototype.html) 04:49:56 INFO - PROCESS | 14246 | RSS: Main: 212459520 04:49:56 INFO - PROCESS | 14246 | 04:52:59 INFO - PROCESS | 14246 | Cycle 1(1): loaded http://localhost:50845/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50845/tests/dromaeo/cssquery-yui.html) 04:52:59 INFO - PROCESS | 14246 | RSS: Main: 213942272 04:52:59 INFO - PROCESS | 14246 | 04:56:02 INFO - PROCESS | 14246 | Cycle 1(1): loaded http://localhost:50845/tests/dromaeo/cssquery-yui.html (next: http://localhost:50845/tests/dromaeo/cssquery-dojo.html) 04:56:02 INFO - PROCESS | 14246 | RSS: Main: 239259648 04:56:02 INFO - PROCESS | 14246 | 04:56:02 INFO - PROCESS | 14246 | __start_tp_report 04:56:02 INFO - PROCESS | 14246 | _x_x_mozilla_page_load 04:56:02 INFO - PROCESS | 14246 | _x_x_mozilla_page_load_details 04:56:02 INFO - PROCESS | 14246 | |i|pagename|runs| 04:56:02 INFO - PROCESS | 14246 | |0;dojo.html;3118.516629922362;3156.85794139264;3190.5373720810485;3194.9041528754146;3217.533457648641;5116.053530096925;5246.055709972204;5315;5320.89358212836;5366.570674346048;5159.742012899349;5239.580833533318;5250.159974404096;5264.578833693305;5292;4533.977330113361;4642.234031384817;4743.90512189756;4808.158572249842;4846.466888642247;4636.142313671981;4751.786169622375;4791.6406269529925;4797.328374027639;4920.040592084527;4776.737279449629;4859;4872.1473742094995;4885.218365061609;4914.287428322909;4843.128236917353;4867.610591152699;4871.756412179377;4875.731834749087;4909.288153217799;4692.296155576657;4801.303810947428;4809.903801923977;4843.612510999112;4895.951040489621;5040.571551418134;5101.795928162906;5106.4638212987475;5108.208227724672;5114.948850511484;5620.971895140539;5698.202251684767;5699.373068962411;5702.3157221133315;5758.884822303572;5734.885302293931;5750.6262092963825;5763.337216220147;5767.221425107598;5773.9422605773825;5073.264376665363;5167.405748338914;5299.12564426873;5348.197770334481;5358.544523715489;5844.561657875676;5846.093855452412;5854.2096816930025;5856.795012174639;5875.471207591338;5566.805161819398;5594.496495315441;5596.880623875241;5632.577556683265;5660.490555849993;5488.341399032141;5583.441655834466;5663.830085097454;5671.489565939003;5779.595428319977;5657.15142728594;5658.03813351723;5658.801941932013;5659;5660.801871934463;5643.661380317112;5643.943560564424;5644.971775141098;5651.180578816049;5652.971735141298;4237.046664500463;4308.246056940023;4344.47866256045;4378.715383500063;4430.534793846664;3933.1936952925153;3933.252681990413;3942.8817135485983;3966.186931678999;3966.4446977423186;5215.947840521622;5263.499967503081;5264.341957255343;5265.368155821326;5267.552258058108;5525.392206857243;5628.831135065954;5630;5648.491635752802;5802.6808525531505;5254.816081437208;5281.709505977131;5282.313299271147;5289.867753306121;5327.387350454747;4951.282064100686;4961.280614310905;4962.727050012284;4964.776585053682;5001.44984051754;5654.858628534237;5739.8852022960145;5789.710514474259;5793.073108302651;5955.37468565803;5708.115242137475;5712.6286791358425;5713.857153571194;5729.770809167587;5744.971275143597;5930.644161350333;5951.047832346804;5953.493953014043;5958.612690175125;5958.910616340671;5424.24060631504;5540.418256083214;5546.944530554642;5622.044252477171;5631.239782629293;5579.860503487445;5620.4660557247;5625;5627.746751396279;5632.943670563406;5474.507294343528;5477.561795056466;5478.45215478449;5489.698066606375;5516.889662206653;5373.247745315737;5413.404525502113;5470.671759694431;5509.834704958857;5629.296337957755;5402.945970540244;5429;5431.131019036935;5433.103537916358;5433.157860531624;5273.525382715574;5524.944750552443;5530.91703624454;5552.666839989452;5565.248691426606;5336.279602253646;5416.377116631637;5522.144067669517;5563.610547261653;5565.332160140809 04:56:02 INFO - PROCESS | 14246 | |1;ext.html;551.5959707792528;589.3222793787146;593.8545056461168;599.101347978033;599.6132494541023;28067;28335.85832070842;28623;28663.57004644932;35608.10979725502;39292;39796.20407591847;39810.60189398105;39938.20123597526;39955.20089598206;8602.741917742462;8757.562121893912;8758.781030474225;8766.736997890073;8766.912330876674;7672.808179795494;7805.9609701951695;8471.49171049736;10262.486875656225;10509.947450262776;10243.487825608727;10283.125934295595;10346.37921724699;10358.378497290149;10362.067413932744;7678.961605191938;10160.288779785418;10346.586136554528;10369.170466362673;10370.481475926248;7502.8124296892465;10393.220508461896;10555.894441055569;10597.73505662357;10626.46867656614;36533.269334613426;36877.81561092204;36977;37050.25899482022;37109.61910522986;3311.784733992283;3312.254742682901;3325.700686938163;3352.491378879514;3637.031594415873;26955.578765360635;27049.594256086173;27418.862905685342;27814.443711125867;29356.266093347836;3985.621365970228;4024.3963405489117;4052.8581499647667;4076.2458945094954;4163.5836416358425;262546;262693.686531568;262887;263224;263530;59752.701236493536;59802.70098649479;59993;60036;60066.39933600696;55305.1704224437;56550.151747723816;62355.6882215586;63801.17192968344;63985;15594.84405155934;15694.372225111096;15747.44883929057;15802.60493487649;15895.52313430599;10809.135269178447;10823.13414926804;10824.07995320391;10833.891661083288;10850;19269.4219173425;19397.127129279215;19476;19478.902605487165;19499.220031198878;7672.42456815741;7833.295003449717;7842.647080881374;7870.921290787019;8054.23484768946;904.3895370624933;989.2877128467636;1023.9129673977646;1093.704699731068;1117.804384232756;28731.85634071816;28804.279893002422;28952.565711514344;29091.56362654562;29183;1074.2909679611419;1113.9053180479589;1150.528283403817;1159.565163063851;1205.9276443413423;15187.696246075016;15458.5362439127;15748.92125539365;15913.522594321958;16152.838471615369;316352;321273;321280;321440;321620;52321.215181772306;52508.47491525112;52542;52616.736916315174;52635.473645263824;1156.1386766858575;1255.5982085732478;1295.2617008305365;1357.7352416278732;1383.4258782605107;26626;27080.458390832468;28542;30009.249768755955;30262.394752104396;47619.76190119027;47808.52191478041;47911.76044119757;48254;48302.27546586874;366251;380682;383843.69641187275;396945;397948;30988.915387962214;31282.68717312798;31466.685333146375;31469.05592832219;31720;43774.34338484989;44194.558054419045;44287.55712442834;44338.55661443473;45115.77442112769;36675;36836;37995.43006854955;38304.23391532098;38547.614523854405;37202.8139859299;37413;38302.61697382991;38457.615423845404;38601.42097868478;35529.467057993636;36570.085747856516;36608.633913660524;36647.63352366442;36897.97061161554;32145;32366.83816580996;33497.16257093592;34300.656993429744;34431.65568344285;23260.534789304456;23429.179978700664;23736.762632373455;23742.287731368087;23831.880840595684 04:56:02 INFO - PROCESS | 14246 | |2;jquery.html;350.3640891781416;354.4152148954226;354.588677134524;355.38518363231617;355.62303957804744;13648.11287266327;13998;15985.280662370193;15987.840121598794;16772.496825095237;15798.131102789343;16065.919670401661;16931.469519078237;17057.232424540893;17089.060101694402;5304.681719096847;5424.294841670578;5424.701641409721;5425.159100339434;5427.674339539621;3952.644262016418;4045.6156665116914;5384.40771515133;5789.536837053026;5973.641581505102;5893.793717219898;5914.970425147868;5918.88162236755;5929.258842644669;5931.08068249422;5685.488306052454;5825.79609713658;5828.3297420796725;5830.708464576775;5841.123831425278;5084.720340381277;5090.516400941905;5090.516400941941;5116.104681680691;5121;12350.135490515668;12368.319742414164;16743.827932044762;18349.7247541287;18823.71764423535;2107.6100921329603;2211.402921211264;2216.9889150554304;2223.377454312779;2472.6538284640164;9235.215006724437;9348.813023739487;9373.43759374433;9387.953060234724;9475.668351607661;1703.9148042597944;1778.9377371792054;1792.4353828544097;1811.6195598924241;1829.7346884701644;56619.43380566224;57410.712946435;57504.137437938465;58513.41486585122;60287.39712602906;9462.716118516455;9874.308798384043;10053.693019907512;10355.585776569003;10437.373757574418;13570.525031623845;13587.728245435035;13603.659908502168;13663.863361366259;13707.314634268247;7523.774286771406;7709.884351734729;7723.729669461654;7730.226977302337;7741.806454838562;7470.626468676544;7513.549187048795;7761.650725717243;7812.6093695315;7814.179511151361;4316.352547117957;4417.469903611523;4418.690691651554;4444.888877778017;4461.196984542748;1667.96664066718;1742.3379115935863;1751.2644689230553;1822.9361972330905;1841.5027942455463;921.8571121476182;951.7382719752123;1020.1430798129607;1043.3948309980194;1044.4307852220559;14312.499062532761;15228;16392.180390980404;17843.10784460772;18575;921.2537844345967;939.2298315381322;960.2462067277294;1014.1937159957852;1033.7312298802365;8765.956170219108;8847.601857916408;8911.108889111167;8928.464292142493;9186.356955013085;481229;489976;494359;505337;536135;74578;83506;84521;85324.57337713272;86153.5692321547;1146.621614867092;1155.8381826544291;1158.5423757615695;1162.668639437773;1167.0138732770795;15317.463888764285;15596.922015390304;15788.526344209693;16157.919210403872;16210.432634857723;32551;32738.1815454606;33149.834250829554;33785.49321760225;34155.14612134716;36697.81651091834;37749.245015100096;38121.428178577895;38274.23451530898;45714.77142614266;9316.114969077928;9596.568154432927;9757.51212439361;9761.707148785548;9772.657956971472;11471.311721296748;12426.440810163384;13007.284599347127;16221.351145954502;17944.91027544854;14251.786223206453;14319.928400357932;14432.85567144315;14630;14948.551543453714;14036.2981850905;14423.92788036053;14439.494617688331;14521.92739036298;14951.327190276246;14927;14982.475613353481;14989.700205996038;15415;15435.22823858825;8988.10118988096;9448.385854919408;9454.14912657864;9707.951460242935;9741;12144.635660930186;12742.936285318514;13804.654883627989;13983.161010339412;14545.636359091108 04:56:02 INFO - PROCESS | 14246 | |3;mootools.html;1286.440398426685;1401.8948578856584;1434.7991281220632;1583.5803512069303;1791.3282519055347;6705.79882603522;7439.51643143196;7579.507332023421;7598.202188770182;7625.6949722011195;7383.33549980503;7560.39516838653;7574.772756817304;7576.734814281501;7577.318041376275;2218.8446808723356;2258.0290475095703;2259.186692790594;2259.288324177887;2261.1520679745095;2208.61349263879;2214.9557008859815;2315.513742114158;2316.4787922717337;2318.026428899866;2235.273536100766;2253.6506841439605;2261.1068627891973;2278.54429114177;2280.5096904165603;2219.8557093788854;2221.677856710784;2237.5301186750803;2238.440389902524;2238.462768935444;2272.3183045086575;2289.942751431211;2293.483966107629;2295.758945310735;2295.7933785959176;7570.507916985433;7630.8855367169535;7634.580098094602;7643.044619422572;7646.96765936597;4492.797824097924;4523.140603285398;4528.411306530163;4557.156925968673;4557.316402539613;2985.9850700746356;3015.2914065194664;3068.98465507671;3083.3062560923836;3087.799293045945;1050.6007717067541;1056.9471526423724;1871.6069625378686;1885.820847019531;1924.393815947986;10021.799564008752;10035.197184225244;10075.596976120947;10089.949550252275;10090.747731306703;3969.801509924492;3994.241094192152;4019.7588144711412;4026.697997650188;4132.91734165315;8353;8370.665173393118;8382.455140415854;8384.664613415394;8390.454620449651;4630.976845115752;4648.070385922829;4686.1799185143145;4687.671862969628;4688.671792974527;3666.505021822073;3685.70514358856;4127.814248358831;4292.527821939584;4314.395984562164;3514.3498452786316;3525.7355698322726;3548.449990251515;3566.6433356664124;3608.891733247954;1083.951222195003;1098.3958822647512;1100.834874768791;1101.5924108080062;1112.1603189591806;852.1010334097587;938.5448057692014;1027.9617586237805;1041.906228439444;1103.4593049405732;7052.92947070533;7082.716691332289;7108.3957863581145;7109.28907109285;7114.00403943438;766.8420684766044;1180.392098069495;1201.8077107662732;1221.3055507091121;1225.7180848404917;5383.596230282745;5437.966786310589;5444.945550544523;5449.291592093082;5463.535599474009;8865.778355541033;8923.330750193762;9081.59132839024;9145.725628231165;9196.632134714537;8993.100689931085;9146.085391460801;9163.129502697233;9164.816703665889;9207.309451791143;7079.469039822034;7225.566466011951;7334.4499162563025;7340.11918569775;7418.072740907387;7114.253003434565;7121.643917804193;7157.64211789398;7179.784606461814;7182.317679820409;7606.315431611181;7943.0071241094865;8040.437169398086;8057.83884322322;8058.959705201671;8109.553974531457;8291.08798032204;8297.087320394872;8306.62620182081;8311.127331630092;6876.415504681958;6992.056072430157;7049.365557099885;7086.822829429099;7127.465440092117;7176.21061683204;7212.386947109554;7223.783286501413;7234.457415693739;7287.089113860768;5940.61386009908;6702.095217145623;6798.320167983162;6843.7604683835825;6968.756093536702;6323.747050118128;6569.868602628017;6606.471482281502;6663.36698013688;6791.083203767428;6521.184851893513;6649;6670.299618540177;6689.364510371507;6766.763163289262;5954.880902382015;6004.279486461478;6010.849728756816;6015.939840601713;6042.154098426312;6089.360617135137;6127.3259941407305;6158.599691020069;6170.7223174958135;6172.22847144107 04:56:02 INFO - PROCESS | 14246 | |4;prototype.html;332.5975569560831;335.92441700617366;340.63381864495676;341.56109399421746;344.9292894956533;6007.609505382153;6044.274687037556;6092.482139018189;6092.817215483531;6096.817095487137;5689.573282003846;5827.184194212814;5872.500837428824;5988.311344195408;6044.758209671619;4644.9535504644855;4659.720416774988;4679.672422930396;4688.249880019189;4707.929381059287;4455.487618923817;4685.953140468603;4692.108499385123;4692.859214223578;4699.788509517063;4474.463064432256;4505.098980203956;4565.155446242439;4584.220682483969;4613.284940834176;4579.496255411902;4579.519150489184;4589.334546490773;4635.049814787961;4644.9767751161025;4090.1819636072605;4095.9180816383805;4097.631213190797;4103.117829666606;4106.445629839964;5605.439456054362;5636.239107720447;5652.378238393773;5654.321481422215;5659.773609055633;5371.113766228567;5406.351237851483;5409.891802163935;5419.512243898029;5422.322209723785;6422.357764223587;6435.131257280254;6438.098666186737;6441.323661015573;6470.450011749007;4440.600345968878;4444.799984000728;4445.399871017404;4451.955480445219;4454.9777251113865;6603.108580341688;6650.401463868275;6664.866702665968;6687.364700353459;6695.962125870498;4524.117797029548;4530.799338175386;4530.818767249339;4534.433195850519;4537.047220083753;4578.473475550288;4583.922778147133;4588.059447813191;4590.219662657356;4592;5322.547583455373;5330.493603107699;5331.253624492574;5332.040232758063;5334.333208348957;6309.08518264849;6462.903056454157;6464.321246269168;6470.676466176672;6479.416852483299;1601.3994751968012;1617.9757303640454;1618.9838101619068;1619.9190040497929;1620.8379162083934;1070.5878236878857;1075.913926885863;1077.2997551591527;1092.1972350322508;1101.6970333158445;6030.698465076729;6055.757769689163;6058.57589968698;6069.3627169147485;6075.1798507200965;6478.643674597943;6663.13379260693;6664.966675166593;6667.433268172163;6667.56660817055;5940.970295148497;6015.879682406415;6082.513398928075;6101.359357267512;6120.387961203844;3557.6264492227942;3630.6550877666577;3634.400323946572;3634.7092232621326;3635.4910312556262;6847.383735463832;7015.684294206773;7019.262977387403;7021.1574611047;7021.473389495808;6864.0047193156715;6877.346652068046;6877.58734475933;6882.4149947254045;6882.449404047664;7009.474289428314;7020.122484689414;7033.824154396181;7034.050403195605;7036.964815175891;6589.915840471416;6669.833254168685;6708.597484150967;6714.194296684429;6714.899276510954;6625.602463852184;6629.46964242869;6634.668266586555;6636.27001029896;6640.867182656417;6976.127984002;7012.053372794811;7013;7018.6490675465;7019.613921234381;4467.776611169494;4524.751138687404;4546.568076032771;4550.681452298308;4551.044280700958;6740;6795.218549866829;6796.116504854337;6798.898016529855;6802.965985170043;6521.315261897433;6524.347565243438;6534.346565343428;6539.247986481425;6539.836504087436;6406.231252249573;6504.6747662615735;6510.7721229756735;6510.967445162744;6511.47908167336;6370.331115232834;6370.4903607712195;6370.649614271259;6374.808755737336;6376.9043464349;6511.706973186123;6547.574407663486;6549.70526326326;6550.868982620225;6558.770443034471;6243.188385509855;6361.363863613602;6372.55392122547;6379.138816259746;6400.647964361819 04:56:02 INFO - PROCESS | 14246 | |5;yui.html;696.390658174098;729.3654520567108;759.0966749568014;819.5287709566999;825.5211977053308;12869.099163058578;13119.14725542839;13127.737445251089;13138;13160.605181844548;14433.711325773478;14533.563993080224;14570.708585828277;14578.854211457883;14581.489647862327;674.5413119079025;679.2358596578849;833.9499630022187;842.0400743152811;844.2823599940064;817.8486979908706;823.736404350608;827.3587969323762;829.1294141151797;829.5147338806805;868.5396739727954;868.6655637579514;868.8262347530488;870.7779516223354;873.1879352202449;694.4860803005764;701.0115736811098;849.6346570974479;859.0850743957665;869.7303835810887;643.012975083245;643.112504743451;643.1414062226933;643.584887747405;643.5945354426728;13023.739525209443;13062.477500899953;13087.149335293176;13092;13093.279869607168;11327.263727857662;11674.941625291904;11707.356095414749;11853.214494593763;11971.64085077449;9727.708168754949;10058.698239052841;10188.94905525475;10205.285630005903;10303.845442318296;3649.5802982656805;3659.249853779969;3675.4303083022173;3769.6607305342377;3780.8298626561595;42358.57641423577;43216.78391608053;43230.35154472685;44768.77615611901;45115.54884451146;9999.50002499872;10210.4384258865;10393.9480302598;10433.9478302608;10651.627193048205;18651.253949842125;18697.439076827715;18703.064846757607;18728.812711872706;18764.0617969101;7750.728724494616;7834.451588388872;7898.249666281694;8004.239597238253;8119.4722343047515;4166.791660416967;4260.510041345223;4310.849120280775;4351.97824010878;4357.346398040256;2926.414717056597;2957.2902503399027;2962.066948911086;2963.7184467475554;2966.154645925944;547.1382572448409;547.3459216236639;558.2184941082517;561.1974875927382;573.2662192393743;531.9840404787863;608.622653954551;609.9052201298591;675.7702381190419;695.5166159519085;8579.742607721779;8600.69684332957;8644.178803013703;8796.604152813139;8875.778105547284;572.5076434266527;658.1838520234875;663.91037209977;680.5882441123148;696.3697853442643;3929.9214015719526;4157.875263742093;4203.159368126387;4240.321548552217;4244.724092934011;53874.46125538773;54066;54195.72902135543;54256.45743542593;57547.71226143843;47352.763236184284;48413.5158648416;48418.27372589414;48942.75528622334;49404.011919761404;43062.354064689054;43257.13485730268;44036;44133;44860;8245.464044837066;8523.91476085256;8532.658693652433;8600.913990860261;8636.611352489279;33010.66989330076;33213.16967075843;33816.32367352688;33992.490112648826;34251.82874085614;39295.2140957185;39418.60581394264;41468;43713.78143109264;43869.78065109654;10343.482825858526;10575.312604680672;10595.417252050904;10623.309484883457;10991.725206869893;11416.94291528537;11529.596464123715;11562.30626162433;11733.296002239893;11762.647120586396;10676.57293708243;10957.452127393439;11047.889521104686;11172.888271117185;11283.266587671775;10935.234533582572;11042.392668403316;11130.387828669502;11175.55297788112;11399.14506412039;10027.247956403153;10830.566777329133;10888.564457421615;10895.455227238765;10944.507497162806;9253.167214950687;9300.162985331353;9356.532173391168;9406;9716.174125199155;8566.314694824274;8945.46327220369;8964.641414343614;9115.361924665474;9878.950605246928 04:56:02 INFO - PROCESS | 14246 | __end_tp_report 04:56:02 INFO - PROCESS | 14246 | __start_cc_report 04:56:02 INFO - PROCESS | 14246 | _x_x_mozilla_cycle_collect,915 04:56:02 INFO - PROCESS | 14246 | __end_cc_report 04:56:02 INFO - PROCESS | 14246 | __startTimestamp1451307362665__endTimestamp 04:56:02 INFO - PROCESS | 14246 | 04:56:02 INFO - PROCESS | 14246 | ------- Summary: start ------- 04:56:02 INFO - PROCESS | 14246 | Number of tests: 6 04:56:02 INFO - PROCESS | 14246 | 04:56:02 INFO - PROCESS | 14246 | [#0] dojo.html Cycles:165 Average:5253.72 Median:5429.00 stddev:582.07 (10.7%) stddev-sans-first:559.24 04:56:02 INFO - PROCESS | 14246 | Values: 3118.5 3156.9 3190.5 3194.9 3217.5 5116.1 5246.1 5315.0 5320.9 5366.6 5159.7 5239.6 5250.2 5264.6 5292.0 4534.0 4642.2 4743.9 4808.2 4846.5 4636.1 4751.8 4791.6 4797.3 4920.0 4776.7 4859.0 4872.1 4885.2 4914.3 4843.1 4867.6 4871.8 4875.7 4909.3 4692.3 4801.3 4809.9 4843.6 4896.0 5040.6 5101.8 5106.5 5108.2 5114.9 5621.0 5698.2 5699.4 5702.3 5758.9 5734.9 5750.6 5763.3 5767.2 5773.9 5073.3 5167.4 5299.1 5348.2 5358.5 5844.6 5846.1 5854.2 5856.8 5875.5 5566.8 5594.5 5596.9 5632.6 5660.5 5488.3 5583.4 5663.8 5671.5 5779.6 5657.2 5658.0 5658.8 5659.0 5660.8 5643.7 5643.9 5645.0 5651.2 5653.0 4237.0 4308.2 4344.5 4378.7 4430.5 3933.2 3933.3 3942.9 3966.2 3966.4 5215.9 5263.5 5264.3 5265.4 5267.6 5525.4 5628.8 5630.0 5648.5 5802.7 5254.8 5281.7 5282.3 5289.9 5327.4 4951.3 4961.3 4962.7 4964.8 5001.4 5654.9 5739.9 5789.7 5793.1 5955.4 5708.1 5712.6 5713.9 5729.8 5745.0 5930.6 5951.0 5953.5 5958.6 5958.9 5424.2 5540.4 5546.9 5622.0 5631.2 5579.9 5620.5 5625.0 5627.7 5632.9 5474.5 5477.6 5478.5 5489.7 5516.9 5373.2 5413.4 5470.7 5509.8 5629.3 5402.9 5429.0 5431.1 5433.1 5433.2 5273.5 5524.9 5530.9 5552.7 5565.2 5336.3 5416.4 5522.1 5563.6 5565.3 04:56:02 INFO - PROCESS | 14246 | 04:56:02 INFO - PROCESS | 14246 | [#1] ext.html Cycles:180 Average:48738.48 Median:3318.98 stddev:85824.78 (2585.9%) stddev-sans-first:85989.28 04:56:02 INFO - PROCESS | 14246 | Values: 551.6 589.3 593.9 599.1 599.6 28067.0 28335.9 28623.0 28663.6 35608.1 39292.0 39796.2 39810.6 39938.2 39955.2 8602.7 8757.6 8758.8 8766.7 8766.9 7672.8 7806.0 8471.5 10262.5 10509.9 10243.5 10283.1 10346.4 10358.4 10362.1 7679.0 10160.3 10346.6 10369.2 10370.5 7502.8 10393.2 10555.9 10597.7 10626.5 36533.3 36877.8 36977.0 37050.3 37109.6 3311.8 3312.3 3325.7 3352.5 3637.0 26955.6 27049.6 27418.9 27814.4 29356.3 3985.6 4024.4 4052.9 4076.2 4163.6 262546.0 262693.7 262887.0 263224.0 263530.0 59752.7 59802.7 59993.0 60036.0 60066.4 55305.2 56550.2 62355.7 63801.2 63985.0 15594.8 15694.4 15747.4 15802.6 15895.5 10809.1 10823.1 10824.1 10833.9 10850.0 19269.4 19397.1 19476.0 19478.9 19499.2 7672.4 7833.3 7842.6 7870.9 8054.2 904.4 989.3 1023.9 1093.7 1117.8 28731.9 28804.3 28952.6 29091.6 29183.0 1074.3 1113.9 1150.5 1159.6 1205.9 15187.7 15458.5 15748.9 15913.5 16152.8 316352.0 321273.0 321280.0 321440.0 321620.0 52321.2 52508.5 52542.0 52616.7 52635.5 1156.1 1255.6 1295.3 1357.7 1383.4 26626.0 27080.5 28542.0 30009.2 30262.4 47619.8 47808.5 47911.8 48254.0 48302.3 366251.0 380682.0 383843.7 396945.0 397948.0 30988.9 31282.7 31466.7 31469.1 31720.0 43774.3 44194.6 44287.6 44338.6 45115.8 36675.0 36836.0 37995.4 38304.2 38547.6 37202.8 37413.0 38302.6 38457.6 38601.4 35529.5 36570.1 36608.6 36647.6 36898.0 32145.0 32366.8 33497.2 34300.7 34431.7 23260.5 23429.2 23736.8 23742.3 23831.9 04:56:02 INFO - PROCESS | 14246 | 04:56:02 INFO - PROCESS | 14246 | [#2] jquery.html Cycles:180 Average:27331.13 Median:354.99 stddev:82058.15 (23115.8%) stddev-sans-first:82263.34 04:56:02 INFO - PROCESS | 14246 | Values: 350.4 354.4 354.6 355.4 355.6 13648.1 13998.0 15985.3 15987.8 16772.5 15798.1 16065.9 16931.5 17057.2 17089.1 5304.7 5424.3 5424.7 5425.2 5427.7 3952.6 4045.6 5384.4 5789.5 5973.6 5893.8 5915.0 5918.9 5929.3 5931.1 5685.5 5825.8 5828.3 5830.7 5841.1 5084.7 5090.5 5090.5 5116.1 5121.0 12350.1 12368.3 16743.8 18349.7 18823.7 2107.6 2211.4 2217.0 2223.4 2472.7 9235.2 9348.8 9373.4 9388.0 9475.7 1703.9 1778.9 1792.4 1811.6 1829.7 56619.4 57410.7 57504.1 58513.4 60287.4 9462.7 9874.3 10053.7 10355.6 10437.4 13570.5 13587.7 13603.7 13663.9 13707.3 7523.8 7709.9 7723.7 7730.2 7741.8 7470.6 7513.5 7761.7 7812.6 7814.2 4316.4 4417.5 4418.7 4444.9 4461.2 1668.0 1742.3 1751.3 1822.9 1841.5 921.9 951.7 1020.1 1043.4 1044.4 14312.5 15228.0 16392.2 17843.1 18575.0 921.3 939.2 960.2 1014.2 1033.7 8766.0 8847.6 8911.1 8928.5 9186.4 481229.0 489976.0 494359.0 505337.0 536135.0 74578.0 83506.0 84521.0 85324.6 86153.6 1146.6 1155.8 1158.5 1162.7 1167.0 15317.5 15596.9 15788.5 16157.9 16210.4 32551.0 32738.2 33149.8 33785.5 34155.1 36697.8 37749.2 38121.4 38274.2 45714.8 9316.1 9596.6 9757.5 9761.7 9772.7 11471.3 12426.4 13007.3 16221.4 17944.9 14251.8 14319.9 14432.9 14630.0 14948.6 14036.3 14423.9 14439.5 14521.9 14951.3 14927.0 14982.5 14989.7 15415.0 15435.2 8988.1 9448.4 9454.1 9708.0 9741.0 12144.6 12742.9 13804.7 13983.2 14545.6 04:56:02 INFO - PROCESS | 14246 | 04:56:02 INFO - PROCESS | 14246 | [#3] mootools.html Cycles:180 Average:5279.40 Median:6013.39 stddev:2676.98 (44.5%) stddev-sans-first:2667.66 04:56:02 INFO - PROCESS | 14246 | Values: 1286.4 1401.9 1434.8 1583.6 1791.3 6705.8 7439.5 7579.5 7598.2 7625.7 7383.3 7560.4 7574.8 7576.7 7577.3 2218.8 2258.0 2259.2 2259.3 2261.2 2208.6 2215.0 2315.5 2316.5 2318.0 2235.3 2253.7 2261.1 2278.5 2280.5 2219.9 2221.7 2237.5 2238.4 2238.5 2272.3 2289.9 2293.5 2295.8 2295.8 7570.5 7630.9 7634.6 7643.0 7647.0 4492.8 4523.1 4528.4 4557.2 4557.3 2986.0 3015.3 3069.0 3083.3 3087.8 1050.6 1056.9 1871.6 1885.8 1924.4 10021.8 10035.2 10075.6 10089.9 10090.7 3969.8 3994.2 4019.8 4026.7 4132.9 8353.0 8370.7 8382.5 8384.7 8390.5 4631.0 4648.1 4686.2 4687.7 4688.7 3666.5 3685.7 4127.8 4292.5 4314.4 3514.3 3525.7 3548.4 3566.6 3608.9 1084.0 1098.4 1100.8 1101.6 1112.2 852.1 938.5 1028.0 1041.9 1103.5 7052.9 7082.7 7108.4 7109.3 7114.0 766.8 1180.4 1201.8 1221.3 1225.7 5383.6 5438.0 5444.9 5449.3 5463.5 8865.8 8923.3 9081.6 9145.7 9196.6 8993.1 9146.1 9163.1 9164.8 9207.3 7079.5 7225.6 7334.4 7340.1 7418.1 7114.3 7121.6 7157.6 7179.8 7182.3 7606.3 7943.0 8040.4 8057.8 8059.0 8109.6 8291.1 8297.1 8306.6 8311.1 6876.4 6992.1 7049.4 7086.8 7127.5 7176.2 7212.4 7223.8 7234.5 7287.1 5940.6 6702.1 6798.3 6843.8 6968.8 6323.7 6569.9 6606.5 6663.4 6791.1 6521.2 6649.0 6670.3 6689.4 6766.8 5954.9 6004.3 6010.8 6015.9 6042.2 6089.4 6127.3 6158.6 6170.7 6172.2 04:56:02 INFO - PROCESS | 14246 | 04:56:02 INFO - PROCESS | 14246 | [#4] prototype.html Cycles:180 Average:5394.88 Median:6057.17 stddev:1641.94 (27.1%) stddev-sans-first:1601.98 04:56:02 INFO - PROCESS | 14246 | Values: 332.6 335.9 340.6 341.6 344.9 6007.6 6044.3 6092.5 6092.8 6096.8 5689.6 5827.2 5872.5 5988.3 6044.8 4645.0 4659.7 4679.7 4688.2 4707.9 4455.5 4686.0 4692.1 4692.9 4699.8 4474.5 4505.1 4565.2 4584.2 4613.3 4579.5 4579.5 4589.3 4635.0 4645.0 4090.2 4095.9 4097.6 4103.1 4106.4 5605.4 5636.2 5652.4 5654.3 5659.8 5371.1 5406.4 5409.9 5419.5 5422.3 6422.4 6435.1 6438.1 6441.3 6470.5 4440.6 4444.8 4445.4 4452.0 4455.0 6603.1 6650.4 6664.9 6687.4 6696.0 4524.1 4530.8 4530.8 4534.4 4537.0 4578.5 4583.9 4588.1 4590.2 4592.0 5322.5 5330.5 5331.3 5332.0 5334.3 6309.1 6462.9 6464.3 6470.7 6479.4 1601.4 1618.0 1619.0 1619.9 1620.8 1070.6 1075.9 1077.3 1092.2 1101.7 6030.7 6055.8 6058.6 6069.4 6075.2 6478.6 6663.1 6665.0 6667.4 6667.6 5941.0 6015.9 6082.5 6101.4 6120.4 3557.6 3630.7 3634.4 3634.7 3635.5 6847.4 7015.7 7019.3 7021.2 7021.5 6864.0 6877.3 6877.6 6882.4 6882.4 7009.5 7020.1 7033.8 7034.1 7037.0 6589.9 6669.8 6708.6 6714.2 6714.9 6625.6 6629.5 6634.7 6636.3 6640.9 6976.1 7012.1 7013.0 7018.6 7019.6 4467.8 4524.8 4546.6 4550.7 4551.0 6740.0 6795.2 6796.1 6798.9 6803.0 6521.3 6524.3 6534.3 6539.2 6539.8 6406.2 6504.7 6510.8 6511.0 6511.5 6370.3 6370.5 6370.6 6374.8 6376.9 6511.7 6547.6 6549.7 6550.9 6558.8 6243.2 6361.4 6372.6 6379.1 6400.6 04:56:02 INFO - PROCESS | 14246 | 04:56:02 INFO - PROCESS | 14246 | [#5] yui.html Cycles:180 Average:13278.10 Median:24035.56 stddev:14963.19 (62.3%) stddev-sans-first:14975.33 04:56:02 INFO - PROCESS | 14246 | Values: 696.4 729.4 759.1 819.5 825.5 12869.1 13119.1 13127.7 13138.0 13160.6 14433.7 14533.6 14570.7 14578.9 14581.5 674.5 679.2 833.9 842.0 844.3 817.8 823.7 827.4 829.1 829.5 868.5 868.7 868.8 870.8 873.2 694.5 701.0 849.6 859.1 869.7 643.0 643.1 643.1 643.6 643.6 13023.7 13062.5 13087.1 13092.0 13093.3 11327.3 11674.9 11707.4 11853.2 11971.6 9727.7 10058.7 10188.9 10205.3 10303.8 3649.6 3659.2 3675.4 3769.7 3780.8 42358.6 43216.8 43230.4 44768.8 45115.5 9999.5 10210.4 10393.9 10433.9 10651.6 18651.3 18697.4 18703.1 18728.8 18764.1 7750.7 7834.5 7898.2 8004.2 8119.5 4166.8 4260.5 4310.8 4352.0 4357.3 2926.4 2957.3 2962.1 2963.7 2966.2 547.1 547.3 558.2 561.2 573.3 532.0 608.6 609.9 675.8 695.5 8579.7 8600.7 8644.2 8796.6 8875.8 572.5 658.2 663.9 680.6 696.4 3929.9 4157.9 4203.2 4240.3 4244.7 53874.5 54066.0 54195.7 54256.5 57547.7 47352.8 48413.5 48418.3 48942.8 49404.0 43062.4 43257.1 44036.0 44133.0 44860.0 8245.5 8523.9 8532.7 8600.9 8636.6 33010.7 33213.2 33816.3 33992.5 34251.8 39295.2 39418.6 41468.0 43713.8 43869.8 10343.5 10575.3 10595.4 10623.3 10991.7 11416.9 11529.6 11562.3 11733.3 11762.6 10676.6 10957.5 11047.9 11172.9 11283.3 10935.2 11042.4 11130.4 11175.6 11399.1 10027.2 10830.6 10888.6 10895.5 10944.5 9253.2 9300.2 9356.5 9406.0 9716.2 8566.3 8945.5 8964.6 9115.4 9879.0 04:56:02 INFO - PROCESS | 14246 | -------- Summary: end -------- 04:56:02 INFO - PROCESS | 14246 | 04:56:03 INFO - TEST-INFO | 14246: exit 0 04:56:03 INFO - TEST-OK | dromaeo_css | took 1114351ms 04:56:03 INFO - TEST-START | kraken 04:56:03 INFO - operating with platform_type : linux_ 04:56:03 INFO - Initialising browser for kraken test... 04:56:03 INFO - TEST-INFO | started process 14430 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiQ61iQ/profile http://localhost:50845/getInfo.html) 04:56:08 INFO - PROCESS | 14430 | __metrics Screen width/height:1600/1200 04:56:08 INFO - PROCESS | 14430 | colorDepth:24 04:56:08 INFO - PROCESS | 14430 | Browser inner width/height: 1024/697 04:56:08 INFO - PROCESS | 14430 | __metrics 04:56:08 INFO - PROCESS | 14430 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:56:09 INFO - PROCESS | 14430 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:56:09 INFO - TEST-INFO | 14430: exit 0 04:56:09 INFO - Browser initialized. 04:56:09 INFO - Running cycle 1/1 for kraken test... 04:56:09 INFO - TEST-INFO | started process 14511 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiQ61iQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:21 INFO - PROCESS | 14511 | RSS: Main: 149499904 04:56:21 INFO - PROCESS | 14511 | 04:56:24 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:50845/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50845/tests/kraken/driver.html?testName=audio-beat-detection) 04:56:24 INFO - PROCESS | 14511 | RSS: Main: 184082432 04:56:24 INFO - PROCESS | 14511 | 04:56:27 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:50845/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50845/tests/kraken/driver.html?testName=audio-dft) 04:56:27 INFO - PROCESS | 14511 | RSS: Main: 175095808 04:56:27 INFO - PROCESS | 14511 | 04:56:30 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:50845/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50845/tests/kraken/driver.html?testName=audio-fft) 04:56:31 INFO - PROCESS | 14511 | RSS: Main: 158625792 04:56:31 INFO - PROCESS | 14511 | 04:56:33 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:50845/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50845/tests/kraken/driver.html?testName=audio-oscillator) 04:56:33 INFO - PROCESS | 14511 | RSS: Main: 163364864 04:56:33 INFO - PROCESS | 14511 | 04:56:36 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:50845/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50845/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:56:36 INFO - PROCESS | 14511 | RSS: Main: 164409344 04:56:36 INFO - PROCESS | 14511 | 04:56:39 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:50845/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50845/tests/kraken/driver.html?testName=imaging-darkroom) 04:56:40 INFO - PROCESS | 14511 | RSS: Main: 163164160 04:56:40 INFO - PROCESS | 14511 | 04:56:43 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:50845/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50845/tests/kraken/driver.html?testName=imaging-desaturate) 04:56:44 INFO - PROCESS | 14511 | RSS: Main: 164392960 04:56:44 INFO - PROCESS | 14511 | 04:56:46 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:50845/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50845/tests/kraken/driver.html?testName=json-parse-financial) 04:56:47 INFO - PROCESS | 14511 | RSS: Main: 164233216 04:56:47 INFO - PROCESS | 14511 | 04:56:48 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:50845/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50845/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:56:49 INFO - PROCESS | 14511 | RSS: Main: 179290112 04:56:49 INFO - PROCESS | 14511 | 04:56:51 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:50845/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50845/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:56:51 INFO - PROCESS | 14511 | RSS: Main: 175325184 04:56:51 INFO - PROCESS | 14511 | 04:56:53 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:50845/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50845/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:56:54 INFO - PROCESS | 14511 | RSS: Main: 182280192 04:56:54 INFO - PROCESS | 14511 | 04:56:56 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:50845/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50845/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:56:57 INFO - PROCESS | 14511 | RSS: Main: 190537728 04:56:57 INFO - PROCESS | 14511 | 04:57:00 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:50845/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50845/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:57:00 INFO - PROCESS | 14511 | RSS: Main: 190349312 04:57:00 INFO - PROCESS | 14511 | 04:57:02 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:50845/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50845/tests/kraken/driver.html?testName=ai-astar) 04:57:02 INFO - PROCESS | 14511 | RSS: Main: 247451648 04:57:02 INFO - PROCESS | 14511 | 04:57:02 INFO - PROCESS | 14511 | __start_tp_report 04:57:02 INFO - PROCESS | 14511 | _x_x_mozilla_page_load 04:57:02 INFO - PROCESS | 14511 | _x_x_mozilla_page_load_details 04:57:02 INFO - PROCESS | 14511 | |i|pagename|runs| 04:57:02 INFO - PROCESS | 14511 | |0;ai-astar;112;111;106;110;111;111;101;111;109;101 04:57:02 INFO - PROCESS | 14511 | |1;audio-beat-detection;146;122;150;167;122;151;150;124;164;123 04:57:02 INFO - PROCESS | 14511 | |2;audio-dft;162;162;159;159;164;159;159;160;158;159 04:57:02 INFO - PROCESS | 14511 | |3;audio-fft;74;71;83;91;71;72;74;98;91;73 04:57:02 INFO - PROCESS | 14511 | |4;audio-oscillator;95;97;141;96;96;95;138;95;96;142 04:57:02 INFO - PROCESS | 14511 | |5;imaging-gaussian-blur;109;109;109;109;110;109;109;108;109;110 04:57:02 INFO - PROCESS | 14511 | |6;imaging-darkroom;144;145;146;145;145;146;147;146;145;145 04:57:02 INFO - PROCESS | 14511 | |7;imaging-desaturate;96;95;96;95;95;96;96;96;95;95 04:57:02 INFO - PROCESS | 14511 | |8;json-parse-financial;56;56;57;57;56;57;56;57;55;55 04:57:02 INFO - PROCESS | 14511 | |9;json-stringify-tinderbox;68;67;68;68;69;68;68;68;68;68 04:57:02 INFO - PROCESS | 14511 | |10;stanford-crypto-aes;85;83;86;85;85;85;86;84;85;85 04:57:02 INFO - PROCESS | 14511 | |11;stanford-crypto-ccm;128;112;120;118;115;123;120;114;116;118 04:57:02 INFO - PROCESS | 14511 | |12;stanford-crypto-pbkdf2;140;151;149;153;160;140;149;158;149;139 04:57:02 INFO - PROCESS | 14511 | |13;stanford-crypto-sha256-iterative;67;67;66;68;66;67;66;68;67;66 04:57:02 INFO - PROCESS | 14511 | __end_tp_report 04:57:02 INFO - PROCESS | 14511 | __start_cc_report 04:57:02 INFO - PROCESS | 14511 | _x_x_mozilla_cycle_collect,941 04:57:02 INFO - PROCESS | 14511 | __end_cc_report 04:57:02 INFO - PROCESS | 14511 | __startTimestamp1451307422544__endTimestamp 04:57:02 INFO - PROCESS | 14511 | 04:57:02 INFO - PROCESS | 14511 | ------- Summary: start ------- 04:57:02 INFO - PROCESS | 14511 | Number of tests: 14 04:57:02 INFO - PROCESS | 14511 | 04:57:02 INFO - PROCESS | 14511 | [#0] ai-astar Cycles:10 Average:108.30 Median:111.00 stddev:4.19 (3.8%) stddev-sans-first:4.23 04:57:02 INFO - PROCESS | 14511 | Values: 112.0 111.0 106.0 110.0 111.0 111.0 101.0 111.0 109.0 101.0 04:57:02 INFO - PROCESS | 14511 | 04:57:02 INFO - PROCESS | 14511 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:150.00 stddev:17.70 (11.8%) stddev-sans-first:18.71 04:57:02 INFO - PROCESS | 14511 | Values: 146.0 122.0 150.0 167.0 122.0 151.0 150.0 124.0 164.0 123.0 04:57:02 INFO - PROCESS | 14511 | 04:57:02 INFO - PROCESS | 14511 | [#2] audio-dft Cycles:10 Average:160.10 Median:159.50 stddev:1.91 (1.2%) stddev-sans-first:1.90 04:57:02 INFO - PROCESS | 14511 | Values: 162.0 162.0 159.0 159.0 164.0 159.0 159.0 160.0 158.0 159.0 04:57:02 INFO - PROCESS | 14511 | 04:57:02 INFO - PROCESS | 14511 | [#3] audio-fft Cycles:10 Average:79.80 Median:78.50 stddev:10.12 (12.9%) stddev-sans-first:10.51 04:57:02 INFO - PROCESS | 14511 | Values: 74.0 71.0 83.0 91.0 71.0 72.0 74.0 98.0 91.0 73.0 04:57:02 INFO - PROCESS | 14511 | 04:57:02 INFO - PROCESS | 14511 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:95.50 stddev:21.58 (22.6%) stddev-sans-first:22.28 04:57:02 INFO - PROCESS | 14511 | Values: 95.0 97.0 141.0 96.0 96.0 95.0 138.0 95.0 96.0 142.0 04:57:02 INFO - PROCESS | 14511 | 04:57:02 INFO - PROCESS | 14511 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:57:02 INFO - PROCESS | 14511 | Values: 109.0 109.0 109.0 109.0 110.0 109.0 109.0 108.0 109.0 110.0 04:57:02 INFO - PROCESS | 14511 | 04:57:02 INFO - PROCESS | 14511 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 04:57:02 INFO - PROCESS | 14511 | Values: 144.0 145.0 146.0 145.0 145.0 146.0 147.0 146.0 145.0 145.0 04:57:02 INFO - PROCESS | 14511 | 04:57:02 INFO - PROCESS | 14511 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:57:02 INFO - PROCESS | 14511 | Values: 96.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 04:57:02 INFO - PROCESS | 14511 | 04:57:02 INFO - PROCESS | 14511 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.50 stddev:0.79 (1.4%) stddev-sans-first:0.83 04:57:02 INFO - PROCESS | 14511 | Values: 56.0 56.0 57.0 57.0 56.0 57.0 56.0 57.0 55.0 55.0 04:57:02 INFO - PROCESS | 14511 | 04:57:02 INFO - PROCESS | 14511 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 04:57:02 INFO - PROCESS | 14511 | Values: 68.0 67.0 68.0 68.0 69.0 68.0 68.0 68.0 68.0 68.0 04:57:02 INFO - PROCESS | 14511 | 04:57:02 INFO - PROCESS | 14511 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.00 stddev:0.88 (1.0%) stddev-sans-first:0.93 04:57:02 INFO - PROCESS | 14511 | Values: 85.0 83.0 86.0 85.0 85.0 85.0 86.0 84.0 85.0 85.0 04:57:02 INFO - PROCESS | 14511 | 04:57:02 INFO - PROCESS | 14511 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:119.00 stddev:4.67 (3.9%) stddev-sans-first:3.43 04:57:02 INFO - PROCESS | 14511 | Values: 128.0 112.0 120.0 118.0 115.0 123.0 120.0 114.0 116.0 118.0 04:57:02 INFO - PROCESS | 14511 | 04:57:02 INFO - PROCESS | 14511 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:150.00 stddev:7.33 (4.9%) stddev-sans-first:7.05 04:57:02 INFO - PROCESS | 14511 | Values: 140.0 151.0 149.0 153.0 160.0 140.0 149.0 158.0 149.0 139.0 04:57:02 INFO - PROCESS | 14511 | 04:57:02 INFO - PROCESS | 14511 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 04:57:02 INFO - PROCESS | 14511 | Values: 67.0 67.0 66.0 68.0 66.0 67.0 66.0 68.0 67.0 66.0 04:57:02 INFO - PROCESS | 14511 | -------- Summary: end -------- 04:57:02 INFO - PROCESS | 14511 | 04:57:03 INFO - TEST-INFO | 14511: exit 0 04:57:03 INFO - TEST-OK | kraken | took 60044ms 04:57:03 INFO - TEST-START | v8_7 04:57:03 INFO - operating with platform_type : linux_ 04:57:03 INFO - Initialising browser for v8_7 test... 04:57:03 INFO - TEST-INFO | started process 14759 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcEIBic/profile http://localhost:50845/getInfo.html) 04:57:08 INFO - PROCESS | 14759 | __metrics Screen width/height:1600/1200 04:57:08 INFO - PROCESS | 14759 | colorDepth:24 04:57:08 INFO - PROCESS | 14759 | Browser inner width/height: 1024/697 04:57:08 INFO - PROCESS | 14759 | __metrics 04:57:08 INFO - PROCESS | 14759 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:57:08 INFO - PROCESS | 14759 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:57:09 INFO - TEST-INFO | 14759: exit 0 04:57:09 INFO - Browser initialized. 04:57:09 INFO - Running cycle 1/1 for v8_7 test... 04:57:09 INFO - TEST-INFO | started process 14843 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcEIBic/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:21 INFO - PROCESS | 14843 | RSS: Main: 148262912 04:57:21 INFO - PROCESS | 14843 | 04:57:42 INFO - PROCESS | 14843 | Cycle 1(1): loaded http://localhost:50845/tests/v8_7/run.html (next: http://localhost:50845/tests/v8_7/run.html) 04:57:43 INFO - PROCESS | 14843 | RSS: Main: 576864256 04:57:43 INFO - PROCESS | 14843 | 04:57:43 INFO - PROCESS | 14843 | __start_tp_report 04:57:43 INFO - PROCESS | 14843 | _x_x_mozilla_page_load 04:57:43 INFO - PROCESS | 14843 | _x_x_mozilla_page_load_details 04:57:43 INFO - PROCESS | 14843 | |i|pagename|runs| 04:57:43 INFO - PROCESS | 14843 | |0;Richards;166.61112962345885 04:57:43 INFO - PROCESS | 14843 | |1;DeltaBlue;191.49751053236307 04:57:43 INFO - PROCESS | 14843 | |2;Encrypt;280.0336040324839 04:57:43 INFO - PROCESS | 14843 | |3;Decrypt;5251.308900523561 04:57:43 INFO - PROCESS | 14843 | |4;RayTrace;1978.2608695652175 04:57:43 INFO - PROCESS | 14843 | |5;Earley;777.6049766718507 04:57:43 INFO - PROCESS | 14843 | |6;Boyer;12395.061728395061 04:57:43 INFO - PROCESS | 14843 | |7;RegExp;26051.28205128205 04:57:43 INFO - PROCESS | 14843 | |8;Splay;620.7324643078833 04:57:43 INFO - PROCESS | 14843 | |9;NavierStokes;4840.579710144928 04:57:43 INFO - PROCESS | 14843 | __end_tp_report 04:57:43 INFO - PROCESS | 14843 | __startTimestamp1451307463204__endTimestamp 04:57:43 INFO - PROCESS | 14843 | 04:57:43 INFO - PROCESS | 14843 | ------- Summary: start ------- 04:57:43 INFO - PROCESS | 14843 | Number of tests: 10 04:57:43 INFO - PROCESS | 14843 | 04:57:43 INFO - PROCESS | 14843 | [#0] Richards Cycles:1 Average:166.61 Median:166.61 stddev:0.00 (0.0%) 04:57:43 INFO - PROCESS | 14843 | Values: 166.6 04:57:43 INFO - PROCESS | 14843 | 04:57:43 INFO - PROCESS | 14843 | [#1] DeltaBlue Cycles:1 Average:191.50 Median:191.50 stddev:0.00 (0.0%) 04:57:43 INFO - PROCESS | 14843 | Values: 191.5 04:57:43 INFO - PROCESS | 14843 | 04:57:43 INFO - PROCESS | 14843 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 04:57:43 INFO - PROCESS | 14843 | Values: 280.0 04:57:43 INFO - PROCESS | 14843 | 04:57:43 INFO - PROCESS | 14843 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 04:57:43 INFO - PROCESS | 14843 | Values: 5251.3 04:57:43 INFO - PROCESS | 14843 | 04:57:43 INFO - PROCESS | 14843 | [#4] RayTrace Cycles:1 Average:1978.26 Median:1978.26 stddev:0.00 (0.0%) 04:57:43 INFO - PROCESS | 14843 | Values: 1978.3 04:57:43 INFO - PROCESS | 14843 | 04:57:43 INFO - PROCESS | 14843 | [#5] Earley Cycles:1 Average:777.60 Median:777.60 stddev:0.00 (0.0%) 04:57:43 INFO - PROCESS | 14843 | Values: 777.6 04:57:43 INFO - PROCESS | 14843 | 04:57:43 INFO - PROCESS | 14843 | [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 04:57:43 INFO - PROCESS | 14843 | Values: 12395.1 04:57:43 INFO - PROCESS | 14843 | 04:57:43 INFO - PROCESS | 14843 | [#7] RegExp Cycles:1 Average:26051.28 Median:26051.28 stddev:0.00 (0.0%) 04:57:43 INFO - PROCESS | 14843 | Values: 26051.3 04:57:43 INFO - PROCESS | 14843 | 04:57:43 INFO - PROCESS | 14843 | [#8] Splay Cycles:1 Average:620.73 Median:620.73 stddev:0.00 (0.0%) 04:57:43 INFO - PROCESS | 14843 | Values: 620.7 04:57:43 INFO - PROCESS | 14843 | 04:57:43 INFO - PROCESS | 14843 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 04:57:43 INFO - PROCESS | 14843 | Values: 4840.6 04:57:43 INFO - PROCESS | 14843 | -------- Summary: end -------- 04:57:43 INFO - PROCESS | 14843 | 04:57:44 INFO - TEST-INFO | 14843: exit 0 04:57:44 INFO - TEST-OK | v8_7 | took 40596ms 04:57:44 INFO - SUITE-END | took 1214s 04:57:44 INFO - Completed test suite (00:20:15) 04:57:44 INFO - Working with test: dromaeo_css 04:57:44 INFO - Generating results file: dromaeo_css 04:57:44 INFO - Working with test: kraken 04:57:44 INFO - Generating results file: kraken 04:57:44 INFO - javascript benchmark 04:57:44 INFO - Working with test: v8_7 04:57:44 INFO - Generating results file: v8_7 04:57:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:57:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 04:57:44 INFO - process_Request line: dromaeo_css 6949.68 graph.html#tests=[[72,201,35]] 04:57:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:57:44 INFO - process_Request line: kraken 1492.30 graph.html#tests=[[232,201,35]] 04:57:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:57:44 INFO - process_Request line: v8_7 19719.40 graph.html#tests=[[230,201,35]] 04:57:44 INFO - RETURN: dromaeo_css: 6949.68 04:57:44 INFO - RETURN: kraken: 1492.30 04:57:44 INFO - RETURN: v8_7: 19719.40 04:57:44 INFO - javascript benchmark 04:57:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3118.516629922362, 3156.85794139264, 3190.5373720810485, 3194.9041528754146, 3217.533457648641, 5116.053530096925, 5246.055709972204, 5315.0, 5320.89358212836, 5366.570674346048, 5159.742012899349, 5239.580833533318, 5250.159974404096, 5264.578833693305, 5292.0, 4533.977330113361, 4642.234031384817, 4743.90512189756, 4808.158572249842, 4846.466888642247, 4636.142313671981, 4751.786169622375, 4791.6406269529925, 4797.328374027639, 4920.040592084527, 4776.737279449629, 4859.0, 4872.1473742094995, 4885.218365061609, 4914.287428322909, 4843.128236917353, 4867.610591152699, 4871.756412179377, 4875.731834749087, 4909.288153217799, 4692.296155576657, 4801.303810947428, 4809.903801923977, 4843.612510999112, 4895.951040489621, 5040.571551418134, 5101.795928162906, 5106.4638212987475, 5108.208227724672, 5114.948850511484, 5620.971895140539, 5698.202251684767, 5699.373068962411, 5702.3157221133315, 5758.884822303572, 5734.885302293931, 5750.6262092963825, 5763.337216220147, 5767.221425107598, 5773.9422605773825, 5073.264376665363, 5167.405748338914, 5299.12564426873, 5348.197770334481, 5358.544523715489, 5844.561657875676, 5846.093855452412, 5854.2096816930025, 5856.795012174639, 5875.471207591338, 5566.805161819398, 5594.496495315441, 5596.880623875241, 5632.577556683265, 5660.490555849993, 5488.341399032141, 5583.441655834466, 5663.830085097454, 5671.489565939003, 5779.595428319977, 5657.15142728594, 5658.03813351723, 5658.801941932013, 5659.0, 5660.801871934463, 5643.661380317112, 5643.943560564424, 5644.971775141098, 5651.180578816049, 5652.971735141298, 4237.046664500463, 4308.246056940023, 4344.47866256045, 4378.715383500063, 4430.534793846664, 3933.1936952925153, 3933.252681990413, 3942.8817135485983, 3966.186931678999, 3966.4446977423186, 5215.947840521622, 5263.499967503081, 5264.341957255343, 5265.368155821326, 5267.552258058108, 5525.392206857243, 5628.831135065954, 5630.0, 5648.491635752802, 5802.6808525531505, 5254.816081437208, 5281.709505977131, 5282.313299271147, 5289.867753306121, 5327.387350454747, 4951.282064100686, 4961.280614310905, 4962.727050012284, 4964.776585053682, 5001.44984051754, 5654.858628534237, 5739.8852022960145, 5789.710514474259, 5793.073108302651, 5955.37468565803, 5708.115242137475, 5712.6286791358425, 5713.857153571194, 5729.770809167587, 5744.971275143597, 5930.644161350333, 5951.047832346804, 5953.493953014043, 5958.612690175125, 5958.910616340671, 5424.24060631504, 5540.418256083214, 5546.944530554642, 5622.044252477171, 5631.239782629293, 5579.860503487445, 5620.4660557247, 5625.0, 5627.746751396279, 5632.943670563406, 5474.507294343528, 5477.561795056466, 5478.45215478449, 5489.698066606375, 5516.889662206653, 5373.247745315737, 5413.404525502113, 5470.671759694431, 5509.834704958857, 5629.296337957755, 5402.945970540244, 5429.0, 5431.131019036935, 5433.103537916358, 5433.157860531624, 5273.525382715574, 5524.944750552443, 5530.91703624454, 5552.666839989452, 5565.248691426606, 5336.279602253646, 5416.377116631637, 5522.144067669517, 5563.610547261653, 5565.332160140809], "unit": "score", "name": "dojo.html", "value": 5216.414117631229}, {"lowerIsBetter": false, "replicates": [551.5959707792528, 589.3222793787146, 593.8545056461168, 599.101347978033, 599.6132494541023, 28067.0, 28335.85832070842, 28623.0, 28663.57004644932, 35608.10979725502, 39292.0, 39796.20407591847, 39810.60189398105, 39938.20123597526, 39955.20089598206, 8602.741917742462, 8757.562121893912, 8758.781030474225, 8766.736997890073, 8766.912330876674, 7672.808179795494, 7805.9609701951695, 8471.49171049736, 10262.486875656225, 10509.947450262776, 10243.487825608727, 10283.125934295595, 10346.37921724699, 10358.378497290149, 10362.067413932744, 7678.961605191938, 10160.288779785418, 10346.586136554528, 10369.170466362673, 10370.481475926248, 7502.8124296892465, 10393.220508461896, 10555.894441055569, 10597.73505662357, 10626.46867656614, 36533.269334613426, 36877.81561092204, 36977.0, 37050.25899482022, 37109.61910522986, 3311.784733992283, 3312.254742682901, 3325.700686938163, 3352.491378879514, 3637.031594415873, 26955.578765360635, 27049.594256086173, 27418.862905685342, 27814.443711125867, 29356.266093347836, 3985.621365970228, 4024.3963405489117, 4052.8581499647667, 4076.2458945094954, 4163.5836416358425, 262546.0, 262693.686531568, 262887.0, 263224.0, 263530.0, 59752.701236493536, 59802.70098649479, 59993.0, 60036.0, 60066.39933600696, 55305.1704224437, 56550.151747723816, 62355.6882215586, 63801.17192968344, 63985.0, 15594.84405155934, 15694.372225111096, 15747.44883929057, 15802.60493487649, 15895.52313430599, 10809.135269178447, 10823.13414926804, 10824.07995320391, 10833.891661083288, 10850.0, 19269.4219173425, 19397.127129279215, 19476.0, 19478.902605487165, 19499.220031198878, 7672.42456815741, 7833.295003449717, 7842.647080881374, 7870.921290787019, 8054.23484768946, 904.3895370624933, 989.2877128467636, 1023.9129673977646, 1093.704699731068, 1117.804384232756, 28731.85634071816, 28804.279893002422, 28952.565711514344, 29091.56362654562, 29183.0, 1074.2909679611419, 1113.9053180479589, 1150.528283403817, 1159.565163063851, 1205.9276443413423, 15187.696246075016, 15458.5362439127, 15748.92125539365, 15913.522594321958, 16152.838471615369, 316352.0, 321273.0, 321280.0, 321440.0, 321620.0, 52321.215181772306, 52508.47491525112, 52542.0, 52616.736916315174, 52635.473645263824, 1156.1386766858575, 1255.5982085732478, 1295.2617008305365, 1357.7352416278732, 1383.4258782605107, 26626.0, 27080.458390832468, 28542.0, 30009.249768755955, 30262.394752104396, 47619.76190119027, 47808.52191478041, 47911.76044119757, 48254.0, 48302.27546586874, 366251.0, 380682.0, 383843.69641187275, 396945.0, 397948.0, 30988.915387962214, 31282.68717312798, 31466.685333146375, 31469.05592832219, 31720.0, 43774.34338484989, 44194.558054419045, 44287.55712442834, 44338.55661443473, 45115.77442112769, 36675.0, 36836.0, 37995.43006854955, 38304.23391532098, 38547.614523854405, 37202.8139859299, 37413.0, 38302.61697382991, 38457.615423845404, 38601.42097868478, 35529.467057993636, 36570.085747856516, 36608.633913660524, 36647.63352366442, 36897.97061161554, 32145.0, 32366.83816580996, 33497.16257093592, 34300.656993429744, 34431.65568344285, 23260.534789304456, 23429.179978700664, 23736.762632373455, 23742.287731368087, 23831.880840595684], "unit": "score", "name": "ext.html", "value": 18742.469147206484}, {"lowerIsBetter": false, "replicates": [350.3640891781416, 354.4152148954226, 354.588677134524, 355.38518363231617, 355.62303957804744, 13648.11287266327, 13998.0, 15985.280662370193, 15987.840121598794, 16772.496825095237, 15798.131102789343, 16065.919670401661, 16931.469519078237, 17057.232424540893, 17089.060101694402, 5304.681719096847, 5424.294841670578, 5424.701641409721, 5425.159100339434, 5427.674339539621, 3952.644262016418, 4045.6156665116914, 5384.40771515133, 5789.536837053026, 5973.641581505102, 5893.793717219898, 5914.970425147868, 5918.88162236755, 5929.258842644669, 5931.08068249422, 5685.488306052454, 5825.79609713658, 5828.3297420796725, 5830.708464576775, 5841.123831425278, 5084.720340381277, 5090.516400941905, 5090.516400941941, 5116.104681680691, 5121.0, 12350.135490515668, 12368.319742414164, 16743.827932044762, 18349.7247541287, 18823.71764423535, 2107.6100921329603, 2211.402921211264, 2216.9889150554304, 2223.377454312779, 2472.6538284640164, 9235.215006724437, 9348.813023739487, 9373.43759374433, 9387.953060234724, 9475.668351607661, 1703.9148042597944, 1778.9377371792054, 1792.4353828544097, 1811.6195598924241, 1829.7346884701644, 56619.43380566224, 57410.712946435, 57504.137437938465, 58513.41486585122, 60287.39712602906, 9462.716118516455, 9874.308798384043, 10053.693019907512, 10355.585776569003, 10437.373757574418, 13570.525031623845, 13587.728245435035, 13603.659908502168, 13663.863361366259, 13707.314634268247, 7523.774286771406, 7709.884351734729, 7723.729669461654, 7730.226977302337, 7741.806454838562, 7470.626468676544, 7513.549187048795, 7761.650725717243, 7812.6093695315, 7814.179511151361, 4316.352547117957, 4417.469903611523, 4418.690691651554, 4444.888877778017, 4461.196984542748, 1667.96664066718, 1742.3379115935863, 1751.2644689230553, 1822.9361972330905, 1841.5027942455463, 921.8571121476182, 951.7382719752123, 1020.1430798129607, 1043.3948309980194, 1044.4307852220559, 14312.499062532761, 15228.0, 16392.180390980404, 17843.10784460772, 18575.0, 921.2537844345967, 939.2298315381322, 960.2462067277294, 1014.1937159957852, 1033.7312298802365, 8765.956170219108, 8847.601857916408, 8911.108889111167, 8928.464292142493, 9186.356955013085, 481229.0, 489976.0, 494359.0, 505337.0, 536135.0, 74578.0, 83506.0, 84521.0, 85324.57337713272, 86153.5692321547, 1146.621614867092, 1155.8381826544291, 1158.5423757615695, 1162.668639437773, 1167.0138732770795, 15317.463888764285, 15596.922015390304, 15788.526344209693, 16157.919210403872, 16210.432634857723, 32551.0, 32738.1815454606, 33149.834250829554, 33785.49321760225, 34155.14612134716, 36697.81651091834, 37749.245015100096, 38121.428178577895, 38274.23451530898, 45714.77142614266, 9316.114969077928, 9596.568154432927, 9757.51212439361, 9761.707148785548, 9772.657956971472, 11471.311721296748, 12426.440810163384, 13007.284599347127, 16221.351145954502, 17944.91027544854, 14251.786223206453, 14319.928400357932, 14432.85567144315, 14630.0, 14948.551543453714, 14036.2981850905, 14423.92788036053, 14439.494617688331, 14521.92739036298, 14951.327190276246, 14927.0, 14982.475613353481, 14989.700205996038, 15415.0, 15435.22823858825, 8988.10118988096, 9448.385854919408, 9454.14912657864, 9707.951460242935, 9741.0, 12144.635660930186, 12742.936285318514, 13804.654883627989, 13983.161010339412, 14545.636359091108], "unit": "score", "name": "jquery.html", "value": 8722.102735528266}, {"lowerIsBetter": false, "replicates": [1286.440398426685, 1401.8948578856584, 1434.7991281220632, 1583.5803512069303, 1791.3282519055347, 6705.79882603522, 7439.51643143196, 7579.507332023421, 7598.202188770182, 7625.6949722011195, 7383.33549980503, 7560.39516838653, 7574.772756817304, 7576.734814281501, 7577.318041376275, 2218.8446808723356, 2258.0290475095703, 2259.186692790594, 2259.288324177887, 2261.1520679745095, 2208.61349263879, 2214.9557008859815, 2315.513742114158, 2316.4787922717337, 2318.026428899866, 2235.273536100766, 2253.6506841439605, 2261.1068627891973, 2278.54429114177, 2280.5096904165603, 2219.8557093788854, 2221.677856710784, 2237.5301186750803, 2238.440389902524, 2238.462768935444, 2272.3183045086575, 2289.942751431211, 2293.483966107629, 2295.758945310735, 2295.7933785959176, 7570.507916985433, 7630.8855367169535, 7634.580098094602, 7643.044619422572, 7646.96765936597, 4492.797824097924, 4523.140603285398, 4528.411306530163, 4557.156925968673, 4557.316402539613, 2985.9850700746356, 3015.2914065194664, 3068.98465507671, 3083.3062560923836, 3087.799293045945, 1050.6007717067541, 1056.9471526423724, 1871.6069625378686, 1885.820847019531, 1924.393815947986, 10021.799564008752, 10035.197184225244, 10075.596976120947, 10089.949550252275, 10090.747731306703, 3969.801509924492, 3994.241094192152, 4019.7588144711412, 4026.697997650188, 4132.91734165315, 8353.0, 8370.665173393118, 8382.455140415854, 8384.664613415394, 8390.454620449651, 4630.976845115752, 4648.070385922829, 4686.1799185143145, 4687.671862969628, 4688.671792974527, 3666.505021822073, 3685.70514358856, 4127.814248358831, 4292.527821939584, 4314.395984562164, 3514.3498452786316, 3525.7355698322726, 3548.449990251515, 3566.6433356664124, 3608.891733247954, 1083.951222195003, 1098.3958822647512, 1100.834874768791, 1101.5924108080062, 1112.1603189591806, 852.1010334097587, 938.5448057692014, 1027.9617586237805, 1041.906228439444, 1103.4593049405732, 7052.92947070533, 7082.716691332289, 7108.3957863581145, 7109.28907109285, 7114.00403943438, 766.8420684766044, 1180.392098069495, 1201.8077107662732, 1221.3055507091121, 1225.7180848404917, 5383.596230282745, 5437.966786310589, 5444.945550544523, 5449.291592093082, 5463.535599474009, 8865.778355541033, 8923.330750193762, 9081.59132839024, 9145.725628231165, 9196.632134714537, 8993.100689931085, 9146.085391460801, 9163.129502697233, 9164.816703665889, 9207.309451791143, 7079.469039822034, 7225.566466011951, 7334.4499162563025, 7340.11918569775, 7418.072740907387, 7114.253003434565, 7121.643917804193, 7157.64211789398, 7179.784606461814, 7182.317679820409, 7606.315431611181, 7943.0071241094865, 8040.437169398086, 8057.83884322322, 8058.959705201671, 8109.553974531457, 8291.08798032204, 8297.087320394872, 8306.62620182081, 8311.127331630092, 6876.415504681958, 6992.056072430157, 7049.365557099885, 7086.822829429099, 7127.465440092117, 7176.21061683204, 7212.386947109554, 7223.783286501413, 7234.457415693739, 7287.089113860768, 5940.61386009908, 6702.095217145623, 6798.320167983162, 6843.7604683835825, 6968.756093536702, 6323.747050118128, 6569.868602628017, 6606.471482281502, 6663.36698013688, 6791.083203767428, 6521.184851893513, 6649.0, 6670.299618540177, 6689.364510371507, 6766.763163289262, 5954.880902382015, 6004.279486461478, 6010.849728756816, 6015.939840601713, 6042.154098426312, 6089.360617135137, 6127.3259941407305, 6158.599691020069, 6170.7223174958135, 6172.22847144107], "unit": "score", "name": "mootools.html", "value": 4389.228492622454}, {"lowerIsBetter": false, "replicates": [332.5975569560831, 335.92441700617366, 340.63381864495676, 341.56109399421746, 344.9292894956533, 6007.609505382153, 6044.274687037556, 6092.482139018189, 6092.817215483531, 6096.817095487137, 5689.573282003846, 5827.184194212814, 5872.500837428824, 5988.311344195408, 6044.758209671619, 4644.9535504644855, 4659.720416774988, 4679.672422930396, 4688.249880019189, 4707.929381059287, 4455.487618923817, 4685.953140468603, 4692.108499385123, 4692.859214223578, 4699.788509517063, 4474.463064432256, 4505.098980203956, 4565.155446242439, 4584.220682483969, 4613.284940834176, 4579.496255411902, 4579.519150489184, 4589.334546490773, 4635.049814787961, 4644.9767751161025, 4090.1819636072605, 4095.9180816383805, 4097.631213190797, 4103.117829666606, 4106.445629839964, 5605.439456054362, 5636.239107720447, 5652.378238393773, 5654.321481422215, 5659.773609055633, 5371.113766228567, 5406.351237851483, 5409.891802163935, 5419.512243898029, 5422.322209723785, 6422.357764223587, 6435.131257280254, 6438.098666186737, 6441.323661015573, 6470.450011749007, 4440.600345968878, 4444.799984000728, 4445.399871017404, 4451.955480445219, 4454.9777251113865, 6603.108580341688, 6650.401463868275, 6664.866702665968, 6687.364700353459, 6695.962125870498, 4524.117797029548, 4530.799338175386, 4530.818767249339, 4534.433195850519, 4537.047220083753, 4578.473475550288, 4583.922778147133, 4588.059447813191, 4590.219662657356, 4592.0, 5322.547583455373, 5330.493603107699, 5331.253624492574, 5332.040232758063, 5334.333208348957, 6309.08518264849, 6462.903056454157, 6464.321246269168, 6470.676466176672, 6479.416852483299, 1601.3994751968012, 1617.9757303640454, 1618.9838101619068, 1619.9190040497929, 1620.8379162083934, 1070.5878236878857, 1075.913926885863, 1077.2997551591527, 1092.1972350322508, 1101.6970333158445, 6030.698465076729, 6055.757769689163, 6058.57589968698, 6069.3627169147485, 6075.1798507200965, 6478.643674597943, 6663.13379260693, 6664.966675166593, 6667.433268172163, 6667.56660817055, 5940.970295148497, 6015.879682406415, 6082.513398928075, 6101.359357267512, 6120.387961203844, 3557.6264492227942, 3630.6550877666577, 3634.400323946572, 3634.7092232621326, 3635.4910312556262, 6847.383735463832, 7015.684294206773, 7019.262977387403, 7021.1574611047, 7021.473389495808, 6864.0047193156715, 6877.346652068046, 6877.58734475933, 6882.4149947254045, 6882.449404047664, 7009.474289428314, 7020.122484689414, 7033.824154396181, 7034.050403195605, 7036.964815175891, 6589.915840471416, 6669.833254168685, 6708.597484150967, 6714.194296684429, 6714.899276510954, 6625.602463852184, 6629.46964242869, 6634.668266586555, 6636.27001029896, 6640.867182656417, 6976.127984002, 7012.053372794811, 7013.0, 7018.6490675465, 7019.613921234381, 4467.776611169494, 4524.751138687404, 4546.568076032771, 4550.681452298308, 4551.044280700958, 6740.0, 6795.218549866829, 6796.116504854337, 6798.898016529855, 6802.965985170043, 6521.315261897433, 6524.347565243438, 6534.346565343428, 6539.247986481425, 6539.836504087436, 6406.231252249573, 6504.6747662615735, 6510.7721229756735, 6510.967445162744, 6511.47908167336, 6370.331115232834, 6370.4903607712195, 6370.649614271259, 6374.808755737336, 6376.9043464349, 6511.706973186123, 6547.574407663486, 6549.70526326326, 6550.868982620225, 6558.770443034471, 6243.188385509855, 6361.363863613602, 6372.55392122547, 6379.138816259746, 6400.647964361819], "unit": "score", "name": "prototype.html", "value": 4859.914649054958}, {"lowerIsBetter": false, "replicates": [696.390658174098, 729.3654520567108, 759.0966749568014, 819.5287709566999, 825.5211977053308, 12869.099163058578, 13119.14725542839, 13127.737445251089, 13138.0, 13160.605181844548, 14433.711325773478, 14533.563993080224, 14570.708585828277, 14578.854211457883, 14581.489647862327, 674.5413119079025, 679.2358596578849, 833.9499630022187, 842.0400743152811, 844.2823599940064, 817.8486979908706, 823.736404350608, 827.3587969323762, 829.1294141151797, 829.5147338806805, 868.5396739727954, 868.6655637579514, 868.8262347530488, 870.7779516223354, 873.1879352202449, 694.4860803005764, 701.0115736811098, 849.6346570974479, 859.0850743957665, 869.7303835810887, 643.012975083245, 643.112504743451, 643.1414062226933, 643.584887747405, 643.5945354426728, 13023.739525209443, 13062.477500899953, 13087.149335293176, 13092.0, 13093.279869607168, 11327.263727857662, 11674.941625291904, 11707.356095414749, 11853.214494593763, 11971.64085077449, 9727.708168754949, 10058.698239052841, 10188.94905525475, 10205.285630005903, 10303.845442318296, 3649.5802982656805, 3659.249853779969, 3675.4303083022173, 3769.6607305342377, 3780.8298626561595, 42358.57641423577, 43216.78391608053, 43230.35154472685, 44768.77615611901, 45115.54884451146, 9999.50002499872, 10210.4384258865, 10393.9480302598, 10433.9478302608, 10651.627193048205, 18651.253949842125, 18697.439076827715, 18703.064846757607, 18728.812711872706, 18764.0617969101, 7750.728724494616, 7834.451588388872, 7898.249666281694, 8004.239597238253, 8119.4722343047515, 4166.791660416967, 4260.510041345223, 4310.849120280775, 4351.97824010878, 4357.346398040256, 2926.414717056597, 2957.2902503399027, 2962.066948911086, 2963.7184467475554, 2966.154645925944, 547.1382572448409, 547.3459216236639, 558.2184941082517, 561.1974875927382, 573.2662192393743, 531.9840404787863, 608.622653954551, 609.9052201298591, 675.7702381190419, 695.5166159519085, 8579.742607721779, 8600.69684332957, 8644.178803013703, 8796.604152813139, 8875.778105547284, 572.5076434266527, 658.1838520234875, 663.91037209977, 680.5882441123148, 696.3697853442643, 3929.9214015719526, 4157.875263742093, 4203.159368126387, 4240.321548552217, 4244.724092934011, 53874.46125538773, 54066.0, 54195.72902135543, 54256.45743542593, 57547.71226143843, 47352.763236184284, 48413.5158648416, 48418.27372589414, 48942.75528622334, 49404.011919761404, 43062.354064689054, 43257.13485730268, 44036.0, 44133.0, 44860.0, 8245.464044837066, 8523.91476085256, 8532.658693652433, 8600.913990860261, 8636.611352489279, 33010.66989330076, 33213.16967075843, 33816.32367352688, 33992.490112648826, 34251.82874085614, 39295.2140957185, 39418.60581394264, 41468.0, 43713.78143109264, 43869.78065109654, 10343.482825858526, 10575.312604680672, 10595.417252050904, 10623.309484883457, 10991.725206869893, 11416.94291528537, 11529.596464123715, 11562.30626162433, 11733.296002239893, 11762.647120586396, 10676.57293708243, 10957.452127393439, 11047.889521104686, 11172.888271117185, 11283.266587671775, 10935.234533582572, 11042.392668403316, 11130.387828669502, 11175.55297788112, 11399.14506412039, 10027.247956403153, 10830.566777329133, 10888.564457421615, 10895.455227238765, 10944.507497162806, 9253.167214950687, 9300.162985331353, 9356.532173391168, 9406.0, 9716.174125199155, 8566.314694824274, 8945.46327220369, 8964.641414343614, 9115.361924665474, 9878.950605246928], "unit": "score", "name": "yui.html", "value": 6193.17694405121}], "name": "dromaeo_css", "value": 6949.683283876175}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 106.0, 110.0, 111.0, 111.0, 101.0, 111.0, 109.0, 101.0], "unit": "score", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [146.0, 122.0, 150.0, 167.0, 122.0, 151.0, 150.0, 124.0, 164.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 141.9}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 159.0, 159.0, 164.0, 159.0, 159.0, 160.0, 158.0, 159.0], "unit": "score", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 83.0, 91.0, 71.0, 72.0, 74.0, 98.0, 91.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 141.0, 96.0, 96.0, 95.0, 138.0, 95.0, 96.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 108.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [144.0, 145.0, 146.0, 145.0, 145.0, 146.0, 147.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 57.0, 57.0, 56.0, 57.0, 56.0, 57.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 86.0, 85.0, 85.0, 85.0, 86.0, 84.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [128.0, 112.0, 120.0, 118.0, 115.0, 123.0, 120.0, 114.0, 116.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.4}, {"lowerIsBetter": true, "replicates": [140.0, 151.0, 149.0, 153.0, 160.0, 140.0, 149.0, 158.0, 149.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 68.0, 66.0, 67.0, 66.0, 68.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1492.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.61112962345885], "unit": "score", "name": "Richards", "value": 211.88260400000004}, {"lowerIsBetter": false, "replicates": [191.49751053236307], "unit": "score", "name": "DeltaBlue", "value": 345.26819599999993}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1978.2608695652175], "unit": "score", "name": "RayTrace", "value": 374.06037362637363}, {"lowerIsBetter": false, "replicates": [777.6049766718507], "unit": "score", "name": "Earley", "value": 857.0714179999998}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [26051.28205128205], "unit": "score", "name": "RegExp", "value": 34.96891240157479}, {"lowerIsBetter": false, "replicates": [620.7324643078833], "unit": "score", "name": "Splay", "value": 131.28200099999995}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19719.395760489544}]} 04:57:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19719.40"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1492.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6949.68"}}} 04:57:44 INFO - Return code: 0 04:57:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:57:44 INFO - # TBPL SUCCESS # 04:57:44 INFO - Running post-action listener: _resource_record_post_action 04:57:44 INFO - Running post-run listener: _resource_record_post_run 04:57:45 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 28672; Write bytes: 551686144; Read time: 1360; Write time: 1333204 04:57:45 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 235376640; Read time: 464; Write time: 574068 04:57:45 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 24576; Write bytes: 316309504; Read time: 896; Write time: 759136 04:57:45 INFO - Running post-run listener: _upload_blobber_files 04:57:45 INFO - Blob upload gear active. 04:57:45 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:57:45 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:57:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 04:57:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 04:57:46 INFO - (blobuploader) - INFO - Open directory for files ... 04:57:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 04:57:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:57:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:47 INFO - (blobuploader) - INFO - Done attempting. 04:57:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:57:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:57:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:47 INFO - (blobuploader) - INFO - Done attempting. 04:57:47 INFO - (blobuploader) - INFO - Iteration through files over. 04:57:47 INFO - Return code: 0 04:57:47 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:57:47 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:57:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/84c8ef79d32716fae7e8455885799cbbbb38df54840493a1c43ac30f436386c6e3e9a3bf45ccc472f10310f1be0a39090e4dfdc1196d20beefa278381a6c5619", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/2452aa652ed9ff19e7e6ccd32f4a4a8ca4f6f7287efb1fefc0d907bb84c376c39e803631239b48761699daacb37b22e46c2866e1cb06641d4f2c6920b3b23401"} 04:57:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:57:47 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:57:47 INFO - Contents: 04:57:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/84c8ef79d32716fae7e8455885799cbbbb38df54840493a1c43ac30f436386c6e3e9a3bf45ccc472f10310f1be0a39090e4dfdc1196d20beefa278381a6c5619", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/2452aa652ed9ff19e7e6ccd32f4a4a8ca4f6f7287efb1fefc0d907bb84c376c39e803631239b48761699daacb37b22e46c2866e1cb06641d4f2c6920b3b23401"} 04:57:47 INFO - Copying logs to upload dir... 04:57:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.564390 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-28 04:57:47.667040) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-28 04:57:47.670850) ========= 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=ccb4611811c763f2fad71465000001de-1451300952.898369-692960851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/84c8ef79d32716fae7e8455885799cbbbb38df54840493a1c43ac30f436386c6e3e9a3bf45ccc472f10310f1be0a39090e4dfdc1196d20beefa278381a6c5619", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/2452aa652ed9ff19e7e6ccd32f4a4a8ca4f6f7287efb1fefc0d907bb84c376c39e803631239b48761699daacb37b22e46c2866e1cb06641d4f2c6920b3b23401"} build_url:https://queue.taskcluster.net/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/LtQFtAEXTfqyht2PpeQY9w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/84c8ef79d32716fae7e8455885799cbbbb38df54840493a1c43ac30f436386c6e3e9a3bf45ccc472f10310f1be0a39090e4dfdc1196d20beefa278381a6c5619", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/2452aa652ed9ff19e7e6ccd32f4a4a8ca4f6f7287efb1fefc0d907bb84c376c39e803631239b48761699daacb37b22e46c2866e1cb06641d4f2c6920b3b23401"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-28 04:57:47.696019) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 04:57:47.696385) ========= 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=ccb4611811c763f2fad71465000001de-1451300952.898369-692960851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 04:57:47.778520) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 04:57:47.778883) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 04:57:47.779233) ========= ========= Total master_lag: 0.24 =========