builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1451912069.11 results: success (0) buildid: 20160104023005 builduid: 7851b21433634eeab9d5c8318429dcfc revision: f56d3f847e3cb407d99a7623e9f1c36ee39085a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:29.106409) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:29.106992) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:29.107507) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006305 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:29.151949) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:29.152395) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:29.184326) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:29.184905) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004651 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:29.236254) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:29.236573) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:29.236941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:29.237221) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 04:54: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% 228M=0s 2016-01-04 04:54:29 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173578 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:29.424855) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:29.425144) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017840 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:29.479389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:29.479692) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev f56d3f847e3cb407d99a7623e9f1c36ee39085a4 --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 f56d3f847e3cb407d99a7623e9f1c36ee39085a4 --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=a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 04:54:29,731 truncating revision to first 12 chars 2016-01-04 04:54:29,731 Setting DEBUG logging. 2016-01-04 04:54:29,731 attempt 1/10 2016-01-04 04:54:29,731 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/f56d3f847e3c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 04:54:29,983 unpacking tar archive at: b2g-inbound-f56d3f847e3c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532338 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:30.027772) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:30.028117) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:30.038005) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:30.038290) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 04:54:30.038728) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-04 04:54:30.039013) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --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', '--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=a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:54:30 INFO - MultiFileLogger online at 20160104 04:54:30 in /builds/slave/test-pgo 04:54:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 04:54:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:54:30 INFO - {'append_to_log': False, 04:54:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:54:30 INFO - 'blob_upload_branch': 'B2G-Inbound', 04:54:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:54:30 INFO - 'branch': 'B2G-Inbound', 04:54:30 INFO - 'buildbot_json_path': 'buildprops.json', 04:54:30 INFO - 'config_files': ('talos/linux_config.py',), 04:54:30 INFO - 'default_actions': ('clobber', 04:54:30 INFO - 'read-buildbot-config', 04:54:30 INFO - 'download-and-extract', 04:54:30 INFO - 'populate-webroot', 04:54:30 INFO - 'create-virtualenv', 04:54:30 INFO - 'install', 04:54:30 INFO - 'run-tests'), 04:54:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:54:30 INFO - 'download_minidump_stackwalk': True, 04:54:30 INFO - 'download_symbols': 'ondemand', 04:54:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:54:30 INFO - 'tooltool.py': '/tools/tooltool.py', 04:54:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:54:30 INFO - '/tools/misc-python/virtualenv.py')}, 04:54:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:54:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:54:30 INFO - 'installer_path': 'installer.exe', 04:54:30 INFO - 'log_level': 'info', 04:54:30 INFO - 'log_name': 'talos', 04:54:30 INFO - 'log_to_console': True, 04:54:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:54:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:54:30 INFO - 'opt_config_files': (), 04:54:30 INFO - 'pip_index': False, 04:54:30 INFO - 'sps_profile': False, 04:54:30 INFO - 'sps_profile_interval': 0, 04:54:30 INFO - 'suite': 'dromaeojs', 04:54:30 INFO - 'system_bits': '32', 04:54:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:54:30 INFO - 'title': 'talos-linux64-ix-064', 04:54:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:54:30 INFO - 'use_talos_json': True, 04:54:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:54:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:54:30 INFO - 'work_dir': 'build'} 04:54:30 INFO - ##### 04:54:30 INFO - ##### Running clobber step. 04:54:30 INFO - ##### 04:54:30 INFO - Running pre-action listener: _resource_record_pre_action 04:54:30 INFO - Running main action method: clobber 04:54:30 INFO - rmtree: /builds/slave/test-pgo/build 04:54:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:54:30 INFO - Running post-action listener: _resource_record_post_action 04:54:30 INFO - ##### 04:54:30 INFO - ##### Running read-buildbot-config step. 04:54:30 INFO - ##### 04:54:30 INFO - Running pre-action listener: _resource_record_pre_action 04:54:30 INFO - Running main action method: read_buildbot_config 04:54:30 INFO - Using buildbot properties: 04:54:30 INFO - { 04:54:30 INFO - "project": "", 04:54:30 INFO - "product": "firefox", 04:54:30 INFO - "script_repo_revision": "production", 04:54:30 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 04:54:30 INFO - "repository": "", 04:54:30 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 04:54:30 INFO - "buildid": "20160104023005", 04:54:30 INFO - "pgo_build": "True", 04:54:30 INFO - "basedir": "/builds/slave/test-pgo", 04:54:30 INFO - "buildnumber": 178, 04:54:30 INFO - "slavename": "talos-linux64-ix-064", 04:54:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:54:30 INFO - "platform": "ubuntu64_hw", 04:54:30 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 04:54:30 INFO - "branch": "b2g-inbound", 04:54:30 INFO - "repo_path": "integration/b2g-inbound", 04:54:30 INFO - "revision": "f56d3f847e3cb407d99a7623e9f1c36ee39085a4", 04:54:30 INFO - "stage_platform": "linux64-pgo", 04:54:30 INFO - "builduid": "7851b21433634eeab9d5c8318429dcfc", 04:54:30 INFO - "slavebuilddir": "test" 04:54:30 INFO - } 04:54:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:54:30 INFO - Running post-action listener: _resource_record_post_action 04:54:30 INFO - ##### 04:54:30 INFO - ##### Running download-and-extract step. 04:54:30 INFO - ##### 04:54:30 INFO - Running pre-action listener: _resource_record_pre_action 04:54:30 INFO - Running main action method: download_and_extract 04:54:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:54:30 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:54:30 INFO - https://queue.taskcluster.net/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:54:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/test_packages.json 04:54:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/test_packages.json 04:54:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:54:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:54:31 INFO - Downloaded 1302 bytes. 04:54:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:54:31 INFO - Using the following test package requirements: 04:54:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:54:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:54:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:31 INFO - u'jsshell-linux-x86_64.zip'], 04:54:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:54:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:54:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:54:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:54:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:54:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:54:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:54:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:54: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:54:31 INFO - https://queue.taskcluster.net/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:54:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:54:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:54:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/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:54:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/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:54:33 INFO - Downloaded 23197957 bytes. 04:54:33 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:54:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:54:33 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:54:34 INFO - Return code: 0 04:54:34 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:54: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:54:34 INFO - https://queue.taskcluster.net/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:54:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:54:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:54:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/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:54:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/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:54:36 INFO - Downloaded 23197957 bytes. 04:54:36 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:54:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:54:36 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:54:37 INFO - Return code: 0 04:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:37 INFO - https://queue.taskcluster.net/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:54:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/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:54:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/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:54:40 INFO - Downloaded 11132285 bytes. 04:54:40 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:54:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:40 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:54:40 INFO - Return code: 0 04:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:40 INFO - https://queue.taskcluster.net/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:54:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:54:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:54:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/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:54:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/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:54:42 INFO - Downloaded 54985647 bytes. 04:54:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:54:42 INFO - mkdir: /builds/slave/test-pgo/properties 04:54:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:54:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:54:42 INFO - Contents: 04:54:42 INFO - build_url:https://queue.taskcluster.net/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:54:42 INFO - Running post-action listener: _resource_record_post_action 04:54:42 INFO - Running post-action listener: set_extra_try_arguments 04:54:42 INFO - ##### 04:54:42 INFO - ##### Running populate-webroot step. 04:54:42 INFO - ##### 04:54:42 INFO - Running pre-action listener: _resource_record_pre_action 04:54:42 INFO - Running main action method: populate_webroot 04:54:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:54:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:54:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:54:42 INFO - '--tppagecycles', 04:54:42 INFO - '7'], 04:54:42 INFO - 'tests': ['tsvgm']}}, 04:54:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:54:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:54:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:54:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:54:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:54:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:54:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:42 INFO - 'talos_options': ['--e10s'], 04:54:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:42 INFO - 'tests': ['damp', 'tps']}, 04:54:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:42 INFO - 'talos_options': ['--e10s'], 04:54:42 INFO - 'tests': ['damp', 'tps']}, 04:54:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:54:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:54:42 INFO - 'other': {'tests': ['a11yr', 04:54:42 INFO - 'ts_paint', 04:54:42 INFO - 'tpaint', 04:54:42 INFO - 'sessionrestore', 04:54:42 INFO - 'sessionrestore_no_auto_restore']}, 04:54:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:54:42 INFO - 'tests': ['a11yr', 04:54:42 INFO - 'ts_paint', 04:54:42 INFO - 'tpaint', 04:54:42 INFO - 'sessionrestore', 04:54:42 INFO - 'sessionrestore_no_auto_restore']}, 04:54:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:54:42 INFO - 'tests': ['a11yr', 04:54:42 INFO - 'ts_paint', 04:54:42 INFO - 'tpaint', 04:54:42 INFO - 'sessionrestore', 04:54:42 INFO - 'sessionrestore_no_auto_restore']}, 04:54:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:54:42 INFO - 'tests': ['a11yr', 04:54:42 INFO - 'ts_paint', 04:54:42 INFO - 'tpaint', 04:54:42 INFO - 'sessionrestore', 04:54:42 INFO - 'sessionrestore_no_auto_restore']}, 04:54:42 INFO - 'other_l64': {'tests': ['a11yr', 04:54:42 INFO - 'ts_paint', 04:54:42 INFO - 'tpaint', 04:54:42 INFO - 'sessionrestore', 04:54:42 INFO - 'sessionrestore_no_auto_restore']}, 04:54:42 INFO - 'other_nol64': {'tests': ['a11yr', 04:54:42 INFO - 'ts_paint', 04:54:42 INFO - 'tpaint', 04:54:42 INFO - 'sessionrestore', 04:54:42 INFO - 'sessionrestore_no_auto_restore']}, 04:54:42 INFO - 'svgr': {'tests': ['tsvgx', 04:54:42 INFO - 'tsvgr_opacity', 04:54:42 INFO - 'tart', 04:54:42 INFO - 'tscrollx', 04:54:42 INFO - 'cart']}, 04:54:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:54:42 INFO - 'tests': ['tsvgx', 04:54:42 INFO - 'tsvgr_opacity', 04:54:42 INFO - 'tart', 04:54:42 INFO - 'tscrollx', 04:54:42 INFO - 'cart']}, 04:54:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:42 INFO - 'tests': ['tp5o']}, 04:54:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:42 INFO - 'talos_options': ['--e10s'], 04:54:42 INFO - 'tests': ['tp5o']}, 04:54:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:42 INFO - 'talos_options': ['--xperf_path', 04:54:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:42 INFO - 'tests': ['tp5n']}, 04:54:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:42 INFO - 'talos_options': ['--e10s', 04:54:42 INFO - '--xperf_path', 04:54:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:42 INFO - 'tests': ['tp5n']}}, 04:54:42 INFO - 'talos.zip': {'path': '', 04:54:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:54:42 INFO - Running post-action listener: _resource_record_post_action 04:54:42 INFO - ##### 04:54:42 INFO - ##### Running create-virtualenv step. 04:54:42 INFO - ##### 04:54:42 INFO - Running pre-action listener: _resource_record_pre_action 04:54:42 INFO - Running main action method: create_virtualenv 04:54:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:54:42 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:54:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:54:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:54:43 INFO - Using real prefix '/usr' 04:54:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:54:43 INFO - Installing distribute.............................................................................................................................................................................................done. 04:54:45 INFO - Installing pip.................done. 04:54:45 INFO - Return code: 0 04:54:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:45 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 0x7faf7830df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cef840>, '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 0x2c5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5cb60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067', '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:54:45 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:54:45 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:54:45 INFO - Using env: {'DISPLAY': ':0', 04:54:45 INFO - 'HOME': '/home/cltbld', 04:54:45 INFO - 'LANG': 'en_US.UTF-8', 04:54:45 INFO - 'LANGUAGE': 'en_US:en', 04:54:45 INFO - 'LOGNAME': 'cltbld', 04:54:45 INFO - 'MAIL': '/var/mail/cltbld', 04:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:45 INFO - 'MOZ_NO_REMOTE': '1', 04:54:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:45 INFO - 'NO_EM_RESTART': '1', 04:54:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:45 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:45 INFO - 'SHELL': '/bin/bash', 04:54:45 INFO - 'SHLVL': '1', 04:54:45 INFO - 'TERM': 'linux', 04:54:45 INFO - 'TMOUT': '86400', 04:54:45 INFO - 'USER': 'cltbld', 04:54:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067', 04:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:45 INFO - '_': '/tools/buildbot/bin/python'} 04:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:46 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:54:46 INFO - Cleaning up... 04:54:46 INFO - Return code: 0 04:54:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:54: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:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:46 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 0x7faf7830df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cef840>, '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 0x2c5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5cb60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067', '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:54:46 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:54:46 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:54:46 INFO - Using env: {'DISPLAY': ':0', 04:54:46 INFO - 'HOME': '/home/cltbld', 04:54:46 INFO - 'LANG': 'en_US.UTF-8', 04:54:46 INFO - 'LANGUAGE': 'en_US:en', 04:54:46 INFO - 'LOGNAME': 'cltbld', 04:54:46 INFO - 'MAIL': '/var/mail/cltbld', 04:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:46 INFO - 'MOZ_NO_REMOTE': '1', 04:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:46 INFO - 'NO_EM_RESTART': '1', 04:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:46 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:46 INFO - 'SHELL': '/bin/bash', 04:54:46 INFO - 'SHLVL': '1', 04:54:46 INFO - 'TERM': 'linux', 04:54:46 INFO - 'TMOUT': '86400', 04:54:46 INFO - 'USER': 'cltbld', 04:54:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067', 04:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:46 INFO - '_': '/tools/buildbot/bin/python'} 04:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:46 INFO - Downloading/unpacking psutil>=0.7.1 04:54:46 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:54:46 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:54:46 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:54:46 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:54:46 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:54:46 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:54:48 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:54:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:54:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:54:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:48 INFO - Installing collected packages: psutil 04:54:48 INFO - Running setup.py install for psutil 04:54:48 INFO - building 'psutil._psutil_linux' extension 04:54:48 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:54:48 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:54:48 INFO - building 'psutil._psutil_posix' extension 04:54:48 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:54:48 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:54:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:48 INFO - Successfully installed psutil 04:54:48 INFO - Cleaning up... 04:54:48 INFO - Return code: 0 04:54:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:48 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 0x7faf7830df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cef840>, '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 0x2c5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5cb60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067', '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:54:48 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:54:48 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:54:48 INFO - Using env: {'DISPLAY': ':0', 04:54:48 INFO - 'HOME': '/home/cltbld', 04:54:48 INFO - 'LANG': 'en_US.UTF-8', 04:54:48 INFO - 'LANGUAGE': 'en_US:en', 04:54:48 INFO - 'LOGNAME': 'cltbld', 04:54:48 INFO - 'MAIL': '/var/mail/cltbld', 04:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:48 INFO - 'MOZ_NO_REMOTE': '1', 04:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:48 INFO - 'NO_EM_RESTART': '1', 04:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:48 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:48 INFO - 'SHELL': '/bin/bash', 04:54:48 INFO - 'SHLVL': '1', 04:54:48 INFO - 'TERM': 'linux', 04:54:48 INFO - 'TMOUT': '86400', 04:54:48 INFO - 'USER': 'cltbld', 04:54:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067', 04:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:48 INFO - '_': '/tools/buildbot/bin/python'} 04:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:54:48 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:54:48 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:54:48 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:54:48 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:54:48 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:54:48 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:54:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:54:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:54:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:54:50 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:54:50 INFO - Installing collected packages: mozsystemmonitor 04:54:50 INFO - Running setup.py install for mozsystemmonitor 04:54:51 INFO - Successfully installed mozsystemmonitor 04:54:51 INFO - Cleaning up... 04:54:51 INFO - Return code: 0 04:54:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:54: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:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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', '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 0x7faf7830df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cef840>, '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 0x2c5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5cb60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067', '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:54: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:54: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 blobuploader==1.2.4 04:54:51 INFO - Using env: {'DISPLAY': ':0', 04:54:51 INFO - 'HOME': '/home/cltbld', 04:54:51 INFO - 'LANG': 'en_US.UTF-8', 04:54:51 INFO - 'LANGUAGE': 'en_US:en', 04:54:51 INFO - 'LOGNAME': 'cltbld', 04:54:51 INFO - 'MAIL': '/var/mail/cltbld', 04:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:51 INFO - 'MOZ_NO_REMOTE': '1', 04:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:51 INFO - 'NO_EM_RESTART': '1', 04:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:51 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:51 INFO - 'SHELL': '/bin/bash', 04:54:51 INFO - 'SHLVL': '1', 04:54:51 INFO - 'TERM': 'linux', 04:54:51 INFO - 'TMOUT': '86400', 04:54:51 INFO - 'USER': 'cltbld', 04:54:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067', 04:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:51 INFO - '_': '/tools/buildbot/bin/python'} 04:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:51 INFO - Downloading/unpacking blobuploader==1.2.4 04:54: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:54: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:54: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:54: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:54: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:54: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:54:53 INFO - Downloading blobuploader-1.2.4.tar.gz 04:54:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:54:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:54:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:54:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:54:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:53 INFO - Downloading docopt-0.6.1.tar.gz 04:54:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:54:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:54:53 INFO - Installing collected packages: blobuploader, requests, docopt 04:54:53 INFO - Running setup.py install for blobuploader 04:54:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:54:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:54:53 INFO - Running setup.py install for requests 04:54:54 INFO - Running setup.py install for docopt 04:54:54 INFO - Successfully installed blobuploader requests docopt 04:54:54 INFO - Cleaning up... 04:54:54 INFO - Return code: 0 04:54:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:54: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:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:54 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 0x7faf7830df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cef840>, '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 0x2c5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5cb60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067', '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:54:54 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:54:54 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:54:54 INFO - Using env: {'DISPLAY': ':0', 04:54:54 INFO - 'HOME': '/home/cltbld', 04:54:54 INFO - 'LANG': 'en_US.UTF-8', 04:54:54 INFO - 'LANGUAGE': 'en_US:en', 04:54:54 INFO - 'LOGNAME': 'cltbld', 04:54:54 INFO - 'MAIL': '/var/mail/cltbld', 04:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:54 INFO - 'MOZ_NO_REMOTE': '1', 04:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:54 INFO - 'NO_EM_RESTART': '1', 04:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:54 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:54 INFO - 'SHELL': '/bin/bash', 04:54:54 INFO - 'SHLVL': '1', 04:54:54 INFO - 'TERM': 'linux', 04:54:54 INFO - 'TMOUT': '86400', 04:54:54 INFO - 'USER': 'cltbld', 04:54:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067', 04:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:54 INFO - '_': '/tools/buildbot/bin/python'} 04:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:54:54 INFO - Running setup.py (path:/tmp/pip-l01Z_x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:54:54 INFO - Running setup.py (path:/tmp/pip-C3LRWy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:54:54 INFO - Running setup.py (path:/tmp/pip-6abfjH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:54:54 INFO - Running setup.py (path:/tmp/pip-0OsK1A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:54:54 INFO - Running setup.py (path:/tmp/pip-vGmqhp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:54:55 INFO - Running setup.py (path:/tmp/pip-D2FYiE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:54:55 INFO - Running setup.py (path:/tmp/pip-9Hpk70-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:54:55 INFO - Running setup.py (path:/tmp/pip-4lUMhx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:54:55 INFO - Running setup.py (path:/tmp/pip-8VxrPY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:54:55 INFO - Running setup.py (path:/tmp/pip-kfl1g2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:54:55 INFO - Running setup.py (path:/tmp/pip-XjiuRM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:54:55 INFO - Running setup.py (path:/tmp/pip-gvXleK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:54:55 INFO - Running setup.py (path:/tmp/pip-nNL2eP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:54:55 INFO - Running setup.py (path:/tmp/pip-Mm4SBW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:54:55 INFO - Running setup.py (path:/tmp/pip-ERk0vF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:54:55 INFO - Running setup.py (path:/tmp/pip-uJXivt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:54:55 INFO - Running setup.py (path:/tmp/pip-c92I7A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:54:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:54:55 INFO - Running setup.py install for manifestparser 04:54:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:54:56 INFO - Running setup.py install for mozcrash 04:54:56 INFO - Running setup.py install for mozdebug 04:54:56 INFO - Running setup.py install for mozdevice 04:54:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:54:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:54:56 INFO - Running setup.py install for mozfile 04:54:56 INFO - Running setup.py install for mozhttpd 04:54:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:54:56 INFO - Running setup.py install for mozinfo 04:54:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:54:56 INFO - Running setup.py install for mozInstall 04:54:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:54:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:54:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:54:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:54:56 INFO - Running setup.py install for mozleak 04:54:56 INFO - Running setup.py install for mozlog 04:54:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:54:56 INFO - Running setup.py install for moznetwork 04:54:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:54:57 INFO - Running setup.py install for mozprocess 04:54:57 INFO - Running setup.py install for mozprofile 04:54:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:54:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:54:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:54:57 INFO - Running setup.py install for mozrunner 04:54:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:54:57 INFO - Running setup.py install for mozscreenshot 04:54:57 INFO - Running setup.py install for moztest 04:54:57 INFO - Running setup.py install for mozversion 04:54:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:54:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:54:57 INFO - Cleaning up... 04:54:57 INFO - Return code: 0 04:54:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7faf7830df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cef840>, '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 0x2c5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5cb60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067', '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:54:57 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:54:57 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:54:57 INFO - Using env: {'DISPLAY': ':0', 04:54:57 INFO - 'HOME': '/home/cltbld', 04:54:57 INFO - 'LANG': 'en_US.UTF-8', 04:54:57 INFO - 'LANGUAGE': 'en_US:en', 04:54:57 INFO - 'LOGNAME': 'cltbld', 04:54:57 INFO - 'MAIL': '/var/mail/cltbld', 04:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:57 INFO - 'MOZ_NO_REMOTE': '1', 04:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:57 INFO - 'NO_EM_RESTART': '1', 04:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:57 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:57 INFO - 'SHELL': '/bin/bash', 04:54:57 INFO - 'SHLVL': '1', 04:54:57 INFO - 'TERM': 'linux', 04:54:57 INFO - 'TMOUT': '86400', 04:54:57 INFO - 'USER': 'cltbld', 04:54:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067', 04:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:57 INFO - '_': '/tools/buildbot/bin/python'} 04:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:54:57 INFO - Running setup.py (path:/tmp/pip-398Ekf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:54:57 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:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:54:57 INFO - Running setup.py (path:/tmp/pip-POkf7P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:54:58 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:54:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:54:58 INFO - Running setup.py (path:/tmp/pip-xFHWIs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:54:58 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:54:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:54:58 INFO - Running setup.py (path:/tmp/pip-Q8NVx7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:54:58 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:54:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:54:58 INFO - Running setup.py (path:/tmp/pip-UKhqKy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:54:58 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:54:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:54:58 INFO - Running setup.py (path:/tmp/pip-YVKkrB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:54:58 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:54:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:54:58 INFO - Running setup.py (path:/tmp/pip-El2dES-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:54:58 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:54:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:54:58 INFO - Running setup.py (path:/tmp/pip-L0CeFE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:54:58 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:54:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:54:58 INFO - Running setup.py (path:/tmp/pip-XX5db_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:54:58 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:54:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:54:58 INFO - Running setup.py (path:/tmp/pip-4tOU2z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:54:58 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:54:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:54:58 INFO - Running setup.py (path:/tmp/pip-QzyKL8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:54:58 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:54:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:54:58 INFO - Running setup.py (path:/tmp/pip-Y_4Z6w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:54:58 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:54:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:54:58 INFO - Running setup.py (path:/tmp/pip-QcNkHY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:54:58 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:54:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:54:58 INFO - Running setup.py (path:/tmp/pip-EtEFLj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:54:58 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:54:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:54:58 INFO - Running setup.py (path:/tmp/pip-c8g6fO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:54:59 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:54:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:54:59 INFO - Running setup.py (path:/tmp/pip-IWj65n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:54:59 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:54:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:54:59 INFO - Running setup.py (path:/tmp/pip-DxxsvL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:54:59 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:54:59 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:54:59 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:54:59 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:54:59 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:54:59 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:54:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:54:59 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:54:59 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:54:59 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:54:59 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:54:59 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:54:59 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:55:00 INFO - Downloading blessings-1.5.1.tar.gz 04:55:00 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:55:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:55:00 INFO - Installing collected packages: blessings 04:55:00 INFO - Running setup.py install for blessings 04:55:00 INFO - Successfully installed blessings 04:55:00 INFO - Cleaning up... 04:55:01 INFO - Return code: 0 04:55:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:55:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:55:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:55:01 INFO - Reading from file tmpfile_stdout 04:55:01 INFO - Current package versions: 04:55:01 INFO - argparse == 1.2.1 04:55:01 INFO - blessings == 1.5.1 04:55:01 INFO - blobuploader == 1.2.4 04:55:01 INFO - docopt == 0.6.1 04:55:01 INFO - manifestparser == 1.1 04:55:01 INFO - mozInstall == 1.12 04:55:01 INFO - mozcrash == 0.16 04:55:01 INFO - mozdebug == 0.1 04:55:01 INFO - mozdevice == 0.47 04:55:01 INFO - mozfile == 1.2 04:55:01 INFO - mozhttpd == 0.7 04:55:01 INFO - mozinfo == 0.9 04:55:01 INFO - mozleak == 0.1 04:55:01 INFO - mozlog == 3.1 04:55:01 INFO - moznetwork == 0.27 04:55:01 INFO - mozprocess == 0.22 04:55:01 INFO - mozprofile == 0.28 04:55:01 INFO - mozrunner == 6.11 04:55:01 INFO - mozscreenshot == 0.1 04:55:01 INFO - mozsystemmonitor == 0.0 04:55:01 INFO - moztest == 0.7 04:55:01 INFO - mozversion == 1.4 04:55:01 INFO - psutil == 3.1.1 04:55:01 INFO - requests == 1.2.3 04:55:01 INFO - wsgiref == 0.1.2 04:55:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:55:01 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:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:01 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:55:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:01 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 0x7faf7830df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cef840>, '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 0x2c5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5cb60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067', '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:55:01 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:55:01 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:55:01 INFO - Using env: {'DISPLAY': ':0', 04:55:01 INFO - 'HOME': '/home/cltbld', 04:55:01 INFO - 'LANG': 'en_US.UTF-8', 04:55:01 INFO - 'LANGUAGE': 'en_US:en', 04:55:01 INFO - 'LOGNAME': 'cltbld', 04:55:01 INFO - 'MAIL': '/var/mail/cltbld', 04:55:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:01 INFO - 'MOZ_NO_REMOTE': '1', 04:55:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:01 INFO - 'NO_EM_RESTART': '1', 04:55:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:01 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:01 INFO - 'SHELL': '/bin/bash', 04:55:01 INFO - 'SHLVL': '1', 04:55:01 INFO - 'TERM': 'linux', 04:55:01 INFO - 'TMOUT': '86400', 04:55:01 INFO - 'USER': 'cltbld', 04:55:01 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067', 04:55:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:01 INFO - '_': '/tools/buildbot/bin/python'} 04:55:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:01 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:55:01 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:55:01 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:55:01 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:55:01 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:55:01 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:55:01 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:55:01 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:55:01 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:55:01 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:55:01 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:55:01 INFO - Cleaning up... 04:55:01 INFO - Return code: 0 04:55:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:55:01 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:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:01 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:55:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:01 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 0x7faf7830df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cef840>, '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 0x2c5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5cb60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067', '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:55:01 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:55:01 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:55:01 INFO - Using env: {'DISPLAY': ':0', 04:55:01 INFO - 'HOME': '/home/cltbld', 04:55:01 INFO - 'LANG': 'en_US.UTF-8', 04:55:01 INFO - 'LANGUAGE': 'en_US:en', 04:55:01 INFO - 'LOGNAME': 'cltbld', 04:55:01 INFO - 'MAIL': '/var/mail/cltbld', 04:55:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:01 INFO - 'MOZ_NO_REMOTE': '1', 04:55:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:01 INFO - 'NO_EM_RESTART': '1', 04:55:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:01 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:01 INFO - 'SHELL': '/bin/bash', 04:55:01 INFO - 'SHLVL': '1', 04:55:01 INFO - 'TERM': 'linux', 04:55:01 INFO - 'TMOUT': '86400', 04:55:01 INFO - 'USER': 'cltbld', 04:55:01 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067', 04:55:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:01 INFO - '_': '/tools/buildbot/bin/python'} 04:55:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:01 INFO - Downloading/unpacking jsonschema 04:55:01 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:55:01 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:55:01 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:55:01 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:55:01 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:55:01 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:55:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:55:03 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:55:03 INFO - Downloading/unpacking functools32 (from jsonschema) 04:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:03 INFO - Downloading functools32-3.2.3-2.tar.gz 04:55:03 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:55:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:55:03 INFO - warning: no files found matching '*.txt' 04:55:03 INFO - no previously-included directories found matching 'build' 04:55:03 INFO - no previously-included directories found matching 'dist' 04:55:03 INFO - no previously-included directories found matching '.git*' 04:55:03 INFO - Installing collected packages: jsonschema, functools32 04:55:03 INFO - Running setup.py install for functools32 04:55:03 INFO - warning: no files found matching '*.txt' 04:55:03 INFO - no previously-included directories found matching 'build' 04:55:03 INFO - no previously-included directories found matching 'dist' 04:55:03 INFO - no previously-included directories found matching '.git*' 04:55:03 INFO - Successfully installed jsonschema functools32 04:55:03 INFO - Cleaning up... 04:55:03 INFO - Return code: 0 04:55:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:55:03 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:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:03 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:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:03 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 0x7faf7830df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cef840>, '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 0x2c5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5cb60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067', '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:55:03 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:55:03 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:55:03 INFO - Using env: {'DISPLAY': ':0', 04:55:03 INFO - 'HOME': '/home/cltbld', 04:55:03 INFO - 'LANG': 'en_US.UTF-8', 04:55:03 INFO - 'LANGUAGE': 'en_US:en', 04:55:03 INFO - 'LOGNAME': 'cltbld', 04:55:03 INFO - 'MAIL': '/var/mail/cltbld', 04:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:03 INFO - 'MOZ_NO_REMOTE': '1', 04:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:03 INFO - 'NO_EM_RESTART': '1', 04:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:03 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:03 INFO - 'SHELL': '/bin/bash', 04:55:03 INFO - 'SHLVL': '1', 04:55:03 INFO - 'TERM': 'linux', 04:55:03 INFO - 'TMOUT': '86400', 04:55:03 INFO - 'USER': 'cltbld', 04:55:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067', 04:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:03 INFO - '_': '/tools/buildbot/bin/python'} 04:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:04 INFO - Downloading/unpacking flake8 04:55: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:55: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:55: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:55: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:55: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:55: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:55:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:55:05 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:55:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:55:05 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:55:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:06 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:55:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:55: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:55: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:55: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:55: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:55: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:55: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:55:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:55:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:55:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:55:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:55:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:55:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:55:06 INFO - no previously-included directories found matching 'docs/_build' 04:55:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:55:06 INFO - Running setup.py install for pep8 04:55:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:55:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:55:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:55:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:55:06 INFO - no previously-included directories found matching 'docs/_build' 04:55:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:55:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:55:06 INFO - Cleaning up... 04:55:06 INFO - Return code: 0 04:55:06 INFO - Running post-action listener: _resource_record_post_action 04:55:06 INFO - Running post-action listener: _start_resource_monitoring 04:55:06 INFO - Starting resource monitoring. 04:55:06 INFO - ##### 04:55:06 INFO - ##### Running install step. 04:55:06 INFO - ##### 04:55:06 INFO - Running pre-action listener: _resource_record_pre_action 04:55:06 INFO - Running main action method: install 04:55:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:55:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:55:06 INFO - Reading from file tmpfile_stdout 04:55:06 INFO - Detecting whether we're running mozinstall >=1.0... 04:55:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:55:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:55:06 INFO - Reading from file tmpfile_stdout 04:55:06 INFO - Output received: 04:55:06 INFO - Usage: mozinstall [options] installer 04:55:06 INFO - Options: 04:55:06 INFO - -h, --help show this help message and exit 04:55:06 INFO - -d DEST, --destination=DEST 04:55:06 INFO - Directory to install application into. [default: 04:55:06 INFO - "/builds/slave/test-pgo"] 04:55:06 INFO - --app=APP Application being installed. [default: firefox] 04:55:06 INFO - mkdir: /builds/slave/test-pgo/build/application 04:55:06 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:55:06 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:55:22 INFO - Reading from file tmpfile_stdout 04:55:22 INFO - Output received: 04:55:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:55:22 INFO - Running post-action listener: _resource_record_post_action 04:55:22 INFO - ##### 04:55:22 INFO - ##### Running run-tests step. 04:55:22 INFO - ##### 04:55:22 INFO - Running pre-action listener: _resource_record_pre_action 04:55:22 INFO - Running main action method: run_tests 04:55:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:55:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:55:22 INFO - Python 2.7.3 04:55:22 INFO - Return code: 0 04:55:22 INFO - grabbing minidump binary from tooltool 04:55:22 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:55:22 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 0x2cef840>, '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 0x2c5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5cb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:55:22 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:55:22 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:55:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:55:22 INFO - Return code: 0 04:55:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:55:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:55:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:55:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:55:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:55:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:55:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:55:23 INFO - Return code: 0 04:55:23 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/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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:55:23 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/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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:55:23 INFO - Using env: {'DISPLAY': ':0', 04:55:23 INFO - 'HOME': '/home/cltbld', 04:55:23 INFO - 'LANG': 'en_US.UTF-8', 04:55:23 INFO - 'LANGUAGE': 'en_US:en', 04:55:23 INFO - 'LOGNAME': 'cltbld', 04:55:23 INFO - 'MAIL': '/var/mail/cltbld', 04:55:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:55:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:23 INFO - 'MOZ_NO_REMOTE': '1', 04:55:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:55:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:23 INFO - 'NO_EM_RESTART': '1', 04:55:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:23 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:55:23 INFO - 'SHELL': '/bin/bash', 04:55:23 INFO - 'SHLVL': '1', 04:55:23 INFO - 'TERM': 'linux', 04:55:23 INFO - 'TMOUT': '86400', 04:55:23 INFO - 'USER': 'cltbld', 04:55:23 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067', 04:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:23 INFO - '_': '/tools/buildbot/bin/python'} 04:55:23 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/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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:55:24 INFO - mozversion application_buildid: 20160104023005 04:55:24 INFO - mozversion application_changeset: f56d3f847e3cb407d99a7623e9f1c36ee39085a4 04:55:24 INFO - mozversion application_display_name: Nightly 04:55:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:55:24 INFO - mozversion application_name: Firefox 04:55:24 INFO - mozversion application_remotingname: firefox 04:55:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 04:55:24 INFO - mozversion application_vendor: Mozilla 04:55:24 INFO - mozversion application_version: 46.0a1 04:55:24 INFO - mozversion platform_buildid: 20160104023005 04:55:24 INFO - mozversion platform_changeset: f56d3f847e3cb407d99a7623e9f1c36ee39085a4 04:55:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 04:55:24 INFO - mozversion platform_version: 46.0a1 04:55:24 INFO - using testdate: 1451912124 04:55:24 INFO - actual date: 1451912124 04:55:24 INFO - starting webserver on 'localhost:55351' 04:55:24 INFO - SUITE-START | Running 3 tests 04:55:24 INFO - TEST-START | dromaeo_css 04:55:24 INFO - operating with platform_type : linux_ 04:55:24 INFO - Initialising browser for dromaeo_css test... 04:55:24 INFO - TEST-INFO | started process 5898 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMwGxK0/profile http://localhost:55351/getInfo.html) 04:55:28 INFO - PROCESS | 5898 | __metrics Screen width/height:1600/1200 04:55:28 INFO - PROCESS | 5898 | colorDepth:24 04:55:28 INFO - PROCESS | 5898 | Browser inner width/height: 1024/697 04:55:28 INFO - PROCESS | 5898 | __metrics 04:55:29 INFO - PROCESS | 5898 | 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:55:29 INFO - PROCESS | 5898 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:55:29 INFO - TEST-INFO | 5898: exit 0 04:55:29 INFO - Browser initialized. 04:55:29 INFO - Running cycle 1/1 for dromaeo_css test... 04:55:29 INFO - TEST-INFO | started process 5994 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMwGxK0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:41 INFO - PROCESS | 5994 | RSS: Main: 149655552 04:55:41 INFO - PROCESS | 5994 | 04:56:32 INFO - PROCESS | 5994 | 1451912192391 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:58:41 INFO - PROCESS | 5994 | Cycle 1(1): loaded http://localhost:55351/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55351/tests/dromaeo/cssquery-ext.html) 04:58:43 INFO - PROCESS | 5994 | RSS: Main: 264331264 04:58:43 INFO - PROCESS | 5994 | 05:01:45 INFO - PROCESS | 5994 | Cycle 1(1): loaded http://localhost:55351/tests/dromaeo/cssquery-ext.html (next: http://localhost:55351/tests/dromaeo/cssquery-jquery.html) 05:01:45 INFO - PROCESS | 5994 | RSS: Main: 231550976 05:01:45 INFO - PROCESS | 5994 | 05:04:47 INFO - PROCESS | 5994 | Cycle 1(1): loaded http://localhost:55351/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55351/tests/dromaeo/cssquery-mootools.html) 05:04:48 INFO - PROCESS | 5994 | RSS: Main: 222547968 05:04:48 INFO - PROCESS | 5994 | 05:07:50 INFO - PROCESS | 5994 | Cycle 1(1): loaded http://localhost:55351/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55351/tests/dromaeo/cssquery-prototype.html) 05:07:50 INFO - PROCESS | 5994 | RSS: Main: 206843904 05:07:50 INFO - PROCESS | 5994 | 05:10:53 INFO - PROCESS | 5994 | Cycle 1(1): loaded http://localhost:55351/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55351/tests/dromaeo/cssquery-yui.html) 05:10:53 INFO - PROCESS | 5994 | RSS: Main: 214466560 05:10:53 INFO - PROCESS | 5994 | 05:13:56 INFO - PROCESS | 5994 | Cycle 1(1): loaded http://localhost:55351/tests/dromaeo/cssquery-yui.html (next: http://localhost:55351/tests/dromaeo/cssquery-dojo.html) 05:13:56 INFO - PROCESS | 5994 | RSS: Main: 291135488 05:13:56 INFO - PROCESS | 5994 | 05:13:56 INFO - PROCESS | 5994 | __start_tp_report 05:13:56 INFO - PROCESS | 5994 | _x_x_mozilla_page_load 05:13:56 INFO - PROCESS | 5994 | _x_x_mozilla_page_load_details 05:13:56 INFO - PROCESS | 5994 | |i|pagename|runs| 05:13:56 INFO - PROCESS | 5994 | |0;dojo.html;3122.0789866989235;3165.5568220449154;3216.9866492055003;3217.7908435951663;3234.9838250808743;5282.788688452457;5358.41057483677;5361.356637203531;5400.594955378343;5428.104362780142;5269.235960785693;5323.547498462625;5347.973260133704;5350.5184533391985;5423.078076726956;4792.257200133985;4871.464138944713;4874.195757699993;4921.163402221613;4956.653034287601;4942.357493525837;4963.950360496385;5015.974920125394;5037.722925239111;5041.59667226621;4829.9275510867365;4984.526469985346;4986.825461108844;5059.2916991621205;5074.112030394685;4848.0788650156355;4921.458639549646;4928.802847886081;4942.654014219006;4967.925481117786;4874.147024270738;4877.1984001673745;4879.512048795092;4896.216605343128;4915.115279249733;5158.793648254103;5216.2958000669805;5231.659942103751;5253.4221235664045;5263.315768950012;5642.492175704207;5786.305643322786;5796.043652797283;5829.621074630178;5867.794627188028;5829.242198514208;5836.970815145897;5843.561732870009;5843.766249350021;5850.385709500484;5316.680999140064;5428.647137936022;5439.83680489582;5446.400895901447;5453.863653408657;5865.736041878125;5910.231669882888;5924.348321684612;5949.613275137102;5976.043832986701;5690.3456102548735;5692.459216374438;5693.658380497183;5694.686792226467;5701.4013528579735;5656.971715141398;5724.227229324071;5761.251037365116;5778.3354914184565;5792.9710351447975;5736.627119237236;5791.536677065825;5793.246877905845;5795.159701843209;5824.446677565625;5758.481736643638;5819.301683797887;5820.82537523875;5822.417758224228;5824.621399609096;4361.760103194355;4447.2439685253585;4457.9331310030375;4478.820847166142;4520.50274469808;3953.2686453006286;3969.285528604879;3970.841166353371;3987.960120398817;3991.7604943703473;5371.006363822706;5373.408925018245;5376.489233522809;5376.946230537645;5429.701366424884;5605.523530499953;5739.71301434935;5744.310682718101;5748.913766293509;5789.363170051291;5350.91973620396;5383.515483606416;5398.271233383522;5402.783888644489;5425.701586412706;4906.288588154697;4906.533879281463;4909.165441874889;4910.484399138039;4950.975245123751;5716.228309178291;5897.085951677497;5984.581079324405;5994.730237139339;6004.639721616717;5639.210510528611;5721.914171287517;5836.124581312837;5846.152307915413;5884.411558844253;6069.423404776539;6071.939280607314;6074.969625152023;6076.240469941257;6080.148779171008;5599.412061733459;5716.657000579812;5739.770409183586;5740.0815869460685;5741.8564535886935;5663.745131469176;5786.537077033911;5881.382454842351;5891.821635672968;5911.054231322968;5693.572982026448;5700.144978253129;5710.486056254957;5717.371089180104;5720.227769251098;5544.500994910478;5678.829635110953;5687.914681279702;5690.658560486384;5691.800786972436;5364.061289274439;5492.944501363654;5532.0595498766115;5534.806281780118;5539.113741801292;5681.9431805681415;5692.203091567267;5692.544596432358;5694.1458781183155;5695.889301586151;5539.41836107219;5571.916421253603;5583.916241256466;5585.106382978704;5589.189567512769 05:13:56 INFO - PROCESS | 5994 | |1;ext.html;526.8761840967375;554.9223108764771;573.5012058717409;591.0985746736227;617.1452538234545;28344.716552834467;35333.46999795002;36378.27243455129;36399.818000910025;36466.63533364666;38188.618113818855;38410.23179536415;38634.420483692695;38716;38754;7449.8510029799645;7543.170251272356;8505.31957443403;8616.569171541429;8681.913180868174;10089.848652270186;10300.12448941841;10346.586136554528;10347.068763811256;10356.17150627948;10013.749656258578;10051.195904327673;10060.74848128799;10114.54484548197;10120.645777397756;7653.387728981668;7827.726029588994;7830.647620857075;7841.764747057598;10019.248556358265;10085.89914100857;10363.63727269542;10364.37813731171;10367.896321036844;10373.89626103737;36040.819795900854;36143.81928090343;36485;36489.452658210146;36517.81741091304;3140.7487401008093;3269.7711160218796;3532.2229109595846;3631.0014745944814;3919.8432062717457;28326.858365708038;29490.410191796258;29622.25944351387;30034.24914377136;30703.846480767676;3852.348257069206;3900.4149377593303;3919.9216015679813;3938.960610393888;4038.2125485530332;266453;268055;268371.65814171;268837;269495;58542.707286463294;59049.40950590439;59065.70467147637;59120.704396478606;59170;54056;55968.72015639977;62044.069338959955;62702;64107.67946160239;14797.92601036988;14961.850381496264;14967.775483367759;15064.924675376553;15127.924360378347;11716.531338746354;11792.056635469142;11820.468078936468;11827.467763950643;11829.88170118305;18894.244230230637;18916.81083189178;18963;18998.71501927472;19043.714344284846;7149.320814522612;7430;7447.292507211806;7452.701891924371;7463.365613922877;940.2243149401634;946.3706635087727;960.2078285414422;1004.1866088468219;1065.8827528971806;26249.606255906176;26755.732442675715;27203.183904482896;27297.727022729916;27333.726662733516;1052.4369462337613;1075.9569617215225;1082.442542090824;1096.2435919215716;1101.944902754859;13883.097598656055;14039.157650541;14046.227457489731;14064;14135.363908623931;311103;314959;316561;316892;317971;44161.33757993633;44906.55093449089;46335.3049704248;46609.30086048712;46757.532424676;1321.062045947388;1323.8543760186371;1324.265032906746;1335.779596366608;1348.966275843092;25593.104241351462;25881.87059064768;26285.272132969116;28182.71817281883;28587.571186431804;38400.423993640674;38401.6159838398;38513.422298664984;42330.576694233896;43259;354302;354775;355644;357652;357718;31963.520547191347;32207.516887246242;32531.51202732008;32545.34909301848;32546.83726581352;42953.57046429496;43280.78359608182;43329.56670433255;43494.565054350314;44340.778296108314;36126.63873361338;36162.27675446529;36164.276714465035;36262.27475450424;37430.438543421325;35147.29705405929;36012.4598131023;36164;36580.63419365772;36589;35687;36677.26645467129;36744.265114697024;36750.44874326834;36753;29871.402571948875;32828.507572385955;33062.5040624386;33189.668103318654;33553;24621.63067554024;24916.501669966863;25053.498930020934;25410.364740881625;25531 05:13:56 INFO - PROCESS | 5994 | |2;jquery.html;355.5182727404367;359.1918184085807;359.54158447978824;362.08212182118336;363.29702026578553;13942.23317717525;14087.506937257198;16270.83729162708;16580.33678652854;17342.393016244434;15308.69382612347;16091.597710057255;16419.261133249;16420.261088251027;16550.420735274267;4959.752012399384;5069.340985671857;5076.796928122871;5080.288759573663;5084.694918304895;4113.8354465821485;4234.21666991606;5366.597505187107;5396.64921780083;5870.442307980735;5943.900378430004;5959.821205363846;5968.582199246054;5976.970115149418;5984.820455386345;5772.971135144318;5950.5834591578605;5954.31525374581;5955.731992060368;5958.940410595882;5249.7112658804135;5253.737313134328;5261.263423120766;5262.210668399733;5262.500062494057;18600.906995465073;20060.598788024305;20109.39671809848;20118.49703757403;20750.06624701892;2249.550089981994;2293.4610366563843;2301.4821665125382;2359.823013273994;2431.6960379952507;12941.54704585335;13133.802992955114;13199.736005279936;13300.866991330156;13416.664583385396;1784.5984653453;1831.542114471382;1836.32056139228;1852.4257480181186;1872.485066606694;56641.484030219;59734.103988440205;60247.69876150591;60314;61442;9513.476758778334;9571.904280957102;9848.310618256653;9857.162141218078;9909.306348555676;12982.15615984958;13001.414936327888;13009.349532523336;13016.674583135497;13019.414126364336;7451.739189128354;7468.775936721907;7534.623268836536;7604.733834315883;7682.96158519215;7427;7469.290417410337;7494.6627401767055;7501.399888009056;7549;5890.764369425175;5902.4097590240635;5919.644821310649;5951;5975.133605627159;1679.4541773923524;1721.0362197169625;1734.9826501735074;1748.2744660965557;1763.9029853357931;924.7549399409162;974.3763991045737;1001.5493028137367;1028.0747327405245;1069.919756018286;13563.389647465889;15928.442504512519;16445.506634800975;17185.39851105205;17702.29190832352;873.6112429968603;898.1871406377239;935.2004036548789;937.6530683647094;945.9054094590623;7041.647917604099;8994.550272486349;9232.492212928353;9262.536873156316;9409.153176214173;463181;473084;473719;486456;560410;78934.21065789384;79799;81052;82536.17463825404;83355.5832220835;1120.9159313051555;1174.682835634391;1179.6107284596062;1189.4723712111763;1195.7608478304373;15065.397384104514;15158.16630085356;15241.923790380977;15405.845941540889;15667.764983525483;33975.66024339725;34134.317313654086;34723.65276347204;34794.478082829286;35189.82405087958;46037.07925841532;47868.521314786405;48112.03775924532;48175;49006;8688.956555217184;9147.542622868697;9180.632774688938;9187.356885017985;9189.88632614489;10676.679699609023;12454.439550220442;16502.917485412498;16878;17065.573360666083;12243.632691019284;13629.318534073058;13766.724665506434;14059.718805624036;14276.643083922985;9165.954170229374;9176.58705358247;13418.664533386744;13455.125416847874;13726;9694.46680432583;9702.75743106428;9792.51037448139;10069.798604027732;10080.941501142275;14174.433022678977;14200.366505927264;14331.06848054873;14673.339699713326;14791.408343666133;9359.532023398939;9842.60629574809;9849.704508864745;15311.234438278265;15422.69154616879 05:13:56 INFO - PROCESS | 5994 | |3;mootools.html;1341.4097796969338;1465.853414658534;1467.0390893964454;1617.1348328644178;1784.072282413145;6627.469802415807;7141.2501687322865;7214.494985351028;7254.600996945166;7257.3831224345995;7107.502474826764;7230.9276907230915;7278.417726581874;7300.561966282027;7310.963445182767;2014.63736527425;2053.5995480881234;2199.3401979406194;2304.493011537463;2343.7773411525964;2278.327893271489;2302.481941563152;2303.67748515208;2304.4008557774932;2304.8156147508157;2190.6823510590953;2263.0495192019393;2265.762094980028;2266.410733209369;2266.648669456237;2238.888055597222;2251.684764133023;2264.399934017487;2282.5092605089985;2287.1080278691325;2285.337252196861;2288.8626682398944;2314.6875171851752;2328.906843726249;2329.825263105257;7292.489525733201;7366.889496657554;7374.078240219973;7380.63096845161;7382.593957332345;4642.187617166982;4669.276262179367;4671.392718946515;4704.223803072523;4720.079584481027;2994.82031078136;3027.091872438282;3035.2260173655795;3036.7418769404626;3147.087344670043;992.8014397120533;995;1014.9188064954786;1041.1930753665895;1050.9054185123375;9948.253880958884;10014.599416023277;10015.298929074968;10021.79956400868;10022.098011178956;4213.115245798355;4273.294906340419;4300.720453170597;4341.175176716414;4342.5657434256955;8691.217790398894;8708.78228044304;8709.433886797338;8711.34664900135;8720.127987201357;4658.627309815207;4698.2247929092;4699.718016918996;4703.176944034849;4704;4326.697131200785;4331.025519258142;4332.155229730172;4335.458067741532;4336.588024137702;3303.0586282909258;3352;3547.343741407848;3548.1484443733316;3579.266250418658;1152.567787079845;1175.506287359311;1177.7350096228452;1181.9172657914035;1186.1519013904926;1019.4342140112161;1020.3928662445833;1072.4048153275007;1119.7368618374676;1262.3498898067503;6593.2088149421415;6628.767993120217;6677.565958212701;6694.933050669529;6736.393724564715;1084.8589683341115;1088.472091035847;1099.7360633447915;1105.9004689577976;1113.8106521891298;5416.756245968941;5495.175723641486;5517.889642207133;5518.724063796794;5527.585431092603;8236.094029656733;8286.70996515119;8340.165983401612;8412.074671786098;8558.400911936229;8301;8330.000399952045;8340.666373345119;8359.164083591591;8420.873686894702;6789.15135608049;6919.688614012281;6967.477439192081;6979.127609048869;6995.8950615740805;6559;6570.5729127606555;6586.8353291168105;6601;6667.966660166668;7579.317861392501;7667.079950405987;7743.109542402696;7870.72452464161;7893.250141236574;7578.09062912454;7827.765167044998;7832.84334313322;7857.410694198073;7993.880091798512;6417;6487.805365839033;6527.412532872065;6541.8691626168165;6563;6276.592021518587;6394.520410969289;6517.804465866032;6617.305182955721;6654.168228971379;6499.545031847914;6562.967185164043;6571.080048793077;6660.10088638047;6697.162854643169;6456.709448074754;6540.247871494839;6561.40947314744;6652.434543063894;6657.40083392497;6549.345065493412;6590.90113648286;6591.571547849375;6596.30738772422;6605.976073708583;6103.389661033861;6133.110698948717;6140.5394595406415;6182.381761823782;6183.907241391473;6184.690765461799;6190;6240;6252.062190671436;6254.9687251563455 05:13:56 INFO - PROCESS | 5994 | |4;prototype.html;339.3823241700105;339.8148009334912;347.22048999995013;350.45329286313347;353.8195520284654;5970.701464926758;5977.790777322794;6003.369646187148;6007.3692262312425;6009.969950150254;5643;5747.563109222694;5856.707164641762;5952.5535584831205;5972.880542389161;4620.561046700558;4621.4223222097235;4637.1189474;4643.582077613014;4649.488556258817;4401.625861801735;4638.281066434708;4639.791209395568;4642.512536183703;4651.837185698484;4448.6885917985755;4451.354553589727;4509.481409637884;4526.75102869342;4532.56940590645;4502.8874278142985;4511.052678937427;4513.074819661962;4518.638508919278;4527.185106680796;3991.5808840071954;3995.081131339779;3996.080901392696;3999.6800255979742;4000.5399379071196;5520.530754885839;5635.436456354373;5684.488396044376;5687.772489100473;5690.374058853523;5331.253624492574;5334.866628334284;5347.358317001946;5348.572114230852;5349.759260833272;6276.968615156895;6290.339514350973;6293.622382657055;6298.2756982947085;6303.338149494283;4461.933071003938;4463.732176069414;4471.35165401015;4473.507914129443;4473.932891006638;6348.111264422984;6547.836304092388;6548.70530826114;6578.375054369827;6594.208694956588;4376.956230437719;4391;4398.186335527937;4400.273954797487;4401.427814384109;4439.733615983051;4450.443694538183;4453.576910193527;4456.7548784817145;4458.665600080007;5122.206058061007;5141.794328226829;5200.063988482034;5208.661437006583;5219.765110570033;6100.969495152496;6262.655553944485;6279.748810047547;6285.968570157212;6290.056491526216;1588.3329001819263;1603.6712473942814;1605.1813575076794;1608.1959020489755;1608.4772448953902;1072.4905669806935;1073.7906108308805;1076.0638244727138;1094.414488248783;1094.934303941766;6007.459328660441;6020.819375418744;6021.036634138517;6028.8794224116145;6036.456718895321;6466.1270728452;6473.2232132144445;6482.611043337415;6492.5455218134275;6500.219973603198;5814.069748840166;5928.407159284037;5970.880582388328;6060.969695151496;6081.5742897996715;3515.1739341254784;3515.20907795749;3527.400341941876;3535.1515636247113;3538.115471132217;6845.726170953206;6846.315368463114;6852.109225800614;6854.451643868479;6854.828629284208;6596.934030659728;6720.462363010947;6720.9663951680905;6731.730730770714;6733.966330168416;6701.564398314192;6720.22717387497;6721.932780672229;6726.260111387744;6729.596224226464;6480.708368123352;6482.513811464253;6484.351564843667;6484.675766211576;6486.740530378732;6281.152044473937;6478.805635830932;6482.254540727877;6486.481081513562;6488.70800813974;6804.557703749439;6817.727290908507;6820.249772524919;6826.283240259701;6830.556013859084;4491.101779644019;4492.236319825703;4494.235979883493;4494.685372023927;4499.122671079239;6437.903431448625;6564.5076619252795;6567.704453299709;6574.178227721535;6588.176477940257;6382.968085159545;6386.808395748135;6405.743770249138;6408.166938298178;6425.1004859320665;6395.136656551306;6408.1349017881985;6409.198850143732;6415.807525774234;6418.743250270124;6169.321374648875;6271.247450305992;6276.529260305587;6287.622742635456;6288.496920246461;6416.7754128605275;6431.324710905287;6435.613863168225;6437.034444833313;6437.871242575028;6290.150829637941;6297.307296197323;6300.621962682254;6300.716467759054;6300.9684951574945 05:13:56 INFO - PROCESS | 5994 | |5;yui.html;778.2684276779825;806.0287353738744;839.9244068033884;844.370943646983;859.9355048371369;12983.545575904833;13277.933610331947;13309.667258318523;13310.201387916708;13312.467501299936;12782.42479088441;12904.161229520074;12909.289989050598;12911.031672624567;12945.288009159493;784.019975031211;784.4822417204646;784.5841703896943;787.763670898731;788.4874831359633;660.7291010685595;664.950128740344;797.8444203380343;807.3460496997421;808.0424696734359;828.958552072397;829.3323874281201;843.6330196364601;844.0546587821648;844.932405407566;676.908617336663;683.5010442377043;836.5817091454303;836.6695155413638;837.0374069819726;605.9121427393003;609.6189881324173;613.328405396095;613.3712944232153;614.0022463496817;12611.432485538173;12683.239005659598;12721.618351449379;12733.299668518228;12791.5522956697;11101.666949991513;11370.204085714004;11584.015358694436;11784.764304713943;12372.566960156351;10355.94822025885;10359.741006474824;10525.157987360994;10594.62918797846;10969.83545246822;3533.876314328986;3570.1788588624504;3582.5163602913794;3588.623194564559;3700.6854417374557;42894.78552607217;43265.35101973473;43368.3494747579;43384;43408;9395.483248421402;9536.427814331162;9559.235261179228;9601;9905.950470247746;17901.552461188316;18000;18056.45830625083;18082.186301616457;18106.45680629583;7005.1944026436595;7067.611281379471;7074.71701131949;7081.291870812981;7383;3897.922041559153;3942.980285098556;3976.642102210757;3997.4403583498333;4072.429859819628;3158.210447388153;3189.728873045771;3193.0899693587216;3196.5205219217305;3197.4724170512072;563.456264704562;571.0492030768806;582.4466756581264;596.8746563221686;600.207725801946;547.7644612816528;584.713490389706;620.6803496199461;653.9901901471482;661.3023260460164;8175.877361839577;8282.917170828336;8349;8386.412951093487;8434.57827108642;594.9464548190683;648.9675516224264;655.5574986883835;657.3525077798365;706.523096909584;3795.3168429682923;3848.461215429842;3861.092643228839;3862.667335097094;3910.8044597770568;53105.7344713274;54315;54441.45558544443;54664;54791;47165;47335;48063.75968120137;48239.75880120577;49273.50726492761;39008.414873776914;39129.2174156521;39848.20303593912;39924.60075399209;40264.59735402608;8135.75592732219;8451.8155622476;8839.734807955772;8845.336599754915;8847.778805529913;31750.364992700477;31767.364652707278;31794.364112718078;33089.50365744564;33690.663093368756;39306.410403843394;39505.407418888164;39995.40006899841;43612;43629;10729.517171727135;10860.891391085988;10873;10981.61564345244;11171;11958.820617690915;12068.785722443876;12135.939320303341;12542.937285313516;12890.29103399322;10695.786084278116;11069.5018724156;11084.61203857861;11185.944070279596;11765.941170294094;10697.572097116028;11066.723331916766;11087.778244434905;11265.943670281924;11545.538178472767;11039.613613523488;11149;11188.888111118784;11318.830217546578;11670;9099.66919324872;9376.29677774156;9456.763580910532;9472.905270947202;9696.369735967139;8981.191692747683;9174.770630734018;9229;9243.768399418093;9312.44125352481 05:13:56 INFO - PROCESS | 5994 | __end_tp_report 05:13:56 INFO - PROCESS | 5994 | __start_cc_report 05:13:56 INFO - PROCESS | 5994 | _x_x_mozilla_cycle_collect,908 05:13:56 INFO - PROCESS | 5994 | __end_cc_report 05:13:56 INFO - PROCESS | 5994 | __startTimestamp1451913236881__endTimestamp 05:13:56 INFO - PROCESS | 5994 | 05:13:56 INFO - PROCESS | 5994 | ------- Summary: start ------- 05:13:56 INFO - PROCESS | 5994 | Number of tests: 6 05:13:56 INFO - PROCESS | 5994 | 05:13:56 INFO - PROCESS | 5994 | [#0] dojo.html Cycles:165 Average:5366.51 Median:5571.92 stddev:602.12 (10.8%) stddev-sans-first:577.65 05:13:56 INFO - PROCESS | 5994 | Values: 3122.1 3165.6 3217.0 3217.8 3235.0 5282.8 5358.4 5361.4 5400.6 5428.1 5269.2 5323.5 5348.0 5350.5 5423.1 4792.3 4871.5 4874.2 4921.2 4956.7 4942.4 4964.0 5016.0 5037.7 5041.6 4829.9 4984.5 4986.8 5059.3 5074.1 4848.1 4921.5 4928.8 4942.7 4967.9 4874.1 4877.2 4879.5 4896.2 4915.1 5158.8 5216.3 5231.7 5253.4 5263.3 5642.5 5786.3 5796.0 5829.6 5867.8 5829.2 5837.0 5843.6 5843.8 5850.4 5316.7 5428.6 5439.8 5446.4 5453.9 5865.7 5910.2 5924.3 5949.6 5976.0 5690.3 5692.5 5693.7 5694.7 5701.4 5657.0 5724.2 5761.3 5778.3 5793.0 5736.6 5791.5 5793.2 5795.2 5824.4 5758.5 5819.3 5820.8 5822.4 5824.6 4361.8 4447.2 4457.9 4478.8 4520.5 3953.3 3969.3 3970.8 3988.0 3991.8 5371.0 5373.4 5376.5 5376.9 5429.7 5605.5 5739.7 5744.3 5748.9 5789.4 5350.9 5383.5 5398.3 5402.8 5425.7 4906.3 4906.5 4909.2 4910.5 4951.0 5716.2 5897.1 5984.6 5994.7 6004.6 5639.2 5721.9 5836.1 5846.2 5884.4 6069.4 6071.9 6075.0 6076.2 6080.1 5599.4 5716.7 5739.8 5740.1 5741.9 5663.7 5786.5 5881.4 5891.8 5911.1 5693.6 5700.1 5710.5 5717.4 5720.2 5544.5 5678.8 5687.9 5690.7 5691.8 5364.1 5492.9 5532.1 5534.8 5539.1 5681.9 5692.2 5692.5 5694.1 5695.9 5539.4 5571.9 5583.9 5585.1 5589.2 05:13:56 INFO - PROCESS | 5994 | 05:13:56 INFO - PROCESS | 5994 | [#1] ext.html Cycles:180 Average:47376.51 Median:34350.15 stddev:82661.77 (240.6%) stddev-sans-first:82818.82 05:13:56 INFO - PROCESS | 5994 | Values: 526.9 554.9 573.5 591.1 617.1 28344.7 35333.5 36378.3 36399.8 36466.6 38188.6 38410.2 38634.4 38716.0 38754.0 7449.9 7543.2 8505.3 8616.6 8681.9 10089.8 10300.1 10346.6 10347.1 10356.2 10013.7 10051.2 10060.7 10114.5 10120.6 7653.4 7827.7 7830.6 7841.8 10019.2 10085.9 10363.6 10364.4 10367.9 10373.9 36040.8 36143.8 36485.0 36489.5 36517.8 3140.7 3269.8 3532.2 3631.0 3919.8 28326.9 29490.4 29622.3 30034.2 30703.8 3852.3 3900.4 3919.9 3939.0 4038.2 266453.0 268055.0 268371.7 268837.0 269495.0 58542.7 59049.4 59065.7 59120.7 59170.0 54056.0 55968.7 62044.1 62702.0 64107.7 14797.9 14961.9 14967.8 15064.9 15127.9 11716.5 11792.1 11820.5 11827.5 11829.9 18894.2 18916.8 18963.0 18998.7 19043.7 7149.3 7430.0 7447.3 7452.7 7463.4 940.2 946.4 960.2 1004.2 1065.9 26249.6 26755.7 27203.2 27297.7 27333.7 1052.4 1076.0 1082.4 1096.2 1101.9 13883.1 14039.2 14046.2 14064.0 14135.4 311103.0 314959.0 316561.0 316892.0 317971.0 44161.3 44906.6 46335.3 46609.3 46757.5 1321.1 1323.9 1324.3 1335.8 1349.0 25593.1 25881.9 26285.3 28182.7 28587.6 38400.4 38401.6 38513.4 42330.6 43259.0 354302.0 354775.0 355644.0 357652.0 357718.0 31963.5 32207.5 32531.5 32545.3 32546.8 42953.6 43280.8 43329.6 43494.6 44340.8 36126.6 36162.3 36164.3 36262.3 37430.4 35147.3 36012.5 36164.0 36580.6 36589.0 35687.0 36677.3 36744.3 36750.4 36753.0 29871.4 32828.5 33062.5 33189.7 33553.0 24621.6 24916.5 25053.5 25410.4 25531.0 05:13:56 INFO - PROCESS | 5994 | 05:13:56 INFO - PROCESS | 5994 | [#2] jquery.html Cycles:180 Average:27373.84 Median:4174.03 stddev:80617.81 (1931.4%) stddev-sans-first:80818.44 05:13:56 INFO - PROCESS | 5994 | Values: 355.5 359.2 359.5 362.1 363.3 13942.2 14087.5 16270.8 16580.3 17342.4 15308.7 16091.6 16419.3 16420.3 16550.4 4959.8 5069.3 5076.8 5080.3 5084.7 4113.8 4234.2 5366.6 5396.6 5870.4 5943.9 5959.8 5968.6 5977.0 5984.8 5773.0 5950.6 5954.3 5955.7 5958.9 5249.7 5253.7 5261.3 5262.2 5262.5 18600.9 20060.6 20109.4 20118.5 20750.1 2249.6 2293.5 2301.5 2359.8 2431.7 12941.5 13133.8 13199.7 13300.9 13416.7 1784.6 1831.5 1836.3 1852.4 1872.5 56641.5 59734.1 60247.7 60314.0 61442.0 9513.5 9571.9 9848.3 9857.2 9909.3 12982.2 13001.4 13009.3 13016.7 13019.4 7451.7 7468.8 7534.6 7604.7 7683.0 7427.0 7469.3 7494.7 7501.4 7549.0 5890.8 5902.4 5919.6 5951.0 5975.1 1679.5 1721.0 1735.0 1748.3 1763.9 924.8 974.4 1001.5 1028.1 1069.9 13563.4 15928.4 16445.5 17185.4 17702.3 873.6 898.2 935.2 937.7 945.9 7041.6 8994.6 9232.5 9262.5 9409.2 463181.0 473084.0 473719.0 486456.0 560410.0 78934.2 79799.0 81052.0 82536.2 83355.6 1120.9 1174.7 1179.6 1189.5 1195.8 15065.4 15158.2 15241.9 15405.8 15667.8 33975.7 34134.3 34723.7 34794.5 35189.8 46037.1 47868.5 48112.0 48175.0 49006.0 8689.0 9147.5 9180.6 9187.4 9189.9 10676.7 12454.4 16502.9 16878.0 17065.6 12243.6 13629.3 13766.7 14059.7 14276.6 9166.0 9176.6 13418.7 13455.1 13726.0 9694.5 9702.8 9792.5 10069.8 10080.9 14174.4 14200.4 14331.1 14673.3 14791.4 9359.5 9842.6 9849.7 15311.2 15422.7 05:13:56 INFO - PROCESS | 5994 | 05:13:56 INFO - PROCESS | 5994 | [#3] mootools.html Cycles:180 Average:5146.40 Median:6183.14 stddev:2552.45 (41.3%) stddev-sans-first:2543.58 05:13:56 INFO - PROCESS | 5994 | Values: 1341.4 1465.9 1467.0 1617.1 1784.1 6627.5 7141.3 7214.5 7254.6 7257.4 7107.5 7230.9 7278.4 7300.6 7311.0 2014.6 2053.6 2199.3 2304.5 2343.8 2278.3 2302.5 2303.7 2304.4 2304.8 2190.7 2263.0 2265.8 2266.4 2266.6 2238.9 2251.7 2264.4 2282.5 2287.1 2285.3 2288.9 2314.7 2328.9 2329.8 7292.5 7366.9 7374.1 7380.6 7382.6 4642.2 4669.3 4671.4 4704.2 4720.1 2994.8 3027.1 3035.2 3036.7 3147.1 992.8 995.0 1014.9 1041.2 1050.9 9948.3 10014.6 10015.3 10021.8 10022.1 4213.1 4273.3 4300.7 4341.2 4342.6 8691.2 8708.8 8709.4 8711.3 8720.1 4658.6 4698.2 4699.7 4703.2 4704.0 4326.7 4331.0 4332.2 4335.5 4336.6 3303.1 3352.0 3547.3 3548.1 3579.3 1152.6 1175.5 1177.7 1181.9 1186.2 1019.4 1020.4 1072.4 1119.7 1262.3 6593.2 6628.8 6677.6 6694.9 6736.4 1084.9 1088.5 1099.7 1105.9 1113.8 5416.8 5495.2 5517.9 5518.7 5527.6 8236.1 8286.7 8340.2 8412.1 8558.4 8301.0 8330.0 8340.7 8359.2 8420.9 6789.2 6919.7 6967.5 6979.1 6995.9 6559.0 6570.6 6586.8 6601.0 6668.0 7579.3 7667.1 7743.1 7870.7 7893.3 7578.1 7827.8 7832.8 7857.4 7993.9 6417.0 6487.8 6527.4 6541.9 6563.0 6276.6 6394.5 6517.8 6617.3 6654.2 6499.5 6563.0 6571.1 6660.1 6697.2 6456.7 6540.2 6561.4 6652.4 6657.4 6549.3 6590.9 6591.6 6596.3 6606.0 6103.4 6133.1 6140.5 6182.4 6183.9 6184.7 6190.0 6240.0 6252.1 6255.0 05:13:56 INFO - PROCESS | 5994 | 05:13:56 INFO - PROCESS | 5994 | [#4] prototype.html Cycles:180 Average:5291.52 Median:6005.37 stddev:1596.47 (26.6%) stddev-sans-first:1557.07 05:13:56 INFO - PROCESS | 5994 | Values: 339.4 339.8 347.2 350.5 353.8 5970.7 5977.8 6003.4 6007.4 6010.0 5643.0 5747.6 5856.7 5952.6 5972.9 4620.6 4621.4 4637.1 4643.6 4649.5 4401.6 4638.3 4639.8 4642.5 4651.8 4448.7 4451.4 4509.5 4526.8 4532.6 4502.9 4511.1 4513.1 4518.6 4527.2 3991.6 3995.1 3996.1 3999.7 4000.5 5520.5 5635.4 5684.5 5687.8 5690.4 5331.3 5334.9 5347.4 5348.6 5349.8 6277.0 6290.3 6293.6 6298.3 6303.3 4461.9 4463.7 4471.4 4473.5 4473.9 6348.1 6547.8 6548.7 6578.4 6594.2 4377.0 4391.0 4398.2 4400.3 4401.4 4439.7 4450.4 4453.6 4456.8 4458.7 5122.2 5141.8 5200.1 5208.7 5219.8 6101.0 6262.7 6279.7 6286.0 6290.1 1588.3 1603.7 1605.2 1608.2 1608.5 1072.5 1073.8 1076.1 1094.4 1094.9 6007.5 6020.8 6021.0 6028.9 6036.5 6466.1 6473.2 6482.6 6492.5 6500.2 5814.1 5928.4 5970.9 6061.0 6081.6 3515.2 3515.2 3527.4 3535.2 3538.1 6845.7 6846.3 6852.1 6854.5 6854.8 6596.9 6720.5 6721.0 6731.7 6734.0 6701.6 6720.2 6721.9 6726.3 6729.6 6480.7 6482.5 6484.4 6484.7 6486.7 6281.2 6478.8 6482.3 6486.5 6488.7 6804.6 6817.7 6820.2 6826.3 6830.6 4491.1 4492.2 4494.2 4494.7 4499.1 6437.9 6564.5 6567.7 6574.2 6588.2 6383.0 6386.8 6405.7 6408.2 6425.1 6395.1 6408.1 6409.2 6415.8 6418.7 6169.3 6271.2 6276.5 6287.6 6288.5 6416.8 6431.3 6435.6 6437.0 6437.9 6290.2 6297.3 6300.6 6300.7 6301.0 05:13:56 INFO - PROCESS | 5994 | 05:13:56 INFO - PROCESS | 5994 | [#5] yui.html Cycles:180 Average:13000.37 Median:43376.17 stddev:14574.15 (33.6%) stddev-sans-first:14586.13 05:13:56 INFO - PROCESS | 5994 | Values: 778.3 806.0 839.9 844.4 859.9 12983.5 13277.9 13309.7 13310.2 13312.5 12782.4 12904.2 12909.3 12911.0 12945.3 784.0 784.5 784.6 787.8 788.5 660.7 665.0 797.8 807.3 808.0 829.0 829.3 843.6 844.1 844.9 676.9 683.5 836.6 836.7 837.0 605.9 609.6 613.3 613.4 614.0 12611.4 12683.2 12721.6 12733.3 12791.6 11101.7 11370.2 11584.0 11784.8 12372.6 10355.9 10359.7 10525.2 10594.6 10969.8 3533.9 3570.2 3582.5 3588.6 3700.7 42894.8 43265.4 43368.3 43384.0 43408.0 9395.5 9536.4 9559.2 9601.0 9906.0 17901.6 18000.0 18056.5 18082.2 18106.5 7005.2 7067.6 7074.7 7081.3 7383.0 3897.9 3943.0 3976.6 3997.4 4072.4 3158.2 3189.7 3193.1 3196.5 3197.5 563.5 571.0 582.4 596.9 600.2 547.8 584.7 620.7 654.0 661.3 8175.9 8282.9 8349.0 8386.4 8434.6 594.9 649.0 655.6 657.4 706.5 3795.3 3848.5 3861.1 3862.7 3910.8 53105.7 54315.0 54441.5 54664.0 54791.0 47165.0 47335.0 48063.8 48239.8 49273.5 39008.4 39129.2 39848.2 39924.6 40264.6 8135.8 8451.8 8839.7 8845.3 8847.8 31750.4 31767.4 31794.4 33089.5 33690.7 39306.4 39505.4 39995.4 43612.0 43629.0 10729.5 10860.9 10873.0 10981.6 11171.0 11958.8 12068.8 12135.9 12542.9 12890.3 10695.8 11069.5 11084.6 11185.9 11765.9 10697.6 11066.7 11087.8 11265.9 11545.5 11039.6 11149.0 11188.9 11318.8 11670.0 9099.7 9376.3 9456.8 9472.9 9696.4 8981.2 9174.8 9229.0 9243.8 9312.4 05:13:56 INFO - PROCESS | 5994 | -------- Summary: end -------- 05:13:56 INFO - PROCESS | 5994 | 05:13:57 INFO - TEST-INFO | 5994: exit 0 05:13:57 INFO - TEST-OK | dromaeo_css | took 1113506ms 05:13:57 INFO - TEST-START | kraken 05:13:57 INFO - operating with platform_type : linux_ 05:13:57 INFO - Initialising browser for kraken test... 05:13:57 INFO - TEST-INFO | started process 6188 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppuH5Zf/profile http://localhost:55351/getInfo.html) 05:14:02 INFO - PROCESS | 6188 | __metrics Screen width/height:1600/1200 05:14:02 INFO - PROCESS | 6188 | colorDepth:24 05:14:02 INFO - PROCESS | 6188 | Browser inner width/height: 1024/697 05:14:02 INFO - PROCESS | 6188 | __metrics 05:14:02 INFO - PROCESS | 6188 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:14:02 INFO - PROCESS | 6188 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:14:03 INFO - TEST-INFO | 6188: exit 0 05:14:03 INFO - Browser initialized. 05:14:03 INFO - Running cycle 1/1 for kraken test... 05:14:03 INFO - TEST-INFO | started process 6271 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppuH5Zf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:14:14 INFO - PROCESS | 6271 | RSS: Main: 149831680 05:14:14 INFO - PROCESS | 6271 | 05:14:17 INFO - PROCESS | 6271 | Cycle 1(1): loaded http://localhost:55351/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55351/tests/kraken/driver.html?testName=audio-beat-detection) 05:14:17 INFO - PROCESS | 6271 | RSS: Main: 185806848 05:14:17 INFO - PROCESS | 6271 | 05:14:20 INFO - PROCESS | 6271 | Cycle 1(1): loaded http://localhost:55351/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55351/tests/kraken/driver.html?testName=audio-dft) 05:14:21 INFO - PROCESS | 6271 | RSS: Main: 176340992 05:14:21 INFO - PROCESS | 6271 | 05:14:24 INFO - PROCESS | 6271 | Cycle 1(1): loaded http://localhost:55351/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55351/tests/kraken/driver.html?testName=audio-fft) 05:14:24 INFO - PROCESS | 6271 | RSS: Main: 159666176 05:14:24 INFO - PROCESS | 6271 | 05:14:26 INFO - PROCESS | 6271 | Cycle 1(1): loaded http://localhost:55351/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55351/tests/kraken/driver.html?testName=audio-oscillator) 05:14:27 INFO - PROCESS | 6271 | RSS: Main: 162680832 05:14:27 INFO - PROCESS | 6271 | 05:14:29 INFO - PROCESS | 6271 | Cycle 1(1): loaded http://localhost:55351/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55351/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:14:29 INFO - PROCESS | 6271 | RSS: Main: 164814848 05:14:29 INFO - PROCESS | 6271 | 05:14:32 INFO - PROCESS | 6271 | Cycle 1(1): loaded http://localhost:55351/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55351/tests/kraken/driver.html?testName=imaging-darkroom) 05:14:33 INFO - PROCESS | 6271 | RSS: Main: 164511744 05:14:33 INFO - PROCESS | 6271 | 05:14:36 INFO - PROCESS | 6271 | Cycle 1(1): loaded http://localhost:55351/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55351/tests/kraken/driver.html?testName=imaging-desaturate) 05:14:37 INFO - PROCESS | 6271 | RSS: Main: 165388288 05:14:37 INFO - PROCESS | 6271 | 05:14:40 INFO - PROCESS | 6271 | Cycle 1(1): loaded http://localhost:55351/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55351/tests/kraken/driver.html?testName=json-parse-financial) 05:14:40 INFO - PROCESS | 6271 | RSS: Main: 166658048 05:14:40 INFO - PROCESS | 6271 | 05:14:42 INFO - PROCESS | 6271 | Cycle 1(1): loaded http://localhost:55351/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55351/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:14:42 INFO - PROCESS | 6271 | RSS: Main: 174841856 05:14:42 INFO - PROCESS | 6271 | 05:14:44 INFO - PROCESS | 6271 | Cycle 1(1): loaded http://localhost:55351/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55351/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:14:45 INFO - PROCESS | 6271 | RSS: Main: 175890432 05:14:45 INFO - PROCESS | 6271 | 05:14:47 INFO - PROCESS | 6271 | Cycle 1(1): loaded http://localhost:55351/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55351/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:14:47 INFO - PROCESS | 6271 | RSS: Main: 185552896 05:14:47 INFO - PROCESS | 6271 | 05:14:50 INFO - PROCESS | 6271 | Cycle 1(1): loaded http://localhost:55351/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55351/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:14:50 INFO - PROCESS | 6271 | RSS: Main: 193142784 05:14:50 INFO - PROCESS | 6271 | 05:14:53 INFO - PROCESS | 6271 | Cycle 1(1): loaded http://localhost:55351/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55351/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:14:54 INFO - PROCESS | 6271 | RSS: Main: 188960768 05:14:54 INFO - PROCESS | 6271 | 05:14:55 INFO - PROCESS | 6271 | Cycle 1(1): loaded http://localhost:55351/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55351/tests/kraken/driver.html?testName=ai-astar) 05:14:56 INFO - PROCESS | 6271 | RSS: Main: 246247424 05:14:56 INFO - PROCESS | 6271 | 05:14:56 INFO - PROCESS | 6271 | __start_tp_report 05:14:56 INFO - PROCESS | 6271 | _x_x_mozilla_page_load 05:14:56 INFO - PROCESS | 6271 | _x_x_mozilla_page_load_details 05:14:56 INFO - PROCESS | 6271 | |i|pagename|runs| 05:14:56 INFO - PROCESS | 6271 | |0;ai-astar;109;110;104;109;111;110;100;110;109;117 05:14:56 INFO - PROCESS | 6271 | |1;audio-beat-detection;150;127;147;163;125;150;158;124;165;124 05:14:56 INFO - PROCESS | 6271 | |2;audio-dft;161;160;161;159;162;160;158;161;164;163 05:14:56 INFO - PROCESS | 6271 | |3;audio-fft;75;73;83;95;73;72;73;101;93;72 05:14:56 INFO - PROCESS | 6271 | |4;audio-oscillator;96;96;139;95;96;96;139;96;97;135 05:14:56 INFO - PROCESS | 6271 | |5;imaging-gaussian-blur;110;109;109;109;109;109;110;109;110;110 05:14:56 INFO - PROCESS | 6271 | |6;imaging-darkroom;146;145;146;145;145;146;146;145;145;147 05:14:56 INFO - PROCESS | 6271 | |7;imaging-desaturate;95;95;95;96;95;95;96;95;96;96 05:14:56 INFO - PROCESS | 6271 | |8;json-parse-financial;57;57;57;57;57;57;59;66;55;55 05:14:56 INFO - PROCESS | 6271 | |9;json-stringify-tinderbox;66;67;68;67;68;69;68;67;67;67 05:14:56 INFO - PROCESS | 6271 | |10;stanford-crypto-aes;86;92;87;93;86;85;86;85;85;87 05:14:56 INFO - PROCESS | 6271 | |11;stanford-crypto-ccm;134;121;124;115;123;119;123;117;118;117 05:14:56 INFO - PROCESS | 6271 | |12;stanford-crypto-pbkdf2;156;145;156;153;146;146;154;153;161;146 05:14:56 INFO - PROCESS | 6271 | |13;stanford-crypto-sha256-iterative;69;68;70;71;70;68;67;71;68;73 05:14:56 INFO - PROCESS | 6271 | __end_tp_report 05:14:56 INFO - PROCESS | 6271 | __start_cc_report 05:14:56 INFO - PROCESS | 6271 | _x_x_mozilla_cycle_collect,916 05:14:56 INFO - PROCESS | 6271 | __end_cc_report 05:14:56 INFO - PROCESS | 6271 | __startTimestamp1451913296044__endTimestamp 05:14:56 INFO - PROCESS | 6271 | 05:14:56 INFO - PROCESS | 6271 | ------- Summary: start ------- 05:14:56 INFO - PROCESS | 6271 | Number of tests: 14 05:14:56 INFO - PROCESS | 6271 | 05:14:56 INFO - PROCESS | 6271 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:4.43 (4.0%) stddev-sans-first:4.70 05:14:56 INFO - PROCESS | 6271 | Values: 109.0 110.0 104.0 109.0 111.0 110.0 100.0 110.0 109.0 117.0 05:14:56 INFO - PROCESS | 6271 | 05:14:56 INFO - PROCESS | 6271 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:150.00 stddev:16.75 (11.2%) stddev-sans-first:17.59 05:14:56 INFO - PROCESS | 6271 | Values: 150.0 127.0 147.0 163.0 125.0 150.0 158.0 124.0 165.0 124.0 05:14:56 INFO - PROCESS | 6271 | 05:14:56 INFO - PROCESS | 6271 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.79 (1.1%) stddev-sans-first:1.90 05:14:56 INFO - PROCESS | 6271 | Values: 161.0 160.0 161.0 159.0 162.0 160.0 158.0 161.0 164.0 163.0 05:14:56 INFO - PROCESS | 6271 | 05:14:56 INFO - PROCESS | 6271 | [#3] audio-fft Cycles:10 Average:81.00 Median:74.00 stddev:11.22 (15.2%) stddev-sans-first:11.69 05:14:56 INFO - PROCESS | 6271 | Values: 75.0 73.0 83.0 95.0 73.0 72.0 73.0 101.0 93.0 72.0 05:14:56 INFO - PROCESS | 6271 | 05:14:56 INFO - PROCESS | 6271 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:96.00 stddev:20.16 (21.0%) stddev-sans-first:20.87 05:14:56 INFO - PROCESS | 6271 | Values: 96.0 96.0 139.0 95.0 96.0 96.0 139.0 96.0 97.0 135.0 05:14:56 INFO - PROCESS | 6271 | 05:14:56 INFO - PROCESS | 6271 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:14:56 INFO - PROCESS | 6271 | Values: 110.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 110.0 05:14:56 INFO - PROCESS | 6271 | 05:14:56 INFO - PROCESS | 6271 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 05:14:56 INFO - PROCESS | 6271 | Values: 146.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 145.0 147.0 05:14:56 INFO - PROCESS | 6271 | 05:14:56 INFO - PROCESS | 6271 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:14:56 INFO - PROCESS | 6271 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 05:14:56 INFO - PROCESS | 6271 | 05:14:56 INFO - PROCESS | 6271 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:3.13 (5.5%) stddev-sans-first:3.31 05:14:56 INFO - PROCESS | 6271 | Values: 57.0 57.0 57.0 57.0 57.0 57.0 59.0 66.0 55.0 55.0 05:14:56 INFO - PROCESS | 6271 | 05:14:56 INFO - PROCESS | 6271 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.84 (1.2%) stddev-sans-first:0.73 05:14:56 INFO - PROCESS | 6271 | Values: 66.0 67.0 68.0 67.0 68.0 69.0 68.0 67.0 67.0 67.0 05:14:56 INFO - PROCESS | 6271 | 05:14:56 INFO - PROCESS | 6271 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:86.50 stddev:2.90 (3.4%) stddev-sans-first:3.04 05:14:56 INFO - PROCESS | 6271 | Values: 86.0 92.0 87.0 93.0 86.0 85.0 86.0 85.0 85.0 87.0 05:14:56 INFO - PROCESS | 6271 | 05:14:56 INFO - PROCESS | 6271 | [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:122.00 stddev:5.45 (4.5%) stddev-sans-first:3.20 05:14:56 INFO - PROCESS | 6271 | Values: 134.0 121.0 124.0 115.0 123.0 119.0 123.0 117.0 118.0 117.0 05:14:56 INFO - PROCESS | 6271 | 05:14:56 INFO - PROCESS | 6271 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.60 Median:153.50 stddev:5.52 (3.6%) stddev-sans-first:5.62 05:14:56 INFO - PROCESS | 6271 | Values: 156.0 145.0 156.0 153.0 146.0 146.0 154.0 153.0 161.0 146.0 05:14:56 INFO - PROCESS | 6271 | 05:14:56 INFO - PROCESS | 6271 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:1.84 (2.6%) stddev-sans-first:1.94 05:14:56 INFO - PROCESS | 6271 | Values: 69.0 68.0 70.0 71.0 70.0 68.0 67.0 71.0 68.0 73.0 05:14:56 INFO - PROCESS | 6271 | -------- Summary: end -------- 05:14:56 INFO - PROCESS | 6271 | 05:14:56 INFO - TEST-INFO | 6271: exit 0 05:14:56 INFO - TEST-OK | kraken | took 59385ms 05:14:56 INFO - TEST-START | v8_7 05:14:56 INFO - operating with platform_type : linux_ 05:14:56 INFO - Initialising browser for v8_7 test... 05:14:56 INFO - TEST-INFO | started process 6518 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8zFA6S/profile http://localhost:55351/getInfo.html) 05:15:01 INFO - PROCESS | 6518 | __metrics Screen width/height:1600/1200 05:15:01 INFO - PROCESS | 6518 | colorDepth:24 05:15:01 INFO - PROCESS | 6518 | Browser inner width/height: 1024/697 05:15:01 INFO - PROCESS | 6518 | __metrics 05:15:01 INFO - PROCESS | 6518 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:15:01 INFO - PROCESS | 6518 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:15:02 INFO - TEST-INFO | 6518: exit 0 05:15:02 INFO - Browser initialized. 05:15:02 INFO - Running cycle 1/1 for v8_7 test... 05:15:02 INFO - TEST-INFO | started process 6603 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8zFA6S/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:14 INFO - PROCESS | 6603 | RSS: Main: 149745664 05:15:14 INFO - PROCESS | 6603 | 05:15:35 INFO - PROCESS | 6603 | Cycle 1(1): loaded http://localhost:55351/tests/v8_7/run.html (next: http://localhost:55351/tests/v8_7/run.html) 05:15:35 INFO - PROCESS | 6603 | RSS: Main: 612708352 05:15:35 INFO - PROCESS | 6603 | 05:15:35 INFO - PROCESS | 6603 | __start_tp_report 05:15:35 INFO - PROCESS | 6603 | _x_x_mozilla_page_load 05:15:35 INFO - PROCESS | 6603 | _x_x_mozilla_page_load_details 05:15:35 INFO - PROCESS | 6603 | |i|pagename|runs| 05:15:35 INFO - PROCESS | 6603 | |0;Richards;166.91704223001167 05:15:35 INFO - PROCESS | 6603 | |1;DeltaBlue;191.0219675262655 05:15:35 INFO - PROCESS | 6603 | |2;Encrypt;280.8988764044944 05:15:35 INFO - PROCESS | 6603 | |3;Decrypt;5256.544502617801 05:15:35 INFO - PROCESS | 6603 | |4;RayTrace;1990.0596421471173 05:15:35 INFO - PROCESS | 6603 | |5;Earley;803.8585209003215 05:15:35 INFO - PROCESS | 6603 | |6;Boyer;12207.317073170732 05:15:35 INFO - PROCESS | 6603 | |7;RegExp;25846.153846153848 05:15:35 INFO - PROCESS | 6603 | |8;Splay;677.3977196512408 05:15:35 INFO - PROCESS | 6603 | |9;NavierStokes;4826.923076923077 05:15:35 INFO - PROCESS | 6603 | __end_tp_report 05:15:35 INFO - PROCESS | 6603 | __startTimestamp1451913335834__endTimestamp 05:15:35 INFO - PROCESS | 6603 | 05:15:35 INFO - PROCESS | 6603 | ------- Summary: start ------- 05:15:35 INFO - PROCESS | 6603 | Number of tests: 10 05:15:35 INFO - PROCESS | 6603 | 05:15:35 INFO - PROCESS | 6603 | [#0] Richards Cycles:1 Average:166.92 Median:166.92 stddev:0.00 (0.0%) 05:15:35 INFO - PROCESS | 6603 | Values: 166.9 05:15:35 INFO - PROCESS | 6603 | 05:15:35 INFO - PROCESS | 6603 | [#1] DeltaBlue Cycles:1 Average:191.02 Median:191.02 stddev:0.00 (0.0%) 05:15:35 INFO - PROCESS | 6603 | Values: 191.0 05:15:35 INFO - PROCESS | 6603 | 05:15:35 INFO - PROCESS | 6603 | [#2] Encrypt Cycles:1 Average:280.90 Median:280.90 stddev:0.00 (0.0%) 05:15:35 INFO - PROCESS | 6603 | Values: 280.9 05:15:35 INFO - PROCESS | 6603 | 05:15:35 INFO - PROCESS | 6603 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 05:15:35 INFO - PROCESS | 6603 | Values: 5256.5 05:15:35 INFO - PROCESS | 6603 | 05:15:35 INFO - PROCESS | 6603 | [#4] RayTrace Cycles:1 Average:1990.06 Median:1990.06 stddev:0.00 (0.0%) 05:15:35 INFO - PROCESS | 6603 | Values: 1990.1 05:15:35 INFO - PROCESS | 6603 | 05:15:35 INFO - PROCESS | 6603 | [#5] Earley Cycles:1 Average:803.86 Median:803.86 stddev:0.00 (0.0%) 05:15:35 INFO - PROCESS | 6603 | Values: 803.9 05:15:35 INFO - PROCESS | 6603 | 05:15:35 INFO - PROCESS | 6603 | [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 05:15:35 INFO - PROCESS | 6603 | Values: 12207.3 05:15:35 INFO - PROCESS | 6603 | 05:15:35 INFO - PROCESS | 6603 | [#7] RegExp Cycles:1 Average:25846.15 Median:25846.15 stddev:0.00 (0.0%) 05:15:35 INFO - PROCESS | 6603 | Values: 25846.2 05:15:35 INFO - PROCESS | 6603 | 05:15:35 INFO - PROCESS | 6603 | [#8] Splay Cycles:1 Average:677.40 Median:677.40 stddev:0.00 (0.0%) 05:15:35 INFO - PROCESS | 6603 | Values: 677.4 05:15:35 INFO - PROCESS | 6603 | 05:15:35 INFO - PROCESS | 6603 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 05:15:35 INFO - PROCESS | 6603 | Values: 4826.9 05:15:35 INFO - PROCESS | 6603 | -------- Summary: end -------- 05:15:35 INFO - PROCESS | 6603 | 05:15:36 INFO - TEST-INFO | 6603: exit 0 05:15:36 INFO - TEST-OK | v8_7 | took 39756ms 05:15:36 INFO - SUITE-END | took 1212s 05:15:36 INFO - Completed test suite (00:20:12) 05:15:36 INFO - Working with test: dromaeo_css 05:15:36 INFO - Generating results file: dromaeo_css 05:15:36 INFO - Working with test: kraken 05:15:36 INFO - Generating results file: kraken 05:15:36 INFO - javascript benchmark 05:15:36 INFO - Working with test: v8_7 05:15:36 INFO - Generating results file: v8_7 05:15:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:15:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 05:15:36 INFO - process_Request line: dromaeo_css 6902.45 graph.html#tests=[[72,201,35]] 05:15:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:15:37 INFO - process_Request line: kraken 1507.50 graph.html#tests=[[232,201,35]] 05:15:37 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:15:37 INFO - process_Request line: v8_7 19514.97 graph.html#tests=[[230,201,35]] 05:15:37 INFO - RETURN: dromaeo_css: 6902.45 05:15:37 INFO - RETURN: kraken: 1507.50 05:15:37 INFO - RETURN: v8_7: 19514.97 05:15:37 INFO - javascript benchmark 05:15:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3122.0789866989235, 3165.5568220449154, 3216.9866492055003, 3217.7908435951663, 3234.9838250808743, 5282.788688452457, 5358.41057483677, 5361.356637203531, 5400.594955378343, 5428.104362780142, 5269.235960785693, 5323.547498462625, 5347.973260133704, 5350.5184533391985, 5423.078076726956, 4792.257200133985, 4871.464138944713, 4874.195757699993, 4921.163402221613, 4956.653034287601, 4942.357493525837, 4963.950360496385, 5015.974920125394, 5037.722925239111, 5041.59667226621, 4829.9275510867365, 4984.526469985346, 4986.825461108844, 5059.2916991621205, 5074.112030394685, 4848.0788650156355, 4921.458639549646, 4928.802847886081, 4942.654014219006, 4967.925481117786, 4874.147024270738, 4877.1984001673745, 4879.512048795092, 4896.216605343128, 4915.115279249733, 5158.793648254103, 5216.2958000669805, 5231.659942103751, 5253.4221235664045, 5263.315768950012, 5642.492175704207, 5786.305643322786, 5796.043652797283, 5829.621074630178, 5867.794627188028, 5829.242198514208, 5836.970815145897, 5843.561732870009, 5843.766249350021, 5850.385709500484, 5316.680999140064, 5428.647137936022, 5439.83680489582, 5446.400895901447, 5453.863653408657, 5865.736041878125, 5910.231669882888, 5924.348321684612, 5949.613275137102, 5976.043832986701, 5690.3456102548735, 5692.459216374438, 5693.658380497183, 5694.686792226467, 5701.4013528579735, 5656.971715141398, 5724.227229324071, 5761.251037365116, 5778.3354914184565, 5792.9710351447975, 5736.627119237236, 5791.536677065825, 5793.246877905845, 5795.159701843209, 5824.446677565625, 5758.481736643638, 5819.301683797887, 5820.82537523875, 5822.417758224228, 5824.621399609096, 4361.760103194355, 4447.2439685253585, 4457.9331310030375, 4478.820847166142, 4520.50274469808, 3953.2686453006286, 3969.285528604879, 3970.841166353371, 3987.960120398817, 3991.7604943703473, 5371.006363822706, 5373.408925018245, 5376.489233522809, 5376.946230537645, 5429.701366424884, 5605.523530499953, 5739.71301434935, 5744.310682718101, 5748.913766293509, 5789.363170051291, 5350.91973620396, 5383.515483606416, 5398.271233383522, 5402.783888644489, 5425.701586412706, 4906.288588154697, 4906.533879281463, 4909.165441874889, 4910.484399138039, 4950.975245123751, 5716.228309178291, 5897.085951677497, 5984.581079324405, 5994.730237139339, 6004.639721616717, 5639.210510528611, 5721.914171287517, 5836.124581312837, 5846.152307915413, 5884.411558844253, 6069.423404776539, 6071.939280607314, 6074.969625152023, 6076.240469941257, 6080.148779171008, 5599.412061733459, 5716.657000579812, 5739.770409183586, 5740.0815869460685, 5741.8564535886935, 5663.745131469176, 5786.537077033911, 5881.382454842351, 5891.821635672968, 5911.054231322968, 5693.572982026448, 5700.144978253129, 5710.486056254957, 5717.371089180104, 5720.227769251098, 5544.500994910478, 5678.829635110953, 5687.914681279702, 5690.658560486384, 5691.800786972436, 5364.061289274439, 5492.944501363654, 5532.0595498766115, 5534.806281780118, 5539.113741801292, 5681.9431805681415, 5692.203091567267, 5692.544596432358, 5694.1458781183155, 5695.889301586151, 5539.41836107219, 5571.916421253603, 5583.916241256466, 5585.106382978704, 5589.189567512769], "unit": "score", "name": "dojo.html", "value": 5326.897637162083}, {"lowerIsBetter": false, "replicates": [526.8761840967375, 554.9223108764771, 573.5012058717409, 591.0985746736227, 617.1452538234545, 28344.716552834467, 35333.46999795002, 36378.27243455129, 36399.818000910025, 36466.63533364666, 38188.618113818855, 38410.23179536415, 38634.420483692695, 38716.0, 38754.0, 7449.8510029799645, 7543.170251272356, 8505.31957443403, 8616.569171541429, 8681.913180868174, 10089.848652270186, 10300.12448941841, 10346.586136554528, 10347.068763811256, 10356.17150627948, 10013.749656258578, 10051.195904327673, 10060.74848128799, 10114.54484548197, 10120.645777397756, 7653.387728981668, 7827.726029588994, 7830.647620857075, 7841.764747057598, 10019.248556358265, 10085.89914100857, 10363.63727269542, 10364.37813731171, 10367.896321036844, 10373.89626103737, 36040.819795900854, 36143.81928090343, 36485.0, 36489.452658210146, 36517.81741091304, 3140.7487401008093, 3269.7711160218796, 3532.2229109595846, 3631.0014745944814, 3919.8432062717457, 28326.858365708038, 29490.410191796258, 29622.25944351387, 30034.24914377136, 30703.846480767676, 3852.348257069206, 3900.4149377593303, 3919.9216015679813, 3938.960610393888, 4038.2125485530332, 266453.0, 268055.0, 268371.65814171, 268837.0, 269495.0, 58542.707286463294, 59049.40950590439, 59065.70467147637, 59120.704396478606, 59170.0, 54056.0, 55968.72015639977, 62044.069338959955, 62702.0, 64107.67946160239, 14797.92601036988, 14961.850381496264, 14967.775483367759, 15064.924675376553, 15127.924360378347, 11716.531338746354, 11792.056635469142, 11820.468078936468, 11827.467763950643, 11829.88170118305, 18894.244230230637, 18916.81083189178, 18963.0, 18998.71501927472, 19043.714344284846, 7149.320814522612, 7430.0, 7447.292507211806, 7452.701891924371, 7463.365613922877, 940.2243149401634, 946.3706635087727, 960.2078285414422, 1004.1866088468219, 1065.8827528971806, 26249.606255906176, 26755.732442675715, 27203.183904482896, 27297.727022729916, 27333.726662733516, 1052.4369462337613, 1075.9569617215225, 1082.442542090824, 1096.2435919215716, 1101.944902754859, 13883.097598656055, 14039.157650541, 14046.227457489731, 14064.0, 14135.363908623931, 311103.0, 314959.0, 316561.0, 316892.0, 317971.0, 44161.33757993633, 44906.55093449089, 46335.3049704248, 46609.30086048712, 46757.532424676, 1321.062045947388, 1323.8543760186371, 1324.265032906746, 1335.779596366608, 1348.966275843092, 25593.104241351462, 25881.87059064768, 26285.272132969116, 28182.71817281883, 28587.571186431804, 38400.423993640674, 38401.6159838398, 38513.422298664984, 42330.576694233896, 43259.0, 354302.0, 354775.0, 355644.0, 357652.0, 357718.0, 31963.520547191347, 32207.516887246242, 32531.51202732008, 32545.34909301848, 32546.83726581352, 42953.57046429496, 43280.78359608182, 43329.56670433255, 43494.565054350314, 44340.778296108314, 36126.63873361338, 36162.27675446529, 36164.276714465035, 36262.27475450424, 37430.438543421325, 35147.29705405929, 36012.4598131023, 36164.0, 36580.63419365772, 36589.0, 35687.0, 36677.26645467129, 36744.265114697024, 36750.44874326834, 36753.0, 29871.402571948875, 32828.507572385955, 33062.5040624386, 33189.668103318654, 33553.0, 24621.63067554024, 24916.501669966863, 25053.498930020934, 25410.364740881625, 25531.0], "unit": "score", "name": "ext.html", "value": 18356.112778970928}, {"lowerIsBetter": false, "replicates": [355.5182727404367, 359.1918184085807, 359.54158447978824, 362.08212182118336, 363.29702026578553, 13942.23317717525, 14087.506937257198, 16270.83729162708, 16580.33678652854, 17342.393016244434, 15308.69382612347, 16091.597710057255, 16419.261133249, 16420.261088251027, 16550.420735274267, 4959.752012399384, 5069.340985671857, 5076.796928122871, 5080.288759573663, 5084.694918304895, 4113.8354465821485, 4234.21666991606, 5366.597505187107, 5396.64921780083, 5870.442307980735, 5943.900378430004, 5959.821205363846, 5968.582199246054, 5976.970115149418, 5984.820455386345, 5772.971135144318, 5950.5834591578605, 5954.31525374581, 5955.731992060368, 5958.940410595882, 5249.7112658804135, 5253.737313134328, 5261.263423120766, 5262.210668399733, 5262.500062494057, 18600.906995465073, 20060.598788024305, 20109.39671809848, 20118.49703757403, 20750.06624701892, 2249.550089981994, 2293.4610366563843, 2301.4821665125382, 2359.823013273994, 2431.6960379952507, 12941.54704585335, 13133.802992955114, 13199.736005279936, 13300.866991330156, 13416.664583385396, 1784.5984653453, 1831.542114471382, 1836.32056139228, 1852.4257480181186, 1872.485066606694, 56641.484030219, 59734.103988440205, 60247.69876150591, 60314.0, 61442.0, 9513.476758778334, 9571.904280957102, 9848.310618256653, 9857.162141218078, 9909.306348555676, 12982.15615984958, 13001.414936327888, 13009.349532523336, 13016.674583135497, 13019.414126364336, 7451.739189128354, 7468.775936721907, 7534.623268836536, 7604.733834315883, 7682.96158519215, 7427.0, 7469.290417410337, 7494.6627401767055, 7501.399888009056, 7549.0, 5890.764369425175, 5902.4097590240635, 5919.644821310649, 5951.0, 5975.133605627159, 1679.4541773923524, 1721.0362197169625, 1734.9826501735074, 1748.2744660965557, 1763.9029853357931, 924.7549399409162, 974.3763991045737, 1001.5493028137367, 1028.0747327405245, 1069.919756018286, 13563.389647465889, 15928.442504512519, 16445.506634800975, 17185.39851105205, 17702.29190832352, 873.6112429968603, 898.1871406377239, 935.2004036548789, 937.6530683647094, 945.9054094590623, 7041.647917604099, 8994.550272486349, 9232.492212928353, 9262.536873156316, 9409.153176214173, 463181.0, 473084.0, 473719.0, 486456.0, 560410.0, 78934.21065789384, 79799.0, 81052.0, 82536.17463825404, 83355.5832220835, 1120.9159313051555, 1174.682835634391, 1179.6107284596062, 1189.4723712111763, 1195.7608478304373, 15065.397384104514, 15158.16630085356, 15241.923790380977, 15405.845941540889, 15667.764983525483, 33975.66024339725, 34134.317313654086, 34723.65276347204, 34794.478082829286, 35189.82405087958, 46037.07925841532, 47868.521314786405, 48112.03775924532, 48175.0, 49006.0, 8688.956555217184, 9147.542622868697, 9180.632774688938, 9187.356885017985, 9189.88632614489, 10676.679699609023, 12454.439550220442, 16502.917485412498, 16878.0, 17065.573360666083, 12243.632691019284, 13629.318534073058, 13766.724665506434, 14059.718805624036, 14276.643083922985, 9165.954170229374, 9176.58705358247, 13418.664533386744, 13455.125416847874, 13726.0, 9694.46680432583, 9702.75743106428, 9792.51037448139, 10069.798604027732, 10080.941501142275, 14174.433022678977, 14200.366505927264, 14331.06848054873, 14673.339699713326, 14791.408343666133, 9359.532023398939, 9842.60629574809, 9849.704508864745, 15311.234438278265, 15422.69154616879], "unit": "score", "name": "jquery.html", "value": 8841.415514940898}, {"lowerIsBetter": false, "replicates": [1341.4097796969338, 1465.853414658534, 1467.0390893964454, 1617.1348328644178, 1784.072282413145, 6627.469802415807, 7141.2501687322865, 7214.494985351028, 7254.600996945166, 7257.3831224345995, 7107.502474826764, 7230.9276907230915, 7278.417726581874, 7300.561966282027, 7310.963445182767, 2014.63736527425, 2053.5995480881234, 2199.3401979406194, 2304.493011537463, 2343.7773411525964, 2278.327893271489, 2302.481941563152, 2303.67748515208, 2304.4008557774932, 2304.8156147508157, 2190.6823510590953, 2263.0495192019393, 2265.762094980028, 2266.410733209369, 2266.648669456237, 2238.888055597222, 2251.684764133023, 2264.399934017487, 2282.5092605089985, 2287.1080278691325, 2285.337252196861, 2288.8626682398944, 2314.6875171851752, 2328.906843726249, 2329.825263105257, 7292.489525733201, 7366.889496657554, 7374.078240219973, 7380.63096845161, 7382.593957332345, 4642.187617166982, 4669.276262179367, 4671.392718946515, 4704.223803072523, 4720.079584481027, 2994.82031078136, 3027.091872438282, 3035.2260173655795, 3036.7418769404626, 3147.087344670043, 992.8014397120533, 995.0, 1014.9188064954786, 1041.1930753665895, 1050.9054185123375, 9948.253880958884, 10014.599416023277, 10015.298929074968, 10021.79956400868, 10022.098011178956, 4213.115245798355, 4273.294906340419, 4300.720453170597, 4341.175176716414, 4342.5657434256955, 8691.217790398894, 8708.78228044304, 8709.433886797338, 8711.34664900135, 8720.127987201357, 4658.627309815207, 4698.2247929092, 4699.718016918996, 4703.176944034849, 4704.0, 4326.697131200785, 4331.025519258142, 4332.155229730172, 4335.458067741532, 4336.588024137702, 3303.0586282909258, 3352.0, 3547.343741407848, 3548.1484443733316, 3579.266250418658, 1152.567787079845, 1175.506287359311, 1177.7350096228452, 1181.9172657914035, 1186.1519013904926, 1019.4342140112161, 1020.3928662445833, 1072.4048153275007, 1119.7368618374676, 1262.3498898067503, 6593.2088149421415, 6628.767993120217, 6677.565958212701, 6694.933050669529, 6736.393724564715, 1084.8589683341115, 1088.472091035847, 1099.7360633447915, 1105.9004689577976, 1113.8106521891298, 5416.756245968941, 5495.175723641486, 5517.889642207133, 5518.724063796794, 5527.585431092603, 8236.094029656733, 8286.70996515119, 8340.165983401612, 8412.074671786098, 8558.400911936229, 8301.0, 8330.000399952045, 8340.666373345119, 8359.164083591591, 8420.873686894702, 6789.15135608049, 6919.688614012281, 6967.477439192081, 6979.127609048869, 6995.8950615740805, 6559.0, 6570.5729127606555, 6586.8353291168105, 6601.0, 6667.966660166668, 7579.317861392501, 7667.079950405987, 7743.109542402696, 7870.72452464161, 7893.250141236574, 7578.09062912454, 7827.765167044998, 7832.84334313322, 7857.410694198073, 7993.880091798512, 6417.0, 6487.805365839033, 6527.412532872065, 6541.8691626168165, 6563.0, 6276.592021518587, 6394.520410969289, 6517.804465866032, 6617.305182955721, 6654.168228971379, 6499.545031847914, 6562.967185164043, 6571.080048793077, 6660.10088638047, 6697.162854643169, 6456.709448074754, 6540.247871494839, 6561.40947314744, 6652.434543063894, 6657.40083392497, 6549.345065493412, 6590.90113648286, 6591.571547849375, 6596.30738772422, 6605.976073708583, 6103.389661033861, 6133.110698948717, 6140.5394595406415, 6182.381761823782, 6183.907241391473, 6184.690765461799, 6190.0, 6240.0, 6252.062190671436, 6254.9687251563455], "unit": "score", "name": "mootools.html", "value": 4295.16445298253}, {"lowerIsBetter": false, "replicates": [339.3823241700105, 339.8148009334912, 347.22048999995013, 350.45329286313347, 353.8195520284654, 5970.701464926758, 5977.790777322794, 6003.369646187148, 6007.3692262312425, 6009.969950150254, 5643.0, 5747.563109222694, 5856.707164641762, 5952.5535584831205, 5972.880542389161, 4620.561046700558, 4621.4223222097235, 4637.1189474, 4643.582077613014, 4649.488556258817, 4401.625861801735, 4638.281066434708, 4639.791209395568, 4642.512536183703, 4651.837185698484, 4448.6885917985755, 4451.354553589727, 4509.481409637884, 4526.75102869342, 4532.56940590645, 4502.8874278142985, 4511.052678937427, 4513.074819661962, 4518.638508919278, 4527.185106680796, 3991.5808840071954, 3995.081131339779, 3996.080901392696, 3999.6800255979742, 4000.5399379071196, 5520.530754885839, 5635.436456354373, 5684.488396044376, 5687.772489100473, 5690.374058853523, 5331.253624492574, 5334.866628334284, 5347.358317001946, 5348.572114230852, 5349.759260833272, 6276.968615156895, 6290.339514350973, 6293.622382657055, 6298.2756982947085, 6303.338149494283, 4461.933071003938, 4463.732176069414, 4471.35165401015, 4473.507914129443, 4473.932891006638, 6348.111264422984, 6547.836304092388, 6548.70530826114, 6578.375054369827, 6594.208694956588, 4376.956230437719, 4391.0, 4398.186335527937, 4400.273954797487, 4401.427814384109, 4439.733615983051, 4450.443694538183, 4453.576910193527, 4456.7548784817145, 4458.665600080007, 5122.206058061007, 5141.794328226829, 5200.063988482034, 5208.661437006583, 5219.765110570033, 6100.969495152496, 6262.655553944485, 6279.748810047547, 6285.968570157212, 6290.056491526216, 1588.3329001819263, 1603.6712473942814, 1605.1813575076794, 1608.1959020489755, 1608.4772448953902, 1072.4905669806935, 1073.7906108308805, 1076.0638244727138, 1094.414488248783, 1094.934303941766, 6007.459328660441, 6020.819375418744, 6021.036634138517, 6028.8794224116145, 6036.456718895321, 6466.1270728452, 6473.2232132144445, 6482.611043337415, 6492.5455218134275, 6500.219973603198, 5814.069748840166, 5928.407159284037, 5970.880582388328, 6060.969695151496, 6081.5742897996715, 3515.1739341254784, 3515.20907795749, 3527.400341941876, 3535.1515636247113, 3538.115471132217, 6845.726170953206, 6846.315368463114, 6852.109225800614, 6854.451643868479, 6854.828629284208, 6596.934030659728, 6720.462363010947, 6720.9663951680905, 6731.730730770714, 6733.966330168416, 6701.564398314192, 6720.22717387497, 6721.932780672229, 6726.260111387744, 6729.596224226464, 6480.708368123352, 6482.513811464253, 6484.351564843667, 6484.675766211576, 6486.740530378732, 6281.152044473937, 6478.805635830932, 6482.254540727877, 6486.481081513562, 6488.70800813974, 6804.557703749439, 6817.727290908507, 6820.249772524919, 6826.283240259701, 6830.556013859084, 4491.101779644019, 4492.236319825703, 4494.235979883493, 4494.685372023927, 4499.122671079239, 6437.903431448625, 6564.5076619252795, 6567.704453299709, 6574.178227721535, 6588.176477940257, 6382.968085159545, 6386.808395748135, 6405.743770249138, 6408.166938298178, 6425.1004859320665, 6395.136656551306, 6408.1349017881985, 6409.198850143732, 6415.807525774234, 6418.743250270124, 6169.321374648875, 6271.247450305992, 6276.529260305587, 6287.622742635456, 6288.496920246461, 6416.7754128605275, 6431.324710905287, 6435.613863168225, 6437.034444833313, 6437.871242575028, 6290.150829637941, 6297.307296197323, 6300.621962682254, 6300.716467759054, 6300.9684951574945], "unit": "score", "name": "prototype.html", "value": 4776.8641878343105}, {"lowerIsBetter": false, "replicates": [778.2684276779825, 806.0287353738744, 839.9244068033884, 844.370943646983, 859.9355048371369, 12983.545575904833, 13277.933610331947, 13309.667258318523, 13310.201387916708, 13312.467501299936, 12782.42479088441, 12904.161229520074, 12909.289989050598, 12911.031672624567, 12945.288009159493, 784.019975031211, 784.4822417204646, 784.5841703896943, 787.763670898731, 788.4874831359633, 660.7291010685595, 664.950128740344, 797.8444203380343, 807.3460496997421, 808.0424696734359, 828.958552072397, 829.3323874281201, 843.6330196364601, 844.0546587821648, 844.932405407566, 676.908617336663, 683.5010442377043, 836.5817091454303, 836.6695155413638, 837.0374069819726, 605.9121427393003, 609.6189881324173, 613.328405396095, 613.3712944232153, 614.0022463496817, 12611.432485538173, 12683.239005659598, 12721.618351449379, 12733.299668518228, 12791.5522956697, 11101.666949991513, 11370.204085714004, 11584.015358694436, 11784.764304713943, 12372.566960156351, 10355.94822025885, 10359.741006474824, 10525.157987360994, 10594.62918797846, 10969.83545246822, 3533.876314328986, 3570.1788588624504, 3582.5163602913794, 3588.623194564559, 3700.6854417374557, 42894.78552607217, 43265.35101973473, 43368.3494747579, 43384.0, 43408.0, 9395.483248421402, 9536.427814331162, 9559.235261179228, 9601.0, 9905.950470247746, 17901.552461188316, 18000.0, 18056.45830625083, 18082.186301616457, 18106.45680629583, 7005.1944026436595, 7067.611281379471, 7074.71701131949, 7081.291870812981, 7383.0, 3897.922041559153, 3942.980285098556, 3976.642102210757, 3997.4403583498333, 4072.429859819628, 3158.210447388153, 3189.728873045771, 3193.0899693587216, 3196.5205219217305, 3197.4724170512072, 563.456264704562, 571.0492030768806, 582.4466756581264, 596.8746563221686, 600.207725801946, 547.7644612816528, 584.713490389706, 620.6803496199461, 653.9901901471482, 661.3023260460164, 8175.877361839577, 8282.917170828336, 8349.0, 8386.412951093487, 8434.57827108642, 594.9464548190683, 648.9675516224264, 655.5574986883835, 657.3525077798365, 706.523096909584, 3795.3168429682923, 3848.461215429842, 3861.092643228839, 3862.667335097094, 3910.8044597770568, 53105.7344713274, 54315.0, 54441.45558544443, 54664.0, 54791.0, 47165.0, 47335.0, 48063.75968120137, 48239.75880120577, 49273.50726492761, 39008.414873776914, 39129.2174156521, 39848.20303593912, 39924.60075399209, 40264.59735402608, 8135.75592732219, 8451.8155622476, 8839.734807955772, 8845.336599754915, 8847.778805529913, 31750.364992700477, 31767.364652707278, 31794.364112718078, 33089.50365744564, 33690.663093368756, 39306.410403843394, 39505.407418888164, 39995.40006899841, 43612.0, 43629.0, 10729.517171727135, 10860.891391085988, 10873.0, 10981.61564345244, 11171.0, 11958.820617690915, 12068.785722443876, 12135.939320303341, 12542.937285313516, 12890.29103399322, 10695.786084278116, 11069.5018724156, 11084.61203857861, 11185.944070279596, 11765.941170294094, 10697.572097116028, 11066.723331916766, 11087.778244434905, 11265.943670281924, 11545.538178472767, 11039.613613523488, 11149.0, 11188.888111118784, 11318.830217546578, 11670.0, 9099.66919324872, 9376.29677774156, 9456.763580910532, 9472.905270947202, 9696.369735967139, 8981.191692747683, 9174.770630734018, 9229.0, 9243.768399418093, 9312.44125352481], "unit": "score", "name": "yui.html", "value": 6096.517690652589}], "name": "dromaeo_css", "value": 6902.45485395792}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 109.0, 111.0, 110.0, 100.0, 110.0, 109.0, 117.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [150.0, 127.0, 147.0, 163.0, 125.0, 150.0, 158.0, 124.0, 165.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 159.0, 162.0, 160.0, 158.0, 161.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 83.0, 95.0, 73.0, 72.0, 73.0, 101.0, 93.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 139.0, 95.0, 96.0, 96.0, 139.0, 96.0, 97.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 59.0, 66.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 68.0, 67.0, 68.0, 69.0, 68.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [86.0, 92.0, 87.0, 93.0, 86.0, 85.0, 86.0, 85.0, 85.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.2}, {"lowerIsBetter": true, "replicates": [134.0, 121.0, 124.0, 115.0, 123.0, 119.0, 123.0, 117.0, 118.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.1}, {"lowerIsBetter": true, "replicates": [156.0, 145.0, 156.0, 153.0, 146.0, 146.0, 154.0, 153.0, 161.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.6}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 70.0, 71.0, 70.0, 68.0, 67.0, 71.0, 68.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1507.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.91704223001167], "unit": "score", "name": "Richards", "value": 211.49428200000003}, {"lowerIsBetter": false, "replicates": [191.0219675262655], "unit": "score", "name": "DeltaBlue", "value": 346.12773000000004}, {"lowerIsBetter": false, "replicates": [280.8988764044944], "unit": "score", "name": "Encrypt", "value": 947.6043599999998}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1990.0596421471173], "unit": "score", "name": "RayTrace", "value": 371.84262437562455}, {"lowerIsBetter": false, "replicates": [803.8585209003215], "unit": "score", "name": "Earley", "value": 829.0799720000001}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [25846.153846153848], "unit": "score", "name": "RegExp", "value": 35.24644345238097}, {"lowerIsBetter": false, "replicates": [677.3977196512408], "unit": "score", "name": "Splay", "value": 120.30008019801976}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19514.966421411536}]} 05:15:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19514.97"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1507.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6902.45"}}} 05:15:37 INFO - Return code: 0 05:15:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:15:37 INFO - # TBPL SUCCESS # 05:15:37 INFO - Running post-action listener: _resource_record_post_action 05:15:37 INFO - Running post-run listener: _resource_record_post_run 05:15:38 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 323489792; Read time: 0; Write time: 186808 05:15:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5410816; Read time: 0; Write time: 332 05:15:38 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 318078976; Read time: 0; Write time: 186476 05:15:38 INFO - Running post-run listener: _upload_blobber_files 05:15:38 INFO - Blob upload gear active. 05:15:38 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:15:38 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 05:15:38 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'] 05:15:38 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 05:15:38 INFO - (blobuploader) - INFO - Open directory for files ... 05:15:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:15:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:15:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:39 INFO - (blobuploader) - INFO - Done attempting. 05:15:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:15:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:15:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:41 INFO - (blobuploader) - INFO - Done attempting. 05:15:41 INFO - (blobuploader) - INFO - Iteration through files over. 05:15:41 INFO - Return code: 0 05:15:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:15:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:15:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/15bc6770bb3778005666a32cbe740c291b38f25004a4e4baf650247a2d2f24a03462f1ce595ce592a96f3fe78ed4bbf8fd4ad17715f66e4eb611adbb2afcf701", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/606f7e910309606744394780ec2d43ffb2a8ef30056092af193c62e7e8e40a3512b37109165901a30f3fa4b469725946d95c18f8b6715cc09fc5941213e151e6"} 05:15:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:15:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:15:41 INFO - Contents: 05:15:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/15bc6770bb3778005666a32cbe740c291b38f25004a4e4baf650247a2d2f24a03462f1ce595ce592a96f3fe78ed4bbf8fd4ad17715f66e4eb611adbb2afcf701", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/606f7e910309606744394780ec2d43ffb2a8ef30056092af193c62e7e8e40a3512b37109165901a30f3fa4b469725946d95c18f8b6715cc09fc5941213e151e6"} 05:15:41 INFO - Copying logs to upload dir... 05:15:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.307984 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-04 05:15:41.344039) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 05:15:41.347894) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067 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/15bc6770bb3778005666a32cbe740c291b38f25004a4e4baf650247a2d2f24a03462f1ce595ce592a96f3fe78ed4bbf8fd4ad17715f66e4eb611adbb2afcf701", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/606f7e910309606744394780ec2d43ffb2a8ef30056092af193c62e7e8e40a3512b37109165901a30f3fa4b469725946d95c18f8b6715cc09fc5941213e151e6"} build_url:https://queue.taskcluster.net/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011409 build_url: 'https://queue.taskcluster.net/v1/task/DPuzcRQxQTmMR3tKnrs9eQ/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/15bc6770bb3778005666a32cbe740c291b38f25004a4e4baf650247a2d2f24a03462f1ce595ce592a96f3fe78ed4bbf8fd4ad17715f66e4eb611adbb2afcf701", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/606f7e910309606744394780ec2d43ffb2a8ef30056092af193c62e7e8e40a3512b37109165901a30f3fa4b469725946d95c18f8b6715cc09fc5941213e151e6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 05:15:41.374107) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 05:15:41.374479) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1451911044.140979-384086067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 05:15:41.459727) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 05:15:41.460106) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 05:15:41.460478) ========= ========= Total master_lag: 0.24 =========