builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1452203129.29 results: success (0) buildid: 20160107113022 builduid: 1a941b937875426a9200a12e4788e9c0 revision: a0df531dbd608ec8655b55de8fd9f07a3de06206 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:29.291392) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:29.291793) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:29.292087) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006416 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:29.315795) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:29.316087) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:29.348431) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:29.348680) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004624 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:29.411363) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:29.411630) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:29.411953) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:29.412245) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 13:45:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.2M=0s 2016-01-07 13:45:29 (40.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163283 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:29.588648) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:29.588943) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017747 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:29.637968) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:29.638288) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev a0df531dbd608ec8655b55de8fd9f07a3de06206 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev a0df531dbd608ec8655b55de8fd9f07a3de06206 --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=2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 13:45:29,882 truncating revision to first 12 chars 2016-01-07 13:45:29,882 Setting DEBUG logging. 2016-01-07 13:45:29,882 attempt 1/10 2016-01-07 13:45:29,882 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/a0df531dbd60?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 13:45:30,305 unpacking tar archive at: b2g-inbound-a0df531dbd60/testing/mozharness/ program finished with exit code 0 elapsedTime=0.721168 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:30.372040) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:30.372359) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:30.382833) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:30.383125) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 13:45:30.383530) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-07 13:45:30.383813) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:45:30 INFO - MultiFileLogger online at 20160107 13:45:30 in /builds/slave/test-pgo 13:45:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 13:45:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:45:30 INFO - {'append_to_log': False, 13:45:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:45:30 INFO - 'blob_upload_branch': 'B2G-Inbound', 13:45:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:45:30 INFO - 'branch': 'B2G-Inbound', 13:45:30 INFO - 'buildbot_json_path': 'buildprops.json', 13:45:30 INFO - 'config_files': ('talos/linux_config.py',), 13:45:30 INFO - 'default_actions': ('clobber', 13:45:30 INFO - 'read-buildbot-config', 13:45:30 INFO - 'download-and-extract', 13:45:30 INFO - 'populate-webroot', 13:45:30 INFO - 'create-virtualenv', 13:45:30 INFO - 'install', 13:45:30 INFO - 'run-tests'), 13:45:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:45:30 INFO - 'download_minidump_stackwalk': True, 13:45:30 INFO - 'download_symbols': 'ondemand', 13:45:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:45:30 INFO - 'tooltool.py': '/tools/tooltool.py', 13:45:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:45:30 INFO - '/tools/misc-python/virtualenv.py')}, 13:45:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:45:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:45:30 INFO - 'installer_path': 'installer.exe', 13:45:30 INFO - 'log_level': 'info', 13:45:30 INFO - 'log_name': 'talos', 13:45:30 INFO - 'log_to_console': True, 13:45:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:45:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:45:30 INFO - 'opt_config_files': (), 13:45:30 INFO - 'pip_index': False, 13:45:30 INFO - 'sps_profile': False, 13:45:30 INFO - 'sps_profile_interval': 0, 13:45:30 INFO - 'suite': 'dromaeojs', 13:45:30 INFO - 'system_bits': '32', 13:45:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:45:30 INFO - 'title': 'talos-linux64-ix-012', 13:45:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:45:30 INFO - 'use_talos_json': True, 13:45:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:45:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:45:30 INFO - 'work_dir': 'build'} 13:45:30 INFO - ##### 13:45:30 INFO - ##### Running clobber step. 13:45:30 INFO - ##### 13:45:30 INFO - Running pre-action listener: _resource_record_pre_action 13:45:30 INFO - Running main action method: clobber 13:45:30 INFO - rmtree: /builds/slave/test-pgo/build 13:45:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:45:31 INFO - Running post-action listener: _resource_record_post_action 13:45:31 INFO - ##### 13:45:31 INFO - ##### Running read-buildbot-config step. 13:45:31 INFO - ##### 13:45:31 INFO - Running pre-action listener: _resource_record_pre_action 13:45:31 INFO - Running main action method: read_buildbot_config 13:45:31 INFO - Using buildbot properties: 13:45:31 INFO - { 13:45:31 INFO - "project": "", 13:45:31 INFO - "product": "firefox", 13:45:31 INFO - "script_repo_revision": "production", 13:45:31 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 13:45:31 INFO - "repository": "", 13:45:31 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 13:45:31 INFO - "buildid": "20160107113022", 13:45:31 INFO - "pgo_build": "True", 13:45:31 INFO - "basedir": "/builds/slave/test-pgo", 13:45:31 INFO - "buildnumber": 193, 13:45:31 INFO - "slavename": "talos-linux64-ix-012", 13:45:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:45:31 INFO - "platform": "ubuntu64_hw", 13:45:31 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 13:45:31 INFO - "branch": "b2g-inbound", 13:45:31 INFO - "repo_path": "integration/b2g-inbound", 13:45:31 INFO - "revision": "a0df531dbd608ec8655b55de8fd9f07a3de06206", 13:45:31 INFO - "stage_platform": "linux64-pgo", 13:45:31 INFO - "builduid": "1a941b937875426a9200a12e4788e9c0", 13:45:31 INFO - "slavebuilddir": "test" 13:45:31 INFO - } 13:45:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:45:31 INFO - Running post-action listener: _resource_record_post_action 13:45:31 INFO - ##### 13:45:31 INFO - ##### Running download-and-extract step. 13:45:31 INFO - ##### 13:45:31 INFO - Running pre-action listener: _resource_record_pre_action 13:45:31 INFO - Running main action method: download_and_extract 13:45:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:31 INFO - https://queue.taskcluster.net/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:45:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/test_packages.json 13:45:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/test_packages.json 13:45:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:45:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:45:32 INFO - Downloaded 1302 bytes. 13:45:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:45:32 INFO - Using the following test package requirements: 13:45:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:45:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:45:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:32 INFO - u'jsshell-linux-x86_64.zip'], 13:45:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:45:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:45:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:45:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:45:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:45:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:45:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:45:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:45:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:45: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')]} 13:45:32 INFO - https://queue.taskcluster.net/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:45:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:45:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:45:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/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 13:45:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/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 13:45:34 INFO - Downloaded 24056311 bytes. 13:45:34 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 13:45:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:45:34 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 13:45:35 INFO - Return code: 0 13:45:35 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 13:45:35 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')]} 13:45:35 INFO - https://queue.taskcluster.net/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:45:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:45:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:45:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/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 13:45:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/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 13:45:41 INFO - Downloaded 24056311 bytes. 13:45:41 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 13:45:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:45:41 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 13:45:42 INFO - Return code: 0 13:45:42 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')]} 13:45:42 INFO - https://queue.taskcluster.net/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:45:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:45:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:45:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/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 13:45:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/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 13:45:43 INFO - Downloaded 11132285 bytes. 13:45:43 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 13:45:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:45:43 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 13:45:43 INFO - Return code: 0 13:45:43 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')]} 13:45:43 INFO - https://queue.taskcluster.net/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:45:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:45:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:45:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/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 13:45:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UqmxgjGMTgy3PDbbnRcy6A/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 13:45:45 INFO - Downloaded 55943355 bytes. 13:45:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:45:45 INFO - mkdir: /builds/slave/test-pgo/properties 13:45:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:45:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:45:45 INFO - Contents: 13:45:45 INFO - build_url:https://queue.taskcluster.net/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:45:45 INFO - Running post-action listener: _resource_record_post_action 13:45:45 INFO - Running post-action listener: set_extra_try_arguments 13:45:45 INFO - ##### 13:45:45 INFO - ##### Running populate-webroot step. 13:45:45 INFO - ##### 13:45:45 INFO - Running pre-action listener: _resource_record_pre_action 13:45:45 INFO - Running main action method: populate_webroot 13:45:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:45:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:45:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:45:45 INFO - '--tppagecycles', 13:45:45 INFO - '7'], 13:45:45 INFO - 'tests': ['tsvgm']}}, 13:45:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:45:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:45:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:45:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:45:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:45:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:45:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:45:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:45 INFO - 'talos_options': ['--e10s'], 13:45:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:45:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:45 INFO - 'tests': ['damp', 'tps']}, 13:45:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:45 INFO - 'talos_options': ['--e10s'], 13:45:45 INFO - 'tests': ['damp', 'tps']}, 13:45:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:45:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:45:45 INFO - 'other': {'tests': ['a11yr', 13:45:45 INFO - 'ts_paint', 13:45:45 INFO - 'tpaint', 13:45:45 INFO - 'sessionrestore', 13:45:45 INFO - 'sessionrestore_no_auto_restore']}, 13:45:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:45:45 INFO - 'tests': ['a11yr', 13:45:45 INFO - 'ts_paint', 13:45:45 INFO - 'tpaint', 13:45:45 INFO - 'sessionrestore', 13:45:45 INFO - 'sessionrestore_no_auto_restore']}, 13:45:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:45:45 INFO - 'tests': ['a11yr', 13:45:45 INFO - 'ts_paint', 13:45:45 INFO - 'tpaint', 13:45:45 INFO - 'sessionrestore', 13:45:45 INFO - 'sessionrestore_no_auto_restore']}, 13:45:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:45:45 INFO - 'tests': ['a11yr', 13:45:45 INFO - 'ts_paint', 13:45:45 INFO - 'tpaint', 13:45:45 INFO - 'sessionrestore', 13:45:45 INFO - 'sessionrestore_no_auto_restore']}, 13:45:45 INFO - 'other_l64': {'tests': ['a11yr', 13:45:45 INFO - 'ts_paint', 13:45:45 INFO - 'tpaint', 13:45:45 INFO - 'sessionrestore', 13:45:45 INFO - 'sessionrestore_no_auto_restore']}, 13:45:45 INFO - 'other_nol64': {'tests': ['a11yr', 13:45:45 INFO - 'ts_paint', 13:45:45 INFO - 'tpaint', 13:45:45 INFO - 'sessionrestore', 13:45:45 INFO - 'sessionrestore_no_auto_restore']}, 13:45:45 INFO - 'svgr': {'tests': ['tsvgx', 13:45:45 INFO - 'tsvgr_opacity', 13:45:45 INFO - 'tart', 13:45:45 INFO - 'tscrollx', 13:45:45 INFO - 'cart']}, 13:45:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:45:45 INFO - 'tests': ['tsvgx', 13:45:45 INFO - 'tsvgr_opacity', 13:45:45 INFO - 'tart', 13:45:45 INFO - 'tscrollx', 13:45:45 INFO - 'cart']}, 13:45:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:45 INFO - 'tests': ['tp5o']}, 13:45:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:45 INFO - 'talos_options': ['--e10s'], 13:45:45 INFO - 'tests': ['tp5o']}, 13:45:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:45 INFO - 'talos_options': ['--xperf_path', 13:45:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:45:45 INFO - 'tests': ['tp5n']}, 13:45:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:45 INFO - 'talos_options': ['--e10s', 13:45:45 INFO - '--xperf_path', 13:45:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:45:45 INFO - 'tests': ['tp5n']}}, 13:45:45 INFO - 'talos.zip': {'path': '', 13:45:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:45:45 INFO - Running post-action listener: _resource_record_post_action 13:45:45 INFO - ##### 13:45:45 INFO - ##### Running create-virtualenv step. 13:45:45 INFO - ##### 13:45:45 INFO - Running pre-action listener: _resource_record_pre_action 13:45:45 INFO - Running main action method: create_virtualenv 13:45:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:45:45 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 13:45:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:45:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:45:45 INFO - Using real prefix '/usr' 13:45:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:45:45 INFO - Installing distribute.............................................................................................................................................................................................done. 13:45:47 INFO - Installing pip.................done. 13:45:47 INFO - Return code: 0 13:45:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:45: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')]} 13:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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')]} 13:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f306acfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe10840>, '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 0xd7d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7db60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251', '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 13:45: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 13:45: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 pip>=1.5 13:45:47 INFO - Using env: {'DISPLAY': ':0', 13:45:47 INFO - 'HOME': '/home/cltbld', 13:45:47 INFO - 'LANG': 'en_US.UTF-8', 13:45:47 INFO - 'LANGUAGE': 'en_US:en', 13:45:47 INFO - 'LOGNAME': 'cltbld', 13:45:47 INFO - 'MAIL': '/var/mail/cltbld', 13:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:47 INFO - 'MOZ_NO_REMOTE': '1', 13:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:47 INFO - 'NO_EM_RESTART': '1', 13:45:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:45:47 INFO - 'PWD': '/builds/slave/test-pgo', 13:45:47 INFO - 'SHELL': '/bin/bash', 13:45:47 INFO - 'SHLVL': '1', 13:45:47 INFO - 'TERM': 'linux', 13:45:47 INFO - 'TMOUT': '86400', 13:45:47 INFO - 'USER': 'cltbld', 13:45:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251', 13:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:47 INFO - '_': '/tools/buildbot/bin/python'} 13:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:48 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 13:45:48 INFO - Cleaning up... 13:45:48 INFO - Return code: 0 13:45:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f306acfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe10840>, '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 0xd7d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7db60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251', '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 13:45:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 13:45:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:45:48 INFO - Using env: {'DISPLAY': ':0', 13:45:48 INFO - 'HOME': '/home/cltbld', 13:45:48 INFO - 'LANG': 'en_US.UTF-8', 13:45:48 INFO - 'LANGUAGE': 'en_US:en', 13:45:48 INFO - 'LOGNAME': 'cltbld', 13:45:48 INFO - 'MAIL': '/var/mail/cltbld', 13:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:48 INFO - 'MOZ_NO_REMOTE': '1', 13:45:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:48 INFO - 'NO_EM_RESTART': '1', 13:45:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:45:48 INFO - 'PWD': '/builds/slave/test-pgo', 13:45:48 INFO - 'SHELL': '/bin/bash', 13:45:48 INFO - 'SHLVL': '1', 13:45:48 INFO - 'TERM': 'linux', 13:45:48 INFO - 'TMOUT': '86400', 13:45:48 INFO - 'USER': 'cltbld', 13:45:48 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251', 13:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:48 INFO - '_': '/tools/buildbot/bin/python'} 13:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:48 INFO - Downloading/unpacking psutil>=0.7.1 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:45:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:45:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:45:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:45:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:45:50 INFO - Installing collected packages: psutil 13:45:50 INFO - Running setup.py install for psutil 13:45:50 INFO - building 'psutil._psutil_linux' extension 13:45:50 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 13:45:50 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 13:45:50 INFO - building 'psutil._psutil_posix' extension 13:45:50 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 13:45:50 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 13:45:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:45:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:45:50 INFO - Successfully installed psutil 13:45:50 INFO - Cleaning up... 13:45:50 INFO - Return code: 0 13:45:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:45: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')]} 13:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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')]} 13:45:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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', '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 0x7f306acfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe10840>, '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 0xd7d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7db60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251', '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 13:45: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 13:45: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 mozsystemmonitor==0.0.0 13:45:50 INFO - Using env: {'DISPLAY': ':0', 13:45:50 INFO - 'HOME': '/home/cltbld', 13:45:50 INFO - 'LANG': 'en_US.UTF-8', 13:45:50 INFO - 'LANGUAGE': 'en_US:en', 13:45:50 INFO - 'LOGNAME': 'cltbld', 13:45:50 INFO - 'MAIL': '/var/mail/cltbld', 13:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:50 INFO - 'MOZ_NO_REMOTE': '1', 13:45:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:50 INFO - 'NO_EM_RESTART': '1', 13:45:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:45:50 INFO - 'PWD': '/builds/slave/test-pgo', 13:45:50 INFO - 'SHELL': '/bin/bash', 13:45:50 INFO - 'SHLVL': '1', 13:45:50 INFO - 'TERM': 'linux', 13:45:50 INFO - 'TMOUT': '86400', 13:45:50 INFO - 'USER': 'cltbld', 13:45:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251', 13:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:50 INFO - '_': '/tools/buildbot/bin/python'} 13:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:45:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:45:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:45:52 INFO - Installing collected packages: mozsystemmonitor 13:45:52 INFO - Running setup.py install for mozsystemmonitor 13:45:52 INFO - Successfully installed mozsystemmonitor 13:45:52 INFO - Cleaning up... 13:45:52 INFO - Return code: 0 13:45:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f306acfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe10840>, '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 0xd7d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7db60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251', '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 13:45:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 13:45:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:45:52 INFO - Using env: {'DISPLAY': ':0', 13:45:52 INFO - 'HOME': '/home/cltbld', 13:45:52 INFO - 'LANG': 'en_US.UTF-8', 13:45:52 INFO - 'LANGUAGE': 'en_US:en', 13:45:52 INFO - 'LOGNAME': 'cltbld', 13:45:52 INFO - 'MAIL': '/var/mail/cltbld', 13:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:52 INFO - 'MOZ_NO_REMOTE': '1', 13:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:52 INFO - 'NO_EM_RESTART': '1', 13:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:45:52 INFO - 'PWD': '/builds/slave/test-pgo', 13:45:52 INFO - 'SHELL': '/bin/bash', 13:45:52 INFO - 'SHLVL': '1', 13:45:52 INFO - 'TERM': 'linux', 13:45:52 INFO - 'TMOUT': '86400', 13:45:52 INFO - 'USER': 'cltbld', 13:45:52 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251', 13:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:52 INFO - '_': '/tools/buildbot/bin/python'} 13:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:53 INFO - Downloading/unpacking blobuploader==1.2.4 13:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:54 INFO - Downloading blobuploader-1.2.4.tar.gz 13:45:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:45:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:45:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:45:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:45:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:45:55 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 13:45:55 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 13:45:55 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 13:45:55 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 13:45:55 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 13:45:55 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 13:45:55 INFO - Downloading docopt-0.6.1.tar.gz 13:45:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:45:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:45:55 INFO - Installing collected packages: blobuploader, requests, docopt 13:45:55 INFO - Running setup.py install for blobuploader 13:45:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:45:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:45:55 INFO - Running setup.py install for requests 13:45:55 INFO - Running setup.py install for docopt 13:45:55 INFO - Successfully installed blobuploader requests docopt 13:45:55 INFO - Cleaning up... 13:45:56 INFO - Return code: 0 13:45:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:45: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')]} 13:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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')]} 13:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:56 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 0x7f306acfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe10840>, '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 0xd7d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7db60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251', '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 13:45:56 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 13:45:56 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 13:45:56 INFO - Using env: {'DISPLAY': ':0', 13:45:56 INFO - 'HOME': '/home/cltbld', 13:45:56 INFO - 'LANG': 'en_US.UTF-8', 13:45:56 INFO - 'LANGUAGE': 'en_US:en', 13:45:56 INFO - 'LOGNAME': 'cltbld', 13:45:56 INFO - 'MAIL': '/var/mail/cltbld', 13:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:56 INFO - 'MOZ_NO_REMOTE': '1', 13:45:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:56 INFO - 'NO_EM_RESTART': '1', 13:45:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:45:56 INFO - 'PWD': '/builds/slave/test-pgo', 13:45:56 INFO - 'SHELL': '/bin/bash', 13:45:56 INFO - 'SHLVL': '1', 13:45:56 INFO - 'TERM': 'linux', 13:45:56 INFO - 'TMOUT': '86400', 13:45:56 INFO - 'USER': 'cltbld', 13:45:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251', 13:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:56 INFO - '_': '/tools/buildbot/bin/python'} 13:45:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:45:56 INFO - Running setup.py (path:/tmp/pip-_R9oih-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:45:56 INFO - Running setup.py (path:/tmp/pip-4mWWg8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:45:56 INFO - Running setup.py (path:/tmp/pip-nkOa3E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:45:56 INFO - Running setup.py (path:/tmp/pip-qq9IFz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:45:56 INFO - Running setup.py (path:/tmp/pip-NIh1bh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:45:56 INFO - Running setup.py (path:/tmp/pip-7TVbiV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:45:56 INFO - Running setup.py (path:/tmp/pip-kuAq2w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:45:56 INFO - Running setup.py (path:/tmp/pip-_Tm9JL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:45:56 INFO - Running setup.py (path:/tmp/pip-LEAuyi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:45:56 INFO - Running setup.py (path:/tmp/pip-jkiAGA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:45:56 INFO - Running setup.py (path:/tmp/pip-gj1XP1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:45:57 INFO - Running setup.py (path:/tmp/pip-svUadu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:45:57 INFO - Running setup.py (path:/tmp/pip-ubm88r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:45:57 INFO - Running setup.py (path:/tmp/pip-ZQYAtD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:45:57 INFO - Running setup.py (path:/tmp/pip-_uD9BF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:45:57 INFO - Running setup.py (path:/tmp/pip-qVAMk2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:45:57 INFO - Running setup.py (path:/tmp/pip-jyDnha-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:45:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:45:57 INFO - Running setup.py install for manifestparser 13:45:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:45:57 INFO - Running setup.py install for mozcrash 13:45:57 INFO - Running setup.py install for mozdebug 13:45:57 INFO - Running setup.py install for mozdevice 13:45:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:45:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:45:57 INFO - Running setup.py install for mozfile 13:45:58 INFO - Running setup.py install for mozhttpd 13:45:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:45:58 INFO - Running setup.py install for mozinfo 13:45:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:45:58 INFO - Running setup.py install for mozInstall 13:45:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:45:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:45:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:45:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:45:58 INFO - Running setup.py install for mozleak 13:45:58 INFO - Running setup.py install for mozlog 13:45:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:45:58 INFO - Running setup.py install for moznetwork 13:45:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:45:58 INFO - Running setup.py install for mozprocess 13:45:58 INFO - Running setup.py install for mozprofile 13:45:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:45:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:45:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:45:58 INFO - Running setup.py install for mozrunner 13:45:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:45:58 INFO - Running setup.py install for mozscreenshot 13:45:59 INFO - Running setup.py install for moztest 13:45:59 INFO - Running setup.py install for mozversion 13:45:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:45:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:45:59 INFO - Cleaning up... 13:45:59 INFO - Return code: 0 13:45:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:59 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 0x7f306acfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe10840>, '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 0xd7d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7db60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251', '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 13:45:59 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 13:45:59 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 13:45:59 INFO - Using env: {'DISPLAY': ':0', 13:45:59 INFO - 'HOME': '/home/cltbld', 13:45:59 INFO - 'LANG': 'en_US.UTF-8', 13:45:59 INFO - 'LANGUAGE': 'en_US:en', 13:45:59 INFO - 'LOGNAME': 'cltbld', 13:45:59 INFO - 'MAIL': '/var/mail/cltbld', 13:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:59 INFO - 'MOZ_NO_REMOTE': '1', 13:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:59 INFO - 'NO_EM_RESTART': '1', 13:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:45:59 INFO - 'PWD': '/builds/slave/test-pgo', 13:45:59 INFO - 'SHELL': '/bin/bash', 13:45:59 INFO - 'SHLVL': '1', 13:45:59 INFO - 'TERM': 'linux', 13:45:59 INFO - 'TMOUT': '86400', 13:45:59 INFO - 'USER': 'cltbld', 13:45:59 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251', 13:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:59 INFO - '_': '/tools/buildbot/bin/python'} 13:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:45:59 INFO - Running setup.py (path:/tmp/pip-4HmE42-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:45:59 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)) 13:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:45:59 INFO - Running setup.py (path:/tmp/pip-TFDMML-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:45:59 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)) 13:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:45:59 INFO - Running setup.py (path:/tmp/pip-ARXz4W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:45:59 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)) 13:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:45:59 INFO - Running setup.py (path:/tmp/pip-b8fRYJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:45:59 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)) 13:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:45:59 INFO - Running setup.py (path:/tmp/pip-ed7ukb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:45:59 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)) 13:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:45:59 INFO - Running setup.py (path:/tmp/pip-Q_sZ2w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:45:59 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)) 13:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:45:59 INFO - Running setup.py (path:/tmp/pip-VzAAYz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:45:59 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)) 13:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:45:59 INFO - Running setup.py (path:/tmp/pip-jb8rcQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:46:00 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)) 13:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:46:00 INFO - Running setup.py (path:/tmp/pip-s34nXE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:46:00 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)) 13:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:46:00 INFO - Running setup.py (path:/tmp/pip-qNg44f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:46:00 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)) 13:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:46:00 INFO - Running setup.py (path:/tmp/pip-jgqBPx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:46:00 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)) 13:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:46:00 INFO - Running setup.py (path:/tmp/pip-UJACrv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:46:00 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)) 13:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:46:00 INFO - Running setup.py (path:/tmp/pip-3Wvo7s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:46:00 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)) 13:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:46:00 INFO - Running setup.py (path:/tmp/pip-GQoabR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:46:00 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)) 13:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:46:00 INFO - Running setup.py (path:/tmp/pip-Bnsnp1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:46:00 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)) 13:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:46:00 INFO - Running setup.py (path:/tmp/pip-bhxeMF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:46:00 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)) 13:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:46:00 INFO - Running setup.py (path:/tmp/pip-x3Maqb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:46:00 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)) 13:46:00 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)) 13:46:00 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)) 13:46:00 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)) 13:46: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 mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:46:00 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)) 13:46:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:46: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 13:46: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 13:46: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 13:46: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 13:46: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 13:46: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 13:46:02 INFO - Downloading blessings-1.5.1.tar.gz 13:46:02 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 13:46:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:46:02 INFO - Installing collected packages: blessings 13:46:02 INFO - Running setup.py install for blessings 13:46:02 INFO - Successfully installed blessings 13:46:02 INFO - Cleaning up... 13:46:02 INFO - Return code: 0 13:46:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:46:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:46:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:46:02 INFO - Reading from file tmpfile_stdout 13:46:02 INFO - Current package versions: 13:46:02 INFO - argparse == 1.2.1 13:46:02 INFO - blessings == 1.5.1 13:46:02 INFO - blobuploader == 1.2.4 13:46:02 INFO - docopt == 0.6.1 13:46:02 INFO - manifestparser == 1.1 13:46:02 INFO - mozInstall == 1.12 13:46:02 INFO - mozcrash == 0.16 13:46:02 INFO - mozdebug == 0.1 13:46:02 INFO - mozdevice == 0.47 13:46:02 INFO - mozfile == 1.2 13:46:02 INFO - mozhttpd == 0.7 13:46:02 INFO - mozinfo == 0.9 13:46:02 INFO - mozleak == 0.1 13:46:02 INFO - mozlog == 3.1 13:46:02 INFO - moznetwork == 0.27 13:46:02 INFO - mozprocess == 0.22 13:46:02 INFO - mozprofile == 0.28 13:46:02 INFO - mozrunner == 6.11 13:46:02 INFO - mozscreenshot == 0.1 13:46:02 INFO - mozsystemmonitor == 0.0 13:46:02 INFO - moztest == 0.7 13:46:02 INFO - mozversion == 1.4 13:46:02 INFO - psutil == 3.1.1 13:46:02 INFO - requests == 1.2.3 13:46:02 INFO - wsgiref == 0.1.2 13:46:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:46: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')]} 13:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46: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')]} 13:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f306acfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe10840>, '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 0xd7d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7db60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251', '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 13:46:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 13:46:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 13:46:02 INFO - Using env: {'DISPLAY': ':0', 13:46:02 INFO - 'HOME': '/home/cltbld', 13:46:02 INFO - 'LANG': 'en_US.UTF-8', 13:46:02 INFO - 'LANGUAGE': 'en_US:en', 13:46:02 INFO - 'LOGNAME': 'cltbld', 13:46:02 INFO - 'MAIL': '/var/mail/cltbld', 13:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:02 INFO - 'MOZ_NO_REMOTE': '1', 13:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:02 INFO - 'NO_EM_RESTART': '1', 13:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:46:02 INFO - 'PWD': '/builds/slave/test-pgo', 13:46:02 INFO - 'SHELL': '/bin/bash', 13:46:02 INFO - 'SHLVL': '1', 13:46:02 INFO - 'TERM': 'linux', 13:46:02 INFO - 'TMOUT': '86400', 13:46:02 INFO - 'USER': 'cltbld', 13:46:02 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251', 13:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:02 INFO - '_': '/tools/buildbot/bin/python'} 13:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:03 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)) 13:46:03 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)) 13:46:03 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)) 13:46:03 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)) 13:46:03 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)) 13:46:03 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)) 13:46:03 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)) 13:46:03 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)) 13:46:03 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)) 13:46:03 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)) 13:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 13:46:03 INFO - Cleaning up... 13:46:03 INFO - Return code: 0 13:46:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f306acfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe10840>, '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 0xd7d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7db60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251', '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 13:46:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 13:46:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:46:03 INFO - Using env: {'DISPLAY': ':0', 13:46:03 INFO - 'HOME': '/home/cltbld', 13:46:03 INFO - 'LANG': 'en_US.UTF-8', 13:46:03 INFO - 'LANGUAGE': 'en_US:en', 13:46:03 INFO - 'LOGNAME': 'cltbld', 13:46:03 INFO - 'MAIL': '/var/mail/cltbld', 13:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:03 INFO - 'MOZ_NO_REMOTE': '1', 13:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:03 INFO - 'NO_EM_RESTART': '1', 13:46:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:46:03 INFO - 'PWD': '/builds/slave/test-pgo', 13:46:03 INFO - 'SHELL': '/bin/bash', 13:46:03 INFO - 'SHLVL': '1', 13:46:03 INFO - 'TERM': 'linux', 13:46:03 INFO - 'TMOUT': '86400', 13:46:03 INFO - 'USER': 'cltbld', 13:46:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251', 13:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:03 INFO - '_': '/tools/buildbot/bin/python'} 13:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:03 INFO - Downloading/unpacking jsonschema 13:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:46:05 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 13:46:05 INFO - Downloading/unpacking functools32 (from jsonschema) 13:46: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 13:46: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 13:46: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 13:46: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 13:46: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 13:46: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 13:46:05 INFO - Downloading functools32-3.2.3-2.tar.gz 13:46:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:46:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:46:05 INFO - warning: no files found matching '*.txt' 13:46:05 INFO - no previously-included directories found matching 'build' 13:46:05 INFO - no previously-included directories found matching 'dist' 13:46:05 INFO - no previously-included directories found matching '.git*' 13:46:05 INFO - Installing collected packages: jsonschema, functools32 13:46:05 INFO - Running setup.py install for functools32 13:46:05 INFO - warning: no files found matching '*.txt' 13:46:05 INFO - no previously-included directories found matching 'build' 13:46:05 INFO - no previously-included directories found matching 'dist' 13:46:05 INFO - no previously-included directories found matching '.git*' 13:46:05 INFO - Successfully installed jsonschema functools32 13:46:05 INFO - Cleaning up... 13:46:05 INFO - Return code: 0 13:46:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f306acfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe10840>, '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 0xd7d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7db60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251', '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 13:46:05 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 13:46:05 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 13:46:05 INFO - Using env: {'DISPLAY': ':0', 13:46:05 INFO - 'HOME': '/home/cltbld', 13:46:05 INFO - 'LANG': 'en_US.UTF-8', 13:46:05 INFO - 'LANGUAGE': 'en_US:en', 13:46:05 INFO - 'LOGNAME': 'cltbld', 13:46:05 INFO - 'MAIL': '/var/mail/cltbld', 13:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:05 INFO - 'MOZ_NO_REMOTE': '1', 13:46:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:05 INFO - 'NO_EM_RESTART': '1', 13:46:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:46:05 INFO - 'PWD': '/builds/slave/test-pgo', 13:46:05 INFO - 'SHELL': '/bin/bash', 13:46:05 INFO - 'SHLVL': '1', 13:46:05 INFO - 'TERM': 'linux', 13:46:05 INFO - 'TMOUT': '86400', 13:46:05 INFO - 'USER': 'cltbld', 13:46:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251', 13:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:05 INFO - '_': '/tools/buildbot/bin/python'} 13:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:05 INFO - Downloading/unpacking flake8 13:46: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 13:46: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 13:46: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 13:46: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 13:46: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 13:46: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 13:46:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:46:07 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 13:46:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:46:07 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 13:46:07 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 13:46:07 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 13:46:07 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 13:46:07 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 13:46:07 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 13:46:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:46:07 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 13:46:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:46:07 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 13:46:07 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 13:46:07 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 13:46:07 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 13:46:07 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 13:46:07 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 13:46:07 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 13:46:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:46:07 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 13:46:07 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 13:46:07 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 13:46:07 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 13:46:07 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 13:46:07 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 13:46:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:46:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:46:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:46:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:46:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:46:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:46:08 INFO - no previously-included directories found matching 'docs/_build' 13:46:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:46:08 INFO - Running setup.py install for pep8 13:46:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:46:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:46:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:46:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:46:08 INFO - no previously-included directories found matching 'docs/_build' 13:46:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:46:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:46:08 INFO - Cleaning up... 13:46:08 INFO - Return code: 0 13:46:08 INFO - Running post-action listener: _resource_record_post_action 13:46:08 INFO - Running post-action listener: _start_resource_monitoring 13:46:08 INFO - Starting resource monitoring. 13:46:08 INFO - ##### 13:46:08 INFO - ##### Running install step. 13:46:08 INFO - ##### 13:46:08 INFO - Running pre-action listener: _resource_record_pre_action 13:46:08 INFO - Running main action method: install 13:46:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:46:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:46:08 INFO - Reading from file tmpfile_stdout 13:46:08 INFO - Detecting whether we're running mozinstall >=1.0... 13:46:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:46:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:46:08 INFO - Reading from file tmpfile_stdout 13:46:08 INFO - Output received: 13:46:08 INFO - Usage: mozinstall [options] installer 13:46:08 INFO - Options: 13:46:08 INFO - -h, --help show this help message and exit 13:46:08 INFO - -d DEST, --destination=DEST 13:46:08 INFO - Directory to install application into. [default: 13:46:08 INFO - "/builds/slave/test-pgo"] 13:46:08 INFO - --app=APP Application being installed. [default: firefox] 13:46:08 INFO - mkdir: /builds/slave/test-pgo/build/application 13:46:08 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'] 13:46:08 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 13:46:24 INFO - Reading from file tmpfile_stdout 13:46:24 INFO - Output received: 13:46:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:46:24 INFO - Running post-action listener: _resource_record_post_action 13:46:24 INFO - ##### 13:46:24 INFO - ##### Running run-tests step. 13:46:24 INFO - ##### 13:46:24 INFO - Running pre-action listener: _resource_record_pre_action 13:46:24 INFO - Running main action method: run_tests 13:46:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:46:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:46:24 INFO - Python 2.7.3 13:46:24 INFO - Return code: 0 13:46:24 INFO - grabbing minidump binary from tooltool 13:46:24 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')]} 13:46:24 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 0xe10840>, '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 0xd7d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7db60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:46:24 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 13:46:24 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 13:46:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:46:24 INFO - Return code: 0 13:46:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:46:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:46:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:46:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:46:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:46:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:46:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:46:25 INFO - Return code: 0 13:46:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 13:46:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 13:46:25 INFO - Using env: {'DISPLAY': ':0', 13:46:25 INFO - 'HOME': '/home/cltbld', 13:46:25 INFO - 'LANG': 'en_US.UTF-8', 13:46:25 INFO - 'LANGUAGE': 'en_US:en', 13:46:25 INFO - 'LOGNAME': 'cltbld', 13:46:25 INFO - 'MAIL': '/var/mail/cltbld', 13:46:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:46:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:25 INFO - 'MOZ_NO_REMOTE': '1', 13:46:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:46:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:25 INFO - 'NO_EM_RESTART': '1', 13:46:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:46:25 INFO - 'PWD': '/builds/slave/test-pgo', 13:46:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:46:25 INFO - 'SHELL': '/bin/bash', 13:46:25 INFO - 'SHLVL': '1', 13:46:25 INFO - 'TERM': 'linux', 13:46:25 INFO - 'TMOUT': '86400', 13:46:25 INFO - 'USER': 'cltbld', 13:46:25 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251', 13:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:25 INFO - '_': '/tools/buildbot/bin/python'} 13:46:25 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:46:25 INFO - mozversion application_buildid: 20160107113022 13:46:25 INFO - mozversion application_changeset: a0df531dbd608ec8655b55de8fd9f07a3de06206 13:46:25 INFO - mozversion application_display_name: Nightly 13:46:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:46:25 INFO - mozversion application_name: Firefox 13:46:25 INFO - mozversion application_remotingname: firefox 13:46:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 13:46:25 INFO - mozversion application_vendor: Mozilla 13:46:25 INFO - mozversion application_version: 46.0a1 13:46:25 INFO - mozversion platform_buildid: 20160107113022 13:46:25 INFO - mozversion platform_changeset: a0df531dbd608ec8655b55de8fd9f07a3de06206 13:46:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 13:46:25 INFO - mozversion platform_version: 46.0a1 13:46:25 INFO - using testdate: 1452203185 13:46:25 INFO - actual date: 1452203185 13:46:25 INFO - starting webserver on 'localhost:60913' 13:46:25 INFO - SUITE-START | Running 3 tests 13:46:25 INFO - TEST-START | dromaeo_css 13:46:25 INFO - operating with platform_type : linux_ 13:46:25 INFO - Initialising browser for dromaeo_css test... 13:46:25 INFO - TEST-INFO | started process 22306 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpM6uljK/profile http://localhost:60913/getInfo.html) 13:46:29 INFO - PROCESS | 22306 | __metrics Screen width/height:1600/1200 13:46:29 INFO - PROCESS | 22306 | colorDepth:24 13:46:29 INFO - PROCESS | 22306 | Browser inner width/height: 1024/697 13:46:29 INFO - PROCESS | 22306 | __metrics 13:46:29 INFO - PROCESS | 22306 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:46:29 INFO - PROCESS | 22306 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:46:30 INFO - TEST-INFO | 22306: exit 0 13:46:30 INFO - Browser initialized. 13:46:30 INFO - Running cycle 1/1 for dromaeo_css test... 13:46:30 INFO - TEST-INFO | started process 22403 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpM6uljK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:46:42 INFO - PROCESS | 22403 | RSS: Main: 149807104 13:46:42 INFO - PROCESS | 22403 | 13:47:33 INFO - PROCESS | 22403 | 1452203253922 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] 13:49:42 INFO - PROCESS | 22403 | Cycle 1(1): loaded http://localhost:60913/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60913/tests/dromaeo/cssquery-ext.html) 13:49:43 INFO - PROCESS | 22403 | RSS: Main: 271663104 13:49:43 INFO - PROCESS | 22403 | 13:52:45 INFO - PROCESS | 22403 | Cycle 1(1): loaded http://localhost:60913/tests/dromaeo/cssquery-ext.html (next: http://localhost:60913/tests/dromaeo/cssquery-jquery.html) 13:52:46 INFO - PROCESS | 22403 | RSS: Main: 233168896 13:52:46 INFO - PROCESS | 22403 | 13:55:48 INFO - PROCESS | 22403 | Cycle 1(1): loaded http://localhost:60913/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60913/tests/dromaeo/cssquery-mootools.html) 13:55:49 INFO - PROCESS | 22403 | RSS: Main: 233672704 13:55:49 INFO - PROCESS | 22403 | 13:58:50 INFO - PROCESS | 22403 | Cycle 1(1): loaded http://localhost:60913/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60913/tests/dromaeo/cssquery-prototype.html) 13:58:51 INFO - PROCESS | 22403 | RSS: Main: 214024192 13:58:51 INFO - PROCESS | 22403 | 14:01:54 INFO - PROCESS | 22403 | Cycle 1(1): loaded http://localhost:60913/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60913/tests/dromaeo/cssquery-yui.html) 14:01:54 INFO - PROCESS | 22403 | RSS: Main: 218873856 14:01:54 INFO - PROCESS | 22403 | 14:04:57 INFO - PROCESS | 22403 | Cycle 1(1): loaded http://localhost:60913/tests/dromaeo/cssquery-yui.html (next: http://localhost:60913/tests/dromaeo/cssquery-dojo.html) 14:04:57 INFO - PROCESS | 22403 | RSS: Main: 279089152 14:04:57 INFO - PROCESS | 22403 | 14:04:57 INFO - PROCESS | 22403 | __start_tp_report 14:04:57 INFO - PROCESS | 22403 | _x_x_mozilla_page_load 14:04:57 INFO - PROCESS | 22403 | _x_x_mozilla_page_load_details 14:04:57 INFO - PROCESS | 22403 | |i|pagename|runs| 14:04:57 INFO - PROCESS | 22403 | |0;dojo.html;3138.4037032963734;3183.904482865512;3237.320162765819;3238.206639373354;3274.083256688127;5085.567726743222;5200.8699782505455;5232.4505926877655;5252.789888404459;5305.681659100456;5207.6354655174055;5234.110201265785;5281.2342210379475;5292.126799078147;5326.041312563737;4777.641676874222;4788.832390866321;4794.137055330039;4858.805647774085;4901.632377571678;4852.49048849871;4868.902621947559;4898.53463920927;4915.434725006617;4926;4644.2801365788355;4776.999999999983;4784.569388755029;4880.389951256093;4890.73100979446;4818.494058123882;4831.202851529529;4834.613230941516;4849.296851956482;4853.757312134415;4666.183417901853;4802;4802.35168252285;4803.783829727636;4859.829905953275;5028.296038554568;5060.51925067118;5109.872253193663;5119.641625086246;5171.250168725552;5647.774089036434;5654.943450565524;5655.575831812631;5656.745446454878;5661.688607126606;5408.13469844823;5559.833205003816;5682.687452190128;5694.145878118274;5705.914411283834;5184.948150518484;5207.0887594670785;5284.471552844761;5315.787368505294;5343.09167441532;5673.943260567424;5704.344000440003;5705.229793977843;5706.942930570641;5754.942450575524;5392.433794451605;5470.8085217017215;5481.506664400223;5503.11950087992;5535.446455354432;5550.4449555044985;5597.384287728347;5685.857853553694;5695.202671625976;5695.7152142392715;5508.338999320027;5570.136628822539;5579.414161513064;5581.888362232733;5593.468620481048;5562.527185189304;5572.219889215513;5579.581531385081;5582.637128586629;5591.189277554732;4298.806553705091;4305.052888364555;4378.233809083397;4386.539413361551;4390.934135987963;3893.4743809585343;3897.2205558888336;3925.4896863407575;3940.5174739913673;3964.9207015860097;5230.189320655304;5230.267762513251;5230.503102205284;5238.292830467914;5239.083160446983;5456.072467680504;5589.580781441408;5594.049011667945;5600;5687.573431992534;5236.39781425141;5295.867603309871;5302.045631786238;5303.4696530346655;5305;4865.927011094836;4876.658633895593;4878.268259761065;4878.390201224847;4929.285253638202;5665.943340566541;5783.652980821164;5784.681842498619;5907.261592300963;6007.12896629995;5635.211070450222;5648.209250704823;5653.971730141323;5655.943440565542;5658.17956396312;5824.330202026821;5841.357450680337;5852.18069470266;5857.26784151981;5885.970570147122;5477.75350109254;5585.581081418829;5586.636868603528;5595.776168953196;5715.542756579381;5593.972030139823;5639.210510528447;5647.491725744702;5653.519450846724;5654.491095801398;5507.284053073075;5512.283403157564;5513.696746678971;5517.503424691797;5520.392756796668;5358.7320633967365;5475.972620136874;5477;5548.583856210719;5590.357108932525;5325.174597937326;5341.519263266325;5341.5459685927135;5344.465553444625;5345.812896548602;5438.70087145195;5442;5442.346918369821;5449.509544141047;5463.016657001619;5336.2529245904825;5342.706151161723;5396.9460305398015;5416.485433883775;5453.345598528202 14:04:57 INFO - PROCESS | 22403 | |1;ext.html;502.2190493782168;505.07571144805036;509.94645562215965;529.1639210048123;535.6598559914453;27872.86063569682;29019;35978.46032309514;36722.44916326257;36805.26389472209;40128.59871401285;40707.79646101766;40717.185656286856;40856.79571602145;40863;7463.290987356192;8464.873026904586;8594.312455003615;8599.398042137052;8629.482231066124;7491.400687944979;7584.01407816983;10193.286469947107;10385.532651030722;10389.532471038821;10101.949490252538;10189.54147063384;10203.489825508732;10211.795764084714;10217.897821021768;7652.57910814905;7816.570088645122;10085.697429077103;10104.242181836391;10178.134858536996;10221.540030698561;10407.947960260226;10465;10471.738206544822;10473.162147028219;35477.64522354769;35796;35824.10439739027;35851.4622280666;35934.10164745876;3233.514972754082;3315.1546355679147;3321.667833216683;3321.750868684834;3332.8500217490273;28224.576631350545;28423;30954.53568196479;31355.529667055012;31687.84156079228;3910.276598829197;3911.1395492991496;4010.598940105995;4102.651274641659;4180.540140584533;260850;261611;262235.9999999981;263504;264641;51004;51931.740341298806;58833;60186;60257;59225;59263.70368148218;59400;59736.40263597395;59903.70048149731;15149.62125946838;15242.542723718307;15322.693546129016;15343.07941523512;15381.38474461009;10927.726806829893;10973.451327433597;10990.835137472945;11008.614698485675;11070.944645276883;19740.90129549343;20120.698189527167;20130.597388052156;20131.899340503496;20145.798542014687;7262.346388824925;7438.776836694908;7451.993980812521;7551;7560.9621951889885;964.5273815830193;971.7376308396834;985.3152059318704;1012.4380968562372;1123.7864805686893;25326.240212793644;28581.42837143287;28800.567991480144;29473.410531789243;29589;1029.3875144289136;1038.2472707287156;1071.3411252079916;1073.3238060022136;1148.0930065248526;13860.861391386159;14144.36350364236;14159.027500996535;14275.571732847824;14294.356753946098;322208;333685;336919;337007;337037;47972.7601361991;48113.5188648116;48147.03705925932;48151.5184848154;48199.75900120477;1308.7317099994477;1317.4071667749358;1338.6118025772612;1339.8928085753116;1345.4080204709896;27089.59365609478;28318.716812832434;28362.85818570894;28571.14286571406;29557.852210739667;43202.78398607987;43538.782306088266;43669.78165109154;43692.34461483017;43724.78137609291;198729;198931;199781;200377;200449;29154.708452915198;31533.684663153075;31966.84016579902;32285.677143229208;32380.190495237806;38229.61770382372;38346;38470.615293846706;38698;39408.40887386749;32932.34135317232;32955.83522082374;33211.50182747309;33584.49623255604;35380.292394152486;30071.24821879383;32593.674063259063;34313;36075.819620901726;37269;32562.185945351557;33021.83489082539;33254.66745332516;33303;33319;30445.54331684982;30848.228794280323;32069.358612827145;32083.19792005125;32266.83866580652;22297.888510557343;24947.37631559153;25024.374390639652;25385.619215712148;25444.109456168946 14:04:57 INFO - PROCESS | 22403 | |2;jquery.html;330.1893850596785;332.5842696629214;333.77803760499256;334.90713263016045;341.2816022273115;13924.582262532114;14285.214313212795;15966.827367421865;16140.515784526468;17846.643067138648;15905.761413578806;16031.759523607156;16699.83300167001;16704.665906681857;16720.08039557824;4661.720296782187;4912.287718280847;4913.631477639174;4913.803447862081;4918.704877707331;3735.2716220337047;3824.9617503825025;4878.70727756334;5304.867378315554;5462.945370546303;5406.351237851463;5413.242146099549;5427.45725427458;5451.890962180754;5456.0997435423105;5183.144781111131;5338.199270109476;5343.438938911417;5349.545288650469;5428.565714742831;5114.744262786846;5150.562202212816;5152.407473140562;5173.120569503193;5181.5854731621375;11633.185677002613;12107.636770896886;12163.452644630925;12184.02527797774;12224.694382640506;2061.175529788082;2085.8852763098025;2118.491562025118;2121.0561300221407;2239.857672586976;9022.323325750594;9162.083791620851;9163.35856490046;9570.330076894621;10779.029887310102;1804.1881153480986;1821.271491403436;1838.5219842840825;1920.3854766474733;1969.133581224271;52726.73636631792;58663;59068.40931590672;59448;59903.80192396171;9845.409275443497;10191.643292484727;10192.439415832201;10246.48767561619;10276;13285.269310188032;13292.933535332262;13309.66725831862;13318.667033324244;13354.732905341838;6870.244273129952;6908.378245957888;7125.394341481032;7150.249223831423;7187.712491500386;6566.146400967939;6758.05387245786;6769.153855768029;6788.898166527506;6800.455963522906;4416.050549131952;4417.359482874966;4421.38100665907;4448.310511870665;4462.085272519126;1710.632214073955;1751.7109676903424;1759.4193916007687;1759.6832570137499;1762.0749106719074;868.3140319147802;883.3551507399634;905.6603773584906;956.5791051937125;983.7048885334372;16111.436099736453;17114.828851711325;17320.307187712602;17426.12869356527;17477.7378339325;887.8934527856569;913.1462082952461;935.7426707655313;944.763809047738;981.2640519610293;9632.229421646252;9776.364536305118;9867.555959981819;9904.059114384121;9921.603135874484;567088.151914681;569655;585574;586787;588208;77498.22501775023;78301;78656;79261;79614;1064.5794911010262;1065.9766624041008;1085.5223701571442;1091.8962698543626;1097.7914196302836;15031.849681503045;15059.247037647854;15283.694326113638;15286.694266114839;15610.21948902573;33261.33477330488;33289.500657489676;33611.66388336085;34987.65012349844;37198.44202336913;38557.421638676;40184;41713;42120.3681944765;45544.77227613841;8959;9372.859407109036;9601.807963840824;9898.901010990086;9901.752456188653;10946.726331841768;10957.83563246568;11005.779884402427;11084.778304434027;14041.5085472008;11715.648530544097;11930.522779088738;12020.699482513008;14360.784588231394;14933;13533.661658458617;13928.303584820516;13960.790588140982;14020.298985050911;14524;14492.85507144915;14690.11859288446;14831.629209269855;14907.329170187584;15067.4726384576;9285.442873427615;9749.561269742737;9835.262355323237;10022.098011179029;10038.347507411994;14866.182359970306;14877;14970.925145374204;15150.3182356792;15181.544553662967 14:04:57 INFO - PROCESS | 22403 | |3;mootools.html;1273.8853503184723;1426.1443134119527;1427.3291552970102;1555.1757568488706;1768.5490199999006;6723.663816809159;7226.891596626055;7315.8536829263385;7320.926790732091;7322.890156647648;7207.747728829492;7300.963495182516;7317.853642927138;7357;7394.223606521318;1919.8464122870207;1975.6147551227516;2155.9029843656995;2190.310052333514;2238.473958619723;1853.2586965213889;1859.962800743991;1862.9347972820954;1866.6266746650656;1869.0000849545495;2184.5740080684272;2223.210760180137;2234.128689810975;2242.7308722953185;2245.69683092782;2198.472366632013;2217.157480157546;2220.200727738021;2222.7443843957826;2261.5929132756096;2257.9887100564392;2261.9886900565557;2299.908003679851;2303.516261585069;2303.988480057589;7446.069241344832;7476.551406915548;7498.66256018475;7506.924930750732;7529.811754706121;4587.059652771174;4613.238815595456;4657;4660.510646382115;4661.440627124767;2820.1257610140924;2932.061740243123;2938.676745557987;2943.8380889051095;2947.3515826518133;949.8005418862048;963.942163470187;970.2238209432426;982.2338575910801;1021.5403068619152;10226.795464090677;10332.32839865414;10413.79172416555;10420.843687344695;10430.634927777492;4155.085881106152;4208.705390622688;4267.295896177096;4282.678799090081;4287.099709061132;8858.158474945;8881.689140880038;8894.332925030649;8894.377393582516;8918.063603321558;4742.383490146259;4751.192297309466;4751.40607424072;4752.192127338291;4754.453237877619;4273;4319.568043195655;4319.8488052918;4324.156789426094;4324.329728892027;3416.6754158354915;3476.7392445566684;3602.85588576454;3612.9819350903076;3695.3533131702384;1163.1450883600546;1172.6306213542707;1172.8299396587447;1177.087756988341;1188.6552899659002;1074.312440038376;1076.1498416251075;1117.044926587772;1229.7786398448186;1347.6496111011209;7146.428285737128;7172.175199852084;7248.710051597877;7253.528520646141;7265.346118849329;1128.3342827731678;1129.6554550861902;1131.5021390588115;1131.7962766702074;1146.8337091121741;5756.884862302814;5853.707314634251;5878;5885.793997210163;5892.941070589325;9127.680531181377;9324.1608255256;9326.72019839406;9442.055794420503;9531.714048578553;9368.67209647659;9478.33651644392;9482.952585237168;9494.857577136348;9514.38156519824;7181.425485961111;7281.344678978811;7338.4496162788;7463.738769143054;7471.215522370181;7052.294770522906;7068.681909314196;7082.468814838805;7094.787156385317;7108.537945033556;8179.591020449073;8317.085120636604;8338.874916876373;8355.289800366794;8408.201220884006;8662.956685216534;8759.343049271458;8801.779955501164;8820.603072861608;8838.469691818511;6811.080504132077;6918.169819621678;6933.272006439453;6937.549059311129;6948.687309071003;6491.058796474579;6573.605583664996;6584.242812076673;7182.533135346186;7510.887336690063;6918.238993710788;6954.8956765647545;7089.61007144612;7205.819854503469;7209.71161153548;6750.459963202834;6801.081853949851;6871.5189936703955;6932.376086152271;6994.685239164148;6852.862942741217;6868.244493105854;6907.7236910525025;6908.516403851682;6920.5847649141215;6498.252700939453;6538.444232240313;6615.569987950767;6644.368784965421;6666.433353165035;6709.060731497497;6714.865702685821;6731.091302674076;6740.865182696417;6756.966215168893 14:04:57 INFO - PROCESS | 22403 | |4;prototype.html;321.0672994949672;324.2364232233091;329.3183110960313;330.71228031612503;336.80465330108524;5785.508231800302;5858.677772722499;5873.588848780587;5878.9999999999945;5916.497097746691;5627.831165065055;5785.710714464281;5798.478136967672;5806.680632565207;5819.67991760453;4508.66185036122;4515.63874890008;4518.502964673883;4524.5249248828895;4527.09458108378;4324.2648749712625;4411.669124815651;4417.933730994037;4418.469783625969;4523.592876641102;4373.584509471611;4390.056137930344;4470.798814053375;4473.731576105444;4477.417935668359;4442.3558584005295;4449.710768800018;4454.33185022246;4454.510003899569;4457.888552786174;3964.5837187095226;3968.1666849961543;3968.761874287552;3971.0270983609203;4007.0383108054148;5380.973095134538;5508.614396992212;5514.862128446781;5527.2538207341895;5565.443455654402;5221.869453263699;5227.294315267466;5240.423553409122;5243.895122097537;5245.580353571705;6130.540209484307;6137.324894261627;6142.170806941095;6143.293521245069;6143.877122457526;4393.1872603568445;4406.339049142623;4406.361077643755;4406.383106365111;4409.5149533551285;6145.723442445101;6157.599756015845;6293.433590976834;6461.903071453932;6462.0306953956815;4379.408779814684;4410.823567057282;4484.798184081724;4487.775611219426;4506.81972721094;4534.115847409724;4557.703749256288;4561.7262964222255;4565.0641618468135;4566.4748553916725;5203.687778733212;5234.241035049897;5237.057329680618;5238.633295669343;5241.318628578337;6066.757329706762;6180.227471566054;6199.783007594712;6228.719707613168;6245.125682404467;1612.3550579767953;1624.84563966423;1625.5042212125416;1625.5692241555996;1627.9511614651578;1084.8481212630238;1108.894655007773;1109.8113320735495;1110.2838669058413;1128.7121783945042;5773.364929857712;5842.357340692521;5847.181394604759;5854.941450585525;5862.062070068769;6334.683265836689;6343.080253363237;6347.777827776005;6349.873002539924;6351.491880649537;5843.678597677083;5847.035239185572;5848.590598658053;5851.561132915049;5857.7656893724625;3320.6015278166774;3433.5193072969805;3439.208981934169;3441.5525981622227;3443.070370999816;6588.439982601437;6592.70332835014;6596.076549283104;6607.273199948002;6607.702653380609;6497.64262965532;6501.739930402826;6503.869922601616;6515.250746164157;6523.086767852505;6473.449756770728;6527.8694426111215;6535.705893234721;6558.770443034567;6698.4306333961185;6416;6416.967915160394;6418.422341989243;6419.2296924369375;6424.807255782334;6356.491480681442;6371.585846919936;6373.7131829066875;6373.7131829066875;6377.713002914973;6420.165378500765;6474.514411419068;6524.3149469305035;6579.901301480578;6702.83242918931;4370.322599997005;4371.737695738266;4391.934120988124;4400.053988392511;4401.559844015573;6383.776567820104;6409.359064093554;6412.326705695835;6413.2945376007665;6424.678766061772;6032.306284777307;6215.533834962486;6220.066989951543;6225.31521532622;6227.314995350598;6222.875542489034;6225;6230.875382492415;6230.906536402048;6235.594686345373;6119.3268740437625;6121.4490695837585;6125;6128.080787881853;6130.724117414817;6178.073289006506;6192.309407375485;6247.281562620356;6279.340669229665;6280.152179455715;6062.848428789315;6111.572189946661;6112.572119951561;6117.847053823512;6126.23422072241 14:04:57 INFO - PROCESS | 22403 | |5;yui.html;757.8143354878056;796.7575432154362;814.2346194577095;819.2299238715608;820.6881385073671;13587.45650173993;13845.376958036888;13856.861431385696;13866.37601307941;13884.166949982982;12097.879021209785;12336.198147120453;14397.20815355155;14608.4887028954;14614.415423383078;766.4673052228703;781.8240895798428;782;782.3936449251819;783.0994356490054;654.9934500655004;663.6217356107021;740.7777666699996;756.3722110648176;787.9921200788004;824.3075816314295;825.3314814999869;829.0341751859077;829.4276948905236;830.0703212402118;672.5930811858852;824.4599787139404;826.4338927834392;826.6238861318116;827.2761333832926;497.7113274300897;597.8505373656586;603.0833133636892;605.449041372349;609.7195290166529;13500.729985400336;13513.324333783272;13555.118917270345;13566.389512471962;13572.93213533926;11585.131115166396;11683.824742628867;11730.53077876884;11864.52541898323;12401.441935112942;9537.14165725088;10156.187504999582;10224.693259202237;10528.36829790215;11082.168837337233;3503.439449688063;3542.220711443478;3561.7684850484634;3562.305350456662;3588.766730162557;47851.76074119642;48048.75975620135;48197.75901120507;48331.516684833055;48352.758236208596;8393;8575.756669756227;8642.351823613255;8661.956690216508;8689.695860644848;17370.478885633453;17378;17457.738133928;17471.475855724348;17480.47558573245;7251.637418129072;7267.745628903069;7273.272672732684;7332.41340692754;7469.514481558681;3991.980040099839;4168.083021735213;4201.936970945439;4263.147370525907;4300.763458009839;3004.879804807827;3040.087973607953;3040.9543856842165;3044.543318502198;3054.618172728409;547.7726743401523;565.3131445293988;568.0541897740217;568.692905830855;577.3591313641854;585.2041223935445;607.6263098194579;649.7823229218264;662.0565693886193;684.1755684400285;8308.916910830814;8406.537640429713;8485.618147183392;8579.871301930476;8844.33667474942;628.9088082228143;656.6191608866845;664.6244871647503;664.9401553860176;717.2791344698545;3931.4692516510477;4044.5348784889525;4336.371226172188;4409.2724700424715;4535.433070866142;51283;51366;53618.73190634022;53706;54261.72869135629;44153;44217.55782442199;46174.30738538925;48031;48083;44408;44887.77556112198;45263.54736452659;45318.54681453143;45532.089358213314;8338;8713;8757;8878.5116818573;8922.73231803047;33806.3238735219;34467.31065378729;34503.827480862434;35015.82492087523;35137.64862351446;41226.38160427536;41647.58352416437;42326.15347692967;42831;43478.78260608677;10821.188410869374;11344.943275283571;11348.886511134782;11572.074234061423;11644.301341919512;12609.810852837398;12776.233425994471;12823.61529154127;12904.741905162033;12980.026498012498;11152.721181970192;11355.432228388383;11734.647960561197;12062.035037197178;12456.377181141088;10617.150627949592;10874.325060682555;11316.20786544934;11596.130290228099;11908.404579770804;11068.778624427305;11147.163962702667;11173.441327933408;11174.27367221128;11243.325400475998;9589.995818315732;9951.95778259047;10074.798504030025;10087.89912100899;10252.128569071712;8795.25240354577;8817.691380801898;9313.44119352841;9439.28244010032;9643.710688679352 14:04:57 INFO - PROCESS | 22403 | __end_tp_report 14:04:57 INFO - PROCESS | 22403 | __start_cc_report 14:04:57 INFO - PROCESS | 22403 | _x_x_mozilla_cycle_collect,951 14:04:57 INFO - PROCESS | 22403 | __end_cc_report 14:04:57 INFO - PROCESS | 22403 | __startTimestamp1452204297285__endTimestamp 14:04:57 INFO - PROCESS | 22403 | 14:04:57 INFO - PROCESS | 22403 | ------- Summary: start ------- 14:04:57 INFO - PROCESS | 22403 | Number of tests: 6 14:04:57 INFO - PROCESS | 22403 | 14:04:57 INFO - PROCESS | 22403 | [#0] dojo.html Cycles:165 Average:5225.81 Median:5358.73 stddev:557.38 (10.4%) stddev-sans-first:534.50 14:04:57 INFO - PROCESS | 22403 | Values: 3138.4 3183.9 3237.3 3238.2 3274.1 5085.6 5200.9 5232.5 5252.8 5305.7 5207.6 5234.1 5281.2 5292.1 5326.0 4777.6 4788.8 4794.1 4858.8 4901.6 4852.5 4868.9 4898.5 4915.4 4926.0 4644.3 4777.0 4784.6 4880.4 4890.7 4818.5 4831.2 4834.6 4849.3 4853.8 4666.2 4802.0 4802.4 4803.8 4859.8 5028.3 5060.5 5109.9 5119.6 5171.3 5647.8 5654.9 5655.6 5656.7 5661.7 5408.1 5559.8 5682.7 5694.1 5705.9 5184.9 5207.1 5284.5 5315.8 5343.1 5673.9 5704.3 5705.2 5706.9 5754.9 5392.4 5470.8 5481.5 5503.1 5535.4 5550.4 5597.4 5685.9 5695.2 5695.7 5508.3 5570.1 5579.4 5581.9 5593.5 5562.5 5572.2 5579.6 5582.6 5591.2 4298.8 4305.1 4378.2 4386.5 4390.9 3893.5 3897.2 3925.5 3940.5 3964.9 5230.2 5230.3 5230.5 5238.3 5239.1 5456.1 5589.6 5594.0 5600.0 5687.6 5236.4 5295.9 5302.0 5303.5 5305.0 4865.9 4876.7 4878.3 4878.4 4929.3 5665.9 5783.7 5784.7 5907.3 6007.1 5635.2 5648.2 5654.0 5655.9 5658.2 5824.3 5841.4 5852.2 5857.3 5886.0 5477.8 5585.6 5586.6 5595.8 5715.5 5594.0 5639.2 5647.5 5653.5 5654.5 5507.3 5512.3 5513.7 5517.5 5520.4 5358.7 5476.0 5477.0 5548.6 5590.4 5325.2 5341.5 5341.5 5344.5 5345.8 5438.7 5442.0 5442.3 5449.5 5463.0 5336.3 5342.7 5396.9 5416.5 5453.3 14:04:57 INFO - PROCESS | 22403 | 14:04:57 INFO - PROCESS | 22403 | [#1] ext.html Cycles:180 Average:43148.28 Median:17759.60 stddev:70802.32 (398.7%) stddev-sans-first:70928.54 14:04:57 INFO - PROCESS | 22403 | Values: 502.2 505.1 509.9 529.2 535.7 27872.9 29019.0 35978.5 36722.4 36805.3 40128.6 40707.8 40717.2 40856.8 40863.0 7463.3 8464.9 8594.3 8599.4 8629.5 7491.4 7584.0 10193.3 10385.5 10389.5 10101.9 10189.5 10203.5 10211.8 10217.9 7652.6 7816.6 10085.7 10104.2 10178.1 10221.5 10407.9 10465.0 10471.7 10473.2 35477.6 35796.0 35824.1 35851.5 35934.1 3233.5 3315.2 3321.7 3321.8 3332.9 28224.6 28423.0 30954.5 31355.5 31687.8 3910.3 3911.1 4010.6 4102.7 4180.5 260850.0 261611.0 262236.0 263504.0 264641.0 51004.0 51931.7 58833.0 60186.0 60257.0 59225.0 59263.7 59400.0 59736.4 59903.7 15149.6 15242.5 15322.7 15343.1 15381.4 10927.7 10973.5 10990.8 11008.6 11070.9 19740.9 20120.7 20130.6 20131.9 20145.8 7262.3 7438.8 7452.0 7551.0 7561.0 964.5 971.7 985.3 1012.4 1123.8 25326.2 28581.4 28800.6 29473.4 29589.0 1029.4 1038.2 1071.3 1073.3 1148.1 13860.9 14144.4 14159.0 14275.6 14294.4 322208.0 333685.0 336919.0 337007.0 337037.0 47972.8 48113.5 48147.0 48151.5 48199.8 1308.7 1317.4 1338.6 1339.9 1345.4 27089.6 28318.7 28362.9 28571.1 29557.9 43202.8 43538.8 43669.8 43692.3 43724.8 198729.0 198931.0 199781.0 200377.0 200449.0 29154.7 31533.7 31966.8 32285.7 32380.2 38229.6 38346.0 38470.6 38698.0 39408.4 32932.3 32955.8 33211.5 33584.5 35380.3 30071.2 32593.7 34313.0 36075.8 37269.0 32562.2 33021.8 33254.7 33303.0 33319.0 30445.5 30848.2 32069.4 32083.2 32266.8 22297.9 24947.4 25024.4 25385.6 25444.1 14:04:57 INFO - PROCESS | 22403 | 14:04:57 INFO - PROCESS | 22403 | [#2] jquery.html Cycles:180 Average:29217.82 Median:36093.05 stddev:94641.24 (262.2%) stddev-sans-first:94881.88 14:04:57 INFO - PROCESS | 22403 | Values: 330.2 332.6 333.8 334.9 341.3 13924.6 14285.2 15966.8 16140.5 17846.6 15905.8 16031.8 16699.8 16704.7 16720.1 4661.7 4912.3 4913.6 4913.8 4918.7 3735.3 3825.0 4878.7 5304.9 5462.9 5406.4 5413.2 5427.5 5451.9 5456.1 5183.1 5338.2 5343.4 5349.5 5428.6 5114.7 5150.6 5152.4 5173.1 5181.6 11633.2 12107.6 12163.5 12184.0 12224.7 2061.2 2085.9 2118.5 2121.1 2239.9 9022.3 9162.1 9163.4 9570.3 10779.0 1804.2 1821.3 1838.5 1920.4 1969.1 52726.7 58663.0 59068.4 59448.0 59903.8 9845.4 10191.6 10192.4 10246.5 10276.0 13285.3 13292.9 13309.7 13318.7 13354.7 6870.2 6908.4 7125.4 7150.2 7187.7 6566.1 6758.1 6769.2 6788.9 6800.5 4416.1 4417.4 4421.4 4448.3 4462.1 1710.6 1751.7 1759.4 1759.7 1762.1 868.3 883.4 905.7 956.6 983.7 16111.4 17114.8 17320.3 17426.1 17477.7 887.9 913.1 935.7 944.8 981.3 9632.2 9776.4 9867.6 9904.1 9921.6 567088.2 569655.0 585574.0 586787.0 588208.0 77498.2 78301.0 78656.0 79261.0 79614.0 1064.6 1066.0 1085.5 1091.9 1097.8 15031.8 15059.2 15283.7 15286.7 15610.2 33261.3 33289.5 33611.7 34987.7 37198.4 38557.4 40184.0 41713.0 42120.4 45544.8 8959.0 9372.9 9601.8 9898.9 9901.8 10946.7 10957.8 11005.8 11084.8 14041.5 11715.6 11930.5 12020.7 14360.8 14933.0 13533.7 13928.3 13960.8 14020.3 14524.0 14492.9 14690.1 14831.6 14907.3 15067.5 9285.4 9749.6 9835.3 10022.1 10038.3 14866.2 14877.0 14970.9 15150.3 15181.5 14:04:57 INFO - PROCESS | 22403 | 14:04:57 INFO - PROCESS | 22403 | [#3] mootools.html Cycles:180 Average:5379.20 Median:6599.91 stddev:2799.72 (42.4%) stddev-sans-first:2790.56 14:04:57 INFO - PROCESS | 22403 | Values: 1273.9 1426.1 1427.3 1555.2 1768.5 6723.7 7226.9 7315.9 7320.9 7322.9 7207.7 7301.0 7317.9 7357.0 7394.2 1919.8 1975.6 2155.9 2190.3 2238.5 1853.3 1860.0 1862.9 1866.6 1869.0 2184.6 2223.2 2234.1 2242.7 2245.7 2198.5 2217.2 2220.2 2222.7 2261.6 2258.0 2262.0 2299.9 2303.5 2304.0 7446.1 7476.6 7498.7 7506.9 7529.8 4587.1 4613.2 4657.0 4660.5 4661.4 2820.1 2932.1 2938.7 2943.8 2947.4 949.8 963.9 970.2 982.2 1021.5 10226.8 10332.3 10413.8 10420.8 10430.6 4155.1 4208.7 4267.3 4282.7 4287.1 8858.2 8881.7 8894.3 8894.4 8918.1 4742.4 4751.2 4751.4 4752.2 4754.5 4273.0 4319.6 4319.8 4324.2 4324.3 3416.7 3476.7 3602.9 3613.0 3695.4 1163.1 1172.6 1172.8 1177.1 1188.7 1074.3 1076.1 1117.0 1229.8 1347.6 7146.4 7172.2 7248.7 7253.5 7265.3 1128.3 1129.7 1131.5 1131.8 1146.8 5756.9 5853.7 5878.0 5885.8 5892.9 9127.7 9324.2 9326.7 9442.1 9531.7 9368.7 9478.3 9483.0 9494.9 9514.4 7181.4 7281.3 7338.4 7463.7 7471.2 7052.3 7068.7 7082.5 7094.8 7108.5 8179.6 8317.1 8338.9 8355.3 8408.2 8663.0 8759.3 8801.8 8820.6 8838.5 6811.1 6918.2 6933.3 6937.5 6948.7 6491.1 6573.6 6584.2 7182.5 7510.9 6918.2 6954.9 7089.6 7205.8 7209.7 6750.5 6801.1 6871.5 6932.4 6994.7 6852.9 6868.2 6907.7 6908.5 6920.6 6498.3 6538.4 6615.6 6644.4 6666.4 6709.1 6714.9 6731.1 6740.9 6757.0 14:04:57 INFO - PROCESS | 22403 | 14:04:57 INFO - PROCESS | 22403 | [#4] prototype.html Cycles:180 Average:5183.90 Median:5847.89 stddev:1540.47 (26.3%) stddev-sans-first:1500.93 14:04:57 INFO - PROCESS | 22403 | Values: 321.1 324.2 329.3 330.7 336.8 5785.5 5858.7 5873.6 5879.0 5916.5 5627.8 5785.7 5798.5 5806.7 5819.7 4508.7 4515.6 4518.5 4524.5 4527.1 4324.3 4411.7 4417.9 4418.5 4523.6 4373.6 4390.1 4470.8 4473.7 4477.4 4442.4 4449.7 4454.3 4454.5 4457.9 3964.6 3968.2 3968.8 3971.0 4007.0 5381.0 5508.6 5514.9 5527.3 5565.4 5221.9 5227.3 5240.4 5243.9 5245.6 6130.5 6137.3 6142.2 6143.3 6143.9 4393.2 4406.3 4406.4 4406.4 4409.5 6145.7 6157.6 6293.4 6461.9 6462.0 4379.4 4410.8 4484.8 4487.8 4506.8 4534.1 4557.7 4561.7 4565.1 4566.5 5203.7 5234.2 5237.1 5238.6 5241.3 6066.8 6180.2 6199.8 6228.7 6245.1 1612.4 1624.8 1625.5 1625.6 1628.0 1084.8 1108.9 1109.8 1110.3 1128.7 5773.4 5842.4 5847.2 5854.9 5862.1 6334.7 6343.1 6347.8 6349.9 6351.5 5843.7 5847.0 5848.6 5851.6 5857.8 3320.6 3433.5 3439.2 3441.6 3443.1 6588.4 6592.7 6596.1 6607.3 6607.7 6497.6 6501.7 6503.9 6515.3 6523.1 6473.4 6527.9 6535.7 6558.8 6698.4 6416.0 6417.0 6418.4 6419.2 6424.8 6356.5 6371.6 6373.7 6373.7 6377.7 6420.2 6474.5 6524.3 6579.9 6702.8 4370.3 4371.7 4391.9 4400.1 4401.6 6383.8 6409.4 6412.3 6413.3 6424.7 6032.3 6215.5 6220.1 6225.3 6227.3 6222.9 6225.0 6230.9 6230.9 6235.6 6119.3 6121.4 6125.0 6128.1 6130.7 6178.1 6192.3 6247.3 6279.3 6280.2 6062.8 6111.6 6112.6 6117.8 6126.2 14:04:57 INFO - PROCESS | 22403 | 14:04:57 INFO - PROCESS | 22403 | [#5] yui.html Cycles:180 Average:13382.00 Median:45291.05 stddev:15073.91 (33.3%) stddev-sans-first:15086.38 14:04:57 INFO - PROCESS | 22403 | Values: 757.8 796.8 814.2 819.2 820.7 13587.5 13845.4 13856.9 13866.4 13884.2 12097.9 12336.2 14397.2 14608.5 14614.4 766.5 781.8 782.0 782.4 783.1 655.0 663.6 740.8 756.4 788.0 824.3 825.3 829.0 829.4 830.1 672.6 824.5 826.4 826.6 827.3 497.7 597.9 603.1 605.4 609.7 13500.7 13513.3 13555.1 13566.4 13572.9 11585.1 11683.8 11730.5 11864.5 12401.4 9537.1 10156.2 10224.7 10528.4 11082.2 3503.4 3542.2 3561.8 3562.3 3588.8 47851.8 48048.8 48197.8 48331.5 48352.8 8393.0 8575.8 8642.4 8662.0 8689.7 17370.5 17378.0 17457.7 17471.5 17480.5 7251.6 7267.7 7273.3 7332.4 7469.5 3992.0 4168.1 4201.9 4263.1 4300.8 3004.9 3040.1 3041.0 3044.5 3054.6 547.8 565.3 568.1 568.7 577.4 585.2 607.6 649.8 662.1 684.2 8308.9 8406.5 8485.6 8579.9 8844.3 628.9 656.6 664.6 664.9 717.3 3931.5 4044.5 4336.4 4409.3 4535.4 51283.0 51366.0 53618.7 53706.0 54261.7 44153.0 44217.6 46174.3 48031.0 48083.0 44408.0 44887.8 45263.5 45318.5 45532.1 8338.0 8713.0 8757.0 8878.5 8922.7 33806.3 34467.3 34503.8 35015.8 35137.6 41226.4 41647.6 42326.2 42831.0 43478.8 10821.2 11344.9 11348.9 11572.1 11644.3 12609.8 12776.2 12823.6 12904.7 12980.0 11152.7 11355.4 11734.6 12062.0 12456.4 10617.2 10874.3 11316.2 11596.1 11908.4 11068.8 11147.2 11173.4 11174.3 11243.3 9590.0 9952.0 10074.8 10087.9 10252.1 8795.3 8817.7 9313.4 9439.3 9643.7 14:04:57 INFO - PROCESS | 22403 | -------- Summary: end -------- 14:04:57 INFO - PROCESS | 22403 | 14:04:57 INFO - TEST-INFO | 22403: exit 0 14:04:57 INFO - TEST-OK | dromaeo_css | took 1112042ms 14:04:57 INFO - TEST-START | kraken 14:04:57 INFO - operating with platform_type : linux_ 14:04:57 INFO - Initialising browser for kraken test... 14:04:58 INFO - TEST-INFO | started process 22597 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcP_MVW/profile http://localhost:60913/getInfo.html) 14:05:01 INFO - PROCESS | 22597 | __metrics Screen width/height:1600/1200 14:05:01 INFO - PROCESS | 22597 | colorDepth:24 14:05:01 INFO - PROCESS | 22597 | Browser inner width/height: 1024/697 14:05:01 INFO - PROCESS | 22597 | __metrics 14:05:01 INFO - PROCESS | 22597 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:05:01 INFO - PROCESS | 22597 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:05:02 INFO - PROCESS | 22597 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 14:05:02 INFO - TEST-INFO | 22597: exit 0 14:05:02 INFO - Browser initialized. 14:05:02 INFO - Running cycle 1/1 for kraken test... 14:05:02 INFO - TEST-INFO | started process 22679 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcP_MVW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:05:14 INFO - PROCESS | 22679 | RSS: Main: 147279872 14:05:14 INFO - PROCESS | 22679 | 14:05:16 INFO - PROCESS | 22679 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60913/tests/kraken/driver.html?testName=audio-beat-detection) 14:05:17 INFO - PROCESS | 22679 | RSS: Main: 183431168 14:05:17 INFO - PROCESS | 22679 | 14:05:19 INFO - PROCESS | 22679 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60913/tests/kraken/driver.html?testName=audio-dft) 14:05:20 INFO - PROCESS | 22679 | RSS: Main: 173051904 14:05:20 INFO - PROCESS | 22679 | 14:05:23 INFO - PROCESS | 22679 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60913/tests/kraken/driver.html?testName=audio-fft) 14:05:24 INFO - PROCESS | 22679 | RSS: Main: 159248384 14:05:24 INFO - PROCESS | 22679 | 14:05:25 INFO - PROCESS | 22679 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60913/tests/kraken/driver.html?testName=audio-oscillator) 14:05:26 INFO - PROCESS | 22679 | RSS: Main: 160665600 14:05:26 INFO - PROCESS | 22679 | 14:05:28 INFO - PROCESS | 22679 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60913/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:05:29 INFO - PROCESS | 22679 | RSS: Main: 161607680 14:05:29 INFO - PROCESS | 22679 | 14:05:32 INFO - PROCESS | 22679 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60913/tests/kraken/driver.html?testName=imaging-darkroom) 14:05:32 INFO - PROCESS | 22679 | RSS: Main: 163471360 14:05:32 INFO - PROCESS | 22679 | 14:05:36 INFO - PROCESS | 22679 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60913/tests/kraken/driver.html?testName=imaging-desaturate) 14:05:36 INFO - PROCESS | 22679 | RSS: Main: 164691968 14:05:36 INFO - PROCESS | 22679 | 14:05:39 INFO - PROCESS | 22679 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60913/tests/kraken/driver.html?testName=json-parse-financial) 14:05:40 INFO - PROCESS | 22679 | RSS: Main: 163540992 14:05:40 INFO - PROCESS | 22679 | 14:05:41 INFO - PROCESS | 22679 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60913/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:05:42 INFO - PROCESS | 22679 | RSS: Main: 173752320 14:05:42 INFO - PROCESS | 22679 | 14:05:43 INFO - PROCESS | 22679 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60913/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:05:44 INFO - PROCESS | 22679 | RSS: Main: 169365504 14:05:44 INFO - PROCESS | 22679 | 14:05:46 INFO - PROCESS | 22679 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60913/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:05:47 INFO - PROCESS | 22679 | RSS: Main: 181301248 14:05:47 INFO - PROCESS | 22679 | 14:05:49 INFO - PROCESS | 22679 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:05:50 INFO - PROCESS | 22679 | RSS: Main: 191086592 14:05:50 INFO - PROCESS | 22679 | 14:05:52 INFO - PROCESS | 22679 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:05:53 INFO - PROCESS | 22679 | RSS: Main: 189255680 14:05:53 INFO - PROCESS | 22679 | 14:05:55 INFO - PROCESS | 22679 | Cycle 1(1): loaded http://localhost:60913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60913/tests/kraken/driver.html?testName=ai-astar) 14:05:55 INFO - PROCESS | 22679 | RSS: Main: 246157312 14:05:55 INFO - PROCESS | 22679 | 14:05:55 INFO - PROCESS | 22679 | __start_tp_report 14:05:55 INFO - PROCESS | 22679 | _x_x_mozilla_page_load 14:05:55 INFO - PROCESS | 22679 | _x_x_mozilla_page_load_details 14:05:55 INFO - PROCESS | 22679 | |i|pagename|runs| 14:05:55 INFO - PROCESS | 22679 | |0;ai-astar;110;111;104;109;109;112;99;111;110;109 14:05:55 INFO - PROCESS | 22679 | |1;audio-beat-detection;156;126;150;158;125;149;146;127;166;125 14:05:55 INFO - PROCESS | 22679 | |2;audio-dft;160;161;161;160;160;160;160;162;161;162 14:05:55 INFO - PROCESS | 22679 | |3;audio-fft;74;72;82;91;72;72;72;105;89;72 14:05:55 INFO - PROCESS | 22679 | |4;audio-oscillator;95;96;141;94;96;95;147;96;96;138 14:05:55 INFO - PROCESS | 22679 | |5;imaging-gaussian-blur;109;109;109;109;109;110;109;109;109;109 14:05:55 INFO - PROCESS | 22679 | |6;imaging-darkroom;146;145;147;146;146;145;146;146;145;146 14:05:55 INFO - PROCESS | 22679 | |7;imaging-desaturate;95;96;96;95;96;95;95;95;96;96 14:05:55 INFO - PROCESS | 22679 | |8;json-parse-financial;56;55;56;55;56;56;55;64;53;54 14:05:55 INFO - PROCESS | 22679 | |9;json-stringify-tinderbox;66;67;67;67;68;68;67;67;73;68 14:05:55 INFO - PROCESS | 22679 | |10;stanford-crypto-aes;84;87;87;85;93;87;87;88;87;87 14:05:55 INFO - PROCESS | 22679 | |11;stanford-crypto-ccm;116;122;124;129;118;123;120;118;116;134 14:05:55 INFO - PROCESS | 22679 | |12;stanford-crypto-pbkdf2;144;141;147;148;148;140;151;153;147;138 14:05:55 INFO - PROCESS | 22679 | |13;stanford-crypto-sha256-iterative;70;70;70;66;67;69;67;67;67;67 14:05:55 INFO - PROCESS | 22679 | __end_tp_report 14:05:55 INFO - PROCESS | 22679 | __start_cc_report 14:05:55 INFO - PROCESS | 22679 | _x_x_mozilla_cycle_collect,985 14:05:55 INFO - PROCESS | 22679 | __end_cc_report 14:05:55 INFO - PROCESS | 22679 | __startTimestamp1452204355341__endTimestamp 14:05:55 INFO - PROCESS | 22679 | 14:05:55 INFO - PROCESS | 22679 | ------- Summary: start ------- 14:05:55 INFO - PROCESS | 22679 | Number of tests: 14 14:05:55 INFO - PROCESS | 22679 | 14:05:55 INFO - PROCESS | 22679 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.50 stddev:3.95 (3.6%) stddev-sans-first:4.15 14:05:55 INFO - PROCESS | 22679 | Values: 110.0 111.0 104.0 109.0 109.0 112.0 99.0 111.0 110.0 109.0 14:05:55 INFO - PROCESS | 22679 | 14:05:55 INFO - PROCESS | 22679 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:149.50 stddev:15.67 (10.5%) stddev-sans-first:15.87 14:05:55 INFO - PROCESS | 22679 | Values: 156.0 126.0 150.0 158.0 125.0 149.0 146.0 127.0 166.0 125.0 14:05:55 INFO - PROCESS | 22679 | 14:05:55 INFO - PROCESS | 22679 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 14:05:55 INFO - PROCESS | 22679 | Values: 160.0 161.0 161.0 160.0 160.0 160.0 160.0 162.0 161.0 162.0 14:05:55 INFO - PROCESS | 22679 | 14:05:55 INFO - PROCESS | 22679 | [#3] audio-fft Cycles:10 Average:80.10 Median:73.00 stddev:11.48 (15.7%) stddev-sans-first:11.97 14:05:55 INFO - PROCESS | 22679 | Values: 74.0 72.0 82.0 91.0 72.0 72.0 72.0 105.0 89.0 72.0 14:05:55 INFO - PROCESS | 22679 | 14:05:55 INFO - PROCESS | 22679 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:95.50 stddev:22.61 (23.7%) stddev-sans-first:23.37 14:05:55 INFO - PROCESS | 22679 | Values: 95.0 96.0 141.0 94.0 96.0 95.0 147.0 96.0 96.0 138.0 14:05:55 INFO - PROCESS | 22679 | 14:05:55 INFO - PROCESS | 22679 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:05:55 INFO - PROCESS | 22679 | Values: 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 14:05:55 INFO - PROCESS | 22679 | 14:05:55 INFO - PROCESS | 22679 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 14:05:55 INFO - PROCESS | 22679 | Values: 146.0 145.0 147.0 146.0 146.0 145.0 146.0 146.0 145.0 146.0 14:05:55 INFO - PROCESS | 22679 | 14:05:55 INFO - PROCESS | 22679 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 14:05:55 INFO - PROCESS | 22679 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 14:05:55 INFO - PROCESS | 22679 | 14:05:55 INFO - PROCESS | 22679 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:2.98 (5.3%) stddev-sans-first:3.16 14:05:55 INFO - PROCESS | 22679 | Values: 56.0 55.0 56.0 55.0 56.0 56.0 55.0 64.0 53.0 54.0 14:05:55 INFO - PROCESS | 22679 | 14:05:55 INFO - PROCESS | 22679 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:67.50 stddev:1.93 (2.9%) stddev-sans-first:1.94 14:05:55 INFO - PROCESS | 22679 | Values: 66.0 67.0 67.0 67.0 68.0 68.0 67.0 67.0 73.0 68.0 14:05:55 INFO - PROCESS | 22679 | 14:05:55 INFO - PROCESS | 22679 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:87.00 stddev:2.35 (2.7%) stddev-sans-first:2.19 14:05:55 INFO - PROCESS | 22679 | Values: 84.0 87.0 87.0 85.0 93.0 87.0 87.0 88.0 87.0 87.0 14:05:55 INFO - PROCESS | 22679 | 14:05:55 INFO - PROCESS | 22679 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:122.50 stddev:5.83 (4.8%) stddev-sans-first:5.77 14:05:55 INFO - PROCESS | 22679 | Values: 116.0 122.0 124.0 129.0 118.0 123.0 120.0 118.0 116.0 134.0 14:05:55 INFO - PROCESS | 22679 | 14:05:55 INFO - PROCESS | 22679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.70 Median:147.50 stddev:4.85 (3.3%) stddev-sans-first:5.11 14:05:55 INFO - PROCESS | 22679 | Values: 144.0 141.0 147.0 148.0 148.0 140.0 151.0 153.0 147.0 138.0 14:05:55 INFO - PROCESS | 22679 | 14:05:55 INFO - PROCESS | 22679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.56 (2.3%) stddev-sans-first:1.48 14:05:55 INFO - PROCESS | 22679 | Values: 70.0 70.0 70.0 66.0 67.0 69.0 67.0 67.0 67.0 67.0 14:05:55 INFO - PROCESS | 22679 | -------- Summary: end -------- 14:05:55 INFO - PROCESS | 22679 | 14:05:56 INFO - TEST-INFO | 22679: exit 0 14:05:56 INFO - TEST-OK | kraken | took 58231ms 14:05:56 INFO - TEST-START | v8_7 14:05:56 INFO - operating with platform_type : linux_ 14:05:56 INFO - Initialising browser for v8_7 test... 14:05:56 INFO - TEST-INFO | started process 22928 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPdeSpZ/profile http://localhost:60913/getInfo.html) 14:05:59 INFO - PROCESS | 22928 | __metrics Screen width/height:1600/1200 14:05:59 INFO - PROCESS | 22928 | colorDepth:24 14:05:59 INFO - PROCESS | 22928 | Browser inner width/height: 1024/697 14:05:59 INFO - PROCESS | 22928 | __metrics 14:05:59 INFO - PROCESS | 22928 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:05:59 INFO - PROCESS | 22928 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:06:00 INFO - TEST-INFO | 22928: exit 0 14:06:00 INFO - Browser initialized. 14:06:00 INFO - Running cycle 1/1 for v8_7 test... 14:06:00 INFO - TEST-INFO | started process 23010 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPdeSpZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:06:12 INFO - PROCESS | 23010 | RSS: Main: 149893120 14:06:12 INFO - PROCESS | 23010 | 14:06:33 INFO - PROCESS | 23010 | Cycle 1(1): loaded http://localhost:60913/tests/v8_7/run.html (next: http://localhost:60913/tests/v8_7/run.html) 14:06:33 INFO - PROCESS | 23010 | RSS: Main: 563417088 14:06:33 INFO - PROCESS | 23010 | 14:06:33 INFO - PROCESS | 23010 | __start_tp_report 14:06:33 INFO - PROCESS | 23010 | _x_x_mozilla_page_load 14:06:33 INFO - PROCESS | 23010 | _x_x_mozilla_page_load_details 14:06:33 INFO - PROCESS | 23010 | |i|pagename|runs| 14:06:33 INFO - PROCESS | 23010 | |0;Richards;166.11295681063123 14:06:33 INFO - PROCESS | 23010 | |1;DeltaBlue;190.5850962454736 14:06:33 INFO - PROCESS | 23010 | |2;Encrypt;284.3332385555872 14:06:33 INFO - PROCESS | 23010 | |3;Decrypt;5246.073298429319 14:06:33 INFO - PROCESS | 23010 | |4;RayTrace;1114.8272017837235 14:06:33 INFO - PROCESS | 23010 | |5;Earley;786.7820613690008 14:06:33 INFO - PROCESS | 23010 | |6;Boyer;12382.716049382716 14:06:33 INFO - PROCESS | 23010 | |7;RegExp;26315.78947368421 14:06:33 INFO - PROCESS | 23010 | |8;Splay;586.5102639296188 14:06:33 INFO - PROCESS | 23010 | |9;NavierStokes;4835.748792270531 14:06:33 INFO - PROCESS | 23010 | __end_tp_report 14:06:33 INFO - PROCESS | 23010 | __startTimestamp1452204393967__endTimestamp 14:06:33 INFO - PROCESS | 23010 | 14:06:33 INFO - PROCESS | 23010 | ------- Summary: start ------- 14:06:33 INFO - PROCESS | 23010 | Number of tests: 10 14:06:33 INFO - PROCESS | 23010 | 14:06:33 INFO - PROCESS | 23010 | [#0] Richards Cycles:1 Average:166.11 Median:166.11 stddev:0.00 (0.0%) 14:06:33 INFO - PROCESS | 23010 | Values: 166.1 14:06:33 INFO - PROCESS | 23010 | 14:06:33 INFO - PROCESS | 23010 | [#1] DeltaBlue Cycles:1 Average:190.59 Median:190.59 stddev:0.00 (0.0%) 14:06:33 INFO - PROCESS | 23010 | Values: 190.6 14:06:33 INFO - PROCESS | 23010 | 14:06:33 INFO - PROCESS | 23010 | [#2] Encrypt Cycles:1 Average:284.33 Median:284.33 stddev:0.00 (0.0%) 14:06:33 INFO - PROCESS | 23010 | Values: 284.3 14:06:33 INFO - PROCESS | 23010 | 14:06:33 INFO - PROCESS | 23010 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 14:06:33 INFO - PROCESS | 23010 | Values: 5246.1 14:06:33 INFO - PROCESS | 23010 | 14:06:33 INFO - PROCESS | 23010 | [#4] RayTrace Cycles:1 Average:1114.83 Median:1114.83 stddev:0.00 (0.0%) 14:06:33 INFO - PROCESS | 23010 | Values: 1114.8 14:06:33 INFO - PROCESS | 23010 | 14:06:33 INFO - PROCESS | 23010 | [#5] Earley Cycles:1 Average:786.78 Median:786.78 stddev:0.00 (0.0%) 14:06:33 INFO - PROCESS | 23010 | Values: 786.8 14:06:33 INFO - PROCESS | 23010 | 14:06:33 INFO - PROCESS | 23010 | [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 14:06:33 INFO - PROCESS | 23010 | Values: 12382.7 14:06:33 INFO - PROCESS | 23010 | 14:06:33 INFO - PROCESS | 23010 | [#7] RegExp Cycles:1 Average:26315.79 Median:26315.79 stddev:0.00 (0.0%) 14:06:33 INFO - PROCESS | 23010 | Values: 26315.8 14:06:33 INFO - PROCESS | 23010 | 14:06:33 INFO - PROCESS | 23010 | [#8] Splay Cycles:1 Average:586.51 Median:586.51 stddev:0.00 (0.0%) 14:06:33 INFO - PROCESS | 23010 | Values: 586.5 14:06:33 INFO - PROCESS | 23010 | 14:06:33 INFO - PROCESS | 23010 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 14:06:33 INFO - PROCESS | 23010 | Values: 4835.7 14:06:33 INFO - PROCESS | 23010 | -------- Summary: end -------- 14:06:33 INFO - PROCESS | 23010 | 14:06:34 INFO - TEST-INFO | 23010: exit 0 14:06:34 INFO - TEST-OK | v8_7 | took 38564ms 14:06:34 INFO - SUITE-END | took 1208s 14:06:35 INFO - Completed test suite (00:20:09) 14:06:35 INFO - Working with test: dromaeo_css 14:06:35 INFO - Generating results file: dromaeo_css 14:06:35 INFO - Working with test: kraken 14:06:35 INFO - Generating results file: kraken 14:06:35 INFO - javascript benchmark 14:06:35 INFO - Working with test: v8_7 14:06:35 INFO - Generating results file: v8_7 14:06:35 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:06:35 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 14:06:35 INFO - process_Request line: dromaeo_css 6822.72 graph.html#tests=[[72,201,35]] 14:06:35 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:06:35 INFO - process_Request line: kraken 1498.50 graph.html#tests=[[232,201,35]] 14:06:35 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:06:35 INFO - process_Request line: v8_7 20950.39 graph.html#tests=[[230,201,35]] 14:06:35 INFO - RETURN: dromaeo_css: 6822.72 14:06:35 INFO - RETURN: kraken: 1498.50 14:06:35 INFO - RETURN: v8_7: 20950.39 14:06:35 INFO - javascript benchmark 14:06:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3138.4037032963734, 3183.904482865512, 3237.320162765819, 3238.206639373354, 3274.083256688127, 5085.567726743222, 5200.8699782505455, 5232.4505926877655, 5252.789888404459, 5305.681659100456, 5207.6354655174055, 5234.110201265785, 5281.2342210379475, 5292.126799078147, 5326.041312563737, 4777.641676874222, 4788.832390866321, 4794.137055330039, 4858.805647774085, 4901.632377571678, 4852.49048849871, 4868.902621947559, 4898.53463920927, 4915.434725006617, 4926.0, 4644.2801365788355, 4776.999999999983, 4784.569388755029, 4880.389951256093, 4890.73100979446, 4818.494058123882, 4831.202851529529, 4834.613230941516, 4849.296851956482, 4853.757312134415, 4666.183417901853, 4802.0, 4802.35168252285, 4803.783829727636, 4859.829905953275, 5028.296038554568, 5060.51925067118, 5109.872253193663, 5119.641625086246, 5171.250168725552, 5647.774089036434, 5654.943450565524, 5655.575831812631, 5656.745446454878, 5661.688607126606, 5408.13469844823, 5559.833205003816, 5682.687452190128, 5694.145878118274, 5705.914411283834, 5184.948150518484, 5207.0887594670785, 5284.471552844761, 5315.787368505294, 5343.09167441532, 5673.943260567424, 5704.344000440003, 5705.229793977843, 5706.942930570641, 5754.942450575524, 5392.433794451605, 5470.8085217017215, 5481.506664400223, 5503.11950087992, 5535.446455354432, 5550.4449555044985, 5597.384287728347, 5685.857853553694, 5695.202671625976, 5695.7152142392715, 5508.338999320027, 5570.136628822539, 5579.414161513064, 5581.888362232733, 5593.468620481048, 5562.527185189304, 5572.219889215513, 5579.581531385081, 5582.637128586629, 5591.189277554732, 4298.806553705091, 4305.052888364555, 4378.233809083397, 4386.539413361551, 4390.934135987963, 3893.4743809585343, 3897.2205558888336, 3925.4896863407575, 3940.5174739913673, 3964.9207015860097, 5230.189320655304, 5230.267762513251, 5230.503102205284, 5238.292830467914, 5239.083160446983, 5456.072467680504, 5589.580781441408, 5594.049011667945, 5600.0, 5687.573431992534, 5236.39781425141, 5295.867603309871, 5302.045631786238, 5303.4696530346655, 5305.0, 4865.927011094836, 4876.658633895593, 4878.268259761065, 4878.390201224847, 4929.285253638202, 5665.943340566541, 5783.652980821164, 5784.681842498619, 5907.261592300963, 6007.12896629995, 5635.211070450222, 5648.209250704823, 5653.971730141323, 5655.943440565542, 5658.17956396312, 5824.330202026821, 5841.357450680337, 5852.18069470266, 5857.26784151981, 5885.970570147122, 5477.75350109254, 5585.581081418829, 5586.636868603528, 5595.776168953196, 5715.542756579381, 5593.972030139823, 5639.210510528447, 5647.491725744702, 5653.519450846724, 5654.491095801398, 5507.284053073075, 5512.283403157564, 5513.696746678971, 5517.503424691797, 5520.392756796668, 5358.7320633967365, 5475.972620136874, 5477.0, 5548.583856210719, 5590.357108932525, 5325.174597937326, 5341.519263266325, 5341.5459685927135, 5344.465553444625, 5345.812896548602, 5438.70087145195, 5442.0, 5442.346918369821, 5449.509544141047, 5463.016657001619, 5336.2529245904825, 5342.706151161723, 5396.9460305398015, 5416.485433883775, 5453.345598528202], "unit": "score", "name": "dojo.html", "value": 5191.354861497629}, {"lowerIsBetter": false, "replicates": [502.2190493782168, 505.07571144805036, 509.94645562215965, 529.1639210048123, 535.6598559914453, 27872.86063569682, 29019.0, 35978.46032309514, 36722.44916326257, 36805.26389472209, 40128.59871401285, 40707.79646101766, 40717.185656286856, 40856.79571602145, 40863.0, 7463.290987356192, 8464.873026904586, 8594.312455003615, 8599.398042137052, 8629.482231066124, 7491.400687944979, 7584.01407816983, 10193.286469947107, 10385.532651030722, 10389.532471038821, 10101.949490252538, 10189.54147063384, 10203.489825508732, 10211.795764084714, 10217.897821021768, 7652.57910814905, 7816.570088645122, 10085.697429077103, 10104.242181836391, 10178.134858536996, 10221.540030698561, 10407.947960260226, 10465.0, 10471.738206544822, 10473.162147028219, 35477.64522354769, 35796.0, 35824.10439739027, 35851.4622280666, 35934.10164745876, 3233.514972754082, 3315.1546355679147, 3321.667833216683, 3321.750868684834, 3332.8500217490273, 28224.576631350545, 28423.0, 30954.53568196479, 31355.529667055012, 31687.84156079228, 3910.276598829197, 3911.1395492991496, 4010.598940105995, 4102.651274641659, 4180.540140584533, 260850.0, 261611.0, 262235.9999999981, 263504.0, 264641.0, 51004.0, 51931.740341298806, 58833.0, 60186.0, 60257.0, 59225.0, 59263.70368148218, 59400.0, 59736.40263597395, 59903.70048149731, 15149.62125946838, 15242.542723718307, 15322.693546129016, 15343.07941523512, 15381.38474461009, 10927.726806829893, 10973.451327433597, 10990.835137472945, 11008.614698485675, 11070.944645276883, 19740.90129549343, 20120.698189527167, 20130.597388052156, 20131.899340503496, 20145.798542014687, 7262.346388824925, 7438.776836694908, 7451.993980812521, 7551.0, 7560.9621951889885, 964.5273815830193, 971.7376308396834, 985.3152059318704, 1012.4380968562372, 1123.7864805686893, 25326.240212793644, 28581.42837143287, 28800.567991480144, 29473.410531789243, 29589.0, 1029.3875144289136, 1038.2472707287156, 1071.3411252079916, 1073.3238060022136, 1148.0930065248526, 13860.861391386159, 14144.36350364236, 14159.027500996535, 14275.571732847824, 14294.356753946098, 322208.0, 333685.0, 336919.0, 337007.0, 337037.0, 47972.7601361991, 48113.5188648116, 48147.03705925932, 48151.5184848154, 48199.75900120477, 1308.7317099994477, 1317.4071667749358, 1338.6118025772612, 1339.8928085753116, 1345.4080204709896, 27089.59365609478, 28318.716812832434, 28362.85818570894, 28571.14286571406, 29557.852210739667, 43202.78398607987, 43538.782306088266, 43669.78165109154, 43692.34461483017, 43724.78137609291, 198729.0, 198931.0, 199781.0, 200377.0, 200449.0, 29154.708452915198, 31533.684663153075, 31966.84016579902, 32285.677143229208, 32380.190495237806, 38229.61770382372, 38346.0, 38470.615293846706, 38698.0, 39408.40887386749, 32932.34135317232, 32955.83522082374, 33211.50182747309, 33584.49623255604, 35380.292394152486, 30071.24821879383, 32593.674063259063, 34313.0, 36075.819620901726, 37269.0, 32562.185945351557, 33021.83489082539, 33254.66745332516, 33303.0, 33319.0, 30445.54331684982, 30848.228794280323, 32069.358612827145, 32083.19792005125, 32266.83866580652, 22297.888510557343, 24947.37631559153, 25024.374390639652, 25385.619215712148, 25444.109456168946], "unit": "score", "name": "ext.html", "value": 17936.99370885091}, {"lowerIsBetter": false, "replicates": [330.1893850596785, 332.5842696629214, 333.77803760499256, 334.90713263016045, 341.2816022273115, 13924.582262532114, 14285.214313212795, 15966.827367421865, 16140.515784526468, 17846.643067138648, 15905.761413578806, 16031.759523607156, 16699.83300167001, 16704.665906681857, 16720.08039557824, 4661.720296782187, 4912.287718280847, 4913.631477639174, 4913.803447862081, 4918.704877707331, 3735.2716220337047, 3824.9617503825025, 4878.70727756334, 5304.867378315554, 5462.945370546303, 5406.351237851463, 5413.242146099549, 5427.45725427458, 5451.890962180754, 5456.0997435423105, 5183.144781111131, 5338.199270109476, 5343.438938911417, 5349.545288650469, 5428.565714742831, 5114.744262786846, 5150.562202212816, 5152.407473140562, 5173.120569503193, 5181.5854731621375, 11633.185677002613, 12107.636770896886, 12163.452644630925, 12184.02527797774, 12224.694382640506, 2061.175529788082, 2085.8852763098025, 2118.491562025118, 2121.0561300221407, 2239.857672586976, 9022.323325750594, 9162.083791620851, 9163.35856490046, 9570.330076894621, 10779.029887310102, 1804.1881153480986, 1821.271491403436, 1838.5219842840825, 1920.3854766474733, 1969.133581224271, 52726.73636631792, 58663.0, 59068.40931590672, 59448.0, 59903.80192396171, 9845.409275443497, 10191.643292484727, 10192.439415832201, 10246.48767561619, 10276.0, 13285.269310188032, 13292.933535332262, 13309.66725831862, 13318.667033324244, 13354.732905341838, 6870.244273129952, 6908.378245957888, 7125.394341481032, 7150.249223831423, 7187.712491500386, 6566.146400967939, 6758.05387245786, 6769.153855768029, 6788.898166527506, 6800.455963522906, 4416.050549131952, 4417.359482874966, 4421.38100665907, 4448.310511870665, 4462.085272519126, 1710.632214073955, 1751.7109676903424, 1759.4193916007687, 1759.6832570137499, 1762.0749106719074, 868.3140319147802, 883.3551507399634, 905.6603773584906, 956.5791051937125, 983.7048885334372, 16111.436099736453, 17114.828851711325, 17320.307187712602, 17426.12869356527, 17477.7378339325, 887.8934527856569, 913.1462082952461, 935.7426707655313, 944.763809047738, 981.2640519610293, 9632.229421646252, 9776.364536305118, 9867.555959981819, 9904.059114384121, 9921.603135874484, 567088.151914681, 569655.0, 585574.0, 586787.0, 588208.0, 77498.22501775023, 78301.0, 78656.0, 79261.0, 79614.0, 1064.5794911010262, 1065.9766624041008, 1085.5223701571442, 1091.8962698543626, 1097.7914196302836, 15031.849681503045, 15059.247037647854, 15283.694326113638, 15286.694266114839, 15610.21948902573, 33261.33477330488, 33289.500657489676, 33611.66388336085, 34987.65012349844, 37198.44202336913, 38557.421638676, 40184.0, 41713.0, 42120.3681944765, 45544.77227613841, 8959.0, 9372.859407109036, 9601.807963840824, 9898.901010990086, 9901.752456188653, 10946.726331841768, 10957.83563246568, 11005.779884402427, 11084.778304434027, 14041.5085472008, 11715.648530544097, 11930.522779088738, 12020.699482513008, 14360.784588231394, 14933.0, 13533.661658458617, 13928.303584820516, 13960.790588140982, 14020.298985050911, 14524.0, 14492.85507144915, 14690.11859288446, 14831.629209269855, 14907.329170187584, 15067.4726384576, 9285.442873427615, 9749.561269742737, 9835.262355323237, 10022.098011179029, 10038.347507411994, 14866.182359970306, 14877.0, 14970.925145374204, 15150.3182356792, 15181.544553662967], "unit": "score", "name": "jquery.html", "value": 8476.756187566025}, {"lowerIsBetter": false, "replicates": [1273.8853503184723, 1426.1443134119527, 1427.3291552970102, 1555.1757568488706, 1768.5490199999006, 6723.663816809159, 7226.891596626055, 7315.8536829263385, 7320.926790732091, 7322.890156647648, 7207.747728829492, 7300.963495182516, 7317.853642927138, 7357.0, 7394.223606521318, 1919.8464122870207, 1975.6147551227516, 2155.9029843656995, 2190.310052333514, 2238.473958619723, 1853.2586965213889, 1859.962800743991, 1862.9347972820954, 1866.6266746650656, 1869.0000849545495, 2184.5740080684272, 2223.210760180137, 2234.128689810975, 2242.7308722953185, 2245.69683092782, 2198.472366632013, 2217.157480157546, 2220.200727738021, 2222.7443843957826, 2261.5929132756096, 2257.9887100564392, 2261.9886900565557, 2299.908003679851, 2303.516261585069, 2303.988480057589, 7446.069241344832, 7476.551406915548, 7498.66256018475, 7506.924930750732, 7529.811754706121, 4587.059652771174, 4613.238815595456, 4657.0, 4660.510646382115, 4661.440627124767, 2820.1257610140924, 2932.061740243123, 2938.676745557987, 2943.8380889051095, 2947.3515826518133, 949.8005418862048, 963.942163470187, 970.2238209432426, 982.2338575910801, 1021.5403068619152, 10226.795464090677, 10332.32839865414, 10413.79172416555, 10420.843687344695, 10430.634927777492, 4155.085881106152, 4208.705390622688, 4267.295896177096, 4282.678799090081, 4287.099709061132, 8858.158474945, 8881.689140880038, 8894.332925030649, 8894.377393582516, 8918.063603321558, 4742.383490146259, 4751.192297309466, 4751.40607424072, 4752.192127338291, 4754.453237877619, 4273.0, 4319.568043195655, 4319.8488052918, 4324.156789426094, 4324.329728892027, 3416.6754158354915, 3476.7392445566684, 3602.85588576454, 3612.9819350903076, 3695.3533131702384, 1163.1450883600546, 1172.6306213542707, 1172.8299396587447, 1177.087756988341, 1188.6552899659002, 1074.312440038376, 1076.1498416251075, 1117.044926587772, 1229.7786398448186, 1347.6496111011209, 7146.428285737128, 7172.175199852084, 7248.710051597877, 7253.528520646141, 7265.346118849329, 1128.3342827731678, 1129.6554550861902, 1131.5021390588115, 1131.7962766702074, 1146.8337091121741, 5756.884862302814, 5853.707314634251, 5878.0, 5885.793997210163, 5892.941070589325, 9127.680531181377, 9324.1608255256, 9326.72019839406, 9442.055794420503, 9531.714048578553, 9368.67209647659, 9478.33651644392, 9482.952585237168, 9494.857577136348, 9514.38156519824, 7181.425485961111, 7281.344678978811, 7338.4496162788, 7463.738769143054, 7471.215522370181, 7052.294770522906, 7068.681909314196, 7082.468814838805, 7094.787156385317, 7108.537945033556, 8179.591020449073, 8317.085120636604, 8338.874916876373, 8355.289800366794, 8408.201220884006, 8662.956685216534, 8759.343049271458, 8801.779955501164, 8820.603072861608, 8838.469691818511, 6811.080504132077, 6918.169819621678, 6933.272006439453, 6937.549059311129, 6948.687309071003, 6491.058796474579, 6573.605583664996, 6584.242812076673, 7182.533135346186, 7510.887336690063, 6918.238993710788, 6954.8956765647545, 7089.61007144612, 7205.819854503469, 7209.71161153548, 6750.459963202834, 6801.081853949851, 6871.5189936703955, 6932.376086152271, 6994.685239164148, 6852.862942741217, 6868.244493105854, 6907.7236910525025, 6908.516403851682, 6920.5847649141215, 6498.252700939453, 6538.444232240313, 6615.569987950767, 6644.368784965421, 6666.433353165035, 6709.060731497497, 6714.865702685821, 6731.091302674076, 6740.865182696417, 6756.966215168893], "unit": "score", "name": "mootools.html", "value": 4405.491732427357}, {"lowerIsBetter": false, "replicates": [321.0672994949672, 324.2364232233091, 329.3183110960313, 330.71228031612503, 336.80465330108524, 5785.508231800302, 5858.677772722499, 5873.588848780587, 5878.9999999999945, 5916.497097746691, 5627.831165065055, 5785.710714464281, 5798.478136967672, 5806.680632565207, 5819.67991760453, 4508.66185036122, 4515.63874890008, 4518.502964673883, 4524.5249248828895, 4527.09458108378, 4324.2648749712625, 4411.669124815651, 4417.933730994037, 4418.469783625969, 4523.592876641102, 4373.584509471611, 4390.056137930344, 4470.798814053375, 4473.731576105444, 4477.417935668359, 4442.3558584005295, 4449.710768800018, 4454.33185022246, 4454.510003899569, 4457.888552786174, 3964.5837187095226, 3968.1666849961543, 3968.761874287552, 3971.0270983609203, 4007.0383108054148, 5380.973095134538, 5508.614396992212, 5514.862128446781, 5527.2538207341895, 5565.443455654402, 5221.869453263699, 5227.294315267466, 5240.423553409122, 5243.895122097537, 5245.580353571705, 6130.540209484307, 6137.324894261627, 6142.170806941095, 6143.293521245069, 6143.877122457526, 4393.1872603568445, 4406.339049142623, 4406.361077643755, 4406.383106365111, 4409.5149533551285, 6145.723442445101, 6157.599756015845, 6293.433590976834, 6461.903071453932, 6462.0306953956815, 4379.408779814684, 4410.823567057282, 4484.798184081724, 4487.775611219426, 4506.81972721094, 4534.115847409724, 4557.703749256288, 4561.7262964222255, 4565.0641618468135, 4566.4748553916725, 5203.687778733212, 5234.241035049897, 5237.057329680618, 5238.633295669343, 5241.318628578337, 6066.757329706762, 6180.227471566054, 6199.783007594712, 6228.719707613168, 6245.125682404467, 1612.3550579767953, 1624.84563966423, 1625.5042212125416, 1625.5692241555996, 1627.9511614651578, 1084.8481212630238, 1108.894655007773, 1109.8113320735495, 1110.2838669058413, 1128.7121783945042, 5773.364929857712, 5842.357340692521, 5847.181394604759, 5854.941450585525, 5862.062070068769, 6334.683265836689, 6343.080253363237, 6347.777827776005, 6349.873002539924, 6351.491880649537, 5843.678597677083, 5847.035239185572, 5848.590598658053, 5851.561132915049, 5857.7656893724625, 3320.6015278166774, 3433.5193072969805, 3439.208981934169, 3441.5525981622227, 3443.070370999816, 6588.439982601437, 6592.70332835014, 6596.076549283104, 6607.273199948002, 6607.702653380609, 6497.64262965532, 6501.739930402826, 6503.869922601616, 6515.250746164157, 6523.086767852505, 6473.449756770728, 6527.8694426111215, 6535.705893234721, 6558.770443034567, 6698.4306333961185, 6416.0, 6416.967915160394, 6418.422341989243, 6419.2296924369375, 6424.807255782334, 6356.491480681442, 6371.585846919936, 6373.7131829066875, 6373.7131829066875, 6377.713002914973, 6420.165378500765, 6474.514411419068, 6524.3149469305035, 6579.901301480578, 6702.83242918931, 4370.322599997005, 4371.737695738266, 4391.934120988124, 4400.053988392511, 4401.559844015573, 6383.776567820104, 6409.359064093554, 6412.326705695835, 6413.2945376007665, 6424.678766061772, 6032.306284777307, 6215.533834962486, 6220.066989951543, 6225.31521532622, 6227.314995350598, 6222.875542489034, 6225.0, 6230.875382492415, 6230.906536402048, 6235.594686345373, 6119.3268740437625, 6121.4490695837585, 6125.0, 6128.080787881853, 6130.724117414817, 6178.073289006506, 6192.309407375485, 6247.281562620356, 6279.340669229665, 6280.152179455715, 6062.848428789315, 6111.572189946661, 6112.572119951561, 6117.847053823512, 6126.23422072241], "unit": "score", "name": "prototype.html", "value": 4687.588884825172}, {"lowerIsBetter": false, "replicates": [757.8143354878056, 796.7575432154362, 814.2346194577095, 819.2299238715608, 820.6881385073671, 13587.45650173993, 13845.376958036888, 13856.861431385696, 13866.37601307941, 13884.166949982982, 12097.879021209785, 12336.198147120453, 14397.20815355155, 14608.4887028954, 14614.415423383078, 766.4673052228703, 781.8240895798428, 782.0, 782.3936449251819, 783.0994356490054, 654.9934500655004, 663.6217356107021, 740.7777666699996, 756.3722110648176, 787.9921200788004, 824.3075816314295, 825.3314814999869, 829.0341751859077, 829.4276948905236, 830.0703212402118, 672.5930811858852, 824.4599787139404, 826.4338927834392, 826.6238861318116, 827.2761333832926, 497.7113274300897, 597.8505373656586, 603.0833133636892, 605.449041372349, 609.7195290166529, 13500.729985400336, 13513.324333783272, 13555.118917270345, 13566.389512471962, 13572.93213533926, 11585.131115166396, 11683.824742628867, 11730.53077876884, 11864.52541898323, 12401.441935112942, 9537.14165725088, 10156.187504999582, 10224.693259202237, 10528.36829790215, 11082.168837337233, 3503.439449688063, 3542.220711443478, 3561.7684850484634, 3562.305350456662, 3588.766730162557, 47851.76074119642, 48048.75975620135, 48197.75901120507, 48331.516684833055, 48352.758236208596, 8393.0, 8575.756669756227, 8642.351823613255, 8661.956690216508, 8689.695860644848, 17370.478885633453, 17378.0, 17457.738133928, 17471.475855724348, 17480.47558573245, 7251.637418129072, 7267.745628903069, 7273.272672732684, 7332.41340692754, 7469.514481558681, 3991.980040099839, 4168.083021735213, 4201.936970945439, 4263.147370525907, 4300.763458009839, 3004.879804807827, 3040.087973607953, 3040.9543856842165, 3044.543318502198, 3054.618172728409, 547.7726743401523, 565.3131445293988, 568.0541897740217, 568.692905830855, 577.3591313641854, 585.2041223935445, 607.6263098194579, 649.7823229218264, 662.0565693886193, 684.1755684400285, 8308.916910830814, 8406.537640429713, 8485.618147183392, 8579.871301930476, 8844.33667474942, 628.9088082228143, 656.6191608866845, 664.6244871647503, 664.9401553860176, 717.2791344698545, 3931.4692516510477, 4044.5348784889525, 4336.371226172188, 4409.2724700424715, 4535.433070866142, 51283.0, 51366.0, 53618.73190634022, 53706.0, 54261.72869135629, 44153.0, 44217.55782442199, 46174.30738538925, 48031.0, 48083.0, 44408.0, 44887.77556112198, 45263.54736452659, 45318.54681453143, 45532.089358213314, 8338.0, 8713.0, 8757.0, 8878.5116818573, 8922.73231803047, 33806.3238735219, 34467.31065378729, 34503.827480862434, 35015.82492087523, 35137.64862351446, 41226.38160427536, 41647.58352416437, 42326.15347692967, 42831.0, 43478.78260608677, 10821.188410869374, 11344.943275283571, 11348.886511134782, 11572.074234061423, 11644.301341919512, 12609.810852837398, 12776.233425994471, 12823.61529154127, 12904.741905162033, 12980.026498012498, 11152.721181970192, 11355.432228388383, 11734.647960561197, 12062.035037197178, 12456.377181141088, 10617.150627949592, 10874.325060682555, 11316.20786544934, 11596.130290228099, 11908.404579770804, 11068.778624427305, 11147.163962702667, 11173.441327933408, 11174.27367221128, 11243.325400475998, 9589.995818315732, 9951.95778259047, 10074.798504030025, 10087.89912100899, 10252.128569071712, 8795.25240354577, 8817.691380801898, 9313.44119352841, 9439.28244010032, 9643.710688679352], "unit": "score", "name": "yui.html", "value": 6187.324800814491}], "name": "dromaeo_css", "value": 6822.720474394467}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 104.0, 109.0, 109.0, 112.0, 99.0, 111.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [156.0, 126.0, 150.0, 158.0, 125.0, 149.0, 146.0, 127.0, 166.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 142.8}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 82.0, 91.0, 72.0, 72.0, 72.0, 105.0, 89.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 141.0, 94.0, 96.0, 95.0, 147.0, 96.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 55.0, 56.0, 56.0, 55.0, 64.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 67.0, 73.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 87.0, 85.0, 93.0, 87.0, 87.0, 88.0, 87.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.2}, {"lowerIsBetter": true, "replicates": [116.0, 122.0, 124.0, 129.0, 118.0, 123.0, 120.0, 118.0, 116.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [144.0, 141.0, 147.0, 148.0, 148.0, 140.0, 151.0, 153.0, 147.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.7}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 66.0, 67.0, 69.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1498.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.11295681063123], "unit": "score", "name": "Richards", "value": 212.51804000000004}, {"lowerIsBetter": false, "replicates": [190.5850962454736], "unit": "score", "name": "DeltaBlue", "value": 346.9211459999999}, {"lowerIsBetter": false, "replicates": [284.3332385555872], "unit": "score", "name": "Encrypt", "value": 936.1585769999997}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1114.8272017837235], "unit": "score", "name": "RayTrace", "value": 663.7701329999999}, {"lowerIsBetter": false, "replicates": [786.7820613690008], "unit": "score", "name": "Earley", "value": 847.0744729999998}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [26315.78947368421], "unit": "score", "name": "RegExp", "value": 34.61742999999998}, {"lowerIsBetter": false, "replicates": [586.5102639296188], "unit": "score", "name": "Splay", "value": 138.94215499999996}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20950.3932956314}]} 14:06:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20950.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1498.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6822.72"}}} 14:06:35 INFO - Return code: 0 14:06:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:06:35 INFO - # TBPL SUCCESS # 14:06:35 INFO - Running post-action listener: _resource_record_post_action 14:06:35 INFO - Running post-run listener: _resource_record_post_run 14:06:36 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 0; Write bytes: 569466880; Read time: 0; Write time: 462752 14:06:36 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 255848448; Read time: 0; Write time: 249668 14:06:36 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 313425920; Read time: 0; Write time: 213068 14:06:36 INFO - Running post-run listener: _upload_blobber_files 14:06:36 INFO - Blob upload gear active. 14:06:36 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:06:36 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 14:06:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:06:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:06:36 INFO - (blobuploader) - INFO - Open directory for files ... 14:06:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:06:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:06:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:06:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:06:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:06:37 INFO - (blobuploader) - INFO - Done attempting. 14:06:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:06:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:06:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:06:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:06:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:06:38 INFO - (blobuploader) - INFO - Done attempting. 14:06:38 INFO - (blobuploader) - INFO - Iteration through files over. 14:06:38 INFO - Return code: 0 14:06:38 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:06:38 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:06:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/238821c34b492948f2e2c8cb6d6e8d1d23365df7f7fa7d10207046f872c6bfdc7b79938122ac140afc304b254460e3606e389dab0fdd0b9066317bbd63fdea16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/327784fff51d54abe3a71dc30eb4b8576357fa9d178d27ab65abaab389e051e0037bfc153e46acf41f6af5d3346a8aed8584a182a5046dd679d78d0a1f3206d6"} 14:06:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:06:38 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:06:38 INFO - Contents: 14:06:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/238821c34b492948f2e2c8cb6d6e8d1d23365df7f7fa7d10207046f872c6bfdc7b79938122ac140afc304b254460e3606e389dab0fdd0b9066317bbd63fdea16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/327784fff51d54abe3a71dc30eb4b8576357fa9d178d27ab65abaab389e051e0037bfc153e46acf41f6af5d3346a8aed8584a182a5046dd679d78d0a1f3206d6"} 14:06:38 INFO - Copying logs to upload dir... 14:06:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.255833 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-07 14:06:38.653656) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 14:06:38.657435) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/238821c34b492948f2e2c8cb6d6e8d1d23365df7f7fa7d10207046f872c6bfdc7b79938122ac140afc304b254460e3606e389dab0fdd0b9066317bbd63fdea16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/327784fff51d54abe3a71dc30eb4b8576357fa9d178d27ab65abaab389e051e0037bfc153e46acf41f6af5d3346a8aed8584a182a5046dd679d78d0a1f3206d6"} build_url:https://queue.taskcluster.net/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011440 build_url: 'https://queue.taskcluster.net/v1/task/UqmxgjGMTgy3PDbbnRcy6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/238821c34b492948f2e2c8cb6d6e8d1d23365df7f7fa7d10207046f872c6bfdc7b79938122ac140afc304b254460e3606e389dab0fdd0b9066317bbd63fdea16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/327784fff51d54abe3a71dc30eb4b8576357fa9d178d27ab65abaab389e051e0037bfc153e46acf41f6af5d3346a8aed8584a182a5046dd679d78d0a1f3206d6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 14:06:38.682514) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 14:06:38.682828) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1452202978.991341-549410251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004681 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 14:06:38.767009) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 14:06:38.767315) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 14:06:38.767623) ========= ========= Total master_lag: 0.24 =========