builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1453705632.5 results: success (0) buildid: 20160124203442 builduid: dbe0166fe6f04821b3108951b7766e2a revision: b4600877d959435ef43ce362b04b9546639f0be4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-24 23:07:12.495838) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-24 23:07:12.496326) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-24 23:07:12.496628) ========= 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=8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006428 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-24 23:07:12.546188) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-24 23:07:12.546491) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-24 23:07:12.603574) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 23:07:12.603843) ========= 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=8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024229 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 23:07:12.658963) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-24 23:07:12.659268) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-24 23:07:12.659915) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 23:07:12.660453) ========= 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=8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-24 23:07: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 213M=0s 2016-01-24 23:07:12 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116593 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 23:07:12.794827) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 23:07:12.795118) ========= 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=8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.159691 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 23:07:12.974279) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-24 23:07:12.974604) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b4600877d959435ef43ce362b04b9546639f0be4 --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 b4600877d959435ef43ce362b04b9546639f0be4 --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=8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-24 23:07:13,124 truncating revision to first 12 chars 2016-01-24 23:07:13,124 Setting DEBUG logging. 2016-01-24 23:07:13,124 attempt 1/10 2016-01-24 23:07:13,124 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b4600877d959?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-24 23:07:13,902 unpacking tar archive at: fx-team-b4600877d959/testing/mozharness/ program finished with exit code 0 elapsedTime=1.082333 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-24 23:07:14.072929) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-24 23:07:14.073252) ========= echo b4600877d959435ef43ce362b04b9546639f0be4 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b4600877d959435ef43ce362b04b9546639f0be4'] 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=8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b4600877d959435ef43ce362b04b9546639f0be4 program finished with exit code 0 elapsedTime=0.004358 script_repo_revision: 'b4600877d959435ef43ce362b04b9546639f0be4' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-24 23:07:14.123986) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-24 23:07:14.124336) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-24 23:07:14.134162) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-01-24 23:07:14.134461) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:07:14 INFO - MultiFileLogger online at 20160124 23:07:14 in /builds/slave/test-pgo 23:07:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:07:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:07:14 INFO - {'append_to_log': False, 23:07:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:07:14 INFO - 'blob_upload_branch': 'Fx-Team', 23:07:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:07:14 INFO - 'branch': 'Fx-Team', 23:07:14 INFO - 'buildbot_json_path': 'buildprops.json', 23:07:14 INFO - 'config_files': ('talos/linux_config.py',), 23:07:14 INFO - 'default_actions': ('clobber', 23:07:14 INFO - 'read-buildbot-config', 23:07:14 INFO - 'download-and-extract', 23:07:14 INFO - 'populate-webroot', 23:07:14 INFO - 'create-virtualenv', 23:07:14 INFO - 'install', 23:07:14 INFO - 'run-tests'), 23:07:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:07:14 INFO - 'download_minidump_stackwalk': True, 23:07:14 INFO - 'download_symbols': 'ondemand', 23:07:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:07:14 INFO - 'tooltool.py': '/tools/tooltool.py', 23:07:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:07:14 INFO - '/tools/misc-python/virtualenv.py')}, 23:07:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:07:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:07:14 INFO - 'installer_path': 'installer.exe', 23:07:14 INFO - 'log_level': 'info', 23:07:14 INFO - 'log_name': 'talos', 23:07:14 INFO - 'log_to_console': True, 23:07:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:07:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:07:14 INFO - 'opt_config_files': (), 23:07:14 INFO - 'pip_index': False, 23:07:14 INFO - 'sps_profile': False, 23:07:14 INFO - 'sps_profile_interval': 0, 23:07:14 INFO - 'suite': 'dromaeojs-e10s', 23:07:14 INFO - 'system_bits': '32', 23:07:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:07:14 INFO - 'title': 'talos-linux64-ix-038', 23:07:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:07:14 INFO - 'use_talos_json': True, 23:07:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:07:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:07:14 INFO - 'work_dir': 'build'} 23:07:14 INFO - ##### 23:07:14 INFO - ##### Running clobber step. 23:07:14 INFO - ##### 23:07:14 INFO - Running pre-action listener: _resource_record_pre_action 23:07:14 INFO - Running main action method: clobber 23:07:14 INFO - rmtree: /builds/slave/test-pgo/build 23:07:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:07:15 INFO - Running post-action listener: _resource_record_post_action 23:07:15 INFO - ##### 23:07:15 INFO - ##### Running read-buildbot-config step. 23:07:15 INFO - ##### 23:07:15 INFO - Running pre-action listener: _resource_record_pre_action 23:07:15 INFO - Running main action method: read_buildbot_config 23:07:15 INFO - Using buildbot properties: 23:07:15 INFO - { 23:07:15 INFO - "project": "", 23:07:15 INFO - "product": "firefox", 23:07:15 INFO - "script_repo_revision": "production", 23:07:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:07:15 INFO - "repository": "", 23:07:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:07:15 INFO - "buildid": "20160124203442", 23:07:15 INFO - "pgo_build": "True", 23:07:15 INFO - "basedir": "/builds/slave/test-pgo", 23:07:15 INFO - "buildnumber": 243, 23:07:15 INFO - "slavename": "talos-linux64-ix-038", 23:07:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:07:15 INFO - "platform": "ubuntu64_hw", 23:07:15 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:07:15 INFO - "branch": "fx-team", 23:07:15 INFO - "repo_path": "integration/fx-team", 23:07:15 INFO - "revision": "b4600877d959435ef43ce362b04b9546639f0be4", 23:07:15 INFO - "stage_platform": "linux64-pgo", 23:07:15 INFO - "builduid": "dbe0166fe6f04821b3108951b7766e2a", 23:07:15 INFO - "slavebuilddir": "test" 23:07:15 INFO - } 23:07:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 23:07:15 INFO - Running post-action listener: _resource_record_post_action 23:07:15 INFO - ##### 23:07:15 INFO - ##### Running download-and-extract step. 23:07:15 INFO - ##### 23:07:15 INFO - Running pre-action listener: _resource_record_pre_action 23:07:15 INFO - Running main action method: download_and_extract 23:07:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:07: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')]} 23:07:15 INFO - https://queue.taskcluster.net/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:07:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/test_packages.json 23:07:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/test_packages.json 23:07:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 23:07:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 23:07:20 INFO - Downloaded 1448 bytes. 23:07:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 23:07:20 INFO - Using the following test package requirements: 23:07:20 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:07:20 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:07:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:07:20 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:07:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:07:20 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:07:20 INFO - u'jsshell-linux-x86_64.zip'], 23:07:20 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:07:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:07:20 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:07:20 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:07:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:07:20 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:07:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:07:20 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:07:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:07:20 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:07:20 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:07:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:07:20 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:07:20 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')]} 23:07:20 INFO - https://queue.taskcluster.net/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:07:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:07:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:07:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/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 23:07:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/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 23:07:37 INFO - Downloaded 22491878 bytes. 23:07:37 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'] 23:07:37 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 23:07:38 INFO - Return code: 0 23:07:38 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 23:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:07:38 INFO - https://queue.taskcluster.net/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:07:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:07:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:07:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/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 23:07:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/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 23:07:39 INFO - Downloaded 22491878 bytes. 23:07:39 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'] 23:07:39 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 23:07:41 INFO - Return code: 0 23:07:41 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')]} 23:07:41 INFO - https://queue.taskcluster.net/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:07:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:07:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:07:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/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 23:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/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 23:07:42 INFO - Downloaded 10706572 bytes. 23:07:42 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'] 23:07:42 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 23:07:42 INFO - Return code: 0 23:07: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')]} 23:07:42 INFO - https://queue.taskcluster.net/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:07:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:07:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:07:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/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 23:07:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/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 23:07:44 INFO - Downloaded 55977634 bytes. 23:07:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:07:44 INFO - mkdir: /builds/slave/test-pgo/properties 23:07:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:07:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:07:44 INFO - Contents: 23:07:44 INFO - build_url:https://queue.taskcluster.net/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:07:44 INFO - Running post-action listener: _resource_record_post_action 23:07:44 INFO - Running post-action listener: set_extra_try_arguments 23:07:44 INFO - ##### 23:07:44 INFO - ##### Running populate-webroot step. 23:07:44 INFO - ##### 23:07:44 INFO - Running pre-action listener: _resource_record_pre_action 23:07:44 INFO - Running main action method: populate_webroot 23:07:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:07:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:07:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:07:44 INFO - '--tppagecycles', 23:07:44 INFO - '7'], 23:07:44 INFO - 'tests': ['tsvgm']}}, 23:07:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:07:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:07:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:07:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:07:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:07:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:07:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:07:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:07:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:07:44 INFO - 'talos_options': ['--e10s'], 23:07:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:07:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:07:44 INFO - 'tests': ['damp', 'tps']}, 23:07:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:07:44 INFO - 'talos_options': ['--e10s'], 23:07:44 INFO - 'tests': ['damp', 'tps']}, 23:07:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:07:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:07:44 INFO - 'other': {'tests': ['a11yr', 23:07:44 INFO - 'ts_paint', 23:07:44 INFO - 'tpaint', 23:07:44 INFO - 'sessionrestore', 23:07:44 INFO - 'sessionrestore_no_auto_restore']}, 23:07:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:07:44 INFO - 'tests': ['a11yr', 23:07:44 INFO - 'ts_paint', 23:07:44 INFO - 'tpaint', 23:07:44 INFO - 'sessionrestore', 23:07:44 INFO - 'sessionrestore_no_auto_restore']}, 23:07:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:07:44 INFO - 'tests': ['a11yr', 23:07:44 INFO - 'ts_paint', 23:07:44 INFO - 'tpaint', 23:07:44 INFO - 'sessionrestore', 23:07:44 INFO - 'sessionrestore_no_auto_restore']}, 23:07:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:07:44 INFO - 'tests': ['a11yr', 23:07:44 INFO - 'ts_paint', 23:07:44 INFO - 'tpaint', 23:07:44 INFO - 'sessionrestore', 23:07:44 INFO - 'sessionrestore_no_auto_restore']}, 23:07:44 INFO - 'other_l64': {'tests': ['a11yr', 23:07:44 INFO - 'ts_paint', 23:07:44 INFO - 'tpaint', 23:07:44 INFO - 'sessionrestore', 23:07:44 INFO - 'sessionrestore_no_auto_restore']}, 23:07:44 INFO - 'other_nol64': {'tests': ['a11yr', 23:07:44 INFO - 'ts_paint', 23:07:44 INFO - 'tpaint', 23:07:44 INFO - 'sessionrestore', 23:07:44 INFO - 'sessionrestore_no_auto_restore']}, 23:07:44 INFO - 'svgr': {'tests': ['tsvgx', 23:07:44 INFO - 'tsvgr_opacity', 23:07:44 INFO - 'tart', 23:07:44 INFO - 'tscrollx', 23:07:44 INFO - 'cart']}, 23:07:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:07:44 INFO - 'tests': ['tsvgx', 23:07:44 INFO - 'tsvgr_opacity', 23:07:44 INFO - 'tart', 23:07:44 INFO - 'tscrollx', 23:07:44 INFO - 'cart']}, 23:07:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:07:44 INFO - 'tests': ['tp5o']}, 23:07:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:07:44 INFO - 'talos_options': ['--e10s'], 23:07:44 INFO - 'tests': ['tp5o']}, 23:07:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:07:44 INFO - 'talos_options': ['--xperf_path', 23:07:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:07:44 INFO - 'tests': ['tp5n']}, 23:07:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:07:44 INFO - 'talos_options': ['--e10s', 23:07:44 INFO - '--xperf_path', 23:07:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:07:44 INFO - 'tests': ['tp5n']}}, 23:07:44 INFO - 'talos.zip': {'path': '', 23:07:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:07:44 INFO - Running post-action listener: _resource_record_post_action 23:07:44 INFO - ##### 23:07:44 INFO - ##### Running create-virtualenv step. 23:07:44 INFO - ##### 23:07:44 INFO - Running pre-action listener: _resource_record_pre_action 23:07:44 INFO - Running main action method: create_virtualenv 23:07:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:07:44 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 23:07:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:07:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:07:44 INFO - Using real prefix '/usr' 23:07:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:07:44 INFO - Installing distribute.............................................................................................................................................................................................done. 23:07:46 INFO - Installing pip.................done. 23:07:46 INFO - Return code: 0 23:07:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:07: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')]} 23:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07: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')]} 23:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:46 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 0x7f0c9510ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f53840>, '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 0x1ec06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0b60>, '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': '8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704', '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 23:07:46 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 23:07:46 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 23:07:46 INFO - Using env: {'DISPLAY': ':0', 23:07:46 INFO - 'HOME': '/home/cltbld', 23:07:46 INFO - 'LANG': 'en_US.UTF-8', 23:07:46 INFO - 'LANGUAGE': 'en_US:en', 23:07:46 INFO - 'LOGNAME': 'cltbld', 23:07:46 INFO - 'MAIL': '/var/mail/cltbld', 23:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:07:46 INFO - 'MOZ_NO_REMOTE': '1', 23:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:07:46 INFO - 'NO_EM_RESTART': '1', 23:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:07:46 INFO - 'PWD': '/builds/slave/test-pgo', 23:07:46 INFO - 'SHELL': '/bin/bash', 23:07:46 INFO - 'SHLVL': '1', 23:07:46 INFO - 'TERM': 'linux', 23:07:46 INFO - 'TMOUT': '86400', 23:07:46 INFO - 'USER': 'cltbld', 23:07:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704', 23:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:07:46 INFO - '_': '/tools/buildbot/bin/python'} 23:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:07:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:07:46 INFO - Cleaning up... 23:07:46 INFO - Return code: 0 23:07:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:07: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')]} 23:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07: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')]} 23:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:46 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 0x7f0c9510ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f53840>, '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 0x1ec06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0b60>, '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': '8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704', '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 23:07:46 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 23:07:46 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 23:07:46 INFO - Using env: {'DISPLAY': ':0', 23:07:46 INFO - 'HOME': '/home/cltbld', 23:07:46 INFO - 'LANG': 'en_US.UTF-8', 23:07:46 INFO - 'LANGUAGE': 'en_US:en', 23:07:46 INFO - 'LOGNAME': 'cltbld', 23:07:46 INFO - 'MAIL': '/var/mail/cltbld', 23:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:07:46 INFO - 'MOZ_NO_REMOTE': '1', 23:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:07:46 INFO - 'NO_EM_RESTART': '1', 23:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:07:46 INFO - 'PWD': '/builds/slave/test-pgo', 23:07:46 INFO - 'SHELL': '/bin/bash', 23:07:46 INFO - 'SHLVL': '1', 23:07:46 INFO - 'TERM': 'linux', 23:07:46 INFO - 'TMOUT': '86400', 23:07:46 INFO - 'USER': 'cltbld', 23:07:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704', 23:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:07:46 INFO - '_': '/tools/buildbot/bin/python'} 23:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:07:47 INFO - Downloading/unpacking psutil>=0.7.1 23:07:47 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 23:07:47 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 23:07:47 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 23:07:47 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 23:07:47 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 23:07:47 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 23:07:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:07:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:07:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:07:51 INFO - Installing collected packages: psutil 23:07:51 INFO - Running setup.py install for psutil 23:07:51 INFO - building 'psutil._psutil_linux' extension 23:07:51 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 23:07:51 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 23:07:51 INFO - building 'psutil._psutil_posix' extension 23:07:51 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 23:07:51 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 23:07:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:07:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:07:51 INFO - Successfully installed psutil 23:07:51 INFO - Cleaning up... 23:07:51 INFO - Return code: 0 23:07:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:51 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 0x7f0c9510ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f53840>, '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 0x1ec06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0b60>, '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': '8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704', '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 23:07:51 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 23:07:51 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 23:07:51 INFO - Using env: {'DISPLAY': ':0', 23:07:51 INFO - 'HOME': '/home/cltbld', 23:07:51 INFO - 'LANG': 'en_US.UTF-8', 23:07:51 INFO - 'LANGUAGE': 'en_US:en', 23:07:51 INFO - 'LOGNAME': 'cltbld', 23:07:51 INFO - 'MAIL': '/var/mail/cltbld', 23:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:07:51 INFO - 'MOZ_NO_REMOTE': '1', 23:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:07:51 INFO - 'NO_EM_RESTART': '1', 23:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:07:51 INFO - 'PWD': '/builds/slave/test-pgo', 23:07:51 INFO - 'SHELL': '/bin/bash', 23:07:51 INFO - 'SHLVL': '1', 23:07:51 INFO - 'TERM': 'linux', 23:07:51 INFO - 'TMOUT': '86400', 23:07:51 INFO - 'USER': 'cltbld', 23:07:51 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704', 23:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:07:51 INFO - '_': '/tools/buildbot/bin/python'} 23:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:07:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:07: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 23:07: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 23:07: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 23:07: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 23:07: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 23:07: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 23:07:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:07:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:07:53 INFO - Installing collected packages: mozsystemmonitor 23:07:53 INFO - Running setup.py install for mozsystemmonitor 23:07:53 INFO - Successfully installed mozsystemmonitor 23:07:53 INFO - Cleaning up... 23:07:53 INFO - Return code: 0 23:07:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:07: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')]} 23:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07: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')]} 23:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:53 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 0x7f0c9510ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f53840>, '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 0x1ec06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0b60>, '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': '8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704', '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 23:07:53 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 23:07:53 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 23:07:53 INFO - Using env: {'DISPLAY': ':0', 23:07:53 INFO - 'HOME': '/home/cltbld', 23:07:53 INFO - 'LANG': 'en_US.UTF-8', 23:07:53 INFO - 'LANGUAGE': 'en_US:en', 23:07:53 INFO - 'LOGNAME': 'cltbld', 23:07:53 INFO - 'MAIL': '/var/mail/cltbld', 23:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:07:53 INFO - 'MOZ_NO_REMOTE': '1', 23:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:07:53 INFO - 'NO_EM_RESTART': '1', 23:07:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:07:53 INFO - 'PWD': '/builds/slave/test-pgo', 23:07:53 INFO - 'SHELL': '/bin/bash', 23:07:53 INFO - 'SHLVL': '1', 23:07:53 INFO - 'TERM': 'linux', 23:07:53 INFO - 'TMOUT': '86400', 23:07:53 INFO - 'USER': 'cltbld', 23:07:53 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704', 23:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:07:53 INFO - '_': '/tools/buildbot/bin/python'} 23:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:07:54 INFO - Downloading/unpacking blobuploader==1.2.4 23:07: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 23:07: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 23:07: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 23:07: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 23:07: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 23:07: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 23:07:55 INFO - Downloading blobuploader-1.2.4.tar.gz 23:07:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:07:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:07:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:07:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:07:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:07:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:07: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 23:07: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 23:07: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 23:07: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 23:07: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 23:07: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 23:07:56 INFO - Downloading docopt-0.6.1.tar.gz 23:07:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:07:56 INFO - Installing collected packages: blobuploader, requests, docopt 23:07:56 INFO - Running setup.py install for blobuploader 23:07:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:07:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:07:56 INFO - Running setup.py install for requests 23:07:56 INFO - Running setup.py install for docopt 23:07:57 INFO - Successfully installed blobuploader requests docopt 23:07:57 INFO - Cleaning up... 23:07:57 INFO - Return code: 0 23:07:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:57 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 0x7f0c9510ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f53840>, '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 0x1ec06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0b60>, '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': '8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704', '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 23:07:57 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 23:07:57 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 23:07:57 INFO - Using env: {'DISPLAY': ':0', 23:07:57 INFO - 'HOME': '/home/cltbld', 23:07:57 INFO - 'LANG': 'en_US.UTF-8', 23:07:57 INFO - 'LANGUAGE': 'en_US:en', 23:07:57 INFO - 'LOGNAME': 'cltbld', 23:07:57 INFO - 'MAIL': '/var/mail/cltbld', 23:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:07:57 INFO - 'MOZ_NO_REMOTE': '1', 23:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:07:57 INFO - 'NO_EM_RESTART': '1', 23:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:07:57 INFO - 'PWD': '/builds/slave/test-pgo', 23:07:57 INFO - 'SHELL': '/bin/bash', 23:07:57 INFO - 'SHLVL': '1', 23:07:57 INFO - 'TERM': 'linux', 23:07:57 INFO - 'TMOUT': '86400', 23:07:57 INFO - 'USER': 'cltbld', 23:07:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704', 23:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:07:57 INFO - '_': '/tools/buildbot/bin/python'} 23:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:07:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:07:57 INFO - Running setup.py (path:/tmp/pip-bk58xE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:07:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:07:57 INFO - Running setup.py (path:/tmp/pip-pI7_e_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:07:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:07:57 INFO - Running setup.py (path:/tmp/pip-WWgsz3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:07:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:07:57 INFO - Running setup.py (path:/tmp/pip-Pe3uwu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:07:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:07:57 INFO - Running setup.py (path:/tmp/pip-PMAcyA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:07:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:07:57 INFO - Running setup.py (path:/tmp/pip-xdJpmG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:07:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:07:57 INFO - Running setup.py (path:/tmp/pip-K1BIw1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:07:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:07:57 INFO - Running setup.py (path:/tmp/pip-gvPe0p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:07:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:07:57 INFO - Running setup.py (path:/tmp/pip-0p487t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:07:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:07:57 INFO - Running setup.py (path:/tmp/pip-hlBII2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:07:58 INFO - Running setup.py (path:/tmp/pip-D_9RLq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:07:58 INFO - Running setup.py (path:/tmp/pip-1O5VQ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:07:58 INFO - Running setup.py (path:/tmp/pip-OQWrCF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:07:58 INFO - Running setup.py (path:/tmp/pip-xLp94n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:07:58 INFO - Running setup.py (path:/tmp/pip-Ca8qt9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:07:58 INFO - Running setup.py (path:/tmp/pip-0yPOSZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:07:58 INFO - Running setup.py (path:/tmp/pip-MIF5_l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:07:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:07:58 INFO - Running setup.py install for manifestparser 23:07:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:07:58 INFO - Running setup.py install for mozcrash 23:07:58 INFO - Running setup.py install for mozdebug 23:07:58 INFO - Running setup.py install for mozdevice 23:07:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:07:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:07:58 INFO - Running setup.py install for mozfile 23:07:59 INFO - Running setup.py install for mozhttpd 23:07:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:07:59 INFO - Running setup.py install for mozinfo 23:07:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:07:59 INFO - Running setup.py install for mozInstall 23:07:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:07:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:07:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:07:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:07:59 INFO - Running setup.py install for mozleak 23:07:59 INFO - Running setup.py install for mozlog 23:07:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:07:59 INFO - Running setup.py install for moznetwork 23:07:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:07:59 INFO - Running setup.py install for mozprocess 23:07:59 INFO - Running setup.py install for mozprofile 23:07:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:07:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:07:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:07:59 INFO - Running setup.py install for mozrunner 23:07:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:08:00 INFO - Running setup.py install for mozscreenshot 23:08:00 INFO - Running setup.py install for moztest 23:08:00 INFO - Running setup.py install for mozversion 23:08:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:08:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:08:00 INFO - Cleaning up... 23:08:00 INFO - Return code: 0 23:08:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:00 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 0x7f0c9510ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f53840>, '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 0x1ec06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0b60>, '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': '8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704', '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 23:08:00 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 23:08:00 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 23:08:00 INFO - Using env: {'DISPLAY': ':0', 23:08:00 INFO - 'HOME': '/home/cltbld', 23:08:00 INFO - 'LANG': 'en_US.UTF-8', 23:08:00 INFO - 'LANGUAGE': 'en_US:en', 23:08:00 INFO - 'LOGNAME': 'cltbld', 23:08:00 INFO - 'MAIL': '/var/mail/cltbld', 23:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:08:00 INFO - 'MOZ_NO_REMOTE': '1', 23:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:08:00 INFO - 'NO_EM_RESTART': '1', 23:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:08:00 INFO - 'PWD': '/builds/slave/test-pgo', 23:08:00 INFO - 'SHELL': '/bin/bash', 23:08:00 INFO - 'SHLVL': '1', 23:08:00 INFO - 'TERM': 'linux', 23:08:00 INFO - 'TMOUT': '86400', 23:08:00 INFO - 'USER': 'cltbld', 23:08:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704', 23:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:08:00 INFO - '_': '/tools/buildbot/bin/python'} 23:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:08:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:08:00 INFO - Running setup.py (path:/tmp/pip-ztIiUE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:08:00 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)) 23:08:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:08:00 INFO - Running setup.py (path:/tmp/pip-6qBo6h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:08:00 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)) 23:08:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:08:00 INFO - Running setup.py (path:/tmp/pip-rIuisw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:08:00 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)) 23:08:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:08:00 INFO - Running setup.py (path:/tmp/pip-_z_rPj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:08:00 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)) 23:08:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:08:00 INFO - Running setup.py (path:/tmp/pip-bpi1Uc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:08:00 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)) 23:08:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:08:00 INFO - Running setup.py (path:/tmp/pip-hhWPp2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:08:00 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)) 23:08:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:08:00 INFO - Running setup.py (path:/tmp/pip-W1yofc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:08:01 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)) 23:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:08:01 INFO - Running setup.py (path:/tmp/pip-gzTMfD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:08:01 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)) 23:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:08:01 INFO - Running setup.py (path:/tmp/pip-KWlcCE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:08:01 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)) 23:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:08:01 INFO - Running setup.py (path:/tmp/pip-iDEZFL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:08:01 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)) 23:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:08:01 INFO - Running setup.py (path:/tmp/pip-IbmnVI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:08:01 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)) 23:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:08:01 INFO - Running setup.py (path:/tmp/pip-A5CJ3g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:08:01 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)) 23:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:08:01 INFO - Running setup.py (path:/tmp/pip-y2w9Tb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:08:01 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)) 23:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:08:01 INFO - Running setup.py (path:/tmp/pip-WDUezo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:08:01 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)) 23:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:08:01 INFO - Running setup.py (path:/tmp/pip-0gbMv7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:08:01 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)) 23:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:08:01 INFO - Running setup.py (path:/tmp/pip-6Qe1e5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:08:01 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)) 23:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:08:01 INFO - Running setup.py (path:/tmp/pip-eFaaMH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:08:01 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)) 23:08:01 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)) 23:08:01 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)) 23:08:01 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)) 23:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 23:08:01 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)) 23:08:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:08:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:08:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:08:03 INFO - Downloading blessings-1.6.tar.gz 23:08:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:08:03 INFO - Installing collected packages: blessings 23:08:03 INFO - Running setup.py install for blessings 23:08:03 INFO - Successfully installed blessings 23:08:03 INFO - Cleaning up... 23:08:03 INFO - Return code: 0 23:08:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:08:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:08:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:08:03 INFO - Reading from file tmpfile_stdout 23:08:03 INFO - Current package versions: 23:08:03 INFO - argparse == 1.2.1 23:08:03 INFO - blessings == 1.6 23:08:03 INFO - blobuploader == 1.2.4 23:08:03 INFO - docopt == 0.6.1 23:08:03 INFO - manifestparser == 1.1 23:08:03 INFO - mozInstall == 1.12 23:08:03 INFO - mozcrash == 0.16 23:08:03 INFO - mozdebug == 0.1 23:08:03 INFO - mozdevice == 0.48 23:08:03 INFO - mozfile == 1.2 23:08:03 INFO - mozhttpd == 0.7 23:08:03 INFO - mozinfo == 0.9 23:08:03 INFO - mozleak == 0.1 23:08:03 INFO - mozlog == 3.1 23:08:03 INFO - moznetwork == 0.27 23:08:03 INFO - mozprocess == 0.22 23:08:03 INFO - mozprofile == 0.28 23:08:03 INFO - mozrunner == 6.11 23:08:03 INFO - mozscreenshot == 0.1 23:08:03 INFO - mozsystemmonitor == 0.0 23:08:03 INFO - moztest == 0.7 23:08:03 INFO - mozversion == 1.4 23:08:03 INFO - psutil == 3.1.1 23:08:03 INFO - requests == 1.2.3 23:08:03 INFO - wsgiref == 0.1.2 23:08:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:03 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 0x7f0c9510ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f53840>, '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 0x1ec06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0b60>, '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': '8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704', '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 23:08:03 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 23:08:03 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 23:08:03 INFO - Using env: {'DISPLAY': ':0', 23:08:03 INFO - 'HOME': '/home/cltbld', 23:08:03 INFO - 'LANG': 'en_US.UTF-8', 23:08:03 INFO - 'LANGUAGE': 'en_US:en', 23:08:03 INFO - 'LOGNAME': 'cltbld', 23:08:03 INFO - 'MAIL': '/var/mail/cltbld', 23:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:08:03 INFO - 'MOZ_NO_REMOTE': '1', 23:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:08:04 INFO - 'NO_EM_RESTART': '1', 23:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:08:04 INFO - 'PWD': '/builds/slave/test-pgo', 23:08:04 INFO - 'SHELL': '/bin/bash', 23:08:04 INFO - 'SHLVL': '1', 23:08:04 INFO - 'TERM': 'linux', 23:08:04 INFO - 'TMOUT': '86400', 23:08:04 INFO - 'USER': 'cltbld', 23:08:04 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704', 23:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:08:04 INFO - '_': '/tools/buildbot/bin/python'} 23:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:08:04 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)) 23:08:04 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)) 23:08:04 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)) 23:08:04 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)) 23:08:04 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)) 23:08:04 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)) 23:08:04 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)) 23:08:04 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)) 23:08:04 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)) 23:08:04 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)) 23:08:04 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)) 23:08:04 INFO - Cleaning up... 23:08:04 INFO - Return code: 0 23:08:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:08:04 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')]} 23:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:04 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')]} 23:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:04 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 0x7f0c9510ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f53840>, '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 0x1ec06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0b60>, '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': '8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704', '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 23:08:04 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 23:08:04 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 23:08:04 INFO - Using env: {'DISPLAY': ':0', 23:08:04 INFO - 'HOME': '/home/cltbld', 23:08:04 INFO - 'LANG': 'en_US.UTF-8', 23:08:04 INFO - 'LANGUAGE': 'en_US:en', 23:08:04 INFO - 'LOGNAME': 'cltbld', 23:08:04 INFO - 'MAIL': '/var/mail/cltbld', 23:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:08:04 INFO - 'MOZ_NO_REMOTE': '1', 23:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:08:04 INFO - 'NO_EM_RESTART': '1', 23:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:08:04 INFO - 'PWD': '/builds/slave/test-pgo', 23:08:04 INFO - 'SHELL': '/bin/bash', 23:08:04 INFO - 'SHLVL': '1', 23:08:04 INFO - 'TERM': 'linux', 23:08:04 INFO - 'TMOUT': '86400', 23:08:04 INFO - 'USER': 'cltbld', 23:08:04 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704', 23:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:08:04 INFO - '_': '/tools/buildbot/bin/python'} 23:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:08:04 INFO - Downloading/unpacking jsonschema 23:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:08:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:08:06 INFO - Downloading/unpacking functools32 (from jsonschema) 23:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:08:06 INFO - Downloading functools32-3.2.3-2.tar.gz 23:08:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:08:06 INFO - warning: no files found matching '*.txt' 23:08:06 INFO - no previously-included directories found matching 'build' 23:08:06 INFO - no previously-included directories found matching 'dist' 23:08:06 INFO - no previously-included directories found matching '.git*' 23:08:06 INFO - Installing collected packages: jsonschema, functools32 23:08:06 INFO - Running setup.py install for functools32 23:08:06 INFO - warning: no files found matching '*.txt' 23:08:06 INFO - no previously-included directories found matching 'build' 23:08:06 INFO - no previously-included directories found matching 'dist' 23:08:06 INFO - no previously-included directories found matching '.git*' 23:08:06 INFO - Successfully installed jsonschema functools32 23:08:06 INFO - Cleaning up... 23:08:06 INFO - Return code: 0 23:08:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:08:06 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')]} 23:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:06 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')]} 23:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:06 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 0x7f0c9510ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f53840>, '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 0x1ec06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0b60>, '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': '8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704', '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 23:08:06 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 23:08:06 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 23:08:06 INFO - Using env: {'DISPLAY': ':0', 23:08:06 INFO - 'HOME': '/home/cltbld', 23:08:06 INFO - 'LANG': 'en_US.UTF-8', 23:08:06 INFO - 'LANGUAGE': 'en_US:en', 23:08:06 INFO - 'LOGNAME': 'cltbld', 23:08:06 INFO - 'MAIL': '/var/mail/cltbld', 23:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:08:06 INFO - 'MOZ_NO_REMOTE': '1', 23:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:08:06 INFO - 'NO_EM_RESTART': '1', 23:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:08:06 INFO - 'PWD': '/builds/slave/test-pgo', 23:08:06 INFO - 'SHELL': '/bin/bash', 23:08:06 INFO - 'SHLVL': '1', 23:08:06 INFO - 'TERM': 'linux', 23:08:06 INFO - 'TMOUT': '86400', 23:08:06 INFO - 'USER': 'cltbld', 23:08:06 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704', 23:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:08:06 INFO - '_': '/tools/buildbot/bin/python'} 23:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:08:06 INFO - Downloading/unpacking flake8 23:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:08:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:08:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:08:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:08:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:08:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:08:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:08:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:08:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:08:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:08:09 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 23:08:09 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 23:08:09 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 23:08:09 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 23:08:09 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 23:08:09 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 23:08:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:08:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:08:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:08:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:08:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:08:09 INFO - no previously-included directories found matching 'docs/_build' 23:08:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:08:09 INFO - Running setup.py install for pep8 23:08:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:08:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:08:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:08:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:08:09 INFO - no previously-included directories found matching 'docs/_build' 23:08:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:08:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:08:09 INFO - Cleaning up... 23:08:09 INFO - Return code: 0 23:08:09 INFO - Running post-action listener: _resource_record_post_action 23:08:09 INFO - Running post-action listener: _start_resource_monitoring 23:08:09 INFO - Starting resource monitoring. 23:08:09 INFO - ##### 23:08:09 INFO - ##### Running install step. 23:08:09 INFO - ##### 23:08:09 INFO - Running pre-action listener: _resource_record_pre_action 23:08:09 INFO - Running main action method: install 23:08:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:08:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:08:09 INFO - Reading from file tmpfile_stdout 23:08:09 INFO - Detecting whether we're running mozinstall >=1.0... 23:08:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:08:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:08:09 INFO - Reading from file tmpfile_stdout 23:08:09 INFO - Output received: 23:08:09 INFO - Usage: mozinstall [options] installer 23:08:09 INFO - Options: 23:08:09 INFO - -h, --help show this help message and exit 23:08:09 INFO - -d DEST, --destination=DEST 23:08:09 INFO - Directory to install application into. [default: 23:08:09 INFO - "/builds/slave/test-pgo"] 23:08:09 INFO - --app=APP Application being installed. [default: firefox] 23:08:09 INFO - mkdir: /builds/slave/test-pgo/build/application 23:08:09 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'] 23:08:09 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 23:08:25 INFO - Reading from file tmpfile_stdout 23:08:25 INFO - Output received: 23:08:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:08:25 INFO - Running post-action listener: _resource_record_post_action 23:08:25 INFO - ##### 23:08:25 INFO - ##### Running run-tests step. 23:08:25 INFO - ##### 23:08:25 INFO - Running pre-action listener: _resource_record_pre_action 23:08:25 INFO - Running main action method: run_tests 23:08:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:08:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:08:25 INFO - Python 2.7.3 23:08:25 INFO - Return code: 0 23:08:25 INFO - grabbing minidump binary from tooltool 23:08:25 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')]} 23:08:25 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 0x1f53840>, '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 0x1ec06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:08:25 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 23:08:25 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 23:08:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:08:25 INFO - Return code: 0 23:08:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:08:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:08:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:08:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:08:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:08:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:08:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:08:27 INFO - Return code: 0 23:08:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 23:08:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:08:27 INFO - Using env: {'DISPLAY': ':0', 23:08:27 INFO - 'HOME': '/home/cltbld', 23:08:27 INFO - 'LANG': 'en_US.UTF-8', 23:08:27 INFO - 'LANGUAGE': 'en_US:en', 23:08:27 INFO - 'LOGNAME': 'cltbld', 23:08:27 INFO - 'MAIL': '/var/mail/cltbld', 23:08:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:08:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:08:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:08:27 INFO - 'MOZ_NO_REMOTE': '1', 23:08:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:08:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:08:27 INFO - 'NO_EM_RESTART': '1', 23:08:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:08:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:08:27 INFO - 'PWD': '/builds/slave/test-pgo', 23:08:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:08:27 INFO - 'SHELL': '/bin/bash', 23:08:27 INFO - 'SHLVL': '1', 23:08:27 INFO - 'TERM': 'linux', 23:08:27 INFO - 'TMOUT': '86400', 23:08:27 INFO - 'USER': 'cltbld', 23:08:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704', 23:08:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:08:27 INFO - '_': '/tools/buildbot/bin/python'} 23:08:27 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:08:27 INFO - mozversion application_buildid: 20160124203442 23:08:27 INFO - mozversion application_changeset: b4600877d959435ef43ce362b04b9546639f0be4 23:08:27 INFO - mozversion application_display_name: Nightly 23:08:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:08:27 INFO - mozversion application_name: Firefox 23:08:27 INFO - mozversion application_remotingname: firefox 23:08:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:08:27 INFO - mozversion application_vendor: Mozilla 23:08:27 INFO - mozversion application_version: 46.0a1 23:08:27 INFO - mozversion platform_buildid: 20160124203442 23:08:27 INFO - mozversion platform_changeset: b4600877d959435ef43ce362b04b9546639f0be4 23:08:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:08:27 INFO - mozversion platform_version: 46.0a1 23:08:27 INFO - using testdate: 1453705707 23:08:27 INFO - actual date: 1453705707 23:08:27 INFO - starting webserver on 'localhost:53622' 23:08:27 INFO - SUITE-START | Running 3 tests 23:08:27 INFO - TEST-START | dromaeo_css 23:08:27 INFO - operating with platform_type : linux_ 23:08:27 INFO - Initialising browser for dromaeo_css test... 23:08:27 INFO - TEST-INFO | started process 3887 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_dwWSG/profile http://localhost:53622/getInfo.html) 23:08:30 INFO - PROCESS | 3887 | 23:08:30 INFO - PROCESS | 3887 | (process:3970): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:08:31 INFO - PROCESS | 3887 | __metrics Screen width/height:1600/1200 23:08:31 INFO - PROCESS | 3887 | colorDepth:24 23:08:31 INFO - PROCESS | 3887 | Browser inner width/height: 1024/697 23:08:31 INFO - PROCESS | 3887 | __metrics 23:08:32 INFO - PROCESS | 3887 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:08:32 INFO - TEST-INFO | 3887: exit 0 23:08:32 INFO - Browser initialized. 23:08:32 INFO - Running cycle 1/1 for dromaeo_css test... 23:08:32 INFO - TEST-INFO | started process 4019 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_dwWSG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:08:34 INFO - PROCESS | 4019 | 23:08:34 INFO - PROCESS | 4019 | (process:4076): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:08:44 INFO - PROCESS | 4019 | RSS: Main: 151683072 23:08:44 INFO - PROCESS | 4019 | 23:09:34 INFO - PROCESS | 4019 | 1453705774359 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] 23:11:42 INFO - PROCESS | 4019 | Cycle 1(1): loaded http://localhost:53622/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53622/tests/dromaeo/cssquery-ext.html) 23:11:43 INFO - PROCESS | 4019 | RSS: Main: 160870400 23:11:43 INFO - PROCESS | 4019 | 23:14:45 INFO - PROCESS | 4019 | Cycle 1(1): loaded http://localhost:53622/tests/dromaeo/cssquery-ext.html (next: http://localhost:53622/tests/dromaeo/cssquery-jquery.html) 23:14:46 INFO - PROCESS | 4019 | RSS: Main: 155815936 23:14:46 INFO - PROCESS | 4019 | 23:17:48 INFO - PROCESS | 4019 | Cycle 1(1): loaded http://localhost:53622/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53622/tests/dromaeo/cssquery-mootools.html) 23:17:48 INFO - PROCESS | 4019 | RSS: Main: 155701248 23:17:48 INFO - PROCESS | 4019 | 23:20:50 INFO - PROCESS | 4019 | Cycle 1(1): loaded http://localhost:53622/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53622/tests/dromaeo/cssquery-prototype.html) 23:20:50 INFO - PROCESS | 4019 | RSS: Main: 153686016 23:20:50 INFO - PROCESS | 4019 | 23:23:53 INFO - PROCESS | 4019 | Cycle 1(1): loaded http://localhost:53622/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53622/tests/dromaeo/cssquery-yui.html) 23:23:53 INFO - PROCESS | 4019 | RSS: Main: 154644480 23:23:53 INFO - PROCESS | 4019 | 23:26:56 INFO - PROCESS | 4019 | Cycle 1(1): loaded http://localhost:53622/tests/dromaeo/cssquery-yui.html (next: http://localhost:53622/tests/dromaeo/cssquery-dojo.html) 23:26:56 INFO - PROCESS | 4019 | RSS: Main: 158187520 23:26:56 INFO - PROCESS | 4019 | 23:26:56 INFO - PROCESS | 4019 | __start_tp_report 23:26:56 INFO - PROCESS | 4019 | _x_x_mozilla_page_load 23:26:56 INFO - PROCESS | 4019 | _x_x_mozilla_page_load_details 23:26:56 INFO - PROCESS | 4019 | |i|pagename|runs| 23:26:56 INFO - PROCESS | 4019 | |0;dojo.html;3081.5685803987444;3119.500879859223;3121.859516321765;3142.151619062853;3151.0546835949212;5047.823326183584;5090.821821236257;5097.184450487923;5103.311053007843;5110.284560161575;5018.422881368644;5120.539151476366;5139.280500729901;5174.0945334566395;5185.118529849935;4637.83767568136;4662.04428092242;4680.672352935296;4740.620750339965;4748.19280722278;4759.714417134983;4760.738159401231;4766.76166191689;4817.638677099231;4854.296127061574;4597.42532183477;4666.603338716213;4688.601468875133;4750.334953106568;4755.83354582588;4686.882827929295;4692.6245900327895;4696.882577935545;4709.128811169944;4729.290606409032;4504.121696269229;4691.906161876777;4701.036287561042;4703.976480117578;4740.123077230689;4952.7523623819025;5024.673396229234;5034.421041580228;5040.47075057121;5058.064258112224;5450.509454149145;5488.7530061147345;5508.889822203533;5513.558915286768;5545.168224766277;5430.239766432703;5500.834974950758;5549.6115271930985;5567.582431317667;5569.443055694439;5208.9739551302;5215.608829337777;5251.054810134213;5258.158694608845;5294.97352513235;5657.236273103078;5699.971500142473;5701.828945131652;5706.4864162225595;5711.9718450679275;5290.338707661543;5359.035373632783;5467.753951072212;5504.311961004874;5553.722313884289;5517.034518959166;5533.916991245134;5535.142052981794;5547.278853748987;5562.860928476821;5498.340199176125;5501;5516.641418307797;5525.557955363562;5536.252605898152;5340.19897015443;5402.702851343214;5529.060059789846;5533.750981205855;5584.134459158837;4287.992321804373;4318.805653745589;4321.351797230441;4322.243607368698;4355.15074560464;3859.324618191861;3860.0735823402742;3888.4167374893427;3891.988083098415;3900.7269491135917;5068.467810879878;5197.0905091609575;5198.2722418861385;5205.84382468519;5264.473552644781;5503.642263252876;5507.146392309199;5538.6399884008215;5546.445355464502;5562.110062389998;5023.472535383805;5180.326557547494;5186.196139598368;5190.455002224712;5240.4497527759795;4643.257078867365;4711.387519622427;4716.764161791897;4722.693024953367;4783.904321913542;5719.428057194247;5761.366249712528;5765.884682306414;5766.855828604234;5771.187962722749;5404.486573775485;5480.616356854982;5566.777328906798;5576.470235327637;5641.548676105902;5673.149027645886;5685.71571421419;5696.686682232351;5713.285839270091;5742.971285143548;5378.569714422915;5443.074677304789;5445.428230035947;5446.754896029767;5460.754266058117;5326.227696983993;5435.130379139477;5552.58355623338;5554.2779438672715;5587.77648894056;5481.232627432242;5485.341758988947;5486;5499.862503437446;5499.917501237404;5429.375621803385;5429.728513574384;5431.619786614899;5441.102218133963;5482.2873026506295;5081.23781432788;5151.4590967949325;5290.28581141541;5331.280277162688;5352.063388907003;5394.2448057272795;5404.945950540444;5411.972940135274;5412.891742165213;5421.484958928895;5301.125314323248;5312.814051508179;5319.760610772602;5328.57371410294;5356.116240820221 23:26:56 INFO - PROCESS | 4019 | |1;ext.html;493.1591636260179;520.8854052108535;532.1884126706773;534.5563182558477;554.1576803259046;28528.144155675338;36700.26599468009;36768.632313676855;36995.63004369955;37118.7313458952;38938.80530597343;39349.40975885364;39404.21191576167;39535.80232098843;39608.603913960855;8328.08391076981;8460.196281353261;8465.53439560824;8496.447730897471;8527.658893644248;8219.95890020549;8288.336933045342;8314.70898518552;8323.292520135796;8352.749417517454;8339.666413343459;8398.45410048348;8426.831463370729;8426.957865210665;8456.78858028548;8274.420790544664;8321.500709957421;8396.706115285966;8531.061583225903;8595.785105372353;8363.916360836374;8449.408541402043;8477.109903460172;8492.830143397097;8496.745097647081;39154.21691566153;39332.60667393318;39386.80306598477;39541;39606;3098.7366073883522;3156.1162874395204;3306.123877172551;3398.2693720850134;3732.9440058399146;30090.84954575235;30188.84905575458;30635.846820765753;30759.2310192247;31774.205644859063;3870.4000879863665;3892.7469714468752;3906.833989257686;3918.5297764268184;3986.681065514752;249445;253332;253734;254326.72836635885;255375;51884.22173667398;52462.475375246526;53039.20441193385;58628.41371586315;59345.70327148337;53540.46459535433;53677.7316113417;54038;54051.45948540543;54216;14482.927585362217;14506.709865802835;14550.399456059826;14577.344019519147;14769.40922363115;11102.888971110347;11211.887881121247;11258;11298.322100673986;11324.32054076758;19521.34068604156;19733.210671572975;20007.59984800296;20019.39941801748;20057.29799457012;7655.425843061793;7741.767746967487;7773.222677732181;7833.64748586315;7897.23596741136;917.4220241247971;989.1196834817018;997.9550920208608;1016.4714348538719;1059.3167407022427;29111.417771644872;29196.416071678446;29375.11874643764;29517.409651807273;29559.408811823643;1045.5974449836867;1082.5074591061207;1083.1443159903588;1102.470814009264;1109.6171820721838;14471.78292325616;14688.779668304984;14714.950305562003;14860.851391486163;14881.47914822976;324001;328826;329532;330004;330938;51923;52054.47945520572;52164.739176303876;52301.2154817678;52481.475185248426;1327.1705184259838;1338.906276560651;1341.631051460856;1347.2590075458459;1351.574254109952;27410.72589274082;28544.286392839513;28660.713392865804;28699.71300287054;28796.280092997844;46300.53699462962;46354.536454635025;46575.76712116418;46683.29975050445;46846.29730554113;302451;302698;305942;306197;306455;30330;30934.381312374077;31021.68978310188;31047;31201.8439907799;42093.57906420896;42688;43241.783791080845;43450.56549434465;43976.34035489406;35386.46920296249;35835.46246806248;36445.08887277839;36513.81743091268;37056.814715926244;32871.17822054468;33554.832225839695;33572.66427335695;34067.65932340645;35127;32282.35435291234;32690.182745431553;32726.836365818017;33002.504962425104;33114.834425827714;29809.25476863009;30328;30596.388072237984;30889;31075;24055.398615034763;25646.487070258863;26050.34874128162;26306.86846565755;27513.31216719598 23:26:56 INFO - PROCESS | 4019 | |2;jquery.html;367.4579994508099;368.34434706222925;371.42243810874095;371.87913927973415;379.24908680812007;15511.224438778072;16525;16932.83067169328;16976.236069376875;17692.55768605784;10817.513211905463;11036.006759391654;15810.525684229462;16072.839271607281;16127.113008784512;4969.62727795415;5189.558887494568;5398.244245805571;5399.217113518537;5409.675419474825;5234.398044224925;5315.920261196085;5316.840494785143;5549.889002219953;5552.472515111058;5091.465396133408;5328.8401347959625;5543.501084902358;5545.667259964395;5555.972220138914;5236.240745091978;5248.160294352923;5274.235235890794;5298.682079075248;5685;5345.118055520873;5375.489328513824;5394.352677678665;5403.5136837684795;5420.7018613976215;12010.759784804342;12832.03759718025;18186.544816449874;19612.41162765105;20006.199752009903;2083.6874468829647;2099.769025407204;2134.135675051591;2187.201671389931;2434.0142242391858;12176.939115304456;12186.51253949841;12400.379981000913;12790.48838046477;12822.615321540368;1824.7354133650679;1835.8347748702681;1846.2799508191815;1847.2057015483338;1850.8149185081384;52125.218121728205;54986.45013549853;54994;55547;55856.44143558593;9972.351797133164;10191.388516689023;10220.897791022144;10279.074883260393;10395.32430392022;13381.93309033468;13469.932650336686;13507.729845403037;13523.526676566273;13576.117552359263;7459.664315105725;7514.812129696801;7518.436117291116;7573.659185336673;7616.657250423744;7110.5733655979775;7126.394256488153;7141.82145446368;7166.928330716626;7187.820304492429;4388.692791504628;4441.755703436277;4470.418845550058;4480.551944805494;4482.843100491467;1793.4709260768104;1866.4027511196286;1870.2518992402875;1889.093235247089;2913.8251704897775;469.4390203706606;834.3283656656329;919.650532797546;978.3347323819871;1033.5194134727387;10335.741606459898;10673.35959842412;10859.619913303155;11100;11171;469.1344469453852;477.40801406256685;483.68437849050525;493.89628178082285;513.3726088300098;5784.450477204743;5971.2834459864225;5993.101034844721;6066.272047354346;6088.908666370008;525019;533695;535959;542706;554998;67046;67542.66228668825;69502.30497694958;70263.64868175627;71044;494.6067876038558;501.6989806116374;502.17893743729263;502.56779169913847;505.6637336171405;9375.390599611004;9386.296027797805;9521.523923803921;9587.712368628952;9626.941036485841;28241;28889.7111028887;29437.85281073581;30439.54340684936;30576.235594110327;42241.57758422376;42707.57292427036;42832.35751463793;43022.784886075366;44619.776901115285;7214.71141154348;7241.565506069653;7343.8531229376185;7534.472586918863;7537;9995.350302230332;10493.737656558647;10715.892841071489;10798.082163016232;10951.45242737844;7262.854742905007;7431.182569917197;7432.799924155223;7451.666083828919;7530.322270995418;7111.964440177766;7402.1857595665515;7653.043369578802;7685.5004424712215;7748.14770375247;7606.163322034682;7713.421493387906;7814.062312522534;7848.803779905548;7854.803629909298;9717.319787614799;9721;9837.557309920927;9947.850782238127;10020.148287395654;6746.831329216809;6895.862082758216;7284.745033923788;7375.446841487017;7456 23:26:56 INFO - PROCESS | 4019 | |3;mootools.html;1462.1519518679165;1476.6825132596489;1642.3102297035243;1765.9823401765977;1801.57662949207;7845.92154078459;7926.247006534384;8045.356371490281;8052.758417247484;8084.797880052987;7913.762587122395;7982.962214912053;8115;8115.472494287882;8119.675212991488;2236.910523579059;2270.7842754938256;2273;2286.702728645282;2289.5306462175213;2226.7995880370763;2327.4763178284834;2401.903923843044;2407.374082738492;2416.32342943976;2286.3941055620276;2288.164819840763;2289.496310811619;2352.2355234548754;2352.4236562042324;2261.694671219381;2269.965950510744;2282.087165133951;2284.7715228477186;2286.1884031168943;2303.1478353009325;2306.6078766609717;2319.512902290521;2324.37241944674;2332.346942856003;7897.289243968013;7916.960415197945;7932.127465978738;7936.8412631747615;7952.125266220711;4695.225287827504;4761.761911904391;4764.595009424203;4766.451858036336;4786.162421576245;3081.152683012167;3142.685731426862;3214.453542897713;3223.580934478526;3229.40256052631;1065.4779158212498;1078.4230436716318;1079.854219680341;1087.1846115413439;1099.142668718401;11027.22809403342;11099.223054386115;11130.38782866942;11161.553537858475;11173.553057877594;4171.10321280926;4306.354046892991;4309.504406993173;4325.480942286946;4345.804438800262;9018.819623607491;9021.548922553846;9072.773180670536;9099.454032758056;9144.771380715536;4721.504242054603;4743.075100355467;4769.594584460359;4802.543758342952;4808.110499557523;4380.649548036149;4390.07808360248;4394.340848872695;4397.36238245459;4419.204543182258;3418.179636887129;3488.9127771805906;3507.2459421224557;3530.5763308403157;3538.380783362901;1064.3401091323428;1082.258652822819;1086.440483151178;1095.3592148593161;1130.0451118804597;1325.4499382756242;1336.5789776220458;1353.2286596639822;1356.0846428660614;1363.175278956237;7214.927850721426;7508.361789247975;7693.038370203724;7737.8452430951065;7763.883541746878;1127.3067063755732;1130.5082289204222;1132.2244262679926;1140.43548443521;1148;5800.738966746507;5846.590738648254;5888.440598143169;5901.1148327750325;5904.911426328608;9152;9460.810783784285;9526.952365238269;9564.95217523908;9639.662611808553;9561.235101191887;9590.42457452555;9637.277204209713;9647.614095436244;9685.273604479693;7446.962765186247;7636.618169091523;7641.197674244125;7681.846363072819;7714.652840622185;7223.422126229994;7319.780406587811;7340;7354.080739907512;7439.851202975802;8497.1502849717;8577.828443430972;8697.95651021741;8752.64989400417;8787.736367908972;8854.335924805795;8950.507722075088;8989.865152022594;9086.000539940469;9100.954495227481;6834.897476537955;6884.827879303058;6901.792946211622;6908.205556360882;6916.789561826559;7499.850003000019;7601.581912994839;7675.194104619158;7720.150783413707;7751;6106.419890110433;6896.344847239504;7257.129144502694;7343.632818359168;7386.926130738624;6659.367360100783;6759.763408280686;6794.218664853407;6815.250322464624;6835.213950395768;6651.900221496779;6722.899156512754;6724.663766811542;6746.123004009447;6770.187577490536;6392.097188614652;6396.840078998062;6483.967580162069;6532.314107018695;6613.6693165340575;6528.21661400635;6573.408393244631;6582.473402127723;6600.273969863215;6602.207735071822 23:26:56 INFO - PROCESS | 4019 | |4;prototype.html;352.344638971513;357.5673435143476;359.5487662982956;364.5206553382302;365.7439792145499;6184.81445556634;6201.689915504229;6248.437640612344;6293.118963345135;6380.213540208737;6223.2532096148525;6243.625382477043;6254.593451425654;6273.749050037993;6277.937220627804;4669.743164125972;4702.882427939312;4710.3405523226775;4722.527747225285;4727.976360118212;4710.576048155665;4724.4094488188975;4730.97634511827;4732.290156476539;4734.934639706073;4578.2903649934315;4598.126355992351;4629.166749985001;4667.089917466078;4679.976600116995;4628.675992680513;4659.347691323217;4659.557342052533;4662.020975595112;4676.55572720591;4120.299549076634;4122.2579935611575;4123.381492776108;4125.401816736587;4128.153728485653;5904.5571582131515;5912.526997840206;5916.349201587822;5942.197803296586;5948.107783832416;5383.703896285702;5499.642523236017;5528.834134975958;5535.25274087997;5550.4449555044575;6525.477961763095;6564.835879103013;6577.539572229945;6583.703733332011;6590;4555.157295900269;4565.840195593171;4577.725336479822;4587.839425620121;4596.35651008859;6811.897821532681;6862.9313706862795;7017.087778588751;7018.227994920555;7024.683889224997;4643.791029403617;4646.442426908725;4649.744264065441;4666.390095417076;4668.789904454307;4688.226442636995;4701.929471057937;4703.341532185496;4708.646851486153;4711.7879695413785;5451.618386712892;5465.836024919259;5468.589855760833;5469.863253418696;5470.835874923759;6524.282328943812;6634.436072933758;6643.701033453506;6653.866922661519;6654.401103900672;1654.7600597913236;1681.865450763936;1682.86537077036;1683.1752441303918;1683.5538582275706;1125.471028616549;1132.4337831084458;1132.6262333429947;1146.1461211397561;1147.9540818367173;6221.844453888689;6253.906191407133;6296;6302.810915672537;6336.303006669263;6765.391114799691;6839.316068393121;6842.144731908512;6843.8973415398805;6876;6022.728977196037;6114.266288045463;6237.532185086136;6303.810885673437;6307.653079080603;3699.056740531147;3700.6114357992024;3706.980580340428;3712.294664013829;3732.5147730795366;7061.646917654097;7193.604351760599;7201.3158749918675;7204.24355442671;7204.603746793977;6932.202796678446;7034.859302813915;7063.399611033017;7108.969199466152;7110.537815042109;7164.283571642898;7174.210836807947;7175.96412017947;7188.784336469915;7192.352688258082;6840.179178498612;6862.9313706862295;6896.931030689629;6905.274946130584;6926.8614627708175;6726.327367263235;6816.965915170393;6842.315768423118;6844.28135045813;6852.937794641838;7080.716771329089;7081.610511421921;7155;7157.96209549602;7188.065551478275;4557.361969324231;4574.199515084781;4616.769161541976;4620.930686039779;4625.121226966866;6817;6871.793846184622;6922.06552115458;6922.861542769016;6953;6714.529982901346;6730.629815360202;6731.899021514583;6734.451076252391;6746.0555522227905;6713.395794378529;6718.596884186964;6732.158480189976;6732.596044237362;6735.764248251287;6403.263624683221;6531.563056127644;6576.638284894377;6580.078788969452;6584.934150658432;6701.698423570853;6741.764038258638;6745.190577130776;6745.954377071562;6758.391744742997;6415.711292991733;6549.984752363392;6588.07766912623;6597.241317248578;6603.7688680895935 23:26:56 INFO - PROCESS | 4019 | |5;yui.html;746.2015643261709;749.917509074002;759.7151068349369;801.178791738468;878.5651102704162;13326.600201993944;13362.131461455;13384.93307533461;13443.46226150954;13493.595192144227;12517.874821251784;12520.311382873939;13025.934870325658;13056.281904495272;13102.47590096395;810.1331575214523;811.4928169893816;825.5624519004937;829.1832544943226;831.1605278668528;819.315871247509;823.8640624296984;826.6941231744263;828.4987582512583;833.5165603949725;862.5169904853271;871.442276942754;872.8996165440992;873.1268731268731;876.2332958661171;856.1908995998783;857.785553611594;861.1990848510883;867.4795122926225;871.2202578692066;632.3455223843346;634.3624657219511;636.7771280051991;638.7540796793221;639.11163482759;13255.867441325656;13288.867111328957;13350.19898806065;13373.598792036157;13944.860551394459;12616.495340186382;12644.747105057848;12829.422675979604;12890.484380624765;12978.935105324508;10779.407132607703;10791.406472644001;10867.239293249475;10936.56253749849;11139.498722557504;3550.14796448853;3577.141486043357;3598.4962105305276;3746.8875933722034;3752.5309336332957;47406.5259347409;47499.525004750205;47833.52166478326;47844;47937.760311198566;9237.491937943343;9508.906475755239;9581.856272155923;10042.949785251027;10064.849027264598;16719.247633856507;16819.243134058997;16883.40908068212;16895.662086758195;16910.239039243017;7227.168875579376;7368.557886526718;7400.407967362706;7415.3326200642205;7423.888641670379;3929.960700393017;4011.3782363733667;4197.24449599069;4235.047114399235;4238.579438507731;3101.4727496325677;3121.7970831895855;3128.89048883288;3138.6547479777205;3149.700778426046;549.7031602934451;566.03773584905;578.8784355285353;579.5016285994042;588.341058015026;534.3534323468568;560.2660514725723;571.9971400143056;572.1789232451446;597.4354235247649;8204.507729536246;8535.701250456328;8576.742697719079;8695.913040869636;8852.822943541094;499.85254349966846;558.8044184535462;563.7970330680952;607.9300880398811;633.8795628830508;3898.3958279629774;3980;4051.756894586334;4063.167050754588;4087.8978025549004;49036.509634903196;49637.25544116841;49809.75095124501;50063.74968125209;50272.49727502751;48107.75946120247;48260.75869620629;48391.75804120957;48458;48972;44276.557234427244;45390.773046134556;47203.76398117987;47543.5245647546;48487.75756121197;8480.067192608685;8508.702195423131;8776.517291548771;8837.248833849195;8908.955455222942;35128.29743405169;35227.295454090265;35823.46264805978;36024;36059.27881442409;43574.12851742884;43906.780466097465;44198.55801441945;44893;44903.32645010393;10231.48842557884;10357.4303413313;10626.52180651857;10771.458570738976;11393.259438136494;12291.56979505713;12469.5012199511;12676.683082923;12802.935985320386;13053.34733263352;11178.552857885594;11210.27133236337;11506.827397588875;11534.423278836193;11541.307521548733;11658.475368608602;11780.76438471243;11901.940490297493;12243.75512489763;12301.630951071482;10611.257211995086;10898.618548350769;11456.140789440658;11758.294502329887;11885.821712674144;8471.872921906299;8829.64681412762;8906.38150403475;9506.334556580972;9560.235181185628;9683.9031609683;9992.250581206585;10065.993400660169;10131.594736210469;10277.922918066293 23:26:56 INFO - PROCESS | 4019 | __end_tp_report 23:26:56 INFO - PROCESS | 4019 | __start_cc_report 23:26:56 INFO - PROCESS | 4019 | _x_x_mozilla_cycle_collect,317 23:26:56 INFO - PROCESS | 4019 | __end_cc_report 23:26:56 INFO - PROCESS | 4019 | __startTimestamp1453706816710__endTimestamp 23:26:56 INFO - PROCESS | 4019 | 23:26:56 INFO - PROCESS | 4019 | ------- Summary: start ------- 23:26:56 INFO - PROCESS | 4019 | Number of tests: 6 23:26:56 INFO - PROCESS | 4019 | 23:26:56 INFO - PROCESS | 4019 | [#0] dojo.html Cycles:165 Average:5135.50 Median:5326.23 stddev:557.40 (10.5%) stddev-sans-first:535.32 23:26:56 INFO - PROCESS | 4019 | Values: 3081.6 3119.5 3121.9 3142.2 3151.1 5047.8 5090.8 5097.2 5103.3 5110.3 5018.4 5120.5 5139.3 5174.1 5185.1 4637.8 4662.0 4680.7 4740.6 4748.2 4759.7 4760.7 4766.8 4817.6 4854.3 4597.4 4666.6 4688.6 4750.3 4755.8 4686.9 4692.6 4696.9 4709.1 4729.3 4504.1 4691.9 4701.0 4704.0 4740.1 4952.8 5024.7 5034.4 5040.5 5058.1 5450.5 5488.8 5508.9 5513.6 5545.2 5430.2 5500.8 5549.6 5567.6 5569.4 5209.0 5215.6 5251.1 5258.2 5295.0 5657.2 5700.0 5701.8 5706.5 5712.0 5290.3 5359.0 5467.8 5504.3 5553.7 5517.0 5533.9 5535.1 5547.3 5562.9 5498.3 5501.0 5516.6 5525.6 5536.3 5340.2 5402.7 5529.1 5533.8 5584.1 4288.0 4318.8 4321.4 4322.2 4355.2 3859.3 3860.1 3888.4 3892.0 3900.7 5068.5 5197.1 5198.3 5205.8 5264.5 5503.6 5507.1 5538.6 5546.4 5562.1 5023.5 5180.3 5186.2 5190.5 5240.4 4643.3 4711.4 4716.8 4722.7 4783.9 5719.4 5761.4 5765.9 5766.9 5771.2 5404.5 5480.6 5566.8 5576.5 5641.5 5673.1 5685.7 5696.7 5713.3 5743.0 5378.6 5443.1 5445.4 5446.8 5460.8 5326.2 5435.1 5552.6 5554.3 5587.8 5481.2 5485.3 5486.0 5499.9 5499.9 5429.4 5429.7 5431.6 5441.1 5482.3 5081.2 5151.5 5290.3 5331.3 5352.1 5394.2 5404.9 5412.0 5412.9 5421.5 5301.1 5312.8 5319.8 5328.6 5356.1 23:26:56 INFO - PROCESS | 4019 | 23:26:56 INFO - PROCESS | 4019 | [#1] ext.html Cycles:180 Average:45876.64 Median:34597.33 stddev:77751.01 (224.7%) stddev-sans-first:77894.45 23:26:56 INFO - PROCESS | 4019 | Values: 493.2 520.9 532.2 534.6 554.2 28528.1 36700.3 36768.6 36995.6 37118.7 38938.8 39349.4 39404.2 39535.8 39608.6 8328.1 8460.2 8465.5 8496.4 8527.7 8220.0 8288.3 8314.7 8323.3 8352.7 8339.7 8398.5 8426.8 8427.0 8456.8 8274.4 8321.5 8396.7 8531.1 8595.8 8363.9 8449.4 8477.1 8492.8 8496.7 39154.2 39332.6 39386.8 39541.0 39606.0 3098.7 3156.1 3306.1 3398.3 3732.9 30090.8 30188.8 30635.8 30759.2 31774.2 3870.4 3892.7 3906.8 3918.5 3986.7 249445.0 253332.0 253734.0 254326.7 255375.0 51884.2 52462.5 53039.2 58628.4 59345.7 53540.5 53677.7 54038.0 54051.5 54216.0 14482.9 14506.7 14550.4 14577.3 14769.4 11102.9 11211.9 11258.0 11298.3 11324.3 19521.3 19733.2 20007.6 20019.4 20057.3 7655.4 7741.8 7773.2 7833.6 7897.2 917.4 989.1 998.0 1016.5 1059.3 29111.4 29196.4 29375.1 29517.4 29559.4 1045.6 1082.5 1083.1 1102.5 1109.6 14471.8 14688.8 14715.0 14860.9 14881.5 324001.0 328826.0 329532.0 330004.0 330938.0 51923.0 52054.5 52164.7 52301.2 52481.5 1327.2 1338.9 1341.6 1347.3 1351.6 27410.7 28544.3 28660.7 28699.7 28796.3 46300.5 46354.5 46575.8 46683.3 46846.3 302451.0 302698.0 305942.0 306197.0 306455.0 30330.0 30934.4 31021.7 31047.0 31201.8 42093.6 42688.0 43241.8 43450.6 43976.3 35386.5 35835.5 36445.1 36513.8 37056.8 32871.2 33554.8 33572.7 34067.7 35127.0 32282.4 32690.2 32726.8 33002.5 33114.8 29809.3 30328.0 30596.4 30889.0 31075.0 24055.4 25646.5 26050.3 26306.9 27513.3 23:26:56 INFO - PROCESS | 4019 | 23:26:56 INFO - PROCESS | 4019 | [#2] jquery.html Cycles:180 Average:26569.63 Median:5235.32 stddev:88020.46 (1681.3%) stddev-sans-first:88245.39 23:26:56 INFO - PROCESS | 4019 | Values: 367.5 368.3 371.4 371.9 379.2 15511.2 16525.0 16932.8 16976.2 17692.6 10817.5 11036.0 15810.5 16072.8 16127.1 4969.6 5189.6 5398.2 5399.2 5409.7 5234.4 5315.9 5316.8 5549.9 5552.5 5091.5 5328.8 5543.5 5545.7 5556.0 5236.2 5248.2 5274.2 5298.7 5685.0 5345.1 5375.5 5394.4 5403.5 5420.7 12010.8 12832.0 18186.5 19612.4 20006.2 2083.7 2099.8 2134.1 2187.2 2434.0 12176.9 12186.5 12400.4 12790.5 12822.6 1824.7 1835.8 1846.3 1847.2 1850.8 52125.2 54986.5 54994.0 55547.0 55856.4 9972.4 10191.4 10220.9 10279.1 10395.3 13381.9 13469.9 13507.7 13523.5 13576.1 7459.7 7514.8 7518.4 7573.7 7616.7 7110.6 7126.4 7141.8 7166.9 7187.8 4388.7 4441.8 4470.4 4480.6 4482.8 1793.5 1866.4 1870.3 1889.1 2913.8 469.4 834.3 919.7 978.3 1033.5 10335.7 10673.4 10859.6 11100.0 11171.0 469.1 477.4 483.7 493.9 513.4 5784.5 5971.3 5993.1 6066.3 6088.9 525019.0 533695.0 535959.0 542706.0 554998.0 67046.0 67542.7 69502.3 70263.6 71044.0 494.6 501.7 502.2 502.6 505.7 9375.4 9386.3 9521.5 9587.7 9626.9 28241.0 28889.7 29437.9 30439.5 30576.2 42241.6 42707.6 42832.4 43022.8 44619.8 7214.7 7241.6 7343.9 7534.5 7537.0 9995.4 10493.7 10715.9 10798.1 10951.5 7262.9 7431.2 7432.8 7451.7 7530.3 7112.0 7402.2 7653.0 7685.5 7748.1 7606.2 7713.4 7814.1 7848.8 7854.8 9717.3 9721.0 9837.6 9947.9 10020.1 6746.8 6895.9 7284.7 7375.4 7456.0 23:26:56 INFO - PROCESS | 4019 | 23:26:56 INFO - PROCESS | 4019 | [#3] mootools.html Cycles:180 Average:5558.98 Median:6249.26 stddev:2889.85 (46.2%) stddev-sans-first:2881.55 23:26:56 INFO - PROCESS | 4019 | Values: 1462.2 1476.7 1642.3 1766.0 1801.6 7845.9 7926.2 8045.4 8052.8 8084.8 7913.8 7983.0 8115.0 8115.5 8119.7 2236.9 2270.8 2273.0 2286.7 2289.5 2226.8 2327.5 2401.9 2407.4 2416.3 2286.4 2288.2 2289.5 2352.2 2352.4 2261.7 2270.0 2282.1 2284.8 2286.2 2303.1 2306.6 2319.5 2324.4 2332.3 7897.3 7917.0 7932.1 7936.8 7952.1 4695.2 4761.8 4764.6 4766.5 4786.2 3081.2 3142.7 3214.5 3223.6 3229.4 1065.5 1078.4 1079.9 1087.2 1099.1 11027.2 11099.2 11130.4 11161.6 11173.6 4171.1 4306.4 4309.5 4325.5 4345.8 9018.8 9021.5 9072.8 9099.5 9144.8 4721.5 4743.1 4769.6 4802.5 4808.1 4380.6 4390.1 4394.3 4397.4 4419.2 3418.2 3488.9 3507.2 3530.6 3538.4 1064.3 1082.3 1086.4 1095.4 1130.0 1325.4 1336.6 1353.2 1356.1 1363.2 7214.9 7508.4 7693.0 7737.8 7763.9 1127.3 1130.5 1132.2 1140.4 1148.0 5800.7 5846.6 5888.4 5901.1 5904.9 9152.0 9460.8 9527.0 9565.0 9639.7 9561.2 9590.4 9637.3 9647.6 9685.3 7447.0 7636.6 7641.2 7681.8 7714.7 7223.4 7319.8 7340.0 7354.1 7439.9 8497.2 8577.8 8698.0 8752.6 8787.7 8854.3 8950.5 8989.9 9086.0 9101.0 6834.9 6884.8 6901.8 6908.2 6916.8 7499.9 7601.6 7675.2 7720.2 7751.0 6106.4 6896.3 7257.1 7343.6 7386.9 6659.4 6759.8 6794.2 6815.3 6835.2 6651.9 6722.9 6724.7 6746.1 6770.2 6392.1 6396.8 6484.0 6532.3 6613.7 6528.2 6573.4 6582.5 6600.3 6602.2 23:26:56 INFO - PROCESS | 4019 | 23:26:56 INFO - PROCESS | 4019 | [#4] prototype.html Cycles:180 Average:5542.69 Median:6264.17 stddev:1692.91 (27.0%) stddev-sans-first:1652.23 23:26:56 INFO - PROCESS | 4019 | Values: 352.3 357.6 359.5 364.5 365.7 6184.8 6201.7 6248.4 6293.1 6380.2 6223.3 6243.6 6254.6 6273.7 6277.9 4669.7 4702.9 4710.3 4722.5 4728.0 4710.6 4724.4 4731.0 4732.3 4734.9 4578.3 4598.1 4629.2 4667.1 4680.0 4628.7 4659.3 4659.6 4662.0 4676.6 4120.3 4122.3 4123.4 4125.4 4128.2 5904.6 5912.5 5916.3 5942.2 5948.1 5383.7 5499.6 5528.8 5535.3 5550.4 6525.5 6564.8 6577.5 6583.7 6590.0 4555.2 4565.8 4577.7 4587.8 4596.4 6811.9 6862.9 7017.1 7018.2 7024.7 4643.8 4646.4 4649.7 4666.4 4668.8 4688.2 4701.9 4703.3 4708.6 4711.8 5451.6 5465.8 5468.6 5469.9 5470.8 6524.3 6634.4 6643.7 6653.9 6654.4 1654.8 1681.9 1682.9 1683.2 1683.6 1125.5 1132.4 1132.6 1146.1 1148.0 6221.8 6253.9 6296.0 6302.8 6336.3 6765.4 6839.3 6842.1 6843.9 6876.0 6022.7 6114.3 6237.5 6303.8 6307.7 3699.1 3700.6 3707.0 3712.3 3732.5 7061.6 7193.6 7201.3 7204.2 7204.6 6932.2 7034.9 7063.4 7109.0 7110.5 7164.3 7174.2 7176.0 7188.8 7192.4 6840.2 6862.9 6896.9 6905.3 6926.9 6726.3 6817.0 6842.3 6844.3 6852.9 7080.7 7081.6 7155.0 7158.0 7188.1 4557.4 4574.2 4616.8 4620.9 4625.1 6817.0 6871.8 6922.1 6922.9 6953.0 6714.5 6730.6 6731.9 6734.5 6746.1 6713.4 6718.6 6732.2 6732.6 6735.8 6403.3 6531.6 6576.6 6580.1 6584.9 6701.7 6741.8 6745.2 6746.0 6758.4 6415.7 6550.0 6588.1 6597.2 6603.8 23:26:56 INFO - PROCESS | 4019 | 23:26:56 INFO - PROCESS | 4019 | [#5] yui.html Cycles:180 Average:13487.15 Median:45147.05 stddev:15194.58 (33.7%) stddev-sans-first:15207.08 23:26:56 INFO - PROCESS | 4019 | Values: 746.2 749.9 759.7 801.2 878.6 13326.6 13362.1 13384.9 13443.5 13493.6 12517.9 12520.3 13025.9 13056.3 13102.5 810.1 811.5 825.6 829.2 831.2 819.3 823.9 826.7 828.5 833.5 862.5 871.4 872.9 873.1 876.2 856.2 857.8 861.2 867.5 871.2 632.3 634.4 636.8 638.8 639.1 13255.9 13288.9 13350.2 13373.6 13944.9 12616.5 12644.7 12829.4 12890.5 12978.9 10779.4 10791.4 10867.2 10936.6 11139.5 3550.1 3577.1 3598.5 3746.9 3752.5 47406.5 47499.5 47833.5 47844.0 47937.8 9237.5 9508.9 9581.9 10042.9 10064.8 16719.2 16819.2 16883.4 16895.7 16910.2 7227.2 7368.6 7400.4 7415.3 7423.9 3930.0 4011.4 4197.2 4235.0 4238.6 3101.5 3121.8 3128.9 3138.7 3149.7 549.7 566.0 578.9 579.5 588.3 534.4 560.3 572.0 572.2 597.4 8204.5 8535.7 8576.7 8695.9 8852.8 499.9 558.8 563.8 607.9 633.9 3898.4 3980.0 4051.8 4063.2 4087.9 49036.5 49637.3 49809.8 50063.7 50272.5 48107.8 48260.8 48391.8 48458.0 48972.0 44276.6 45390.8 47203.8 47543.5 48487.8 8480.1 8508.7 8776.5 8837.2 8909.0 35128.3 35227.3 35823.5 36024.0 36059.3 43574.1 43906.8 44198.6 44893.0 44903.3 10231.5 10357.4 10626.5 10771.5 11393.3 12291.6 12469.5 12676.7 12802.9 13053.3 11178.6 11210.3 11506.8 11534.4 11541.3 11658.5 11780.8 11901.9 12243.8 12301.6 10611.3 10898.6 11456.1 11758.3 11885.8 8471.9 8829.6 8906.4 9506.3 9560.2 9683.9 9992.3 10066.0 10131.6 10277.9 23:26:56 INFO - PROCESS | 4019 | -------- Summary: end -------- 23:26:56 INFO - PROCESS | 4019 | 23:26:57 INFO - TEST-INFO | 4019: exit 0 23:26:57 INFO - TEST-OK | dromaeo_css | took 1110159ms 23:26:57 INFO - TEST-START | kraken 23:26:57 INFO - operating with platform_type : linux_ 23:26:57 INFO - Initialising browser for kraken test... 23:26:57 INFO - TEST-INFO | started process 4261 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFmlyrq/profile http://localhost:53622/getInfo.html) 23:27:01 INFO - PROCESS | 4261 | 23:27:01 INFO - PROCESS | 4261 | (process:4333): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:27:02 INFO - PROCESS | 4261 | __metrics Screen width/height:1600/1200 23:27:02 INFO - PROCESS | 4261 | colorDepth:24 23:27:02 INFO - PROCESS | 4261 | Browser inner width/height: 1024/697 23:27:02 INFO - PROCESS | 4261 | __metrics 23:27:02 INFO - PROCESS | 4261 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:27:03 INFO - TEST-INFO | 4261: exit 0 23:27:03 INFO - Browser initialized. 23:27:03 INFO - Running cycle 1/1 for kraken test... 23:27:03 INFO - TEST-INFO | started process 4382 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFmlyrq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:27:04 INFO - PROCESS | 4382 | 23:27:04 INFO - PROCESS | 4382 | (process:4439): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:27:15 INFO - PROCESS | 4382 | RSS: Main: 150265856 23:27:15 INFO - PROCESS | 4382 | 23:27:17 INFO - PROCESS | 4382 | Cycle 1(1): loaded http://localhost:53622/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53622/tests/kraken/driver.html?testName=audio-beat-detection) 23:27:18 INFO - PROCESS | 4382 | RSS: Main: 154906624 23:27:18 INFO - PROCESS | 4382 | 23:27:21 INFO - PROCESS | 4382 | Cycle 1(1): loaded http://localhost:53622/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53622/tests/kraken/driver.html?testName=audio-dft) 23:27:21 INFO - PROCESS | 4382 | RSS: Main: 159039488 23:27:21 INFO - PROCESS | 4382 | 23:27:24 INFO - PROCESS | 4382 | Cycle 1(1): loaded http://localhost:53622/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53622/tests/kraken/driver.html?testName=audio-fft) 23:27:25 INFO - PROCESS | 4382 | RSS: Main: 151920640 23:27:25 INFO - PROCESS | 4382 | 23:27:27 INFO - PROCESS | 4382 | Cycle 1(1): loaded http://localhost:53622/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53622/tests/kraken/driver.html?testName=audio-oscillator) 23:27:27 INFO - PROCESS | 4382 | RSS: Main: 152551424 23:27:27 INFO - PROCESS | 4382 | 23:27:29 INFO - PROCESS | 4382 | Cycle 1(1): loaded http://localhost:53622/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53622/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:27:30 INFO - PROCESS | 4382 | RSS: Main: 152735744 23:27:30 INFO - PROCESS | 4382 | 23:27:33 INFO - PROCESS | 4382 | Cycle 1(1): loaded http://localhost:53622/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53622/tests/kraken/driver.html?testName=imaging-darkroom) 23:27:34 INFO - PROCESS | 4382 | RSS: Main: 152170496 23:27:34 INFO - PROCESS | 4382 | 23:27:37 INFO - PROCESS | 4382 | Cycle 1(1): loaded http://localhost:53622/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53622/tests/kraken/driver.html?testName=imaging-desaturate) 23:27:38 INFO - PROCESS | 4382 | RSS: Main: 152772608 23:27:38 INFO - PROCESS | 4382 | 23:27:40 INFO - PROCESS | 4382 | Cycle 1(1): loaded http://localhost:53622/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53622/tests/kraken/driver.html?testName=json-parse-financial) 23:27:41 INFO - PROCESS | 4382 | RSS: Main: 155459584 23:27:41 INFO - PROCESS | 4382 | 23:27:43 INFO - PROCESS | 4382 | Cycle 1(1): loaded http://localhost:53622/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53622/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:27:43 INFO - PROCESS | 4382 | RSS: Main: 154828800 23:27:43 INFO - PROCESS | 4382 | 23:27:45 INFO - PROCESS | 4382 | Cycle 1(1): loaded http://localhost:53622/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53622/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:27:46 INFO - PROCESS | 4382 | RSS: Main: 153677824 23:27:46 INFO - PROCESS | 4382 | 23:27:48 INFO - PROCESS | 4382 | Cycle 1(1): loaded http://localhost:53622/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53622/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:27:48 INFO - PROCESS | 4382 | RSS: Main: 154230784 23:27:48 INFO - PROCESS | 4382 | 23:27:51 INFO - PROCESS | 4382 | Cycle 1(1): loaded http://localhost:53622/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53622/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:27:51 INFO - PROCESS | 4382 | RSS: Main: 155824128 23:27:51 INFO - PROCESS | 4382 | 23:27:54 INFO - PROCESS | 4382 | Cycle 1(1): loaded http://localhost:53622/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53622/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:27:54 INFO - PROCESS | 4382 | RSS: Main: 155795456 23:27:54 INFO - PROCESS | 4382 | 23:27:56 INFO - PROCESS | 4382 | Cycle 1(1): loaded http://localhost:53622/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53622/tests/kraken/driver.html?testName=ai-astar) 23:27:56 INFO - PROCESS | 4382 | RSS: Main: 156545024 23:27:56 INFO - PROCESS | 4382 | 23:27:56 INFO - PROCESS | 4382 | __start_tp_report 23:27:56 INFO - PROCESS | 4382 | _x_x_mozilla_page_load 23:27:56 INFO - PROCESS | 4382 | _x_x_mozilla_page_load_details 23:27:56 INFO - PROCESS | 4382 | |i|pagename|runs| 23:27:56 INFO - PROCESS | 4382 | |0;ai-astar;116;105;111;111;112;122;110;112;111;113 23:27:56 INFO - PROCESS | 4382 | |1;audio-beat-detection;157;127;154;166;126;148;150;134;163;128 23:27:56 INFO - PROCESS | 4382 | |2;audio-dft;163;162;163;162;163;160;160;167;166;161 23:27:56 INFO - PROCESS | 4382 | |3;audio-fft;72;74;74;77;74;135;76;73;76;73 23:27:56 INFO - PROCESS | 4382 | |4;audio-oscillator;97;96;148;96;96;96;142;97;96;136 23:27:56 INFO - PROCESS | 4382 | |5;imaging-gaussian-blur;110;109;109;110;109;110;110;109;109;111 23:27:56 INFO - PROCESS | 4382 | |6;imaging-darkroom;146;148;150;147;147;146;147;146;147;147 23:27:56 INFO - PROCESS | 4382 | |7;imaging-desaturate;97;97;97;97;96;96;97;97;96;96 23:27:56 INFO - PROCESS | 4382 | |8;json-parse-financial;62;63;61;60;60;60;60;62;69;59 23:27:56 INFO - PROCESS | 4382 | |9;json-stringify-tinderbox;67;68;74;68;70;68;69;68;67;67 23:27:56 INFO - PROCESS | 4382 | |10;stanford-crypto-aes;82;82;84;85;84;84;90;90;83;82 23:27:56 INFO - PROCESS | 4382 | |11;stanford-crypto-ccm;116;121;121;117;126;115;132;117;128;124 23:27:56 INFO - PROCESS | 4382 | |12;stanford-crypto-pbkdf2;133;151;147;142;148;141;155;149;143;148 23:27:56 INFO - PROCESS | 4382 | |13;stanford-crypto-sha256-iterative;70;70;67;67;73;68;66;66;69;66 23:27:56 INFO - PROCESS | 4382 | __end_tp_report 23:27:56 INFO - PROCESS | 4382 | __start_cc_report 23:27:56 INFO - PROCESS | 4382 | _x_x_mozilla_cycle_collect,730 23:27:56 INFO - PROCESS | 4382 | __end_cc_report 23:27:56 INFO - PROCESS | 4382 | __startTimestamp1453706876883__endTimestamp 23:27:56 INFO - PROCESS | 4382 | 23:27:56 INFO - PROCESS | 4382 | ------- Summary: start ------- 23:27:56 INFO - PROCESS | 4382 | Number of tests: 14 23:27:56 INFO - PROCESS | 4382 | 23:27:56 INFO - PROCESS | 4382 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:4.37 (3.9%) stddev-sans-first:4.43 23:27:56 INFO - PROCESS | 4382 | Values: 116.0 105.0 111.0 111.0 112.0 122.0 110.0 112.0 111.0 113.0 23:27:56 INFO - PROCESS | 4382 | 23:27:56 INFO - PROCESS | 4382 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:152.00 stddev:15.34 (10.1%) stddev-sans-first:15.68 23:27:56 INFO - PROCESS | 4382 | Values: 157.0 127.0 154.0 166.0 126.0 148.0 150.0 134.0 163.0 128.0 23:27:56 INFO - PROCESS | 4382 | 23:27:56 INFO - PROCESS | 4382 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:2.31 (1.4%) stddev-sans-first:2.45 23:27:56 INFO - PROCESS | 4382 | Values: 163.0 162.0 163.0 162.0 163.0 160.0 160.0 167.0 166.0 161.0 23:27:56 INFO - PROCESS | 4382 | 23:27:56 INFO - PROCESS | 4382 | [#3] audio-fft Cycles:10 Average:80.40 Median:74.00 stddev:19.25 (26.0%) stddev-sans-first:20.17 23:27:56 INFO - PROCESS | 4382 | Values: 72.0 74.0 74.0 77.0 74.0 135.0 76.0 73.0 76.0 73.0 23:27:56 INFO - PROCESS | 4382 | 23:27:56 INFO - PROCESS | 4382 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:96.00 stddev:22.27 (23.2%) stddev-sans-first:23.11 23:27:56 INFO - PROCESS | 4382 | Values: 97.0 96.0 148.0 96.0 96.0 96.0 142.0 97.0 96.0 136.0 23:27:56 INFO - PROCESS | 4382 | 23:27:56 INFO - PROCESS | 4382 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 23:27:56 INFO - PROCESS | 4382 | Values: 110.0 109.0 109.0 110.0 109.0 110.0 110.0 109.0 109.0 111.0 23:27:56 INFO - PROCESS | 4382 | 23:27:56 INFO - PROCESS | 4382 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.20 (0.8%) stddev-sans-first:1.20 23:27:56 INFO - PROCESS | 4382 | Values: 146.0 148.0 150.0 147.0 147.0 146.0 147.0 146.0 147.0 147.0 23:27:56 INFO - PROCESS | 4382 | 23:27:56 INFO - PROCESS | 4382 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 23:27:56 INFO - PROCESS | 4382 | Values: 97.0 97.0 97.0 97.0 96.0 96.0 97.0 97.0 96.0 96.0 23:27:56 INFO - PROCESS | 4382 | 23:27:56 INFO - PROCESS | 4382 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:61.50 stddev:2.88 (4.7%) stddev-sans-first:3.05 23:27:56 INFO - PROCESS | 4382 | Values: 62.0 63.0 61.0 60.0 60.0 60.0 60.0 62.0 69.0 59.0 23:27:56 INFO - PROCESS | 4382 | 23:27:56 INFO - PROCESS | 4382 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:68.00 stddev:2.12 (3.1%) stddev-sans-first:2.17 23:27:56 INFO - PROCESS | 4382 | Values: 67.0 68.0 74.0 68.0 70.0 68.0 69.0 68.0 67.0 67.0 23:27:56 INFO - PROCESS | 4382 | 23:27:56 INFO - PROCESS | 4382 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.00 stddev:3.03 (3.6%) stddev-sans-first:3.06 23:27:56 INFO - PROCESS | 4382 | Values: 82.0 82.0 84.0 85.0 84.0 84.0 90.0 90.0 83.0 82.0 23:27:56 INFO - PROCESS | 4382 | 23:27:56 INFO - PROCESS | 4382 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:122.50 stddev:5.70 (4.7%) stddev-sans-first:5.66 23:27:56 INFO - PROCESS | 4382 | Values: 116.0 121.0 121.0 117.0 126.0 115.0 132.0 117.0 128.0 124.0 23:27:56 INFO - PROCESS | 4382 | 23:27:56 INFO - PROCESS | 4382 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.70 Median:148.00 stddev:6.17 (4.2%) stddev-sans-first:4.51 23:27:56 INFO - PROCESS | 4382 | Values: 133.0 151.0 147.0 142.0 148.0 141.0 155.0 149.0 143.0 148.0 23:27:56 INFO - PROCESS | 4382 | 23:27:56 INFO - PROCESS | 4382 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:2.30 (3.4%) stddev-sans-first:2.35 23:27:56 INFO - PROCESS | 4382 | Values: 70.0 70.0 67.0 67.0 73.0 68.0 66.0 66.0 69.0 66.0 23:27:56 INFO - PROCESS | 4382 | -------- Summary: end -------- 23:27:56 INFO - PROCESS | 4382 | 23:27:57 INFO - TEST-INFO | 4382: exit 0 23:27:57 INFO - TEST-OK | kraken | took 60427ms 23:27:57 INFO - TEST-START | v8_7 23:27:57 INFO - operating with platform_type : linux_ 23:27:57 INFO - Initialising browser for v8_7 test... 23:27:57 INFO - TEST-INFO | started process 4667 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpASyy4e/profile http://localhost:53622/getInfo.html) 23:28:01 INFO - PROCESS | 4667 | 23:28:01 INFO - PROCESS | 4667 | (process:4737): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:28:02 INFO - PROCESS | 4667 | __metrics Screen width/height:1600/1200 23:28:02 INFO - PROCESS | 4667 | colorDepth:24 23:28:02 INFO - PROCESS | 4667 | Browser inner width/height: 1024/697 23:28:02 INFO - PROCESS | 4667 | __metrics 23:28:02 INFO - PROCESS | 4667 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:28:03 INFO - TEST-INFO | 4667: exit 0 23:28:03 INFO - Browser initialized. 23:28:03 INFO - Running cycle 1/1 for v8_7 test... 23:28:03 INFO - TEST-INFO | started process 4786 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpASyy4e/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:28:05 INFO - PROCESS | 4786 | 23:28:05 INFO - PROCESS | 4786 | (process:4844): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:28:15 INFO - PROCESS | 4786 | RSS: Main: 150769664 23:28:15 INFO - PROCESS | 4786 | 23:28:38 INFO - PROCESS | 4786 | Cycle 1(1): loaded http://localhost:53622/tests/v8_7/run.html (next: http://localhost:53622/tests/v8_7/run.html) 23:28:38 INFO - PROCESS | 4786 | RSS: Main: 151941120 23:28:38 INFO - PROCESS | 4786 | 23:28:38 INFO - PROCESS | 4786 | __start_tp_report 23:28:38 INFO - PROCESS | 4786 | _x_x_mozilla_page_load 23:28:38 INFO - PROCESS | 4786 | _x_x_mozilla_page_load_details 23:28:38 INFO - PROCESS | 4786 | |i|pagename|runs| 23:28:38 INFO - PROCESS | 4786 | |0;Richards;167.58840288252054 23:28:38 INFO - PROCESS | 4786 | |1;DeltaBlue;190.94901661256444 23:28:38 INFO - PROCESS | 4786 | |2;Encrypt;280.50490883590464 23:28:38 INFO - PROCESS | 4786 | |3;Decrypt;5196.891191709845 23:28:38 INFO - PROCESS | 4786 | |4;RayTrace;1053.740779768177 23:28:38 INFO - PROCESS | 4786 | |5;Earley;716.3323782234957 23:28:38 INFO - PROCESS | 4786 | |6;Boyer;12600 23:28:38 INFO - PROCESS | 4786 | |7;RegExp;42040.816326530614 23:28:38 INFO - PROCESS | 4786 | |8;Splay;600.2400960384153 23:28:38 INFO - PROCESS | 4786 | |9;NavierStokes;4830.917874396136 23:28:38 INFO - PROCESS | 4786 | __end_tp_report 23:28:38 INFO - PROCESS | 4786 | __startTimestamp1453706918251__endTimestamp 23:28:38 INFO - PROCESS | 4786 | 23:28:38 INFO - PROCESS | 4786 | ------- Summary: start ------- 23:28:38 INFO - PROCESS | 4786 | Number of tests: 10 23:28:38 INFO - PROCESS | 4786 | 23:28:38 INFO - PROCESS | 4786 | [#0] Richards Cycles:1 Average:167.59 Median:167.59 stddev:0.00 (0.0%) 23:28:38 INFO - PROCESS | 4786 | Values: 167.6 23:28:38 INFO - PROCESS | 4786 | 23:28:38 INFO - PROCESS | 4786 | [#1] DeltaBlue Cycles:1 Average:190.95 Median:190.95 stddev:0.00 (0.0%) 23:28:38 INFO - PROCESS | 4786 | Values: 190.9 23:28:38 INFO - PROCESS | 4786 | 23:28:38 INFO - PROCESS | 4786 | [#2] Encrypt Cycles:1 Average:280.50 Median:280.50 stddev:0.00 (0.0%) 23:28:38 INFO - PROCESS | 4786 | Values: 280.5 23:28:38 INFO - PROCESS | 4786 | 23:28:38 INFO - PROCESS | 4786 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 23:28:38 INFO - PROCESS | 4786 | Values: 5196.9 23:28:38 INFO - PROCESS | 4786 | 23:28:38 INFO - PROCESS | 4786 | [#4] RayTrace Cycles:1 Average:1053.74 Median:1053.74 stddev:0.00 (0.0%) 23:28:38 INFO - PROCESS | 4786 | Values: 1053.7 23:28:38 INFO - PROCESS | 4786 | 23:28:38 INFO - PROCESS | 4786 | [#5] Earley Cycles:1 Average:716.33 Median:716.33 stddev:0.00 (0.0%) 23:28:38 INFO - PROCESS | 4786 | Values: 716.3 23:28:38 INFO - PROCESS | 4786 | 23:28:38 INFO - PROCESS | 4786 | [#6] Boyer Cycles:1 Average:12600.00 Median:12600.00 stddev:0.00 (0.0%) 23:28:38 INFO - PROCESS | 4786 | Values: 12600.0 23:28:38 INFO - PROCESS | 4786 | 23:28:38 INFO - PROCESS | 4786 | [#7] RegExp Cycles:1 Average:42040.82 Median:42040.82 stddev:0.00 (0.0%) 23:28:38 INFO - PROCESS | 4786 | Values: 42040.8 23:28:38 INFO - PROCESS | 4786 | 23:28:38 INFO - PROCESS | 4786 | [#8] Splay Cycles:1 Average:600.24 Median:600.24 stddev:0.00 (0.0%) 23:28:38 INFO - PROCESS | 4786 | Values: 600.2 23:28:38 INFO - PROCESS | 4786 | 23:28:38 INFO - PROCESS | 4786 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 23:28:38 INFO - PROCESS | 4786 | Values: 4830.9 23:28:38 INFO - PROCESS | 4786 | -------- Summary: end -------- 23:28:38 INFO - PROCESS | 4786 | 23:28:39 INFO - TEST-INFO | 4786: exit 0 23:28:39 INFO - TEST-OK | v8_7 | took 41325ms 23:28:39 INFO - SUITE-END | took 1211s 23:28:39 INFO - Completed test suite (00:20:11) 23:28:39 INFO - Working with test: dromaeo_css 23:28:39 INFO - Generating results file: dromaeo_css 23:28:39 INFO - Working with test: kraken 23:28:39 INFO - Generating results file: kraken 23:28:39 INFO - javascript benchmark 23:28:39 INFO - Working with test: v8_7 23:28:39 INFO - Generating results file: v8_7 23:28:39 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:28:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 23:28:39 INFO - process_Request line: dromaeo_css 6776.72 graph.html#tests=[[72,64,43]] 23:28:39 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:28:39 INFO - process_Request line: kraken 1514.40 graph.html#tests=[[232,64,43]] 23:28:39 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:28:39 INFO - process_Request line: v8_7 20269.43 graph.html#tests=[[230,64,43]] 23:28:39 INFO - RETURN: dromaeo_css: 6776.72 23:28:39 INFO - RETURN: kraken: 1514.40 23:28:39 INFO - RETURN: v8_7: 20269.43 23:28:39 INFO - javascript benchmark 23:28:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3081.5685803987444, 3119.500879859223, 3121.859516321765, 3142.151619062853, 3151.0546835949212, 5047.823326183584, 5090.821821236257, 5097.184450487923, 5103.311053007843, 5110.284560161575, 5018.422881368644, 5120.539151476366, 5139.280500729901, 5174.0945334566395, 5185.118529849935, 4637.83767568136, 4662.04428092242, 4680.672352935296, 4740.620750339965, 4748.19280722278, 4759.714417134983, 4760.738159401231, 4766.76166191689, 4817.638677099231, 4854.296127061574, 4597.42532183477, 4666.603338716213, 4688.601468875133, 4750.334953106568, 4755.83354582588, 4686.882827929295, 4692.6245900327895, 4696.882577935545, 4709.128811169944, 4729.290606409032, 4504.121696269229, 4691.906161876777, 4701.036287561042, 4703.976480117578, 4740.123077230689, 4952.7523623819025, 5024.673396229234, 5034.421041580228, 5040.47075057121, 5058.064258112224, 5450.509454149145, 5488.7530061147345, 5508.889822203533, 5513.558915286768, 5545.168224766277, 5430.239766432703, 5500.834974950758, 5549.6115271930985, 5567.582431317667, 5569.443055694439, 5208.9739551302, 5215.608829337777, 5251.054810134213, 5258.158694608845, 5294.97352513235, 5657.236273103078, 5699.971500142473, 5701.828945131652, 5706.4864162225595, 5711.9718450679275, 5290.338707661543, 5359.035373632783, 5467.753951072212, 5504.311961004874, 5553.722313884289, 5517.034518959166, 5533.916991245134, 5535.142052981794, 5547.278853748987, 5562.860928476821, 5498.340199176125, 5501.0, 5516.641418307797, 5525.557955363562, 5536.252605898152, 5340.19897015443, 5402.702851343214, 5529.060059789846, 5533.750981205855, 5584.134459158837, 4287.992321804373, 4318.805653745589, 4321.351797230441, 4322.243607368698, 4355.15074560464, 3859.324618191861, 3860.0735823402742, 3888.4167374893427, 3891.988083098415, 3900.7269491135917, 5068.467810879878, 5197.0905091609575, 5198.2722418861385, 5205.84382468519, 5264.473552644781, 5503.642263252876, 5507.146392309199, 5538.6399884008215, 5546.445355464502, 5562.110062389998, 5023.472535383805, 5180.326557547494, 5186.196139598368, 5190.455002224712, 5240.4497527759795, 4643.257078867365, 4711.387519622427, 4716.764161791897, 4722.693024953367, 4783.904321913542, 5719.428057194247, 5761.366249712528, 5765.884682306414, 5766.855828604234, 5771.187962722749, 5404.486573775485, 5480.616356854982, 5566.777328906798, 5576.470235327637, 5641.548676105902, 5673.149027645886, 5685.71571421419, 5696.686682232351, 5713.285839270091, 5742.971285143548, 5378.569714422915, 5443.074677304789, 5445.428230035947, 5446.754896029767, 5460.754266058117, 5326.227696983993, 5435.130379139477, 5552.58355623338, 5554.2779438672715, 5587.77648894056, 5481.232627432242, 5485.341758988947, 5486.0, 5499.862503437446, 5499.917501237404, 5429.375621803385, 5429.728513574384, 5431.619786614899, 5441.102218133963, 5482.2873026506295, 5081.23781432788, 5151.4590967949325, 5290.28581141541, 5331.280277162688, 5352.063388907003, 5394.2448057272795, 5404.945950540444, 5411.972940135274, 5412.891742165213, 5421.484958928895, 5301.125314323248, 5312.814051508179, 5319.760610772602, 5328.57371410294, 5356.116240820221], "unit": "score", "name": "dojo.html", "value": 5100.4170304669515}, {"lowerIsBetter": false, "replicates": [493.1591636260179, 520.8854052108535, 532.1884126706773, 534.5563182558477, 554.1576803259046, 28528.144155675338, 36700.26599468009, 36768.632313676855, 36995.63004369955, 37118.7313458952, 38938.80530597343, 39349.40975885364, 39404.21191576167, 39535.80232098843, 39608.603913960855, 8328.08391076981, 8460.196281353261, 8465.53439560824, 8496.447730897471, 8527.658893644248, 8219.95890020549, 8288.336933045342, 8314.70898518552, 8323.292520135796, 8352.749417517454, 8339.666413343459, 8398.45410048348, 8426.831463370729, 8426.957865210665, 8456.78858028548, 8274.420790544664, 8321.500709957421, 8396.706115285966, 8531.061583225903, 8595.785105372353, 8363.916360836374, 8449.408541402043, 8477.109903460172, 8492.830143397097, 8496.745097647081, 39154.21691566153, 39332.60667393318, 39386.80306598477, 39541.0, 39606.0, 3098.7366073883522, 3156.1162874395204, 3306.123877172551, 3398.2693720850134, 3732.9440058399146, 30090.84954575235, 30188.84905575458, 30635.846820765753, 30759.2310192247, 31774.205644859063, 3870.4000879863665, 3892.7469714468752, 3906.833989257686, 3918.5297764268184, 3986.681065514752, 249445.0, 253332.0, 253734.0, 254326.72836635885, 255375.0, 51884.22173667398, 52462.475375246526, 53039.20441193385, 58628.41371586315, 59345.70327148337, 53540.46459535433, 53677.7316113417, 54038.0, 54051.45948540543, 54216.0, 14482.927585362217, 14506.709865802835, 14550.399456059826, 14577.344019519147, 14769.40922363115, 11102.888971110347, 11211.887881121247, 11258.0, 11298.322100673986, 11324.32054076758, 19521.34068604156, 19733.210671572975, 20007.59984800296, 20019.39941801748, 20057.29799457012, 7655.425843061793, 7741.767746967487, 7773.222677732181, 7833.64748586315, 7897.23596741136, 917.4220241247971, 989.1196834817018, 997.9550920208608, 1016.4714348538719, 1059.3167407022427, 29111.417771644872, 29196.416071678446, 29375.11874643764, 29517.409651807273, 29559.408811823643, 1045.5974449836867, 1082.5074591061207, 1083.1443159903588, 1102.470814009264, 1109.6171820721838, 14471.78292325616, 14688.779668304984, 14714.950305562003, 14860.851391486163, 14881.47914822976, 324001.0, 328826.0, 329532.0, 330004.0, 330938.0, 51923.0, 52054.47945520572, 52164.739176303876, 52301.2154817678, 52481.475185248426, 1327.1705184259838, 1338.906276560651, 1341.631051460856, 1347.2590075458459, 1351.574254109952, 27410.72589274082, 28544.286392839513, 28660.713392865804, 28699.71300287054, 28796.280092997844, 46300.53699462962, 46354.536454635025, 46575.76712116418, 46683.29975050445, 46846.29730554113, 302451.0, 302698.0, 305942.0, 306197.0, 306455.0, 30330.0, 30934.381312374077, 31021.68978310188, 31047.0, 31201.8439907799, 42093.57906420896, 42688.0, 43241.783791080845, 43450.56549434465, 43976.34035489406, 35386.46920296249, 35835.46246806248, 36445.08887277839, 36513.81743091268, 37056.814715926244, 32871.17822054468, 33554.832225839695, 33572.66427335695, 34067.65932340645, 35127.0, 32282.35435291234, 32690.182745431553, 32726.836365818017, 33002.504962425104, 33114.834425827714, 29809.25476863009, 30328.0, 30596.388072237984, 30889.0, 31075.0, 24055.398615034763, 25646.487070258863, 26050.34874128162, 26306.86846565755, 27513.31216719598], "unit": "score", "name": "ext.html", "value": 18047.949432176105}, {"lowerIsBetter": false, "replicates": [367.4579994508099, 368.34434706222925, 371.42243810874095, 371.87913927973415, 379.24908680812007, 15511.224438778072, 16525.0, 16932.83067169328, 16976.236069376875, 17692.55768605784, 10817.513211905463, 11036.006759391654, 15810.525684229462, 16072.839271607281, 16127.113008784512, 4969.62727795415, 5189.558887494568, 5398.244245805571, 5399.217113518537, 5409.675419474825, 5234.398044224925, 5315.920261196085, 5316.840494785143, 5549.889002219953, 5552.472515111058, 5091.465396133408, 5328.8401347959625, 5543.501084902358, 5545.667259964395, 5555.972220138914, 5236.240745091978, 5248.160294352923, 5274.235235890794, 5298.682079075248, 5685.0, 5345.118055520873, 5375.489328513824, 5394.352677678665, 5403.5136837684795, 5420.7018613976215, 12010.759784804342, 12832.03759718025, 18186.544816449874, 19612.41162765105, 20006.199752009903, 2083.6874468829647, 2099.769025407204, 2134.135675051591, 2187.201671389931, 2434.0142242391858, 12176.939115304456, 12186.51253949841, 12400.379981000913, 12790.48838046477, 12822.615321540368, 1824.7354133650679, 1835.8347748702681, 1846.2799508191815, 1847.2057015483338, 1850.8149185081384, 52125.218121728205, 54986.45013549853, 54994.0, 55547.0, 55856.44143558593, 9972.351797133164, 10191.388516689023, 10220.897791022144, 10279.074883260393, 10395.32430392022, 13381.93309033468, 13469.932650336686, 13507.729845403037, 13523.526676566273, 13576.117552359263, 7459.664315105725, 7514.812129696801, 7518.436117291116, 7573.659185336673, 7616.657250423744, 7110.5733655979775, 7126.394256488153, 7141.82145446368, 7166.928330716626, 7187.820304492429, 4388.692791504628, 4441.755703436277, 4470.418845550058, 4480.551944805494, 4482.843100491467, 1793.4709260768104, 1866.4027511196286, 1870.2518992402875, 1889.093235247089, 2913.8251704897775, 469.4390203706606, 834.3283656656329, 919.650532797546, 978.3347323819871, 1033.5194134727387, 10335.741606459898, 10673.35959842412, 10859.619913303155, 11100.0, 11171.0, 469.1344469453852, 477.40801406256685, 483.68437849050525, 493.89628178082285, 513.3726088300098, 5784.450477204743, 5971.2834459864225, 5993.101034844721, 6066.272047354346, 6088.908666370008, 525019.0, 533695.0, 535959.0, 542706.0, 554998.0, 67046.0, 67542.66228668825, 69502.30497694958, 70263.64868175627, 71044.0, 494.6067876038558, 501.6989806116374, 502.17893743729263, 502.56779169913847, 505.6637336171405, 9375.390599611004, 9386.296027797805, 9521.523923803921, 9587.712368628952, 9626.941036485841, 28241.0, 28889.7111028887, 29437.85281073581, 30439.54340684936, 30576.235594110327, 42241.57758422376, 42707.57292427036, 42832.35751463793, 43022.784886075366, 44619.776901115285, 7214.71141154348, 7241.565506069653, 7343.8531229376185, 7534.472586918863, 7537.0, 9995.350302230332, 10493.737656558647, 10715.892841071489, 10798.082163016232, 10951.45242737844, 7262.854742905007, 7431.182569917197, 7432.799924155223, 7451.666083828919, 7530.322270995418, 7111.964440177766, 7402.1857595665515, 7653.043369578802, 7685.5004424712215, 7748.14770375247, 7606.163322034682, 7713.421493387906, 7814.062312522534, 7848.803779905548, 7854.803629909298, 9717.319787614799, 9721.0, 9837.557309920927, 9947.850782238127, 10020.148287395654, 6746.831329216809, 6895.862082758216, 7284.745033923788, 7375.446841487017, 7456.0], "unit": "score", "name": "jquery.html", "value": 7374.521959732389}, {"lowerIsBetter": false, "replicates": [1462.1519518679165, 1476.6825132596489, 1642.3102297035243, 1765.9823401765977, 1801.57662949207, 7845.92154078459, 7926.247006534384, 8045.356371490281, 8052.758417247484, 8084.797880052987, 7913.762587122395, 7982.962214912053, 8115.0, 8115.472494287882, 8119.675212991488, 2236.910523579059, 2270.7842754938256, 2273.0, 2286.702728645282, 2289.5306462175213, 2226.7995880370763, 2327.4763178284834, 2401.903923843044, 2407.374082738492, 2416.32342943976, 2286.3941055620276, 2288.164819840763, 2289.496310811619, 2352.2355234548754, 2352.4236562042324, 2261.694671219381, 2269.965950510744, 2282.087165133951, 2284.7715228477186, 2286.1884031168943, 2303.1478353009325, 2306.6078766609717, 2319.512902290521, 2324.37241944674, 2332.346942856003, 7897.289243968013, 7916.960415197945, 7932.127465978738, 7936.8412631747615, 7952.125266220711, 4695.225287827504, 4761.761911904391, 4764.595009424203, 4766.451858036336, 4786.162421576245, 3081.152683012167, 3142.685731426862, 3214.453542897713, 3223.580934478526, 3229.40256052631, 1065.4779158212498, 1078.4230436716318, 1079.854219680341, 1087.1846115413439, 1099.142668718401, 11027.22809403342, 11099.223054386115, 11130.38782866942, 11161.553537858475, 11173.553057877594, 4171.10321280926, 4306.354046892991, 4309.504406993173, 4325.480942286946, 4345.804438800262, 9018.819623607491, 9021.548922553846, 9072.773180670536, 9099.454032758056, 9144.771380715536, 4721.504242054603, 4743.075100355467, 4769.594584460359, 4802.543758342952, 4808.110499557523, 4380.649548036149, 4390.07808360248, 4394.340848872695, 4397.36238245459, 4419.204543182258, 3418.179636887129, 3488.9127771805906, 3507.2459421224557, 3530.5763308403157, 3538.380783362901, 1064.3401091323428, 1082.258652822819, 1086.440483151178, 1095.3592148593161, 1130.0451118804597, 1325.4499382756242, 1336.5789776220458, 1353.2286596639822, 1356.0846428660614, 1363.175278956237, 7214.927850721426, 7508.361789247975, 7693.038370203724, 7737.8452430951065, 7763.883541746878, 1127.3067063755732, 1130.5082289204222, 1132.2244262679926, 1140.43548443521, 1148.0, 5800.738966746507, 5846.590738648254, 5888.440598143169, 5901.1148327750325, 5904.911426328608, 9152.0, 9460.810783784285, 9526.952365238269, 9564.95217523908, 9639.662611808553, 9561.235101191887, 9590.42457452555, 9637.277204209713, 9647.614095436244, 9685.273604479693, 7446.962765186247, 7636.618169091523, 7641.197674244125, 7681.846363072819, 7714.652840622185, 7223.422126229994, 7319.780406587811, 7340.0, 7354.080739907512, 7439.851202975802, 8497.1502849717, 8577.828443430972, 8697.95651021741, 8752.64989400417, 8787.736367908972, 8854.335924805795, 8950.507722075088, 8989.865152022594, 9086.000539940469, 9100.954495227481, 6834.897476537955, 6884.827879303058, 6901.792946211622, 6908.205556360882, 6916.789561826559, 7499.850003000019, 7601.581912994839, 7675.194104619158, 7720.150783413707, 7751.0, 6106.419890110433, 6896.344847239504, 7257.129144502694, 7343.632818359168, 7386.926130738624, 6659.367360100783, 6759.763408280686, 6794.218664853407, 6815.250322464624, 6835.213950395768, 6651.900221496779, 6722.899156512754, 6724.663766811542, 6746.123004009447, 6770.187577490536, 6392.097188614652, 6396.840078998062, 6483.967580162069, 6532.314107018695, 6613.6693165340575, 6528.21661400635, 6573.408393244631, 6582.473402127723, 6600.273969863215, 6602.207735071822], "unit": "score", "name": "mootools.html", "value": 4575.542003408465}, {"lowerIsBetter": false, "replicates": [352.344638971513, 357.5673435143476, 359.5487662982956, 364.5206553382302, 365.7439792145499, 6184.81445556634, 6201.689915504229, 6248.437640612344, 6293.118963345135, 6380.213540208737, 6223.2532096148525, 6243.625382477043, 6254.593451425654, 6273.749050037993, 6277.937220627804, 4669.743164125972, 4702.882427939312, 4710.3405523226775, 4722.527747225285, 4727.976360118212, 4710.576048155665, 4724.4094488188975, 4730.97634511827, 4732.290156476539, 4734.934639706073, 4578.2903649934315, 4598.126355992351, 4629.166749985001, 4667.089917466078, 4679.976600116995, 4628.675992680513, 4659.347691323217, 4659.557342052533, 4662.020975595112, 4676.55572720591, 4120.299549076634, 4122.2579935611575, 4123.381492776108, 4125.401816736587, 4128.153728485653, 5904.5571582131515, 5912.526997840206, 5916.349201587822, 5942.197803296586, 5948.107783832416, 5383.703896285702, 5499.642523236017, 5528.834134975958, 5535.25274087997, 5550.4449555044575, 6525.477961763095, 6564.835879103013, 6577.539572229945, 6583.703733332011, 6590.0, 4555.157295900269, 4565.840195593171, 4577.725336479822, 4587.839425620121, 4596.35651008859, 6811.897821532681, 6862.9313706862795, 7017.087778588751, 7018.227994920555, 7024.683889224997, 4643.791029403617, 4646.442426908725, 4649.744264065441, 4666.390095417076, 4668.789904454307, 4688.226442636995, 4701.929471057937, 4703.341532185496, 4708.646851486153, 4711.7879695413785, 5451.618386712892, 5465.836024919259, 5468.589855760833, 5469.863253418696, 5470.835874923759, 6524.282328943812, 6634.436072933758, 6643.701033453506, 6653.866922661519, 6654.401103900672, 1654.7600597913236, 1681.865450763936, 1682.86537077036, 1683.1752441303918, 1683.5538582275706, 1125.471028616549, 1132.4337831084458, 1132.6262333429947, 1146.1461211397561, 1147.9540818367173, 6221.844453888689, 6253.906191407133, 6296.0, 6302.810915672537, 6336.303006669263, 6765.391114799691, 6839.316068393121, 6842.144731908512, 6843.8973415398805, 6876.0, 6022.728977196037, 6114.266288045463, 6237.532185086136, 6303.810885673437, 6307.653079080603, 3699.056740531147, 3700.6114357992024, 3706.980580340428, 3712.294664013829, 3732.5147730795366, 7061.646917654097, 7193.604351760599, 7201.3158749918675, 7204.24355442671, 7204.603746793977, 6932.202796678446, 7034.859302813915, 7063.399611033017, 7108.969199466152, 7110.537815042109, 7164.283571642898, 7174.210836807947, 7175.96412017947, 7188.784336469915, 7192.352688258082, 6840.179178498612, 6862.9313706862295, 6896.931030689629, 6905.274946130584, 6926.8614627708175, 6726.327367263235, 6816.965915170393, 6842.315768423118, 6844.28135045813, 6852.937794641838, 7080.716771329089, 7081.610511421921, 7155.0, 7157.96209549602, 7188.065551478275, 4557.361969324231, 4574.199515084781, 4616.769161541976, 4620.930686039779, 4625.121226966866, 6817.0, 6871.793846184622, 6922.06552115458, 6922.861542769016, 6953.0, 6714.529982901346, 6730.629815360202, 6731.899021514583, 6734.451076252391, 6746.0555522227905, 6713.395794378529, 6718.596884186964, 6732.158480189976, 6732.596044237362, 6735.764248251287, 6403.263624683221, 6531.563056127644, 6576.638284894377, 6580.078788969452, 6584.934150658432, 6701.698423570853, 6741.764038258638, 6745.190577130776, 6745.954377071562, 6758.391744742997, 6415.711292991733, 6549.984752363392, 6588.07766912623, 6597.241317248578, 6603.7688680895935], "unit": "score", "name": "prototype.html", "value": 4997.527464077602}, {"lowerIsBetter": false, "replicates": [746.2015643261709, 749.917509074002, 759.7151068349369, 801.178791738468, 878.5651102704162, 13326.600201993944, 13362.131461455, 13384.93307533461, 13443.46226150954, 13493.595192144227, 12517.874821251784, 12520.311382873939, 13025.934870325658, 13056.281904495272, 13102.47590096395, 810.1331575214523, 811.4928169893816, 825.5624519004937, 829.1832544943226, 831.1605278668528, 819.315871247509, 823.8640624296984, 826.6941231744263, 828.4987582512583, 833.5165603949725, 862.5169904853271, 871.442276942754, 872.8996165440992, 873.1268731268731, 876.2332958661171, 856.1908995998783, 857.785553611594, 861.1990848510883, 867.4795122926225, 871.2202578692066, 632.3455223843346, 634.3624657219511, 636.7771280051991, 638.7540796793221, 639.11163482759, 13255.867441325656, 13288.867111328957, 13350.19898806065, 13373.598792036157, 13944.860551394459, 12616.495340186382, 12644.747105057848, 12829.422675979604, 12890.484380624765, 12978.935105324508, 10779.407132607703, 10791.406472644001, 10867.239293249475, 10936.56253749849, 11139.498722557504, 3550.14796448853, 3577.141486043357, 3598.4962105305276, 3746.8875933722034, 3752.5309336332957, 47406.5259347409, 47499.525004750205, 47833.52166478326, 47844.0, 47937.760311198566, 9237.491937943343, 9508.906475755239, 9581.856272155923, 10042.949785251027, 10064.849027264598, 16719.247633856507, 16819.243134058997, 16883.40908068212, 16895.662086758195, 16910.239039243017, 7227.168875579376, 7368.557886526718, 7400.407967362706, 7415.3326200642205, 7423.888641670379, 3929.960700393017, 4011.3782363733667, 4197.24449599069, 4235.047114399235, 4238.579438507731, 3101.4727496325677, 3121.7970831895855, 3128.89048883288, 3138.6547479777205, 3149.700778426046, 549.7031602934451, 566.03773584905, 578.8784355285353, 579.5016285994042, 588.341058015026, 534.3534323468568, 560.2660514725723, 571.9971400143056, 572.1789232451446, 597.4354235247649, 8204.507729536246, 8535.701250456328, 8576.742697719079, 8695.913040869636, 8852.822943541094, 499.85254349966846, 558.8044184535462, 563.7970330680952, 607.9300880398811, 633.8795628830508, 3898.3958279629774, 3980.0, 4051.756894586334, 4063.167050754588, 4087.8978025549004, 49036.509634903196, 49637.25544116841, 49809.75095124501, 50063.74968125209, 50272.49727502751, 48107.75946120247, 48260.75869620629, 48391.75804120957, 48458.0, 48972.0, 44276.557234427244, 45390.773046134556, 47203.76398117987, 47543.5245647546, 48487.75756121197, 8480.067192608685, 8508.702195423131, 8776.517291548771, 8837.248833849195, 8908.955455222942, 35128.29743405169, 35227.295454090265, 35823.46264805978, 36024.0, 36059.27881442409, 43574.12851742884, 43906.780466097465, 44198.55801441945, 44893.0, 44903.32645010393, 10231.48842557884, 10357.4303413313, 10626.52180651857, 10771.458570738976, 11393.259438136494, 12291.56979505713, 12469.5012199511, 12676.683082923, 12802.935985320386, 13053.34733263352, 11178.552857885594, 11210.27133236337, 11506.827397588875, 11534.423278836193, 11541.307521548733, 11658.475368608602, 11780.76438471243, 11901.940490297493, 12243.75512489763, 12301.630951071482, 10611.257211995086, 10898.618548350769, 11456.140789440658, 11758.294502329887, 11885.821712674144, 8471.872921906299, 8829.64681412762, 8906.38150403475, 9506.334556580972, 9560.235181185628, 9683.9031609683, 9992.250581206585, 10065.993400660169, 10131.594736210469, 10277.922918066293], "unit": "score", "name": "yui.html", "value": 6239.029775617302}], "name": "dromaeo_css", "value": 6776.719930675884}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 105.0, 111.0, 111.0, 112.0, 122.0, 110.0, 112.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [157.0, 127.0, 154.0, 166.0, 126.0, 148.0, 150.0, 134.0, 163.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 163.0, 162.0, 163.0, 160.0, 160.0, 167.0, 166.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 74.0, 77.0, 74.0, 135.0, 76.0, 73.0, 76.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 148.0, 96.0, 96.0, 96.0, 142.0, 97.0, 96.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 150.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 97.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 61.0, 60.0, 60.0, 60.0, 60.0, 62.0, 69.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 61.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 74.0, 68.0, 70.0, 68.0, 69.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 84.0, 85.0, 84.0, 84.0, 90.0, 90.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [116.0, 121.0, 121.0, 117.0, 126.0, 115.0, 132.0, 117.0, 128.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.7}, {"lowerIsBetter": true, "replicates": [133.0, 151.0, 147.0, 142.0, 148.0, 141.0, 155.0, 149.0, 143.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.7}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 67.0, 67.0, 73.0, 68.0, 66.0, 66.0, 69.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1514.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.58840288252054], "unit": "score", "name": "Richards", "value": 210.64703400000002}, {"lowerIsBetter": false, "replicates": [190.94901661256444], "unit": "score", "name": "DeltaBlue", "value": 346.2599660000002}, {"lowerIsBetter": false, "replicates": [280.50490883590464], "unit": "score", "name": "Encrypt", "value": 948.9352650000003}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1053.740779768177], "unit": "score", "name": "RayTrace", "value": 702.2495610000001}, {"lowerIsBetter": false, "replicates": [716.3323782234957], "unit": "score", "name": "Earley", "value": 930.3823479999999}, {"lowerIsBetter": false, "replicates": [12600.0], "unit": "score", "name": "Boyer", "value": 52.89388888888888}, {"lowerIsBetter": false, "replicates": [42040.816326530614], "unit": "score", "name": "RegExp", "value": 21.66906067961165}, {"lowerIsBetter": false, "replicates": [600.2400960384153], "unit": "score", "name": "Splay", "value": 135.764006}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20269.43492610126}]} 23:28:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20269.43"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1514.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6776.72"}}} 23:28:39 INFO - Return code: 0 23:28:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:28:39 INFO - # TBPL SUCCESS # 23:28:39 INFO - Running post-action listener: _resource_record_post_action 23:28:39 INFO - Running post-run listener: _resource_record_post_run 23:28:40 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 507904; Write bytes: 385302528; Read time: 136; Write time: 508784 23:28:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 78495744; Read time: 0; Write time: 128340 23:28:40 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 507904; Write bytes: 306806784; Read time: 136; Write time: 380444 23:28:40 INFO - Running post-run listener: _upload_blobber_files 23:28:40 INFO - Blob upload gear active. 23:28:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:28:40 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 23:28:40 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'] 23:28:40 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 23:28:40 INFO - (blobuploader) - INFO - Open directory for files ... 23:28:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:28:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:28:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:28:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:28:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:28:41 INFO - (blobuploader) - INFO - Done attempting. 23:28:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:28:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:28:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:28:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:28:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:28:42 INFO - (blobuploader) - INFO - Done attempting. 23:28:42 INFO - (blobuploader) - INFO - Iteration through files over. 23:28:42 INFO - Return code: 0 23:28:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:28:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:28:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/37d624c14933b93498759eb0f1f9df868b484803ed1e57a5cb6d91a28ee7d6864a462841497376666e9771315df96328969cedde5700742db5d32dcfee0e394d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b4f244ef0e01fd17c8a2f44d7bd7cca38a7920d5c4ec3e26c6e4bde373dfdf75461341cb78dee6b08a3b6fb302cc10656950ab0a4fe88054b7ad7a14a151bbe"} 23:28:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:28:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:28:42 INFO - Contents: 23:28:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/37d624c14933b93498759eb0f1f9df868b484803ed1e57a5cb6d91a28ee7d6864a462841497376666e9771315df96328969cedde5700742db5d32dcfee0e394d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b4f244ef0e01fd17c8a2f44d7bd7cca38a7920d5c4ec3e26c6e4bde373dfdf75461341cb78dee6b08a3b6fb302cc10656950ab0a4fe88054b7ad7a14a151bbe"} 23:28:42 INFO - Running post-run listener: copy_logs_to_upload_dir 23:28:42 INFO - Copying logs to upload dir... 23:28:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:28:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.472832 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-01-24 23:28:42.626281) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-24 23:28:42.629633) ========= 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=8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/37d624c14933b93498759eb0f1f9df868b484803ed1e57a5cb6d91a28ee7d6864a462841497376666e9771315df96328969cedde5700742db5d32dcfee0e394d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b4f244ef0e01fd17c8a2f44d7bd7cca38a7920d5c4ec3e26c6e4bde373dfdf75461341cb78dee6b08a3b6fb302cc10656950ab0a4fe88054b7ad7a14a151bbe"} build_url:https://queue.taskcluster.net/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011458 build_url: 'https://queue.taskcluster.net/v1/task/ZjWEiGIIQBSnLahxz0u9Dg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/37d624c14933b93498759eb0f1f9df868b484803ed1e57a5cb6d91a28ee7d6864a462841497376666e9771315df96328969cedde5700742db5d32dcfee0e394d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b4f244ef0e01fd17c8a2f44d7bd7cca38a7920d5c4ec3e26c6e4bde373dfdf75461341cb78dee6b08a3b6fb302cc10656950ab0a4fe88054b7ad7a14a151bbe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-24 23:28:42.658107) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 23:28:42.658408) ========= 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=8783db0840cc980e80bb0bd400000236-1453702355.758056-350353704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004668 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 23:28:42.740910) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-24 23:28:42.741224) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-24 23:28:42.741507) ========= ========= Total master_lag: 0.29 =========