builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1452711564.56 results: success (0) buildid: 20160113083112 builduid: abbe6ee34ef14f818fd1d4c53bc6db7d revision: 92e6520552764d4fdd9e0b77d28ccef7179311be ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 10:59:24.563220) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 10:59:24.563608) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 10:59:24.563911) ========= 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=62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006351 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 10:59:24.594677) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 10:59:24.594962) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 10:59:24.686196) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 10:59:24.686444) ========= 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=62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004655 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 10:59:24.753177) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 10:59:24.753436) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 10:59:24.753767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 10:59:24.754033) ========= 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=62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 10:59:24-- 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% 60.9M=0s 2016-01-13 10:59:25 (60.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159807 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 10:59:24.946199) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 10:59:24.946497) ========= 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=62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013886 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 10:59:25.010103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 10:59:25.010417) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 92e6520552764d4fdd9e0b77d28ccef7179311be --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 92e6520552764d4fdd9e0b77d28ccef7179311be --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=62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 10:59:25,262 truncating revision to first 12 chars 2016-01-13 10:59:25,262 Setting DEBUG logging. 2016-01-13 10:59:25,263 attempt 1/10 2016-01-13 10:59:25,263 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/92e652055276?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 10:59:26,357 unpacking tar archive at: fx-team-92e652055276/testing/mozharness/ program finished with exit code 0 elapsedTime=1.415631 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 10:59:26.443156) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 10:59:26.443452) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 10:59:26.451615) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 10:59:26.451877) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 10:59:26.452277) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-01-13 10:59:26.452559) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:59:26 INFO - MultiFileLogger online at 20160113 10:59:26 in /builds/slave/test-pgo 10:59:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:59:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:59:26 INFO - {'append_to_log': False, 10:59:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:59:26 INFO - 'blob_upload_branch': 'Fx-Team', 10:59:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:59:26 INFO - 'branch': 'Fx-Team', 10:59:26 INFO - 'buildbot_json_path': 'buildprops.json', 10:59:26 INFO - 'config_files': ('talos/linux_config.py',), 10:59:26 INFO - 'default_actions': ('clobber', 10:59:26 INFO - 'read-buildbot-config', 10:59:26 INFO - 'download-and-extract', 10:59:26 INFO - 'populate-webroot', 10:59:26 INFO - 'create-virtualenv', 10:59:26 INFO - 'install', 10:59:26 INFO - 'run-tests'), 10:59:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:59:26 INFO - 'download_minidump_stackwalk': True, 10:59:26 INFO - 'download_symbols': 'ondemand', 10:59:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:59:26 INFO - 'tooltool.py': '/tools/tooltool.py', 10:59:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:59:26 INFO - '/tools/misc-python/virtualenv.py')}, 10:59:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:59:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:59:26 INFO - 'installer_path': 'installer.exe', 10:59:26 INFO - 'log_level': 'info', 10:59:26 INFO - 'log_name': 'talos', 10:59:26 INFO - 'log_to_console': True, 10:59:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:59:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:59:26 INFO - 'opt_config_files': (), 10:59:26 INFO - 'pip_index': False, 10:59:26 INFO - 'sps_profile': False, 10:59:26 INFO - 'sps_profile_interval': 0, 10:59:26 INFO - 'suite': 'dromaeojs', 10:59:26 INFO - 'system_bits': '32', 10:59:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:59:26 INFO - 'title': 'talos-linux64-ix-018', 10:59:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:59:26 INFO - 'use_talos_json': True, 10:59:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:59:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:59:26 INFO - 'work_dir': 'build'} 10:59:26 INFO - ##### 10:59:26 INFO - ##### Running clobber step. 10:59:26 INFO - ##### 10:59:26 INFO - Running pre-action listener: _resource_record_pre_action 10:59:26 INFO - Running main action method: clobber 10:59:26 INFO - rmtree: /builds/slave/test-pgo/build 10:59:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:59:27 INFO - Running post-action listener: _resource_record_post_action 10:59:27 INFO - ##### 10:59:27 INFO - ##### Running read-buildbot-config step. 10:59:27 INFO - ##### 10:59:27 INFO - Running pre-action listener: _resource_record_pre_action 10:59:27 INFO - Running main action method: read_buildbot_config 10:59:27 INFO - Using buildbot properties: 10:59:27 INFO - { 10:59:27 INFO - "project": "", 10:59:27 INFO - "product": "firefox", 10:59:27 INFO - "script_repo_revision": "production", 10:59:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:59:27 INFO - "repository": "", 10:59:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:59:27 INFO - "buildid": "20160113083112", 10:59:27 INFO - "pgo_build": "True", 10:59:27 INFO - "basedir": "/builds/slave/test-pgo", 10:59:27 INFO - "buildnumber": 896, 10:59:27 INFO - "slavename": "talos-linux64-ix-018", 10:59:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:59:27 INFO - "platform": "ubuntu64_hw", 10:59:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:59:27 INFO - "branch": "fx-team", 10:59:27 INFO - "repo_path": "integration/fx-team", 10:59:27 INFO - "revision": "92e6520552764d4fdd9e0b77d28ccef7179311be", 10:59:27 INFO - "stage_platform": "linux64-pgo", 10:59:27 INFO - "builduid": "abbe6ee34ef14f818fd1d4c53bc6db7d", 10:59:27 INFO - "slavebuilddir": "test" 10:59:27 INFO - } 10:59:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:59:27 INFO - Running post-action listener: _resource_record_post_action 10:59:27 INFO - ##### 10:59:27 INFO - ##### Running download-and-extract step. 10:59:27 INFO - ##### 10:59:27 INFO - Running pre-action listener: _resource_record_pre_action 10:59:27 INFO - Running main action method: download_and_extract 10:59:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:59:27 INFO - https://queue.taskcluster.net/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:59:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/test_packages.json 10:59:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/test_packages.json 10:59:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:59:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:59:33 INFO - Downloaded 1448 bytes. 10:59:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:59:33 INFO - Using the following test package requirements: 10:59:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:59:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:59:33 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:59:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:33 INFO - u'jsshell-linux-x86_64.zip'], 10:59:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:59:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:59:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:59:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:59:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:59:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:59:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:59:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:59:33 INFO - https://queue.taskcluster.net/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:59:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:59:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:59:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/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 10:59:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/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 10:59:47 INFO - Downloaded 24029197 bytes. 10:59:47 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 10:59:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:59:47 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 10:59:49 INFO - Return code: 0 10:59:49 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 10:59:49 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')]} 10:59:49 INFO - https://queue.taskcluster.net/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:59:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:59:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:59:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/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 10:59:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/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 10:59:53 INFO - Downloaded 24029197 bytes. 10:59:53 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 10:59:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:59:53 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 10:59:54 INFO - Return code: 0 10:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:59:54 INFO - https://queue.taskcluster.net/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:59:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:59:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:59:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/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 10:59:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/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 10:59:56 INFO - Downloaded 11132279 bytes. 10:59:56 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 10:59:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:59:56 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 10:59:56 INFO - Return code: 0 10:59: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')]} 10:59:56 INFO - https://queue.taskcluster.net/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:59:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:59:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:59:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/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 10:59:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:00:05 INFO - Downloaded 55893264 bytes. 11:00:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:00:05 INFO - mkdir: /builds/slave/test-pgo/properties 11:00:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:00:05 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:00:05 INFO - Contents: 11:00:05 INFO - build_url:https://queue.taskcluster.net/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:00:05 INFO - Running post-action listener: _resource_record_post_action 11:00:05 INFO - Running post-action listener: set_extra_try_arguments 11:00:05 INFO - ##### 11:00:05 INFO - ##### Running populate-webroot step. 11:00:05 INFO - ##### 11:00:05 INFO - Running pre-action listener: _resource_record_pre_action 11:00:05 INFO - Running main action method: populate_webroot 11:00:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:00:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:00:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:00:05 INFO - '--tppagecycles', 11:00:05 INFO - '7'], 11:00:05 INFO - 'tests': ['tsvgm']}}, 11:00:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:00:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:00:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:00:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:00:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:00:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:00:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:00:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:05 INFO - 'talos_options': ['--e10s'], 11:00:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:00:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:05 INFO - 'tests': ['damp', 'tps']}, 11:00:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:05 INFO - 'talos_options': ['--e10s'], 11:00:05 INFO - 'tests': ['damp', 'tps']}, 11:00:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:00:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:00:05 INFO - 'other': {'tests': ['a11yr', 11:00:05 INFO - 'ts_paint', 11:00:05 INFO - 'tpaint', 11:00:05 INFO - 'sessionrestore', 11:00:05 INFO - 'sessionrestore_no_auto_restore']}, 11:00:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:00:05 INFO - 'tests': ['a11yr', 11:00:05 INFO - 'ts_paint', 11:00:05 INFO - 'tpaint', 11:00:05 INFO - 'sessionrestore', 11:00:05 INFO - 'sessionrestore_no_auto_restore']}, 11:00:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:00:05 INFO - 'tests': ['a11yr', 11:00:05 INFO - 'ts_paint', 11:00:05 INFO - 'tpaint', 11:00:05 INFO - 'sessionrestore', 11:00:05 INFO - 'sessionrestore_no_auto_restore']}, 11:00:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:00:05 INFO - 'tests': ['a11yr', 11:00:05 INFO - 'ts_paint', 11:00:05 INFO - 'tpaint', 11:00:05 INFO - 'sessionrestore', 11:00:05 INFO - 'sessionrestore_no_auto_restore']}, 11:00:05 INFO - 'other_l64': {'tests': ['a11yr', 11:00:05 INFO - 'ts_paint', 11:00:05 INFO - 'tpaint', 11:00:05 INFO - 'sessionrestore', 11:00:05 INFO - 'sessionrestore_no_auto_restore']}, 11:00:05 INFO - 'other_nol64': {'tests': ['a11yr', 11:00:05 INFO - 'ts_paint', 11:00:05 INFO - 'tpaint', 11:00:05 INFO - 'sessionrestore', 11:00:05 INFO - 'sessionrestore_no_auto_restore']}, 11:00:05 INFO - 'svgr': {'tests': ['tsvgx', 11:00:05 INFO - 'tsvgr_opacity', 11:00:05 INFO - 'tart', 11:00:05 INFO - 'tscrollx', 11:00:05 INFO - 'cart']}, 11:00:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:00:05 INFO - 'tests': ['tsvgx', 11:00:05 INFO - 'tsvgr_opacity', 11:00:05 INFO - 'tart', 11:00:05 INFO - 'tscrollx', 11:00:05 INFO - 'cart']}, 11:00:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:05 INFO - 'tests': ['tp5o']}, 11:00:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:05 INFO - 'talos_options': ['--e10s'], 11:00:05 INFO - 'tests': ['tp5o']}, 11:00:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:05 INFO - 'talos_options': ['--xperf_path', 11:00:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:00:05 INFO - 'tests': ['tp5n']}, 11:00:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:05 INFO - 'talos_options': ['--e10s', 11:00:05 INFO - '--xperf_path', 11:00:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:00:05 INFO - 'tests': ['tp5n']}}, 11:00:05 INFO - 'talos.zip': {'path': '', 11:00:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:00:05 INFO - Running post-action listener: _resource_record_post_action 11:00:05 INFO - ##### 11:00:05 INFO - ##### Running create-virtualenv step. 11:00:05 INFO - ##### 11:00:05 INFO - Running pre-action listener: _resource_record_pre_action 11:00:05 INFO - Running main action method: create_virtualenv 11:00:05 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:00:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 11:00:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:00:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:00:06 INFO - Using real prefix '/usr' 11:00:06 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:00:06 INFO - Installing distribute.............................................................................................................................................................................................done. 11:00:08 INFO - Installing pip.................done. 11:00:08 INFO - Return code: 0 11:00:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2fca7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2099480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2128660>, '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 0x2129560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2129a10>, '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': '62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 11:00:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:00:08 INFO - Using env: {'DISPLAY': ':0', 11:00:08 INFO - 'HOME': '/home/cltbld', 11:00:08 INFO - 'LANG': 'en_US.UTF-8', 11:00:08 INFO - 'LANGUAGE': 'en_US:en', 11:00:08 INFO - 'LOGNAME': 'cltbld', 11:00:08 INFO - 'MAIL': '/var/mail/cltbld', 11:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:08 INFO - 'MOZ_NO_REMOTE': '1', 11:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:08 INFO - 'NO_EM_RESTART': '1', 11:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:08 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:08 INFO - 'SHELL': '/bin/bash', 11:00:08 INFO - 'SHLVL': '1', 11:00:08 INFO - 'TERM': 'linux', 11:00:08 INFO - 'TMOUT': '86400', 11:00:08 INFO - 'USER': 'cltbld', 11:00:08 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466', 11:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:08 INFO - '_': '/tools/buildbot/bin/python'} 11:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:00:08 INFO - Cleaning up... 11:00:08 INFO - Return code: 0 11:00:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa2fca7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2099480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2128660>, '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 0x2129560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2129a10>, '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': '62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 11:00:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:00:08 INFO - Using env: {'DISPLAY': ':0', 11:00:08 INFO - 'HOME': '/home/cltbld', 11:00:08 INFO - 'LANG': 'en_US.UTF-8', 11:00:08 INFO - 'LANGUAGE': 'en_US:en', 11:00:08 INFO - 'LOGNAME': 'cltbld', 11:00:08 INFO - 'MAIL': '/var/mail/cltbld', 11:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:08 INFO - 'MOZ_NO_REMOTE': '1', 11:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:08 INFO - 'NO_EM_RESTART': '1', 11:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:08 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:08 INFO - 'SHELL': '/bin/bash', 11:00:08 INFO - 'SHLVL': '1', 11:00:08 INFO - 'TERM': 'linux', 11:00:08 INFO - 'TMOUT': '86400', 11:00:08 INFO - 'USER': 'cltbld', 11:00:08 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466', 11:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:08 INFO - '_': '/tools/buildbot/bin/python'} 11:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:08 INFO - Downloading/unpacking psutil>=0.7.1 11:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:10 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 11:00:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:00:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:00:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:00:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:00:10 INFO - Installing collected packages: psutil 11:00:10 INFO - Running setup.py install for psutil 11:00:10 INFO - building 'psutil._psutil_linux' extension 11:00:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:00:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:00:11 INFO - building 'psutil._psutil_posix' extension 11:00:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:00:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:00:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:00:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:00:11 INFO - Successfully installed psutil 11:00:11 INFO - Cleaning up... 11:00:11 INFO - Return code: 0 11:00:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fa2fca7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2099480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2128660>, '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 0x2129560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2129a10>, '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': '62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 11:00:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:00:11 INFO - Using env: {'DISPLAY': ':0', 11:00:11 INFO - 'HOME': '/home/cltbld', 11:00:11 INFO - 'LANG': 'en_US.UTF-8', 11:00:11 INFO - 'LANGUAGE': 'en_US:en', 11:00:11 INFO - 'LOGNAME': 'cltbld', 11:00:11 INFO - 'MAIL': '/var/mail/cltbld', 11:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:11 INFO - 'MOZ_NO_REMOTE': '1', 11:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:11 INFO - 'NO_EM_RESTART': '1', 11:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:11 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:11 INFO - 'SHELL': '/bin/bash', 11:00:11 INFO - 'SHLVL': '1', 11:00:11 INFO - 'TERM': 'linux', 11:00:11 INFO - 'TMOUT': '86400', 11:00:11 INFO - 'USER': 'cltbld', 11:00:11 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466', 11:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:11 INFO - '_': '/tools/buildbot/bin/python'} 11:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:00:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:00:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:00:13 INFO - Installing collected packages: mozsystemmonitor 11:00:13 INFO - Running setup.py install for mozsystemmonitor 11:00:13 INFO - Successfully installed mozsystemmonitor 11:00:13 INFO - Cleaning up... 11:00:13 INFO - Return code: 0 11:00:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:13 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 0x7fa2fca7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2099480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2128660>, '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 0x2129560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2129a10>, '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': '62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 11:00:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:00:13 INFO - Using env: {'DISPLAY': ':0', 11:00:13 INFO - 'HOME': '/home/cltbld', 11:00:13 INFO - 'LANG': 'en_US.UTF-8', 11:00:13 INFO - 'LANGUAGE': 'en_US:en', 11:00:13 INFO - 'LOGNAME': 'cltbld', 11:00:13 INFO - 'MAIL': '/var/mail/cltbld', 11:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:13 INFO - 'MOZ_NO_REMOTE': '1', 11:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:13 INFO - 'NO_EM_RESTART': '1', 11:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:13 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:13 INFO - 'SHELL': '/bin/bash', 11:00:13 INFO - 'SHLVL': '1', 11:00:13 INFO - 'TERM': 'linux', 11:00:13 INFO - 'TMOUT': '86400', 11:00:13 INFO - 'USER': 'cltbld', 11:00:13 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466', 11:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:13 INFO - '_': '/tools/buildbot/bin/python'} 11:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:13 INFO - Downloading/unpacking blobuploader==1.2.4 11:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:15 INFO - Downloading blobuploader-1.2.4.tar.gz 11:00:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:00:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:00:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:00:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:00:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:16 INFO - Downloading docopt-0.6.1.tar.gz 11:00:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:00:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:00:16 INFO - Installing collected packages: blobuploader, requests, docopt 11:00:16 INFO - Running setup.py install for blobuploader 11:00:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:00:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:00:16 INFO - Running setup.py install for requests 11:00:16 INFO - Running setup.py install for docopt 11:00:16 INFO - Successfully installed blobuploader requests docopt 11:00:16 INFO - Cleaning up... 11:00:16 INFO - Return code: 0 11:00:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:16 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 0x7fa2fca7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2099480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2128660>, '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 0x2129560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2129a10>, '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': '62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 11:00:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:00:16 INFO - Using env: {'DISPLAY': ':0', 11:00:16 INFO - 'HOME': '/home/cltbld', 11:00:16 INFO - 'LANG': 'en_US.UTF-8', 11:00:16 INFO - 'LANGUAGE': 'en_US:en', 11:00:16 INFO - 'LOGNAME': 'cltbld', 11:00:16 INFO - 'MAIL': '/var/mail/cltbld', 11:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:16 INFO - 'MOZ_NO_REMOTE': '1', 11:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:16 INFO - 'NO_EM_RESTART': '1', 11:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:16 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:16 INFO - 'SHELL': '/bin/bash', 11:00:16 INFO - 'SHLVL': '1', 11:00:16 INFO - 'TERM': 'linux', 11:00:16 INFO - 'TMOUT': '86400', 11:00:16 INFO - 'USER': 'cltbld', 11:00:16 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466', 11:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:16 INFO - '_': '/tools/buildbot/bin/python'} 11:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:00:16 INFO - Running setup.py (path:/tmp/pip-_17PUO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:00:17 INFO - Running setup.py (path:/tmp/pip-S53S2B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:00:17 INFO - Running setup.py (path:/tmp/pip-m_Msm2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:00:17 INFO - Running setup.py (path:/tmp/pip-KHgYsA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:00:17 INFO - Running setup.py (path:/tmp/pip-WyKbuH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:00:17 INFO - Running setup.py (path:/tmp/pip-VnCyKY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:00:17 INFO - Running setup.py (path:/tmp/pip-r4JvCN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:00:17 INFO - Running setup.py (path:/tmp/pip-fC7hNb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:00:17 INFO - Running setup.py (path:/tmp/pip-RwStUJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:00:17 INFO - Running setup.py (path:/tmp/pip-YFUbmT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:00:17 INFO - Running setup.py (path:/tmp/pip-zVOSTv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:00:17 INFO - Running setup.py (path:/tmp/pip-H95UIj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:00:17 INFO - Running setup.py (path:/tmp/pip-FAtanM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:00:17 INFO - Running setup.py (path:/tmp/pip-UNvZ6s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:00:17 INFO - Running setup.py (path:/tmp/pip-RhBmQS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:00:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:00:18 INFO - Running setup.py (path:/tmp/pip-bKKVRH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:00:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:00:18 INFO - Running setup.py (path:/tmp/pip-LB_lqa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:00:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:00:18 INFO - Running setup.py install for manifestparser 11:00:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:00:18 INFO - Running setup.py install for mozcrash 11:00:18 INFO - Running setup.py install for mozdebug 11:00:18 INFO - Running setup.py install for mozdevice 11:00:18 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:00:18 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:00:18 INFO - Running setup.py install for mozfile 11:00:18 INFO - Running setup.py install for mozhttpd 11:00:18 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:00:18 INFO - Running setup.py install for mozinfo 11:00:18 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:00:18 INFO - Running setup.py install for mozInstall 11:00:18 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:00:18 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:00:18 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:00:18 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:00:18 INFO - Running setup.py install for mozleak 11:00:19 INFO - Running setup.py install for mozlog 11:00:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:00:19 INFO - Running setup.py install for moznetwork 11:00:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:00:19 INFO - Running setup.py install for mozprocess 11:00:19 INFO - Running setup.py install for mozprofile 11:00:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:00:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:00:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:00:19 INFO - Running setup.py install for mozrunner 11:00:19 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:00:19 INFO - Running setup.py install for mozscreenshot 11:00:19 INFO - Running setup.py install for moztest 11:00:19 INFO - Running setup.py install for mozversion 11:00:19 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:00:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:00:19 INFO - Cleaning up... 11:00:19 INFO - Return code: 0 11:00:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:19 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 0x7fa2fca7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2099480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2128660>, '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 0x2129560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2129a10>, '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': '62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 11:00:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:00:19 INFO - Using env: {'DISPLAY': ':0', 11:00:19 INFO - 'HOME': '/home/cltbld', 11:00:19 INFO - 'LANG': 'en_US.UTF-8', 11:00:19 INFO - 'LANGUAGE': 'en_US:en', 11:00:19 INFO - 'LOGNAME': 'cltbld', 11:00:19 INFO - 'MAIL': '/var/mail/cltbld', 11:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:19 INFO - 'MOZ_NO_REMOTE': '1', 11:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:19 INFO - 'NO_EM_RESTART': '1', 11:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:19 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:19 INFO - 'SHELL': '/bin/bash', 11:00:19 INFO - 'SHLVL': '1', 11:00:19 INFO - 'TERM': 'linux', 11:00:19 INFO - 'TMOUT': '86400', 11:00:19 INFO - 'USER': 'cltbld', 11:00:19 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466', 11:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:19 INFO - '_': '/tools/buildbot/bin/python'} 11:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:00:20 INFO - Running setup.py (path:/tmp/pip-XFATKw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 11:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:00:20 INFO - Running setup.py (path:/tmp/pip-FuaTu5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:00:20 INFO - Running setup.py (path:/tmp/pip-bVnw9D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 11:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:00:20 INFO - Running setup.py (path:/tmp/pip-HfKXTG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:00:20 INFO - Running setup.py (path:/tmp/pip-YI98bo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 11:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:00:20 INFO - Running setup.py (path:/tmp/pip-Y00sSS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 11:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:00:20 INFO - Running setup.py (path:/tmp/pip-E6bg4J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 11:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:00:20 INFO - Running setup.py (path:/tmp/pip-iNq4rn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 11:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:00:20 INFO - Running setup.py (path:/tmp/pip-52Ibce-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 11:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:00:20 INFO - Running setup.py (path:/tmp/pip-tpvnsB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:00:20 INFO - Running setup.py (path:/tmp/pip-QivNia-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 11:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:00:20 INFO - Running setup.py (path:/tmp/pip-LRBjY3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 11:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:00:21 INFO - Running setup.py (path:/tmp/pip-HtrPfo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 11:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:00:21 INFO - Running setup.py (path:/tmp/pip-4x2Pp_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 11:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:00:21 INFO - Running setup.py (path:/tmp/pip-sww2Vo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 11:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:00:21 INFO - Running setup.py (path:/tmp/pip-RzZEdX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 11:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:00:21 INFO - Running setup.py (path:/tmp/pip-589NO_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 11:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 11:00:21 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:00:21 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:00:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:23 INFO - Downloading blessings-1.5.1.tar.gz 11:00:23 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 11:00:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:00:23 INFO - Installing collected packages: blessings 11:00:23 INFO - Running setup.py install for blessings 11:00:23 INFO - Successfully installed blessings 11:00:23 INFO - Cleaning up... 11:00:23 INFO - Return code: 0 11:00:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:00:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:00:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:00:23 INFO - Reading from file tmpfile_stdout 11:00:23 INFO - Current package versions: 11:00:23 INFO - argparse == 1.2.1 11:00:23 INFO - blessings == 1.5.1 11:00:23 INFO - blobuploader == 1.2.4 11:00:23 INFO - docopt == 0.6.1 11:00:23 INFO - manifestparser == 1.1 11:00:23 INFO - mozInstall == 1.12 11:00:23 INFO - mozcrash == 0.16 11:00:23 INFO - mozdebug == 0.1 11:00:23 INFO - mozdevice == 0.48 11:00:23 INFO - mozfile == 1.2 11:00:23 INFO - mozhttpd == 0.7 11:00:23 INFO - mozinfo == 0.9 11:00:23 INFO - mozleak == 0.1 11:00:23 INFO - mozlog == 3.1 11:00:23 INFO - moznetwork == 0.27 11:00:23 INFO - mozprocess == 0.22 11:00:23 INFO - mozprofile == 0.28 11:00:23 INFO - mozrunner == 6.11 11:00:23 INFO - mozscreenshot == 0.1 11:00:23 INFO - mozsystemmonitor == 0.0 11:00:23 INFO - moztest == 0.7 11:00:23 INFO - mozversion == 1.4 11:00:23 INFO - psutil == 3.1.1 11:00:23 INFO - requests == 1.2.3 11:00:23 INFO - wsgiref == 0.1.2 11:00:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:23 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 0x7fa2fca7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2099480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2128660>, '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 0x2129560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2129a10>, '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': '62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 11:00:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:00:23 INFO - Using env: {'DISPLAY': ':0', 11:00:23 INFO - 'HOME': '/home/cltbld', 11:00:23 INFO - 'LANG': 'en_US.UTF-8', 11:00:23 INFO - 'LANGUAGE': 'en_US:en', 11:00:23 INFO - 'LOGNAME': 'cltbld', 11:00:23 INFO - 'MAIL': '/var/mail/cltbld', 11:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:23 INFO - 'MOZ_NO_REMOTE': '1', 11:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:23 INFO - 'NO_EM_RESTART': '1', 11:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:23 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:23 INFO - 'SHELL': '/bin/bash', 11:00:23 INFO - 'SHLVL': '1', 11:00:23 INFO - 'TERM': 'linux', 11:00:23 INFO - 'TMOUT': '86400', 11:00:23 INFO - 'USER': 'cltbld', 11:00:23 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466', 11:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:23 INFO - '_': '/tools/buildbot/bin/python'} 11:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 11:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 11:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 11:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 11:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 11:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 11:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 11:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 11:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 11:00:23 INFO - Cleaning up... 11:00:23 INFO - Return code: 0 11:00:23 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:23 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 0x7fa2fca7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2099480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2128660>, '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 0x2129560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2129a10>, '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': '62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 11:00:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:00:23 INFO - Using env: {'DISPLAY': ':0', 11:00:23 INFO - 'HOME': '/home/cltbld', 11:00:23 INFO - 'LANG': 'en_US.UTF-8', 11:00:23 INFO - 'LANGUAGE': 'en_US:en', 11:00:23 INFO - 'LOGNAME': 'cltbld', 11:00:23 INFO - 'MAIL': '/var/mail/cltbld', 11:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:23 INFO - 'MOZ_NO_REMOTE': '1', 11:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:23 INFO - 'NO_EM_RESTART': '1', 11:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:23 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:23 INFO - 'SHELL': '/bin/bash', 11:00:23 INFO - 'SHLVL': '1', 11:00:23 INFO - 'TERM': 'linux', 11:00:23 INFO - 'TMOUT': '86400', 11:00:23 INFO - 'USER': 'cltbld', 11:00:23 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466', 11:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:23 INFO - '_': '/tools/buildbot/bin/python'} 11:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:23 INFO - Downloading/unpacking jsonschema 11:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:00:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 11:00:25 INFO - Downloading/unpacking functools32 (from jsonschema) 11:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:25 INFO - Downloading functools32-3.2.3-2.tar.gz 11:00:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:00:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:00:25 INFO - warning: no files found matching '*.txt' 11:00:25 INFO - no previously-included directories found matching 'build' 11:00:25 INFO - no previously-included directories found matching 'dist' 11:00:25 INFO - no previously-included directories found matching '.git*' 11:00:25 INFO - Installing collected packages: jsonschema, functools32 11:00:26 INFO - Running setup.py install for functools32 11:00:26 INFO - warning: no files found matching '*.txt' 11:00:26 INFO - no previously-included directories found matching 'build' 11:00:26 INFO - no previously-included directories found matching 'dist' 11:00:26 INFO - no previously-included directories found matching '.git*' 11:00:26 INFO - Successfully installed jsonschema functools32 11:00:26 INFO - Cleaning up... 11:00:26 INFO - Return code: 0 11:00:26 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:26 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 0x7fa2fca7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2099480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2128660>, '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 0x2129560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2129a10>, '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': '62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:00:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 11:00:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:00:26 INFO - Using env: {'DISPLAY': ':0', 11:00:26 INFO - 'HOME': '/home/cltbld', 11:00:26 INFO - 'LANG': 'en_US.UTF-8', 11:00:26 INFO - 'LANGUAGE': 'en_US:en', 11:00:26 INFO - 'LOGNAME': 'cltbld', 11:00:26 INFO - 'MAIL': '/var/mail/cltbld', 11:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:26 INFO - 'MOZ_NO_REMOTE': '1', 11:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:26 INFO - 'NO_EM_RESTART': '1', 11:00:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:26 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:26 INFO - 'SHELL': '/bin/bash', 11:00:26 INFO - 'SHLVL': '1', 11:00:26 INFO - 'TERM': 'linux', 11:00:26 INFO - 'TMOUT': '86400', 11:00:26 INFO - 'USER': 'cltbld', 11:00:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466', 11:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:26 INFO - '_': '/tools/buildbot/bin/python'} 11:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:26 INFO - Downloading/unpacking flake8 11:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:00:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 11:00:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:00:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 11:00:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 11:00:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:00:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:00:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:00:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:00:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:00:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:00:28 INFO - no previously-included directories found matching 'docs/_build' 11:00:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:00:28 INFO - Running setup.py install for pep8 11:00:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:00:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:00:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:00:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:00:28 INFO - no previously-included directories found matching 'docs/_build' 11:00:28 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:00:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:00:28 INFO - Cleaning up... 11:00:29 INFO - Return code: 0 11:00:29 INFO - Running post-action listener: _resource_record_post_action 11:00:29 INFO - Running post-action listener: _start_resource_monitoring 11:00:29 INFO - Starting resource monitoring. 11:00:29 INFO - ##### 11:00:29 INFO - ##### Running install step. 11:00:29 INFO - ##### 11:00:29 INFO - Running pre-action listener: _resource_record_pre_action 11:00:29 INFO - Running main action method: install 11:00:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:00:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:00:29 INFO - Reading from file tmpfile_stdout 11:00:29 INFO - Detecting whether we're running mozinstall >=1.0... 11:00:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:00:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:00:29 INFO - Reading from file tmpfile_stdout 11:00:29 INFO - Output received: 11:00:29 INFO - Usage: mozinstall [options] installer 11:00:29 INFO - Options: 11:00:29 INFO - -h, --help show this help message and exit 11:00:29 INFO - -d DEST, --destination=DEST 11:00:29 INFO - Directory to install application into. [default: 11:00:29 INFO - "/builds/slave/test-pgo"] 11:00:29 INFO - --app=APP Application being installed. [default: firefox] 11:00:29 INFO - mkdir: /builds/slave/test-pgo/build/application 11:00:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:00:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:00:45 INFO - Reading from file tmpfile_stdout 11:00:45 INFO - Output received: 11:00:45 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:00:45 INFO - Running post-action listener: _resource_record_post_action 11:00:45 INFO - ##### 11:00:45 INFO - ##### Running run-tests step. 11:00:45 INFO - ##### 11:00:45 INFO - Running pre-action listener: _resource_record_pre_action 11:00:45 INFO - Running main action method: run_tests 11:00:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:00:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:00:45 INFO - Python 2.7.3 11:00:45 INFO - Return code: 0 11:00:45 INFO - grabbing minidump binary from tooltool 11:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:45 INFO - 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 0x2128660>, '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 0x2129560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2129a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:00:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 11:00:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:00:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:00:45 INFO - Return code: 0 11:00:45 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:00:45 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:00:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:00:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:00:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:00:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:00:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:00:46 INFO - Return code: 0 11:00:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 11:00:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 11:00:46 INFO - Using env: {'DISPLAY': ':0', 11:00:46 INFO - 'HOME': '/home/cltbld', 11:00:46 INFO - 'LANG': 'en_US.UTF-8', 11:00:46 INFO - 'LANGUAGE': 'en_US:en', 11:00:46 INFO - 'LOGNAME': 'cltbld', 11:00:46 INFO - 'MAIL': '/var/mail/cltbld', 11:00:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:00:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:46 INFO - 'MOZ_NO_REMOTE': '1', 11:00:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:46 INFO - 'NO_EM_RESTART': '1', 11:00:46 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:46 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:46 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:00:46 INFO - 'SHELL': '/bin/bash', 11:00:46 INFO - 'SHLVL': '1', 11:00:46 INFO - 'TERM': 'linux', 11:00:46 INFO - 'TMOUT': '86400', 11:00:46 INFO - 'USER': 'cltbld', 11:00:46 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466', 11:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:46 INFO - '_': '/tools/buildbot/bin/python'} 11:00:46 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 11:00:46 INFO - mozversion application_buildid: 20160113083112 11:00:46 INFO - mozversion application_changeset: 92e6520552764d4fdd9e0b77d28ccef7179311be 11:00:46 INFO - mozversion application_display_name: Nightly 11:00:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:00:46 INFO - mozversion application_name: Firefox 11:00:46 INFO - mozversion application_remotingname: firefox 11:00:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:00:46 INFO - mozversion application_vendor: Mozilla 11:00:46 INFO - mozversion application_version: 46.0a1 11:00:46 INFO - mozversion platform_buildid: 20160113083112 11:00:46 INFO - mozversion platform_changeset: 92e6520552764d4fdd9e0b77d28ccef7179311be 11:00:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:00:46 INFO - mozversion platform_version: 46.0a1 11:00:46 INFO - using testdate: 1452711646 11:00:46 INFO - actual date: 1452711646 11:00:46 INFO - starting webserver on 'localhost:44137' 11:00:46 INFO - SUITE-START | Running 3 tests 11:00:46 INFO - TEST-START | dromaeo_css 11:00:46 INFO - operating with platform_type : linux_ 11:00:46 INFO - Initialising browser for dromaeo_css test... 11:00:46 INFO - TEST-INFO | started process 27522 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDQevDb/profile http://localhost:44137/getInfo.html) 11:00:50 INFO - PROCESS | 27522 | __metrics Screen width/height:1600/1200 11:00:50 INFO - PROCESS | 27522 | colorDepth:24 11:00:50 INFO - PROCESS | 27522 | Browser inner width/height: 1024/697 11:00:50 INFO - PROCESS | 27522 | __metrics 11:00:50 INFO - PROCESS | 27522 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:00:50 INFO - PROCESS | 27522 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:00:51 INFO - TEST-INFO | 27522: exit 0 11:00:51 INFO - Browser initialized. 11:00:51 INFO - Running cycle 1/1 for dromaeo_css test... 11:00:51 INFO - TEST-INFO | started process 27614 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDQevDb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:01:03 INFO - PROCESS | 27614 | RSS: Main: 150667264 11:01:03 INFO - PROCESS | 27614 | 11:01:54 INFO - PROCESS | 27614 | 1452711714447 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:04:02 INFO - PROCESS | 27614 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44137/tests/dromaeo/cssquery-ext.html) 11:04:03 INFO - PROCESS | 27614 | RSS: Main: 238104576 11:04:03 INFO - PROCESS | 27614 | 11:07:05 INFO - PROCESS | 27614 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-ext.html (next: http://localhost:44137/tests/dromaeo/cssquery-jquery.html) 11:07:06 INFO - PROCESS | 27614 | RSS: Main: 233156608 11:07:06 INFO - PROCESS | 27614 | 11:10:08 INFO - PROCESS | 27614 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44137/tests/dromaeo/cssquery-mootools.html) 11:10:08 INFO - PROCESS | 27614 | RSS: Main: 224399360 11:10:08 INFO - PROCESS | 27614 | 11:13:10 INFO - PROCESS | 27614 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44137/tests/dromaeo/cssquery-prototype.html) 11:13:11 INFO - PROCESS | 27614 | RSS: Main: 211685376 11:13:11 INFO - PROCESS | 27614 | 11:16:13 INFO - PROCESS | 27614 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44137/tests/dromaeo/cssquery-yui.html) 11:16:14 INFO - PROCESS | 27614 | RSS: Main: 213516288 11:16:14 INFO - PROCESS | 27614 | 11:19:16 INFO - PROCESS | 27614 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-yui.html (next: http://localhost:44137/tests/dromaeo/cssquery-dojo.html) 11:19:17 INFO - PROCESS | 27614 | RSS: Main: 290492416 11:19:17 INFO - PROCESS | 27614 | 11:19:17 INFO - PROCESS | 27614 | __start_tp_report 11:19:17 INFO - PROCESS | 27614 | _x_x_mozilla_page_load 11:19:17 INFO - PROCESS | 27614 | _x_x_mozilla_page_load_details 11:19:17 INFO - PROCESS | 27614 | |i|pagename|runs| 11:19:17 INFO - PROCESS | 27614 | |0;dojo.html;3184.47456169732;3206.0702396305073;3212.5984251968503;3212.6466088730235;3235.4176248275307;5036.798528058874;5106.029854327684;5138.203578445342;5164.868105515587;5208.166693329073;5082.03441346144;5099.15863882459;5166.199239117934;5195.818146364869;5221.477852214776;4709.693869898463;4729.527047295277;4743.217369134089;4771.069641419925;4834.637402194832;498.1338504497599;4634.165850146972;4680;4681.297805329194;4799.52004799519;4678.368420263255;4718.056388722252;4737.810487580493;4778.976105119487;4798.040391921595;4737.810487580493;4753;4757.9286310705365;4758.666893317469;4794.544518270759;4648.535146485358;4715.363425937523;4717.481077081518;4736.123817093849;4789.760511974388;5041.756418393817;5044.243363495469;5045.974770126162;5087.669301495391;5102.132637451605;5521.199426083235;5540.529055030327;5541.778328866841;5543.639663421905;5551.2228288039705;5431.972840135813;5520.06158952975;5562.666240025612;5610.495055444989;5633;5128.71792051437;5165.896682066337;5176.249443830661;5176.922346164735;5217.47825217479;5571.4428557143965;5597.496225339739;5598.776048957996;5598.804041858597;5600.5799565032785;5311.734413279398;5340.225667278223;5369.087255166631;5392.272043274186;5393.514583687487;5430.185472179205;5496.5053145217125;5496.835094947158;5501.9174712379345;5547.41752116022;5399.406065332811;5413.079776438015;5443.891122177534;5449.3460784706085;5449.972750136224;5412.431694672082;5495.148252020943;5496.560275177976;5500.312460942382;5536.944630553723;4304;4314.41755363022;4322.481302243751;4334.1981733379425;4364.10535840152;3865.7100717446306;3873.767573945572;3877.2051729395407;3894;3909.6872250219913;5056.620753443506;5079.492050794891;5141.76862041209;5149.48505149482;5150.124478838607;5492.286002819608;5522.66863988162;5527.640703354349;5536.723163841792;5551.750171242304;5125.410577783528;5126.410462796826;5130.769115389817;5132.640715149978;5178.430372659004;4666.113438446684;4705.576498115186;4729.125111854318;4753.619710423158;4809.398825146856;5655.179998900218;5672.319321681424;5680.119581464797;5683.204351390808;5691.032524470767;5478.561715062865;5490.752916118864;5509.917351239815;5513.972430137824;5543.722813859372;5537.529310008695;5597.412271711411;5698.1737648041635;5709.429057094258;5757.798477053283;5444.646098003617;5454.563634909118;5459.672419654833;5459.945400546103;5461.208124821958;5471.015217260772;5514.91727624094;5520.61984503874;5526.972365138148;5568.55451563882;5340.412554619066;5410.540104091039;5457.072297709478;5465.316835395575;5496.258005169411;5369.758360873692;5381.973090134681;5387.084195686821;5387.353517577916;5387.865303367447;5204.479552044765;5275.997560463499;5284.969430960926;5294.100002999422;5356.866078348073;5458.344998600193;5474.288342515448;5516.255305533862;5537.307836520435;5545.916811247754;5345.705986170798;5368.194770784414;5375.1131063374105;5379.08555545566;5379.596530260168 11:19:17 INFO - PROCESS | 27614 | |1;ext.html;509.6534356637485;518.4452635679819;523.8847453560215;538.3136500961273;538.8194954690179;28237.858810705944;28663.42673146536;28673.426531469384;28708;35261.823690881574;38786.612133878654;38944.41583376245;39121.608783912154;39171.41242881359;39265.80367098167;8236.752897413073;8390.706325278616;8433.072362040171;8446;8452.28155606771;8338.916610833874;8478.321734261275;8481.491110533358;8482.618282177316;8490.533020683892;8348.290395316406;8610;8639.39524233304;8643.438176518506;8643.611037503297;8530.87203691945;8554.700585479479;8579.785505362353;8583;8598.269147122533;8411.915880841174;8587.52768597727;8588.785280368042;8588.914110858936;8589.828203435896;38710.61289387098;39122.60877391246;39218.60781392178;39235.803820981;39266.80366598177;3314.867405303785;3370.5618269624792;3465.6361082086523;3519.6480351964856;3972.483577134983;28198.577021344696;28218.576721349196;28604;29231.707682923112;29512.26219344512;3259.576255086847;3274.8035117892764;3280.0815771583757;3281.092838774576;3360.630330663625;261281;267468;267870;268085;268199;55352.44647553473;55394.44605553974;56255.718721406134;69264.30735692578;70933.29066709267;67094.32905670881;67786;67914.32085679179;67944;67969;16681.332746690237;16738.66522669564;16895.155242237837;16904;16918.57703557421;10219.18246540275;10536.63121790749;12495;12718.300493472947;12722.491100355883;21283.78716212818;21859.125634974742;21947;22017.22939697103;22032.669509957363;8095.635696393559;8244.587770611446;8445.662173513114;8484.745457636282;8579.699710510227;943.9292053096045;985.1527686189871;1026.9075783179549;1029.8506716526213;1040.7710303733168;28083.859580702374;28331.150065498066;29919.85040074829;30647.69352306493;30719.078427647208;1005.7535903703639;1006.7646650399655;1019.5972590826731;1023.1354505442889;1045.9738506537396;14405.78391324131;16040.919795401182;16273.989311977322;16300;16522.917385412995;395946;399306;399555;401165;401754;52793.73603132037;53220;53282.73358633182;53330.20004699933;53523.19715204275;1305.778017736987;1314.9013823963242;1317.1833463252653;1324.7218084202232;1325.6818363592668;27692.72307276982;28857;29061.12816615505;29580.55629165521;29619;44787.32819007652;45307.54692453033;45313.546864532254;45355.31967020563;45366.77316613396;286255;292765;312201;374617;383110;29605.703942960296;29628.851855741446;29657.70342296636;29696.55455168131;30045.399092018473;38317.23365532618;40728.1854362917;40837.795811020755;41216.587834122474;41413.1717365657;35185.47221791726;35347.11632209215;35401;35496.46755298724;36534.8173259132;33755.831220844724;35477;35610.28779424345;35950.46074308835;36020.09949751277;34626.30747385089;35123;35123.648763512036;35265.47101793424;35319.470207947415;28626.284342891595;31669.208269792518;32010.6798932017;32030.67969320277;32250.838745806122;24493.632595510724;24812.751872481767;25201.74798251994;25833.870830645727;25996.8700156498 11:19:17 INFO - PROCESS | 27614 | |2;jquery.html;362.9582598001231;364.7884227148254;366.9119411341279;368.78426120719377;374.02939372328797;13602.863971360284;13721.3825377858;16096.114713690757;16368.427105051325;17024.91487542562;15044;15362.231888405591;15831.208439578033;15835;15900.52298431046;5272.578193744491;5453.64551304166;5455.099908515091;5455.208994695767;5455.318085239345;3990.541087774914;4105.220008198433;5383.973080134594;5436.91844622331;5774.133879918004;5730.083186690131;5898.380670029649;5962.04607262838;5964.701764911737;5968.850778730544;6066.211392518966;6098.69506524672;6111.083337499366;6112.602680825777;6114.663693496856;5184.055979007872;5328.120860058125;5344.91982620261;5349.716068143656;5387.595930305243;19695;19804.504887377785;19913.701294480594;19928.900355498274;19969.101390437467;2155.95688086239;2171.576542574199;2210.049678638185;2250.74116476604;2347.5891718949115;10445;12346.259224446472;12620.747585048339;13243.668908277274;13320.134191277633;1719.295089013511;1827.2416946966994;1834.523024013766;1844.9446516604523;1879.20133943075;50656;51615.48384516144;51773;51831.48168518304;52002.47997520014;9475.478848663251;9551.283653726;9839.360441571274;9843.310968232297;9899.554520046615;12926.612201633967;12945.54690585825;13000;13003.674908127372;13012.21926684402;7619.961900190464;7649.158592554814;7669.233076692398;7883.36933045355;7915.12933577306;7417.851642967111;7427.888581671279;7460.589667568227;7478.775636730907;7505.849883002309;5991.700414979234;5995.2805663319805;6017.669028203491;6026.939730602638;6059.363766804422;1661.4185035237813;1737.3658614605831;1738.0875040603785;1740.2864825421516;1800.2798880447663;416.73953778888193;419.61185903039564;423.71399305468685;428.3617410059052;910.0626354854511;10695.411752353539;10729.624463143753;10758.78482430347;10779.67660970172;10936.726581835517;438.32935608519017;442.9446319210099;455.94984551699287;459.41195270054385;490.2890808327939;5484.561235101262;5794.971025144847;5899.528037756969;5913.704314784243;5935.436133567304;528489;545201;545956;546893;559333;73945.63027184829;74622.25377746261;74794.25205747981;74896.62551687207;78789.21210787933;495.67780942387736;501.503511523589;502.04360692880124;502.31935727089996;502.70591703852926;9758.316917815684;9899.406035637885;9913.504324783877;9981.950090249502;10015.499225038864;30204.69795302019;30246.84876575603;31219.687803121677;31306.373872521966;31383.68616313899;44275;44562.777186115156;45157;45725.54274457213;48038.759806200746;7072.469564782559;7346.449016323691;7404.259574042768;7417.703291868264;7699.191584883507;7653.409596944187;10590.576376944837;10871.945640271748;10919.890801091888;11152;9180.403273787182;9284.118008789153;9329.486878221764;9567.330286879851;9843.409395436296;9891.159251463707;9902.356346837432;9915.454649994319;10139.138173255356;10283.742906427398;7414.592197429193;9541;9627.422354658744;9849.753756155867;10369.74075648115;7578.808516166444;7716.726740087823;7785.64964576584;7814.609269536614;7831.412644051833;9234.215091717278;9590.568424421057;9618.230541556799;9853.704388868346;9886.25853061009 11:19:17 INFO - PROCESS | 27614 | |3;mootools.html;1282.2050328796147;1427.9500217492387;1434.9784753228703;1573.7954065971421;1731.7315816048508;6830.692618832152;7297.4891757576925;7464.5148065375715;7507.774766756992;7531.887021694679;7358.22738612446;7544.358729507999;7549.35830454412;7557.05536807899;7571.053618297713;2018.3339497965635;2055.5683306505653;2260.785225403584;2305.1586171047575;2331.9067237310487;2182.8581142225703;2183.9454013649706;2192.0355043780687;2192.7368715754133;2193.2762188477764;2247.370736193868;2322.6516022596575;2327.2203811723007;2327.8603283803027;2328.8835558222104;2274.124462082102;2302.1482051640915;2302.5394921015863;2317.6523521471913;2320.338703469503;2287.656851472276;2293.392251053472;2319.895604697793;2320.083566991046;2341.1220792202926;7701.037370328709;7746.767596972043;7758;7761.922380776176;7774.144844067148;4593;4733.40832395947;4766.856994290177;4769.308450274725;4771.165046116916;2900.361920377514;3006.2634654509784;3023.7580993520687;3055.2056465318956;3059.724624783758;903.661127077346;913.2921985461254;913.8218047480744;919.3886065766258;933.7385532051037;10085.193184545293;10173.89826101737;10188.694339169837;10202.183825293958;10214.897851021544;4138.937915931264;4235.830566777295;4261.595148460891;4263.552327005682;4297.441332626739;8452.28155606768;8652.091530389218;8672.176143266379;8678.86981695275;8684;4684.8360307389075;4719.764011799396;4731.597814185833;4737.6683632146105;4738;4380.802863871133;4390.275604525217;4404.361367601679;4426.601605855489;4430.047539778963;3270.264190557153;3349.028781653293;3456.205072833212;3533.1873669056263;3605.4772058051435;1079.438691880218;1086.820674588684;1090.8800031996475;1092.3118435385816;1102.4873433853297;1307.7384523095418;1317.0912070671206;1326.595388406526;1344.731053789246;1347.2926713475504;7316.597587132759;7323.487355885037;7335.4131669466315;7337.449691273069;7357.668904899292;1088.1403691084113;1118.1334465789078;1127.5095333529941;1137.6132115080911;1146.644540192543;5759.510441612426;5817.7091145442555;5825.621334613236;5832.212651292021;5839.9124013139835;8536.445131066585;8702.260307873901;8714.69498567547;8721.869171962426;8809.42738721981;9100.453972761656;9147.954260228656;9207.355485116112;9228.676996305097;9238.86141707875;6958.408535274559;7395.371393431511;7417.147028091838;7425.443091768139;7425.777226683208;7152.392046676091;7208.4593655475;7258.600776957107;7265.527740696838;7274.345308922222;8250.174982501701;8314.542700151549;8405.07544170153;8446;8476.618552165044;8408.327333813158;8568.91431085706;8650.351223658377;8694.130586941255;8750.431221970806;6942.479314051366;7039.401650859734;7041.823954401181;7049.823754406181;7053.753118640823;6634.237062737654;6755.662216889037;7091.751788687371;7321.414286857145;7338.046054012944;6737.562058466184;6853.862922741617;6940.930590694028;6967.54710943787;7010.193827709674;6532.640704761284;6754.324567543403;6758.560693554903;6802.489813264124;6894.724211031503;6880.69036893351;6921.89617155733;6933.2026816916705;6940.722371105099;6942.201646810681;6519.348065193442;6521.282658907611;6545.901811472737;6600.60396376219;6608;6553.115329430657;6619.3380661933425;6646.501512386493;6651.135352404156;6659.600423974577 11:19:17 INFO - PROCESS | 27614 | |4;prototype.html;345.35418766905883;351.06266269061604;352.9347070791903;353.77358490566024;354.5001547817578;5647;5752.482276595106;5783.624064435809;5815.680137592431;5840.53275737941;5585.8603534911645;5717.656940583557;5767.961766881959;5778.0466223073145;5805.970970145143;4491.25894227452;4540.97729511352;4547.749873756942;4552.544745525437;4553.977230113861;4328;4447.866564003085;4461.420015397994;4563.383943167663;4582.808469797843;4492.079123779634;4509.301058335946;4514.751688657123;4522.140793249288;4538.137753826779;4493.820247190141;4507.932381014288;4508.278675411935;4519.028408892071;4525.510968967088;3976.0457490202434;4002.8198731057173;4004.939925901114;4008.6191811778126;4012.117334186474;5408.8377348679605;5548.639338442988;5556.416576259475;5556.583256255797;5569.8607534811545;5252.579793616502;5283.916797056594;5285.762140703678;5290.285811415448;5292;5914.112883067532;6161.7227224775;6210.099535567362;6215.720292586844;6219.813405597839;4357.193919124972;4373.278409062501;4442.933355999663;4452.131834292314;4456.532064133252;6335.3981371769605;6429.132067170919;6440.098386225932;6443.7744678936015;6449.999999999953;4551.954480455153;4563.224251877189;4571.839985600488;4572.474165470947;4573.748443835621;4550.908981820345;4623.260278355514;4633.235516139866;4640.211164102043;4665.6967297125575;5252.711100889412;5259.947400526023;5264.473552644781;5268.209768534751;5277.920831187535;6176.845578860564;6194.5354098442795;6205.937940620536;6209.254889413209;6215.285242197205;1622.732249178896;1643.5069479156443;1643.5973186569367;1644.2929540297548;1649.917504124789;1124.1624989382963;1128.1707944660668;1128.5824245029391;1153.6077733570626;1160.2516376936828;5866.941330586725;5871.911921321183;5872.7357268923;5873.970630146822;5877.118432235199;6354.682265886687;6367.108604795332;6387.297397286295;6434.74261029563;6439.098526206335;5853.473187413153;5862.824115276549;5872.588918775645;5874.94125058744;5889.528837692974;3346.5816772903386;3433.639467855889;3445.3626079175433;3463.688268055887;3466.5146879436898;6652.135222421054;6652.600843949282;6652.634105124264;6655.567388119756;6662.233843108008;6532.771353002717;6570.408663220238;6579.111819904251;6588.143541339595;6592.868142637216;6523.054157147187;6644.8671026579195;6647.534672573067;6647.933520664828;6651.035599837996;6212.254529456494;6324.683765811783;6398.072279519537;6409.230892292955;6415.262244841903;6207.6585787782105;6316.526260530571;6335.4931605472375;6339.904901426575;6349.428551430394;6624.271330153776;6631.1379520662;6636.402723754885;6642.867142657024;6644.767433139817;4408.118376324684;4439.311906654474;4471;4480.61914737251;4483.484399294123;6435.967820160869;6438.227412710505;6441.645709486023;6443.935560644333;6446.387593178641;6266.060090986389;6266.467350275096;6277.466415354746;6281.057841323838;6281.842953926189;6141.938580614136;6194.659293738888;6245.937540624535;6246.344133865879;6246.3441338660605;6157.599756016024;6158.414950579688;6159.29168145669;6160.691965401622;6163.075538669235;6287.528435367457;6291.370862913672;6293.559450838397;6293.937060629518;6296.37036296385;6038.818835434944;6094.54290928191;6120.234970628671;6149.477294430024;6154.292256390572 11:19:17 INFO - PROCESS | 27614 | |5;yui.html;754.5133388964118;801.1867954026662;828.6354004238136;831.2975535672355;837.8701301298297;13415.128016678922;13670.316484175788;13687.3156342183;13688.452461901512;13698.863011369884;12756.425960831762;12831.230126192411;12833.486660533568;12844.743105137892;12857.5499857505;647.8218489915264;663;767.1293082351543;771.4484143837155;771.5255118102355;776.5612428977638;785.7289235213842;792.3977776889548;792.9841403171934;793.4406243598249;826.5082276045744;833.0336809301211;833.0420016980461;833.2042899031441;833.4124442268217;682.0723815610766;690.4372936057123;816.1226681317607;827.8758186272047;828.7555171224503;603.8943184942617;608.8234412020553;608.8508315462695;609.3784339973247;610.2524407600698;12258.26450412978;12417.62747117588;12437.191582547195;12452.31512266825;12460.12779105463;12470;12866.228026318451;12946.48214071436;13072.607821765267;13162.473501059947;10471.16230701542;10619.78760424795;10785.191110666732;10930.945345273301;11007.339559626367;3620.6009698216794;3689.594144644087;3705.0366904604725;3731.328360895038;3736.028632555528;43931.34102988458;44223.33664995027;44262.778686106685;44643.33035004477;44672.553274467165;9643.566039528238;9962.302638815358;10023.749406264757;10131.898681013243;10413.16694664425;17462.650746985244;17480.12599370052;17507.29970801154;17530.29878804859;17546.736798948026;7385.076865391826;7478.102627684604;7565.659545320474;7588.886166707503;7662.693492260359;4167.291560434734;4242.257604919127;4259.531451540328;4280.614744672995;4285.314349704033;2999.4151140527388;3024.7277745003057;3027.7577793776445;3035.1653295343517;3038.9544156837665;541.5613353183934;549.4889752530105;550.6008144095579;552.5275889114829;574.1789241384777;515.2837555797445;566.6656672563125;676.3878689785752;689.7137687859582;712.5724565260803;8836.116388361112;8870.778230544289;8951.239144672645;8965.731028069169;8973.641054357882;595.5271058968069;604.3774911840811;658.6772481484134;683.1290105115918;706.5760543673755;4176.765430494732;4186.455760751083;4193.454850869368;4275.144971005749;4356.956430435718;53027.20459193038;53095.07977061222;53341;53567.73216133972;53835.19247211295;47459.52540474551;48430;49267;49447.75276123668;49480.25779613309;42554.78722606367;44678.32982505265;45876.77061614671;45900.540994589624;46869;8606.956965215133;8715.694950676696;9059.728208153765;9105.726828195166;9226;33632;33707;33772.324553508304;34431.655683443845;34757.30485390328;41322.173556529306;41800.79099604482;42056;42307.36538951856;43135;10818.080463160719;10933.671989840317;11289.266197697123;11306.152038596974;12037.699057523632;12462.252264864137;12620.43208055658;12622.495100195889;12776.169548979287;12791.552295669979;11919.76160476803;11955.64133076009;12085.697857553632;12102.576409825613;12593.244405335709;11405.885941140483;11949.820752688891;11990.220635658654;12023.22055537826;12363.62909112728;11435.885641143483;11825.46785394642;11925.880741192477;11926.284422934652;12314.199577027464;9573.18627916607;9789.78711176512;9977;9981.301308908307;10022.699319020441;9607;9623.951880240555;9826.65606703762;9919.702408927744;10033.648822291476 11:19:17 INFO - PROCESS | 27614 | __end_tp_report 11:19:17 INFO - PROCESS | 27614 | __start_cc_report 11:19:17 INFO - PROCESS | 27614 | _x_x_mozilla_cycle_collect,720 11:19:17 INFO - PROCESS | 27614 | __end_cc_report 11:19:17 INFO - PROCESS | 27614 | __startTimestamp1452712757203__endTimestamp 11:19:17 INFO - PROCESS | 27614 | 11:19:17 INFO - PROCESS | 27614 | ------- Summary: start ------- 11:19:17 INFO - PROCESS | 27614 | Number of tests: 6 11:19:17 INFO - PROCESS | 27614 | 11:19:17 INFO - PROCESS | 27614 | [#0] dojo.html Cycles:165 Average:5107.67 Median:5345.71 stddev:643.71 (12.0%) stddev-sans-first:627.75 11:19:17 INFO - PROCESS | 27614 | Values: 3184.5 3206.1 3212.6 3212.6 3235.4 5036.8 5106.0 5138.2 5164.9 5208.2 5082.0 5099.2 5166.2 5195.8 5221.5 4709.7 4729.5 4743.2 4771.1 4834.6 498.1 4634.2 4680.0 4681.3 4799.5 4678.4 4718.1 4737.8 4779.0 4798.0 4737.8 4753.0 4757.9 4758.7 4794.5 4648.5 4715.4 4717.5 4736.1 4789.8 5041.8 5044.2 5046.0 5087.7 5102.1 5521.2 5540.5 5541.8 5543.6 5551.2 5432.0 5520.1 5562.7 5610.5 5633.0 5128.7 5165.9 5176.2 5176.9 5217.5 5571.4 5597.5 5598.8 5598.8 5600.6 5311.7 5340.2 5369.1 5392.3 5393.5 5430.2 5496.5 5496.8 5501.9 5547.4 5399.4 5413.1 5443.9 5449.3 5450.0 5412.4 5495.1 5496.6 5500.3 5536.9 4304.0 4314.4 4322.5 4334.2 4364.1 3865.7 3873.8 3877.2 3894.0 3909.7 5056.6 5079.5 5141.8 5149.5 5150.1 5492.3 5522.7 5527.6 5536.7 5551.8 5125.4 5126.4 5130.8 5132.6 5178.4 4666.1 4705.6 4729.1 4753.6 4809.4 5655.2 5672.3 5680.1 5683.2 5691.0 5478.6 5490.8 5509.9 5514.0 5543.7 5537.5 5597.4 5698.2 5709.4 5757.8 5444.6 5454.6 5459.7 5459.9 5461.2 5471.0 5514.9 5520.6 5527.0 5568.6 5340.4 5410.5 5457.1 5465.3 5496.3 5369.8 5382.0 5387.1 5387.4 5387.9 5204.5 5276.0 5285.0 5294.1 5356.9 5458.3 5474.3 5516.3 5537.3 5545.9 5345.7 5368.2 5375.1 5379.1 5379.6 11:19:17 INFO - PROCESS | 27614 | 11:19:17 INFO - PROCESS | 27614 | [#1] ext.html Cycles:180 Average:49434.88 Median:35292.47 stddev:88828.74 (251.7%) stddev-sans-first:89001.98 11:19:17 INFO - PROCESS | 27614 | Values: 509.7 518.4 523.9 538.3 538.8 28237.9 28663.4 28673.4 28708.0 35261.8 38786.6 38944.4 39121.6 39171.4 39265.8 8236.8 8390.7 8433.1 8446.0 8452.3 8338.9 8478.3 8481.5 8482.6 8490.5 8348.3 8610.0 8639.4 8643.4 8643.6 8530.9 8554.7 8579.8 8583.0 8598.3 8411.9 8587.5 8588.8 8588.9 8589.8 38710.6 39122.6 39218.6 39235.8 39266.8 3314.9 3370.6 3465.6 3519.6 3972.5 28198.6 28218.6 28604.0 29231.7 29512.3 3259.6 3274.8 3280.1 3281.1 3360.6 261281.0 267468.0 267870.0 268085.0 268199.0 55352.4 55394.4 56255.7 69264.3 70933.3 67094.3 67786.0 67914.3 67944.0 67969.0 16681.3 16738.7 16895.2 16904.0 16918.6 10219.2 10536.6 12495.0 12718.3 12722.5 21283.8 21859.1 21947.0 22017.2 22032.7 8095.6 8244.6 8445.7 8484.7 8579.7 943.9 985.2 1026.9 1029.9 1040.8 28083.9 28331.2 29919.9 30647.7 30719.1 1005.8 1006.8 1019.6 1023.1 1046.0 14405.8 16040.9 16274.0 16300.0 16522.9 395946.0 399306.0 399555.0 401165.0 401754.0 52793.7 53220.0 53282.7 53330.2 53523.2 1305.8 1314.9 1317.2 1324.7 1325.7 27692.7 28857.0 29061.1 29580.6 29619.0 44787.3 45307.5 45313.5 45355.3 45366.8 286255.0 292765.0 312201.0 374617.0 383110.0 29605.7 29628.9 29657.7 29696.6 30045.4 38317.2 40728.2 40837.8 41216.6 41413.2 35185.5 35347.1 35401.0 35496.5 36534.8 33755.8 35477.0 35610.3 35950.5 36020.1 34626.3 35123.0 35123.6 35265.5 35319.5 28626.3 31669.2 32010.7 32030.7 32250.8 24493.6 24812.8 25201.7 25833.9 25996.9 11:19:17 INFO - PROCESS | 27614 | 11:19:17 INFO - PROCESS | 27614 | [#2] jquery.html Cycles:180 Average:27260.18 Median:266880.79 stddev:89128.68 (33.4%) stddev-sans-first:89355.82 11:19:17 INFO - PROCESS | 27614 | Values: 363.0 364.8 366.9 368.8 374.0 13602.9 13721.4 16096.1 16368.4 17024.9 15044.0 15362.2 15831.2 15835.0 15900.5 5272.6 5453.6 5455.1 5455.2 5455.3 3990.5 4105.2 5384.0 5436.9 5774.1 5730.1 5898.4 5962.0 5964.7 5968.9 6066.2 6098.7 6111.1 6112.6 6114.7 5184.1 5328.1 5344.9 5349.7 5387.6 19695.0 19804.5 19913.7 19928.9 19969.1 2156.0 2171.6 2210.0 2250.7 2347.6 10445.0 12346.3 12620.7 13243.7 13320.1 1719.3 1827.2 1834.5 1844.9 1879.2 50656.0 51615.5 51773.0 51831.5 52002.5 9475.5 9551.3 9839.4 9843.3 9899.6 12926.6 12945.5 13000.0 13003.7 13012.2 7620.0 7649.2 7669.2 7883.4 7915.1 7417.9 7427.9 7460.6 7478.8 7505.8 5991.7 5995.3 6017.7 6026.9 6059.4 1661.4 1737.4 1738.1 1740.3 1800.3 416.7 419.6 423.7 428.4 910.1 10695.4 10729.6 10758.8 10779.7 10936.7 438.3 442.9 455.9 459.4 490.3 5484.6 5795.0 5899.5 5913.7 5935.4 528489.0 545201.0 545956.0 546893.0 559333.0 73945.6 74622.3 74794.3 74896.6 78789.2 495.7 501.5 502.0 502.3 502.7 9758.3 9899.4 9913.5 9982.0 10015.5 30204.7 30246.8 31219.7 31306.4 31383.7 44275.0 44562.8 45157.0 45725.5 48038.8 7072.5 7346.4 7404.3 7417.7 7699.2 7653.4 10590.6 10871.9 10919.9 11152.0 9180.4 9284.1 9329.5 9567.3 9843.4 9891.2 9902.4 9915.5 10139.1 10283.7 7414.6 9541.0 9627.4 9849.8 10369.7 7578.8 7716.7 7785.6 7814.6 7831.4 9234.2 9590.6 9618.2 9853.7 9886.3 11:19:17 INFO - PROCESS | 27614 | 11:19:17 INFO - PROCESS | 27614 | [#3] mootools.html Cycles:180 Average:5377.53 Median:6604.30 stddev:2736.03 (41.4%) stddev-sans-first:2726.39 11:19:17 INFO - PROCESS | 27614 | Values: 1282.2 1428.0 1435.0 1573.8 1731.7 6830.7 7297.5 7464.5 7507.8 7531.9 7358.2 7544.4 7549.4 7557.1 7571.1 2018.3 2055.6 2260.8 2305.2 2331.9 2182.9 2183.9 2192.0 2192.7 2193.3 2247.4 2322.7 2327.2 2327.9 2328.9 2274.1 2302.1 2302.5 2317.7 2320.3 2287.7 2293.4 2319.9 2320.1 2341.1 7701.0 7746.8 7758.0 7761.9 7774.1 4593.0 4733.4 4766.9 4769.3 4771.2 2900.4 3006.3 3023.8 3055.2 3059.7 903.7 913.3 913.8 919.4 933.7 10085.2 10173.9 10188.7 10202.2 10214.9 4138.9 4235.8 4261.6 4263.6 4297.4 8452.3 8652.1 8672.2 8678.9 8684.0 4684.8 4719.8 4731.6 4737.7 4738.0 4380.8 4390.3 4404.4 4426.6 4430.0 3270.3 3349.0 3456.2 3533.2 3605.5 1079.4 1086.8 1090.9 1092.3 1102.5 1307.7 1317.1 1326.6 1344.7 1347.3 7316.6 7323.5 7335.4 7337.4 7357.7 1088.1 1118.1 1127.5 1137.6 1146.6 5759.5 5817.7 5825.6 5832.2 5839.9 8536.4 8702.3 8714.7 8721.9 8809.4 9100.5 9148.0 9207.4 9228.7 9238.9 6958.4 7395.4 7417.1 7425.4 7425.8 7152.4 7208.5 7258.6 7265.5 7274.3 8250.2 8314.5 8405.1 8446.0 8476.6 8408.3 8568.9 8650.4 8694.1 8750.4 6942.5 7039.4 7041.8 7049.8 7053.8 6634.2 6755.7 7091.8 7321.4 7338.0 6737.6 6853.9 6940.9 6967.5 7010.2 6532.6 6754.3 6758.6 6802.5 6894.7 6880.7 6921.9 6933.2 6940.7 6942.2 6519.3 6521.3 6545.9 6600.6 6608.0 6553.1 6619.3 6646.5 6651.1 6659.6 11:19:17 INFO - PROCESS | 27614 | 11:19:17 INFO - PROCESS | 27614 | [#4] prototype.html Cycles:180 Average:5216.26 Median:5858.15 stddev:1539.51 (26.3%) stddev-sans-first:1499.79 11:19:17 INFO - PROCESS | 27614 | Values: 345.4 351.1 352.9 353.8 354.5 5647.0 5752.5 5783.6 5815.7 5840.5 5585.9 5717.7 5768.0 5778.0 5806.0 4491.3 4541.0 4547.7 4552.5 4554.0 4328.0 4447.9 4461.4 4563.4 4582.8 4492.1 4509.3 4514.8 4522.1 4538.1 4493.8 4507.9 4508.3 4519.0 4525.5 3976.0 4002.8 4004.9 4008.6 4012.1 5408.8 5548.6 5556.4 5556.6 5569.9 5252.6 5283.9 5285.8 5290.3 5292.0 5914.1 6161.7 6210.1 6215.7 6219.8 4357.2 4373.3 4442.9 4452.1 4456.5 6335.4 6429.1 6440.1 6443.8 6450.0 4552.0 4563.2 4571.8 4572.5 4573.7 4550.9 4623.3 4633.2 4640.2 4665.7 5252.7 5259.9 5264.5 5268.2 5277.9 6176.8 6194.5 6205.9 6209.3 6215.3 1622.7 1643.5 1643.6 1644.3 1649.9 1124.2 1128.2 1128.6 1153.6 1160.3 5866.9 5871.9 5872.7 5874.0 5877.1 6354.7 6367.1 6387.3 6434.7 6439.1 5853.5 5862.8 5872.6 5874.9 5889.5 3346.6 3433.6 3445.4 3463.7 3466.5 6652.1 6652.6 6652.6 6655.6 6662.2 6532.8 6570.4 6579.1 6588.1 6592.9 6523.1 6644.9 6647.5 6647.9 6651.0 6212.3 6324.7 6398.1 6409.2 6415.3 6207.7 6316.5 6335.5 6339.9 6349.4 6624.3 6631.1 6636.4 6642.9 6644.8 4408.1 4439.3 4471.0 4480.6 4483.5 6436.0 6438.2 6441.6 6443.9 6446.4 6266.1 6266.5 6277.5 6281.1 6281.8 6141.9 6194.7 6245.9 6246.3 6246.3 6157.6 6158.4 6159.3 6160.7 6163.1 6287.5 6291.4 6293.6 6293.9 6296.4 6038.8 6094.5 6120.2 6149.5 6154.3 11:19:17 INFO - PROCESS | 27614 | 11:19:17 INFO - PROCESS | 27614 | [#5] yui.html Cycles:180 Average:13458.45 Median:24144.15 stddev:14988.61 (62.1%) stddev-sans-first:15000.30 11:19:17 INFO - PROCESS | 27614 | Values: 754.5 801.2 828.6 831.3 837.9 13415.1 13670.3 13687.3 13688.5 13698.9 12756.4 12831.2 12833.5 12844.7 12857.5 647.8 663.0 767.1 771.4 771.5 776.6 785.7 792.4 793.0 793.4 826.5 833.0 833.0 833.2 833.4 682.1 690.4 816.1 827.9 828.8 603.9 608.8 608.9 609.4 610.3 12258.3 12417.6 12437.2 12452.3 12460.1 12470.0 12866.2 12946.5 13072.6 13162.5 10471.2 10619.8 10785.2 10930.9 11007.3 3620.6 3689.6 3705.0 3731.3 3736.0 43931.3 44223.3 44262.8 44643.3 44672.6 9643.6 9962.3 10023.7 10131.9 10413.2 17462.7 17480.1 17507.3 17530.3 17546.7 7385.1 7478.1 7565.7 7588.9 7662.7 4167.3 4242.3 4259.5 4280.6 4285.3 2999.4 3024.7 3027.8 3035.2 3039.0 541.6 549.5 550.6 552.5 574.2 515.3 566.7 676.4 689.7 712.6 8836.1 8870.8 8951.2 8965.7 8973.6 595.5 604.4 658.7 683.1 706.6 4176.8 4186.5 4193.5 4275.1 4357.0 53027.2 53095.1 53341.0 53567.7 53835.2 47459.5 48430.0 49267.0 49447.8 49480.3 42554.8 44678.3 45876.8 45900.5 46869.0 8607.0 8715.7 9059.7 9105.7 9226.0 33632.0 33707.0 33772.3 34431.7 34757.3 41322.2 41800.8 42056.0 42307.4 43135.0 10818.1 10933.7 11289.3 11306.2 12037.7 12462.3 12620.4 12622.5 12776.2 12791.6 11919.8 11955.6 12085.7 12102.6 12593.2 11405.9 11949.8 11990.2 12023.2 12363.6 11435.9 11825.5 11925.9 11926.3 12314.2 9573.2 9789.8 9977.0 9981.3 10022.7 9607.0 9624.0 9826.7 9919.7 10033.6 11:19:17 INFO - PROCESS | 27614 | -------- Summary: end -------- 11:19:17 INFO - PROCESS | 27614 | 11:19:17 INFO - TEST-INFO | 27614: exit 0 11:19:17 INFO - TEST-OK | dromaeo_css | took 1111274ms 11:19:17 INFO - TEST-START | kraken 11:19:17 INFO - operating with platform_type : linux_ 11:19:17 INFO - Initialising browser for kraken test... 11:19:17 INFO - TEST-INFO | started process 27806 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgY9cK5/profile http://localhost:44137/getInfo.html) 11:19:21 INFO - PROCESS | 27806 | __metrics Screen width/height:1600/1200 11:19:21 INFO - PROCESS | 27806 | colorDepth:24 11:19:21 INFO - PROCESS | 27806 | Browser inner width/height: 1024/697 11:19:21 INFO - PROCESS | 27806 | __metrics 11:19:21 INFO - PROCESS | 27806 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:19:21 INFO - PROCESS | 27806 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:19:22 INFO - TEST-INFO | 27806: exit 0 11:19:22 INFO - Browser initialized. 11:19:22 INFO - Running cycle 1/1 for kraken test... 11:19:22 INFO - TEST-INFO | started process 27890 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgY9cK5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:34 INFO - PROCESS | 27890 | RSS: Main: 150327296 11:19:34 INFO - PROCESS | 27890 | 11:19:36 INFO - PROCESS | 27890 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44137/tests/kraken/driver.html?testName=audio-beat-detection) 11:19:37 INFO - PROCESS | 27890 | RSS: Main: 188841984 11:19:37 INFO - PROCESS | 27890 | 11:19:40 INFO - PROCESS | 27890 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44137/tests/kraken/driver.html?testName=audio-dft) 11:19:40 INFO - PROCESS | 27890 | RSS: Main: 177938432 11:19:40 INFO - PROCESS | 27890 | 11:19:43 INFO - PROCESS | 27890 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44137/tests/kraken/driver.html?testName=audio-fft) 11:19:44 INFO - PROCESS | 27890 | RSS: Main: 162607104 11:19:44 INFO - PROCESS | 27890 | 11:19:46 INFO - PROCESS | 27890 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44137/tests/kraken/driver.html?testName=audio-oscillator) 11:19:46 INFO - PROCESS | 27890 | RSS: Main: 163164160 11:19:46 INFO - PROCESS | 27890 | 11:19:48 INFO - PROCESS | 27890 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44137/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:19:49 INFO - PROCESS | 27890 | RSS: Main: 165040128 11:19:49 INFO - PROCESS | 27890 | 11:19:52 INFO - PROCESS | 27890 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44137/tests/kraken/driver.html?testName=imaging-darkroom) 11:19:52 INFO - PROCESS | 27890 | RSS: Main: 166699008 11:19:52 INFO - PROCESS | 27890 | 11:19:56 INFO - PROCESS | 27890 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44137/tests/kraken/driver.html?testName=imaging-desaturate) 11:19:56 INFO - PROCESS | 27890 | RSS: Main: 166383616 11:19:56 INFO - PROCESS | 27890 | 11:19:59 INFO - PROCESS | 27890 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44137/tests/kraken/driver.html?testName=json-parse-financial) 11:20:00 INFO - PROCESS | 27890 | RSS: Main: 167243776 11:20:00 INFO - PROCESS | 27890 | 11:20:01 INFO - PROCESS | 27890 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44137/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:20:02 INFO - PROCESS | 27890 | RSS: Main: 178888704 11:20:02 INFO - PROCESS | 27890 | 11:20:04 INFO - PROCESS | 27890 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:20:04 INFO - PROCESS | 27890 | RSS: Main: 177487872 11:20:04 INFO - PROCESS | 27890 | 11:20:06 INFO - PROCESS | 27890 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:20:07 INFO - PROCESS | 27890 | RSS: Main: 186384384 11:20:07 INFO - PROCESS | 27890 | 11:20:09 INFO - PROCESS | 27890 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:20:10 INFO - PROCESS | 27890 | RSS: Main: 193236992 11:20:10 INFO - PROCESS | 27890 | 11:20:12 INFO - PROCESS | 27890 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:20:13 INFO - PROCESS | 27890 | RSS: Main: 190758912 11:20:13 INFO - PROCESS | 27890 | 11:20:15 INFO - PROCESS | 27890 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44137/tests/kraken/driver.html?testName=ai-astar) 11:20:15 INFO - PROCESS | 27890 | RSS: Main: 248832000 11:20:15 INFO - PROCESS | 27890 | 11:20:15 INFO - PROCESS | 27890 | __start_tp_report 11:20:15 INFO - PROCESS | 27890 | _x_x_mozilla_page_load 11:20:15 INFO - PROCESS | 27890 | _x_x_mozilla_page_load_details 11:20:15 INFO - PROCESS | 27890 | |i|pagename|runs| 11:20:15 INFO - PROCESS | 27890 | |0;ai-astar;110;110;105;109;111;111;106;110;109;109 11:20:15 INFO - PROCESS | 27890 | |1;audio-beat-detection;153;124;147;161;127;153;145;135;170;127 11:20:15 INFO - PROCESS | 27890 | |2;audio-dft;162;160;161;161;160;160;162;161;161;160 11:20:15 INFO - PROCESS | 27890 | |3;audio-fft;73;71;101;92;73;70;72;109;91;72 11:20:15 INFO - PROCESS | 27890 | |4;audio-oscillator;100;96;140;96;96;96;146;96;97;144 11:20:15 INFO - PROCESS | 27890 | |5;imaging-gaussian-blur;109;109;109;110;109;109;109;109;109;109 11:20:15 INFO - PROCESS | 27890 | |6;imaging-darkroom;146;145;145;145;145;147;145;145;145;146 11:20:15 INFO - PROCESS | 27890 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;96;95 11:20:15 INFO - PROCESS | 27890 | |8;json-parse-financial;55;56;56;54;57;57;54;63;53;54 11:20:15 INFO - PROCESS | 27890 | |9;json-stringify-tinderbox;67;68;67;67;68;68;68;68;67;69 11:20:15 INFO - PROCESS | 27890 | |10;stanford-crypto-aes;83;81;83;83;83;82;82;82;83;90 11:20:15 INFO - PROCESS | 27890 | |11;stanford-crypto-ccm;115;120;114;119;114;120;122;113;122;114 11:20:15 INFO - PROCESS | 27890 | |12;stanford-crypto-pbkdf2;147;137;148;133;142;144;141;140;145;135 11:20:15 INFO - PROCESS | 27890 | |13;stanford-crypto-sha256-iterative;67;67;68;66;70;65;66;66;65;69 11:20:15 INFO - PROCESS | 27890 | __end_tp_report 11:20:15 INFO - PROCESS | 27890 | __start_cc_report 11:20:15 INFO - PROCESS | 27890 | _x_x_mozilla_cycle_collect,968 11:20:15 INFO - PROCESS | 27890 | __end_cc_report 11:20:15 INFO - PROCESS | 27890 | __startTimestamp1452712815257__endTimestamp 11:20:15 INFO - PROCESS | 27890 | 11:20:15 INFO - PROCESS | 27890 | ------- Summary: start ------- 11:20:15 INFO - PROCESS | 27890 | Number of tests: 14 11:20:15 INFO - PROCESS | 27890 | 11:20:15 INFO - PROCESS | 27890 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:2.00 (1.8%) stddev-sans-first:2.09 11:20:15 INFO - PROCESS | 27890 | Values: 110.0 110.0 105.0 109.0 111.0 111.0 106.0 110.0 109.0 109.0 11:20:15 INFO - PROCESS | 27890 | 11:20:15 INFO - PROCESS | 27890 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:150.00 stddev:15.62 (10.4%) stddev-sans-first:16.24 11:20:15 INFO - PROCESS | 27890 | Values: 153.0 124.0 147.0 161.0 127.0 153.0 145.0 135.0 170.0 127.0 11:20:15 INFO - PROCESS | 27890 | 11:20:15 INFO - PROCESS | 27890 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 11:20:15 INFO - PROCESS | 27890 | Values: 162.0 160.0 161.0 161.0 160.0 160.0 162.0 161.0 161.0 160.0 11:20:15 INFO - PROCESS | 27890 | 11:20:15 INFO - PROCESS | 27890 | [#3] audio-fft Cycles:10 Average:82.40 Median:72.50 stddev:14.52 (20.0%) stddev-sans-first:14.99 11:20:15 INFO - PROCESS | 27890 | Values: 73.0 71.0 101.0 92.0 73.0 70.0 72.0 109.0 91.0 72.0 11:20:15 INFO - PROCESS | 27890 | 11:20:15 INFO - PROCESS | 27890 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:96.00 stddev:22.60 (23.5%) stddev-sans-first:23.63 11:20:15 INFO - PROCESS | 27890 | Values: 100.0 96.0 140.0 96.0 96.0 96.0 146.0 96.0 97.0 144.0 11:20:15 INFO - PROCESS | 27890 | 11:20:15 INFO - PROCESS | 27890 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:20:15 INFO - PROCESS | 27890 | Values: 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 11:20:15 INFO - PROCESS | 27890 | 11:20:15 INFO - PROCESS | 27890 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 11:20:15 INFO - PROCESS | 27890 | Values: 146.0 145.0 145.0 145.0 145.0 147.0 145.0 145.0 145.0 146.0 11:20:15 INFO - PROCESS | 27890 | 11:20:15 INFO - PROCESS | 27890 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:20:15 INFO - PROCESS | 27890 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 11:20:15 INFO - PROCESS | 27890 | 11:20:15 INFO - PROCESS | 27890 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:2.85 (5.1%) stddev-sans-first:3.00 11:20:15 INFO - PROCESS | 27890 | Values: 55.0 56.0 56.0 54.0 57.0 57.0 54.0 63.0 53.0 54.0 11:20:15 INFO - PROCESS | 27890 | 11:20:15 INFO - PROCESS | 27890 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 11:20:15 INFO - PROCESS | 27890 | Values: 67.0 68.0 67.0 67.0 68.0 68.0 68.0 68.0 67.0 69.0 11:20:15 INFO - PROCESS | 27890 | 11:20:15 INFO - PROCESS | 27890 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:2.49 (3.0%) stddev-sans-first:2.64 11:20:15 INFO - PROCESS | 27890 | Values: 83.0 81.0 83.0 83.0 83.0 82.0 82.0 82.0 83.0 90.0 11:20:15 INFO - PROCESS | 27890 | 11:20:15 INFO - PROCESS | 27890 | [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:119.50 stddev:3.62 (3.0%) stddev-sans-first:3.75 11:20:15 INFO - PROCESS | 27890 | Values: 115.0 120.0 114.0 119.0 114.0 120.0 122.0 113.0 122.0 114.0 11:20:15 INFO - PROCESS | 27890 | 11:20:15 INFO - PROCESS | 27890 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.20 Median:143.00 stddev:5.03 (3.5%) stddev-sans-first:4.88 11:20:15 INFO - PROCESS | 27890 | Values: 147.0 137.0 148.0 133.0 142.0 144.0 141.0 140.0 145.0 135.0 11:20:15 INFO - PROCESS | 27890 | 11:20:15 INFO - PROCESS | 27890 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.66 (2.5%) stddev-sans-first:1.76 11:20:15 INFO - PROCESS | 27890 | Values: 67.0 67.0 68.0 66.0 70.0 65.0 66.0 66.0 65.0 69.0 11:20:15 INFO - PROCESS | 27890 | -------- Summary: end -------- 11:20:15 INFO - PROCESS | 27890 | 11:20:16 INFO - TEST-INFO | 27890: exit 0 11:20:16 INFO - TEST-OK | kraken | took 58314ms 11:20:16 INFO - TEST-START | v8_7 11:20:16 INFO - operating with platform_type : linux_ 11:20:16 INFO - Initialising browser for v8_7 test... 11:20:16 INFO - TEST-INFO | started process 28141 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpG2LvMe/profile http://localhost:44137/getInfo.html) 11:20:20 INFO - PROCESS | 28141 | __metrics Screen width/height:1600/1200 11:20:20 INFO - PROCESS | 28141 | colorDepth:24 11:20:20 INFO - PROCESS | 28141 | Browser inner width/height: 1024/697 11:20:20 INFO - PROCESS | 28141 | __metrics 11:20:20 INFO - PROCESS | 28141 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:20:20 INFO - PROCESS | 28141 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:20:21 INFO - TEST-INFO | 28141: exit 0 11:20:21 INFO - Browser initialized. 11:20:21 INFO - Running cycle 1/1 for v8_7 test... 11:20:21 INFO - TEST-INFO | started process 28225 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpG2LvMe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:20:33 INFO - PROCESS | 28225 | RSS: Main: 150220800 11:20:33 INFO - PROCESS | 28225 | 11:20:55 INFO - PROCESS | 28225 | Cycle 1(1): loaded http://localhost:44137/tests/v8_7/run.html (next: http://localhost:44137/tests/v8_7/run.html) 11:20:55 INFO - PROCESS | 28225 | RSS: Main: 559009792 11:20:55 INFO - PROCESS | 28225 | 11:20:55 INFO - PROCESS | 28225 | __start_tp_report 11:20:55 INFO - PROCESS | 28225 | _x_x_mozilla_page_load 11:20:55 INFO - PROCESS | 28225 | _x_x_mozilla_page_load_details 11:20:55 INFO - PROCESS | 28225 | |i|pagename|runs| 11:20:55 INFO - PROCESS | 28225 | |0;Richards;167.50418760469012 11:20:55 INFO - PROCESS | 28225 | |1;DeltaBlue;188.11136192626034 11:20:55 INFO - PROCESS | 28225 | |2;Encrypt;281.8489289740699 11:20:55 INFO - PROCESS | 28225 | |3;Decrypt;5208.333333333333 11:20:55 INFO - PROCESS | 28225 | |4;RayTrace;1925 11:20:55 INFO - PROCESS | 28225 | |5;Earley;782.4726134585289 11:20:55 INFO - PROCESS | 28225 | |6;Boyer;12011.904761904761 11:20:55 INFO - PROCESS | 28225 | |7;RegExp;42224.489795918365 11:20:55 INFO - PROCESS | 28225 | |8;Splay;592.4170616113744 11:20:55 INFO - PROCESS | 28225 | |9;NavierStokes;4830.917874396136 11:20:55 INFO - PROCESS | 28225 | __end_tp_report 11:20:55 INFO - PROCESS | 28225 | __startTimestamp1452712855669__endTimestamp 11:20:55 INFO - PROCESS | 28225 | 11:20:55 INFO - PROCESS | 28225 | ------- Summary: start ------- 11:20:55 INFO - PROCESS | 28225 | Number of tests: 10 11:20:55 INFO - PROCESS | 28225 | 11:20:55 INFO - PROCESS | 28225 | [#0] Richards Cycles:1 Average:167.50 Median:167.50 stddev:0.00 (0.0%) 11:20:55 INFO - PROCESS | 28225 | Values: 167.5 11:20:55 INFO - PROCESS | 28225 | 11:20:55 INFO - PROCESS | 28225 | [#1] DeltaBlue Cycles:1 Average:188.11 Median:188.11 stddev:0.00 (0.0%) 11:20:55 INFO - PROCESS | 28225 | Values: 188.1 11:20:55 INFO - PROCESS | 28225 | 11:20:55 INFO - PROCESS | 28225 | [#2] Encrypt Cycles:1 Average:281.85 Median:281.85 stddev:0.00 (0.0%) 11:20:55 INFO - PROCESS | 28225 | Values: 281.8 11:20:55 INFO - PROCESS | 28225 | 11:20:55 INFO - PROCESS | 28225 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 11:20:55 INFO - PROCESS | 28225 | Values: 5208.3 11:20:55 INFO - PROCESS | 28225 | 11:20:55 INFO - PROCESS | 28225 | [#4] RayTrace Cycles:1 Average:1925.00 Median:1925.00 stddev:0.00 (0.0%) 11:20:55 INFO - PROCESS | 28225 | Values: 1925.0 11:20:55 INFO - PROCESS | 28225 | 11:20:55 INFO - PROCESS | 28225 | [#5] Earley Cycles:1 Average:782.47 Median:782.47 stddev:0.00 (0.0%) 11:20:55 INFO - PROCESS | 28225 | Values: 782.5 11:20:55 INFO - PROCESS | 28225 | 11:20:55 INFO - PROCESS | 28225 | [#6] Boyer Cycles:1 Average:12011.90 Median:12011.90 stddev:0.00 (0.0%) 11:20:55 INFO - PROCESS | 28225 | Values: 12011.9 11:20:55 INFO - PROCESS | 28225 | 11:20:55 INFO - PROCESS | 28225 | [#7] RegExp Cycles:1 Average:42224.49 Median:42224.49 stddev:0.00 (0.0%) 11:20:55 INFO - PROCESS | 28225 | Values: 42224.5 11:20:55 INFO - PROCESS | 28225 | 11:20:55 INFO - PROCESS | 28225 | [#8] Splay Cycles:1 Average:592.42 Median:592.42 stddev:0.00 (0.0%) 11:20:55 INFO - PROCESS | 28225 | Values: 592.4 11:20:55 INFO - PROCESS | 28225 | 11:20:55 INFO - PROCESS | 28225 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 11:20:55 INFO - PROCESS | 28225 | Values: 4830.9 11:20:55 INFO - PROCESS | 28225 | -------- Summary: end -------- 11:20:55 INFO - PROCESS | 28225 | 11:20:56 INFO - TEST-INFO | 28225: exit 0 11:20:56 INFO - TEST-OK | v8_7 | took 40415ms 11:20:56 INFO - SUITE-END | took 1210s 11:20:56 INFO - Completed test suite (00:20:10) 11:20:56 INFO - Working with test: dromaeo_css 11:20:56 INFO - Generating results file: dromaeo_css 11:20:56 INFO - Working with test: kraken 11:20:56 INFO - Generating results file: kraken 11:20:56 INFO - javascript benchmark 11:20:56 INFO - Working with test: v8_7 11:20:56 INFO - Generating results file: v8_7 11:20:56 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:20:56 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 11:20:56 INFO - process_Request line: dromaeo_css 6723.54 graph.html#tests=[[72,64,35]] 11:20:56 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:20:56 INFO - process_Request line: kraken 1489.00 graph.html#tests=[[232,64,35]] 11:20:56 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:20:56 INFO - process_Request line: v8_7 19034.68 graph.html#tests=[[230,64,35]] 11:20:56 INFO - RETURN: dromaeo_css: 6723.54 11:20:56 INFO - RETURN: kraken: 1489.00 11:20:56 INFO - RETURN: v8_7: 19034.68 11:20:56 INFO - javascript benchmark 11:20:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3184.47456169732, 3206.0702396305073, 3212.5984251968503, 3212.6466088730235, 3235.4176248275307, 5036.798528058874, 5106.029854327684, 5138.203578445342, 5164.868105515587, 5208.166693329073, 5082.03441346144, 5099.15863882459, 5166.199239117934, 5195.818146364869, 5221.477852214776, 4709.693869898463, 4729.527047295277, 4743.217369134089, 4771.069641419925, 4834.637402194832, 498.1338504497599, 4634.165850146972, 4680.0, 4681.297805329194, 4799.52004799519, 4678.368420263255, 4718.056388722252, 4737.810487580493, 4778.976105119487, 4798.040391921595, 4737.810487580493, 4753.0, 4757.9286310705365, 4758.666893317469, 4794.544518270759, 4648.535146485358, 4715.363425937523, 4717.481077081518, 4736.123817093849, 4789.760511974388, 5041.756418393817, 5044.243363495469, 5045.974770126162, 5087.669301495391, 5102.132637451605, 5521.199426083235, 5540.529055030327, 5541.778328866841, 5543.639663421905, 5551.2228288039705, 5431.972840135813, 5520.06158952975, 5562.666240025612, 5610.495055444989, 5633.0, 5128.71792051437, 5165.896682066337, 5176.249443830661, 5176.922346164735, 5217.47825217479, 5571.4428557143965, 5597.496225339739, 5598.776048957996, 5598.804041858597, 5600.5799565032785, 5311.734413279398, 5340.225667278223, 5369.087255166631, 5392.272043274186, 5393.514583687487, 5430.185472179205, 5496.5053145217125, 5496.835094947158, 5501.9174712379345, 5547.41752116022, 5399.406065332811, 5413.079776438015, 5443.891122177534, 5449.3460784706085, 5449.972750136224, 5412.431694672082, 5495.148252020943, 5496.560275177976, 5500.312460942382, 5536.944630553723, 4304.0, 4314.41755363022, 4322.481302243751, 4334.1981733379425, 4364.10535840152, 3865.7100717446306, 3873.767573945572, 3877.2051729395407, 3894.0, 3909.6872250219913, 5056.620753443506, 5079.492050794891, 5141.76862041209, 5149.48505149482, 5150.124478838607, 5492.286002819608, 5522.66863988162, 5527.640703354349, 5536.723163841792, 5551.750171242304, 5125.410577783528, 5126.410462796826, 5130.769115389817, 5132.640715149978, 5178.430372659004, 4666.113438446684, 4705.576498115186, 4729.125111854318, 4753.619710423158, 4809.398825146856, 5655.179998900218, 5672.319321681424, 5680.119581464797, 5683.204351390808, 5691.032524470767, 5478.561715062865, 5490.752916118864, 5509.917351239815, 5513.972430137824, 5543.722813859372, 5537.529310008695, 5597.412271711411, 5698.1737648041635, 5709.429057094258, 5757.798477053283, 5444.646098003617, 5454.563634909118, 5459.672419654833, 5459.945400546103, 5461.208124821958, 5471.015217260772, 5514.91727624094, 5520.61984503874, 5526.972365138148, 5568.55451563882, 5340.412554619066, 5410.540104091039, 5457.072297709478, 5465.316835395575, 5496.258005169411, 5369.758360873692, 5381.973090134681, 5387.084195686821, 5387.353517577916, 5387.865303367447, 5204.479552044765, 5275.997560463499, 5284.969430960926, 5294.100002999422, 5356.866078348073, 5458.344998600193, 5474.288342515448, 5516.255305533862, 5537.307836520435, 5545.916811247754, 5345.705986170798, 5368.194770784414, 5375.1131063374105, 5379.08555545566, 5379.596530260168], "unit": "score", "name": "dojo.html", "value": 5070.643611522478}, {"lowerIsBetter": false, "replicates": [509.6534356637485, 518.4452635679819, 523.8847453560215, 538.3136500961273, 538.8194954690179, 28237.858810705944, 28663.42673146536, 28673.426531469384, 28708.0, 35261.823690881574, 38786.612133878654, 38944.41583376245, 39121.608783912154, 39171.41242881359, 39265.80367098167, 8236.752897413073, 8390.706325278616, 8433.072362040171, 8446.0, 8452.28155606771, 8338.916610833874, 8478.321734261275, 8481.491110533358, 8482.618282177316, 8490.533020683892, 8348.290395316406, 8610.0, 8639.39524233304, 8643.438176518506, 8643.611037503297, 8530.87203691945, 8554.700585479479, 8579.785505362353, 8583.0, 8598.269147122533, 8411.915880841174, 8587.52768597727, 8588.785280368042, 8588.914110858936, 8589.828203435896, 38710.61289387098, 39122.60877391246, 39218.60781392178, 39235.803820981, 39266.80366598177, 3314.867405303785, 3370.5618269624792, 3465.6361082086523, 3519.6480351964856, 3972.483577134983, 28198.577021344696, 28218.576721349196, 28604.0, 29231.707682923112, 29512.26219344512, 3259.576255086847, 3274.8035117892764, 3280.0815771583757, 3281.092838774576, 3360.630330663625, 261281.0, 267468.0, 267870.0, 268085.0, 268199.0, 55352.44647553473, 55394.44605553974, 56255.718721406134, 69264.30735692578, 70933.29066709267, 67094.32905670881, 67786.0, 67914.32085679179, 67944.0, 67969.0, 16681.332746690237, 16738.66522669564, 16895.155242237837, 16904.0, 16918.57703557421, 10219.18246540275, 10536.63121790749, 12495.0, 12718.300493472947, 12722.491100355883, 21283.78716212818, 21859.125634974742, 21947.0, 22017.22939697103, 22032.669509957363, 8095.635696393559, 8244.587770611446, 8445.662173513114, 8484.745457636282, 8579.699710510227, 943.9292053096045, 985.1527686189871, 1026.9075783179549, 1029.8506716526213, 1040.7710303733168, 28083.859580702374, 28331.150065498066, 29919.85040074829, 30647.69352306493, 30719.078427647208, 1005.7535903703639, 1006.7646650399655, 1019.5972590826731, 1023.1354505442889, 1045.9738506537396, 14405.78391324131, 16040.919795401182, 16273.989311977322, 16300.0, 16522.917385412995, 395946.0, 399306.0, 399555.0, 401165.0, 401754.0, 52793.73603132037, 53220.0, 53282.73358633182, 53330.20004699933, 53523.19715204275, 1305.778017736987, 1314.9013823963242, 1317.1833463252653, 1324.7218084202232, 1325.6818363592668, 27692.72307276982, 28857.0, 29061.12816615505, 29580.55629165521, 29619.0, 44787.32819007652, 45307.54692453033, 45313.546864532254, 45355.31967020563, 45366.77316613396, 286255.0, 292765.0, 312201.0, 374617.0, 383110.0, 29605.703942960296, 29628.851855741446, 29657.70342296636, 29696.55455168131, 30045.399092018473, 38317.23365532618, 40728.1854362917, 40837.795811020755, 41216.587834122474, 41413.1717365657, 35185.47221791726, 35347.11632209215, 35401.0, 35496.46755298724, 36534.8173259132, 33755.831220844724, 35477.0, 35610.28779424345, 35950.46074308835, 36020.09949751277, 34626.30747385089, 35123.0, 35123.648763512036, 35265.47101793424, 35319.470207947415, 28626.284342891595, 31669.208269792518, 32010.6798932017, 32030.67969320277, 32250.838745806122, 24493.632595510724, 24812.751872481767, 25201.74798251994, 25833.870830645727, 25996.8700156498], "unit": "score", "name": "ext.html", "value": 18417.53975985611}, {"lowerIsBetter": false, "replicates": [362.9582598001231, 364.7884227148254, 366.9119411341279, 368.78426120719377, 374.02939372328797, 13602.863971360284, 13721.3825377858, 16096.114713690757, 16368.427105051325, 17024.91487542562, 15044.0, 15362.231888405591, 15831.208439578033, 15835.0, 15900.52298431046, 5272.578193744491, 5453.64551304166, 5455.099908515091, 5455.208994695767, 5455.318085239345, 3990.541087774914, 4105.220008198433, 5383.973080134594, 5436.91844622331, 5774.133879918004, 5730.083186690131, 5898.380670029649, 5962.04607262838, 5964.701764911737, 5968.850778730544, 6066.211392518966, 6098.69506524672, 6111.083337499366, 6112.602680825777, 6114.663693496856, 5184.055979007872, 5328.120860058125, 5344.91982620261, 5349.716068143656, 5387.595930305243, 19695.0, 19804.504887377785, 19913.701294480594, 19928.900355498274, 19969.101390437467, 2155.95688086239, 2171.576542574199, 2210.049678638185, 2250.74116476604, 2347.5891718949115, 10445.0, 12346.259224446472, 12620.747585048339, 13243.668908277274, 13320.134191277633, 1719.295089013511, 1827.2416946966994, 1834.523024013766, 1844.9446516604523, 1879.20133943075, 50656.0, 51615.48384516144, 51773.0, 51831.48168518304, 52002.47997520014, 9475.478848663251, 9551.283653726, 9839.360441571274, 9843.310968232297, 9899.554520046615, 12926.612201633967, 12945.54690585825, 13000.0, 13003.674908127372, 13012.21926684402, 7619.961900190464, 7649.158592554814, 7669.233076692398, 7883.36933045355, 7915.12933577306, 7417.851642967111, 7427.888581671279, 7460.589667568227, 7478.775636730907, 7505.849883002309, 5991.700414979234, 5995.2805663319805, 6017.669028203491, 6026.939730602638, 6059.363766804422, 1661.4185035237813, 1737.3658614605831, 1738.0875040603785, 1740.2864825421516, 1800.2798880447663, 416.73953778888193, 419.61185903039564, 423.71399305468685, 428.3617410059052, 910.0626354854511, 10695.411752353539, 10729.624463143753, 10758.78482430347, 10779.67660970172, 10936.726581835517, 438.32935608519017, 442.9446319210099, 455.94984551699287, 459.41195270054385, 490.2890808327939, 5484.561235101262, 5794.971025144847, 5899.528037756969, 5913.704314784243, 5935.436133567304, 528489.0, 545201.0, 545956.0, 546893.0, 559333.0, 73945.63027184829, 74622.25377746261, 74794.25205747981, 74896.62551687207, 78789.21210787933, 495.67780942387736, 501.503511523589, 502.04360692880124, 502.31935727089996, 502.70591703852926, 9758.316917815684, 9899.406035637885, 9913.504324783877, 9981.950090249502, 10015.499225038864, 30204.69795302019, 30246.84876575603, 31219.687803121677, 31306.373872521966, 31383.68616313899, 44275.0, 44562.777186115156, 45157.0, 45725.54274457213, 48038.759806200746, 7072.469564782559, 7346.449016323691, 7404.259574042768, 7417.703291868264, 7699.191584883507, 7653.409596944187, 10590.576376944837, 10871.945640271748, 10919.890801091888, 11152.0, 9180.403273787182, 9284.118008789153, 9329.486878221764, 9567.330286879851, 9843.409395436296, 9891.159251463707, 9902.356346837432, 9915.454649994319, 10139.138173255356, 10283.742906427398, 7414.592197429193, 9541.0, 9627.422354658744, 9849.753756155867, 10369.74075648115, 7578.808516166444, 7716.726740087823, 7785.64964576584, 7814.609269536614, 7831.412644051833, 9234.215091717278, 9590.568424421057, 9618.230541556799, 9853.704388868346, 9886.25853061009], "unit": "score", "name": "jquery.html", "value": 7538.053570679746}, {"lowerIsBetter": false, "replicates": [1282.2050328796147, 1427.9500217492387, 1434.9784753228703, 1573.7954065971421, 1731.7315816048508, 6830.692618832152, 7297.4891757576925, 7464.5148065375715, 7507.774766756992, 7531.887021694679, 7358.22738612446, 7544.358729507999, 7549.35830454412, 7557.05536807899, 7571.053618297713, 2018.3339497965635, 2055.5683306505653, 2260.785225403584, 2305.1586171047575, 2331.9067237310487, 2182.8581142225703, 2183.9454013649706, 2192.0355043780687, 2192.7368715754133, 2193.2762188477764, 2247.370736193868, 2322.6516022596575, 2327.2203811723007, 2327.8603283803027, 2328.8835558222104, 2274.124462082102, 2302.1482051640915, 2302.5394921015863, 2317.6523521471913, 2320.338703469503, 2287.656851472276, 2293.392251053472, 2319.895604697793, 2320.083566991046, 2341.1220792202926, 7701.037370328709, 7746.767596972043, 7758.0, 7761.922380776176, 7774.144844067148, 4593.0, 4733.40832395947, 4766.856994290177, 4769.308450274725, 4771.165046116916, 2900.361920377514, 3006.2634654509784, 3023.7580993520687, 3055.2056465318956, 3059.724624783758, 903.661127077346, 913.2921985461254, 913.8218047480744, 919.3886065766258, 933.7385532051037, 10085.193184545293, 10173.89826101737, 10188.694339169837, 10202.183825293958, 10214.897851021544, 4138.937915931264, 4235.830566777295, 4261.595148460891, 4263.552327005682, 4297.441332626739, 8452.28155606768, 8652.091530389218, 8672.176143266379, 8678.86981695275, 8684.0, 4684.8360307389075, 4719.764011799396, 4731.597814185833, 4737.6683632146105, 4738.0, 4380.802863871133, 4390.275604525217, 4404.361367601679, 4426.601605855489, 4430.047539778963, 3270.264190557153, 3349.028781653293, 3456.205072833212, 3533.1873669056263, 3605.4772058051435, 1079.438691880218, 1086.820674588684, 1090.8800031996475, 1092.3118435385816, 1102.4873433853297, 1307.7384523095418, 1317.0912070671206, 1326.595388406526, 1344.731053789246, 1347.2926713475504, 7316.597587132759, 7323.487355885037, 7335.4131669466315, 7337.449691273069, 7357.668904899292, 1088.1403691084113, 1118.1334465789078, 1127.5095333529941, 1137.6132115080911, 1146.644540192543, 5759.510441612426, 5817.7091145442555, 5825.621334613236, 5832.212651292021, 5839.9124013139835, 8536.445131066585, 8702.260307873901, 8714.69498567547, 8721.869171962426, 8809.42738721981, 9100.453972761656, 9147.954260228656, 9207.355485116112, 9228.676996305097, 9238.86141707875, 6958.408535274559, 7395.371393431511, 7417.147028091838, 7425.443091768139, 7425.777226683208, 7152.392046676091, 7208.4593655475, 7258.600776957107, 7265.527740696838, 7274.345308922222, 8250.174982501701, 8314.542700151549, 8405.07544170153, 8446.0, 8476.618552165044, 8408.327333813158, 8568.91431085706, 8650.351223658377, 8694.130586941255, 8750.431221970806, 6942.479314051366, 7039.401650859734, 7041.823954401181, 7049.823754406181, 7053.753118640823, 6634.237062737654, 6755.662216889037, 7091.751788687371, 7321.414286857145, 7338.046054012944, 6737.562058466184, 6853.862922741617, 6940.930590694028, 6967.54710943787, 7010.193827709674, 6532.640704761284, 6754.324567543403, 6758.560693554903, 6802.489813264124, 6894.724211031503, 6880.69036893351, 6921.89617155733, 6933.2026816916705, 6940.722371105099, 6942.201646810681, 6519.348065193442, 6521.282658907611, 6545.901811472737, 6600.60396376219, 6608.0, 6553.115329430657, 6619.3380661933425, 6646.501512386493, 6651.135352404156, 6659.600423974577], "unit": "score", "name": "mootools.html", "value": 4433.751181280876}, {"lowerIsBetter": false, "replicates": [345.35418766905883, 351.06266269061604, 352.9347070791903, 353.77358490566024, 354.5001547817578, 5647.0, 5752.482276595106, 5783.624064435809, 5815.680137592431, 5840.53275737941, 5585.8603534911645, 5717.656940583557, 5767.961766881959, 5778.0466223073145, 5805.970970145143, 4491.25894227452, 4540.97729511352, 4547.749873756942, 4552.544745525437, 4553.977230113861, 4328.0, 4447.866564003085, 4461.420015397994, 4563.383943167663, 4582.808469797843, 4492.079123779634, 4509.301058335946, 4514.751688657123, 4522.140793249288, 4538.137753826779, 4493.820247190141, 4507.932381014288, 4508.278675411935, 4519.028408892071, 4525.510968967088, 3976.0457490202434, 4002.8198731057173, 4004.939925901114, 4008.6191811778126, 4012.117334186474, 5408.8377348679605, 5548.639338442988, 5556.416576259475, 5556.583256255797, 5569.8607534811545, 5252.579793616502, 5283.916797056594, 5285.762140703678, 5290.285811415448, 5292.0, 5914.112883067532, 6161.7227224775, 6210.099535567362, 6215.720292586844, 6219.813405597839, 4357.193919124972, 4373.278409062501, 4442.933355999663, 4452.131834292314, 4456.532064133252, 6335.3981371769605, 6429.132067170919, 6440.098386225932, 6443.7744678936015, 6449.999999999953, 4551.954480455153, 4563.224251877189, 4571.839985600488, 4572.474165470947, 4573.748443835621, 4550.908981820345, 4623.260278355514, 4633.235516139866, 4640.211164102043, 4665.6967297125575, 5252.711100889412, 5259.947400526023, 5264.473552644781, 5268.209768534751, 5277.920831187535, 6176.845578860564, 6194.5354098442795, 6205.937940620536, 6209.254889413209, 6215.285242197205, 1622.732249178896, 1643.5069479156443, 1643.5973186569367, 1644.2929540297548, 1649.917504124789, 1124.1624989382963, 1128.1707944660668, 1128.5824245029391, 1153.6077733570626, 1160.2516376936828, 5866.941330586725, 5871.911921321183, 5872.7357268923, 5873.970630146822, 5877.118432235199, 6354.682265886687, 6367.108604795332, 6387.297397286295, 6434.74261029563, 6439.098526206335, 5853.473187413153, 5862.824115276549, 5872.588918775645, 5874.94125058744, 5889.528837692974, 3346.5816772903386, 3433.639467855889, 3445.3626079175433, 3463.688268055887, 3466.5146879436898, 6652.135222421054, 6652.600843949282, 6652.634105124264, 6655.567388119756, 6662.233843108008, 6532.771353002717, 6570.408663220238, 6579.111819904251, 6588.143541339595, 6592.868142637216, 6523.054157147187, 6644.8671026579195, 6647.534672573067, 6647.933520664828, 6651.035599837996, 6212.254529456494, 6324.683765811783, 6398.072279519537, 6409.230892292955, 6415.262244841903, 6207.6585787782105, 6316.526260530571, 6335.4931605472375, 6339.904901426575, 6349.428551430394, 6624.271330153776, 6631.1379520662, 6636.402723754885, 6642.867142657024, 6644.767433139817, 4408.118376324684, 4439.311906654474, 4471.0, 4480.61914737251, 4483.484399294123, 6435.967820160869, 6438.227412710505, 6441.645709486023, 6443.935560644333, 6446.387593178641, 6266.060090986389, 6266.467350275096, 6277.466415354746, 6281.057841323838, 6281.842953926189, 6141.938580614136, 6194.659293738888, 6245.937540624535, 6246.344133865879, 6246.3441338660605, 6157.599756016024, 6158.414950579688, 6159.29168145669, 6160.691965401622, 6163.075538669235, 6287.528435367457, 6291.370862913672, 6293.559450838397, 6293.937060629518, 6296.37036296385, 6038.818835434944, 6094.54290928191, 6120.234970628671, 6149.477294430024, 6154.292256390572], "unit": "score", "name": "prototype.html", "value": 4728.686159689039}, {"lowerIsBetter": false, "replicates": [754.5133388964118, 801.1867954026662, 828.6354004238136, 831.2975535672355, 837.8701301298297, 13415.128016678922, 13670.316484175788, 13687.3156342183, 13688.452461901512, 13698.863011369884, 12756.425960831762, 12831.230126192411, 12833.486660533568, 12844.743105137892, 12857.5499857505, 647.8218489915264, 663.0, 767.1293082351543, 771.4484143837155, 771.5255118102355, 776.5612428977638, 785.7289235213842, 792.3977776889548, 792.9841403171934, 793.4406243598249, 826.5082276045744, 833.0336809301211, 833.0420016980461, 833.2042899031441, 833.4124442268217, 682.0723815610766, 690.4372936057123, 816.1226681317607, 827.8758186272047, 828.7555171224503, 603.8943184942617, 608.8234412020553, 608.8508315462695, 609.3784339973247, 610.2524407600698, 12258.26450412978, 12417.62747117588, 12437.191582547195, 12452.31512266825, 12460.12779105463, 12470.0, 12866.228026318451, 12946.48214071436, 13072.607821765267, 13162.473501059947, 10471.16230701542, 10619.78760424795, 10785.191110666732, 10930.945345273301, 11007.339559626367, 3620.6009698216794, 3689.594144644087, 3705.0366904604725, 3731.328360895038, 3736.028632555528, 43931.34102988458, 44223.33664995027, 44262.778686106685, 44643.33035004477, 44672.553274467165, 9643.566039528238, 9962.302638815358, 10023.749406264757, 10131.898681013243, 10413.16694664425, 17462.650746985244, 17480.12599370052, 17507.29970801154, 17530.29878804859, 17546.736798948026, 7385.076865391826, 7478.102627684604, 7565.659545320474, 7588.886166707503, 7662.693492260359, 4167.291560434734, 4242.257604919127, 4259.531451540328, 4280.614744672995, 4285.314349704033, 2999.4151140527388, 3024.7277745003057, 3027.7577793776445, 3035.1653295343517, 3038.9544156837665, 541.5613353183934, 549.4889752530105, 550.6008144095579, 552.5275889114829, 574.1789241384777, 515.2837555797445, 566.6656672563125, 676.3878689785752, 689.7137687859582, 712.5724565260803, 8836.116388361112, 8870.778230544289, 8951.239144672645, 8965.731028069169, 8973.641054357882, 595.5271058968069, 604.3774911840811, 658.6772481484134, 683.1290105115918, 706.5760543673755, 4176.765430494732, 4186.455760751083, 4193.454850869368, 4275.144971005749, 4356.956430435718, 53027.20459193038, 53095.07977061222, 53341.0, 53567.73216133972, 53835.19247211295, 47459.52540474551, 48430.0, 49267.0, 49447.75276123668, 49480.25779613309, 42554.78722606367, 44678.32982505265, 45876.77061614671, 45900.540994589624, 46869.0, 8606.956965215133, 8715.694950676696, 9059.728208153765, 9105.726828195166, 9226.0, 33632.0, 33707.0, 33772.324553508304, 34431.655683443845, 34757.30485390328, 41322.173556529306, 41800.79099604482, 42056.0, 42307.36538951856, 43135.0, 10818.080463160719, 10933.671989840317, 11289.266197697123, 11306.152038596974, 12037.699057523632, 12462.252264864137, 12620.43208055658, 12622.495100195889, 12776.169548979287, 12791.552295669979, 11919.76160476803, 11955.64133076009, 12085.697857553632, 12102.576409825613, 12593.244405335709, 11405.885941140483, 11949.820752688891, 11990.220635658654, 12023.22055537826, 12363.62909112728, 11435.885641143483, 11825.46785394642, 11925.880741192477, 11926.284422934652, 12314.199577027464, 9573.18627916607, 9789.78711176512, 9977.0, 9981.301308908307, 10022.699319020441, 9607.0, 9623.951880240555, 9826.65606703762, 9919.702408927744, 10033.648822291476], "unit": "score", "name": "yui.html", "value": 6258.682595685378}], "name": "dromaeo_css", "value": 6723.537831471727}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 109.0, 111.0, 111.0, 106.0, 110.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [153.0, 124.0, 147.0, 161.0, 127.0, 153.0, 145.0, 135.0, 170.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 144.2}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 161.0, 160.0, 160.0, 162.0, 161.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 101.0, 92.0, 73.0, 70.0, 72.0, 109.0, 91.0, 72.0], "unit": "score", "name": "audio-fft", "value": 82.4}, {"lowerIsBetter": true, "replicates": [100.0, 96.0, 140.0, 96.0, 96.0, 96.0, 146.0, 96.0, 97.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 110.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.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, 145.0, 145.0, 145.0, 147.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 56.0, 54.0, 57.0, 57.0, 54.0, 63.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 83.0, 83.0, 83.0, 82.0, 82.0, 82.0, 83.0, 90.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [115.0, 120.0, 114.0, 119.0, 114.0, 120.0, 122.0, 113.0, 122.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.3}, {"lowerIsBetter": true, "replicates": [147.0, 137.0, 148.0, 133.0, 142.0, 144.0, 141.0, 140.0, 145.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 66.0, 70.0, 65.0, 66.0, 66.0, 65.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1489.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.50418760469012], "unit": "score", "name": "Richards", "value": 210.75293999999994}, {"lowerIsBetter": false, "replicates": [188.11136192626034], "unit": "score", "name": "DeltaBlue", "value": 351.483288}, {"lowerIsBetter": false, "replicates": [281.8489289740699], "unit": "score", "name": "Encrypt", "value": 944.410188}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1925.0], "unit": "score", "name": "RayTrace", "value": 384.40987012987}, {"lowerIsBetter": false, "replicates": [782.4726134585289], "unit": "score", "name": "Earley", "value": 851.7397139999999}, {"lowerIsBetter": false, "replicates": [12011.904761904761], "unit": "score", "name": "Boyer", "value": 55.483540138751295}, {"lowerIsBetter": false, "replicates": [42224.489795918365], "unit": "score", "name": "RegExp", "value": 21.574801836636038}, {"lowerIsBetter": false, "replicates": [592.4170616113744], "unit": "score", "name": "Splay", "value": 137.55680799999996}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19034.67557453288}]} 11:20:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19034.68"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1489.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6723.54"}}} 11:20:56 INFO - Return code: 0 11:20:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:20:56 INFO - # TBPL SUCCESS # 11:20:56 INFO - Running post-action listener: _resource_record_post_action 11:20:56 INFO - Running post-run listener: _resource_record_post_run 11:20:57 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 412266496; Read time: 8; Write time: 395032 11:20:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113119232; Read time: 0; Write time: 112528 11:20:57 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298168320; Read time: 8; Write time: 282488 11:20:57 INFO - Running post-run listener: _upload_blobber_files 11:20:57 INFO - Blob upload gear active. 11:20:57 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:20:57 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:20:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 11:20:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 11:20:58 INFO - (blobuploader) - INFO - Open directory for files ... 11:20:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:20:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:20:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:59 INFO - (blobuploader) - INFO - Done attempting. 11:20:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:20:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:21:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:00 INFO - (blobuploader) - INFO - Done attempting. 11:21:00 INFO - (blobuploader) - INFO - Iteration through files over. 11:21:00 INFO - Return code: 0 11:21:00 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:21:00 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:21:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2ced1328675cdb55aa4d338a0789479d8d75f8f04bf7eeca3d824f9a920d2146dbe67ad24749bbcb3757eab4dcdb634e1b97eecc61597a5ca8e3b4a950195e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c14d1b31ee911adad32262f11a92a394a26a850c3c33dc245a39c8bdfddf5e94eb72b2042fd084bcaf7d46ef6deff73ee79cc15b42fa9ad26791bd513584700"} 11:21:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:21:00 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:21:00 INFO - Contents: 11:21:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2ced1328675cdb55aa4d338a0789479d8d75f8f04bf7eeca3d824f9a920d2146dbe67ad24749bbcb3757eab4dcdb634e1b97eecc61597a5ca8e3b4a950195e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c14d1b31ee911adad32262f11a92a394a26a850c3c33dc245a39c8bdfddf5e94eb72b2042fd084bcaf7d46ef6deff73ee79cc15b42fa9ad26791bd513584700"} 11:21:00 INFO - Copying logs to upload dir... 11:21:00 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1293.648568 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-01-13 11:21:00.119768) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 11:21:00.123481) ========= 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=62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2ced1328675cdb55aa4d338a0789479d8d75f8f04bf7eeca3d824f9a920d2146dbe67ad24749bbcb3757eab4dcdb634e1b97eecc61597a5ca8e3b4a950195e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c14d1b31ee911adad32262f11a92a394a26a850c3c33dc245a39c8bdfddf5e94eb72b2042fd084bcaf7d46ef6deff73ee79cc15b42fa9ad26791bd513584700"} build_url:https://queue.taskcluster.net/v1/task/UwkzWuedQVyk5XAHaNZzPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011384 build_url: 'https://queue.taskcluster.net/v1/task/UwkzWuedQVyk5XAHaNZzPg/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/Fx-Team/sha512/a2ced1328675cdb55aa4d338a0789479d8d75f8f04bf7eeca3d824f9a920d2146dbe67ad24749bbcb3757eab4dcdb634e1b97eecc61597a5ca8e3b4a950195e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c14d1b31ee911adad32262f11a92a394a26a850c3c33dc245a39c8bdfddf5e94eb72b2042fd084bcaf7d46ef6deff73ee79cc15b42fa9ad26791bd513584700"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 11:21:00.147903) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 11:21:00.148230) ========= 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=62c568580acbfdaac3eec7be000001dc-1452708886.128378-1169515466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 11:21:00.233961) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 11:21:00.234286) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 11:21:00.234592) ========= ========= Total master_lag: 0.30 =========