builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1452193229.01 results: success (0) buildid: 20160107083050 builduid: cce3b22be404424eb9d46c0522ca7bf2 revision: bf1d46d3edfc7cff8469d46393835b915634420e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.009969) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.010431) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.010734) ========= 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-1452192428.915715-1933112473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006299 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.034025) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.034334) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.047617) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.047959) ========= 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-1452192428.915715-1933112473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004703 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.097019) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.097321) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.097691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.097969) ========= 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-1452192428.915715-1933112473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 11:00:31-- 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% 227M=0s 2016-01-07 11:00:31 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161939 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.272951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.273329) ========= 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-1452192428.915715-1933112473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021861 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.323489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.323877) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bf1d46d3edfc7cff8469d46393835b915634420e --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/fx-team --rev bf1d46d3edfc7cff8469d46393835b915634420e --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-1452192428.915715-1933112473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 11:00:31,306 truncating revision to first 12 chars 2016-01-07 11:00:31,306 Setting DEBUG logging. 2016-01-07 11:00:31,306 attempt 1/10 2016-01-07 11:00:31,306 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bf1d46d3edfc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 11:00:31,588 unpacking tar archive at: fx-team-bf1d46d3edfc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.580572 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.917651) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.917973) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.927936) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.928232) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 11:00:29.928616) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-07 11:00:29.928898) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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-1452192428.915715-1933112473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:00:31 INFO - MultiFileLogger online at 20160107 11:00:31 in /builds/slave/test-pgo 11:00:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:00:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:00:31 INFO - {'append_to_log': False, 11:00:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:00:31 INFO - 'blob_upload_branch': 'Fx-Team', 11:00:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:00:31 INFO - 'branch': 'Fx-Team', 11:00:31 INFO - 'buildbot_json_path': 'buildprops.json', 11:00:31 INFO - 'config_files': ('talos/linux_config.py',), 11:00:31 INFO - 'default_actions': ('clobber', 11:00:31 INFO - 'read-buildbot-config', 11:00:31 INFO - 'download-and-extract', 11:00:31 INFO - 'populate-webroot', 11:00:31 INFO - 'create-virtualenv', 11:00:31 INFO - 'install', 11:00:31 INFO - 'run-tests'), 11:00:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:00:31 INFO - 'download_minidump_stackwalk': True, 11:00:31 INFO - 'download_symbols': 'ondemand', 11:00:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:00:31 INFO - 'tooltool.py': '/tools/tooltool.py', 11:00:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:00:31 INFO - '/tools/misc-python/virtualenv.py')}, 11:00:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:00:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:00:31 INFO - 'installer_path': 'installer.exe', 11:00:31 INFO - 'log_level': 'info', 11:00:31 INFO - 'log_name': 'talos', 11:00:31 INFO - 'log_to_console': True, 11:00:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:00:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:00:31 INFO - 'opt_config_files': (), 11:00:31 INFO - 'pip_index': False, 11:00:31 INFO - 'sps_profile': False, 11:00:31 INFO - 'sps_profile_interval': 0, 11:00:31 INFO - 'suite': 'dromaeojs-e10s', 11:00:31 INFO - 'system_bits': '32', 11:00:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:00:31 INFO - 'title': 'talos-linux64-ix-064', 11:00:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:00:31 INFO - 'use_talos_json': True, 11:00:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:00:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:00:31 INFO - 'work_dir': 'build'} 11:00:31 INFO - ##### 11:00:31 INFO - ##### Running clobber step. 11:00:31 INFO - ##### 11:00:31 INFO - Running pre-action listener: _resource_record_pre_action 11:00:31 INFO - Running main action method: clobber 11:00:31 INFO - rmtree: /builds/slave/test-pgo/build 11:00:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:00:32 INFO - Running post-action listener: _resource_record_post_action 11:00:32 INFO - ##### 11:00:32 INFO - ##### Running read-buildbot-config step. 11:00:32 INFO - ##### 11:00:32 INFO - Running pre-action listener: _resource_record_pre_action 11:00:32 INFO - Running main action method: read_buildbot_config 11:00:32 INFO - Using buildbot properties: 11:00:32 INFO - { 11:00:32 INFO - "project": "", 11:00:32 INFO - "product": "firefox", 11:00:32 INFO - "script_repo_revision": "production", 11:00:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:00:32 INFO - "repository": "", 11:00:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:00:32 INFO - "buildid": "20160107083050", 11:00:32 INFO - "pgo_build": "True", 11:00:32 INFO - "basedir": "/builds/slave/test-pgo", 11:00:32 INFO - "buildnumber": 190, 11:00:32 INFO - "slavename": "talos-linux64-ix-064", 11:00:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:00:32 INFO - "platform": "ubuntu64_hw", 11:00:32 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:00:32 INFO - "branch": "fx-team", 11:00:32 INFO - "repo_path": "integration/fx-team", 11:00:32 INFO - "revision": "bf1d46d3edfc7cff8469d46393835b915634420e", 11:00:32 INFO - "stage_platform": "linux64-pgo", 11:00:32 INFO - "builduid": "cce3b22be404424eb9d46c0522ca7bf2", 11:00:32 INFO - "slavebuilddir": "test" 11:00:32 INFO - } 11:00:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:00:32 INFO - Running post-action listener: _resource_record_post_action 11:00:32 INFO - ##### 11:00:32 INFO - ##### Running download-and-extract step. 11:00:32 INFO - ##### 11:00:32 INFO - Running pre-action listener: _resource_record_pre_action 11:00:32 INFO - Running main action method: download_and_extract 11:00:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:00:32 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')]} 11:00:32 INFO - https://queue.taskcluster.net/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:00:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/test_packages.json 11:00:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/test_packages.json 11:00:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:00:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:00:33 INFO - Downloaded 1302 bytes. 11:00:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:00:33 INFO - Using the following test package requirements: 11:00:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:00:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:00:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:33 INFO - u'jsshell-linux-x86_64.zip'], 11:00:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:00:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:00:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:00:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:00:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:00:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:00:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:00:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:00:33 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')]} 11:00:33 INFO - https://queue.taskcluster.net/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:00:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:00:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:00:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/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 11:00:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/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 11:00:35 INFO - Downloaded 24055985 bytes. 11:00:35 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 11:00:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:00:35 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 11:00:36 INFO - Return code: 0 11:00:36 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 11:00:36 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')]} 11:00:36 INFO - https://queue.taskcluster.net/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:00:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:00:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:00:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/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 11:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/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 11:00:37 INFO - Downloaded 24055985 bytes. 11:00:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:00:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:00:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:00:38 INFO - Return code: 0 11:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:38 INFO - https://queue.taskcluster.net/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:00:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:00:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:00:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/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 11:00:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/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 11:00:40 INFO - Downloaded 11132285 bytes. 11:00: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 11:00:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:00: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 11:00:40 INFO - Return code: 0 11:00: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')]} 11:00:40 INFO - https://queue.taskcluster.net/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:00:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:00:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:00:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/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 11:00:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/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 11:00:42 INFO - Downloaded 55898937 bytes. 11:00:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:00:42 INFO - mkdir: /builds/slave/test-pgo/properties 11:00:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:00:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:00:42 INFO - Contents: 11:00:42 INFO - build_url:https://queue.taskcluster.net/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:00:42 INFO - Running post-action listener: _resource_record_post_action 11:00:42 INFO - Running post-action listener: set_extra_try_arguments 11:00:42 INFO - ##### 11:00:42 INFO - ##### Running populate-webroot step. 11:00:42 INFO - ##### 11:00:42 INFO - Running pre-action listener: _resource_record_pre_action 11:00:42 INFO - Running main action method: populate_webroot 11:00:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:00:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:00:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:00:42 INFO - '--tppagecycles', 11:00:42 INFO - '7'], 11:00:42 INFO - 'tests': ['tsvgm']}}, 11:00:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:00:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:00:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:00:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:00:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:00:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:00:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:00:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:42 INFO - 'talos_options': ['--e10s'], 11:00:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:00:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:42 INFO - 'tests': ['damp', 'tps']}, 11:00:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:42 INFO - 'talos_options': ['--e10s'], 11:00:42 INFO - 'tests': ['damp', 'tps']}, 11:00:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:00:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:00:42 INFO - 'other': {'tests': ['a11yr', 11:00:42 INFO - 'ts_paint', 11:00:42 INFO - 'tpaint', 11:00:42 INFO - 'sessionrestore', 11:00:42 INFO - 'sessionrestore_no_auto_restore']}, 11:00:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:00:42 INFO - 'tests': ['a11yr', 11:00:42 INFO - 'ts_paint', 11:00:42 INFO - 'tpaint', 11:00:42 INFO - 'sessionrestore', 11:00:42 INFO - 'sessionrestore_no_auto_restore']}, 11:00:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:00:42 INFO - 'tests': ['a11yr', 11:00:42 INFO - 'ts_paint', 11:00:42 INFO - 'tpaint', 11:00:42 INFO - 'sessionrestore', 11:00:42 INFO - 'sessionrestore_no_auto_restore']}, 11:00:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:00:42 INFO - 'tests': ['a11yr', 11:00:42 INFO - 'ts_paint', 11:00:42 INFO - 'tpaint', 11:00:42 INFO - 'sessionrestore', 11:00:42 INFO - 'sessionrestore_no_auto_restore']}, 11:00:42 INFO - 'other_l64': {'tests': ['a11yr', 11:00:42 INFO - 'ts_paint', 11:00:42 INFO - 'tpaint', 11:00:42 INFO - 'sessionrestore', 11:00:42 INFO - 'sessionrestore_no_auto_restore']}, 11:00:42 INFO - 'other_nol64': {'tests': ['a11yr', 11:00:42 INFO - 'ts_paint', 11:00:42 INFO - 'tpaint', 11:00:42 INFO - 'sessionrestore', 11:00:42 INFO - 'sessionrestore_no_auto_restore']}, 11:00:42 INFO - 'svgr': {'tests': ['tsvgx', 11:00:42 INFO - 'tsvgr_opacity', 11:00:42 INFO - 'tart', 11:00:42 INFO - 'tscrollx', 11:00:42 INFO - 'cart']}, 11:00:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:00:42 INFO - 'tests': ['tsvgx', 11:00:42 INFO - 'tsvgr_opacity', 11:00:42 INFO - 'tart', 11:00:42 INFO - 'tscrollx', 11:00:42 INFO - 'cart']}, 11:00:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:42 INFO - 'tests': ['tp5o']}, 11:00:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:42 INFO - 'talos_options': ['--e10s'], 11:00:42 INFO - 'tests': ['tp5o']}, 11:00:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:42 INFO - 'talos_options': ['--xperf_path', 11:00:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:00:42 INFO - 'tests': ['tp5n']}, 11:00:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:42 INFO - 'talos_options': ['--e10s', 11:00:42 INFO - '--xperf_path', 11:00:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:00:42 INFO - 'tests': ['tp5n']}}, 11:00:42 INFO - 'talos.zip': {'path': '', 11:00:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:00:42 INFO - Running post-action listener: _resource_record_post_action 11:00:42 INFO - ##### 11:00:42 INFO - ##### Running create-virtualenv step. 11:00:42 INFO - ##### 11:00:42 INFO - Running pre-action listener: _resource_record_pre_action 11:00:42 INFO - Running main action method: create_virtualenv 11:00:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:00: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 11:00:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:00:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:00:42 INFO - Using real prefix '/usr' 11:00:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:00:43 INFO - Installing distribute.............................................................................................................................................................................................done. 11:00:45 INFO - Installing pip.................done. 11:00:45 INFO - Return code: 0 11:00:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:00: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')]} 11:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00: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')]} 11:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00: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 0x7f1962fd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2578840>, '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 0x24e56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e5b60>, '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-1452192428.915715-1933112473', '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 11:00: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 11:00: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 11:00:45 INFO - Using env: {'DISPLAY': ':0', 11:00:45 INFO - 'HOME': '/home/cltbld', 11:00:45 INFO - 'LANG': 'en_US.UTF-8', 11:00:45 INFO - 'LANGUAGE': 'en_US:en', 11:00:45 INFO - 'LOGNAME': 'cltbld', 11:00:45 INFO - 'MAIL': '/var/mail/cltbld', 11:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:45 INFO - 'MOZ_NO_REMOTE': '1', 11:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:45 INFO - 'NO_EM_RESTART': '1', 11:00:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:45 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:45 INFO - 'SHELL': '/bin/bash', 11:00:45 INFO - 'SHLVL': '1', 11:00:45 INFO - 'TERM': 'linux', 11:00:45 INFO - 'TMOUT': '86400', 11:00:45 INFO - 'USER': 'cltbld', 11:00:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452192428.915715-1933112473', 11:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:45 INFO - '_': '/tools/buildbot/bin/python'} 11:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:45 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 11:00:45 INFO - Cleaning up... 11:00:45 INFO - Return code: 0 11:00:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:00: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')]} 11:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00: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')]} 11:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00: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', '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 0x7f1962fd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2578840>, '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 0x24e56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e5b60>, '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-1452192428.915715-1933112473', '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 11:00: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 11:00: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 psutil>=0.7.1 11:00:45 INFO - Using env: {'DISPLAY': ':0', 11:00:45 INFO - 'HOME': '/home/cltbld', 11:00:45 INFO - 'LANG': 'en_US.UTF-8', 11:00:45 INFO - 'LANGUAGE': 'en_US:en', 11:00:45 INFO - 'LOGNAME': 'cltbld', 11:00:45 INFO - 'MAIL': '/var/mail/cltbld', 11:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:45 INFO - 'MOZ_NO_REMOTE': '1', 11:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:45 INFO - 'NO_EM_RESTART': '1', 11:00:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:45 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:45 INFO - 'SHELL': '/bin/bash', 11:00:45 INFO - 'SHLVL': '1', 11:00:45 INFO - 'TERM': 'linux', 11:00:45 INFO - 'TMOUT': '86400', 11:00:45 INFO - 'USER': 'cltbld', 11:00:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452192428.915715-1933112473', 11:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:45 INFO - '_': '/tools/buildbot/bin/python'} 11:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:45 INFO - Downloading/unpacking psutil>=0.7.1 11:00:45 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 11:00:45 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 11:00:45 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 11:00:45 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 11:00:45 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 11:00:45 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 11:00:47 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 11:00:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:00:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:00:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:00:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:00:47 INFO - Installing collected packages: psutil 11:00:47 INFO - Running setup.py install for psutil 11:00:47 INFO - building 'psutil._psutil_linux' extension 11:00:47 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 11:00:47 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 11:00:47 INFO - building 'psutil._psutil_posix' extension 11:00:47 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 11:00:47 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 11:00:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:00:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:00:47 INFO - Successfully installed psutil 11:00:47 INFO - Cleaning up... 11:00:47 INFO - Return code: 0 11:00:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:00:47 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')]} 11:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:47 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')]} 11:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:47 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 0x7f1962fd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2578840>, '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 0x24e56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e5b60>, '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-1452192428.915715-1933112473', '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 11:00:47 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 11:00:47 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 11:00:47 INFO - Using env: {'DISPLAY': ':0', 11:00:47 INFO - 'HOME': '/home/cltbld', 11:00:47 INFO - 'LANG': 'en_US.UTF-8', 11:00:47 INFO - 'LANGUAGE': 'en_US:en', 11:00:47 INFO - 'LOGNAME': 'cltbld', 11:00:47 INFO - 'MAIL': '/var/mail/cltbld', 11:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:47 INFO - 'MOZ_NO_REMOTE': '1', 11:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:47 INFO - 'NO_EM_RESTART': '1', 11:00:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:47 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:47 INFO - 'SHELL': '/bin/bash', 11:00:47 INFO - 'SHLVL': '1', 11:00:47 INFO - 'TERM': 'linux', 11:00:47 INFO - 'TMOUT': '86400', 11:00:47 INFO - 'USER': 'cltbld', 11:00:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452192428.915715-1933112473', 11:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:47 INFO - '_': '/tools/buildbot/bin/python'} 11:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:00:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:00:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:00:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:00:49 INFO - Installing collected packages: mozsystemmonitor 11:00:49 INFO - Running setup.py install for mozsystemmonitor 11:00:49 INFO - Successfully installed mozsystemmonitor 11:00:49 INFO - Cleaning up... 11:00:50 INFO - Return code: 0 11:00:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:00:50 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')]} 11:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:50 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')]} 11:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:50 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 0x7f1962fd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2578840>, '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 0x24e56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e5b60>, '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-1452192428.915715-1933112473', '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 11:00:50 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 11:00:50 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 11:00:50 INFO - Using env: {'DISPLAY': ':0', 11:00:50 INFO - 'HOME': '/home/cltbld', 11:00:50 INFO - 'LANG': 'en_US.UTF-8', 11:00:50 INFO - 'LANGUAGE': 'en_US:en', 11:00:50 INFO - 'LOGNAME': 'cltbld', 11:00:50 INFO - 'MAIL': '/var/mail/cltbld', 11:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:50 INFO - 'MOZ_NO_REMOTE': '1', 11:00:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:50 INFO - 'NO_EM_RESTART': '1', 11:00:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:50 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:50 INFO - 'SHELL': '/bin/bash', 11:00:50 INFO - 'SHLVL': '1', 11:00:50 INFO - 'TERM': 'linux', 11:00:50 INFO - 'TMOUT': '86400', 11:00:50 INFO - 'USER': 'cltbld', 11:00:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452192428.915715-1933112473', 11:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:50 INFO - '_': '/tools/buildbot/bin/python'} 11:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:50 INFO - Downloading/unpacking blobuploader==1.2.4 11:00:50 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 11:00:50 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 11:00:50 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 11:00:50 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 11:00:50 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 11:00:50 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 11:00:51 INFO - Downloading blobuploader-1.2.4.tar.gz 11:00:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:00:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:00:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:00:52 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 11:00:52 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 11:00:52 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 11:00:52 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 11:00:52 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 11:00:52 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 11:00:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:00:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:00:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:00:52 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 11:00:52 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 11:00:52 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 11:00:52 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 11:00:52 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 11:00:52 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 11:00:52 INFO - Downloading docopt-0.6.1.tar.gz 11:00:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:00:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:00:52 INFO - Installing collected packages: blobuploader, requests, docopt 11:00:52 INFO - Running setup.py install for blobuploader 11:00:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:00:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:00:52 INFO - Running setup.py install for requests 11:00:53 INFO - Running setup.py install for docopt 11:00:53 INFO - Successfully installed blobuploader requests docopt 11:00:53 INFO - Cleaning up... 11:00:53 INFO - Return code: 0 11:00:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:53 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 0x7f1962fd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2578840>, '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 0x24e56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e5b60>, '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-1452192428.915715-1933112473', '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 11:00:53 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 11:00:53 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 11:00:53 INFO - Using env: {'DISPLAY': ':0', 11:00:53 INFO - 'HOME': '/home/cltbld', 11:00:53 INFO - 'LANG': 'en_US.UTF-8', 11:00:53 INFO - 'LANGUAGE': 'en_US:en', 11:00:53 INFO - 'LOGNAME': 'cltbld', 11:00:53 INFO - 'MAIL': '/var/mail/cltbld', 11:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:53 INFO - 'MOZ_NO_REMOTE': '1', 11:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:53 INFO - 'NO_EM_RESTART': '1', 11:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:53 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:53 INFO - 'SHELL': '/bin/bash', 11:00:53 INFO - 'SHLVL': '1', 11:00:53 INFO - 'TERM': 'linux', 11:00:53 INFO - 'TMOUT': '86400', 11:00:53 INFO - 'USER': 'cltbld', 11:00:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452192428.915715-1933112473', 11:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:53 INFO - '_': '/tools/buildbot/bin/python'} 11:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:00:53 INFO - Running setup.py (path:/tmp/pip-2Ea8Iy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:00:53 INFO - Running setup.py (path:/tmp/pip-JgCiBP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:00:53 INFO - Running setup.py (path:/tmp/pip-00QuMx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:00:53 INFO - Running setup.py (path:/tmp/pip-lQ0OnH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:00:53 INFO - Running setup.py (path:/tmp/pip-VQFMLo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:00:53 INFO - Running setup.py (path:/tmp/pip-ZcqmTL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:00:53 INFO - Running setup.py (path:/tmp/pip-avL2pW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:00:53 INFO - Running setup.py (path:/tmp/pip-at61k7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:00:54 INFO - Running setup.py (path:/tmp/pip-hW31x_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:00:54 INFO - Running setup.py (path:/tmp/pip-V61ELT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:00:54 INFO - Running setup.py (path:/tmp/pip-nd7hK4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:00:54 INFO - Running setup.py (path:/tmp/pip-Clwjr8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:00:54 INFO - Running setup.py (path:/tmp/pip-NEvw07-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:00:54 INFO - Running setup.py (path:/tmp/pip-NuUc_y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:00:54 INFO - Running setup.py (path:/tmp/pip-Y07OYG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:00:54 INFO - Running setup.py (path:/tmp/pip-X2Y0zQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:00:54 INFO - Running setup.py (path:/tmp/pip-5telYe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:00:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:00:54 INFO - Running setup.py install for manifestparser 11:00:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:00:54 INFO - Running setup.py install for mozcrash 11:00:54 INFO - Running setup.py install for mozdebug 11:00:55 INFO - Running setup.py install for mozdevice 11:00:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:00:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:00:55 INFO - Running setup.py install for mozfile 11:00:55 INFO - Running setup.py install for mozhttpd 11:00:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:00:55 INFO - Running setup.py install for mozinfo 11:00:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:00:55 INFO - Running setup.py install for mozInstall 11:00:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:00:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:00:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:00:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:00:55 INFO - Running setup.py install for mozleak 11:00:55 INFO - Running setup.py install for mozlog 11:00:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:00:55 INFO - Running setup.py install for moznetwork 11:00:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:00:55 INFO - Running setup.py install for mozprocess 11:00:55 INFO - Running setup.py install for mozprofile 11:00:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:00:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:00:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:00:56 INFO - Running setup.py install for mozrunner 11:00:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:00:56 INFO - Running setup.py install for mozscreenshot 11:00:56 INFO - Running setup.py install for moztest 11:00:56 INFO - Running setup.py install for mozversion 11:00:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:00:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:00:56 INFO - Cleaning up... 11:00:56 INFO - Return code: 0 11:00:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f1962fd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2578840>, '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 0x24e56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e5b60>, '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-1452192428.915715-1933112473', '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 11:00:56 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 11:00:56 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 11:00:56 INFO - Using env: {'DISPLAY': ':0', 11:00:56 INFO - 'HOME': '/home/cltbld', 11:00:56 INFO - 'LANG': 'en_US.UTF-8', 11:00:56 INFO - 'LANGUAGE': 'en_US:en', 11:00:56 INFO - 'LOGNAME': 'cltbld', 11:00:56 INFO - 'MAIL': '/var/mail/cltbld', 11:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:56 INFO - 'MOZ_NO_REMOTE': '1', 11:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:56 INFO - 'NO_EM_RESTART': '1', 11:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:56 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:56 INFO - 'SHELL': '/bin/bash', 11:00:56 INFO - 'SHLVL': '1', 11:00:56 INFO - 'TERM': 'linux', 11:00:56 INFO - 'TMOUT': '86400', 11:00:56 INFO - 'USER': 'cltbld', 11:00:56 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452192428.915715-1933112473', 11:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:56 INFO - '_': '/tools/buildbot/bin/python'} 11:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:00:56 INFO - Running setup.py (path:/tmp/pip-ezb0B5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:00:56 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)) 11:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:00:56 INFO - Running setup.py (path:/tmp/pip-9FKeGg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:00:56 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)) 11:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:00:56 INFO - Running setup.py (path:/tmp/pip-dE7qvK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:00:56 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)) 11:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:00:56 INFO - Running setup.py (path:/tmp/pip-kYRHE0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:00:56 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)) 11:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:00:56 INFO - Running setup.py (path:/tmp/pip-6pJP3U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:00:57 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)) 11:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:00:57 INFO - Running setup.py (path:/tmp/pip-wmAtWf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:00:57 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)) 11:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:00:57 INFO - Running setup.py (path:/tmp/pip-GjkEpp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:00:57 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)) 11:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:00:57 INFO - Running setup.py (path:/tmp/pip-YRVogC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:00:57 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)) 11:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:00:57 INFO - Running setup.py (path:/tmp/pip-NzhD3k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:00:57 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)) 11:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:00:57 INFO - Running setup.py (path:/tmp/pip-USc8u8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:00:57 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)) 11:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:00:57 INFO - Running setup.py (path:/tmp/pip-AptFi9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:00:57 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)) 11:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:00:57 INFO - Running setup.py (path:/tmp/pip-CaeGbk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:00:57 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)) 11:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:00:57 INFO - Running setup.py (path:/tmp/pip-D97XII-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:00:57 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)) 11:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:00:57 INFO - Running setup.py (path:/tmp/pip-xAwNg4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:00:57 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)) 11:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:00:57 INFO - Running setup.py (path:/tmp/pip-XJD_xG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:00:57 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)) 11:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:00:57 INFO - Running setup.py (path:/tmp/pip-RliBhl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:00:57 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)) 11:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:00:57 INFO - Running setup.py (path:/tmp/pip-Uo8clL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:00:57 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)) 11:00:57 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)) 11:00:57 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)) 11:00:57 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)) 11:00:57 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)) 11:00:57 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)) 11:00:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:59 INFO - Downloading blessings-1.5.1.tar.gz 11:00:59 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 11:00:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:00:59 INFO - Installing collected packages: blessings 11:00:59 INFO - Running setup.py install for blessings 11:00:59 INFO - Successfully installed blessings 11:00:59 INFO - Cleaning up... 11:00:59 INFO - Return code: 0 11:00:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:00:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:00:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:01:00 INFO - Reading from file tmpfile_stdout 11:01:00 INFO - Current package versions: 11:01:00 INFO - argparse == 1.2.1 11:01:00 INFO - blessings == 1.5.1 11:01:00 INFO - blobuploader == 1.2.4 11:01:00 INFO - docopt == 0.6.1 11:01:00 INFO - manifestparser == 1.1 11:01:00 INFO - mozInstall == 1.12 11:01:00 INFO - mozcrash == 0.16 11:01:00 INFO - mozdebug == 0.1 11:01:00 INFO - mozdevice == 0.47 11:01:00 INFO - mozfile == 1.2 11:01:00 INFO - mozhttpd == 0.7 11:01:00 INFO - mozinfo == 0.9 11:01:00 INFO - mozleak == 0.1 11:01:00 INFO - mozlog == 3.1 11:01:00 INFO - moznetwork == 0.27 11:01:00 INFO - mozprocess == 0.22 11:01:00 INFO - mozprofile == 0.28 11:01:00 INFO - mozrunner == 6.11 11:01:00 INFO - mozscreenshot == 0.1 11:01:00 INFO - mozsystemmonitor == 0.0 11:01:00 INFO - moztest == 0.7 11:01:00 INFO - mozversion == 1.4 11:01:00 INFO - psutil == 3.1.1 11:01:00 INFO - requests == 1.2.3 11:01:00 INFO - wsgiref == 0.1.2 11:01:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f1962fd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2578840>, '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 0x24e56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e5b60>, '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-1452192428.915715-1933112473', '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 11:01:00 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 11:01:00 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 11:01:00 INFO - Using env: {'DISPLAY': ':0', 11:01:00 INFO - 'HOME': '/home/cltbld', 11:01:00 INFO - 'LANG': 'en_US.UTF-8', 11:01:00 INFO - 'LANGUAGE': 'en_US:en', 11:01:00 INFO - 'LOGNAME': 'cltbld', 11:01:00 INFO - 'MAIL': '/var/mail/cltbld', 11:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:00 INFO - 'MOZ_NO_REMOTE': '1', 11:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:00 INFO - 'NO_EM_RESTART': '1', 11:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:00 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:00 INFO - 'SHELL': '/bin/bash', 11:01:00 INFO - 'SHLVL': '1', 11:01:00 INFO - 'TERM': 'linux', 11:01:00 INFO - 'TMOUT': '86400', 11:01:00 INFO - 'USER': 'cltbld', 11:01:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452192428.915715-1933112473', 11:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:00 INFO - '_': '/tools/buildbot/bin/python'} 11:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:00 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)) 11:01:00 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)) 11:01:00 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)) 11:01:00 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)) 11:01:00 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)) 11:01:00 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)) 11:01:00 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)) 11:01:00 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)) 11:01:00 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)) 11:01:00 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)) 11:01:00 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)) 11:01:00 INFO - Cleaning up... 11:01:00 INFO - Return code: 0 11:01:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1962fd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2578840>, '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 0x24e56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e5b60>, '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-1452192428.915715-1933112473', '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 11:01:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 11:01:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:01:00 INFO - Using env: {'DISPLAY': ':0', 11:01:00 INFO - 'HOME': '/home/cltbld', 11:01:00 INFO - 'LANG': 'en_US.UTF-8', 11:01:00 INFO - 'LANGUAGE': 'en_US:en', 11:01:00 INFO - 'LOGNAME': 'cltbld', 11:01:00 INFO - 'MAIL': '/var/mail/cltbld', 11:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:00 INFO - 'MOZ_NO_REMOTE': '1', 11:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:00 INFO - 'NO_EM_RESTART': '1', 11:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:00 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:00 INFO - 'SHELL': '/bin/bash', 11:01:00 INFO - 'SHLVL': '1', 11:01:00 INFO - 'TERM': 'linux', 11:01:00 INFO - 'TMOUT': '86400', 11:01:00 INFO - 'USER': 'cltbld', 11:01:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452192428.915715-1933112473', 11:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:00 INFO - '_': '/tools/buildbot/bin/python'} 11:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:00 INFO - Downloading/unpacking jsonschema 11:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:01:02 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 11:01:02 INFO - Downloading/unpacking functools32 (from jsonschema) 11:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:02 INFO - Downloading functools32-3.2.3-2.tar.gz 11:01:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:01:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:01:02 INFO - warning: no files found matching '*.txt' 11:01:02 INFO - no previously-included directories found matching 'build' 11:01:02 INFO - no previously-included directories found matching 'dist' 11:01:02 INFO - no previously-included directories found matching '.git*' 11:01:02 INFO - Installing collected packages: jsonschema, functools32 11:01:02 INFO - Running setup.py install for functools32 11:01:02 INFO - warning: no files found matching '*.txt' 11:01:02 INFO - no previously-included directories found matching 'build' 11:01:02 INFO - no previously-included directories found matching 'dist' 11:01:02 INFO - no previously-included directories found matching '.git*' 11:01:02 INFO - Successfully installed jsonschema functools32 11:01:02 INFO - Cleaning up... 11:01:02 INFO - Return code: 0 11:01:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1962fd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2578840>, '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 0x24e56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e5b60>, '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-1452192428.915715-1933112473', '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 11:01:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 11:01:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:01:02 INFO - Using env: {'DISPLAY': ':0', 11:01:02 INFO - 'HOME': '/home/cltbld', 11:01:02 INFO - 'LANG': 'en_US.UTF-8', 11:01:02 INFO - 'LANGUAGE': 'en_US:en', 11:01:02 INFO - 'LOGNAME': 'cltbld', 11:01:02 INFO - 'MAIL': '/var/mail/cltbld', 11:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:02 INFO - 'MOZ_NO_REMOTE': '1', 11:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:02 INFO - 'NO_EM_RESTART': '1', 11:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:02 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:02 INFO - 'SHELL': '/bin/bash', 11:01:02 INFO - 'SHLVL': '1', 11:01:02 INFO - 'TERM': 'linux', 11:01:02 INFO - 'TMOUT': '86400', 11:01:02 INFO - 'USER': 'cltbld', 11:01:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452192428.915715-1933112473', 11:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:02 INFO - '_': '/tools/buildbot/bin/python'} 11:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:02 INFO - Downloading/unpacking flake8 11:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:01:04 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 11:01:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:01:04 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 11:01:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01:05 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 11:01:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:01:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:01:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:01:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:01:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:01:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:01:05 INFO - no previously-included directories found matching 'docs/_build' 11:01:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:01:05 INFO - Running setup.py install for pep8 11:01:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:01:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:01:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:01:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:01:05 INFO - no previously-included directories found matching 'docs/_build' 11:01:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:01:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:01:05 INFO - Cleaning up... 11:01:05 INFO - Return code: 0 11:01:05 INFO - Running post-action listener: _resource_record_post_action 11:01:05 INFO - Running post-action listener: _start_resource_monitoring 11:01:05 INFO - Starting resource monitoring. 11:01:05 INFO - ##### 11:01:05 INFO - ##### Running install step. 11:01:05 INFO - ##### 11:01:05 INFO - Running pre-action listener: _resource_record_pre_action 11:01:05 INFO - Running main action method: install 11:01:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:01:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:01:05 INFO - Reading from file tmpfile_stdout 11:01:05 INFO - Detecting whether we're running mozinstall >=1.0... 11:01:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:01:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:01:05 INFO - Reading from file tmpfile_stdout 11:01:05 INFO - Output received: 11:01:05 INFO - Usage: mozinstall [options] installer 11:01:05 INFO - Options: 11:01:05 INFO - -h, --help show this help message and exit 11:01:05 INFO - -d DEST, --destination=DEST 11:01:05 INFO - Directory to install application into. [default: 11:01:05 INFO - "/builds/slave/test-pgo"] 11:01:05 INFO - --app=APP Application being installed. [default: firefox] 11:01:05 INFO - mkdir: /builds/slave/test-pgo/build/application 11:01:05 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'] 11:01:05 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 11:01:22 INFO - Reading from file tmpfile_stdout 11:01:22 INFO - Output received: 11:01:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:01:22 INFO - Running post-action listener: _resource_record_post_action 11:01:22 INFO - ##### 11:01:22 INFO - ##### Running run-tests step. 11:01:22 INFO - ##### 11:01:22 INFO - Running pre-action listener: _resource_record_pre_action 11:01:22 INFO - Running main action method: run_tests 11:01:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:01:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:01:22 INFO - Python 2.7.3 11:01:22 INFO - Return code: 0 11:01:22 INFO - grabbing minidump binary from tooltool 11:01: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')]} 11:01: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 0x2578840>, '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 0x24e56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e5b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:01: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 11:01: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 11:01:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:01:22 INFO - Return code: 0 11:01:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:01:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:01:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:01:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:01:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:01:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:01:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:01:23 INFO - Return code: 0 11:01:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 11:01:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/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-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:01:23 INFO - Using env: {'DISPLAY': ':0', 11:01:23 INFO - 'HOME': '/home/cltbld', 11:01:23 INFO - 'LANG': 'en_US.UTF-8', 11:01:23 INFO - 'LANGUAGE': 'en_US:en', 11:01:23 INFO - 'LOGNAME': 'cltbld', 11:01:23 INFO - 'MAIL': '/var/mail/cltbld', 11:01:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:01:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:23 INFO - 'MOZ_NO_REMOTE': '1', 11:01:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:23 INFO - 'NO_EM_RESTART': '1', 11:01:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:23 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:01:23 INFO - 'SHELL': '/bin/bash', 11:01:23 INFO - 'SHLVL': '1', 11:01:23 INFO - 'TERM': 'linux', 11:01:23 INFO - 'TMOUT': '86400', 11:01:23 INFO - 'USER': 'cltbld', 11:01:23 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452192428.915715-1933112473', 11:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:23 INFO - '_': '/tools/buildbot/bin/python'} 11:01:23 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:01:23 INFO - mozversion application_buildid: 20160107083050 11:01:23 INFO - mozversion application_changeset: bf1d46d3edfc7cff8469d46393835b915634420e 11:01:23 INFO - mozversion application_display_name: Nightly 11:01:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:01:23 INFO - mozversion application_name: Firefox 11:01:23 INFO - mozversion application_remotingname: firefox 11:01:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:01:23 INFO - mozversion application_vendor: Mozilla 11:01:23 INFO - mozversion application_version: 46.0a1 11:01:23 INFO - mozversion platform_buildid: 20160107083050 11:01:23 INFO - mozversion platform_changeset: bf1d46d3edfc7cff8469d46393835b915634420e 11:01:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:01:23 INFO - mozversion platform_version: 46.0a1 11:01:23 INFO - using testdate: 1452193283 11:01:23 INFO - actual date: 1452193283 11:01:23 INFO - starting webserver on 'localhost:41443' 11:01:23 INFO - SUITE-START | Running 3 tests 11:01:23 INFO - TEST-START | dromaeo_css 11:01:23 INFO - operating with platform_type : linux_ 11:01:23 INFO - Initialising browser for dromaeo_css test... 11:01:23 INFO - TEST-INFO | started process 26977 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYR_jzC/profile http://localhost:41443/getInfo.html) 11:01:27 INFO - PROCESS | 26977 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 11:01:28 INFO - PROCESS | 26977 | __metrics Screen width/height:1600/1200 11:01:28 INFO - PROCESS | 26977 | colorDepth:24 11:01:28 INFO - PROCESS | 26977 | Browser inner width/height: 1024/697 11:01:28 INFO - PROCESS | 26977 | __metrics 11:01:28 INFO - PROCESS | 26977 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:01:30 INFO - TEST-INFO | 26977: exit 0 11:01:30 INFO - Browser initialized. 11:01:30 INFO - Running cycle 1/1 for dromaeo_css test... 11:01:30 INFO - TEST-INFO | started process 27113 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYR_jzC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:01:41 INFO - PROCESS | 27113 | RSS: Main: 150360064 11:01:41 INFO - PROCESS | 27113 | 11:02:31 INFO - PROCESS | 27113 | 1452193351484 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] 11:04:40 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:41443/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41443/tests/dromaeo/cssquery-ext.html) 11:04:41 INFO - PROCESS | 27113 | RSS: Main: 157437952 11:04:41 INFO - PROCESS | 27113 | 11:07:43 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:41443/tests/dromaeo/cssquery-ext.html (next: http://localhost:41443/tests/dromaeo/cssquery-jquery.html) 11:07:44 INFO - PROCESS | 27113 | RSS: Main: 152850432 11:07:44 INFO - PROCESS | 27113 | 11:10:46 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:41443/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41443/tests/dromaeo/cssquery-mootools.html) 11:10:46 INFO - PROCESS | 27113 | RSS: Main: 153284608 11:10:46 INFO - PROCESS | 27113 | 11:13:48 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:41443/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41443/tests/dromaeo/cssquery-prototype.html) 11:13:48 INFO - PROCESS | 27113 | RSS: Main: 152510464 11:13:48 INFO - PROCESS | 27113 | 11:16:51 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:41443/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41443/tests/dromaeo/cssquery-yui.html) 11:16:51 INFO - PROCESS | 27113 | RSS: Main: 153223168 11:16:51 INFO - PROCESS | 27113 | 11:19:54 INFO - PROCESS | 27113 | Cycle 1(1): loaded http://localhost:41443/tests/dromaeo/cssquery-yui.html (next: http://localhost:41443/tests/dromaeo/cssquery-dojo.html) 11:19:54 INFO - PROCESS | 27113 | RSS: Main: 155111424 11:19:54 INFO - PROCESS | 27113 | 11:19:54 INFO - PROCESS | 27113 | __start_tp_report 11:19:54 INFO - PROCESS | 27113 | _x_x_mozilla_page_load 11:19:54 INFO - PROCESS | 27113 | _x_x_mozilla_page_load_details 11:19:54 INFO - PROCESS | 27113 | |i|pagename|runs| 11:19:54 INFO - PROCESS | 27113 | |0;dojo.html;3192.058342788877;3229.3864165808495;3272.9199364209812;3273.9017829465124;3290.736741060715;5145.228215767636;5248.317718696569;5294.073537131001;5361.544268737157;5364.088105022146;5267.973660131704;5309.495597918191;5378.596605254602;5479.150731636592;5514.503694667479;4919.163742163841;4982.451930287665;5032.094223039851;5056.494350564951;5070.797168113271;4834.951650483503;4935.259711043336;4970.801167953296;4981.352424184869;4993.500649935014;4760.6429517785955;4779.068081724065;4829.203181475034;4852;4881.682690625098;4834.250691142844;4842.878928026827;4857.9028419431415;4885.096257192431;4897.461279259279;4825.034993001414;4834.129856625806;4836.830710925101;4841.733704646278;4858.805647774085;4979.30289759434;5063.721495317756;5144.176931690911;5186.870328241786;5298.947010529922;5701.914471282934;5725.599208055438;5730.713464326767;5741.3110426748635;5761.654300741969;5758.740856661419;5784.30588329399;5795.565332600072;5799.130130480419;5806.158107074492;5278.788848446057;5287.339082614673;5373.811916582901;5390.0836857734275;5405.21624364465;5832.650040997553;5841.824745257649;5847.26909136358;5863.472287494146;5864.70676466175;5621.550275977912;5663.122216056518;5672.092465205547;5672.744726487318;5684.8294551163535;5571.9721401392735;5597.356304025089;5657.32112146545;5658.603897727202;5667.518260947783;5591.440855914458;5617.073182924772;5628.240187574707;5640.464155905182;5650.463205995424;5731.426857314319;5783.103618939072;5823.5923485355615;5845.970770146122;5879.441453061952;4395.164918665443;4420.005498762753;4447.399601053881;4466.9106617867465;4473.664475164375;3907.882763517099;3980.8805735827973;3988.0428697112484;3994.6804255659476;4003.959960400417;5298.761555730001;5360.785568577291;5369.624126311121;5412.891742165135;5455.945440545624;5736.196932429463;5770.932377510174;5771.59598828078;5779.653220806765;5780.364159942403;5140.383154021467;5245.947540524546;5314.28257185275;5391.892162156735;5446.101393270066;4844.903101937942;4848.296996935424;4875.07373599015;4906.460289368167;4910.926336104962;5889.558283128783;5895.528357731457;5896.528277737771;5903.144044113579;5925.022371308686;5672.801451949162;5673.716314184192;5700.515456186271;5734.254546908875;5822.417758224144;5947.762089516371;5957.344692083954;5970.58205925581;6000.429959153874;6001.609895356788;5692.31692196939;5692.6299790513485;5702.5437964961875;5708.971455142698;5716.28546431696;5633.605647604629;5703.828885133453;5718.942810571841;5724.055530837365;5734.311882573951;5577.721113944205;5581.832545023656;5584.664920104807;5612.943870561242;5635.126555383922;5538.556915446835;5557.305336832896;5574.609777315549;5584.664920104807;5591.384947655836;5451.536619387396;5496.725163741877;5531.059719847555;5540.75066622011;5574.637648552994;5572.052751032254;5648.971755141198;5654.378018418053;5661.801836935688;5671.858203544779;5521.944780552304;5553.6390134641115;5557.083081291542;5558.499735023867;5576.637518561281 11:19:54 INFO - PROCESS | 27113 | |1;ext.html;486.107991834983;544.379407475478;558.193410521796;564.700708624429;599.1851082527764;29075.418491630156;34831.4775278371;34938.12654683634;35134.64865351345;35230;41167;42050.15899682004;42309;42324.36513452301;42385.36421953673;8613.22480976712;8719.869201961976;8740.169683880022;8760.299176065899;8768.649254029831;8518.318534517224;8616.698415555456;8649.178328058824;8665.090165532623;8680.30557555394;8652.740417787445;8720.825583488326;8732.738017859474;8740.562971851414;8775.385722999392;8613.655453781841;8677.1756683115;8727.909011373578;8735.170158834964;8742.300615950773;8482.321414286904;8617.827643447159;8641.135886411372;8641.740747777514;8660.090690477535;39041.60958390408;39531.80234098811;39544.209115817524;39553.80223098895;39573.40639890404;3343.7157841583494;3488.354654388946;3610.6930910872607;3716.349638813197;3940.8423663053445;29174.124776256747;29860.850695746598;30317.24206894823;30442.54336184959;31209.687903121132;3173.5557022016937;3188.3623275344794;3194.7444204463586;3195.4035578613084;3223.387556364307;248214;248252;248416;248757;248969.7551512249;41008.38487422691;41245.1750964979;41720.1655966885;41874;56682.43317566771;39084;39256;39373.60626393757;39376.2124757509;39426.605733942866;12446.626601201979;12475.500979960882;12475.625731228078;12593.811092833432;12600.621981340575;9813.656522021694;9832.852507212398;9916.405015699082;9925;9929.106380425796;13845.515406960709;13900.235487048309;13922.234277114654;13951.58145255644;13969.650758731113;5839.328477225174;5840.766369345179;5876.853078672982;5915.58590898633;5946.791862284799;898.5282726568604;941.6751220828941;1060.2101434431245;1096.616184335492;1160.1241062997383;29789.255268618457;30447.23881902926;31025.534616980764;31204.687953120632;31403;966.4636126949611;968.5496244246459;1029.5161274201114;1083.377058191543;1093.0654290581597;14756.40974361035;14910.627234319012;15116.470923517623;15229.314680839389;15283.541493755205;377056;379510;379694;381157;382563;52340;52567.474325256255;52584.47415525872;52912.47087529075;53256;1345.9192448453125;1346.6767975685962;1368.5415385845854;1373.4025698821044;1378.3452859891672;27632;28851;28852.711472885003;28923.710762892944;29001.41997160003;45066.549334507545;45122.54877451184;45674.086518270116;45688.54311456843;45730.771346143054;290260;296049;296431;296863;297272;30632.540511892785;41298.79350603228;41433.58566414297;41925.58074419339;42526.78736606297;44179;44278;44491.96048526244;45051.549484504736;45051.549484506046;34836;35328;35398;36811.63188368082;38423.80788096042;31998.360032798748;32662.673373266913;36858;38067.238655227295;38219.808900955315;35811.28377432385;37484.625153748115;37655.43516847304;37720.811395942845;37806.81096594499;29604.703952960193;30589.23526911845;32333;32374.514382284757;32660.51009234816;24575.13987010446;24639.26082217536;24728.381790455383;24732;25016.37459063538 11:19:54 INFO - PROCESS | 27113 | |2;jquery.html;362.6029497700018;362.7732667083073;365.6946449714487;366.7432797042071;369.0846700183543;16424.753628695566;16883.662326753456;17518.824811751896;17558.473245802645;18082.186301616424;10975.725606859813;10988.175886808482;11266.4366781661;11285.605003824869;11294.152938529623;4908.656394052417;4910.656254062208;4957.405111386621;4969.8509044728535;5044.344235249431;4938;4955;4992.176290912013;4995.100881841267;5006.54941055305;4983.9252411213865;4988.675736077162;5150.896982060356;5317.936412717452;5322.2548843161985;5123.38519377677;5164.948350516484;5199.194124910626;5243.370795504545;5467.425920278393;5280.10238259493;5291.3385826771655;5292.682439053669;5293.25894374784;5304.973475132639;13803.309834508234;18579.44261672152;19318.32385866502;19848.900755496274;19870;2066.4730493724005;2102.6951092091563;2134.893255337227;2181.8690878547336;2237.8881055947136;9473.19477844384;9853;9889.109980101754;11929.94035029828;12563.874361256454;1705.590658242013;1706.6083890033974;1764.347191539126;1785.366195000782;1788.669096217204;58913.41086589122;60758.696206519126;61082;62980.685096574685;63062.68468657627;9981.500924953723;10216.846747298649;10249.231307651957;10324.741881452874;10413.895861041445;13349;13448.529301474597;13496.595102146755;13511.391987360592;13542.526011589547;7048.92951070493;7170.139583250043;7234.927650723531;7318.414526837841;7366.337029667356;6801.421879140328;6842.178938527409;6849.417799487;6874.415674667609;6895.655217239118;4411.470623525198;4466.59800617946;4475.7985890635;4492.168948744493;4515.164694531522;1770.725537541683;1804.5759246577045;1806.97289540657;1822.4623735997648;1822.4988128264567;911.9361644684941;941.5339406993583;951.1914872358578;1050.9632162874263;1064.7072055184885;16354.264058117413;16546.91726541384;16775.664486710197;16896.22589628096;17107.48677539676;922.8661844032578;924.1959495239184;957.5068839547639;998.0668075349571;1042.7497400623947;9527.428354298765;9549.61801527945;9644.373115747454;9649.05726170011;9679.564419601134;395232;403766;551313;551878;560066;70047;70615.64692176609;71206.64396678087;72487.63756181185;77650.61174694091;1086.147374311162;1134.8014097532898;1138.2715062360096;1144.9484773185227;1165.3881712101215;14505.709885802014;15380.538583842503;15559.45541906028;15744.842551574338;15825.208739563206;30473.847630761706;31075.844620776752;31274.53088203633;31286;31303.686963130076;36228.63771362358;37671.24657506889;38599.42100868545;39073.41389879211;45388.31917521306;9264.907350926405;9278.628854846;9561.760955976157;9658.951705241428;9670.903290967;11231.326120432801;11324.886751132382;11418.657440276806;16135.354585816905;16563.83436165671;11079.612213572485;11603.825942611036;12530.624081277576;13836.308184590529;14150.080244784056;13474.730505389642;13592.456301748214;13709.245991470167;13906.930465347608;14021.579352619437;13882.930585347009;14211.857881421467;14327.212003339917;14606;14648.560543183721;9353.39202951806;9525.666601669185;9606.231501479726;9609.711708648752;9797.31418800677;14365.64085897861;14382.712345753236;14784.852151478348;14808.777868331768;14936.103833770008 11:19:54 INFO - PROCESS | 27113 | |3;mootools.html;1455.1850963460463;1481.1409382558113;1641.926113324901;1773.7339399090142;1810.7555480010203;6776.695048722807;6877.552959057671;7463.738769143081;7638.350740187091;7653.502522336044;6923.826904327382;7089.610071446068;7118.323759242877;7128.465365097625;7156.069710937584;2211.380813372258;2256.7291924969027;2260.886955652219;2265.592193405186;2267.38780529257;2191.660292654641;2204.1073365287084;2236.7875051870046;2251.0883092347626;2256.6050941085327;2191.7917797809264;2217.079911836586;2237.10515793683;2240.1263507232193;2253.0649780341137;2195.890205489719;2202.878841663708;2219.7780221977832;2225.788550087739;2233.251860626692;2264.4225722440838;2289.1530133850583;2290.576243394977;2295.7130358705163;2299.9655005174936;7577.355924746404;7584;7641.579713115776;7655.808604784869;7671.309582137635;4478.686491945565;4554.63562914966;4569.109023740372;4582.908341833145;4583.793729282191;3026.7636988010863;3027.6215473065868;3083.969160308413;3099.705527974839;3108.0675797260956;919.7194855569048;923.1507013547485;949.6486300069018;957.5254108672635;967.3373738988815;10362.222833287533;10402.843957340647;10404.115650169744;10438.530266138043;10474.58101675932;4008.2985477541315;4078.1843631273864;4086.223617512663;4142.502899652;4143.047099167148;8908.465492070496;8922.330825188006;8923.196912277795;8926.330525210635;8948.776280593038;4522.095580883836;4574.794134263966;4579.702319349231;4588.793504292248;4589.059242855206;4047.9595204048173;4187.937180942288;4189.6438802701505;4189.706720529594;4211.43145675336;3414.9487757683655;3432.742544309137;3438.8796392126155;3465.9133521661656;3475.7740746851878;1037.097724979273;1046.08467590858;1047.6490375724065;1054.0987455725399;1065.4353192807823;1253.5549879792725;1267.6133779197248;1278.9936050319875;1280.2318608834626;1285.832841730569;6901.344372284625;6931.1682598088555;7011.719531218796;7066.752663656747;7087.82280442993;462.9884252893637;466.93929789127196;472.5274725274725;474.3998841465549;474.63927415164034;5366.946330536723;5402.081646120169;5459.863503412367;5462.2079798429;5482;8313.916860831314;8366.707165249187;8559.700410485728;8566.3146948244;8704.608292626846;8481.575921203916;8504.277136443348;8527.957360213159;8560.186782255676;8619.138086191457;6717.865642687118;6760.121184246016;6801.829954251183;6859.451243900476;6935.375816176568;6352.0789485525265;6400.615963042233;6402.295747467681;6403.455706265019;6422.775202867877;7567.129780075142;7697.923020769721;7762.146163922077;7783.143854175923;7811.570363630055;7731.072271327252;7898.328642065489;7931.405144614292;7946.642401091849;8028.116907140093;6424.9036264455135;6528.575642583217;6565.868682626417;6595.472362210916;6605.207375115017;7058.54119482232;7063;7064.364207221169;7078.044463997295;7089.7873063808165;6523.902141467787;6651.33486651331;6655.534112612264;6666.866662666816;6791.898121528082;6510.511711621552;6569.9014514783275;6597.769078082244;6703.597784132968;6713.328667133443;6654.035164901159;6675.532712710064;6696.497762667722;6736.461083113241;6746.9325306746305;6001;6156.261248650011;6175.84560385976;6180.196574445294;6194.442500174826;6007.639541627516;6087.330393656783;6094.908576371269;6099.146119543178;6103.725332359965 11:19:54 INFO - PROCESS | 27113 | |4;prototype.html;335.95128706337584;342.84743289236286;345.2766454278286;348.24604730757903;351.9454484554895;6227.128202051711;6245.937540624598;6270.341614130519;6318.210223722035;6411.519136064802;6189;6252.468540174079;6268.874622507547;6269.279032911217;6274.654893980829;4715.811367545302;4736.550027747358;4745.786439610226;4746.952530474686;4747.643926705511;4723.669343145981;4728.432588089434;4746.833860814872;4749.833755818529;4756.809727610891;4564.452265728118;4591.678582499227;4630.189716799563;4667.323238130469;4671.182543054952;4632.791524381411;4665.766711664437;4667.439907211139;4670.252759558454;4674.135284972274;4069.8779036628653;4077.510698716173;4091.9181616367505;4092.815823287959;4104.343305071204;5982.641041537521;5991.520678345765;5994.97002514989;5999.490043346321;6008.459238668541;5357.732113394315;5423.620346575742;5460.31746031746;5462.262594549725;5494.945050549483;6524.445422139124;6539.869202615921;6546.44355229806;6556.049372840911;6559.409653131241;4488.977555112237;4498.640108791289;4503.887402814923;4510.323451482271;4517.07399983006;6756.425703815182;6819.079424277758;6839.213490448612;6899.689513971884;6915.893457046898;4577.29051996941;4581.587657110809;4585.151746926829;4585.312203169551;4595.103954728863;4643.814247430132;4671.672982891165;4672.509386514435;4674.836380726658;4685.531446855287;5419;5422.593305502103;5424;5431.755570999315;5438.972805135949;6503.772367967098;6663.200415950117;6685.164354455693;6685.665716714145;6696.1629796275465;1637.3450619752196;1653.983460165383;1661.1113054515777;1664.7586100015671;1667.4497415852738;1086.8152414089623;1097.1003776902862;1103.564092183583;1114.0530549033258;1114.3815182573749;6227.221597300338;6289.622622642656;6306.527010474233;6317.178766760384;6323.936760632335;6817.216020157646;6826.351496607815;6849.863002739918;6866.073080134218;6867.141607299088;6226.25284965798;6314.8421289467215;6316.810495685137;6340.524460665469;6372.139761132188;3740.6072362401555;3744.4383342498845;3747.063234191452;3754.568224654145;3761.586225515191;7160.606166660884;7166.892496612555;7170.4622153338705;7172.748953786592;7185.49701520899;6962;7089.539179953286;7116.252793456716;7128.322809333105;7129.89305160423;7218.422526197892;7244.963775181091;7265.745698900513;7271.163816161209;7274.018007569016;6881.071055407456;6884.139482564679;6913.3777959983845;6929.133858267716;6932.48006399512;6748.527603067738;6851.45188384938;6859.039734437282;6859.211190713132;6862.348076932683;7230.6384680764695;7281;7281.2718728126765;7291.30732580404;7298.160711518243;4578.839740609063;4639.86080417588;4641.396618439716;4648.907021859612;4650.604698600521;6798;6901.1718593769065;6922.238553758982;6934.375906168469;6944.201416837129;6681.76613818514;6684.63234522106;6708.228553716385;6711.395974362331;6721.092652491851;6502.577332473374;6659.933400665931;6673.666316684049;6673.733050677918;6674.365935236145;6583.736650534117;6590.340965903371;6591.967040164768;6592.373724496165;6598.637074960731;6690.899636505554;6737.730490780314;6750.5274630775375;6759.932400676127;6766.627835469097;6364.172657554488;6535.509836762167;6576.243731970884;6579.309172536815;6588.04473351371 11:19:54 INFO - PROCESS | 27113 | |5;yui.html;696.1785093589564;716.1942814333875;740.8555331710319;773.6325245508383;776.6000509737482;12692.873071269285;13106.868931310684;13115.60653180405;13121.67195820105;13128.671783205426;12761;12810.359482025908;12877.74244515109;12932.159409638367;12978.93510532446;794.9682012719499;808.2241048593357;819.6229734322219;827.1108558299821;835.052215735142;826.7933016745814;831.4969443486694;834.5159807311775;839.911809260028;840.5251033166242;867.9435836670627;869.5304535550795;875.1511034296753;880;880.4277219807112;856.4989481153564;857.8927634045745;863.0506442912808;867.9281087856492;871.2855458524012;634.0742515926753;635.5995722694719;637.4549759955217;638.6455517187959;638.8339031851706;13333.666658333523;13344.399502022336;13405.128666636638;13409.66475838102;13422.86577134226;11190.94404527972;11293.322400655987;11848.822267665992;12077.396130193543;12589.055820813384;9720.61117555297;9884.604615815359;9913.107820296207;10130.805196357163;10371.740706482324;3433.8111403872776;3548.1307079765365;3552.8934131976084;3565.322588708163;3630.146915474861;47156;48619.513804861854;48929.510704893204;49009.26486102711;49051.26423103656;8082.7588939070365;8352.12302708219;8533.957330213309;8534.78663033429;8607;16384.508464746075;16538.58653533671;16543.669126617642;16547.338106475847;16564.503064908073;7057.0472986146215;7201.855962880713;7282.4902256841515;7289.453291003196;7314.341709246193;3777.338965680995;3831.65515103642;3857.1128640412862;3923.941140882889;3964.1080756829483;3018.9245268868017;3061.2652963289097;3061.3724186541704;3067.693230676959;3070.2170946408523;551.3273805956726;558.5810642018486;584.1821449970076;584.8976429124971;598.796409220867;660.5046215338496;674.2246416620827;680.4896327754184;682.617734068923;685.0990946904805;7598.468107232551;7828.921710782819;7890.250426209501;8127.878081828777;8146.959265203636;526.1292560811786;561.811793049333;587.3157771196594;637.5740308127527;708.9716411343488;3616.710663146942;3826.9617303826603;3863.208042351311;4028.335324671455;4169.187008533368;52349;52463;52502.73748631309;52553.737231314364;56044;47941.28088078681;49518.75240623774;49573.25640115329;50313.74843125761;50404.24393634099;46177.30734038992;46311;46667.766661166475;46861.06277874492;47303;8465;8488.702895398632;8498.575071246536;8500;8594.742157735027;35548;35828;36249.27501450009;36629.63370366262;36800;43710.781446092566;45251.28492290473;45324.32013519866;45360.77319613381;45784;10850.837237441287;11032.669019929415;11070.335779853234;11251.437428128724;11342.886571134513;12499.187552809039;12564.560240391542;12676.556320529106;12826.935865320987;13014.544490942772;11519.53921843117;11537.711557211136;11792.174547781573;11955.820662690241;12007.639770806889;11161.939615736492;11452.427378631202;11463.598774042868;11646.359450230319;11664.241824281735;9579.377340472847;9643.710688679352;9896.208303335572;9932.503374831374;10017;10163.94918025405;10351.63769268072;10481.685549433529;10780.460976950964;11006.614768483065;9210.171084602418;9251.167394934488;9294.907050929674;9794.461304628314;9876.35803672759 11:19:54 INFO - PROCESS | 27113 | __end_tp_report 11:19:54 INFO - PROCESS | 27113 | __start_cc_report 11:19:54 INFO - PROCESS | 27113 | _x_x_mozilla_cycle_collect,314 11:19:54 INFO - PROCESS | 27113 | __end_cc_report 11:19:54 INFO - PROCESS | 27113 | __startTimestamp1452194394627__endTimestamp 11:19:54 INFO - PROCESS | 27113 | 11:19:54 INFO - PROCESS | 27113 | ------- Summary: start ------- 11:19:54 INFO - PROCESS | 27113 | Number of tests: 6 11:19:54 INFO - PROCESS | 27113 | 11:19:54 INFO - PROCESS | 27113 | [#0] dojo.html Cycles:165 Average:5321.85 Median:5557.08 stddev:581.21 (10.5%) stddev-sans-first:558.46 11:19:54 INFO - PROCESS | 27113 | Values: 3192.1 3229.4 3272.9 3273.9 3290.7 5145.2 5248.3 5294.1 5361.5 5364.1 5268.0 5309.5 5378.6 5479.2 5514.5 4919.2 4982.5 5032.1 5056.5 5070.8 4835.0 4935.3 4970.8 4981.4 4993.5 4760.6 4779.1 4829.2 4852.0 4881.7 4834.3 4842.9 4857.9 4885.1 4897.5 4825.0 4834.1 4836.8 4841.7 4858.8 4979.3 5063.7 5144.2 5186.9 5298.9 5701.9 5725.6 5730.7 5741.3 5761.7 5758.7 5784.3 5795.6 5799.1 5806.2 5278.8 5287.3 5373.8 5390.1 5405.2 5832.7 5841.8 5847.3 5863.5 5864.7 5621.6 5663.1 5672.1 5672.7 5684.8 5572.0 5597.4 5657.3 5658.6 5667.5 5591.4 5617.1 5628.2 5640.5 5650.5 5731.4 5783.1 5823.6 5846.0 5879.4 4395.2 4420.0 4447.4 4466.9 4473.7 3907.9 3980.9 3988.0 3994.7 4004.0 5298.8 5360.8 5369.6 5412.9 5455.9 5736.2 5770.9 5771.6 5779.7 5780.4 5140.4 5245.9 5314.3 5391.9 5446.1 4844.9 4848.3 4875.1 4906.5 4910.9 5889.6 5895.5 5896.5 5903.1 5925.0 5672.8 5673.7 5700.5 5734.3 5822.4 5947.8 5957.3 5970.6 6000.4 6001.6 5692.3 5692.6 5702.5 5709.0 5716.3 5633.6 5703.8 5718.9 5724.1 5734.3 5577.7 5581.8 5584.7 5612.9 5635.1 5538.6 5557.3 5574.6 5584.7 5591.4 5451.5 5496.7 5531.1 5540.8 5574.6 5572.1 5649.0 5654.4 5661.8 5671.9 5521.9 5553.6 5557.1 5558.5 5576.6 11:19:54 INFO - PROCESS | 27113 | 11:19:54 INFO - PROCESS | 27113 | [#1] ext.html Cycles:180 Average:46436.83 Median:208880.62 stddev:82153.56 (39.3%) stddev-sans-first:82311.57 11:19:54 INFO - PROCESS | 27113 | Values: 486.1 544.4 558.2 564.7 599.2 29075.4 34831.5 34938.1 35134.6 35230.0 41167.0 42050.2 42309.0 42324.4 42385.4 8613.2 8719.9 8740.2 8760.3 8768.6 8518.3 8616.7 8649.2 8665.1 8680.3 8652.7 8720.8 8732.7 8740.6 8775.4 8613.7 8677.2 8727.9 8735.2 8742.3 8482.3 8617.8 8641.1 8641.7 8660.1 39041.6 39531.8 39544.2 39553.8 39573.4 3343.7 3488.4 3610.7 3716.3 3940.8 29174.1 29860.9 30317.2 30442.5 31209.7 3173.6 3188.4 3194.7 3195.4 3223.4 248214.0 248252.0 248416.0 248757.0 248969.8 41008.4 41245.2 41720.2 41874.0 56682.4 39084.0 39256.0 39373.6 39376.2 39426.6 12446.6 12475.5 12475.6 12593.8 12600.6 9813.7 9832.9 9916.4 9925.0 9929.1 13845.5 13900.2 13922.2 13951.6 13969.7 5839.3 5840.8 5876.9 5915.6 5946.8 898.5 941.7 1060.2 1096.6 1160.1 29789.3 30447.2 31025.5 31204.7 31403.0 966.5 968.5 1029.5 1083.4 1093.1 14756.4 14910.6 15116.5 15229.3 15283.5 377056.0 379510.0 379694.0 381157.0 382563.0 52340.0 52567.5 52584.5 52912.5 53256.0 1345.9 1346.7 1368.5 1373.4 1378.3 27632.0 28851.0 28852.7 28923.7 29001.4 45066.5 45122.5 45674.1 45688.5 45730.8 290260.0 296049.0 296431.0 296863.0 297272.0 30632.5 41298.8 41433.6 41925.6 42526.8 44179.0 44278.0 44492.0 45051.5 45051.5 34836.0 35328.0 35398.0 36811.6 38423.8 31998.4 32662.7 36858.0 38067.2 38219.8 35811.3 37484.6 37655.4 37720.8 37806.8 29604.7 30589.2 32333.0 32374.5 32660.5 24575.1 24639.3 24728.4 24732.0 25016.4 11:19:54 INFO - PROCESS | 27113 | 11:19:54 INFO - PROCESS | 27113 | [#2] jquery.html Cycles:180 Average:26686.74 Median:18295.71 stddev:81427.39 (445.1%) stddev-sans-first:81631.83 11:19:54 INFO - PROCESS | 27113 | Values: 362.6 362.8 365.7 366.7 369.1 16424.8 16883.7 17518.8 17558.5 18082.2 10975.7 10988.2 11266.4 11285.6 11294.2 4908.7 4910.7 4957.4 4969.9 5044.3 4938.0 4955.0 4992.2 4995.1 5006.5 4983.9 4988.7 5150.9 5317.9 5322.3 5123.4 5164.9 5199.2 5243.4 5467.4 5280.1 5291.3 5292.7 5293.3 5305.0 13803.3 18579.4 19318.3 19848.9 19870.0 2066.5 2102.7 2134.9 2181.9 2237.9 9473.2 9853.0 9889.1 11929.9 12563.9 1705.6 1706.6 1764.3 1785.4 1788.7 58913.4 60758.7 61082.0 62980.7 63062.7 9981.5 10216.8 10249.2 10324.7 10413.9 13349.0 13448.5 13496.6 13511.4 13542.5 7048.9 7170.1 7234.9 7318.4 7366.3 6801.4 6842.2 6849.4 6874.4 6895.7 4411.5 4466.6 4475.8 4492.2 4515.2 1770.7 1804.6 1807.0 1822.5 1822.5 911.9 941.5 951.2 1051.0 1064.7 16354.3 16546.9 16775.7 16896.2 17107.5 922.9 924.2 957.5 998.1 1042.7 9527.4 9549.6 9644.4 9649.1 9679.6 395232.0 403766.0 551313.0 551878.0 560066.0 70047.0 70615.6 71206.6 72487.6 77650.6 1086.1 1134.8 1138.3 1144.9 1165.4 14505.7 15380.5 15559.5 15744.8 15825.2 30473.8 31075.8 31274.5 31286.0 31303.7 36228.6 37671.2 38599.4 39073.4 45388.3 9264.9 9278.6 9561.8 9659.0 9670.9 11231.3 11324.9 11418.7 16135.4 16563.8 11079.6 11603.8 12530.6 13836.3 14150.1 13474.7 13592.5 13709.2 13906.9 14021.6 13882.9 14211.9 14327.2 14606.0 14648.6 9353.4 9525.7 9606.2 9609.7 9797.3 14365.6 14382.7 14784.9 14808.8 14936.1 11:19:54 INFO - PROCESS | 27113 | 11:19:54 INFO - PROCESS | 27113 | [#3] mootools.html Cycles:180 Average:5165.09 Median:6129.99 stddev:2652.36 (43.3%) stddev-sans-first:2645.15 11:19:54 INFO - PROCESS | 27113 | Values: 1455.2 1481.1 1641.9 1773.7 1810.8 6776.7 6877.6 7463.7 7638.4 7653.5 6923.8 7089.6 7118.3 7128.5 7156.1 2211.4 2256.7 2260.9 2265.6 2267.4 2191.7 2204.1 2236.8 2251.1 2256.6 2191.8 2217.1 2237.1 2240.1 2253.1 2195.9 2202.9 2219.8 2225.8 2233.3 2264.4 2289.2 2290.6 2295.7 2300.0 7577.4 7584.0 7641.6 7655.8 7671.3 4478.7 4554.6 4569.1 4582.9 4583.8 3026.8 3027.6 3084.0 3099.7 3108.1 919.7 923.2 949.6 957.5 967.3 10362.2 10402.8 10404.1 10438.5 10474.6 4008.3 4078.2 4086.2 4142.5 4143.0 8908.5 8922.3 8923.2 8926.3 8948.8 4522.1 4574.8 4579.7 4588.8 4589.1 4048.0 4187.9 4189.6 4189.7 4211.4 3414.9 3432.7 3438.9 3465.9 3475.8 1037.1 1046.1 1047.6 1054.1 1065.4 1253.6 1267.6 1279.0 1280.2 1285.8 6901.3 6931.2 7011.7 7066.8 7087.8 463.0 466.9 472.5 474.4 474.6 5366.9 5402.1 5459.9 5462.2 5482.0 8313.9 8366.7 8559.7 8566.3 8704.6 8481.6 8504.3 8528.0 8560.2 8619.1 6717.9 6760.1 6801.8 6859.5 6935.4 6352.1 6400.6 6402.3 6403.5 6422.8 7567.1 7697.9 7762.1 7783.1 7811.6 7731.1 7898.3 7931.4 7946.6 8028.1 6424.9 6528.6 6565.9 6595.5 6605.2 7058.5 7063.0 7064.4 7078.0 7089.8 6523.9 6651.3 6655.5 6666.9 6791.9 6510.5 6569.9 6597.8 6703.6 6713.3 6654.0 6675.5 6696.5 6736.5 6746.9 6001.0 6156.3 6175.8 6180.2 6194.4 6007.6 6087.3 6094.9 6099.1 6103.7 11:19:54 INFO - PROCESS | 27113 | 11:19:54 INFO - PROCESS | 27113 | [#4] prototype.html Cycles:180 Average:5545.24 Median:6298.07 stddev:1705.82 (27.1%) stddev-sans-first:1665.19 11:19:54 INFO - PROCESS | 27113 | Values: 336.0 342.8 345.3 348.2 351.9 6227.1 6245.9 6270.3 6318.2 6411.5 6189.0 6252.5 6268.9 6269.3 6274.7 4715.8 4736.6 4745.8 4747.0 4747.6 4723.7 4728.4 4746.8 4749.8 4756.8 4564.5 4591.7 4630.2 4667.3 4671.2 4632.8 4665.8 4667.4 4670.3 4674.1 4069.9 4077.5 4091.9 4092.8 4104.3 5982.6 5991.5 5995.0 5999.5 6008.5 5357.7 5423.6 5460.3 5462.3 5494.9 6524.4 6539.9 6546.4 6556.0 6559.4 4489.0 4498.6 4503.9 4510.3 4517.1 6756.4 6819.1 6839.2 6899.7 6915.9 4577.3 4581.6 4585.2 4585.3 4595.1 4643.8 4671.7 4672.5 4674.8 4685.5 5419.0 5422.6 5424.0 5431.8 5439.0 6503.8 6663.2 6685.2 6685.7 6696.2 1637.3 1654.0 1661.1 1664.8 1667.4 1086.8 1097.1 1103.6 1114.1 1114.4 6227.2 6289.6 6306.5 6317.2 6323.9 6817.2 6826.4 6849.9 6866.1 6867.1 6226.3 6314.8 6316.8 6340.5 6372.1 3740.6 3744.4 3747.1 3754.6 3761.6 7160.6 7166.9 7170.5 7172.7 7185.5 6962.0 7089.5 7116.3 7128.3 7129.9 7218.4 7245.0 7265.7 7271.2 7274.0 6881.1 6884.1 6913.4 6929.1 6932.5 6748.5 6851.5 6859.0 6859.2 6862.3 7230.6 7281.0 7281.3 7291.3 7298.2 4578.8 4639.9 4641.4 4648.9 4650.6 6798.0 6901.2 6922.2 6934.4 6944.2 6681.8 6684.6 6708.2 6711.4 6721.1 6502.6 6659.9 6673.7 6673.7 6674.4 6583.7 6590.3 6592.0 6592.4 6598.6 6690.9 6737.7 6750.5 6759.9 6766.6 6364.2 6535.5 6576.2 6579.3 6588.0 11:19:54 INFO - PROCESS | 27113 | 11:19:54 INFO - PROCESS | 27113 | [#5] yui.html Cycles:180 Average:13523.72 Median:48774.51 stddev:15659.30 (32.1%) stddev-sans-first:15673.60 11:19:54 INFO - PROCESS | 27113 | Values: 696.2 716.2 740.9 773.6 776.6 12692.9 13106.9 13115.6 13121.7 13128.7 12761.0 12810.4 12877.7 12932.2 12978.9 795.0 808.2 819.6 827.1 835.1 826.8 831.5 834.5 839.9 840.5 867.9 869.5 875.2 880.0 880.4 856.5 857.9 863.1 867.9 871.3 634.1 635.6 637.5 638.6 638.8 13333.7 13344.4 13405.1 13409.7 13422.9 11190.9 11293.3 11848.8 12077.4 12589.1 9720.6 9884.6 9913.1 10130.8 10371.7 3433.8 3548.1 3552.9 3565.3 3630.1 47156.0 48619.5 48929.5 49009.3 49051.3 8082.8 8352.1 8534.0 8534.8 8607.0 16384.5 16538.6 16543.7 16547.3 16564.5 7057.0 7201.9 7282.5 7289.5 7314.3 3777.3 3831.7 3857.1 3923.9 3964.1 3018.9 3061.3 3061.4 3067.7 3070.2 551.3 558.6 584.2 584.9 598.8 660.5 674.2 680.5 682.6 685.1 7598.5 7828.9 7890.3 8127.9 8147.0 526.1 561.8 587.3 637.6 709.0 3616.7 3827.0 3863.2 4028.3 4169.2 52349.0 52463.0 52502.7 52553.7 56044.0 47941.3 49518.8 49573.3 50313.7 50404.2 46177.3 46311.0 46667.8 46861.1 47303.0 8465.0 8488.7 8498.6 8500.0 8594.7 35548.0 35828.0 36249.3 36629.6 36800.0 43710.8 45251.3 45324.3 45360.8 45784.0 10850.8 11032.7 11070.3 11251.4 11342.9 12499.2 12564.6 12676.6 12826.9 13014.5 11519.5 11537.7 11792.2 11955.8 12007.6 11161.9 11452.4 11463.6 11646.4 11664.2 9579.4 9643.7 9896.2 9932.5 10017.0 10163.9 10351.6 10481.7 10780.5 11006.6 9210.2 9251.2 9294.9 9794.5 9876.4 11:19:54 INFO - PROCESS | 27113 | -------- Summary: end -------- 11:19:54 INFO - PROCESS | 27113 | 11:19:55 INFO - TEST-INFO | 27113: exit 0 11:19:55 INFO - TEST-OK | dromaeo_css | took 1111621ms 11:19:55 INFO - TEST-START | kraken 11:19:55 INFO - operating with platform_type : linux_ 11:19:55 INFO - Initialising browser for kraken test... 11:19:55 INFO - TEST-INFO | started process 27357 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqT6qIA/profile http://localhost:41443/getInfo.html) 11:19:59 INFO - PROCESS | 27357 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 11:20:00 INFO - PROCESS | 27357 | __metrics Screen width/height:1600/1200 11:20:00 INFO - PROCESS | 27357 | colorDepth:24 11:20:00 INFO - PROCESS | 27357 | Browser inner width/height: 1024/697 11:20:00 INFO - PROCESS | 27357 | __metrics 11:20:00 INFO - PROCESS | 27357 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:20:01 INFO - TEST-INFO | 27357: exit 0 11:20:01 INFO - Browser initialized. 11:20:01 INFO - Running cycle 1/1 for kraken test... 11:20:01 INFO - TEST-INFO | started process 27479 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqT6qIA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:20:13 INFO - PROCESS | 27479 | RSS: Main: 150454272 11:20:13 INFO - PROCESS | 27479 | 11:20:15 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:41443/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41443/tests/kraken/driver.html?testName=audio-beat-detection) 11:20:16 INFO - PROCESS | 27479 | RSS: Main: 151076864 11:20:16 INFO - PROCESS | 27479 | 11:20:18 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:41443/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41443/tests/kraken/driver.html?testName=audio-dft) 11:20:19 INFO - PROCESS | 27479 | RSS: Main: 149979136 11:20:19 INFO - PROCESS | 27479 | 11:20:22 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:41443/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41443/tests/kraken/driver.html?testName=audio-fft) 11:20:22 INFO - PROCESS | 27479 | RSS: Main: 146944000 11:20:22 INFO - PROCESS | 27479 | 11:20:25 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:41443/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41443/tests/kraken/driver.html?testName=audio-oscillator) 11:20:25 INFO - PROCESS | 27479 | RSS: Main: 147009536 11:20:25 INFO - PROCESS | 27479 | 11:20:27 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:41443/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41443/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:20:28 INFO - PROCESS | 27479 | RSS: Main: 146993152 11:20:28 INFO - PROCESS | 27479 | 11:20:31 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:41443/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41443/tests/kraken/driver.html?testName=imaging-darkroom) 11:20:32 INFO - PROCESS | 27479 | RSS: Main: 148021248 11:20:32 INFO - PROCESS | 27479 | 11:20:35 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:41443/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41443/tests/kraken/driver.html?testName=imaging-desaturate) 11:20:35 INFO - PROCESS | 27479 | RSS: Main: 149319680 11:20:35 INFO - PROCESS | 27479 | 11:20:38 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:41443/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41443/tests/kraken/driver.html?testName=json-parse-financial) 11:20:39 INFO - PROCESS | 27479 | RSS: Main: 147668992 11:20:39 INFO - PROCESS | 27479 | 11:20:41 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:41443/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41443/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:20:41 INFO - PROCESS | 27479 | RSS: Main: 149094400 11:20:41 INFO - PROCESS | 27479 | 11:20:43 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:41443/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41443/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:20:44 INFO - PROCESS | 27479 | RSS: Main: 148754432 11:20:44 INFO - PROCESS | 27479 | 11:20:46 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:41443/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41443/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:20:46 INFO - PROCESS | 27479 | RSS: Main: 148828160 11:20:46 INFO - PROCESS | 27479 | 11:20:49 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:41443/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41443/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:20:49 INFO - PROCESS | 27479 | RSS: Main: 148602880 11:20:49 INFO - PROCESS | 27479 | 11:20:52 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:41443/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41443/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:20:53 INFO - PROCESS | 27479 | RSS: Main: 148418560 11:20:53 INFO - PROCESS | 27479 | 11:20:54 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:41443/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41443/tests/kraken/driver.html?testName=ai-astar) 11:20:55 INFO - PROCESS | 27479 | RSS: Main: 148246528 11:20:55 INFO - PROCESS | 27479 | 11:20:55 INFO - PROCESS | 27479 | __start_tp_report 11:20:55 INFO - PROCESS | 27479 | _x_x_mozilla_page_load 11:20:55 INFO - PROCESS | 27479 | _x_x_mozilla_page_load_details 11:20:55 INFO - PROCESS | 27479 | |i|pagename|runs| 11:20:55 INFO - PROCESS | 27479 | |0;ai-astar;115;106;115;112;111;123;112;113;112;111 11:20:55 INFO - PROCESS | 27479 | |1;audio-beat-detection;156;131;155;163;128;167;157;137;164;125 11:20:55 INFO - PROCESS | 27479 | |2;audio-dft;162;165;165;168;163;161;164;176;166;163 11:20:55 INFO - PROCESS | 27479 | |3;audio-fft;75;77;73;72;74;149;72;73;74;74 11:20:55 INFO - PROCESS | 27479 | |4;audio-oscillator;96;96;143;96;98;98;150;96;97;135 11:20:55 INFO - PROCESS | 27479 | |5;imaging-gaussian-blur;110;110;110;109;109;110;109;110;110;110 11:20:55 INFO - PROCESS | 27479 | |6;imaging-darkroom;147;147;148;147;146;147;147;147;147;148 11:20:55 INFO - PROCESS | 27479 | |7;imaging-desaturate;97;97;96;97;96;96;95;97;96;96 11:20:55 INFO - PROCESS | 27479 | |8;json-parse-financial;59;59;57;68;58;58;59;58;54;57 11:20:55 INFO - PROCESS | 27479 | |9;json-stringify-tinderbox;71;67;68;68;67;67;69;68;69;68 11:20:55 INFO - PROCESS | 27479 | |10;stanford-crypto-aes;99;95;94;85;87;86;86;87;87;87 11:20:55 INFO - PROCESS | 27479 | |11;stanford-crypto-ccm;125;117;120;121;122;125;129;117;134;127 11:20:55 INFO - PROCESS | 27479 | |12;stanford-crypto-pbkdf2;145;163;157;146;159;153;164;148;164;149 11:20:55 INFO - PROCESS | 27479 | |13;stanford-crypto-sha256-iterative;70;69;69;70;69;71;75;68;68;69 11:20:55 INFO - PROCESS | 27479 | __end_tp_report 11:20:55 INFO - PROCESS | 27479 | __start_cc_report 11:20:55 INFO - PROCESS | 27479 | _x_x_mozilla_cycle_collect,743 11:20:55 INFO - PROCESS | 27479 | __end_cc_report 11:20:55 INFO - PROCESS | 27479 | __startTimestamp1452194455015__endTimestamp 11:20:55 INFO - PROCESS | 27479 | 11:20:55 INFO - PROCESS | 27479 | ------- Summary: start ------- 11:20:55 INFO - PROCESS | 27479 | Number of tests: 14 11:20:55 INFO - PROCESS | 27479 | 11:20:55 INFO - PROCESS | 27479 | [#0] ai-astar Cycles:10 Average:113.00 Median:112.50 stddev:4.32 (3.8%) stddev-sans-first:4.52 11:20:55 INFO - PROCESS | 27479 | Values: 115.0 106.0 115.0 112.0 111.0 123.0 112.0 113.0 112.0 111.0 11:20:55 INFO - PROCESS | 27479 | 11:20:55 INFO - PROCESS | 27479 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:156.50 stddev:16.24 (10.4%) stddev-sans-first:16.99 11:20:55 INFO - PROCESS | 27479 | Values: 156.0 131.0 155.0 163.0 128.0 167.0 157.0 137.0 164.0 125.0 11:20:55 INFO - PROCESS | 27479 | 11:20:55 INFO - PROCESS | 27479 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.00 stddev:4.27 (2.6%) stddev-sans-first:4.36 11:20:55 INFO - PROCESS | 27479 | Values: 162.0 165.0 165.0 168.0 163.0 161.0 164.0 176.0 166.0 163.0 11:20:55 INFO - PROCESS | 27479 | 11:20:55 INFO - PROCESS | 27479 | [#3] audio-fft Cycles:10 Average:81.30 Median:74.00 stddev:23.83 (32.2%) stddev-sans-first:25.17 11:20:55 INFO - PROCESS | 27479 | Values: 75.0 77.0 73.0 72.0 74.0 149.0 72.0 73.0 74.0 74.0 11:20:55 INFO - PROCESS | 27479 | 11:20:55 INFO - PROCESS | 27479 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:96.00 stddev:22.49 (23.4%) stddev-sans-first:23.23 11:20:55 INFO - PROCESS | 27479 | Values: 96.0 96.0 143.0 96.0 98.0 98.0 150.0 96.0 97.0 135.0 11:20:55 INFO - PROCESS | 27479 | 11:20:55 INFO - PROCESS | 27479 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:20:55 INFO - PROCESS | 27479 | Values: 110.0 110.0 110.0 109.0 109.0 110.0 109.0 110.0 110.0 110.0 11:20:55 INFO - PROCESS | 27479 | 11:20:55 INFO - PROCESS | 27479 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 11:20:55 INFO - PROCESS | 27479 | Values: 147.0 147.0 148.0 147.0 146.0 147.0 147.0 147.0 147.0 148.0 11:20:55 INFO - PROCESS | 27479 | 11:20:55 INFO - PROCESS | 27479 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 11:20:55 INFO - PROCESS | 27479 | Values: 97.0 97.0 96.0 97.0 96.0 96.0 95.0 97.0 96.0 96.0 11:20:55 INFO - PROCESS | 27479 | 11:20:55 INFO - PROCESS | 27479 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:58.50 stddev:3.59 (6.1%) stddev-sans-first:3.81 11:20:55 INFO - PROCESS | 27479 | Values: 59.0 59.0 57.0 68.0 58.0 58.0 59.0 58.0 54.0 57.0 11:20:55 INFO - PROCESS | 27479 | 11:20:55 INFO - PROCESS | 27479 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:0.78 11:20:55 INFO - PROCESS | 27479 | Values: 71.0 67.0 68.0 68.0 67.0 67.0 69.0 68.0 69.0 68.0 11:20:55 INFO - PROCESS | 27479 | 11:20:55 INFO - PROCESS | 27479 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:87.00 stddev:4.83 (5.6%) stddev-sans-first:3.63 11:20:55 INFO - PROCESS | 27479 | Values: 99.0 95.0 94.0 85.0 87.0 86.0 86.0 87.0 87.0 87.0 11:20:55 INFO - PROCESS | 27479 | 11:20:55 INFO - PROCESS | 27479 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:125.00 stddev:5.40 (4.3%) stddev-sans-first:5.70 11:20:55 INFO - PROCESS | 27479 | Values: 125.0 117.0 120.0 121.0 122.0 125.0 129.0 117.0 134.0 127.0 11:20:55 INFO - PROCESS | 27479 | 11:20:55 INFO - PROCESS | 27479 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:158.00 stddev:7.57 (4.8%) stddev-sans-first:7.15 11:20:55 INFO - PROCESS | 27479 | Values: 145.0 163.0 157.0 146.0 159.0 153.0 164.0 148.0 164.0 149.0 11:20:55 INFO - PROCESS | 27479 | 11:20:55 INFO - PROCESS | 27479 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:69.50 stddev:2.04 (2.9%) stddev-sans-first:2.17 11:20:55 INFO - PROCESS | 27479 | Values: 70.0 69.0 69.0 70.0 69.0 71.0 75.0 68.0 68.0 69.0 11:20:55 INFO - PROCESS | 27479 | -------- Summary: end -------- 11:20:55 INFO - PROCESS | 27479 | 11:20:55 INFO - TEST-INFO | 27479: exit 0 11:20:55 INFO - TEST-OK | kraken | took 60606ms 11:20:55 INFO - TEST-START | v8_7 11:20:55 INFO - operating with platform_type : linux_ 11:20:55 INFO - Initialising browser for v8_7 test... 11:20:55 INFO - TEST-INFO | started process 27768 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpc0H4wC/profile http://localhost:41443/getInfo.html) 11:21:00 INFO - PROCESS | 27768 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 11:21:00 INFO - PROCESS | 27768 | __metrics Screen width/height:1600/1200 11:21:00 INFO - PROCESS | 27768 | colorDepth:24 11:21:00 INFO - PROCESS | 27768 | Browser inner width/height: 1024/697 11:21:00 INFO - PROCESS | 27768 | __metrics 11:21:00 INFO - PROCESS | 27768 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:21:01 INFO - TEST-INFO | 27768: exit 0 11:21:01 INFO - Browser initialized. 11:21:01 INFO - Running cycle 1/1 for v8_7 test... 11:21:01 INFO - TEST-INFO | started process 27897 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpc0H4wC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:13 INFO - PROCESS | 27897 | RSS: Main: 151437312 11:21:13 INFO - PROCESS | 27897 | 11:21:35 INFO - PROCESS | 27897 | Cycle 1(1): loaded http://localhost:41443/tests/v8_7/run.html (next: http://localhost:41443/tests/v8_7/run.html) 11:21:35 INFO - PROCESS | 27897 | RSS: Main: 146604032 11:21:35 INFO - PROCESS | 27897 | 11:21:35 INFO - PROCESS | 27897 | __start_tp_report 11:21:35 INFO - PROCESS | 27897 | _x_x_mozilla_page_load 11:21:35 INFO - PROCESS | 27897 | _x_x_mozilla_page_load_details 11:21:35 INFO - PROCESS | 27897 | |i|pagename|runs| 11:21:35 INFO - PROCESS | 27897 | |0;Richards;166.72224074691565 11:21:35 INFO - PROCESS | 27897 | |1;DeltaBlue;188.96447467876038 11:21:35 INFO - PROCESS | 27897 | |2;Encrypt;281.7695125387433 11:21:35 INFO - PROCESS | 27897 | |3;Decrypt;5235.602094240838 11:21:35 INFO - PROCESS | 27897 | |4;RayTrace;1089.3246187363834 11:21:35 INFO - PROCESS | 27897 | |5;Earley;719.4244604316547 11:21:35 INFO - PROCESS | 27897 | |6;Boyer;12268.292682926829 11:21:35 INFO - PROCESS | 27897 | |7;RegExp;25125 11:21:35 INFO - PROCESS | 27897 | |8;Splay;946.7787114845938 11:21:35 INFO - PROCESS | 27897 | |9;NavierStokes;4830.917874396136 11:21:35 INFO - PROCESS | 27897 | __end_tp_report 11:21:35 INFO - PROCESS | 27897 | __startTimestamp1452194495275__endTimestamp 11:21:35 INFO - PROCESS | 27897 | 11:21:35 INFO - PROCESS | 27897 | ------- Summary: start ------- 11:21:35 INFO - PROCESS | 27897 | Number of tests: 10 11:21:35 INFO - PROCESS | 27897 | 11:21:35 INFO - PROCESS | 27897 | [#0] Richards Cycles:1 Average:166.72 Median:166.72 stddev:0.00 (0.0%) 11:21:35 INFO - PROCESS | 27897 | Values: 166.7 11:21:35 INFO - PROCESS | 27897 | 11:21:35 INFO - PROCESS | 27897 | [#1] DeltaBlue Cycles:1 Average:188.96 Median:188.96 stddev:0.00 (0.0%) 11:21:35 INFO - PROCESS | 27897 | Values: 189.0 11:21:35 INFO - PROCESS | 27897 | 11:21:35 INFO - PROCESS | 27897 | [#2] Encrypt Cycles:1 Average:281.77 Median:281.77 stddev:0.00 (0.0%) 11:21:35 INFO - PROCESS | 27897 | Values: 281.8 11:21:35 INFO - PROCESS | 27897 | 11:21:35 INFO - PROCESS | 27897 | [#3] Decrypt Cycles:1 Average:5235.60 Median:5235.60 stddev:0.00 (0.0%) 11:21:35 INFO - PROCESS | 27897 | Values: 5235.6 11:21:35 INFO - PROCESS | 27897 | 11:21:35 INFO - PROCESS | 27897 | [#4] RayTrace Cycles:1 Average:1089.32 Median:1089.32 stddev:0.00 (0.0%) 11:21:35 INFO - PROCESS | 27897 | Values: 1089.3 11:21:35 INFO - PROCESS | 27897 | 11:21:35 INFO - PROCESS | 27897 | [#5] Earley Cycles:1 Average:719.42 Median:719.42 stddev:0.00 (0.0%) 11:21:35 INFO - PROCESS | 27897 | Values: 719.4 11:21:35 INFO - PROCESS | 27897 | 11:21:35 INFO - PROCESS | 27897 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 11:21:35 INFO - PROCESS | 27897 | Values: 12268.3 11:21:35 INFO - PROCESS | 27897 | 11:21:35 INFO - PROCESS | 27897 | [#7] RegExp Cycles:1 Average:25125.00 Median:25125.00 stddev:0.00 (0.0%) 11:21:35 INFO - PROCESS | 27897 | Values: 25125.0 11:21:35 INFO - PROCESS | 27897 | 11:21:35 INFO - PROCESS | 27897 | [#8] Splay Cycles:1 Average:946.78 Median:946.78 stddev:0.00 (0.0%) 11:21:35 INFO - PROCESS | 27897 | Values: 946.8 11:21:35 INFO - PROCESS | 27897 | 11:21:35 INFO - PROCESS | 27897 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 11:21:35 INFO - PROCESS | 27897 | Values: 4830.9 11:21:35 INFO - PROCESS | 27897 | -------- Summary: end -------- 11:21:35 INFO - PROCESS | 27897 | 11:21:36 INFO - TEST-INFO | 27897: exit 0 11:21:36 INFO - TEST-OK | v8_7 | took 40191ms 11:21:36 INFO - SUITE-END | took 1212s 11:21:36 INFO - Completed test suite (00:20:12) 11:21:36 INFO - Working with test: dromaeo_css 11:21:36 INFO - Generating results file: dromaeo_css 11:21:36 INFO - Working with test: kraken 11:21:36 INFO - Generating results file: kraken 11:21:36 INFO - javascript benchmark 11:21:36 INFO - Working with test: v8_7 11:21:36 INFO - Generating results file: v8_7 11:21:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:21:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 11:21:36 INFO - process_Request line: dromaeo_css 6850.18 graph.html#tests=[[72,64,43]] 11:21:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:21:36 INFO - process_Request line: kraken 1536.00 graph.html#tests=[[232,64,43]] 11:21:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:21:36 INFO - process_Request line: v8_7 20346.73 graph.html#tests=[[230,64,43]] 11:21:36 INFO - RETURN: dromaeo_css: 6850.18 11:21:36 INFO - RETURN: kraken: 1536.00 11:21:36 INFO - RETURN: v8_7: 20346.73 11:21:36 INFO - javascript benchmark 11:21:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3192.058342788877, 3229.3864165808495, 3272.9199364209812, 3273.9017829465124, 3290.736741060715, 5145.228215767636, 5248.317718696569, 5294.073537131001, 5361.544268737157, 5364.088105022146, 5267.973660131704, 5309.495597918191, 5378.596605254602, 5479.150731636592, 5514.503694667479, 4919.163742163841, 4982.451930287665, 5032.094223039851, 5056.494350564951, 5070.797168113271, 4834.951650483503, 4935.259711043336, 4970.801167953296, 4981.352424184869, 4993.500649935014, 4760.6429517785955, 4779.068081724065, 4829.203181475034, 4852.0, 4881.682690625098, 4834.250691142844, 4842.878928026827, 4857.9028419431415, 4885.096257192431, 4897.461279259279, 4825.034993001414, 4834.129856625806, 4836.830710925101, 4841.733704646278, 4858.805647774085, 4979.30289759434, 5063.721495317756, 5144.176931690911, 5186.870328241786, 5298.947010529922, 5701.914471282934, 5725.599208055438, 5730.713464326767, 5741.3110426748635, 5761.654300741969, 5758.740856661419, 5784.30588329399, 5795.565332600072, 5799.130130480419, 5806.158107074492, 5278.788848446057, 5287.339082614673, 5373.811916582901, 5390.0836857734275, 5405.21624364465, 5832.650040997553, 5841.824745257649, 5847.26909136358, 5863.472287494146, 5864.70676466175, 5621.550275977912, 5663.122216056518, 5672.092465205547, 5672.744726487318, 5684.8294551163535, 5571.9721401392735, 5597.356304025089, 5657.32112146545, 5658.603897727202, 5667.518260947783, 5591.440855914458, 5617.073182924772, 5628.240187574707, 5640.464155905182, 5650.463205995424, 5731.426857314319, 5783.103618939072, 5823.5923485355615, 5845.970770146122, 5879.441453061952, 4395.164918665443, 4420.005498762753, 4447.399601053881, 4466.9106617867465, 4473.664475164375, 3907.882763517099, 3980.8805735827973, 3988.0428697112484, 3994.6804255659476, 4003.959960400417, 5298.761555730001, 5360.785568577291, 5369.624126311121, 5412.891742165135, 5455.945440545624, 5736.196932429463, 5770.932377510174, 5771.59598828078, 5779.653220806765, 5780.364159942403, 5140.383154021467, 5245.947540524546, 5314.28257185275, 5391.892162156735, 5446.101393270066, 4844.903101937942, 4848.296996935424, 4875.07373599015, 4906.460289368167, 4910.926336104962, 5889.558283128783, 5895.528357731457, 5896.528277737771, 5903.144044113579, 5925.022371308686, 5672.801451949162, 5673.716314184192, 5700.515456186271, 5734.254546908875, 5822.417758224144, 5947.762089516371, 5957.344692083954, 5970.58205925581, 6000.429959153874, 6001.609895356788, 5692.31692196939, 5692.6299790513485, 5702.5437964961875, 5708.971455142698, 5716.28546431696, 5633.605647604629, 5703.828885133453, 5718.942810571841, 5724.055530837365, 5734.311882573951, 5577.721113944205, 5581.832545023656, 5584.664920104807, 5612.943870561242, 5635.126555383922, 5538.556915446835, 5557.305336832896, 5574.609777315549, 5584.664920104807, 5591.384947655836, 5451.536619387396, 5496.725163741877, 5531.059719847555, 5540.75066622011, 5574.637648552994, 5572.052751032254, 5648.971755141198, 5654.378018418053, 5661.801836935688, 5671.858203544779, 5521.944780552304, 5553.6390134641115, 5557.083081291542, 5558.499735023867, 5576.637518561281], "unit": "score", "name": "dojo.html", "value": 5285.039439610545}, {"lowerIsBetter": false, "replicates": [486.107991834983, 544.379407475478, 558.193410521796, 564.700708624429, 599.1851082527764, 29075.418491630156, 34831.4775278371, 34938.12654683634, 35134.64865351345, 35230.0, 41167.0, 42050.15899682004, 42309.0, 42324.36513452301, 42385.36421953673, 8613.22480976712, 8719.869201961976, 8740.169683880022, 8760.299176065899, 8768.649254029831, 8518.318534517224, 8616.698415555456, 8649.178328058824, 8665.090165532623, 8680.30557555394, 8652.740417787445, 8720.825583488326, 8732.738017859474, 8740.562971851414, 8775.385722999392, 8613.655453781841, 8677.1756683115, 8727.909011373578, 8735.170158834964, 8742.300615950773, 8482.321414286904, 8617.827643447159, 8641.135886411372, 8641.740747777514, 8660.090690477535, 39041.60958390408, 39531.80234098811, 39544.209115817524, 39553.80223098895, 39573.40639890404, 3343.7157841583494, 3488.354654388946, 3610.6930910872607, 3716.349638813197, 3940.8423663053445, 29174.124776256747, 29860.850695746598, 30317.24206894823, 30442.54336184959, 31209.687903121132, 3173.5557022016937, 3188.3623275344794, 3194.7444204463586, 3195.4035578613084, 3223.387556364307, 248214.0, 248252.0, 248416.0, 248757.0, 248969.7551512249, 41008.38487422691, 41245.1750964979, 41720.1655966885, 41874.0, 56682.43317566771, 39084.0, 39256.0, 39373.60626393757, 39376.2124757509, 39426.605733942866, 12446.626601201979, 12475.500979960882, 12475.625731228078, 12593.811092833432, 12600.621981340575, 9813.656522021694, 9832.852507212398, 9916.405015699082, 9925.0, 9929.106380425796, 13845.515406960709, 13900.235487048309, 13922.234277114654, 13951.58145255644, 13969.650758731113, 5839.328477225174, 5840.766369345179, 5876.853078672982, 5915.58590898633, 5946.791862284799, 898.5282726568604, 941.6751220828941, 1060.2101434431245, 1096.616184335492, 1160.1241062997383, 29789.255268618457, 30447.23881902926, 31025.534616980764, 31204.687953120632, 31403.0, 966.4636126949611, 968.5496244246459, 1029.5161274201114, 1083.377058191543, 1093.0654290581597, 14756.40974361035, 14910.627234319012, 15116.470923517623, 15229.314680839389, 15283.541493755205, 377056.0, 379510.0, 379694.0, 381157.0, 382563.0, 52340.0, 52567.474325256255, 52584.47415525872, 52912.47087529075, 53256.0, 1345.9192448453125, 1346.6767975685962, 1368.5415385845854, 1373.4025698821044, 1378.3452859891672, 27632.0, 28851.0, 28852.711472885003, 28923.710762892944, 29001.41997160003, 45066.549334507545, 45122.54877451184, 45674.086518270116, 45688.54311456843, 45730.771346143054, 290260.0, 296049.0, 296431.0, 296863.0, 297272.0, 30632.540511892785, 41298.79350603228, 41433.58566414297, 41925.58074419339, 42526.78736606297, 44179.0, 44278.0, 44491.96048526244, 45051.549484504736, 45051.549484506046, 34836.0, 35328.0, 35398.0, 36811.63188368082, 38423.80788096042, 31998.360032798748, 32662.673373266913, 36858.0, 38067.238655227295, 38219.808900955315, 35811.28377432385, 37484.625153748115, 37655.43516847304, 37720.811395942845, 37806.81096594499, 29604.703952960193, 30589.23526911845, 32333.0, 32374.514382284757, 32660.51009234816, 24575.13987010446, 24639.26082217536, 24728.381790455383, 24732.0, 25016.37459063538], "unit": "score", "name": "ext.html", "value": 17672.675453531287}, {"lowerIsBetter": false, "replicates": [362.6029497700018, 362.7732667083073, 365.6946449714487, 366.7432797042071, 369.0846700183543, 16424.753628695566, 16883.662326753456, 17518.824811751896, 17558.473245802645, 18082.186301616424, 10975.725606859813, 10988.175886808482, 11266.4366781661, 11285.605003824869, 11294.152938529623, 4908.656394052417, 4910.656254062208, 4957.405111386621, 4969.8509044728535, 5044.344235249431, 4938.0, 4955.0, 4992.176290912013, 4995.100881841267, 5006.54941055305, 4983.9252411213865, 4988.675736077162, 5150.896982060356, 5317.936412717452, 5322.2548843161985, 5123.38519377677, 5164.948350516484, 5199.194124910626, 5243.370795504545, 5467.425920278393, 5280.10238259493, 5291.3385826771655, 5292.682439053669, 5293.25894374784, 5304.973475132639, 13803.309834508234, 18579.44261672152, 19318.32385866502, 19848.900755496274, 19870.0, 2066.4730493724005, 2102.6951092091563, 2134.893255337227, 2181.8690878547336, 2237.8881055947136, 9473.19477844384, 9853.0, 9889.109980101754, 11929.94035029828, 12563.874361256454, 1705.590658242013, 1706.6083890033974, 1764.347191539126, 1785.366195000782, 1788.669096217204, 58913.41086589122, 60758.696206519126, 61082.0, 62980.685096574685, 63062.68468657627, 9981.500924953723, 10216.846747298649, 10249.231307651957, 10324.741881452874, 10413.895861041445, 13349.0, 13448.529301474597, 13496.595102146755, 13511.391987360592, 13542.526011589547, 7048.92951070493, 7170.139583250043, 7234.927650723531, 7318.414526837841, 7366.337029667356, 6801.421879140328, 6842.178938527409, 6849.417799487, 6874.415674667609, 6895.655217239118, 4411.470623525198, 4466.59800617946, 4475.7985890635, 4492.168948744493, 4515.164694531522, 1770.725537541683, 1804.5759246577045, 1806.97289540657, 1822.4623735997648, 1822.4988128264567, 911.9361644684941, 941.5339406993583, 951.1914872358578, 1050.9632162874263, 1064.7072055184885, 16354.264058117413, 16546.91726541384, 16775.664486710197, 16896.22589628096, 17107.48677539676, 922.8661844032578, 924.1959495239184, 957.5068839547639, 998.0668075349571, 1042.7497400623947, 9527.428354298765, 9549.61801527945, 9644.373115747454, 9649.05726170011, 9679.564419601134, 395232.0, 403766.0, 551313.0, 551878.0, 560066.0, 70047.0, 70615.64692176609, 71206.64396678087, 72487.63756181185, 77650.61174694091, 1086.147374311162, 1134.8014097532898, 1138.2715062360096, 1144.9484773185227, 1165.3881712101215, 14505.709885802014, 15380.538583842503, 15559.45541906028, 15744.842551574338, 15825.208739563206, 30473.847630761706, 31075.844620776752, 31274.53088203633, 31286.0, 31303.686963130076, 36228.63771362358, 37671.24657506889, 38599.42100868545, 39073.41389879211, 45388.31917521306, 9264.907350926405, 9278.628854846, 9561.760955976157, 9658.951705241428, 9670.903290967, 11231.326120432801, 11324.886751132382, 11418.657440276806, 16135.354585816905, 16563.83436165671, 11079.612213572485, 11603.825942611036, 12530.624081277576, 13836.308184590529, 14150.080244784056, 13474.730505389642, 13592.456301748214, 13709.245991470167, 13906.930465347608, 14021.579352619437, 13882.930585347009, 14211.857881421467, 14327.212003339917, 14606.0, 14648.560543183721, 9353.39202951806, 9525.666601669185, 9606.231501479726, 9609.711708648752, 9797.31418800677, 14365.64085897861, 14382.712345753236, 14784.852151478348, 14808.777868331768, 14936.103833770008], "unit": "score", "name": "jquery.html", "value": 8527.080911479168}, {"lowerIsBetter": false, "replicates": [1455.1850963460463, 1481.1409382558113, 1641.926113324901, 1773.7339399090142, 1810.7555480010203, 6776.695048722807, 6877.552959057671, 7463.738769143081, 7638.350740187091, 7653.502522336044, 6923.826904327382, 7089.610071446068, 7118.323759242877, 7128.465365097625, 7156.069710937584, 2211.380813372258, 2256.7291924969027, 2260.886955652219, 2265.592193405186, 2267.38780529257, 2191.660292654641, 2204.1073365287084, 2236.7875051870046, 2251.0883092347626, 2256.6050941085327, 2191.7917797809264, 2217.079911836586, 2237.10515793683, 2240.1263507232193, 2253.0649780341137, 2195.890205489719, 2202.878841663708, 2219.7780221977832, 2225.788550087739, 2233.251860626692, 2264.4225722440838, 2289.1530133850583, 2290.576243394977, 2295.7130358705163, 2299.9655005174936, 7577.355924746404, 7584.0, 7641.579713115776, 7655.808604784869, 7671.309582137635, 4478.686491945565, 4554.63562914966, 4569.109023740372, 4582.908341833145, 4583.793729282191, 3026.7636988010863, 3027.6215473065868, 3083.969160308413, 3099.705527974839, 3108.0675797260956, 919.7194855569048, 923.1507013547485, 949.6486300069018, 957.5254108672635, 967.3373738988815, 10362.222833287533, 10402.843957340647, 10404.115650169744, 10438.530266138043, 10474.58101675932, 4008.2985477541315, 4078.1843631273864, 4086.223617512663, 4142.502899652, 4143.047099167148, 8908.465492070496, 8922.330825188006, 8923.196912277795, 8926.330525210635, 8948.776280593038, 4522.095580883836, 4574.794134263966, 4579.702319349231, 4588.793504292248, 4589.059242855206, 4047.9595204048173, 4187.937180942288, 4189.6438802701505, 4189.706720529594, 4211.43145675336, 3414.9487757683655, 3432.742544309137, 3438.8796392126155, 3465.9133521661656, 3475.7740746851878, 1037.097724979273, 1046.08467590858, 1047.6490375724065, 1054.0987455725399, 1065.4353192807823, 1253.5549879792725, 1267.6133779197248, 1278.9936050319875, 1280.2318608834626, 1285.832841730569, 6901.344372284625, 6931.1682598088555, 7011.719531218796, 7066.752663656747, 7087.82280442993, 462.9884252893637, 466.93929789127196, 472.5274725274725, 474.3998841465549, 474.63927415164034, 5366.946330536723, 5402.081646120169, 5459.863503412367, 5462.2079798429, 5482.0, 8313.916860831314, 8366.707165249187, 8559.700410485728, 8566.3146948244, 8704.608292626846, 8481.575921203916, 8504.277136443348, 8527.957360213159, 8560.186782255676, 8619.138086191457, 6717.865642687118, 6760.121184246016, 6801.829954251183, 6859.451243900476, 6935.375816176568, 6352.0789485525265, 6400.615963042233, 6402.295747467681, 6403.455706265019, 6422.775202867877, 7567.129780075142, 7697.923020769721, 7762.146163922077, 7783.143854175923, 7811.570363630055, 7731.072271327252, 7898.328642065489, 7931.405144614292, 7946.642401091849, 8028.116907140093, 6424.9036264455135, 6528.575642583217, 6565.868682626417, 6595.472362210916, 6605.207375115017, 7058.54119482232, 7063.0, 7064.364207221169, 7078.044463997295, 7089.7873063808165, 6523.902141467787, 6651.33486651331, 6655.534112612264, 6666.866662666816, 6791.898121528082, 6510.511711621552, 6569.9014514783275, 6597.769078082244, 6703.597784132968, 6713.328667133443, 6654.035164901159, 6675.532712710064, 6696.497762667722, 6736.461083113241, 6746.9325306746305, 6001.0, 6156.261248650011, 6175.84560385976, 6180.196574445294, 6194.442500174826, 6007.639541627516, 6087.330393656783, 6094.908576371269, 6099.146119543178, 6103.725332359965], "unit": "score", "name": "mootools.html", "value": 4204.186980686457}, {"lowerIsBetter": false, "replicates": [335.95128706337584, 342.84743289236286, 345.2766454278286, 348.24604730757903, 351.9454484554895, 6227.128202051711, 6245.937540624598, 6270.341614130519, 6318.210223722035, 6411.519136064802, 6189.0, 6252.468540174079, 6268.874622507547, 6269.279032911217, 6274.654893980829, 4715.811367545302, 4736.550027747358, 4745.786439610226, 4746.952530474686, 4747.643926705511, 4723.669343145981, 4728.432588089434, 4746.833860814872, 4749.833755818529, 4756.809727610891, 4564.452265728118, 4591.678582499227, 4630.189716799563, 4667.323238130469, 4671.182543054952, 4632.791524381411, 4665.766711664437, 4667.439907211139, 4670.252759558454, 4674.135284972274, 4069.8779036628653, 4077.510698716173, 4091.9181616367505, 4092.815823287959, 4104.343305071204, 5982.641041537521, 5991.520678345765, 5994.97002514989, 5999.490043346321, 6008.459238668541, 5357.732113394315, 5423.620346575742, 5460.31746031746, 5462.262594549725, 5494.945050549483, 6524.445422139124, 6539.869202615921, 6546.44355229806, 6556.049372840911, 6559.409653131241, 4488.977555112237, 4498.640108791289, 4503.887402814923, 4510.323451482271, 4517.07399983006, 6756.425703815182, 6819.079424277758, 6839.213490448612, 6899.689513971884, 6915.893457046898, 4577.29051996941, 4581.587657110809, 4585.151746926829, 4585.312203169551, 4595.103954728863, 4643.814247430132, 4671.672982891165, 4672.509386514435, 4674.836380726658, 4685.531446855287, 5419.0, 5422.593305502103, 5424.0, 5431.755570999315, 5438.972805135949, 6503.772367967098, 6663.200415950117, 6685.164354455693, 6685.665716714145, 6696.1629796275465, 1637.3450619752196, 1653.983460165383, 1661.1113054515777, 1664.7586100015671, 1667.4497415852738, 1086.8152414089623, 1097.1003776902862, 1103.564092183583, 1114.0530549033258, 1114.3815182573749, 6227.221597300338, 6289.622622642656, 6306.527010474233, 6317.178766760384, 6323.936760632335, 6817.216020157646, 6826.351496607815, 6849.863002739918, 6866.073080134218, 6867.141607299088, 6226.25284965798, 6314.8421289467215, 6316.810495685137, 6340.524460665469, 6372.139761132188, 3740.6072362401555, 3744.4383342498845, 3747.063234191452, 3754.568224654145, 3761.586225515191, 7160.606166660884, 7166.892496612555, 7170.4622153338705, 7172.748953786592, 7185.49701520899, 6962.0, 7089.539179953286, 7116.252793456716, 7128.322809333105, 7129.89305160423, 7218.422526197892, 7244.963775181091, 7265.745698900513, 7271.163816161209, 7274.018007569016, 6881.071055407456, 6884.139482564679, 6913.3777959983845, 6929.133858267716, 6932.48006399512, 6748.527603067738, 6851.45188384938, 6859.039734437282, 6859.211190713132, 6862.348076932683, 7230.6384680764695, 7281.0, 7281.2718728126765, 7291.30732580404, 7298.160711518243, 4578.839740609063, 4639.86080417588, 4641.396618439716, 4648.907021859612, 4650.604698600521, 6798.0, 6901.1718593769065, 6922.238553758982, 6934.375906168469, 6944.201416837129, 6681.76613818514, 6684.63234522106, 6708.228553716385, 6711.395974362331, 6721.092652491851, 6502.577332473374, 6659.933400665931, 6673.666316684049, 6673.733050677918, 6674.365935236145, 6583.736650534117, 6590.340965903371, 6591.967040164768, 6592.373724496165, 6598.637074960731, 6690.899636505554, 6737.730490780314, 6750.5274630775375, 6759.932400676127, 6766.627835469097, 6364.172657554488, 6535.509836762167, 6576.243731970884, 6579.309172536815, 6588.04473351371], "unit": "score", "name": "prototype.html", "value": 4987.905700230625}, {"lowerIsBetter": false, "replicates": [696.1785093589564, 716.1942814333875, 740.8555331710319, 773.6325245508383, 776.6000509737482, 12692.873071269285, 13106.868931310684, 13115.60653180405, 13121.67195820105, 13128.671783205426, 12761.0, 12810.359482025908, 12877.74244515109, 12932.159409638367, 12978.93510532446, 794.9682012719499, 808.2241048593357, 819.6229734322219, 827.1108558299821, 835.052215735142, 826.7933016745814, 831.4969443486694, 834.5159807311775, 839.911809260028, 840.5251033166242, 867.9435836670627, 869.5304535550795, 875.1511034296753, 880.0, 880.4277219807112, 856.4989481153564, 857.8927634045745, 863.0506442912808, 867.9281087856492, 871.2855458524012, 634.0742515926753, 635.5995722694719, 637.4549759955217, 638.6455517187959, 638.8339031851706, 13333.666658333523, 13344.399502022336, 13405.128666636638, 13409.66475838102, 13422.86577134226, 11190.94404527972, 11293.322400655987, 11848.822267665992, 12077.396130193543, 12589.055820813384, 9720.61117555297, 9884.604615815359, 9913.107820296207, 10130.805196357163, 10371.740706482324, 3433.8111403872776, 3548.1307079765365, 3552.8934131976084, 3565.322588708163, 3630.146915474861, 47156.0, 48619.513804861854, 48929.510704893204, 49009.26486102711, 49051.26423103656, 8082.7588939070365, 8352.12302708219, 8533.957330213309, 8534.78663033429, 8607.0, 16384.508464746075, 16538.58653533671, 16543.669126617642, 16547.338106475847, 16564.503064908073, 7057.0472986146215, 7201.855962880713, 7282.4902256841515, 7289.453291003196, 7314.341709246193, 3777.338965680995, 3831.65515103642, 3857.1128640412862, 3923.941140882889, 3964.1080756829483, 3018.9245268868017, 3061.2652963289097, 3061.3724186541704, 3067.693230676959, 3070.2170946408523, 551.3273805956726, 558.5810642018486, 584.1821449970076, 584.8976429124971, 598.796409220867, 660.5046215338496, 674.2246416620827, 680.4896327754184, 682.617734068923, 685.0990946904805, 7598.468107232551, 7828.921710782819, 7890.250426209501, 8127.878081828777, 8146.959265203636, 526.1292560811786, 561.811793049333, 587.3157771196594, 637.5740308127527, 708.9716411343488, 3616.710663146942, 3826.9617303826603, 3863.208042351311, 4028.335324671455, 4169.187008533368, 52349.0, 52463.0, 52502.73748631309, 52553.737231314364, 56044.0, 47941.28088078681, 49518.75240623774, 49573.25640115329, 50313.74843125761, 50404.24393634099, 46177.30734038992, 46311.0, 46667.766661166475, 46861.06277874492, 47303.0, 8465.0, 8488.702895398632, 8498.575071246536, 8500.0, 8594.742157735027, 35548.0, 35828.0, 36249.27501450009, 36629.63370366262, 36800.0, 43710.781446092566, 45251.28492290473, 45324.32013519866, 45360.77319613381, 45784.0, 10850.837237441287, 11032.669019929415, 11070.335779853234, 11251.437428128724, 11342.886571134513, 12499.187552809039, 12564.560240391542, 12676.556320529106, 12826.935865320987, 13014.544490942772, 11519.53921843117, 11537.711557211136, 11792.174547781573, 11955.820662690241, 12007.639770806889, 11161.939615736492, 11452.427378631202, 11463.598774042868, 11646.359450230319, 11664.241824281735, 9579.377340472847, 9643.710688679352, 9896.208303335572, 9932.503374831374, 10017.0, 10163.94918025405, 10351.63769268072, 10481.685549433529, 10780.460976950964, 11006.614768483065, 9210.171084602418, 9251.167394934488, 9294.907050929674, 9794.461304628314, 9876.35803672759], "unit": "score", "name": "yui.html", "value": 6186.156075265271}], "name": "dromaeo_css", "value": 6850.174735521908}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 106.0, 115.0, 112.0, 111.0, 123.0, 112.0, 113.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 113.0}, {"lowerIsBetter": true, "replicates": [156.0, 131.0, 155.0, 163.0, 128.0, 167.0, 157.0, 137.0, 164.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 148.3}, {"lowerIsBetter": true, "replicates": [162.0, 165.0, 165.0, 168.0, 163.0, 161.0, 164.0, 176.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 165.3}, {"lowerIsBetter": true, "replicates": [75.0, 77.0, 73.0, 72.0, 74.0, 149.0, 72.0, 73.0, 74.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 143.0, 96.0, 98.0, 98.0, 150.0, 96.0, 97.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 97.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 57.0, 68.0, 58.0, 58.0, 59.0, 58.0, 54.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.7}, {"lowerIsBetter": true, "replicates": [71.0, 67.0, 68.0, 68.0, 67.0, 67.0, 69.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [99.0, 95.0, 94.0, 85.0, 87.0, 86.0, 86.0, 87.0, 87.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.3}, {"lowerIsBetter": true, "replicates": [125.0, 117.0, 120.0, 121.0, 122.0, 125.0, 129.0, 117.0, 134.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.7}, {"lowerIsBetter": true, "replicates": [145.0, 163.0, 157.0, 146.0, 159.0, 153.0, 164.0, 148.0, 164.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.8}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 70.0, 69.0, 71.0, 75.0, 68.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1536.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.72224074691565], "unit": "score", "name": "Richards", "value": 211.74139599999998}, {"lowerIsBetter": false, "replicates": [188.96447467876038], "unit": "score", "name": "DeltaBlue", "value": 349.896456}, {"lowerIsBetter": false, "replicates": [281.7695125387433], "unit": "score", "name": "Encrypt", "value": 944.6763689999997}, {"lowerIsBetter": false, "replicates": [5235.602094240838], "unit": "score", "name": "Decrypt", "value": 50.84057100000005}, {"lowerIsBetter": false, "replicates": [1089.3246187363834], "unit": "score", "name": "RayTrace", "value": 679.3099019999999}, {"lowerIsBetter": false, "replicates": [719.4244604316547], "unit": "score", "name": "Earley", "value": 926.3835699999998}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [25125.0], "unit": "score", "name": "RegExp", "value": 36.25810945273629}, {"lowerIsBetter": false, "replicates": [946.7787114845938], "unit": "score", "name": "Splay", "value": 86.07185502958583}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20346.72504773858}]} 11:21:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20346.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1536.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6850.18"}}} 11:21:36 INFO - Return code: 0 11:21:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:21:36 INFO - # TBPL SUCCESS # 11:21:36 INFO - Running post-action listener: _resource_record_post_action 11:21:36 INFO - Running post-run listener: _resource_record_post_run 11:21:37 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 571719680; Read time: 0; Write time: 855744 11:21:37 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 246628352; Read time: 0; Write time: 455932 11:21:37 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 321060864; Read time: 0; Write time: 399232 11:21:37 INFO - Running post-run listener: _upload_blobber_files 11:21:37 INFO - Blob upload gear active. 11:21:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:21:37 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 11:21:37 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 11:21:37 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 11:21:38 INFO - (blobuploader) - INFO - Open directory for files ... 11:21:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:21:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:21:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:21:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:38 INFO - (blobuploader) - INFO - Done attempting. 11:21:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:21:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:21:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:21:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:39 INFO - (blobuploader) - INFO - Done attempting. 11:21:39 INFO - (blobuploader) - INFO - Iteration through files over. 11:21:39 INFO - Return code: 0 11:21:39 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:21:39 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:21:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc84bd644d41100b2218607613ae4d4d8ab9cf5e22e6d18127f99c72525529c1fb5ace2b9984d1252791fa4ff5f3a9edeac68bced1cd65f110fdd077b0badeb6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7bb802b18185d699df69da155f345d247fe8bce57381737f86f74eca5591b4274acf9bf61dc15721db0d3ef28682926429a7c4c2236112a445f5a111aa83166f"} 11:21:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:21:39 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:21:39 INFO - Contents: 11:21:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc84bd644d41100b2218607613ae4d4d8ab9cf5e22e6d18127f99c72525529c1fb5ace2b9984d1252791fa4ff5f3a9edeac68bced1cd65f110fdd077b0badeb6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7bb802b18185d699df69da155f345d247fe8bce57381737f86f74eca5591b4274acf9bf61dc15721db0d3ef28682926429a7c4c2236112a445f5a111aa83166f"} 11:21:39 INFO - Copying logs to upload dir... 11:21:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.906986 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-07 11:21:37.829439) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 11:21:37.833455) ========= 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-1452192428.915715-1933112473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc84bd644d41100b2218607613ae4d4d8ab9cf5e22e6d18127f99c72525529c1fb5ace2b9984d1252791fa4ff5f3a9edeac68bced1cd65f110fdd077b0badeb6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7bb802b18185d699df69da155f345d247fe8bce57381737f86f74eca5591b4274acf9bf61dc15721db0d3ef28682926429a7c4c2236112a445f5a111aa83166f"} build_url:https://queue.taskcluster.net/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/VAxRxLBLT_yvFvz6hPZiUQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc84bd644d41100b2218607613ae4d4d8ab9cf5e22e6d18127f99c72525529c1fb5ace2b9984d1252791fa4ff5f3a9edeac68bced1cd65f110fdd077b0badeb6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7bb802b18185d699df69da155f345d247fe8bce57381737f86f74eca5591b4274acf9bf61dc15721db0d3ef28682926429a7c4c2236112a445f5a111aa83166f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 11:21:37.858674) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 11:21:37.859007) ========= 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-1452192428.915715-1933112473 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 11:21:37.941815) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 11:21:37.942141) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 11:21:37.942439) ========= ========= Total master_lag: 0.20 =========