builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1453683492.61 results: success (0) buildid: 20160124143004 builduid: 8f23f1b0f399422c8c88cf43d821c993 revision: c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.610385) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.610852) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.611175) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006273 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.647994) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.648372) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.681949) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.682314) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.737861) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.738261) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.738688) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.739001) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-24 16:58:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-01-24 16:58:12 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177571 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.930546) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.930908) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020972 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.981515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.981919) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 --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 c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 --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=b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-24 16:58:13,057 truncating revision to first 12 chars 2016-01-24 16:58:13,057 Setting DEBUG logging. 2016-01-24 16:58:13,057 attempt 1/10 2016-01-24 16:58:13,057 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c2256ee8ae9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-24 16:58:13,312 unpacking tar archive at: fx-team-c2256ee8ae9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539524 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:13.534825) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:13.535241) ========= echo c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7'] 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=b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 program finished with exit code 0 elapsedTime=0.003264 script_repo_revision: 'c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:13.583805) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:13.584170) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:13.594548) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-24 16:58:13.594886) ========= /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=b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:58:13 INFO - MultiFileLogger online at 20160124 16:58:13 in /builds/slave/test-pgo 16:58:13 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 16:58:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:58:13 INFO - {'append_to_log': False, 16:58:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:58:13 INFO - 'blob_upload_branch': 'Fx-Team', 16:58:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:58:13 INFO - 'branch': 'Fx-Team', 16:58:13 INFO - 'buildbot_json_path': 'buildprops.json', 16:58:13 INFO - 'config_files': ('talos/linux_config.py',), 16:58:13 INFO - 'default_actions': ('clobber', 16:58:13 INFO - 'read-buildbot-config', 16:58:13 INFO - 'download-and-extract', 16:58:13 INFO - 'populate-webroot', 16:58:13 INFO - 'create-virtualenv', 16:58:13 INFO - 'install', 16:58:13 INFO - 'run-tests'), 16:58:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:58:13 INFO - 'download_minidump_stackwalk': True, 16:58:13 INFO - 'download_symbols': 'ondemand', 16:58:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:58:13 INFO - 'tooltool.py': '/tools/tooltool.py', 16:58:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:58:13 INFO - '/tools/misc-python/virtualenv.py')}, 16:58:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:58:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:58:13 INFO - 'installer_path': 'installer.exe', 16:58:13 INFO - 'log_level': 'info', 16:58:13 INFO - 'log_name': 'talos', 16:58:13 INFO - 'log_to_console': True, 16:58:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:58:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:58:13 INFO - 'opt_config_files': (), 16:58:13 INFO - 'pip_index': False, 16:58:13 INFO - 'sps_profile': False, 16:58:13 INFO - 'sps_profile_interval': 0, 16:58:13 INFO - 'suite': 'dromaeojs', 16:58:13 INFO - 'system_bits': '32', 16:58:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:58:13 INFO - 'title': 'talos-linux64-ix-007', 16:58:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:58:13 INFO - 'use_talos_json': True, 16:58:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:58:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:58:13 INFO - 'work_dir': 'build'} 16:58:13 INFO - ##### 16:58:13 INFO - ##### Running clobber step. 16:58:13 INFO - ##### 16:58:13 INFO - Running pre-action listener: _resource_record_pre_action 16:58:13 INFO - Running main action method: clobber 16:58:13 INFO - rmtree: /builds/slave/test-pgo/build 16:58:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:58:14 INFO - Running post-action listener: _resource_record_post_action 16:58:14 INFO - ##### 16:58:14 INFO - ##### Running read-buildbot-config step. 16:58:14 INFO - ##### 16:58:14 INFO - Running pre-action listener: _resource_record_pre_action 16:58:14 INFO - Running main action method: read_buildbot_config 16:58:14 INFO - Using buildbot properties: 16:58:14 INFO - { 16:58:14 INFO - "project": "", 16:58:14 INFO - "product": "firefox", 16:58:14 INFO - "script_repo_revision": "production", 16:58:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:58:14 INFO - "repository": "", 16:58:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:58:14 INFO - "buildid": "20160124143004", 16:58:14 INFO - "pgo_build": "True", 16:58:14 INFO - "basedir": "/builds/slave/test-pgo", 16:58:14 INFO - "buildnumber": 448, 16:58:14 INFO - "slavename": "talos-linux64-ix-007", 16:58:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:58:14 INFO - "platform": "ubuntu64_hw", 16:58:14 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:58:14 INFO - "branch": "fx-team", 16:58:14 INFO - "repo_path": "integration/fx-team", 16:58:14 INFO - "revision": "c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7", 16:58:14 INFO - "stage_platform": "linux64-pgo", 16:58:14 INFO - "builduid": "8f23f1b0f399422c8c88cf43d821c993", 16:58:14 INFO - "slavebuilddir": "test" 16:58:14 INFO - } 16:58:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:58:14 INFO - Running post-action listener: _resource_record_post_action 16:58:14 INFO - ##### 16:58:14 INFO - ##### Running download-and-extract step. 16:58:14 INFO - ##### 16:58:14 INFO - Running pre-action listener: _resource_record_pre_action 16:58:14 INFO - Running main action method: download_and_extract 16:58:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:58:14 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')]} 16:58:14 INFO - https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:58:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/test_packages.json 16:58:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/test_packages.json 16:58:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:58:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:58:17 INFO - Downloaded 1448 bytes. 16:58:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:58:17 INFO - Using the following test package requirements: 16:58:17 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:58:17 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:58:17 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:58:17 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:17 INFO - u'jsshell-linux-x86_64.zip'], 16:58:17 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:58:17 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:58:17 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:58:17 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:58:17 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:58:17 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:58:17 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:58:17 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:58:17 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')]} 16:58:17 INFO - https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:58:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/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 16:58:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/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 16:58:18 INFO - Downloaded 22491968 bytes. 16:58:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:58:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:58:19 INFO - Return code: 0 16:58:19 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 16:58: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')]} 16:58:19 INFO - https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:58:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/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 16:58:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/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 16:58:29 INFO - Downloaded 22491968 bytes. 16:58:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:58:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:58:30 INFO - Return code: 0 16:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:30 INFO - https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:58:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:58:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:58:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/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 16:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/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 16:58:31 INFO - Downloaded 10706572 bytes. 16:58:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:58:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 16:58:32 INFO - Return code: 0 16:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:32 INFO - https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:58:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:58:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:58:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/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 16:58:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/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 16:58:34 INFO - Downloaded 55977776 bytes. 16:58:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:58:34 INFO - mkdir: /builds/slave/test-pgo/properties 16:58:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:58:34 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:58:34 INFO - Contents: 16:58:34 INFO - build_url:https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:58:34 INFO - Running post-action listener: _resource_record_post_action 16:58:34 INFO - Running post-action listener: set_extra_try_arguments 16:58:34 INFO - ##### 16:58:34 INFO - ##### Running populate-webroot step. 16:58:34 INFO - ##### 16:58:34 INFO - Running pre-action listener: _resource_record_pre_action 16:58:34 INFO - Running main action method: populate_webroot 16:58:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:58:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:58:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:58:34 INFO - '--tppagecycles', 16:58:34 INFO - '7'], 16:58:34 INFO - 'tests': ['tsvgm']}}, 16:58:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:58:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:58:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:58:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:58:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:58:34 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:58:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:34 INFO - 'talos_options': ['--e10s'], 16:58:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:34 INFO - 'tests': ['damp', 'tps']}, 16:58:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:34 INFO - 'talos_options': ['--e10s'], 16:58:34 INFO - 'tests': ['damp', 'tps']}, 16:58:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:58:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:58:34 INFO - 'other': {'tests': ['a11yr', 16:58:34 INFO - 'ts_paint', 16:58:34 INFO - 'tpaint', 16:58:34 INFO - 'sessionrestore', 16:58:34 INFO - 'sessionrestore_no_auto_restore']}, 16:58:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:58:34 INFO - 'tests': ['a11yr', 16:58:34 INFO - 'ts_paint', 16:58:34 INFO - 'tpaint', 16:58:34 INFO - 'sessionrestore', 16:58:34 INFO - 'sessionrestore_no_auto_restore']}, 16:58:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:58:34 INFO - 'tests': ['a11yr', 16:58:34 INFO - 'ts_paint', 16:58:34 INFO - 'tpaint', 16:58:34 INFO - 'sessionrestore', 16:58:34 INFO - 'sessionrestore_no_auto_restore']}, 16:58:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:58:34 INFO - 'tests': ['a11yr', 16:58:34 INFO - 'ts_paint', 16:58:34 INFO - 'tpaint', 16:58:34 INFO - 'sessionrestore', 16:58:34 INFO - 'sessionrestore_no_auto_restore']}, 16:58:34 INFO - 'other_l64': {'tests': ['a11yr', 16:58:34 INFO - 'ts_paint', 16:58:34 INFO - 'tpaint', 16:58:34 INFO - 'sessionrestore', 16:58:34 INFO - 'sessionrestore_no_auto_restore']}, 16:58:34 INFO - 'other_nol64': {'tests': ['a11yr', 16:58:34 INFO - 'ts_paint', 16:58:34 INFO - 'tpaint', 16:58:34 INFO - 'sessionrestore', 16:58:34 INFO - 'sessionrestore_no_auto_restore']}, 16:58:34 INFO - 'svgr': {'tests': ['tsvgx', 16:58:34 INFO - 'tsvgr_opacity', 16:58:34 INFO - 'tart', 16:58:34 INFO - 'tscrollx', 16:58:34 INFO - 'cart']}, 16:58:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:58:34 INFO - 'tests': ['tsvgx', 16:58:34 INFO - 'tsvgr_opacity', 16:58:34 INFO - 'tart', 16:58:34 INFO - 'tscrollx', 16:58:34 INFO - 'cart']}, 16:58:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:34 INFO - 'tests': ['tp5o']}, 16:58:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:34 INFO - 'talos_options': ['--e10s'], 16:58:34 INFO - 'tests': ['tp5o']}, 16:58:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:34 INFO - 'talos_options': ['--xperf_path', 16:58:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:34 INFO - 'tests': ['tp5n']}, 16:58:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:34 INFO - 'talos_options': ['--e10s', 16:58:34 INFO - '--xperf_path', 16:58:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:34 INFO - 'tests': ['tp5n']}}, 16:58:34 INFO - 'talos.zip': {'path': '', 16:58:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:58:34 INFO - Running post-action listener: _resource_record_post_action 16:58:34 INFO - ##### 16:58:34 INFO - ##### Running create-virtualenv step. 16:58:34 INFO - ##### 16:58:34 INFO - Running pre-action listener: _resource_record_pre_action 16:58:34 INFO - Running main action method: create_virtualenv 16:58:34 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:58:34 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 16:58:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:58:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:58:34 INFO - Using real prefix '/usr' 16:58:34 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:58:35 INFO - Installing distribute.............................................................................................................................................................................................done. 16:58:37 INFO - Installing pip.................done. 16:58:37 INFO - Return code: 0 16:58:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f088501ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba540>, '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 0x1abb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8f0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939', '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 16:58:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 16:58:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 16:58:37 INFO - Using env: {'DISPLAY': ':0', 16:58:37 INFO - 'HOME': '/home/cltbld', 16:58:37 INFO - 'LANG': 'en_US.UTF-8', 16:58:37 INFO - 'LANGUAGE': 'en_US:en', 16:58:37 INFO - 'LOGNAME': 'cltbld', 16:58:37 INFO - 'MAIL': '/var/mail/cltbld', 16:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:37 INFO - 'MOZ_NO_REMOTE': '1', 16:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:37 INFO - 'NO_EM_RESTART': '1', 16:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:37 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:37 INFO - 'SHELL': '/bin/bash', 16:58:37 INFO - 'SHLVL': '1', 16:58:37 INFO - 'TERM': 'linux', 16:58:37 INFO - 'TMOUT': '86400', 16:58:37 INFO - 'USER': 'cltbld', 16:58:37 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939', 16:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:37 INFO - '_': '/tools/buildbot/bin/python'} 16:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:37 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 16:58:37 INFO - Cleaning up... 16:58:37 INFO - Return code: 0 16:58:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f088501ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba540>, '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 0x1abb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8f0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939', '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 16:58:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 16:58:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 16:58:37 INFO - Using env: {'DISPLAY': ':0', 16:58:37 INFO - 'HOME': '/home/cltbld', 16:58:37 INFO - 'LANG': 'en_US.UTF-8', 16:58:37 INFO - 'LANGUAGE': 'en_US:en', 16:58:37 INFO - 'LOGNAME': 'cltbld', 16:58:37 INFO - 'MAIL': '/var/mail/cltbld', 16:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:37 INFO - 'MOZ_NO_REMOTE': '1', 16:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:37 INFO - 'NO_EM_RESTART': '1', 16:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:37 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:37 INFO - 'SHELL': '/bin/bash', 16:58:37 INFO - 'SHLVL': '1', 16:58:37 INFO - 'TERM': 'linux', 16:58:37 INFO - 'TMOUT': '86400', 16:58:37 INFO - 'USER': 'cltbld', 16:58:37 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939', 16:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:37 INFO - '_': '/tools/buildbot/bin/python'} 16:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:37 INFO - Downloading/unpacking psutil>=0.7.1 16:58:37 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 16:58:37 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 16:58:37 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 16:58:37 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 16:58:37 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 16:58:37 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 16:58:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:58:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:39 INFO - Installing collected packages: psutil 16:58:39 INFO - Running setup.py install for psutil 16:58:39 INFO - building 'psutil._psutil_linux' extension 16:58:39 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 16:58:39 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 16:58:40 INFO - building 'psutil._psutil_posix' extension 16:58:40 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 16:58:40 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 16:58:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:40 INFO - Successfully installed psutil 16:58:40 INFO - Cleaning up... 16:58:40 INFO - Return code: 0 16:58:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f088501ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba540>, '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 0x1abb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8f0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939', '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 16:58:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 16:58:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 16:58:40 INFO - Using env: {'DISPLAY': ':0', 16:58:40 INFO - 'HOME': '/home/cltbld', 16:58:40 INFO - 'LANG': 'en_US.UTF-8', 16:58:40 INFO - 'LANGUAGE': 'en_US:en', 16:58:40 INFO - 'LOGNAME': 'cltbld', 16:58:40 INFO - 'MAIL': '/var/mail/cltbld', 16:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:40 INFO - 'MOZ_NO_REMOTE': '1', 16:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:40 INFO - 'NO_EM_RESTART': '1', 16:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:40 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:40 INFO - 'SHELL': '/bin/bash', 16:58:40 INFO - 'SHLVL': '1', 16:58:40 INFO - 'TERM': 'linux', 16:58:40 INFO - 'TMOUT': '86400', 16:58:40 INFO - 'USER': 'cltbld', 16:58:40 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939', 16:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:40 INFO - '_': '/tools/buildbot/bin/python'} 16:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:58:40 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 16:58:40 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 16:58:40 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 16:58:40 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 16:58:40 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 16:58:40 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 16:58:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:58:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:58:42 INFO - Installing collected packages: mozsystemmonitor 16:58:42 INFO - Running setup.py install for mozsystemmonitor 16:58:42 INFO - Successfully installed mozsystemmonitor 16:58:42 INFO - Cleaning up... 16:58:42 INFO - Return code: 0 16:58:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f088501ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba540>, '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 0x1abb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8f0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939', '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 16:58:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 16:58:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 16:58:42 INFO - Using env: {'DISPLAY': ':0', 16:58:42 INFO - 'HOME': '/home/cltbld', 16:58:42 INFO - 'LANG': 'en_US.UTF-8', 16:58:42 INFO - 'LANGUAGE': 'en_US:en', 16:58:42 INFO - 'LOGNAME': 'cltbld', 16:58:42 INFO - 'MAIL': '/var/mail/cltbld', 16:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:42 INFO - 'MOZ_NO_REMOTE': '1', 16:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:42 INFO - 'NO_EM_RESTART': '1', 16:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:42 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:42 INFO - 'SHELL': '/bin/bash', 16:58:42 INFO - 'SHLVL': '1', 16:58:42 INFO - 'TERM': 'linux', 16:58:42 INFO - 'TMOUT': '86400', 16:58:42 INFO - 'USER': 'cltbld', 16:58:42 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939', 16:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:42 INFO - '_': '/tools/buildbot/bin/python'} 16:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:42 INFO - Downloading/unpacking blobuploader==1.2.4 16:58:42 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 16:58:42 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 16:58:42 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 16:58:42 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 16:58:42 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 16:58:42 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 16:58:44 INFO - Downloading blobuploader-1.2.4.tar.gz 16:58:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:58:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:58:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:46 INFO - Downloading docopt-0.6.1.tar.gz 16:58:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:58:46 INFO - Installing collected packages: blobuploader, requests, docopt 16:58:46 INFO - Running setup.py install for blobuploader 16:58:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:58:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:58:46 INFO - Running setup.py install for requests 16:58:46 INFO - Running setup.py install for docopt 16:58:46 INFO - Successfully installed blobuploader requests docopt 16:58:46 INFO - Cleaning up... 16:58:46 INFO - Return code: 0 16:58:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f088501ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba540>, '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 0x1abb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8f0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939', '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 16:58:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 16:58:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 16:58:46 INFO - Using env: {'DISPLAY': ':0', 16:58:46 INFO - 'HOME': '/home/cltbld', 16:58:46 INFO - 'LANG': 'en_US.UTF-8', 16:58:46 INFO - 'LANGUAGE': 'en_US:en', 16:58:46 INFO - 'LOGNAME': 'cltbld', 16:58:46 INFO - 'MAIL': '/var/mail/cltbld', 16:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:46 INFO - 'MOZ_NO_REMOTE': '1', 16:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:46 INFO - 'NO_EM_RESTART': '1', 16:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:46 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:46 INFO - 'SHELL': '/bin/bash', 16:58:46 INFO - 'SHLVL': '1', 16:58:46 INFO - 'TERM': 'linux', 16:58:46 INFO - 'TMOUT': '86400', 16:58:46 INFO - 'USER': 'cltbld', 16:58:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939', 16:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:46 INFO - '_': '/tools/buildbot/bin/python'} 16:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:58:47 INFO - Running setup.py (path:/tmp/pip-Edy11j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:58:47 INFO - Running setup.py (path:/tmp/pip-Rk3hp_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:58:47 INFO - Running setup.py (path:/tmp/pip-OmGxt5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:58:47 INFO - Running setup.py (path:/tmp/pip-qjh9zl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:58:47 INFO - Running setup.py (path:/tmp/pip-8rnpBb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:58:47 INFO - Running setup.py (path:/tmp/pip-nTfYrL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:58:47 INFO - Running setup.py (path:/tmp/pip-ScM_HB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:58:47 INFO - Running setup.py (path:/tmp/pip-RbctOO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:58:47 INFO - Running setup.py (path:/tmp/pip-bBAaO7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:58:47 INFO - Running setup.py (path:/tmp/pip-Rsr6xO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:58:47 INFO - Running setup.py (path:/tmp/pip-s1UShw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:58:47 INFO - Running setup.py (path:/tmp/pip-Na0IN9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:58:48 INFO - Running setup.py (path:/tmp/pip-i_dDQq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:58:48 INFO - Running setup.py (path:/tmp/pip-E4wFJQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:58:48 INFO - Running setup.py (path:/tmp/pip-y8GSru-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:58:48 INFO - Running setup.py (path:/tmp/pip-rDZXEG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:58:48 INFO - Running setup.py (path:/tmp/pip-twqDdD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:58:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:58:48 INFO - Running setup.py install for manifestparser 16:58:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:58:48 INFO - Running setup.py install for mozcrash 16:58:48 INFO - Running setup.py install for mozdebug 16:58:48 INFO - Running setup.py install for mozdevice 16:58:48 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:58:48 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:58:48 INFO - Running setup.py install for mozfile 16:58:48 INFO - Running setup.py install for mozhttpd 16:58:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:58:49 INFO - Running setup.py install for mozinfo 16:58:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:58:49 INFO - Running setup.py install for mozInstall 16:58:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:58:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:58:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:58:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:58:49 INFO - Running setup.py install for mozleak 16:58:49 INFO - Running setup.py install for mozlog 16:58:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:58:49 INFO - Running setup.py install for moznetwork 16:58:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:58:49 INFO - Running setup.py install for mozprocess 16:58:49 INFO - Running setup.py install for mozprofile 16:58:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:58:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:58:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:58:49 INFO - Running setup.py install for mozrunner 16:58:49 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:58:49 INFO - Running setup.py install for mozscreenshot 16:58:50 INFO - Running setup.py install for moztest 16:58:50 INFO - Running setup.py install for mozversion 16:58:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:58:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:58:50 INFO - Cleaning up... 16:58:50 INFO - Return code: 0 16:58:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f088501ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba540>, '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 0x1abb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8f0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939', '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 16:58:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 16:58:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 16:58:50 INFO - Using env: {'DISPLAY': ':0', 16:58:50 INFO - 'HOME': '/home/cltbld', 16:58:50 INFO - 'LANG': 'en_US.UTF-8', 16:58:50 INFO - 'LANGUAGE': 'en_US:en', 16:58:50 INFO - 'LOGNAME': 'cltbld', 16:58:50 INFO - 'MAIL': '/var/mail/cltbld', 16:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:50 INFO - 'MOZ_NO_REMOTE': '1', 16:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:50 INFO - 'NO_EM_RESTART': '1', 16:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:50 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:50 INFO - 'SHELL': '/bin/bash', 16:58:50 INFO - 'SHLVL': '1', 16:58:50 INFO - 'TERM': 'linux', 16:58:50 INFO - 'TMOUT': '86400', 16:58:50 INFO - 'USER': 'cltbld', 16:58:50 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939', 16:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:50 INFO - '_': '/tools/buildbot/bin/python'} 16:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:58:50 INFO - Running setup.py (path:/tmp/pip-BcxIJc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:58:50 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)) 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:58:50 INFO - Running setup.py (path:/tmp/pip-e6O2ko-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:58:50 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)) 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:58:50 INFO - Running setup.py (path:/tmp/pip-P0_8T4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:58:50 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)) 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:58:50 INFO - Running setup.py (path:/tmp/pip-_zsgIs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:58:50 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)) 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:58:50 INFO - Running setup.py (path:/tmp/pip-1LpXSc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:58:50 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)) 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:58:50 INFO - Running setup.py (path:/tmp/pip-G4wO91-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:58:50 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)) 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:58:50 INFO - Running setup.py (path:/tmp/pip-KV3ztI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:58:50 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)) 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:58:50 INFO - Running setup.py (path:/tmp/pip-AjjvxJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:58:51 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)) 16:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:58:51 INFO - Running setup.py (path:/tmp/pip-obkL7y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:58:51 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)) 16:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:58:51 INFO - Running setup.py (path:/tmp/pip-2g7emQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:58:51 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)) 16:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:58:51 INFO - Running setup.py (path:/tmp/pip-7Zy_Fd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:58:51 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)) 16:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:58:51 INFO - Running setup.py (path:/tmp/pip-ZVVPuM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:58:51 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)) 16:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:58:51 INFO - Running setup.py (path:/tmp/pip-43XLXJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:58:51 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)) 16:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:58:51 INFO - Running setup.py (path:/tmp/pip-9cIFZz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:58:51 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)) 16:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:58:51 INFO - Running setup.py (path:/tmp/pip-HZ6Zzd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:58:51 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)) 16:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:58:51 INFO - Running setup.py (path:/tmp/pip-aWhC28-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:58:51 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)) 16:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:58:51 INFO - Running setup.py (path:/tmp/pip-CibXoE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:58:51 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)) 16:58:51 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)) 16:58:51 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)) 16:58:51 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)) 16:58:51 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)) 16:58:51 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)) 16:58:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:53 INFO - Downloading blessings-1.6.tar.gz 16:58:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:58:53 INFO - Installing collected packages: blessings 16:58:53 INFO - Running setup.py install for blessings 16:58:53 INFO - Successfully installed blessings 16:58:53 INFO - Cleaning up... 16:58:53 INFO - Return code: 0 16:58:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:58:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:58:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:58:53 INFO - Reading from file tmpfile_stdout 16:58:53 INFO - Current package versions: 16:58:53 INFO - argparse == 1.2.1 16:58:53 INFO - blessings == 1.6 16:58:53 INFO - blobuploader == 1.2.4 16:58:53 INFO - docopt == 0.6.1 16:58:53 INFO - manifestparser == 1.1 16:58:53 INFO - mozInstall == 1.12 16:58:53 INFO - mozcrash == 0.16 16:58:53 INFO - mozdebug == 0.1 16:58:53 INFO - mozdevice == 0.48 16:58:53 INFO - mozfile == 1.2 16:58:53 INFO - mozhttpd == 0.7 16:58:53 INFO - mozinfo == 0.9 16:58:53 INFO - mozleak == 0.1 16:58:53 INFO - mozlog == 3.1 16:58:53 INFO - moznetwork == 0.27 16:58:53 INFO - mozprocess == 0.22 16:58:53 INFO - mozprofile == 0.28 16:58:53 INFO - mozrunner == 6.11 16:58:53 INFO - mozscreenshot == 0.1 16:58:53 INFO - mozsystemmonitor == 0.0 16:58:53 INFO - moztest == 0.7 16:58:53 INFO - mozversion == 1.4 16:58:53 INFO - psutil == 3.1.1 16:58:53 INFO - requests == 1.2.3 16:58:53 INFO - wsgiref == 0.1.2 16:58:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f088501ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba540>, '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 0x1abb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8f0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939', '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 16:58:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 16:58:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 16:58:53 INFO - Using env: {'DISPLAY': ':0', 16:58:53 INFO - 'HOME': '/home/cltbld', 16:58:53 INFO - 'LANG': 'en_US.UTF-8', 16:58:53 INFO - 'LANGUAGE': 'en_US:en', 16:58:53 INFO - 'LOGNAME': 'cltbld', 16:58:53 INFO - 'MAIL': '/var/mail/cltbld', 16:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:53 INFO - 'MOZ_NO_REMOTE': '1', 16:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:53 INFO - 'NO_EM_RESTART': '1', 16:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:53 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:53 INFO - 'SHELL': '/bin/bash', 16:58:53 INFO - 'SHLVL': '1', 16:58:53 INFO - 'TERM': 'linux', 16:58:53 INFO - 'TMOUT': '86400', 16:58:53 INFO - 'USER': 'cltbld', 16:58:53 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939', 16:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:53 INFO - '_': '/tools/buildbot/bin/python'} 16:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:54 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)) 16:58:54 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)) 16:58:54 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)) 16:58:54 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)) 16:58:54 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)) 16:58:54 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)) 16:58:54 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)) 16:58:54 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)) 16:58:54 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)) 16:58:54 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)) 16:58:54 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)) 16:58:54 INFO - Cleaning up... 16:58:54 INFO - Return code: 0 16:58:54 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:58: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')]} 16:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f088501ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba540>, '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 0x1abb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8f0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939', '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 16:58:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 16:58:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 16:58:54 INFO - Using env: {'DISPLAY': ':0', 16:58:54 INFO - 'HOME': '/home/cltbld', 16:58:54 INFO - 'LANG': 'en_US.UTF-8', 16:58:54 INFO - 'LANGUAGE': 'en_US:en', 16:58:54 INFO - 'LOGNAME': 'cltbld', 16:58:54 INFO - 'MAIL': '/var/mail/cltbld', 16:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:54 INFO - 'MOZ_NO_REMOTE': '1', 16:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:54 INFO - 'NO_EM_RESTART': '1', 16:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:54 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:54 INFO - 'SHELL': '/bin/bash', 16:58:54 INFO - 'SHLVL': '1', 16:58:54 INFO - 'TERM': 'linux', 16:58:54 INFO - 'TMOUT': '86400', 16:58:54 INFO - 'USER': 'cltbld', 16:58:54 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939', 16:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:54 INFO - '_': '/tools/buildbot/bin/python'} 16:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:54 INFO - Downloading/unpacking jsonschema 16:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:58:56 INFO - Downloading/unpacking functools32 (from jsonschema) 16:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:56 INFO - Downloading functools32-3.2.3-2.tar.gz 16:58:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:58:56 INFO - warning: no files found matching '*.txt' 16:58:56 INFO - no previously-included directories found matching 'build' 16:58:56 INFO - no previously-included directories found matching 'dist' 16:58:56 INFO - no previously-included directories found matching '.git*' 16:58:56 INFO - Installing collected packages: jsonschema, functools32 16:58:56 INFO - Running setup.py install for functools32 16:58:56 INFO - warning: no files found matching '*.txt' 16:58:56 INFO - no previously-included directories found matching 'build' 16:58:56 INFO - no previously-included directories found matching 'dist' 16:58:56 INFO - no previously-included directories found matching '.git*' 16:58:56 INFO - Successfully installed jsonschema functools32 16:58:56 INFO - Cleaning up... 16:58:56 INFO - Return code: 0 16:58:56 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:58: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')]} 16:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f088501ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba540>, '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 0x1abb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8f0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939', '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 16:58:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 16:58:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 16:58:56 INFO - Using env: {'DISPLAY': ':0', 16:58:56 INFO - 'HOME': '/home/cltbld', 16:58:56 INFO - 'LANG': 'en_US.UTF-8', 16:58:56 INFO - 'LANGUAGE': 'en_US:en', 16:58:56 INFO - 'LOGNAME': 'cltbld', 16:58:56 INFO - 'MAIL': '/var/mail/cltbld', 16:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:56 INFO - 'MOZ_NO_REMOTE': '1', 16:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:56 INFO - 'NO_EM_RESTART': '1', 16:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:56 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:56 INFO - 'SHELL': '/bin/bash', 16:58:56 INFO - 'SHLVL': '1', 16:58:56 INFO - 'TERM': 'linux', 16:58:56 INFO - 'TMOUT': '86400', 16:58:56 INFO - 'USER': 'cltbld', 16:58:56 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939', 16:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:56 INFO - '_': '/tools/buildbot/bin/python'} 16:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:56 INFO - Downloading/unpacking flake8 16:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:58:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:58:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:58:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:58:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:58:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:58:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:58:59 INFO - no previously-included directories found matching 'docs/_build' 16:58:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:58:59 INFO - Running setup.py install for pep8 16:58:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:58:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:58:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:58:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:58:59 INFO - no previously-included directories found matching 'docs/_build' 16:58:59 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:58:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:58:59 INFO - Cleaning up... 16:58:59 INFO - Return code: 0 16:58:59 INFO - Running post-action listener: _resource_record_post_action 16:58:59 INFO - Running post-action listener: _start_resource_monitoring 16:58:59 INFO - Starting resource monitoring. 16:58:59 INFO - ##### 16:58:59 INFO - ##### Running install step. 16:58:59 INFO - ##### 16:58:59 INFO - Running pre-action listener: _resource_record_pre_action 16:58:59 INFO - Running main action method: install 16:58:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:58:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:58:59 INFO - Reading from file tmpfile_stdout 16:58:59 INFO - Detecting whether we're running mozinstall >=1.0... 16:58:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:58:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:58:59 INFO - Reading from file tmpfile_stdout 16:58:59 INFO - Output received: 16:58:59 INFO - Usage: mozinstall [options] installer 16:58:59 INFO - Options: 16:58:59 INFO - -h, --help show this help message and exit 16:58:59 INFO - -d DEST, --destination=DEST 16:58:59 INFO - Directory to install application into. [default: 16:58:59 INFO - "/builds/slave/test-pgo"] 16:58:59 INFO - --app=APP Application being installed. [default: firefox] 16:58:59 INFO - mkdir: /builds/slave/test-pgo/build/application 16:58:59 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'] 16:58:59 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 16:59:15 INFO - Reading from file tmpfile_stdout 16:59:15 INFO - Output received: 16:59:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:59:15 INFO - Running post-action listener: _resource_record_post_action 16:59:15 INFO - ##### 16:59:15 INFO - ##### Running run-tests step. 16:59:15 INFO - ##### 16:59:15 INFO - Running pre-action listener: _resource_record_pre_action 16:59:15 INFO - Running main action method: run_tests 16:59:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:59:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:59:15 INFO - Python 2.7.3 16:59:15 INFO - Return code: 0 16:59:15 INFO - grabbing minidump binary from tooltool 16:59:15 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')]} 16:59:15 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 0x1aba540>, '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 0x1abb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:59:15 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 16:59:15 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 16:59:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:59:15 INFO - Return code: 0 16:59:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:59:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:59:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:59:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:59:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:59:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:59:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:59:16 INFO - Return code: 0 16:59:16 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/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 16:59:17 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/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 16:59:17 INFO - Using env: {'DISPLAY': ':0', 16:59:17 INFO - 'HOME': '/home/cltbld', 16:59:17 INFO - 'LANG': 'en_US.UTF-8', 16:59:17 INFO - 'LANGUAGE': 'en_US:en', 16:59:17 INFO - 'LOGNAME': 'cltbld', 16:59:17 INFO - 'MAIL': '/var/mail/cltbld', 16:59:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:59:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:17 INFO - 'MOZ_NO_REMOTE': '1', 16:59:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:17 INFO - 'NO_EM_RESTART': '1', 16:59:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:17 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:59:17 INFO - 'SHELL': '/bin/bash', 16:59:17 INFO - 'SHLVL': '1', 16:59:17 INFO - 'TERM': 'linux', 16:59:17 INFO - 'TMOUT': '86400', 16:59:17 INFO - 'USER': 'cltbld', 16:59:17 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939', 16:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:17 INFO - '_': '/tools/buildbot/bin/python'} 16:59:17 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/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 16:59:17 INFO - mozversion application_buildid: 20160124143004 16:59:17 INFO - mozversion application_changeset: c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 16:59:17 INFO - mozversion application_display_name: Nightly 16:59:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:59:17 INFO - mozversion application_name: Firefox 16:59:17 INFO - mozversion application_remotingname: firefox 16:59:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:59:17 INFO - mozversion application_vendor: Mozilla 16:59:17 INFO - mozversion application_version: 46.0a1 16:59:17 INFO - mozversion platform_buildid: 20160124143004 16:59:17 INFO - mozversion platform_changeset: c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 16:59:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:59:17 INFO - mozversion platform_version: 46.0a1 16:59:17 INFO - using testdate: 1453683557 16:59:17 INFO - actual date: 1453683557 16:59:17 INFO - starting webserver on 'localhost:36064' 16:59:17 INFO - SUITE-START | Running 3 tests 16:59:17 INFO - TEST-START | dromaeo_css 16:59:17 INFO - operating with platform_type : linux_ 16:59:17 INFO - Initialising browser for dromaeo_css test... 16:59:17 INFO - TEST-INFO | started process 3893 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwr1Fry/profile http://localhost:36064/getInfo.html) 16:59:21 INFO - PROCESS | 3893 | __metrics Screen width/height:1600/1200 16:59:21 INFO - PROCESS | 3893 | colorDepth:24 16:59:21 INFO - PROCESS | 3893 | Browser inner width/height: 1024/697 16:59:21 INFO - PROCESS | 3893 | __metrics 16:59:21 INFO - PROCESS | 3893 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:59:22 INFO - PROCESS | 3893 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:59:22 INFO - TEST-INFO | 3893: exit 0 16:59:22 INFO - Browser initialized. 16:59:22 INFO - Running cycle 1/1 for dromaeo_css test... 16:59:23 INFO - TEST-INFO | started process 3986 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwr1Fry/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:59:34 INFO - PROCESS | 3986 | RSS: Main: 147693568 16:59:34 INFO - PROCESS | 3986 | 17:00:26 INFO - PROCESS | 3986 | 1453683626216 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] 17:02:34 INFO - PROCESS | 3986 | Cycle 1(1): loaded http://localhost:36064/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36064/tests/dromaeo/cssquery-ext.html) 17:02:35 INFO - PROCESS | 3986 | RSS: Main: 228716544 17:02:35 INFO - PROCESS | 3986 | 17:05:37 INFO - PROCESS | 3986 | Cycle 1(1): loaded http://localhost:36064/tests/dromaeo/cssquery-ext.html (next: http://localhost:36064/tests/dromaeo/cssquery-jquery.html) 17:05:38 INFO - PROCESS | 3986 | RSS: Main: 239652864 17:05:38 INFO - PROCESS | 3986 | 17:08:40 INFO - PROCESS | 3986 | Cycle 1(1): loaded http://localhost:36064/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36064/tests/dromaeo/cssquery-mootools.html) 17:08:40 INFO - PROCESS | 3986 | RSS: Main: 225775616 17:08:40 INFO - PROCESS | 3986 | 17:11:42 INFO - PROCESS | 3986 | Cycle 1(1): loaded http://localhost:36064/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36064/tests/dromaeo/cssquery-prototype.html) 17:11:43 INFO - PROCESS | 3986 | RSS: Main: 213598208 17:11:43 INFO - PROCESS | 3986 | 17:14:46 INFO - PROCESS | 3986 | Cycle 1(1): loaded http://localhost:36064/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36064/tests/dromaeo/cssquery-yui.html) 17:14:46 INFO - PROCESS | 3986 | RSS: Main: 214659072 17:14:46 INFO - PROCESS | 3986 | 17:17:49 INFO - PROCESS | 3986 | Cycle 1(1): loaded http://localhost:36064/tests/dromaeo/cssquery-yui.html (next: http://localhost:36064/tests/dromaeo/cssquery-dojo.html) 17:17:49 INFO - PROCESS | 3986 | RSS: Main: 296173568 17:17:49 INFO - PROCESS | 3986 | 17:17:49 INFO - PROCESS | 3986 | __start_tp_report 17:17:49 INFO - PROCESS | 3986 | _x_x_mozilla_page_load 17:17:49 INFO - PROCESS | 3986 | _x_x_mozilla_page_load_details 17:17:49 INFO - PROCESS | 3986 | |i|pagename|runs| 17:17:49 INFO - PROCESS | 3986 | |0;dojo.html;3051.984740076299;3065.1724034510667;3099.752019838413;3116.2053676312553;3145.5910731604886;4918.336024636673;4991.700497970124;4996.425411077723;5008.899822003557;5030.320906677597;5053.418856831466;5101.51535604117;5139;5208.947910520894;5211.114110601197;4647.372604698373;4651.139539185253;4665.790039448233;4681.648876334271;4761.47623761386;4685.601723853477;4719.1977363848055;4725.645576581753;4735.573798358147;4765.666403351766;4651.558101980307;4655.185342565038;4658.790354434059;4661.557152070548;4729.668923175379;4640.628749700016;4644.883877903046;4655.720656760605;4663.323818046364;4695.060987802453;4632.953670463286;4640.396748422717;4646.3495110684535;4664.183767840615;4681.625469962395;4848.2727590861305;4867.440244371872;4885.902281954341;4922.360093187898;4930.950690493121;5469.56243500519;5472.151816468454;5473.781048758045;5485.396606373296;5502.174673798922;5489.094299440588;5491.36849262332;5498.065328894098;5499.917501237484;5503.147012213073;5140.280360749498;5163.561097306733;5175.689458632494;5218.504242096995;5224.555912747421;5613.242212301287;5613.7193140342815;5619.100943849046;5619.606627536034;5624.184493248456;5417;5430.538404235605;5434.184872269191;5435.130379139318;5437.45625437461;5450.1007333789485;5471.343438787371;5529.336479622471;5533.418991005887;5586.748596313176;5348.572114230852;5350.91973620396;5357.249985002103;5359.678419294777;5376.462353764592;5356.651817631841;5361;5377.3816011159215;5391.622586418992;5410.215518749759;4180.122174343361;4213.831446742096;4244.10873716523;4260.147970405931;4287.828486860491;3818.5608655004476;3823.502944617182;3836.462895194675;3869.496965394537;3869.729118961646;5012.54887060159;5047.268146118792;5072.492750724898;5096.133657278272;5143.5113664201845;5425.26758887553;5464.726763661881;5476.972615136979;5511.311086114236;5553;5076.873078173076;5091.0581542414775;5091.363579552556;5093.847184584469;5122.769475373542;4600.631949444037;4681.227597446383;4723.102610503994;4724.669273150916;4725.5746982771025;5668.886622267614;5719.170720245541;5750.5112065474905;5751.309842818805;5786;5440.455954404528;5452.372977107525;5464.863378415413;5465.180222966586;5467.398586155599;5516.972415137899;5658.547316214611;5681.829545113653;5684.687342196054;5713.457221563945;5406.891862162814;5408.891822163613;5410.3778065522965;5411.2965314508865;5416.458354164552;5481.040817856939;5485.122380419114;5485.945140548543;5488.313960754906;5541.168824676331;5307.01820163271;5372.489613486712;5391.299131113087;5415.160650099241;5446.809361672323;5326.360836699466;5375.3280839895015;5375.892482150413;5375.951689420682;5376.166694162411;5220.243064755665;5249.317588713443;5249.343832020997;5251.553617942518;5290.153575427913;5264.63147579681;5353.089974704231;5363.5440987516495;5385.919211211756;5455.399906010415;5186.8962620748125;5255.737213139251;5258.97370513145;5266.473352664703;5308.46915308466 17:17:49 INFO - PROCESS | 3986 | |1;ext.html;512.3723438787486;514.9201873709575;522.9712365819884;538.1953978801693;561.9157126431037;28393;28901;35573.2885342293;36195;36200.09499762507;38970.80514597423;39080;39423;39453;39472.407913881245;8426.452280601772;8593.656253749843;8600.354973377021;8600.827983440327;8603.268722158593;8337.333013358948;8411.95794021032;8447.450915690491;8454.87317690235;8468.745937621881;8688.435251708619;8696.17386348299;8737.388382813206;8749.081346458626;8761.342899282547;8630.309575233967;8703.477791332509;8705;8721.738347849574;8728.258098061673;8573.099824518398;8701.825963480695;8704.086070962521;8708.912910870937;8713.56432178395;39320;39783.80108099441;39787.80106099451;39825.20349593021;39830.60169398298;3282.868685252587;3358.8824391146436;3559.2347645256395;3757.9624203757885;3851.441540976543;30026.24934376658;30284.8485757572;30494.847525762452;31720.36559268825;31954.840225798955;3858.498395208605;3894.9805250973845;3963.4451176835264;4044.615761502682;4071.470708807836;273355;275083;275357;275779.62110189523;276007;41318.79340603338;41946;52298.73850630722;53194.73402632962;58741.82516349649;40327.39508907369;40508.59491405048;40532.79733601313;40635.796821016294;40658.39012414816;13530.661733456545;13609.591712248648;14007.369668364949;14127.364268607937;14190.148591084362;9662.71011869645;10027.29808913369;11432.828507572392;11509.194356394972;11530.827037594443;13925.094868833494;13936.094153879965;13963;13989.230592317317;14087.718245635235;5600.0439610943795;5611.6071874969175;5613.607047506635;5642.520385767174;5734.569907256972;939.9201067909167;1005.5726316315537;1012.6202673997251;1055.9155267578576;1073.8335557988523;28707;28735.42529149447;29105.563416548768;29263.122106336843;30383.24041898926;1022.1260821997085;1042.6794182424296;1067.996083681337;1090.5038207615517;1120.798256313855;14840.480583179537;15084.472043478425;15425.922870385577;15475.148866812207;15970;382963;388025;389916;390252;391074;55342.72328638411;55988.44011559832;56120.719396403576;56169.15746263809;56305;1321.2997111530904;1343.8723321284463;1347.1714895339296;1354.4920654754467;1357.111092234568;29799.70200297969;30406.391872162876;30582.847085764428;30830.691693083678;31099.533506996962;44452.33321500245;45266.773666131456;45371.319430207914;45459.54540454686;45495.545044550454;253774;254401;255157;307261;364949;28696.71303287024;31005.379892402478;31493.212669682525;31697.20756981094;31936.840315798272;36219.818900905324;37105.62894371022;37410;37501.81249093737;40041.799791000856;32532.186695332806;34333.484997724554;34913.47629785606;35152.648473514935;35401;28593.653231600398;32674.29139731477;33705.83147084249;33706.66293337035;36155;31142.75428982906;31480;31838.840805795822;31904.202394940312;32083.35833283368;28557.571636425055;29256.26859328534;29873.850630746707;35007;36308.55068768463;23699.34174002694;25270.115545955803;25435.36411589725;25581.104661336765;26025.869870650524 17:17:49 INFO - PROCESS | 3986 | |2;jquery.html;361.07924791780954;362.87662194853755;364.5224755570203;365.3843274083172;373.4939157441665;12808.423620937057;13069.869301306984;15264.465743698973;16254.91872540637;17277.222524986373;14188.290585470711;15134.318955646995;15401.76897346538;15425.305861236244;16439.91780041101;5289.68261904285;5498.147787093007;5501.697406642633;5503.229547863302;5518.530924871391;3993.5607083220966;4130.731502452331;5384.246205531209;5505.174223866412;5717.428257174291;5818.41815818419;6002.429769171922;6053.334133245339;6053.424924632153;6062.878742425149;5877.970610146965;6059.333473317932;6091.756329746805;6119.694015299217;6145.5390845686525;5179.948200517984;5335.67985920846;5354.625176237665;5356.866078348034;5372.54333381663;19442.805571944242;19572.70640940387;19838.404847854443;20408.183672653075;20431.693524597144;2228.754836967932;2310.4223944013997;2310.7573704761094;2343.133040774924;2349.705539445742;12915;12987.220766754024;13055.477780888754;13121.671958201026;13491.797623035662;1793.775598672604;1828.4423250908467;1831.349870795875;1848.7226915962578;1858.9961420832733;53827;55602.165967510926;56903.430965690226;56908.430915690726;57163;9711.077447642463;9933.3543319684;9951.25365597583;9973.202143828476;10016.198704103654;12939.417726202344;13082.149660272053;13108.868911310956;13124.081314308098;13134.146280491928;7269.89095163573;7414.443916706268;7423.777286681408;7456.440766942501;7464.178940316561;6984.406325462291;6990.825229369307;7051.153861536648;7080.973258877434;7089.255628159072;5916.911246331309;6003.939960600425;6005.879882402415;6008.579399441997;6033.78881739137;1603.7033148867497;1711.9058451785022;1717.7251639737583;1792.354752289175;1806.205269681336;948.6395169835419;967.0571193086824;971.9028097190366;979.9434915834261;999.2405771613626;14005.369758360897;16741;17204.225809838586;17423.825761742475;17497.650046998988;912.8676341930383;951.1392190067861;957.6025949230991;963.5375019990444;1036.657902892044;9616.51917404127;9783.46190959504;9884.258680598983;9909.603615855285;9994.800103997879;332811;335576;360119;364262;369015;42035.36946945798;42546.36180457295;46784.2982355265;54837.4195096591;66164.66917665477;1117.6814607836727;1136.4601814138384;1146.1862077924766;1151.7005578549638;1155.2317708723604;13892.374843131882;15784.21078946071;15980.28088736033;16264.3494260233;16370.590735231715;30028.699713003465;30464.47677616066;30550.694493055675;30731.078067658007;30861.228469288446;37394.62605373911;37625;37816;37821.43267851039;39691.80154099211;7088.858222835617;7096.929030709834;7354.889676654748;7378.557286562824;7569;8335.833283334421;10086.89913100889;10325.74185645365;10388.117010053928;10501.63244286477;9112.134347237003;9298.72103836886;9405.670801522188;9501.192398646193;9577.425354478753;8784.736457906272;9141.085891410805;9569.425834449956;9683.9031609683;9721.125098741148;8341.081551243127;8881.644734210558;8956;9202.355835091746;9271.86092208604;7354.154272258758;7511;7663.195364486649;7680.615969201629;7763.61181940912;8787.121287871418;9262.212711919563;9293.581788819654;9387.29595280343;9445.197158241352 17:17:49 INFO - PROCESS | 3986 | |3;mootools.html;1296.086259187273;1464.8974571779972;1497.3411698852503;1649.158928946237;1782.794978577464;6906.861862762748;7364.74223402181;7516.699332026712;7527.397808175347;7528.962355188216;7593.468457207998;7786.610669466532;7792.688292468294;7809;7810.531368117917;1950.6488832010232;2000.8499362547793;2225.5103877147003;2238.3956331790405;2263.4567703751063;2232.787885150908;2242.3385101395047;2244.607193741097;2245.2141750387314;2245.4723140062074;2140.4327853118934;2209.5249521352907;2210.613142700021;2212.4468882779306;2212.623853944825;2198.7801219878043;2199.670049492573;2208.9668654970187;2251.2908433843286;2253.774622537733;2193.890305484719;2205.217147912484;2219.0236296029693;2221.3669104305195;2225.410266279437;7821.96089019557;7933.801654958615;7935.365170786324;7935.801604959865;7942.444028917978;4704.905901881977;4849.393825771778;4853.757312134379;4854.757262136879;4861.659683822134;3036.2409397650586;3096.5974423325047;3101.2942881415133;3145.1665308693214;3146.2449012237125;988.7528117970508;1003.6738060130486;1007.9748006299901;1076.6070384309749;1077.3374374759544;10877.619283325046;10916.890831091747;10918.617848375268;10928.617498387519;10928.672139835817;4217.219814334358;4346.195953748566;4364.738115713068;4375.518692943773;4409.14021765759;9355.95322023399;9376.203022743006;9378.624855005859;9393.953030234805;9406.623735050522;4831.106245344552;4858;4858.1012512685265;4860.586850117779;4861.611071114302;4372.759498227628;4424.623906967944;4426.557344265548;4426.822927082945;4430.446194225722;3432.5366075579477;3478.4608385700258;3638.7270954678506;3653.725970552219;3690.3357395669036;1168.6435637130587;1179.2983175010854;1182.645206438065;1195.934223617692;1210.267787988272;1112.2936935046305;1127.8308253762002;1129.5707631100129;1287.4721364240804;1367.3231750283674;7296.270372962767;7296.489245752852;7335.853282934311;7354.485186037033;7530.698772049166;1105.5577768892347;1111.8888111188817;1116.9050630696481;1134.432783608196;1137.0619239127752;5828.766849326064;5897.852553686193;5909.645421274738;5914.408559144051;5915.08316210988;9378.953105234566;9548.665796697222;9697.418154910727;9837.901620983841;9839.212862970946;9732.610695572097;9740.951295243478;9742.659006934724;9749.171320437701;9751.707448776406;7141.143062832493;7319.670614822346;7430.108386993596;7435.85128297431;7513.737019204302;7320.1215854097845;7352.41180705553;7415.703371865065;7437.219091995263;7442.62786860644;7624.923750762643;7762.650680719494;7810.531368117931;7820.5307681537015;7955.4828936118965;8260.091389947222;8413.663453461793;8422.24199822019;8429.62066707012;8435;6807.693653785493;6931.7227310907;7004.649767511706;7005;7005.22942476317;6598.736050557924;6713;6851.109355783717;7116.786496405116;7119.537230080028;6805.6937437816405;6904.585724856323;6975.441964642715;7079.82300442493;7116.786496405116;6550.6069635822005;6586.637734924625;6593.835154121185;6696.062551242927;6698.531102822951;6858.2455929848675;6903.0335752993615;6916.55042422241;6931.757388491378;6949.861002779815;6335.366463353628;6385.13800636908;6429.4534964526665;6438.29178790342;6441.13044738973;6387.489000880011;6439;6439.613623182624;6440.774572889926;6551.672416379067 17:17:49 INFO - PROCESS | 3986 | |4;prototype.html;330.3129490659428;341.78125999360407;343.6151510308455;344.9724022078234;353.70995783457573;5673.404292549285;5789.450002249785;5811.27359080115;5811.767529298823;5818.912716309259;5677.517411020068;5750.511206547438;5765.682887441189;5792.391798861122;5799.391063938289;4528.50186479487;4531.954680453203;4535.274356103024;4536.047430039695;4549.499555048942;4311.978440107795;4353.62994145498;4380.97809510952;4390.560943905616;4537.591616754491;4318.179545886287;4348.869533913988;4415.161119387306;4437.29003359461;4466.307722303049;4471.2845944649025;4476.753778542179;4478.977605111986;4487.057717879249;4517.322401639747;3978.9801050994847;3980.3631418973114;3987.4218238355274;3987.6809855211513;3988.80055997199;5309.52214300711;5454.809081682122;5464.18037294409;5474.644148130398;5476.151196564539;5196.428392876781;5213.061648903196;5217.426083130853;5229.816956406507;5230.110881150175;6112.388761123896;6118.785842495536;6120.540959428016;6122.265328160604;6125.816225513242;4362;4396.098799746044;4410.536893626155;4412.977935110336;4419.889502762425;6144.815655530341;6185.474234690012;6310.526710496685;6479.157709497782;6486.610803351767;4397.494288156839;4477.865664030084;4490.57339552742;4524.5701658342405;4525.886852828706;4530.093981203772;4558.791920141165;4567.223571992769;4572.839950601713;4576.610988065985;5173.844784656466;5180.663256888291;5190.714510701948;5194.0650682876685;5196.58427325813;5983.341832398432;6137.508999280047;6156.415140561639;6192.040233763774;6192.752289908353;1556.5252597957506;1576.5743249322848;1576.842315768414;1576.8817338699414;1578.8894777365704;1035.0425856083243;1039.1478987230398;1053.9683809485728;1058.5871510111062;1074.1514203778927;5839.737211825478;5848.064309710426;5857.355690874;5859.091840764689;5861.501772349398;6318.052292156213;6321.051842223703;6324.33594472583;6328.11406403104;6332.8416789579705;5834.387389324144;5837.3870743571315;5838.2702162229725;5848;5848.888711144954;3311.072899588119;3412.078738740526;3417.9658203418144;3418.8803391881165;3420.6579342065593;6626.403623673892;6636.767713130017;6637.070810086591;6639.03733958583;6641.169853768279;6537.084808126866;6539.2479864815205;6543.280239173687;6544.476441884638;6552.3775241352;6453.645049522227;6602.60384376939;6698.330166983263;6717.764878229238;6721.529492935545;6367.808965731036;6368.012957991518;6370.904436433365;6371.23545174582;6373.776917807854;6331.176946997045;6342.175517182921;6347.079673447417;6348.9047664286;6351.2060992375955;6437.291897891322;6448.903266450913;6495.188101487314;6572.112764776694;6701.363370479797;4387.802548885244;4418.050119224382;4435.578620031092;4436.356728274447;4444.200043992112;6386.840328991627;6387.936120638734;6393.328700486568;6395.808125756234;6399;6084.60450070744;6195.16365290698;6198.969005154945;6218.284897236876;6225.315215326401;6165.691715414122;6205.627662340274;6219;6228.190335256388;6229.657368844576;6075.149479072845;6076.6961651916345;6080.939190608037;6081.5742897996715;6082.665453399928;6040.184575082308;6242.937570624235;6266;6269.811905642838;6270.059491076375;6098.786542470993;6109.572329936862;6110.052941794029;6116.26604807426;6117.26592808848 17:17:49 INFO - PROCESS | 3986 | |5;yui.html;814.8981377327832;825.9174082591742;854.1927878155142;863.2964134230598;869.0744357259518;12418.130730848832;12448.937755311234;12473.126881118325;12539.686507837287;12572.994160467175;11579.189456738031;12404.751904961895;12430.378481075955;12485.25088494691;12532.122751407405;650.2652003236336;809.4374409785172;824.8556502612049;825.145973916996;825.4593241426875;806.105223202245;811.3022800391658;812.2892469089546;812.634314558451;815.5840521334103;849.889514363135;860.1355637584219;860.7805009722512;860.8149247911698;861.0184389795638;682.6109117802854;697.5117417807504;833.4249367936166;854.5513605357206;859.5444414460346;623.4607064888884;624.3662682377391;624.6033768556954;625.0655270370779;625.5714835337808;12479.251244925243;12482.001439884787;12491.687707807378;12528.81206781899;12564.874351256462;12120.939395303056;12531.060170487159;12904.096713230078;13091.633505622143;13196.472141114344;10085.142762865165;10217;10286.897131028669;10337.844932326021;10450.895491045145;3561.6972557332656;3599.1182160370613;3624.58317293512;3644.0707619557106;3698.907527311812;48184.27723584149;48507.51492485065;49317.26024109641;49855.2521712171;49867.999999999636;10010.899891000996;10046.899531004743;10111.39331640104;10342.069213770797;10353.223508236912;18380.540486487946;18396.448106556825;18433.90783046076;18445.354412595763;18459.446216613524;7518.736844210426;7742.535447873146;7794.844103118019;7901.802454938673;8034.558099304594;4228.577142285747;4296.076343586144;4297.119090586422;4321.5678432157165;4351.36905148758;3035.2715348316246;3056.5567992640945;3064.831434271092;3068.094912000965;3074.769392295587;527.4277409011189;535.0716506860593;555.536127333681;557.3729554251468;557.8131326005753;617.6417677746896;618.4341327685207;619.6127420362274;700.6776882634045;704.3759855543202;7767.611619419006;8742.562871856382;9449.480278584744;9479.478628675352;9495.66765163216;531.824497915687;625.1997443272618;638.1863124516279;676.4453148418249;682.621145264383;3962.643362097425;3976.264391087658;4101.7744024078365;4152.667786577127;4212.115455754326;53596.19605705918;57181.14228286579;57297;57365.42634573684;57460;49780.253296200586;50269.49730502722;50629.240561391605;50784;50889.745551272004;45118.323225151646;45866.08267834625;45931.54068459273;46032.309515357294;46291.537084629395;7782.649780759993;8185.263326300662;8220.63007164667;8249.587520624065;8335.374846886387;33400.83299583486;33465.16337091592;34494.310113798085;34772.478412824334;35046.29907401888;43476.782616087985;43528.34707479454;44212.77893610511;44446.55553444424;45439.77280113711;10948.890511094787;11088.279261847954;11307.943460282646;11377.715557111138;11575.305481671126;12303.876961230273;12438.502459901865;12484.313362765135;12526.37368131608;12690.302033387883;11248.718782030515;11518.94240528792;11609.825852612048;11632.88367116352;11878.584249551224;11364.602238921598;11382.94308528452;11575.479103440197;11941.104417168573;11955.880441195477;11105.444727763741;11159.163062770487;11271.661850144508;11334.546618135182;11364.374959377314;9561.282903782105;9632.75918102053;9653.420794752337;9896.950515247665;10005.949970250102;9310.767230819283;9407.43555386679;9453.33826632129;9834.852477212704;10023.69928902134 17:17:49 INFO - PROCESS | 3986 | __end_tp_report 17:17:49 INFO - PROCESS | 3986 | __start_cc_report 17:17:49 INFO - PROCESS | 3986 | _x_x_mozilla_cycle_collect,924 17:17:49 INFO - PROCESS | 3986 | __end_cc_report 17:17:49 INFO - PROCESS | 3986 | __startTimestamp1453684669507__endTimestamp 17:17:49 INFO - PROCESS | 3986 | 17:17:49 INFO - PROCESS | 3986 | ------- Summary: start ------- 17:17:49 INFO - PROCESS | 3986 | Number of tests: 6 17:17:49 INFO - PROCESS | 3986 | 17:17:49 INFO - PROCESS | 3986 | [#0] dojo.html Cycles:165 Average:5084.15 Median:5264.63 stddev:552.16 (10.5%) stddev-sans-first:530.34 17:17:49 INFO - PROCESS | 3986 | Values: 3052.0 3065.2 3099.8 3116.2 3145.6 4918.3 4991.7 4996.4 5008.9 5030.3 5053.4 5101.5 5139.0 5208.9 5211.1 4647.4 4651.1 4665.8 4681.6 4761.5 4685.6 4719.2 4725.6 4735.6 4765.7 4651.6 4655.2 4658.8 4661.6 4729.7 4640.6 4644.9 4655.7 4663.3 4695.1 4633.0 4640.4 4646.3 4664.2 4681.6 4848.3 4867.4 4885.9 4922.4 4931.0 5469.6 5472.2 5473.8 5485.4 5502.2 5489.1 5491.4 5498.1 5499.9 5503.1 5140.3 5163.6 5175.7 5218.5 5224.6 5613.2 5613.7 5619.1 5619.6 5624.2 5417.0 5430.5 5434.2 5435.1 5437.5 5450.1 5471.3 5529.3 5533.4 5586.7 5348.6 5350.9 5357.2 5359.7 5376.5 5356.7 5361.0 5377.4 5391.6 5410.2 4180.1 4213.8 4244.1 4260.1 4287.8 3818.6 3823.5 3836.5 3869.5 3869.7 5012.5 5047.3 5072.5 5096.1 5143.5 5425.3 5464.7 5477.0 5511.3 5553.0 5076.9 5091.1 5091.4 5093.8 5122.8 4600.6 4681.2 4723.1 4724.7 4725.6 5668.9 5719.2 5750.5 5751.3 5786.0 5440.5 5452.4 5464.9 5465.2 5467.4 5517.0 5658.5 5681.8 5684.7 5713.5 5406.9 5408.9 5410.4 5411.3 5416.5 5481.0 5485.1 5485.9 5488.3 5541.2 5307.0 5372.5 5391.3 5415.2 5446.8 5326.4 5375.3 5375.9 5376.0 5376.2 5220.2 5249.3 5249.3 5251.6 5290.2 5264.6 5353.1 5363.5 5385.9 5455.4 5186.9 5255.7 5259.0 5266.5 5308.5 17:17:49 INFO - PROCESS | 3986 | 17:17:49 INFO - PROCESS | 3986 | [#1] ext.html Cycles:180 Average:46768.21 Median:19857.12 stddev:84727.73 (426.7%) stddev-sans-first:84894.24 17:17:49 INFO - PROCESS | 3986 | Values: 512.4 514.9 523.0 538.2 561.9 28393.0 28901.0 35573.3 36195.0 36200.1 38970.8 39080.0 39423.0 39453.0 39472.4 8426.5 8593.7 8600.4 8600.8 8603.3 8337.3 8412.0 8447.5 8454.9 8468.7 8688.4 8696.2 8737.4 8749.1 8761.3 8630.3 8703.5 8705.0 8721.7 8728.3 8573.1 8701.8 8704.1 8708.9 8713.6 39320.0 39783.8 39787.8 39825.2 39830.6 3282.9 3358.9 3559.2 3758.0 3851.4 30026.2 30284.8 30494.8 31720.4 31954.8 3858.5 3895.0 3963.4 4044.6 4071.5 273355.0 275083.0 275357.0 275779.6 276007.0 41318.8 41946.0 52298.7 53194.7 58741.8 40327.4 40508.6 40532.8 40635.8 40658.4 13530.7 13609.6 14007.4 14127.4 14190.1 9662.7 10027.3 11432.8 11509.2 11530.8 13925.1 13936.1 13963.0 13989.2 14087.7 5600.0 5611.6 5613.6 5642.5 5734.6 939.9 1005.6 1012.6 1055.9 1073.8 28707.0 28735.4 29105.6 29263.1 30383.2 1022.1 1042.7 1068.0 1090.5 1120.8 14840.5 15084.5 15425.9 15475.1 15970.0 382963.0 388025.0 389916.0 390252.0 391074.0 55342.7 55988.4 56120.7 56169.2 56305.0 1321.3 1343.9 1347.2 1354.5 1357.1 29799.7 30406.4 30582.8 30830.7 31099.5 44452.3 45266.8 45371.3 45459.5 45495.5 253774.0 254401.0 255157.0 307261.0 364949.0 28696.7 31005.4 31493.2 31697.2 31936.8 36219.8 37105.6 37410.0 37501.8 40041.8 32532.2 34333.5 34913.5 35152.6 35401.0 28593.7 32674.3 33705.8 33706.7 36155.0 31142.8 31480.0 31838.8 31904.2 32083.4 28557.6 29256.3 29873.9 35007.0 36308.6 23699.3 25270.1 25435.4 25581.1 26025.9 17:17:49 INFO - PROCESS | 3986 | 17:17:49 INFO - PROCESS | 3986 | [#2] jquery.html Cycles:180 Average:21532.22 Median:5364.70 stddev:57565.61 (1073.0%) stddev-sans-first:57705.14 17:17:49 INFO - PROCESS | 3986 | Values: 361.1 362.9 364.5 365.4 373.5 12808.4 13069.9 15264.5 16254.9 17277.2 14188.3 15134.3 15401.8 15425.3 16439.9 5289.7 5498.1 5501.7 5503.2 5518.5 3993.6 4130.7 5384.2 5505.2 5717.4 5818.4 6002.4 6053.3 6053.4 6062.9 5878.0 6059.3 6091.8 6119.7 6145.5 5179.9 5335.7 5354.6 5356.9 5372.5 19442.8 19572.7 19838.4 20408.2 20431.7 2228.8 2310.4 2310.8 2343.1 2349.7 12915.0 12987.2 13055.5 13121.7 13491.8 1793.8 1828.4 1831.3 1848.7 1859.0 53827.0 55602.2 56903.4 56908.4 57163.0 9711.1 9933.4 9951.3 9973.2 10016.2 12939.4 13082.1 13108.9 13124.1 13134.1 7269.9 7414.4 7423.8 7456.4 7464.2 6984.4 6990.8 7051.2 7081.0 7089.3 5916.9 6003.9 6005.9 6008.6 6033.8 1603.7 1711.9 1717.7 1792.4 1806.2 948.6 967.1 971.9 979.9 999.2 14005.4 16741.0 17204.2 17423.8 17497.7 912.9 951.1 957.6 963.5 1036.7 9616.5 9783.5 9884.3 9909.6 9994.8 332811.0 335576.0 360119.0 364262.0 369015.0 42035.4 42546.4 46784.3 54837.4 66164.7 1117.7 1136.5 1146.2 1151.7 1155.2 13892.4 15784.2 15980.3 16264.3 16370.6 30028.7 30464.5 30550.7 30731.1 30861.2 37394.6 37625.0 37816.0 37821.4 39691.8 7088.9 7096.9 7354.9 7378.6 7569.0 8335.8 10086.9 10325.7 10388.1 10501.6 9112.1 9298.7 9405.7 9501.2 9577.4 8784.7 9141.1 9569.4 9683.9 9721.1 8341.1 8881.6 8956.0 9202.4 9271.9 7354.2 7511.0 7663.2 7680.6 7763.6 8787.1 9262.2 9293.6 9387.3 9445.2 17:17:49 INFO - PROCESS | 3986 | 17:17:49 INFO - PROCESS | 3986 | [#3] mootools.html Cycles:180 Average:5454.50 Median:6386.31 stddev:2840.93 (44.5%) stddev-sans-first:2831.70 17:17:49 INFO - PROCESS | 3986 | Values: 1296.1 1464.9 1497.3 1649.2 1782.8 6906.9 7364.7 7516.7 7527.4 7529.0 7593.5 7786.6 7792.7 7809.0 7810.5 1950.6 2000.8 2225.5 2238.4 2263.5 2232.8 2242.3 2244.6 2245.2 2245.5 2140.4 2209.5 2210.6 2212.4 2212.6 2198.8 2199.7 2209.0 2251.3 2253.8 2193.9 2205.2 2219.0 2221.4 2225.4 7822.0 7933.8 7935.4 7935.8 7942.4 4704.9 4849.4 4853.8 4854.8 4861.7 3036.2 3096.6 3101.3 3145.2 3146.2 988.8 1003.7 1008.0 1076.6 1077.3 10877.6 10916.9 10918.6 10928.6 10928.7 4217.2 4346.2 4364.7 4375.5 4409.1 9356.0 9376.2 9378.6 9394.0 9406.6 4831.1 4858.0 4858.1 4860.6 4861.6 4372.8 4424.6 4426.6 4426.8 4430.4 3432.5 3478.5 3638.7 3653.7 3690.3 1168.6 1179.3 1182.6 1195.9 1210.3 1112.3 1127.8 1129.6 1287.5 1367.3 7296.3 7296.5 7335.9 7354.5 7530.7 1105.6 1111.9 1116.9 1134.4 1137.1 5828.8 5897.9 5909.6 5914.4 5915.1 9379.0 9548.7 9697.4 9837.9 9839.2 9732.6 9741.0 9742.7 9749.2 9751.7 7141.1 7319.7 7430.1 7435.9 7513.7 7320.1 7352.4 7415.7 7437.2 7442.6 7624.9 7762.7 7810.5 7820.5 7955.5 8260.1 8413.7 8422.2 8429.6 8435.0 6807.7 6931.7 7004.6 7005.0 7005.2 6598.7 6713.0 6851.1 7116.8 7119.5 6805.7 6904.6 6975.4 7079.8 7116.8 6550.6 6586.6 6593.8 6696.1 6698.5 6858.2 6903.0 6916.6 6931.8 6949.9 6335.4 6385.1 6429.5 6438.3 6441.1 6387.5 6439.0 6439.6 6440.8 6551.7 17:17:49 INFO - PROCESS | 3986 | 17:17:49 INFO - PROCESS | 3986 | [#4] prototype.html Cycles:180 Average:5173.95 Median:5835.89 stddev:1544.14 (26.5%) stddev-sans-first:1505.07 17:17:49 INFO - PROCESS | 3986 | Values: 330.3 341.8 343.6 345.0 353.7 5673.4 5789.5 5811.3 5811.8 5818.9 5677.5 5750.5 5765.7 5792.4 5799.4 4528.5 4532.0 4535.3 4536.0 4549.5 4312.0 4353.6 4381.0 4390.6 4537.6 4318.2 4348.9 4415.2 4437.3 4466.3 4471.3 4476.8 4479.0 4487.1 4517.3 3979.0 3980.4 3987.4 3987.7 3988.8 5309.5 5454.8 5464.2 5474.6 5476.2 5196.4 5213.1 5217.4 5229.8 5230.1 6112.4 6118.8 6120.5 6122.3 6125.8 4362.0 4396.1 4410.5 4413.0 4419.9 6144.8 6185.5 6310.5 6479.2 6486.6 4397.5 4477.9 4490.6 4524.6 4525.9 4530.1 4558.8 4567.2 4572.8 4576.6 5173.8 5180.7 5190.7 5194.1 5196.6 5983.3 6137.5 6156.4 6192.0 6192.8 1556.5 1576.6 1576.8 1576.9 1578.9 1035.0 1039.1 1054.0 1058.6 1074.2 5839.7 5848.1 5857.4 5859.1 5861.5 6318.1 6321.1 6324.3 6328.1 6332.8 5834.4 5837.4 5838.3 5848.0 5848.9 3311.1 3412.1 3418.0 3418.9 3420.7 6626.4 6636.8 6637.1 6639.0 6641.2 6537.1 6539.2 6543.3 6544.5 6552.4 6453.6 6602.6 6698.3 6717.8 6721.5 6367.8 6368.0 6370.9 6371.2 6373.8 6331.2 6342.2 6347.1 6348.9 6351.2 6437.3 6448.9 6495.2 6572.1 6701.4 4387.8 4418.1 4435.6 4436.4 4444.2 6386.8 6387.9 6393.3 6395.8 6399.0 6084.6 6195.2 6199.0 6218.3 6225.3 6165.7 6205.6 6219.0 6228.2 6229.7 6075.1 6076.7 6080.9 6081.6 6082.7 6040.2 6242.9 6266.0 6269.8 6270.1 6098.8 6109.6 6110.1 6116.3 6117.3 17:17:49 INFO - PROCESS | 3986 | 17:17:49 INFO - PROCESS | 3986 | [#5] yui.html Cycles:180 Average:13709.71 Median:44782.44 stddev:15806.15 (35.3%) stddev-sans-first:15820.83 17:17:49 INFO - PROCESS | 3986 | Values: 814.9 825.9 854.2 863.3 869.1 12418.1 12448.9 12473.1 12539.7 12573.0 11579.2 12404.8 12430.4 12485.3 12532.1 650.3 809.4 824.9 825.1 825.5 806.1 811.3 812.3 812.6 815.6 849.9 860.1 860.8 860.8 861.0 682.6 697.5 833.4 854.6 859.5 623.5 624.4 624.6 625.1 625.6 12479.3 12482.0 12491.7 12528.8 12564.9 12120.9 12531.1 12904.1 13091.6 13196.5 10085.1 10217.0 10286.9 10337.8 10450.9 3561.7 3599.1 3624.6 3644.1 3698.9 48184.3 48507.5 49317.3 49855.3 49868.0 10010.9 10046.9 10111.4 10342.1 10353.2 18380.5 18396.4 18433.9 18445.4 18459.4 7518.7 7742.5 7794.8 7901.8 8034.6 4228.6 4296.1 4297.1 4321.6 4351.4 3035.3 3056.6 3064.8 3068.1 3074.8 527.4 535.1 555.5 557.4 557.8 617.6 618.4 619.6 700.7 704.4 7767.6 8742.6 9449.5 9479.5 9495.7 531.8 625.2 638.2 676.4 682.6 3962.6 3976.3 4101.8 4152.7 4212.1 53596.2 57181.1 57297.0 57365.4 57460.0 49780.3 50269.5 50629.2 50784.0 50889.7 45118.3 45866.1 45931.5 46032.3 46291.5 7782.6 8185.3 8220.6 8249.6 8335.4 33400.8 33465.2 34494.3 34772.5 35046.3 43476.8 43528.3 44212.8 44446.6 45439.8 10948.9 11088.3 11307.9 11377.7 11575.3 12303.9 12438.5 12484.3 12526.4 12690.3 11248.7 11518.9 11609.8 11632.9 11878.6 11364.6 11382.9 11575.5 11941.1 11955.9 11105.4 11159.2 11271.7 11334.5 11364.4 9561.3 9632.8 9653.4 9897.0 10005.9 9310.8 9407.4 9453.3 9834.9 10023.7 17:17:49 INFO - PROCESS | 3986 | -------- Summary: end -------- 17:17:49 INFO - PROCESS | 3986 | 17:17:50 INFO - TEST-INFO | 3986: exit 0 17:17:50 INFO - TEST-OK | dromaeo_css | took 1113009ms 17:17:50 INFO - TEST-START | kraken 17:17:50 INFO - operating with platform_type : linux_ 17:17:50 INFO - Initialising browser for kraken test... 17:17:50 INFO - TEST-INFO | started process 4190 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMr4bqF/profile http://localhost:36064/getInfo.html) 17:17:54 INFO - PROCESS | 4190 | __metrics Screen width/height:1600/1200 17:17:54 INFO - PROCESS | 4190 | colorDepth:24 17:17:54 INFO - PROCESS | 4190 | Browser inner width/height: 1024/697 17:17:54 INFO - PROCESS | 4190 | __metrics 17:17:54 INFO - PROCESS | 4190 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:17:54 INFO - PROCESS | 4190 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:17:55 INFO - TEST-INFO | 4190: exit 0 17:17:55 INFO - Browser initialized. 17:17:55 INFO - Running cycle 1/1 for kraken test... 17:17:55 INFO - TEST-INFO | started process 4271 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMr4bqF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:07 INFO - PROCESS | 4271 | RSS: Main: 148271104 17:18:07 INFO - PROCESS | 4271 | 17:18:09 INFO - PROCESS | 4271 | Cycle 1(1): loaded http://localhost:36064/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36064/tests/kraken/driver.html?testName=audio-beat-detection) 17:18:10 INFO - PROCESS | 4271 | RSS: Main: 190808064 17:18:10 INFO - PROCESS | 4271 | 17:18:13 INFO - PROCESS | 4271 | Cycle 1(1): loaded http://localhost:36064/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36064/tests/kraken/driver.html?testName=audio-dft) 17:18:13 INFO - PROCESS | 4271 | RSS: Main: 180441088 17:18:13 INFO - PROCESS | 4271 | 17:18:16 INFO - PROCESS | 4271 | Cycle 1(1): loaded http://localhost:36064/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36064/tests/kraken/driver.html?testName=audio-fft) 17:18:17 INFO - PROCESS | 4271 | RSS: Main: 163512320 17:18:17 INFO - PROCESS | 4271 | 17:18:19 INFO - PROCESS | 4271 | Cycle 1(1): loaded http://localhost:36064/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36064/tests/kraken/driver.html?testName=audio-oscillator) 17:18:19 INFO - PROCESS | 4271 | RSS: Main: 164761600 17:18:19 INFO - PROCESS | 4271 | 17:18:22 INFO - PROCESS | 4271 | Cycle 1(1): loaded http://localhost:36064/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36064/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:18:22 INFO - PROCESS | 4271 | RSS: Main: 168517632 17:18:22 INFO - PROCESS | 4271 | 17:18:25 INFO - PROCESS | 4271 | Cycle 1(1): loaded http://localhost:36064/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36064/tests/kraken/driver.html?testName=imaging-darkroom) 17:18:26 INFO - PROCESS | 4271 | RSS: Main: 168079360 17:18:26 INFO - PROCESS | 4271 | 17:18:29 INFO - PROCESS | 4271 | Cycle 1(1): loaded http://localhost:36064/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36064/tests/kraken/driver.html?testName=imaging-desaturate) 17:18:30 INFO - PROCESS | 4271 | RSS: Main: 169259008 17:18:30 INFO - PROCESS | 4271 | 17:18:32 INFO - PROCESS | 4271 | Cycle 1(1): loaded http://localhost:36064/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36064/tests/kraken/driver.html?testName=json-parse-financial) 17:18:33 INFO - PROCESS | 4271 | RSS: Main: 167710720 17:18:33 INFO - PROCESS | 4271 | 17:18:35 INFO - PROCESS | 4271 | Cycle 1(1): loaded http://localhost:36064/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36064/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:18:35 INFO - PROCESS | 4271 | RSS: Main: 180760576 17:18:35 INFO - PROCESS | 4271 | 17:18:37 INFO - PROCESS | 4271 | Cycle 1(1): loaded http://localhost:36064/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36064/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:18:38 INFO - PROCESS | 4271 | RSS: Main: 179359744 17:18:38 INFO - PROCESS | 4271 | 17:18:40 INFO - PROCESS | 4271 | Cycle 1(1): loaded http://localhost:36064/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36064/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:18:40 INFO - PROCESS | 4271 | RSS: Main: 188325888 17:18:40 INFO - PROCESS | 4271 | 17:18:43 INFO - PROCESS | 4271 | Cycle 1(1): loaded http://localhost:36064/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:18:43 INFO - PROCESS | 4271 | RSS: Main: 193753088 17:18:43 INFO - PROCESS | 4271 | 17:18:46 INFO - PROCESS | 4271 | Cycle 1(1): loaded http://localhost:36064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:18:46 INFO - PROCESS | 4271 | RSS: Main: 194269184 17:18:46 INFO - PROCESS | 4271 | 17:18:48 INFO - PROCESS | 4271 | Cycle 1(1): loaded http://localhost:36064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36064/tests/kraken/driver.html?testName=ai-astar) 17:18:48 INFO - PROCESS | 4271 | RSS: Main: 254246912 17:18:48 INFO - PROCESS | 4271 | 17:18:48 INFO - PROCESS | 4271 | __start_tp_report 17:18:48 INFO - PROCESS | 4271 | _x_x_mozilla_page_load 17:18:48 INFO - PROCESS | 4271 | _x_x_mozilla_page_load_details 17:18:48 INFO - PROCESS | 4271 | |i|pagename|runs| 17:18:48 INFO - PROCESS | 4271 | |0;ai-astar;112;112;108;110;118;112;110;121;103;109 17:18:48 INFO - PROCESS | 4271 | |1;audio-beat-detection;156;134;149;163;132;154;165;138;170;124 17:18:48 INFO - PROCESS | 4271 | |2;audio-dft;161;159;161;162;162;162;163;159;162;161 17:18:48 INFO - PROCESS | 4271 | |3;audio-fft;73;73;90;100;73;73;72;114;91;73 17:18:48 INFO - PROCESS | 4271 | |4;audio-oscillator;97;96;139;95;96;95;145;95;96;139 17:18:48 INFO - PROCESS | 4271 | |5;imaging-gaussian-blur;109;109;110;109;109;109;109;109;109;109 17:18:48 INFO - PROCESS | 4271 | |6;imaging-darkroom;145;146;145;145;145;145;145;145;145;144 17:18:48 INFO - PROCESS | 4271 | |7;imaging-desaturate;96;96;96;96;97;97;96;95;96;96 17:18:48 INFO - PROCESS | 4271 | |8;json-parse-financial;55;54;55;54;54;54;56;55;60;53 17:18:48 INFO - PROCESS | 4271 | |9;json-stringify-tinderbox;68;69;68;67;69;68;68;67;68;69 17:18:48 INFO - PROCESS | 4271 | |10;stanford-crypto-aes;81;82;84;84;82;83;83;93;83;83 17:18:48 INFO - PROCESS | 4271 | |11;stanford-crypto-ccm;112;116;118;113;112;120;123;121;118;123 17:18:48 INFO - PROCESS | 4271 | |12;stanford-crypto-pbkdf2;143;132;145;142;138;130;139;154;141;142 17:18:48 INFO - PROCESS | 4271 | |13;stanford-crypto-sha256-iterative;70;66;70;67;66;67;68;66;67;68 17:18:48 INFO - PROCESS | 4271 | __end_tp_report 17:18:48 INFO - PROCESS | 4271 | __start_cc_report 17:18:48 INFO - PROCESS | 4271 | _x_x_mozilla_cycle_collect,923 17:18:48 INFO - PROCESS | 4271 | __end_cc_report 17:18:48 INFO - PROCESS | 4271 | __startTimestamp1453684728561__endTimestamp 17:18:48 INFO - PROCESS | 4271 | 17:18:48 INFO - PROCESS | 4271 | ------- Summary: start ------- 17:18:48 INFO - PROCESS | 4271 | Number of tests: 14 17:18:48 INFO - PROCESS | 4271 | 17:18:48 INFO - PROCESS | 4271 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:5.04 (4.5%) stddev-sans-first:5.34 17:18:48 INFO - PROCESS | 4271 | Values: 112.0 112.0 108.0 110.0 118.0 112.0 110.0 121.0 103.0 109.0 17:18:48 INFO - PROCESS | 4271 | 17:18:48 INFO - PROCESS | 4271 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:155.00 stddev:15.72 (10.1%) stddev-sans-first:16.44 17:18:48 INFO - PROCESS | 4271 | Values: 156.0 134.0 149.0 163.0 132.0 154.0 165.0 138.0 170.0 124.0 17:18:48 INFO - PROCESS | 4271 | 17:18:48 INFO - PROCESS | 4271 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.32 (0.8%) stddev-sans-first:1.39 17:18:48 INFO - PROCESS | 4271 | Values: 161.0 159.0 161.0 162.0 162.0 162.0 163.0 159.0 162.0 161.0 17:18:48 INFO - PROCESS | 4271 | 17:18:48 INFO - PROCESS | 4271 | [#3] audio-fft Cycles:10 Average:83.20 Median:73.00 stddev:14.85 (20.3%) stddev-sans-first:15.28 17:18:48 INFO - PROCESS | 4271 | Values: 73.0 73.0 90.0 100.0 73.0 73.0 72.0 114.0 91.0 73.0 17:18:48 INFO - PROCESS | 4271 | 17:18:48 INFO - PROCESS | 4271 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:95.50 stddev:21.94 (23.0%) stddev-sans-first:22.82 17:18:48 INFO - PROCESS | 4271 | Values: 97.0 96.0 139.0 95.0 96.0 95.0 145.0 95.0 96.0 139.0 17:18:48 INFO - PROCESS | 4271 | 17:18:48 INFO - PROCESS | 4271 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:18:48 INFO - PROCESS | 4271 | Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 17:18:48 INFO - PROCESS | 4271 | 17:18:48 INFO - PROCESS | 4271 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 17:18:48 INFO - PROCESS | 4271 | Values: 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 144.0 17:18:48 INFO - PROCESS | 4271 | 17:18:48 INFO - PROCESS | 4271 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 17:18:48 INFO - PROCESS | 4271 | Values: 96.0 96.0 96.0 96.0 97.0 97.0 96.0 95.0 96.0 96.0 17:18:48 INFO - PROCESS | 4271 | 17:18:48 INFO - PROCESS | 4271 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.94 (3.5%) stddev-sans-first:2.06 17:18:48 INFO - PROCESS | 4271 | Values: 55.0 54.0 55.0 54.0 54.0 54.0 56.0 55.0 60.0 53.0 17:18:48 INFO - PROCESS | 4271 | 17:18:48 INFO - PROCESS | 4271 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 17:18:48 INFO - PROCESS | 4271 | Values: 68.0 69.0 68.0 67.0 69.0 68.0 68.0 67.0 68.0 69.0 17:18:48 INFO - PROCESS | 4271 | 17:18:48 INFO - PROCESS | 4271 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.00 stddev:3.36 (4.0%) stddev-sans-first:3.41 17:18:48 INFO - PROCESS | 4271 | Values: 81.0 82.0 84.0 84.0 82.0 83.0 83.0 93.0 83.0 83.0 17:18:48 INFO - PROCESS | 4271 | 17:18:48 INFO - PROCESS | 4271 | [#11] stanford-crypto-ccm Cycles:10 Average:117.60 Median:119.00 stddev:4.25 (3.6%) stddev-sans-first:3.99 17:18:48 INFO - PROCESS | 4271 | Values: 112.0 116.0 118.0 113.0 112.0 120.0 123.0 121.0 118.0 123.0 17:18:48 INFO - PROCESS | 4271 | 17:18:48 INFO - PROCESS | 4271 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.60 Median:142.00 stddev:6.70 (4.7%) stddev-sans-first:7.05 17:18:48 INFO - PROCESS | 4271 | Values: 143.0 132.0 145.0 142.0 138.0 130.0 139.0 154.0 141.0 142.0 17:18:48 INFO - PROCESS | 4271 | 17:18:48 INFO - PROCESS | 4271 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.51 (2.2%) stddev-sans-first:1.30 17:18:48 INFO - PROCESS | 4271 | Values: 70.0 66.0 70.0 67.0 66.0 67.0 68.0 66.0 67.0 68.0 17:18:48 INFO - PROCESS | 4271 | -------- Summary: end -------- 17:18:48 INFO - PROCESS | 4271 | 17:18:49 INFO - TEST-INFO | 4271: exit 0 17:18:49 INFO - TEST-OK | kraken | took 59252ms 17:18:49 INFO - TEST-START | v8_7 17:18:49 INFO - operating with platform_type : linux_ 17:18:49 INFO - Initialising browser for v8_7 test... 17:18:49 INFO - TEST-INFO | started process 4520 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpebc7ag/profile http://localhost:36064/getInfo.html) 17:18:53 INFO - PROCESS | 4520 | __metrics Screen width/height:1600/1200 17:18:53 INFO - PROCESS | 4520 | colorDepth:24 17:18:53 INFO - PROCESS | 4520 | Browser inner width/height: 1024/697 17:18:53 INFO - PROCESS | 4520 | __metrics 17:18:53 INFO - PROCESS | 4520 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:18:53 INFO - PROCESS | 4520 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:18:54 INFO - TEST-INFO | 4520: exit 0 17:18:54 INFO - Browser initialized. 17:18:54 INFO - Running cycle 1/1 for v8_7 test... 17:18:54 INFO - TEST-INFO | started process 4599 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpebc7ag/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:06 INFO - PROCESS | 4599 | RSS: Main: 148430848 17:19:06 INFO - PROCESS | 4599 | 17:19:29 INFO - PROCESS | 4599 | Cycle 1(1): loaded http://localhost:36064/tests/v8_7/run.html (next: http://localhost:36064/tests/v8_7/run.html) 17:19:29 INFO - PROCESS | 4599 | RSS: Main: 561950720 17:19:29 INFO - PROCESS | 4599 | 17:19:29 INFO - PROCESS | 4599 | __start_tp_report 17:19:29 INFO - PROCESS | 4599 | _x_x_mozilla_page_load 17:19:29 INFO - PROCESS | 4599 | _x_x_mozilla_page_load_details 17:19:29 INFO - PROCESS | 4599 | |i|pagename|runs| 17:19:29 INFO - PROCESS | 4599 | |0;Richards;166.47244880972198 17:19:29 INFO - PROCESS | 4599 | |1;DeltaBlue;189.10741301059002 17:19:29 INFO - PROCESS | 4599 | |2;Encrypt;280.50490883590464 17:19:29 INFO - PROCESS | 4599 | |3;Decrypt;5181.347150259067 17:19:29 INFO - PROCESS | 4599 | |4;RayTrace;1112.3470522803113 17:19:29 INFO - PROCESS | 4599 | |5;Earley;771.1864406779661 17:19:29 INFO - PROCESS | 4599 | |6;Boyer;12059.52380952381 17:19:29 INFO - PROCESS | 4599 | |7;RegExp;42244.897959183676 17:19:29 INFO - PROCESS | 4599 | |8;Splay;596.6587112171837 17:19:29 INFO - PROCESS | 4599 | |9;NavierStokes;4817.307692307692 17:19:29 INFO - PROCESS | 4599 | __end_tp_report 17:19:29 INFO - PROCESS | 4599 | __startTimestamp1453684769421__endTimestamp 17:19:29 INFO - PROCESS | 4599 | 17:19:29 INFO - PROCESS | 4599 | ------- Summary: start ------- 17:19:29 INFO - PROCESS | 4599 | Number of tests: 10 17:19:29 INFO - PROCESS | 4599 | 17:19:29 INFO - PROCESS | 4599 | [#0] Richards Cycles:1 Average:166.47 Median:166.47 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 4599 | Values: 166.5 17:19:29 INFO - PROCESS | 4599 | 17:19:29 INFO - PROCESS | 4599 | [#1] DeltaBlue Cycles:1 Average:189.11 Median:189.11 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 4599 | Values: 189.1 17:19:29 INFO - PROCESS | 4599 | 17:19:29 INFO - PROCESS | 4599 | [#2] Encrypt Cycles:1 Average:280.50 Median:280.50 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 4599 | Values: 280.5 17:19:29 INFO - PROCESS | 4599 | 17:19:29 INFO - PROCESS | 4599 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 4599 | Values: 5181.3 17:19:29 INFO - PROCESS | 4599 | 17:19:29 INFO - PROCESS | 4599 | [#4] RayTrace Cycles:1 Average:1112.35 Median:1112.35 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 4599 | Values: 1112.3 17:19:29 INFO - PROCESS | 4599 | 17:19:29 INFO - PROCESS | 4599 | [#5] Earley Cycles:1 Average:771.19 Median:771.19 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 4599 | Values: 771.2 17:19:29 INFO - PROCESS | 4599 | 17:19:29 INFO - PROCESS | 4599 | [#6] Boyer Cycles:1 Average:12059.52 Median:12059.52 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 4599 | Values: 12059.5 17:19:29 INFO - PROCESS | 4599 | 17:19:29 INFO - PROCESS | 4599 | [#7] RegExp Cycles:1 Average:42244.90 Median:42244.90 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 4599 | Values: 42244.9 17:19:29 INFO - PROCESS | 4599 | 17:19:29 INFO - PROCESS | 4599 | [#8] Splay Cycles:1 Average:596.66 Median:596.66 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 4599 | Values: 596.7 17:19:29 INFO - PROCESS | 4599 | 17:19:29 INFO - PROCESS | 4599 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 4599 | Values: 4817.3 17:19:29 INFO - PROCESS | 4599 | -------- Summary: end -------- 17:19:29 INFO - PROCESS | 4599 | 17:19:30 INFO - TEST-INFO | 4599: exit 0 17:19:30 INFO - TEST-OK | v8_7 | took 40824ms 17:19:30 INFO - SUITE-END | took 1213s 17:19:30 INFO - Completed test suite (00:20:13) 17:19:30 INFO - Working with test: dromaeo_css 17:19:30 INFO - Generating results file: dromaeo_css 17:19:30 INFO - Working with test: kraken 17:19:30 INFO - Generating results file: kraken 17:19:30 INFO - javascript benchmark 17:19:30 INFO - Working with test: v8_7 17:19:30 INFO - Generating results file: v8_7 17:19:30 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:19:30 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:19:30 INFO - process_Request line: dromaeo_css 6747.12 graph.html#tests=[[72,64,35]] 17:19:30 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:19:30 INFO - process_Request line: kraken 1496.50 graph.html#tests=[[232,64,35]] 17:19:30 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:19:30 INFO - process_Request line: v8_7 20144.89 graph.html#tests=[[230,64,35]] 17:19:30 INFO - RETURN: dromaeo_css: 6747.12 17:19:30 INFO - RETURN: kraken: 1496.50 17:19:30 INFO - RETURN: v8_7: 20144.89 17:19:30 INFO - javascript benchmark 17:19:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3051.984740076299, 3065.1724034510667, 3099.752019838413, 3116.2053676312553, 3145.5910731604886, 4918.336024636673, 4991.700497970124, 4996.425411077723, 5008.899822003557, 5030.320906677597, 5053.418856831466, 5101.51535604117, 5139.0, 5208.947910520894, 5211.114110601197, 4647.372604698373, 4651.139539185253, 4665.790039448233, 4681.648876334271, 4761.47623761386, 4685.601723853477, 4719.1977363848055, 4725.645576581753, 4735.573798358147, 4765.666403351766, 4651.558101980307, 4655.185342565038, 4658.790354434059, 4661.557152070548, 4729.668923175379, 4640.628749700016, 4644.883877903046, 4655.720656760605, 4663.323818046364, 4695.060987802453, 4632.953670463286, 4640.396748422717, 4646.3495110684535, 4664.183767840615, 4681.625469962395, 4848.2727590861305, 4867.440244371872, 4885.902281954341, 4922.360093187898, 4930.950690493121, 5469.56243500519, 5472.151816468454, 5473.781048758045, 5485.396606373296, 5502.174673798922, 5489.094299440588, 5491.36849262332, 5498.065328894098, 5499.917501237484, 5503.147012213073, 5140.280360749498, 5163.561097306733, 5175.689458632494, 5218.504242096995, 5224.555912747421, 5613.242212301287, 5613.7193140342815, 5619.100943849046, 5619.606627536034, 5624.184493248456, 5417.0, 5430.538404235605, 5434.184872269191, 5435.130379139318, 5437.45625437461, 5450.1007333789485, 5471.343438787371, 5529.336479622471, 5533.418991005887, 5586.748596313176, 5348.572114230852, 5350.91973620396, 5357.249985002103, 5359.678419294777, 5376.462353764592, 5356.651817631841, 5361.0, 5377.3816011159215, 5391.622586418992, 5410.215518749759, 4180.122174343361, 4213.831446742096, 4244.10873716523, 4260.147970405931, 4287.828486860491, 3818.5608655004476, 3823.502944617182, 3836.462895194675, 3869.496965394537, 3869.729118961646, 5012.54887060159, 5047.268146118792, 5072.492750724898, 5096.133657278272, 5143.5113664201845, 5425.26758887553, 5464.726763661881, 5476.972615136979, 5511.311086114236, 5553.0, 5076.873078173076, 5091.0581542414775, 5091.363579552556, 5093.847184584469, 5122.769475373542, 4600.631949444037, 4681.227597446383, 4723.102610503994, 4724.669273150916, 4725.5746982771025, 5668.886622267614, 5719.170720245541, 5750.5112065474905, 5751.309842818805, 5786.0, 5440.455954404528, 5452.372977107525, 5464.863378415413, 5465.180222966586, 5467.398586155599, 5516.972415137899, 5658.547316214611, 5681.829545113653, 5684.687342196054, 5713.457221563945, 5406.891862162814, 5408.891822163613, 5410.3778065522965, 5411.2965314508865, 5416.458354164552, 5481.040817856939, 5485.122380419114, 5485.945140548543, 5488.313960754906, 5541.168824676331, 5307.01820163271, 5372.489613486712, 5391.299131113087, 5415.160650099241, 5446.809361672323, 5326.360836699466, 5375.3280839895015, 5375.892482150413, 5375.951689420682, 5376.166694162411, 5220.243064755665, 5249.317588713443, 5249.343832020997, 5251.553617942518, 5290.153575427913, 5264.63147579681, 5353.089974704231, 5363.5440987516495, 5385.919211211756, 5455.399906010415, 5186.8962620748125, 5255.737213139251, 5258.97370513145, 5266.473352664703, 5308.46915308466], "unit": "score", "name": "dojo.html", "value": 5049.280661406891}, {"lowerIsBetter": false, "replicates": [512.3723438787486, 514.9201873709575, 522.9712365819884, 538.1953978801693, 561.9157126431037, 28393.0, 28901.0, 35573.2885342293, 36195.0, 36200.09499762507, 38970.80514597423, 39080.0, 39423.0, 39453.0, 39472.407913881245, 8426.452280601772, 8593.656253749843, 8600.354973377021, 8600.827983440327, 8603.268722158593, 8337.333013358948, 8411.95794021032, 8447.450915690491, 8454.87317690235, 8468.745937621881, 8688.435251708619, 8696.17386348299, 8737.388382813206, 8749.081346458626, 8761.342899282547, 8630.309575233967, 8703.477791332509, 8705.0, 8721.738347849574, 8728.258098061673, 8573.099824518398, 8701.825963480695, 8704.086070962521, 8708.912910870937, 8713.56432178395, 39320.0, 39783.80108099441, 39787.80106099451, 39825.20349593021, 39830.60169398298, 3282.868685252587, 3358.8824391146436, 3559.2347645256395, 3757.9624203757885, 3851.441540976543, 30026.24934376658, 30284.8485757572, 30494.847525762452, 31720.36559268825, 31954.840225798955, 3858.498395208605, 3894.9805250973845, 3963.4451176835264, 4044.615761502682, 4071.470708807836, 273355.0, 275083.0, 275357.0, 275779.62110189523, 276007.0, 41318.79340603338, 41946.0, 52298.73850630722, 53194.73402632962, 58741.82516349649, 40327.39508907369, 40508.59491405048, 40532.79733601313, 40635.796821016294, 40658.39012414816, 13530.661733456545, 13609.591712248648, 14007.369668364949, 14127.364268607937, 14190.148591084362, 9662.71011869645, 10027.29808913369, 11432.828507572392, 11509.194356394972, 11530.827037594443, 13925.094868833494, 13936.094153879965, 13963.0, 13989.230592317317, 14087.718245635235, 5600.0439610943795, 5611.6071874969175, 5613.607047506635, 5642.520385767174, 5734.569907256972, 939.9201067909167, 1005.5726316315537, 1012.6202673997251, 1055.9155267578576, 1073.8335557988523, 28707.0, 28735.42529149447, 29105.563416548768, 29263.122106336843, 30383.24041898926, 1022.1260821997085, 1042.6794182424296, 1067.996083681337, 1090.5038207615517, 1120.798256313855, 14840.480583179537, 15084.472043478425, 15425.922870385577, 15475.148866812207, 15970.0, 382963.0, 388025.0, 389916.0, 390252.0, 391074.0, 55342.72328638411, 55988.44011559832, 56120.719396403576, 56169.15746263809, 56305.0, 1321.2997111530904, 1343.8723321284463, 1347.1714895339296, 1354.4920654754467, 1357.111092234568, 29799.70200297969, 30406.391872162876, 30582.847085764428, 30830.691693083678, 31099.533506996962, 44452.33321500245, 45266.773666131456, 45371.319430207914, 45459.54540454686, 45495.545044550454, 253774.0, 254401.0, 255157.0, 307261.0, 364949.0, 28696.71303287024, 31005.379892402478, 31493.212669682525, 31697.20756981094, 31936.840315798272, 36219.818900905324, 37105.62894371022, 37410.0, 37501.81249093737, 40041.799791000856, 32532.186695332806, 34333.484997724554, 34913.47629785606, 35152.648473514935, 35401.0, 28593.653231600398, 32674.29139731477, 33705.83147084249, 33706.66293337035, 36155.0, 31142.75428982906, 31480.0, 31838.840805795822, 31904.202394940312, 32083.35833283368, 28557.571636425055, 29256.26859328534, 29873.850630746707, 35007.0, 36308.55068768463, 23699.34174002694, 25270.115545955803, 25435.36411589725, 25581.104661336765, 26025.869870650524], "unit": "score", "name": "ext.html", "value": 17615.230513641993}, {"lowerIsBetter": false, "replicates": [361.07924791780954, 362.87662194853755, 364.5224755570203, 365.3843274083172, 373.4939157441665, 12808.423620937057, 13069.869301306984, 15264.465743698973, 16254.91872540637, 17277.222524986373, 14188.290585470711, 15134.318955646995, 15401.76897346538, 15425.305861236244, 16439.91780041101, 5289.68261904285, 5498.147787093007, 5501.697406642633, 5503.229547863302, 5518.530924871391, 3993.5607083220966, 4130.731502452331, 5384.246205531209, 5505.174223866412, 5717.428257174291, 5818.41815818419, 6002.429769171922, 6053.334133245339, 6053.424924632153, 6062.878742425149, 5877.970610146965, 6059.333473317932, 6091.756329746805, 6119.694015299217, 6145.5390845686525, 5179.948200517984, 5335.67985920846, 5354.625176237665, 5356.866078348034, 5372.54333381663, 19442.805571944242, 19572.70640940387, 19838.404847854443, 20408.183672653075, 20431.693524597144, 2228.754836967932, 2310.4223944013997, 2310.7573704761094, 2343.133040774924, 2349.705539445742, 12915.0, 12987.220766754024, 13055.477780888754, 13121.671958201026, 13491.797623035662, 1793.775598672604, 1828.4423250908467, 1831.349870795875, 1848.7226915962578, 1858.9961420832733, 53827.0, 55602.165967510926, 56903.430965690226, 56908.430915690726, 57163.0, 9711.077447642463, 9933.3543319684, 9951.25365597583, 9973.202143828476, 10016.198704103654, 12939.417726202344, 13082.149660272053, 13108.868911310956, 13124.081314308098, 13134.146280491928, 7269.89095163573, 7414.443916706268, 7423.777286681408, 7456.440766942501, 7464.178940316561, 6984.406325462291, 6990.825229369307, 7051.153861536648, 7080.973258877434, 7089.255628159072, 5916.911246331309, 6003.939960600425, 6005.879882402415, 6008.579399441997, 6033.78881739137, 1603.7033148867497, 1711.9058451785022, 1717.7251639737583, 1792.354752289175, 1806.205269681336, 948.6395169835419, 967.0571193086824, 971.9028097190366, 979.9434915834261, 999.2405771613626, 14005.369758360897, 16741.0, 17204.225809838586, 17423.825761742475, 17497.650046998988, 912.8676341930383, 951.1392190067861, 957.6025949230991, 963.5375019990444, 1036.657902892044, 9616.51917404127, 9783.46190959504, 9884.258680598983, 9909.603615855285, 9994.800103997879, 332811.0, 335576.0, 360119.0, 364262.0, 369015.0, 42035.36946945798, 42546.36180457295, 46784.2982355265, 54837.4195096591, 66164.66917665477, 1117.6814607836727, 1136.4601814138384, 1146.1862077924766, 1151.7005578549638, 1155.2317708723604, 13892.374843131882, 15784.21078946071, 15980.28088736033, 16264.3494260233, 16370.590735231715, 30028.699713003465, 30464.47677616066, 30550.694493055675, 30731.078067658007, 30861.228469288446, 37394.62605373911, 37625.0, 37816.0, 37821.43267851039, 39691.80154099211, 7088.858222835617, 7096.929030709834, 7354.889676654748, 7378.557286562824, 7569.0, 8335.833283334421, 10086.89913100889, 10325.74185645365, 10388.117010053928, 10501.63244286477, 9112.134347237003, 9298.72103836886, 9405.670801522188, 9501.192398646193, 9577.425354478753, 8784.736457906272, 9141.085891410805, 9569.425834449956, 9683.9031609683, 9721.125098741148, 8341.081551243127, 8881.644734210558, 8956.0, 9202.355835091746, 9271.86092208604, 7354.154272258758, 7511.0, 7663.195364486649, 7680.615969201629, 7763.61181940912, 8787.121287871418, 9262.212711919563, 9293.581788819654, 9387.29595280343, 9445.197158241352], "unit": "score", "name": "jquery.html", "value": 8062.903041295838}, {"lowerIsBetter": false, "replicates": [1296.086259187273, 1464.8974571779972, 1497.3411698852503, 1649.158928946237, 1782.794978577464, 6906.861862762748, 7364.74223402181, 7516.699332026712, 7527.397808175347, 7528.962355188216, 7593.468457207998, 7786.610669466532, 7792.688292468294, 7809.0, 7810.531368117917, 1950.6488832010232, 2000.8499362547793, 2225.5103877147003, 2238.3956331790405, 2263.4567703751063, 2232.787885150908, 2242.3385101395047, 2244.607193741097, 2245.2141750387314, 2245.4723140062074, 2140.4327853118934, 2209.5249521352907, 2210.613142700021, 2212.4468882779306, 2212.623853944825, 2198.7801219878043, 2199.670049492573, 2208.9668654970187, 2251.2908433843286, 2253.774622537733, 2193.890305484719, 2205.217147912484, 2219.0236296029693, 2221.3669104305195, 2225.410266279437, 7821.96089019557, 7933.801654958615, 7935.365170786324, 7935.801604959865, 7942.444028917978, 4704.905901881977, 4849.393825771778, 4853.757312134379, 4854.757262136879, 4861.659683822134, 3036.2409397650586, 3096.5974423325047, 3101.2942881415133, 3145.1665308693214, 3146.2449012237125, 988.7528117970508, 1003.6738060130486, 1007.9748006299901, 1076.6070384309749, 1077.3374374759544, 10877.619283325046, 10916.890831091747, 10918.617848375268, 10928.617498387519, 10928.672139835817, 4217.219814334358, 4346.195953748566, 4364.738115713068, 4375.518692943773, 4409.14021765759, 9355.95322023399, 9376.203022743006, 9378.624855005859, 9393.953030234805, 9406.623735050522, 4831.106245344552, 4858.0, 4858.1012512685265, 4860.586850117779, 4861.611071114302, 4372.759498227628, 4424.623906967944, 4426.557344265548, 4426.822927082945, 4430.446194225722, 3432.5366075579477, 3478.4608385700258, 3638.7270954678506, 3653.725970552219, 3690.3357395669036, 1168.6435637130587, 1179.2983175010854, 1182.645206438065, 1195.934223617692, 1210.267787988272, 1112.2936935046305, 1127.8308253762002, 1129.5707631100129, 1287.4721364240804, 1367.3231750283674, 7296.270372962767, 7296.489245752852, 7335.853282934311, 7354.485186037033, 7530.698772049166, 1105.5577768892347, 1111.8888111188817, 1116.9050630696481, 1134.432783608196, 1137.0619239127752, 5828.766849326064, 5897.852553686193, 5909.645421274738, 5914.408559144051, 5915.08316210988, 9378.953105234566, 9548.665796697222, 9697.418154910727, 9837.901620983841, 9839.212862970946, 9732.610695572097, 9740.951295243478, 9742.659006934724, 9749.171320437701, 9751.707448776406, 7141.143062832493, 7319.670614822346, 7430.108386993596, 7435.85128297431, 7513.737019204302, 7320.1215854097845, 7352.41180705553, 7415.703371865065, 7437.219091995263, 7442.62786860644, 7624.923750762643, 7762.650680719494, 7810.531368117931, 7820.5307681537015, 7955.4828936118965, 8260.091389947222, 8413.663453461793, 8422.24199822019, 8429.62066707012, 8435.0, 6807.693653785493, 6931.7227310907, 7004.649767511706, 7005.0, 7005.22942476317, 6598.736050557924, 6713.0, 6851.109355783717, 7116.786496405116, 7119.537230080028, 6805.6937437816405, 6904.585724856323, 6975.441964642715, 7079.82300442493, 7116.786496405116, 6550.6069635822005, 6586.637734924625, 6593.835154121185, 6696.062551242927, 6698.531102822951, 6858.2455929848675, 6903.0335752993615, 6916.55042422241, 6931.757388491378, 6949.861002779815, 6335.366463353628, 6385.13800636908, 6429.4534964526665, 6438.29178790342, 6441.13044738973, 6387.489000880011, 6439.0, 6439.613623182624, 6440.774572889926, 6551.672416379067], "unit": "score", "name": "mootools.html", "value": 4480.484730092176}, {"lowerIsBetter": false, "replicates": [330.3129490659428, 341.78125999360407, 343.6151510308455, 344.9724022078234, 353.70995783457573, 5673.404292549285, 5789.450002249785, 5811.27359080115, 5811.767529298823, 5818.912716309259, 5677.517411020068, 5750.511206547438, 5765.682887441189, 5792.391798861122, 5799.391063938289, 4528.50186479487, 4531.954680453203, 4535.274356103024, 4536.047430039695, 4549.499555048942, 4311.978440107795, 4353.62994145498, 4380.97809510952, 4390.560943905616, 4537.591616754491, 4318.179545886287, 4348.869533913988, 4415.161119387306, 4437.29003359461, 4466.307722303049, 4471.2845944649025, 4476.753778542179, 4478.977605111986, 4487.057717879249, 4517.322401639747, 3978.9801050994847, 3980.3631418973114, 3987.4218238355274, 3987.6809855211513, 3988.80055997199, 5309.52214300711, 5454.809081682122, 5464.18037294409, 5474.644148130398, 5476.151196564539, 5196.428392876781, 5213.061648903196, 5217.426083130853, 5229.816956406507, 5230.110881150175, 6112.388761123896, 6118.785842495536, 6120.540959428016, 6122.265328160604, 6125.816225513242, 4362.0, 4396.098799746044, 4410.536893626155, 4412.977935110336, 4419.889502762425, 6144.815655530341, 6185.474234690012, 6310.526710496685, 6479.157709497782, 6486.610803351767, 4397.494288156839, 4477.865664030084, 4490.57339552742, 4524.5701658342405, 4525.886852828706, 4530.093981203772, 4558.791920141165, 4567.223571992769, 4572.839950601713, 4576.610988065985, 5173.844784656466, 5180.663256888291, 5190.714510701948, 5194.0650682876685, 5196.58427325813, 5983.341832398432, 6137.508999280047, 6156.415140561639, 6192.040233763774, 6192.752289908353, 1556.5252597957506, 1576.5743249322848, 1576.842315768414, 1576.8817338699414, 1578.8894777365704, 1035.0425856083243, 1039.1478987230398, 1053.9683809485728, 1058.5871510111062, 1074.1514203778927, 5839.737211825478, 5848.064309710426, 5857.355690874, 5859.091840764689, 5861.501772349398, 6318.052292156213, 6321.051842223703, 6324.33594472583, 6328.11406403104, 6332.8416789579705, 5834.387389324144, 5837.3870743571315, 5838.2702162229725, 5848.0, 5848.888711144954, 3311.072899588119, 3412.078738740526, 3417.9658203418144, 3418.8803391881165, 3420.6579342065593, 6626.403623673892, 6636.767713130017, 6637.070810086591, 6639.03733958583, 6641.169853768279, 6537.084808126866, 6539.2479864815205, 6543.280239173687, 6544.476441884638, 6552.3775241352, 6453.645049522227, 6602.60384376939, 6698.330166983263, 6717.764878229238, 6721.529492935545, 6367.808965731036, 6368.012957991518, 6370.904436433365, 6371.23545174582, 6373.776917807854, 6331.176946997045, 6342.175517182921, 6347.079673447417, 6348.9047664286, 6351.2060992375955, 6437.291897891322, 6448.903266450913, 6495.188101487314, 6572.112764776694, 6701.363370479797, 4387.802548885244, 4418.050119224382, 4435.578620031092, 4436.356728274447, 4444.200043992112, 6386.840328991627, 6387.936120638734, 6393.328700486568, 6395.808125756234, 6399.0, 6084.60450070744, 6195.16365290698, 6198.969005154945, 6218.284897236876, 6225.315215326401, 6165.691715414122, 6205.627662340274, 6219.0, 6228.190335256388, 6229.657368844576, 6075.149479072845, 6076.6961651916345, 6080.939190608037, 6081.5742897996715, 6082.665453399928, 6040.184575082308, 6242.937570624235, 6266.0, 6269.811905642838, 6270.059491076375, 6098.786542470993, 6109.572329936862, 6110.052941794029, 6116.26604807426, 6117.26592808848], "unit": "score", "name": "prototype.html", "value": 4676.237582949589}, {"lowerIsBetter": false, "replicates": [814.8981377327832, 825.9174082591742, 854.1927878155142, 863.2964134230598, 869.0744357259518, 12418.130730848832, 12448.937755311234, 12473.126881118325, 12539.686507837287, 12572.994160467175, 11579.189456738031, 12404.751904961895, 12430.378481075955, 12485.25088494691, 12532.122751407405, 650.2652003236336, 809.4374409785172, 824.8556502612049, 825.145973916996, 825.4593241426875, 806.105223202245, 811.3022800391658, 812.2892469089546, 812.634314558451, 815.5840521334103, 849.889514363135, 860.1355637584219, 860.7805009722512, 860.8149247911698, 861.0184389795638, 682.6109117802854, 697.5117417807504, 833.4249367936166, 854.5513605357206, 859.5444414460346, 623.4607064888884, 624.3662682377391, 624.6033768556954, 625.0655270370779, 625.5714835337808, 12479.251244925243, 12482.001439884787, 12491.687707807378, 12528.81206781899, 12564.874351256462, 12120.939395303056, 12531.060170487159, 12904.096713230078, 13091.633505622143, 13196.472141114344, 10085.142762865165, 10217.0, 10286.897131028669, 10337.844932326021, 10450.895491045145, 3561.6972557332656, 3599.1182160370613, 3624.58317293512, 3644.0707619557106, 3698.907527311812, 48184.27723584149, 48507.51492485065, 49317.26024109641, 49855.2521712171, 49867.999999999636, 10010.899891000996, 10046.899531004743, 10111.39331640104, 10342.069213770797, 10353.223508236912, 18380.540486487946, 18396.448106556825, 18433.90783046076, 18445.354412595763, 18459.446216613524, 7518.736844210426, 7742.535447873146, 7794.844103118019, 7901.802454938673, 8034.558099304594, 4228.577142285747, 4296.076343586144, 4297.119090586422, 4321.5678432157165, 4351.36905148758, 3035.2715348316246, 3056.5567992640945, 3064.831434271092, 3068.094912000965, 3074.769392295587, 527.4277409011189, 535.0716506860593, 555.536127333681, 557.3729554251468, 557.8131326005753, 617.6417677746896, 618.4341327685207, 619.6127420362274, 700.6776882634045, 704.3759855543202, 7767.611619419006, 8742.562871856382, 9449.480278584744, 9479.478628675352, 9495.66765163216, 531.824497915687, 625.1997443272618, 638.1863124516279, 676.4453148418249, 682.621145264383, 3962.643362097425, 3976.264391087658, 4101.7744024078365, 4152.667786577127, 4212.115455754326, 53596.19605705918, 57181.14228286579, 57297.0, 57365.42634573684, 57460.0, 49780.253296200586, 50269.49730502722, 50629.240561391605, 50784.0, 50889.745551272004, 45118.323225151646, 45866.08267834625, 45931.54068459273, 46032.309515357294, 46291.537084629395, 7782.649780759993, 8185.263326300662, 8220.63007164667, 8249.587520624065, 8335.374846886387, 33400.83299583486, 33465.16337091592, 34494.310113798085, 34772.478412824334, 35046.29907401888, 43476.782616087985, 43528.34707479454, 44212.77893610511, 44446.55553444424, 45439.77280113711, 10948.890511094787, 11088.279261847954, 11307.943460282646, 11377.715557111138, 11575.305481671126, 12303.876961230273, 12438.502459901865, 12484.313362765135, 12526.37368131608, 12690.302033387883, 11248.718782030515, 11518.94240528792, 11609.825852612048, 11632.88367116352, 11878.584249551224, 11364.602238921598, 11382.94308528452, 11575.479103440197, 11941.104417168573, 11955.880441195477, 11105.444727763741, 11159.163062770487, 11271.661850144508, 11334.546618135182, 11364.374959377314, 9561.282903782105, 9632.75918102053, 9653.420794752337, 9896.950515247665, 10005.949970250102, 9310.767230819283, 9407.43555386679, 9453.33826632129, 9834.852477212704, 10023.69928902134], "unit": "score", "name": "yui.html", "value": 6278.334989742172}], "name": "dromaeo_css", "value": 6747.12522688201}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 108.0, 110.0, 118.0, 112.0, 110.0, 121.0, 103.0, 109.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [156.0, 134.0, 149.0, 163.0, 132.0, 154.0, 165.0, 138.0, 170.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 161.0, 162.0, 162.0, 162.0, 163.0, 159.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 90.0, 100.0, 73.0, 73.0, 72.0, 114.0, 91.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.2}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 139.0, 95.0, 96.0, 95.0, 145.0, 95.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.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": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 144.0], "unit": "score", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 55.0, 54.0, 54.0, 54.0, 56.0, 55.0, 60.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 67.0, 69.0, 68.0, 68.0, 67.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 84.0, 84.0, 82.0, 83.0, 83.0, 93.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [112.0, 116.0, 118.0, 113.0, 112.0, 120.0, 123.0, 121.0, 118.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.6}, {"lowerIsBetter": true, "replicates": [143.0, 132.0, 145.0, 142.0, 138.0, 130.0, 139.0, 154.0, 141.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.6}, {"lowerIsBetter": true, "replicates": [70.0, 66.0, 70.0, 67.0, 66.0, 67.0, 68.0, 66.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1496.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.47244880972198], "unit": "score", "name": "Richards", "value": 212.05911400000002}, {"lowerIsBetter": false, "replicates": [189.10741301059002], "unit": "score", "name": "DeltaBlue", "value": 349.631984}, {"lowerIsBetter": false, "replicates": [280.50490883590464], "unit": "score", "name": "Encrypt", "value": 948.9352650000003}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1112.3470522803113], "unit": "score", "name": "RayTrace", "value": 665.2501110000002}, {"lowerIsBetter": false, "replicates": [771.1864406779661], "unit": "score", "name": "Earley", "value": 864.2047692307689}, {"lowerIsBetter": false, "replicates": [12059.52380952381], "unit": "score", "name": "Boyer", "value": 55.264454096742384}, {"lowerIsBetter": false, "replicates": [42244.897959183676], "unit": "score", "name": "RegExp", "value": 21.564379227053134}, {"lowerIsBetter": false, "replicates": [596.6587112171837], "unit": "score", "name": "Splay", "value": 136.578916}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 20144.894394791838}]} 17:19:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20144.89"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1496.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6747.12"}}} 17:19:30 INFO - Return code: 0 17:19:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:19:30 INFO - # TBPL SUCCESS # 17:19:30 INFO - Running post-action listener: _resource_record_post_action 17:19:30 INFO - Running post-run listener: _resource_record_post_run 17:19:31 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 557056; Write bytes: 312590336; Read time: 220; Write time: 275492 17:19:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1232896; Read time: 0; Write time: 36 17:19:31 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 557056; Write bytes: 311357440; Read time: 220; Write time: 275456 17:19:31 INFO - Running post-run listener: _upload_blobber_files 17:19:31 INFO - Blob upload gear active. 17:19:31 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:19:31 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 17:19:31 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'] 17:19:31 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 17:19:32 INFO - (blobuploader) - INFO - Open directory for files ... 17:19:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:19:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:19:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:19:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:19:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:19:32 INFO - (blobuploader) - INFO - Done attempting. 17:19:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:19:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:19:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:19:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:19:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:19:33 INFO - (blobuploader) - INFO - Done attempting. 17:19:33 INFO - (blobuploader) - INFO - Iteration through files over. 17:19:33 INFO - Return code: 0 17:19:33 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:19:33 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:19:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/570ff4ff36885b229b46a6a3ab8eae9f7845b821858f5ee022164eb6eee642b2e2b9b1a88a5b710a5b880b2d75f3f685a2c9f0d3fdf532bded3d3258a435df2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a1ebb5210a61da3038fb0f9c2726d16eb4bdb9ea7886f1c93f6cb960324687edbfacc0a7b0319339fdfe0c021f2b2ff07164075fb78c89080ec47ee23a8e13fa"} 17:19:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:19:33 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:19:33 INFO - Contents: 17:19:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/570ff4ff36885b229b46a6a3ab8eae9f7845b821858f5ee022164eb6eee642b2e2b9b1a88a5b710a5b880b2d75f3f685a2c9f0d3fdf532bded3d3258a435df2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a1ebb5210a61da3038fb0f9c2726d16eb4bdb9ea7886f1c93f6cb960324687edbfacc0a7b0319339fdfe0c021f2b2ff07164075fb78c89080ec47ee23a8e13fa"} 17:19:33 INFO - Running post-run listener: copy_logs_to_upload_dir 17:19:33 INFO - Copying logs to upload dir... 17:19:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:19:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.335682 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-24 17:19:33.940862) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-24 17:19:33.944603) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939 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/570ff4ff36885b229b46a6a3ab8eae9f7845b821858f5ee022164eb6eee642b2e2b9b1a88a5b710a5b880b2d75f3f685a2c9f0d3fdf532bded3d3258a435df2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a1ebb5210a61da3038fb0f9c2726d16eb4bdb9ea7886f1c93f6cb960324687edbfacc0a7b0319339fdfe0c021f2b2ff07164075fb78c89080ec47ee23a8e13fa"} build_url:https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011308 build_url: 'https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/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/570ff4ff36885b229b46a6a3ab8eae9f7845b821858f5ee022164eb6eee642b2e2b9b1a88a5b710a5b880b2d75f3f685a2c9f0d3fdf532bded3d3258a435df2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a1ebb5210a61da3038fb0f9c2726d16eb4bdb9ea7886f1c93f6cb960324687edbfacc0a7b0319339fdfe0c021f2b2ff07164075fb78c89080ec47ee23a8e13fa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-24 17:19:33.968860) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 17:19:33.969144) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453682671.644649-69367939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 17:19:34.052995) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-24 17:19:34.053335) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-24 17:19:34.053610) ========= ========= Total master_lag: 0.29 =========