builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1456338085.59 results: success (0) buildid: 20160224074545 builduid: 8dc4e76aa03f4dbe9b7c14dffb3bf099 revision: 917763c36a6e9a66dc5270e4514e07251967e5d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:25.591926) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:25.592340) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:25.592642) ========= 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=eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006623 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:25.623703) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:25.623974) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:25.661759) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:25.662105) ========= 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=eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021937 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:25.711416) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:25.711697) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:25.712022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:25.712290) ========= 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=eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-24 10:21:25-- 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% 12.1M=0.001s 2016-02-24 10:21:26 (12.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.192177 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:25.920957) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:25.921309) ========= 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=eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.132297 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:26.064320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:26.067724) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 917763c36a6e9a66dc5270e4514e07251967e5d4 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 917763c36a6e9a66dc5270e4514e07251967e5d4 --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=eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-24 10:21:26,239 truncating revision to first 12 chars 2016-02-24 10:21:26,239 Setting DEBUG logging. 2016-02-24 10:21:26,239 attempt 1/10 2016-02-24 10:21:26,239 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/917763c36a6e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-24 10:21:26,507 unpacking tar archive at: mozilla-aurora-917763c36a6e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.530598 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:26.615193) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:26.615523) ========= echo 917763c36a6e9a66dc5270e4514e07251967e5d4 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'917763c36a6e9a66dc5270e4514e07251967e5d4'] 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=eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 917763c36a6e9a66dc5270e4514e07251967e5d4 program finished with exit code 0 elapsedTime=0.004625 script_repo_revision: '917763c36a6e9a66dc5270e4514e07251967e5d4' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:26.673616) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:26.673889) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 10:21:26.690361) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-24 10:21:26.690656) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:21:26 INFO - MultiFileLogger online at 20160224 10:21:26 in /builds/slave/test-pgo 10:21:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:21:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:21:26 INFO - {'append_to_log': False, 10:21:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:21:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:21:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:21:26 INFO - 'branch': 'Mozilla-Aurora', 10:21:26 INFO - 'buildbot_json_path': 'buildprops.json', 10:21:26 INFO - 'config_files': ('talos/linux_config.py',), 10:21:26 INFO - 'default_actions': ('clobber', 10:21:26 INFO - 'read-buildbot-config', 10:21:26 INFO - 'download-and-extract', 10:21:26 INFO - 'populate-webroot', 10:21:26 INFO - 'create-virtualenv', 10:21:26 INFO - 'install', 10:21:26 INFO - 'run-tests'), 10:21:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:21:26 INFO - 'download_minidump_stackwalk': True, 10:21:26 INFO - 'download_symbols': 'ondemand', 10:21:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:21:26 INFO - 'tooltool.py': '/tools/tooltool.py', 10:21:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:21:26 INFO - '/tools/misc-python/virtualenv.py')}, 10:21:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:21:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:21:26 INFO - 'installer_path': 'installer.exe', 10:21:26 INFO - 'log_level': 'info', 10:21:26 INFO - 'log_name': 'talos', 10:21:26 INFO - 'log_to_console': True, 10:21:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:21:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:21:26 INFO - 'opt_config_files': (), 10:21:26 INFO - 'pip_index': False, 10:21:26 INFO - 'sps_profile': False, 10:21:26 INFO - 'sps_profile_interval': 0, 10:21:26 INFO - 'suite': 'dromaeojs-e10s', 10:21:26 INFO - 'system_bits': '32', 10:21:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:21:26 INFO - 'title': 'talos-linux64-ix-010', 10:21:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:21:26 INFO - 'use_talos_json': True, 10:21:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:21:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:21:26 INFO - 'work_dir': 'build'} 10:21:26 INFO - ##### 10:21:26 INFO - ##### Running clobber step. 10:21:26 INFO - ##### 10:21:26 INFO - Running pre-action listener: _resource_record_pre_action 10:21:26 INFO - Running main action method: clobber 10:21:26 INFO - rmtree: /builds/slave/test-pgo/build 10:21:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:21:28 INFO - Running post-action listener: _resource_record_post_action 10:21:28 INFO - ##### 10:21:28 INFO - ##### Running read-buildbot-config step. 10:21:28 INFO - ##### 10:21:28 INFO - Running pre-action listener: _resource_record_pre_action 10:21:28 INFO - Running main action method: read_buildbot_config 10:21:28 INFO - Using buildbot properties: 10:21:28 INFO - { 10:21:28 INFO - "project": "", 10:21:28 INFO - "product": "firefox", 10:21:28 INFO - "script_repo_revision": "production", 10:21:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 10:21:28 INFO - "repository": "", 10:21:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 10:21:28 INFO - "buildid": "20160224074545", 10:21:28 INFO - "pgo_build": "True", 10:21:28 INFO - "basedir": "/builds/slave/test-pgo", 10:21:28 INFO - "buildnumber": 154, 10:21:28 INFO - "slavename": "talos-linux64-ix-010", 10:21:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:21:28 INFO - "platform": "ubuntu64_hw", 10:21:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:21:28 INFO - "branch": "mozilla-aurora", 10:21:28 INFO - "repo_path": "releases/mozilla-aurora", 10:21:28 INFO - "revision": "917763c36a6e9a66dc5270e4514e07251967e5d4", 10:21:28 INFO - "stage_platform": "linux64-pgo", 10:21:28 INFO - "builduid": "8dc4e76aa03f4dbe9b7c14dffb3bf099", 10:21:28 INFO - "slavebuilddir": "test" 10:21:28 INFO - } 10:21:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 10:21:28 INFO - Running post-action listener: _resource_record_post_action 10:21:28 INFO - ##### 10:21:28 INFO - ##### Running download-and-extract step. 10:21:28 INFO - ##### 10:21:28 INFO - Running pre-action listener: _resource_record_pre_action 10:21:28 INFO - Running main action method: download_and_extract 10:21:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:28 INFO - https://queue.taskcluster.net/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:21:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/test_packages.json 10:21:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/test_packages.json 10:21:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:21:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:21:29 INFO - Downloaded 1448 bytes. 10:21:29 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:21:29 INFO - Using the following test package requirements: 10:21:29 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 10:21:29 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:21:29 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:21:29 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:21:29 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:21:29 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:21:29 INFO - u'jsshell-linux-x86_64.zip'], 10:21:29 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:21:29 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:21:29 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 10:21:29 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:21:29 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:21:29 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:21:29 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:21:29 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:21:29 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:21:29 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 10:21:29 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:21:29 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:21:29 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:29 INFO - https://queue.taskcluster.net/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:21:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:21:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:21:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:21:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:21:30 INFO - Downloaded 23079052 bytes. 10:21:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:21:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:21:32 INFO - Return code: 0 10:21:32 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:32 INFO - https://queue.taskcluster.net/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:21:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:21:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:21:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:21:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:21:36 INFO - Downloaded 23079052 bytes. 10:21:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:21:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:21:38 INFO - Return code: 0 10:21: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')]} 10:21:38 INFO - https://queue.taskcluster.net/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:21:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 10:21:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 10:21:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 10:21:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:21:38 INFO - Downloaded 10706572 bytes. 10:21:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:21:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 10:21:39 INFO - Return code: 0 10:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:39 INFO - https://queue.taskcluster.net/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:21:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 10:21:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 10:21:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 10:21:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:21:40 INFO - Downloaded 59961298 bytes. 10:21:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 10:21:40 INFO - mkdir: /builds/slave/test-pgo/properties 10:21:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:21:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:21:40 INFO - Contents: 10:21:40 INFO - build_url:https://queue.taskcluster.net/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 10:21:41 INFO - Running post-action listener: _resource_record_post_action 10:21:41 INFO - Running post-action listener: set_extra_try_arguments 10:21:41 INFO - ##### 10:21:41 INFO - ##### Running populate-webroot step. 10:21:41 INFO - ##### 10:21:41 INFO - Running pre-action listener: _resource_record_pre_action 10:21:41 INFO - Running main action method: populate_webroot 10:21:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:21:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:21:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:21:41 INFO - '--tppagecycles', 10:21:41 INFO - '7'], 10:21:41 INFO - 'tests': ['tsvgm']}}, 10:21:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:21:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:21:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:21:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:21:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:21:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:21:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:41 INFO - 'talos_options': ['--e10s'], 10:21:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:41 INFO - 'tests': ['damp', 'tps']}, 10:21:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:41 INFO - 'talos_options': ['--e10s'], 10:21:41 INFO - 'tests': ['damp', 'tps']}, 10:21:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:21:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:21:41 INFO - 'other': {'tests': ['a11yr', 10:21:41 INFO - 'ts_paint', 10:21:41 INFO - 'tpaint', 10:21:41 INFO - 'sessionrestore', 10:21:41 INFO - 'sessionrestore_no_auto_restore']}, 10:21:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:21:41 INFO - 'tests': ['a11yr', 10:21:41 INFO - 'ts_paint', 10:21:41 INFO - 'tpaint', 10:21:41 INFO - 'sessionrestore', 10:21:41 INFO - 'sessionrestore_no_auto_restore']}, 10:21:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:21:41 INFO - 'tests': ['a11yr', 10:21:41 INFO - 'ts_paint', 10:21:41 INFO - 'tpaint', 10:21:41 INFO - 'sessionrestore', 10:21:41 INFO - 'sessionrestore_no_auto_restore']}, 10:21:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:21:41 INFO - 'tests': ['a11yr', 10:21:41 INFO - 'ts_paint', 10:21:41 INFO - 'tpaint', 10:21:41 INFO - 'sessionrestore', 10:21:41 INFO - 'sessionrestore_no_auto_restore']}, 10:21:41 INFO - 'other_l64': {'tests': ['a11yr', 10:21:41 INFO - 'ts_paint', 10:21:41 INFO - 'tpaint', 10:21:41 INFO - 'sessionrestore', 10:21:41 INFO - 'sessionrestore_no_auto_restore']}, 10:21:41 INFO - 'other_nol64': {'tests': ['a11yr', 10:21:41 INFO - 'ts_paint', 10:21:41 INFO - 'tpaint', 10:21:41 INFO - 'sessionrestore', 10:21:41 INFO - 'sessionrestore_no_auto_restore']}, 10:21:41 INFO - 'svgr': {'tests': ['tsvgx', 10:21:41 INFO - 'tsvgr_opacity', 10:21:41 INFO - 'tart', 10:21:41 INFO - 'tscrollx', 10:21:41 INFO - 'cart']}, 10:21:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:21:41 INFO - 'tests': ['tsvgx', 10:21:41 INFO - 'tsvgr_opacity', 10:21:41 INFO - 'tart', 10:21:41 INFO - 'tscrollx', 10:21:41 INFO - 'cart']}, 10:21:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:41 INFO - 'tests': ['tp5o']}, 10:21:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:41 INFO - 'talos_options': ['--e10s'], 10:21:41 INFO - 'tests': ['tp5o']}, 10:21:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:41 INFO - 'talos_options': ['--xperf_path', 10:21:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:41 INFO - 'tests': ['tp5n']}, 10:21:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:41 INFO - 'talos_options': ['--e10s', 10:21:41 INFO - '--xperf_path', 10:21:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:41 INFO - 'tests': ['tp5n']}}, 10:21:41 INFO - 'talos.zip': {'path': '', 10:21:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:21:41 INFO - Running post-action listener: _resource_record_post_action 10:21:41 INFO - ##### 10:21:41 INFO - ##### Running create-virtualenv step. 10:21:41 INFO - ##### 10:21:41 INFO - Running pre-action listener: _resource_record_pre_action 10:21:41 INFO - Running main action method: create_virtualenv 10:21:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:21:41 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 10:21:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:21:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:21:41 INFO - Using real prefix '/usr' 10:21:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:21:42 INFO - Installing distribute.............................................................................................................................................................................................done. 10:21:44 INFO - Installing pip.................done. 10:21:44 INFO - Return code: 0 10:21:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:44 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 0x7f3ae7db4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f07f0>, '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 0x205c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c760>, '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': 'eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790', '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 10:21:44 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 10:21:44 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 10:21:44 INFO - Using env: {'DISPLAY': ':0', 10:21:44 INFO - 'HOME': '/home/cltbld', 10:21:44 INFO - 'LANG': 'en_US.UTF-8', 10:21:44 INFO - 'LANGUAGE': 'en_US:en', 10:21:44 INFO - 'LOGNAME': 'cltbld', 10:21:44 INFO - 'MAIL': '/var/mail/cltbld', 10:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:44 INFO - 'MOZ_NO_REMOTE': '1', 10:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:44 INFO - 'NO_EM_RESTART': '1', 10:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:21:44 INFO - 'PWD': '/builds/slave/test-pgo', 10:21:44 INFO - 'SHELL': '/bin/bash', 10:21:44 INFO - 'SHLVL': '1', 10:21:44 INFO - 'TERM': 'linux', 10:21:44 INFO - 'TMOUT': '86400', 10:21:44 INFO - 'USER': 'cltbld', 10:21:44 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790', 10:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:44 INFO - '_': '/tools/buildbot/bin/python'} 10:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:44 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 10:21:44 INFO - Cleaning up... 10:21:44 INFO - Return code: 0 10:21:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:44 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 0x7f3ae7db4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f07f0>, '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 0x205c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c760>, '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': 'eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790', '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 10:21:44 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 10:21:44 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 10:21:44 INFO - Using env: {'DISPLAY': ':0', 10:21:44 INFO - 'HOME': '/home/cltbld', 10:21:44 INFO - 'LANG': 'en_US.UTF-8', 10:21:44 INFO - 'LANGUAGE': 'en_US:en', 10:21:44 INFO - 'LOGNAME': 'cltbld', 10:21:44 INFO - 'MAIL': '/var/mail/cltbld', 10:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:44 INFO - 'MOZ_NO_REMOTE': '1', 10:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:44 INFO - 'NO_EM_RESTART': '1', 10:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:21:44 INFO - 'PWD': '/builds/slave/test-pgo', 10:21:44 INFO - 'SHELL': '/bin/bash', 10:21:44 INFO - 'SHLVL': '1', 10:21:44 INFO - 'TERM': 'linux', 10:21:44 INFO - 'TMOUT': '86400', 10:21:44 INFO - 'USER': 'cltbld', 10:21:44 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790', 10:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:44 INFO - '_': '/tools/buildbot/bin/python'} 10:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:44 INFO - Downloading/unpacking psutil>=0.7.1 10:21:44 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 10:21:44 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 10:21:44 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 10:21:44 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 10:21:44 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 10:21:44 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 10:21:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:21:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:21:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:21:46 INFO - Installing collected packages: psutil 10:21:46 INFO - Running setup.py install for psutil 10:21:46 INFO - building 'psutil._psutil_linux' extension 10:21:46 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 10:21:46 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 10:21:46 INFO - building 'psutil._psutil_posix' extension 10:21:46 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 10:21:46 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 10:21:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:21:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:21:46 INFO - Successfully installed psutil 10:21:46 INFO - Cleaning up... 10:21:46 INFO - Return code: 0 10:21:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:21: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')]} 10:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21: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')]} 10:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21: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', '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 0x7f3ae7db4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f07f0>, '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 0x205c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c760>, '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': 'eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790', '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 10:21: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:21: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 mozsystemmonitor==0.0.0 10:21:46 INFO - Using env: {'DISPLAY': ':0', 10:21:46 INFO - 'HOME': '/home/cltbld', 10:21:46 INFO - 'LANG': 'en_US.UTF-8', 10:21:46 INFO - 'LANGUAGE': 'en_US:en', 10:21:46 INFO - 'LOGNAME': 'cltbld', 10:21:46 INFO - 'MAIL': '/var/mail/cltbld', 10:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:46 INFO - 'MOZ_NO_REMOTE': '1', 10:21:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:46 INFO - 'NO_EM_RESTART': '1', 10:21:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:21:46 INFO - 'PWD': '/builds/slave/test-pgo', 10:21:46 INFO - 'SHELL': '/bin/bash', 10:21:46 INFO - 'SHLVL': '1', 10:21:46 INFO - 'TERM': 'linux', 10:21:46 INFO - 'TMOUT': '86400', 10:21:46 INFO - 'USER': 'cltbld', 10:21:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790', 10:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:46 INFO - '_': '/tools/buildbot/bin/python'} 10:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:21:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:21:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:21:49 INFO - Installing collected packages: mozsystemmonitor 10:21:49 INFO - Running setup.py install for mozsystemmonitor 10:21:49 INFO - Successfully installed mozsystemmonitor 10:21:49 INFO - Cleaning up... 10:21:49 INFO - Return code: 0 10:21:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:49 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 0x7f3ae7db4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f07f0>, '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 0x205c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c760>, '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': 'eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790', '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 10:21:49 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 10:21:49 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 10:21:49 INFO - Using env: {'DISPLAY': ':0', 10:21:49 INFO - 'HOME': '/home/cltbld', 10:21:49 INFO - 'LANG': 'en_US.UTF-8', 10:21:49 INFO - 'LANGUAGE': 'en_US:en', 10:21:49 INFO - 'LOGNAME': 'cltbld', 10:21:49 INFO - 'MAIL': '/var/mail/cltbld', 10:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:49 INFO - 'MOZ_NO_REMOTE': '1', 10:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:49 INFO - 'NO_EM_RESTART': '1', 10:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:21:49 INFO - 'PWD': '/builds/slave/test-pgo', 10:21:49 INFO - 'SHELL': '/bin/bash', 10:21:49 INFO - 'SHLVL': '1', 10:21:49 INFO - 'TERM': 'linux', 10:21:49 INFO - 'TMOUT': '86400', 10:21:49 INFO - 'USER': 'cltbld', 10:21:49 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790', 10:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:49 INFO - '_': '/tools/buildbot/bin/python'} 10:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:49 INFO - Downloading/unpacking blobuploader==1.2.4 10:21:49 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 10:21:49 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 10:21:49 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 10:21:49 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 10:21:49 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 10:21:49 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 10:21:51 INFO - Downloading blobuploader-1.2.4.tar.gz 10:21:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:21:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:21:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21:51 INFO - Downloading docopt-0.6.1.tar.gz 10:21:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:21:52 INFO - Installing collected packages: blobuploader, requests, docopt 10:21:52 INFO - Running setup.py install for blobuploader 10:21:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:21:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:21:52 INFO - Running setup.py install for requests 10:21:52 INFO - Running setup.py install for docopt 10:21:52 INFO - Successfully installed blobuploader requests docopt 10:21:52 INFO - Cleaning up... 10:21:52 INFO - Return code: 0 10:21:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:52 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 0x7f3ae7db4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f07f0>, '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 0x205c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c760>, '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': 'eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790', '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 10:21:52 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 10:21:52 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 10:21:52 INFO - Using env: {'DISPLAY': ':0', 10:21:52 INFO - 'HOME': '/home/cltbld', 10:21:52 INFO - 'LANG': 'en_US.UTF-8', 10:21:52 INFO - 'LANGUAGE': 'en_US:en', 10:21:52 INFO - 'LOGNAME': 'cltbld', 10:21:52 INFO - 'MAIL': '/var/mail/cltbld', 10:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:52 INFO - 'MOZ_NO_REMOTE': '1', 10:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:52 INFO - 'NO_EM_RESTART': '1', 10:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:21:52 INFO - 'PWD': '/builds/slave/test-pgo', 10:21:52 INFO - 'SHELL': '/bin/bash', 10:21:52 INFO - 'SHLVL': '1', 10:21:52 INFO - 'TERM': 'linux', 10:21:52 INFO - 'TMOUT': '86400', 10:21:52 INFO - 'USER': 'cltbld', 10:21:52 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790', 10:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:52 INFO - '_': '/tools/buildbot/bin/python'} 10:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:21:52 INFO - Running setup.py (path:/tmp/pip-NR8XuM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:21:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:21:52 INFO - Running setup.py (path:/tmp/pip-HDMvKh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:21:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:21:52 INFO - Running setup.py (path:/tmp/pip-RblO4H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:21:53 INFO - Running setup.py (path:/tmp/pip-ZV8pSH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:21:53 INFO - Running setup.py (path:/tmp/pip-mwdwRy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:21:53 INFO - Running setup.py (path:/tmp/pip-9nIFD7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:21:53 INFO - Running setup.py (path:/tmp/pip-MQDDZE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:21:53 INFO - Running setup.py (path:/tmp/pip-CmYJ1K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:21:53 INFO - Running setup.py (path:/tmp/pip-ERsO4N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:21:53 INFO - Running setup.py (path:/tmp/pip-LxLVxZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:21:53 INFO - Running setup.py (path:/tmp/pip-20lt0v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:21:53 INFO - Running setup.py (path:/tmp/pip-h91sec-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:21:53 INFO - Running setup.py (path:/tmp/pip-iAqXnx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:21:53 INFO - Running setup.py (path:/tmp/pip-Sp9G6A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:21:53 INFO - Running setup.py (path:/tmp/pip-V5DcMh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:21:53 INFO - Running setup.py (path:/tmp/pip-fOfmCQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:21:53 INFO - Running setup.py (path:/tmp/pip-OVdNPf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:21:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:21:54 INFO - Running setup.py install for manifestparser 10:21:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:21:54 INFO - Running setup.py install for mozcrash 10:21:54 INFO - Running setup.py install for mozdebug 10:21:54 INFO - Running setup.py install for mozdevice 10:21:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:21:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:21:54 INFO - Running setup.py install for mozfile 10:21:54 INFO - Running setup.py install for mozhttpd 10:21:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:21:54 INFO - Running setup.py install for mozinfo 10:21:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:21:54 INFO - Running setup.py install for mozInstall 10:21:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:21:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:21:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:21:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:21:54 INFO - Running setup.py install for mozleak 10:21:54 INFO - Running setup.py install for mozlog 10:21:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:21:55 INFO - Running setup.py install for moznetwork 10:21:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:21:55 INFO - Running setup.py install for mozprocess 10:21:55 INFO - Running setup.py install for mozprofile 10:21:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:21:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:21:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:21:55 INFO - Running setup.py install for mozrunner 10:21:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:21:55 INFO - Running setup.py install for mozscreenshot 10:21:55 INFO - Running setup.py install for moztest 10:21:55 INFO - Running setup.py install for mozversion 10:21:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:21:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:21:55 INFO - Cleaning up... 10:21:55 INFO - Return code: 0 10:21:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:21:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:55 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 0x7f3ae7db4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f07f0>, '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 0x205c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c760>, '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': 'eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790', '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 10:21:55 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 10:21:55 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 10:21:55 INFO - Using env: {'DISPLAY': ':0', 10:21:55 INFO - 'HOME': '/home/cltbld', 10:21:55 INFO - 'LANG': 'en_US.UTF-8', 10:21:55 INFO - 'LANGUAGE': 'en_US:en', 10:21:55 INFO - 'LOGNAME': 'cltbld', 10:21:55 INFO - 'MAIL': '/var/mail/cltbld', 10:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:55 INFO - 'MOZ_NO_REMOTE': '1', 10:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:55 INFO - 'NO_EM_RESTART': '1', 10:21:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:21:55 INFO - 'PWD': '/builds/slave/test-pgo', 10:21:55 INFO - 'SHELL': '/bin/bash', 10:21:55 INFO - 'SHLVL': '1', 10:21:55 INFO - 'TERM': 'linux', 10:21:55 INFO - 'TMOUT': '86400', 10:21:55 INFO - 'USER': 'cltbld', 10:21:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790', 10:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:55 INFO - '_': '/tools/buildbot/bin/python'} 10:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:21:56 INFO - Running setup.py (path:/tmp/pip-NnkpUD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 10:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:21:56 INFO - Running setup.py (path:/tmp/pip-4cLaHo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:21:56 INFO - Running setup.py (path:/tmp/pip-n8vLXd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:21:56 INFO - Running setup.py (path:/tmp/pip-MEuxGc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:21:56 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)) 10:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:21:56 INFO - Running setup.py (path:/tmp/pip-0E00Xj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:21:56 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)) 10:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:21:56 INFO - Running setup.py (path:/tmp/pip-Cxm0js-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:21:56 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)) 10:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:21:56 INFO - Running setup.py (path:/tmp/pip-L0tQ4U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:21:56 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)) 10:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:21:56 INFO - Running setup.py (path:/tmp/pip-NijrtU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:21:56 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)) 10:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:21:56 INFO - Running setup.py (path:/tmp/pip-BxyBgc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:21:56 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)) 10:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:21:56 INFO - Running setup.py (path:/tmp/pip-ngi1rF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:21:56 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)) 10:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:21:56 INFO - Running setup.py (path:/tmp/pip-TuADfv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:21:56 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)) 10:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:21:56 INFO - Running setup.py (path:/tmp/pip-g1fwGc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:21:56 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)) 10:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:21:56 INFO - Running setup.py (path:/tmp/pip-CsmPpY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:21:56 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)) 10:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:21:56 INFO - Running setup.py (path:/tmp/pip-5LXnFA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 10:21:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:21:57 INFO - Running setup.py (path:/tmp/pip-iNVKZT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 10:21:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:21:57 INFO - Running setup.py (path:/tmp/pip-9xA4yG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 10:21:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:21:57 INFO - Running setup.py (path:/tmp/pip-5_YjYr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 10:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:21:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:59 INFO - Downloading blessings-1.6.tar.gz 10:21:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:21:59 INFO - Installing collected packages: blessings 10:21:59 INFO - Running setup.py install for blessings 10:21:59 INFO - Successfully installed blessings 10:21:59 INFO - Cleaning up... 10:21:59 INFO - Return code: 0 10:21:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:21:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:21:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:21:59 INFO - Reading from file tmpfile_stdout 10:21:59 INFO - Current package versions: 10:21:59 INFO - argparse == 1.2.1 10:21:59 INFO - blessings == 1.6 10:21:59 INFO - blobuploader == 1.2.4 10:21:59 INFO - docopt == 0.6.1 10:21:59 INFO - manifestparser == 1.1 10:21:59 INFO - mozInstall == 1.12 10:21:59 INFO - mozcrash == 0.16 10:21:59 INFO - mozdebug == 0.1 10:21:59 INFO - mozdevice == 0.48 10:21:59 INFO - mozfile == 1.2 10:21:59 INFO - mozhttpd == 0.7 10:21:59 INFO - mozinfo == 0.9 10:21:59 INFO - mozleak == 0.1 10:21:59 INFO - mozlog == 3.1 10:21:59 INFO - moznetwork == 0.27 10:21:59 INFO - mozprocess == 0.22 10:21:59 INFO - mozprofile == 0.28 10:21:59 INFO - mozrunner == 6.11 10:21:59 INFO - mozscreenshot == 0.1 10:21:59 INFO - mozsystemmonitor == 0.0 10:21:59 INFO - moztest == 0.7 10:21:59 INFO - mozversion == 1.4 10:21:59 INFO - psutil == 3.1.1 10:21:59 INFO - requests == 1.2.3 10:21:59 INFO - wsgiref == 0.1.2 10:21:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:59 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 0x7f3ae7db4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f07f0>, '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 0x205c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c760>, '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': 'eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790', '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 10:21:59 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 10:21:59 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 10:21:59 INFO - Using env: {'DISPLAY': ':0', 10:21:59 INFO - 'HOME': '/home/cltbld', 10:21:59 INFO - 'LANG': 'en_US.UTF-8', 10:21:59 INFO - 'LANGUAGE': 'en_US:en', 10:21:59 INFO - 'LOGNAME': 'cltbld', 10:21:59 INFO - 'MAIL': '/var/mail/cltbld', 10:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:59 INFO - 'MOZ_NO_REMOTE': '1', 10:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:59 INFO - 'NO_EM_RESTART': '1', 10:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:21:59 INFO - 'PWD': '/builds/slave/test-pgo', 10:21:59 INFO - 'SHELL': '/bin/bash', 10:21:59 INFO - 'SHLVL': '1', 10:21:59 INFO - 'TERM': 'linux', 10:21:59 INFO - 'TMOUT': '86400', 10:21:59 INFO - 'USER': 'cltbld', 10:21:59 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790', 10:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:59 INFO - '_': '/tools/buildbot/bin/python'} 10:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:59 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)) 10:21:59 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)) 10:21:59 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)) 10:21:59 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)) 10:21:59 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)) 10:21:59 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)) 10:21:59 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)) 10:21:59 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)) 10:21:59 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)) 10:21:59 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)) 10:21:59 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)) 10:21:59 INFO - Cleaning up... 10:21:59 INFO - Return code: 0 10:21:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:59 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 0x7f3ae7db4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f07f0>, '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 0x205c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c760>, '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': 'eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790', '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 10:21:59 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 10:21:59 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 10:21:59 INFO - Using env: {'DISPLAY': ':0', 10:21:59 INFO - 'HOME': '/home/cltbld', 10:21:59 INFO - 'LANG': 'en_US.UTF-8', 10:21:59 INFO - 'LANGUAGE': 'en_US:en', 10:21:59 INFO - 'LOGNAME': 'cltbld', 10:21:59 INFO - 'MAIL': '/var/mail/cltbld', 10:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:59 INFO - 'MOZ_NO_REMOTE': '1', 10:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:59 INFO - 'NO_EM_RESTART': '1', 10:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:21:59 INFO - 'PWD': '/builds/slave/test-pgo', 10:21:59 INFO - 'SHELL': '/bin/bash', 10:21:59 INFO - 'SHLVL': '1', 10:21:59 INFO - 'TERM': 'linux', 10:21:59 INFO - 'TMOUT': '86400', 10:21:59 INFO - 'USER': 'cltbld', 10:21:59 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790', 10:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:59 INFO - '_': '/tools/buildbot/bin/python'} 10:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:59 INFO - Downloading/unpacking jsonschema 10:21:59 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 10:21:59 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 10:21:59 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 10:21:59 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 10:21:59 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 10:21:59 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 10:22:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:22:01 INFO - Downloading/unpacking functools32 (from jsonschema) 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22:02 INFO - Downloading functools32-3.2.3-2.tar.gz 10:22:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:22:02 INFO - warning: no files found matching '*.txt' 10:22:02 INFO - no previously-included directories found matching 'build' 10:22:02 INFO - no previously-included directories found matching 'dist' 10:22:02 INFO - no previously-included directories found matching '.git*' 10:22:02 INFO - Installing collected packages: jsonschema, functools32 10:22:02 INFO - Running setup.py install for functools32 10:22:02 INFO - warning: no files found matching '*.txt' 10:22:02 INFO - no previously-included directories found matching 'build' 10:22:02 INFO - no previously-included directories found matching 'dist' 10:22:02 INFO - no previously-included directories found matching '.git*' 10:22:02 INFO - Successfully installed jsonschema functools32 10:22:02 INFO - Cleaning up... 10:22:02 INFO - Return code: 0 10:22:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:02 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 0x7f3ae7db4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f07f0>, '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 0x205c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c760>, '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': 'eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790', '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 10:22:02 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 10:22:02 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 10:22:02 INFO - Using env: {'DISPLAY': ':0', 10:22:02 INFO - 'HOME': '/home/cltbld', 10:22:02 INFO - 'LANG': 'en_US.UTF-8', 10:22:02 INFO - 'LANGUAGE': 'en_US:en', 10:22:02 INFO - 'LOGNAME': 'cltbld', 10:22:02 INFO - 'MAIL': '/var/mail/cltbld', 10:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:02 INFO - 'MOZ_NO_REMOTE': '1', 10:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:02 INFO - 'NO_EM_RESTART': '1', 10:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:22:02 INFO - 'PWD': '/builds/slave/test-pgo', 10:22:02 INFO - 'SHELL': '/bin/bash', 10:22:02 INFO - 'SHLVL': '1', 10:22:02 INFO - 'TERM': 'linux', 10:22:02 INFO - 'TMOUT': '86400', 10:22:02 INFO - 'USER': 'cltbld', 10:22:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790', 10:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:02 INFO - '_': '/tools/buildbot/bin/python'} 10:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:02 INFO - Downloading/unpacking flake8 10:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:22:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:22:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:22:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:22:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:22:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:22:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:22:05 INFO - no previously-included directories found matching 'docs/_build' 10:22:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:22:05 INFO - Running setup.py install for pep8 10:22:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:22:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:22:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:22:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:22:05 INFO - no previously-included directories found matching 'docs/_build' 10:22:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:22:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:22:05 INFO - Cleaning up... 10:22:05 INFO - Return code: 0 10:22:05 INFO - Running post-action listener: _resource_record_post_action 10:22:05 INFO - Running post-action listener: _start_resource_monitoring 10:22:05 INFO - Starting resource monitoring. 10:22:05 INFO - ##### 10:22:05 INFO - ##### Running install step. 10:22:05 INFO - ##### 10:22:05 INFO - Running pre-action listener: _resource_record_pre_action 10:22:05 INFO - Running main action method: install 10:22:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:22:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:22:05 INFO - Reading from file tmpfile_stdout 10:22:05 INFO - Detecting whether we're running mozinstall >=1.0... 10:22:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:22:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:22:05 INFO - Reading from file tmpfile_stdout 10:22:05 INFO - Output received: 10:22:05 INFO - Usage: mozinstall [options] installer 10:22:05 INFO - Options: 10:22:05 INFO - -h, --help show this help message and exit 10:22:05 INFO - -d DEST, --destination=DEST 10:22:05 INFO - Directory to install application into. [default: 10:22:05 INFO - "/builds/slave/test-pgo"] 10:22:05 INFO - --app=APP Application being installed. [default: firefox] 10:22:05 INFO - mkdir: /builds/slave/test-pgo/build/application 10:22:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:22:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:22:20 INFO - Reading from file tmpfile_stdout 10:22:20 INFO - Output received: 10:22:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:22:20 INFO - Running post-action listener: _resource_record_post_action 10:22:20 INFO - ##### 10:22:20 INFO - ##### Running run-tests step. 10:22:20 INFO - ##### 10:22:20 INFO - Running pre-action listener: _resource_record_pre_action 10:22:20 INFO - Running main action method: run_tests 10:22:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:22:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:22:20 INFO - Python 2.7.3 10:22:20 INFO - Return code: 0 10:22:20 INFO - grabbing minidump binary from tooltool 10:22: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')]} 10:22:20 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 0x20f07f0>, '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 0x205c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:22:20 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 10:22:20 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 10:22:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:22:20 INFO - Return code: 0 10:22:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:22:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:22:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:22:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:22:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:22:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:22:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:22:21 INFO - Return code: 0 10:22:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 10:22:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 10:22:21 INFO - Using env: {'DISPLAY': ':0', 10:22:21 INFO - 'HOME': '/home/cltbld', 10:22:21 INFO - 'LANG': 'en_US.UTF-8', 10:22:21 INFO - 'LANGUAGE': 'en_US:en', 10:22:21 INFO - 'LOGNAME': 'cltbld', 10:22:21 INFO - 'MAIL': '/var/mail/cltbld', 10:22:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:22:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:21 INFO - 'MOZ_NO_REMOTE': '1', 10:22:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:22:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:21 INFO - 'NO_EM_RESTART': '1', 10:22:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:22:21 INFO - 'PWD': '/builds/slave/test-pgo', 10:22:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:22:21 INFO - 'SHELL': '/bin/bash', 10:22:21 INFO - 'SHLVL': '1', 10:22:21 INFO - 'TERM': 'linux', 10:22:21 INFO - 'TMOUT': '86400', 10:22:21 INFO - 'USER': 'cltbld', 10:22:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790', 10:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:21 INFO - '_': '/tools/buildbot/bin/python'} 10:22:21 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 10:22:21 INFO - mozversion application_buildid: 20160224074545 10:22:21 INFO - mozversion application_changeset: 917763c36a6e9a66dc5270e4514e07251967e5d4 10:22:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:22:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:22:21 INFO - mozversion application_name: Firefox 10:22:21 INFO - mozversion application_remotingname: firefox-dev 10:22:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:22:21 INFO - mozversion application_vendor: Mozilla 10:22:21 INFO - mozversion application_version: 46.0a2 10:22:21 INFO - mozversion platform_buildid: 20160224074545 10:22:21 INFO - mozversion platform_changeset: 917763c36a6e9a66dc5270e4514e07251967e5d4 10:22:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:22:21 INFO - mozversion platform_version: 46.0a2 10:22:21 INFO - using testdate: 1456338141 10:22:21 INFO - actual date: 1456338141 10:22:21 INFO - starting webserver on 'localhost:53344' 10:22:21 INFO - SUITE-START | Running 3 tests 10:22:21 INFO - TEST-START | dromaeo_css 10:22:21 INFO - operating with platform_type : linux_ 10:22:21 INFO - Initialising browser for dromaeo_css test... 10:22:21 INFO - TEST-INFO | started process 16499 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTYPrF7/profile http://localhost:53344/getInfo.html) 10:22:25 INFO - PROCESS | 16499 | 10:22:25 INFO - PROCESS | 16499 | (process:16581): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:22:26 INFO - PROCESS | 16499 | __metrics Screen width/height:1600/1200 10:22:26 INFO - PROCESS | 16499 | colorDepth:24 10:22:26 INFO - PROCESS | 16499 | Browser inner width/height: 1024/697 10:22:26 INFO - PROCESS | 16499 | __metrics 10:22:27 INFO - TEST-INFO | 16499: exit 0 10:22:27 INFO - Browser initialized. 10:22:27 INFO - Running cycle 1/1 for dromaeo_css test... 10:22:27 INFO - TEST-INFO | started process 16630 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTYPrF7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:22:29 INFO - PROCESS | 16630 | 10:22:29 INFO - PROCESS | 16630 | (process:16691): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:22:39 INFO - PROCESS | 16630 | RSS: Main: 140681216 10:22:39 INFO - PROCESS | 16630 | 10:23:29 INFO - PROCESS | 16630 | 1456338209324 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] 10:25:37 INFO - PROCESS | 16630 | Cycle 1(1): loaded http://localhost:53344/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53344/tests/dromaeo/cssquery-ext.html) 10:25:38 INFO - PROCESS | 16630 | RSS: Main: 145195008 10:25:38 INFO - PROCESS | 16630 | 10:28:40 INFO - PROCESS | 16630 | Cycle 1(1): loaded http://localhost:53344/tests/dromaeo/cssquery-ext.html (next: http://localhost:53344/tests/dromaeo/cssquery-jquery.html) 10:28:40 INFO - PROCESS | 16630 | RSS: Main: 144011264 10:28:40 INFO - PROCESS | 16630 | 10:31:42 INFO - PROCESS | 16630 | Cycle 1(1): loaded http://localhost:53344/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53344/tests/dromaeo/cssquery-mootools.html) 10:31:42 INFO - PROCESS | 16630 | RSS: Main: 143745024 10:31:42 INFO - PROCESS | 16630 | 10:34:44 INFO - PROCESS | 16630 | Cycle 1(1): loaded http://localhost:53344/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53344/tests/dromaeo/cssquery-prototype.html) 10:34:45 INFO - PROCESS | 16630 | RSS: Main: 143200256 10:34:45 INFO - PROCESS | 16630 | 10:37:47 INFO - PROCESS | 16630 | Cycle 1(1): loaded http://localhost:53344/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53344/tests/dromaeo/cssquery-yui.html) 10:37:48 INFO - PROCESS | 16630 | RSS: Main: 143773696 10:37:48 INFO - PROCESS | 16630 | 10:40:50 INFO - PROCESS | 16630 | Cycle 1(1): loaded http://localhost:53344/tests/dromaeo/cssquery-yui.html (next: http://localhost:53344/tests/dromaeo/cssquery-dojo.html) 10:40:50 INFO - PROCESS | 16630 | RSS: Main: 146743296 10:40:50 INFO - PROCESS | 16630 | 10:40:50 INFO - PROCESS | 16630 | __start_tp_report 10:40:50 INFO - PROCESS | 16630 | _x_x_mozilla_page_load 10:40:50 INFO - PROCESS | 16630 | _x_x_mozilla_page_load_details 10:40:50 INFO - PROCESS | 16630 | |i|pagename|runs| 10:40:50 INFO - PROCESS | 16630 | |0;dojo.html;3321.7342612590987;3371.662833716628;3372.5615669962917;3388.9322213555747;3414.129397003765;5441.211024401459;5461.453854614541;5477.20580515825;5485.6434331768405;5496.7526461309235;5398.48714372135;5486.725663716818;5504.2018907258525;5528.5024347808685;5528.889422211553;4965.106280869451;5033.672811267256;5101.923471147936;5114.3095682083;5136.768845401947;4904.36243288372;4986.675866068712;5041.495850414965;5058.772355244023;5078.289039534468;5085.644004919639;5115.693058416488;5149.459306772772;5152.381714194302;5159.587233021368;4989;5040.798368065273;5051.494850514956;5056.165732654108;5070.492950704918;4896.706197628154;4917.557419832232;4955.554000140005;4965.081459929925;4972.95567930735;5248.685078895279;5255.290535777659;5279.577633789288;5281.970015846911;5285.7885684572575;5888.440598143169;5905.4980326672285;5925.170476133345;5926.644401335933;5928.6739229342365;5768.336641286264;5925.91111133329;5946.97026514869;5962.433568810956;6052.21321228242;5505.119180931032;5521.585881058896;5522.3649280332875;5532.474414930575;5551.500364967173;5982.4316689914385;5998;6012.098185272244;6013.9699301503215;6014.7594096236535;5660.264165658438;5747.971260143756;5800.4199580042505;5887.8233652990475;5918.556108291896;5883.735231914574;5885.264341957255;5887.646741195542;5893.381194974551;5899.734511946973;5812.82561523155;5825.2135961644635;5846.590738648254;5847.736851841677;5852.619579727304;5778.046622307273;5823.213866128103;5831.650100993954;5843.474087332075;5898.174255604219;4490.214212512862;4499.955000450019;4519.728816271035;4534.45586529612;4535.387722657399;3970.9930973945497;4073.042834933788;4082.040720430696;4090.4886889138857;4098.221337945781;5469.781208751685;5527.778888844401;5592.273004509388;5602.1036634138345;5614.9719251403485;5916.556258280646;5928.525717942641;5972.492338151219;5990.6405615662325;5993.490553303018;5465.480779325958;5520.696361700065;5564.248826408464;5592.328920529562;5617.101263797773;5003;5013.649044566845;5031.572316353077;5049.899002020013;5054.91319366338;6022.57841951068;6023.247094113236;6026.7890623828835;6034.151238344423;6043.546733994968;5841.707914604168;5845.736941837543;5914.64512129265;5925.940740592711;5960.046392577166;6031.969840150771;6046.909296360646;6052.909206361996;6057.606255593372;6059.909101363572;5779.797707080232;5825.213596164633;5830.387809280134;5830.708464576839;5839.474447299764;5779.566532509994;5906.881862362643;5944.405559444021;5988.730507127277;6040.546958978182;5756.94243057564;5762.193292939076;5767.423257674367;5775.393583673822;5781.797637082682;5600.663960162403;5710.600257981901;5711.286089238845;5717.342505611741;5734.7132643368495;5620.353659329229;5627.0434026214825;5629.408912064175;5662.405447428126;5698.088305871041;5785.929603023455;5808.651480911159;5828.504577110993;5831.504322132666;5850;5613.719314034201;5673.092305231144;5709.914351284817;5747.19539264495;5766.423357664368 10:40:50 INFO - PROCESS | 16630 | |1;ext.html;522.7490804413882;548.363897878461;558.888222355529;573.9770409183633;592.0349829777462;30650.54024189636;37385.813070934644;37460.43809342855;37543.99999999996;37736.81131594345;41644.16711665765;42164.36753448693;42183.57816421835;42335;42427.78786106073;8668.826623467543;8893.466392016468;8894.155055269772;8922.910770892306;8924.732258032236;8637.654493820271;8759.255463285597;8803.867941980876;8822.206001459866;8911.509866957314;9017.639294428214;9063.818723625523;9091.909080909172;9092.8636070459;9093.40892841963;8921.910780892205;9028;9035.548222588877;9044.3668943174;9051.954740226289;8868.822623547492;8951.73144805657;8955.328350373748;8994.86507702385;9015.41399809017;41336.379954300406;41851.372229416585;41881.37177942333;41990.37014444786;42098.78950605258;3362.546056282395;3563.1092226943265;3665.9450108248398;3738.36447803874;3770.7171962102952;31667.84166079178;31819.204519886956;31887.202819929455;32113.1971700707;32231.6776832231;4215.2623290924275;4337.954110898647;4342.652587793001;4349.869503914888;4365.257906155961;266990;267609;267671;268540;269240;59218.40781592129;59477.40522594719;59654.40345596575;59878;59905.70047149737;62098;62194.68902655548;62261;62301.37698622956;62475.68762156251;16563.91718041402;17101;17125.14374281281;17150.399736009178;17171.914140429217;11843.23019003762;11934.462949167308;11946.402679865972;12038.097142714332;12051.457684404222;19039.048047597564;19482.123304451332;19591.706124408145;19688.409347719593;19729.704054439197;7956.562389068657;7962.243586859239;8015.679372825021;8066.757997259974;8101.351891848638;1043.9634612788516;1171.1918776044672;1171.718787490996;1194.5938380950518;1223.8959688426582;29941.40117197644;30084.548731769042;30164.095077147722;30289.394212116076;30341.544876826865;1101.4767985207122;1122.5509796081633;1134.6425875849245;1144.1075960750627;1196.186593116689;13932.37304321308;14117.08238964464;16002.439914602934;16734.832651673572;16739.832601674072;356014;356707;356970;358254;359623;48414.75792621085;48604.27093593599;48651.27023094657;48782.26826597604;48806.26790598073;1467.8091848059685;1489.865912067919;1489.9851001489847;1506.0210862939177;1506.344740038087;26560.468790623694;27012.86493567598;27468.17595472139;27775.861120695077;29614.111576652736;44230;44595.55404445914;44931;44934.55065449304;45085.77457112693;225301;225396;226330;226479;227169;31793.682063179996;31855;32258.677413225567;32691.673083269816;32851.50722739113;44573.77713111414;44835.327470088625;44980.100397991206;45069.54930450654;46612.7669361651;37995.81002094972;38406.6159338403;38742.80628596839;39598.80200599094;40055.59944400519;34993.65006349904;36701.63298366982;37682.91292080539;37771;37854.62145378511;38195.61804381921;38463.230735384575;38764.41853372258;39023.414648779726;39061.609383905794;32223.35553288968;32292.19269518281;32564.83717581397;32719.836400817843;33005.834970824995;25349.873250634366;26141.869290653423;26254.737452625228;26259.21222363332;26350.868245659414 10:40:50 INFO - PROCESS | 16630 | |2;jquery.html;398.9062570295982;403.60245158518853;403.800118941124;404.0524968947817;406.8718353718579;17749;18106.728399074007;18367.54081147972;18532.166052527635;18798.436046918596;11772.764544709122;13464.394102265396;17064.829351706478;17407.564810879736;17415.738763918518;5163.354580677425;5295.8146464873735;5312;5324.281222035033;5349.919751203735;5125.846224613268;5227.660202086871;5292.073887069767;5296.496832800878;5323.494268044529;5285.973570132163;5295.7881684732565;5750.769969201227;5953.464188223059;5987.760489580412;5782.248307720011;5855.502282305988;5891.293044834626;6218.253809542884;6223.7821676241565;5381.434949330303;5588;5602;5607.074832652607;5621.297337832771;13809.033367664268;14036.649083772987;14088.436462541486;14092.718145637133;18994.14526346318;2280.920167794119;2324.9651255231183;2360.2919124262653;2366.432056306491;2442.7435119312395;9861.063198996084;10228.74428139295;10601.416922069284;13716.519921802688;13813.240271785047;1863.1615772902248;1901.8288354048063;1939.6896496560482;1986.6622674145285;1999.7700264469627;60594.69702651502;61448.0782788263;63530.68234658843;63917;64339.3566064338;10964.06805421548;11050.226484146033;11096.389698566656;11123.888761112285;11145.498452569655;14444.277786110863;14549.490767823076;14561.854381456262;14638.926805365905;14650.926745366205;7976.521408715495;8028.879566806502;8030.277275045274;8140.267375936194;8190.836183276301;7663.770086897402;7680.884786728204;7749.7675069748;7752.806179845549;7758.7672369829;4580.633549316047;4835.758212089381;4845.515448455127;4879.950810575743;4883.145449546386;1949.814767597076;1951.9316823911095;2036.9898150509448;2039.1945181653164;2065.266830275261;475.3653872080811;1001.449202938381;1002.904724051214;1015.3400289811682;1087.8205096159045;11085.334879907232;11240.887591124148;11246.66260012201;11387.089032877515;11529.884701153049;505.3304371707502;513.3557385481197;518.4219595151379;541.7291354322839;1020.3010937507831;9281.02549232321;9992.950035249778;10563.630272940563;10584.947075264574;10585.523651435704;584902;598953;602241;630011;640131;76675.61662191653;77351;78145.21854781493;79547.60226198948;81111;1246.7880460321767;1258.5783762439685;1268.7081971146688;1271.0911698135876;1271.1038717703996;15807.13060781668;15975.20123993819;16035.198240088183;16100.436484722979;16173.595660108122;34867;36183.819080904424;36417.27165456623;36908.26183476262;37469.625303746616;42059;43393.566064340215;44084.11831763283;44756.55243447524;46822;7534.475950556625;7707.8073048172;7976.7208147714555;8002.3198028165925;8052.154523775153;9680.515974201402;10610.734731631772;10702.357858528514;10755.408452535186;11945.04439644809;3013.560523255545;3056.0984509569284;7538.09542854861;9851.408915465096;10105.747356315856;9464.905350946678;9720.708378748648;10305.278630495794;10468.581256749949;10726.249162558546;9313.953430232805;9441.669541566287;9562;9672.516374181403;10166.288359815038;7858.528488290721;8051.4766540174705;8152.184781522037;8152.714654987047;8170.7957301067945;9473.763155921157;10305.53625086888;10334.276600637882;10420.68737937863;10593.311434756715 10:40:50 INFO - PROCESS | 16630 | |3;mootools.html;1565.1391734545998;1585.556044307594;1831.1576674729624;1907.2180406033528;1946.7469229000228;8129.837403251931;8299.709510167131;8325.5004699718;8331.333493320535;8593.699220527284;8311.584420778967;8378.204070613281;8415.873761893576;8441.860348852902;8492.575371231445;2418.987905060477;2425.9514809703796;2432.136591510015;2441.56051910656;2442.3771938155746;2458.1887976967646;2474.084588702183;2484.8633325167107;2489.0666000249907;2492.6884139482563;2383.92848214553;2421.757824217582;2426.5996110641813;2429.708434987804;2441.914532991346;2446.584080706284;2455.2511483997373;2487.266256454332;2491.252624212738;2500;2462.889169987337;2481.2184161988916;2490.6762120924345;2494.3140636324974;2525.5454018276705;8396.286315663176;8420.115887831751;8444.324454043663;8466.280366168821;8477.83044339116;5158.974205128988;5281.313429254211;5285.048691235576;5314.760835762361;5322.04203243416;3223.4358987177384;3253.137918451612;3293.6541663125504;3324.069260607034;3339.432296509575;1174.1487421619343;1189.1141099880558;1193.6777070191088;1215.598852378713;1215.8966487848543;11905.28568285897;12041.157119001673;12051.457684404135;12058.819117713241;12130.575429859913;4603.263477843596;4620.237660785932;4626.1210370029585;4667.813287468532;4691.7184968901975;9719.222462203006;9743.415395076176;9791.804163916824;9797.16724078447;9803.852942205873;5145.819896303611;5230.869228269324;5262.60530460217;5278.129108697099;5283.365996080495;4768.928466073012;4791.95208047922;4843.903121937541;4860.902781944412;4862.197737373364;3804.4483549885113;3832.559255685632;3891.9416208756893;3915.1778126593163;3923.2545816295383;1129.9378534180535;1168.9532418703157;1194.8028575285155;1198.3049831097942;1200.7778560966249;1122.0686829931137;1178.5344788808372;1180.8819118088122;1201.567435723139;1226.3316492511603;7879.487833290817;7930.682772689143;7946.364290856717;7961.840763184704;8091.676332946617;1204.3978010994504;1208.7401208740164;1217.391304347826;1219.6463025722442;1220.9084318676134;6035.547333949971;6083.482903953125;6105.786297479567;6131.785387511505;6141.07883817431;10057.69826905194;10349.120324772328;10356;10481.475926203659;10499.580016799242;9770;10283.07452329294;10493.9475302623;10502.264841461178;10580.047795698423;7978.042634883851;8033.799155021171;8042.758717238492;8060.193980601893;8103.392245581605;7636.618169091412;7698.384129269757;7738.993930788962;7800.180980996914;7801.804954876174;8932.06213347615;9062.229710474683;9065.093490650883;9121.087891210826;9146.49694266795;9176.26589872822;9272.350935434455;9313.767155821159;9568.378055426376;9618.807623847344;7670.961645191738;7688.46180767341;7795.532268063935;7819.257170568787;7834.177411371724;8131.878021829795;8188.181181882002;8304.128066552925;8309.750707478785;8335.95832020836;7842.490238134731;7845.882311765442;7956.9602151988865;8022.759317220492;8054.637541310773;7394.186639469762;7466.141393739789;7506.8498630026;7555.093388793161;7597.392208623407;7397.223291554525;7458.440616953859;7466.514676546007;7481.588512631857;7513.098428188434;6941.722331106699;6987.0567473392475;7000.159980802337;7000.719971201299;7012.7545535906;6820.488463365168;6863.519553631198;6990.196127445409;7012.1935977363255;7048.400885924754 10:40:50 INFO - PROCESS | 16630 | |4;prototype.html;373.5256224594765;378.19633279281527;384.4444777296807;387.0826142043357;388.8055972013993;6302.9054564181515;6389.105525226472;6392.840178995528;6400.871982560352;6534.215894092716;6238.656873871935;6342.904856427146;6380.521460890429;6409.13476680648;6431.903521447182;5003.2995380646735;5039.798408063673;5040.261109917073;5044.82343117991;5047.318611987372;4973.676711013791;5029.5221953914315;5032.144535428986;5035.320231768719;5041.672291301072;4987.576056035241;4997.800087996494;5001.7499125043605;5011.749412529377;5011.824586139486;4974.87562810929;4998;5003.17447621142;5005.874853128683;5006.098902197603;4402;4403.493598236212;4410.8090815479645;4435.179491793996;4446.977765111186;6038.154658347835;6140.17107690465;6143.907841382383;6152.784652537184;6168.167297414837;5870.853228669274;5875.735591898375;5880.705964701748;5892.204552385416;5904.586678932434;6827.044213810071;6842.178938527359;6842.281560436132;6849.965750171267;6864.656767161672;4912;4924.532169443897;4926.507349265081;4932.432770231433;4937.481564435719;6994.2656021117555;7122.501424900259;7169.175544812361;7169.426445884316;7195.89206161908;5038.949610503922;5054.69671819692;5068.290439338495;5072.721000344943;5076.822311219164;5137.152369859006;5138.3577052868395;5145.07388670043;5150.4849515048945;5152.613553983466;5591.4688104629995;5797.652140871477;5807.186993820868;5843.474087332075;5879.823605291848;6865.347791959756;6877.105976223059;6877.828054298582;6905.620190889449;6915.066466027122;1724.5516165796982;1758.850497707709;1759.9912000440172;1760.938367157169;1762.5153082902305;1177.3348058347005;1178.505027888289;1191.6186820217447;1206.2943178240653;1210.5278941212935;6468.482521398277;6496.350364963466;6512.088307636935;6535.477161827042;6550.148480697479;7019.613921234279;7024.789256322319;7036.19083805369;7037.788866334018;7067.505274630829;6420.422162005442;6485.902711459332;6520.934790652128;6545;6575.704093315812;3771.3777226757825;3845.2117315950163;3845.8846234613006;3846.0961674006585;3848.288066707668;7147.499675022803;7151.499395042297;7156.389812292193;7157.391621712109;7159.427245820426;7116.359527642434;7246.49274550787;7255.673494692752;7257.419406447471;7333.1200255969625;7294.343509084208;7303.269673032654;7319.451041171933;7329.633518324169;7332.413406927433;7168.17565979919;7206.783796486114;7212.386947109345;7214.386777123793;7214.567125972459;6840.486963477859;7019.6841142147705;7029.402500787491;7054.047703559953;7081.398081163159;7320.96339518299;7329.560226386434;7347.302006309392;7366.77899663011;7395;4915.877103072309;4945.307656927961;4968.0312339093525;4970.204767237225;4989.727619457015;7021.964890175516;7051.5063945523325;7168;7171.282871712996;7192.532485388433;6931.09895713554;6953.513254072166;6981.581105133709;6988.580685158907;6991.265917078634;6890.276520965427;6967.163940327193;6973.965130174317;6977.406920411822;6983.755568555076;6648.434883034803;6776.051352810512;6825.488088393489;6838.521303508706;6850.520463567702;6994.160700715946;7006.159260888726;7008.633316503233;7018.473614479037;7029.683664235224;6707.4969377297875;6785.762498312535;6804.76183333581;6839.213490448463;6842.692078856364 10:40:50 INFO - PROCESS | 16630 | |5;yui.html;858.1075681291458;893.4014210478979;914.5015966298366;920.5857364186118;959.1942768074816;14048.227347495897;14048.297585120741;14075.859241407583;14102.506412275572;14123.929380353084;13911.513097041605;14037.578872633838;14061.296935153227;14075.57773266801;14082.92958535206;917.8623206519009;921.5714692667908;924.7456949338952;925.1812146250583;931.2829121576382;910.0580898769774;910.0626354854511;910.81328327693;912.4434095201922;913.6162811619103;949.7862980829293;951.196239177897;952.4523399045542;953.2183609440261;956.2636769687336;943.3302355327726;944.0135058863505;950.3442624589012;950.3632566180676;956.741679746468;698.6227437183915;699.4264702943589;703.1456780012259;703.6481759120439;704.799132247307;14264.85735142656;14285.071470354394;14293;14294.571162865132;14300.785488217685;13761.243131627756;13784.655383615389;13793.793093103612;13839.584812455643;13890.58328250144;11576.594819181373;11669.008134308593;11686.357250351228;11716.179867409284;11836.822447663291;3844.4041173618134;3849.480320156771;3875.7286989910717;3887.280853042168;3892.2799282132896;54288.18567721448;56676.14985775216;57632.13551796768;58490;58512.41487585112;11031.944840275748;11380.430978451044;11589.536418543164;11645.12661550387;11648.70878228034;19023.904880475788;19101.904490477737;19108.522286942938;19127.33054343091;19146.80853191478;8056.073551541648;8159.388045896581;8429.367797415096;8536.231739143506;8650;4606.631469482433;4858.882457034902;4870.878228044327;4894.632902532324;4969.105560998983;3189.091109033914;3206.3587282543585;3206.551082848403;3218.5815843940136;3234.4178047951596;606.884691908536;607.3895734786511;608.5071092415158;610.3987572241339;610.7801191571031;679.3953381490477;717.7272636398135;722.2524686948983;722.4256715910758;743.5835931878165;9129.315301352424;9615.56729947154;9626.855597166048;9687.2734544908;9759.463229522302;579.658001778944;695.8121307247117;738.3613174604036;741.1809950005166;745.2175216023154;4204.285271503852;4343.7176583522605;4495.527969563214;4549.953510692493;4597.011642496879;61684;61706.69146654238;62421;62551;62609;55905.7204713982;56093.15860262099;56351.71824140935;57038;57293;49242;52846.73576632169;53867.19199212015;55233;55685.44314556884;9733;9738.707838764849;10004;10087.848682269625;10092.444915529717;37356.439653404675;38174.42738358983;38809.80595097006;38879.80560097181;39201.2159756809;47750;48054.75972620115;48776.26835597398;48807.75596121997;49019.50980490292;11805;12177.878221217674;12211.26732396059;12288.631341059425;12388.318642474751;13269.325089547197;13401;13647.11293765902;13691.246981416118;14439.350229239499;12282.75434491323;12433;12788.744225115259;12971.610851674464;13111.541096061592;12464.813027804408;12717.173383730398;12735.872641273469;12992.675183120498;13020.41408136655;12059.939700301442;12671.87328126707;12758.808617870925;12784.74430511403;12870.549530766379;10220.488975551045;10458.320209186379;10609.310394824312;10903.182261330274;11022.50398732043;10169.949150254497;10433.373997560171;10762.139028877828;10838.891611083789;10958.56165753361 10:40:50 INFO - PROCESS | 16630 | __end_tp_report 10:40:50 INFO - PROCESS | 16630 | __start_cc_report 10:40:50 INFO - PROCESS | 16630 | _x_x_mozilla_cycle_collect,307 10:40:50 INFO - PROCESS | 16630 | __end_cc_report 10:40:50 INFO - PROCESS | 16630 | __startTimestamp1456339250482__endTimestamp 10:40:50 INFO - PROCESS | 16630 | 10:40:50 INFO - PROCESS | 16630 | ------- Summary: start ------- 10:40:50 INFO - PROCESS | 16630 | Number of tests: 6 10:40:50 INFO - PROCESS | 16630 | 10:40:50 INFO - PROCESS | 16630 | [#0] dojo.html Cycles:165 Average:5472.60 Median:5673.09 stddev:593.41 (10.5%) stddev-sans-first:570.74 10:40:50 INFO - PROCESS | 16630 | Values: 3321.7 3371.7 3372.6 3388.9 3414.1 5441.2 5461.5 5477.2 5485.6 5496.8 5398.5 5486.7 5504.2 5528.5 5528.9 4965.1 5033.7 5101.9 5114.3 5136.8 4904.4 4986.7 5041.5 5058.8 5078.3 5085.6 5115.7 5149.5 5152.4 5159.6 4989.0 5040.8 5051.5 5056.2 5070.5 4896.7 4917.6 4955.6 4965.1 4973.0 5248.7 5255.3 5279.6 5282.0 5285.8 5888.4 5905.5 5925.2 5926.6 5928.7 5768.3 5925.9 5947.0 5962.4 6052.2 5505.1 5521.6 5522.4 5532.5 5551.5 5982.4 5998.0 6012.1 6014.0 6014.8 5660.3 5748.0 5800.4 5887.8 5918.6 5883.7 5885.3 5887.6 5893.4 5899.7 5812.8 5825.2 5846.6 5847.7 5852.6 5778.0 5823.2 5831.7 5843.5 5898.2 4490.2 4500.0 4519.7 4534.5 4535.4 3971.0 4073.0 4082.0 4090.5 4098.2 5469.8 5527.8 5592.3 5602.1 5615.0 5916.6 5928.5 5972.5 5990.6 5993.5 5465.5 5520.7 5564.2 5592.3 5617.1 5003.0 5013.6 5031.6 5049.9 5054.9 6022.6 6023.2 6026.8 6034.2 6043.5 5841.7 5845.7 5914.6 5925.9 5960.0 6032.0 6046.9 6052.9 6057.6 6059.9 5779.8 5825.2 5830.4 5830.7 5839.5 5779.6 5906.9 5944.4 5988.7 6040.5 5756.9 5762.2 5767.4 5775.4 5781.8 5600.7 5710.6 5711.3 5717.3 5734.7 5620.4 5627.0 5629.4 5662.4 5698.1 5785.9 5808.7 5828.5 5831.5 5850.0 5613.7 5673.1 5709.9 5747.2 5766.4 10:40:50 INFO - PROCESS | 16630 | 10:40:50 INFO - PROCESS | 16630 | [#1] ext.html Cycles:180 Average:46019.31 Median:20726.82 stddev:75608.91 (364.8%) stddev-sans-first:75743.85 10:40:50 INFO - PROCESS | 16630 | Values: 522.7 548.4 558.9 574.0 592.0 30650.5 37385.8 37460.4 37544.0 37736.8 41644.2 42164.4 42183.6 42335.0 42427.8 8668.8 8893.5 8894.2 8922.9 8924.7 8637.7 8759.3 8803.9 8822.2 8911.5 9017.6 9063.8 9091.9 9092.9 9093.4 8921.9 9028.0 9035.5 9044.4 9052.0 8868.8 8951.7 8955.3 8994.9 9015.4 41336.4 41851.4 41881.4 41990.4 42098.8 3362.5 3563.1 3665.9 3738.4 3770.7 31667.8 31819.2 31887.2 32113.2 32231.7 4215.3 4338.0 4342.7 4349.9 4365.3 266990.0 267609.0 267671.0 268540.0 269240.0 59218.4 59477.4 59654.4 59878.0 59905.7 62098.0 62194.7 62261.0 62301.4 62475.7 16563.9 17101.0 17125.1 17150.4 17171.9 11843.2 11934.5 11946.4 12038.1 12051.5 19039.0 19482.1 19591.7 19688.4 19729.7 7956.6 7962.2 8015.7 8066.8 8101.4 1044.0 1171.2 1171.7 1194.6 1223.9 29941.4 30084.5 30164.1 30289.4 30341.5 1101.5 1122.6 1134.6 1144.1 1196.2 13932.4 14117.1 16002.4 16734.8 16739.8 356014.0 356707.0 356970.0 358254.0 359623.0 48414.8 48604.3 48651.3 48782.3 48806.3 1467.8 1489.9 1490.0 1506.0 1506.3 26560.5 27012.9 27468.2 27775.9 29614.1 44230.0 44595.6 44931.0 44934.6 45085.8 225301.0 225396.0 226330.0 226479.0 227169.0 31793.7 31855.0 32258.7 32691.7 32851.5 44573.8 44835.3 44980.1 45069.5 46612.8 37995.8 38406.6 38742.8 39598.8 40055.6 34993.7 36701.6 37682.9 37771.0 37854.6 38195.6 38463.2 38764.4 39023.4 39061.6 32223.4 32292.2 32564.8 32719.8 33005.8 25349.9 26141.9 26254.7 26259.2 26350.9 10:40:50 INFO - PROCESS | 16630 | 10:40:50 INFO - PROCESS | 16630 | [#2] jquery.html Cycles:180 Average:29943.12 Median:405.46 stddev:99979.71 (24658.2%) stddev-sans-first:100235.57 10:40:50 INFO - PROCESS | 16630 | Values: 398.9 403.6 403.8 404.1 406.9 17749.0 18106.7 18367.5 18532.2 18798.4 11772.8 13464.4 17064.8 17407.6 17415.7 5163.4 5295.8 5312.0 5324.3 5349.9 5125.8 5227.7 5292.1 5296.5 5323.5 5286.0 5295.8 5750.8 5953.5 5987.8 5782.2 5855.5 5891.3 6218.3 6223.8 5381.4 5588.0 5602.0 5607.1 5621.3 13809.0 14036.6 14088.4 14092.7 18994.1 2280.9 2325.0 2360.3 2366.4 2442.7 9861.1 10228.7 10601.4 13716.5 13813.2 1863.2 1901.8 1939.7 1986.7 1999.8 60594.7 61448.1 63530.7 63917.0 64339.4 10964.1 11050.2 11096.4 11123.9 11145.5 14444.3 14549.5 14561.9 14638.9 14650.9 7976.5 8028.9 8030.3 8140.3 8190.8 7663.8 7680.9 7749.8 7752.8 7758.8 4580.6 4835.8 4845.5 4880.0 4883.1 1949.8 1951.9 2037.0 2039.2 2065.3 475.4 1001.4 1002.9 1015.3 1087.8 11085.3 11240.9 11246.7 11387.1 11529.9 505.3 513.4 518.4 541.7 1020.3 9281.0 9993.0 10563.6 10584.9 10585.5 584902.0 598953.0 602241.0 630011.0 640131.0 76675.6 77351.0 78145.2 79547.6 81111.0 1246.8 1258.6 1268.7 1271.1 1271.1 15807.1 15975.2 16035.2 16100.4 16173.6 34867.0 36183.8 36417.3 36908.3 37469.6 42059.0 43393.6 44084.1 44756.6 46822.0 7534.5 7707.8 7976.7 8002.3 8052.2 9680.5 10610.7 10702.4 10755.4 11945.0 3013.6 3056.1 7538.1 9851.4 10105.7 9464.9 9720.7 10305.3 10468.6 10726.2 9314.0 9441.7 9562.0 9672.5 10166.3 7858.5 8051.5 8152.2 8152.7 8170.8 9473.8 10305.5 10334.3 10420.7 10593.3 10:40:50 INFO - PROCESS | 16630 | 10:40:50 INFO - PROCESS | 16630 | [#3] mootools.html Cycles:180 Average:5966.84 Median:5284.21 stddev:3104.95 (58.8%) stddev-sans-first:3096.04 10:40:50 INFO - PROCESS | 16630 | Values: 1565.1 1585.6 1831.2 1907.2 1946.7 8129.8 8299.7 8325.5 8331.3 8593.7 8311.6 8378.2 8415.9 8441.9 8492.6 2419.0 2426.0 2432.1 2441.6 2442.4 2458.2 2474.1 2484.9 2489.1 2492.7 2383.9 2421.8 2426.6 2429.7 2441.9 2446.6 2455.3 2487.3 2491.3 2500.0 2462.9 2481.2 2490.7 2494.3 2525.5 8396.3 8420.1 8444.3 8466.3 8477.8 5159.0 5281.3 5285.0 5314.8 5322.0 3223.4 3253.1 3293.7 3324.1 3339.4 1174.1 1189.1 1193.7 1215.6 1215.9 11905.3 12041.2 12051.5 12058.8 12130.6 4603.3 4620.2 4626.1 4667.8 4691.7 9719.2 9743.4 9791.8 9797.2 9803.9 5145.8 5230.9 5262.6 5278.1 5283.4 4768.9 4792.0 4843.9 4860.9 4862.2 3804.4 3832.6 3891.9 3915.2 3923.3 1129.9 1169.0 1194.8 1198.3 1200.8 1122.1 1178.5 1180.9 1201.6 1226.3 7879.5 7930.7 7946.4 7961.8 8091.7 1204.4 1208.7 1217.4 1219.6 1220.9 6035.5 6083.5 6105.8 6131.8 6141.1 10057.7 10349.1 10356.0 10481.5 10499.6 9770.0 10283.1 10493.9 10502.3 10580.0 7978.0 8033.8 8042.8 8060.2 8103.4 7636.6 7698.4 7739.0 7800.2 7801.8 8932.1 9062.2 9065.1 9121.1 9146.5 9176.3 9272.4 9313.8 9568.4 9618.8 7671.0 7688.5 7795.5 7819.3 7834.2 8131.9 8188.2 8304.1 8309.8 8336.0 7842.5 7845.9 7957.0 8022.8 8054.6 7394.2 7466.1 7506.8 7555.1 7597.4 7397.2 7458.4 7466.5 7481.6 7513.1 6941.7 6987.1 7000.2 7000.7 7012.8 6820.5 6863.5 6990.2 7012.2 7048.4 10:40:50 INFO - PROCESS | 16630 | 10:40:50 INFO - PROCESS | 16630 | [#4] prototype.html Cycles:180 Average:5781.38 Median:6477.19 stddev:1712.69 (26.4%) stddev-sans-first:1668.70 10:40:50 INFO - PROCESS | 16630 | Values: 373.5 378.2 384.4 387.1 388.8 6302.9 6389.1 6392.8 6400.9 6534.2 6238.7 6342.9 6380.5 6409.1 6431.9 5003.3 5039.8 5040.3 5044.8 5047.3 4973.7 5029.5 5032.1 5035.3 5041.7 4987.6 4997.8 5001.7 5011.7 5011.8 4974.9 4998.0 5003.2 5005.9 5006.1 4402.0 4403.5 4410.8 4435.2 4447.0 6038.2 6140.2 6143.9 6152.8 6168.2 5870.9 5875.7 5880.7 5892.2 5904.6 6827.0 6842.2 6842.3 6850.0 6864.7 4912.0 4924.5 4926.5 4932.4 4937.5 6994.3 7122.5 7169.2 7169.4 7195.9 5038.9 5054.7 5068.3 5072.7 5076.8 5137.2 5138.4 5145.1 5150.5 5152.6 5591.5 5797.7 5807.2 5843.5 5879.8 6865.3 6877.1 6877.8 6905.6 6915.1 1724.6 1758.9 1760.0 1760.9 1762.5 1177.3 1178.5 1191.6 1206.3 1210.5 6468.5 6496.4 6512.1 6535.5 6550.1 7019.6 7024.8 7036.2 7037.8 7067.5 6420.4 6485.9 6520.9 6545.0 6575.7 3771.4 3845.2 3845.9 3846.1 3848.3 7147.5 7151.5 7156.4 7157.4 7159.4 7116.4 7246.5 7255.7 7257.4 7333.1 7294.3 7303.3 7319.5 7329.6 7332.4 7168.2 7206.8 7212.4 7214.4 7214.6 6840.5 7019.7 7029.4 7054.0 7081.4 7321.0 7329.6 7347.3 7366.8 7395.0 4915.9 4945.3 4968.0 4970.2 4989.7 7022.0 7051.5 7168.0 7171.3 7192.5 6931.1 6953.5 6981.6 6988.6 6991.3 6890.3 6967.2 6974.0 6977.4 6983.8 6648.4 6776.1 6825.5 6838.5 6850.5 6994.2 7006.2 7008.6 7018.5 7029.7 6707.5 6785.8 6804.8 6839.2 6842.7 10:40:50 INFO - PROCESS | 16630 | 10:40:50 INFO - PROCESS | 16630 | [#5] yui.html Cycles:180 Average:15320.29 Median:4522.74 stddev:17822.95 (394.1%) stddev-sans-first:17839.86 10:40:50 INFO - PROCESS | 16630 | Values: 858.1 893.4 914.5 920.6 959.2 14048.2 14048.3 14075.9 14102.5 14123.9 13911.5 14037.6 14061.3 14075.6 14082.9 917.9 921.6 924.7 925.2 931.3 910.1 910.1 910.8 912.4 913.6 949.8 951.2 952.5 953.2 956.3 943.3 944.0 950.3 950.4 956.7 698.6 699.4 703.1 703.6 704.8 14264.9 14285.1 14293.0 14294.6 14300.8 13761.2 13784.7 13793.8 13839.6 13890.6 11576.6 11669.0 11686.4 11716.2 11836.8 3844.4 3849.5 3875.7 3887.3 3892.3 54288.2 56676.1 57632.1 58490.0 58512.4 11031.9 11380.4 11589.5 11645.1 11648.7 19023.9 19101.9 19108.5 19127.3 19146.8 8056.1 8159.4 8429.4 8536.2 8650.0 4606.6 4858.9 4870.9 4894.6 4969.1 3189.1 3206.4 3206.6 3218.6 3234.4 606.9 607.4 608.5 610.4 610.8 679.4 717.7 722.3 722.4 743.6 9129.3 9615.6 9626.9 9687.3 9759.5 579.7 695.8 738.4 741.2 745.2 4204.3 4343.7 4495.5 4550.0 4597.0 61684.0 61706.7 62421.0 62551.0 62609.0 55905.7 56093.2 56351.7 57038.0 57293.0 49242.0 52846.7 53867.2 55233.0 55685.4 9733.0 9738.7 10004.0 10087.8 10092.4 37356.4 38174.4 38809.8 38879.8 39201.2 47750.0 48054.8 48776.3 48807.8 49019.5 11805.0 12177.9 12211.3 12288.6 12388.3 13269.3 13401.0 13647.1 13691.2 14439.4 12282.8 12433.0 12788.7 12971.6 13111.5 12464.8 12717.2 12735.9 12992.7 13020.4 12059.9 12671.9 12758.8 12784.7 12870.5 10220.5 10458.3 10609.3 10903.2 11022.5 10169.9 10433.4 10762.1 10838.9 10958.6 10:40:50 INFO - PROCESS | 16630 | -------- Summary: end -------- 10:40:50 INFO - PROCESS | 16630 | 10:40:51 INFO - TEST-INFO | 16630: exit 0 10:40:51 INFO - TEST-OK | dromaeo_css | took 1109146ms 10:40:51 INFO - TEST-START | kraken 10:40:51 INFO - operating with platform_type : linux_ 10:40:51 INFO - Initialising browser for kraken test... 10:40:51 INFO - TEST-INFO | started process 16876 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgAjeFJ/profile http://localhost:53344/getInfo.html) 10:40:55 INFO - PROCESS | 16876 | 10:40:55 INFO - PROCESS | 16876 | (process:16955): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:40:55 INFO - PROCESS | 16876 | __metrics Screen width/height:1600/1200 10:40:55 INFO - PROCESS | 16876 | colorDepth:24 10:40:55 INFO - PROCESS | 16876 | Browser inner width/height: 1024/697 10:40:55 INFO - PROCESS | 16876 | __metrics 10:40:56 INFO - TEST-INFO | 16876: exit 0 10:40:56 INFO - Browser initialized. 10:40:56 INFO - Running cycle 1/1 for kraken test... 10:40:56 INFO - TEST-INFO | started process 17004 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgAjeFJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:40:58 INFO - PROCESS | 17004 | 10:40:58 INFO - PROCESS | 17004 | (process:17069): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:41:08 INFO - PROCESS | 17004 | RSS: Main: 140312576 10:41:08 INFO - PROCESS | 17004 | 10:41:11 INFO - PROCESS | 17004 | Cycle 1(1): loaded http://localhost:53344/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53344/tests/kraken/driver.html?testName=audio-beat-detection) 10:41:11 INFO - PROCESS | 17004 | RSS: Main: 145424384 10:41:11 INFO - PROCESS | 17004 | 10:41:14 INFO - PROCESS | 17004 | Cycle 1(1): loaded http://localhost:53344/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53344/tests/kraken/driver.html?testName=audio-dft) 10:41:15 INFO - PROCESS | 17004 | RSS: Main: 144867328 10:41:15 INFO - PROCESS | 17004 | 10:41:17 INFO - PROCESS | 17004 | Cycle 1(1): loaded http://localhost:53344/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53344/tests/kraken/driver.html?testName=audio-fft) 10:41:18 INFO - PROCESS | 17004 | RSS: Main: 146948096 10:41:18 INFO - PROCESS | 17004 | 10:41:20 INFO - PROCESS | 17004 | Cycle 1(1): loaded http://localhost:53344/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53344/tests/kraken/driver.html?testName=audio-oscillator) 10:41:21 INFO - PROCESS | 17004 | RSS: Main: 146976768 10:41:21 INFO - PROCESS | 17004 | 10:41:23 INFO - PROCESS | 17004 | Cycle 1(1): loaded http://localhost:53344/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53344/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:41:23 INFO - PROCESS | 17004 | RSS: Main: 147107840 10:41:23 INFO - PROCESS | 17004 | 10:41:26 INFO - PROCESS | 17004 | Cycle 1(1): loaded http://localhost:53344/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53344/tests/kraken/driver.html?testName=imaging-darkroom) 10:41:27 INFO - PROCESS | 17004 | RSS: Main: 145547264 10:41:27 INFO - PROCESS | 17004 | 10:41:30 INFO - PROCESS | 17004 | Cycle 1(1): loaded http://localhost:53344/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53344/tests/kraken/driver.html?testName=imaging-desaturate) 10:41:31 INFO - PROCESS | 17004 | RSS: Main: 145014784 10:41:31 INFO - PROCESS | 17004 | 10:41:34 INFO - PROCESS | 17004 | Cycle 1(1): loaded http://localhost:53344/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53344/tests/kraken/driver.html?testName=json-parse-financial) 10:41:34 INFO - PROCESS | 17004 | RSS: Main: 147398656 10:41:34 INFO - PROCESS | 17004 | 10:41:36 INFO - PROCESS | 17004 | Cycle 1(1): loaded http://localhost:53344/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53344/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:41:37 INFO - PROCESS | 17004 | RSS: Main: 145584128 10:41:37 INFO - PROCESS | 17004 | 10:41:38 INFO - PROCESS | 17004 | Cycle 1(1): loaded http://localhost:53344/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53344/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:41:39 INFO - PROCESS | 17004 | RSS: Main: 147013632 10:41:39 INFO - PROCESS | 17004 | 10:41:41 INFO - PROCESS | 17004 | Cycle 1(1): loaded http://localhost:53344/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53344/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:41:42 INFO - PROCESS | 17004 | RSS: Main: 146931712 10:41:42 INFO - PROCESS | 17004 | 10:41:44 INFO - PROCESS | 17004 | Cycle 1(1): loaded http://localhost:53344/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53344/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:41:44 INFO - PROCESS | 17004 | RSS: Main: 147496960 10:41:44 INFO - PROCESS | 17004 | 10:41:47 INFO - PROCESS | 17004 | Cycle 1(1): loaded http://localhost:53344/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53344/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:41:48 INFO - PROCESS | 17004 | RSS: Main: 146190336 10:41:48 INFO - PROCESS | 17004 | 10:41:49 INFO - PROCESS | 17004 | Cycle 1(1): loaded http://localhost:53344/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53344/tests/kraken/driver.html?testName=ai-astar) 10:41:49 INFO - PROCESS | 17004 | RSS: Main: 146665472 10:41:49 INFO - PROCESS | 17004 | 10:41:49 INFO - PROCESS | 17004 | __start_tp_report 10:41:49 INFO - PROCESS | 17004 | _x_x_mozilla_page_load 10:41:49 INFO - PROCESS | 17004 | _x_x_mozilla_page_load_details 10:41:49 INFO - PROCESS | 17004 | |i|pagename|runs| 10:41:49 INFO - PROCESS | 17004 | |0;ai-astar;112;110;112;111;112;122;112;111;110;110 10:41:49 INFO - PROCESS | 17004 | |1;audio-beat-detection;151;127;156;162;128;147;152;130;158;129 10:41:49 INFO - PROCESS | 17004 | |2;audio-dft;165;163;162;161;164;161;162;160;165;162 10:41:49 INFO - PROCESS | 17004 | |3;audio-fft;73;76;76;154;85;76;76;73;150;73 10:41:49 INFO - PROCESS | 17004 | |4;audio-oscillator;97;97;145;96;98;97;136;96;95;137 10:41:49 INFO - PROCESS | 17004 | |5;imaging-gaussian-blur;109;110;110;111;109;110;109;110;109;110 10:41:49 INFO - PROCESS | 17004 | |6;imaging-darkroom;147;147;147;147;146;147;146;147;146;148 10:41:49 INFO - PROCESS | 17004 | |7;imaging-desaturate;96;96;96;96;96;96;97;97;97;96 10:41:49 INFO - PROCESS | 17004 | |8;json-parse-financial;55;57;56;60;57;59;57;66;55;56 10:41:49 INFO - PROCESS | 17004 | |9;json-stringify-tinderbox;64;65;64;65;65;70;65;66;66;71 10:41:49 INFO - PROCESS | 17004 | |10;stanford-crypto-aes;88;81;81;82;81;80;82;81;83;84 10:41:49 INFO - PROCESS | 17004 | |11;stanford-crypto-ccm;112;125;115;114;115;121;118;126;115;114 10:41:49 INFO - PROCESS | 17004 | |12;stanford-crypto-pbkdf2;131;139;141;146;139;139;130;139;148;147 10:41:49 INFO - PROCESS | 17004 | |13;stanford-crypto-sha256-iterative;66;65;67;63;66;64;64;65;70;64 10:41:49 INFO - PROCESS | 17004 | __end_tp_report 10:41:49 INFO - PROCESS | 17004 | __start_cc_report 10:41:49 INFO - PROCESS | 17004 | _x_x_mozilla_cycle_collect,734 10:41:49 INFO - PROCESS | 17004 | __end_cc_report 10:41:49 INFO - PROCESS | 17004 | __startTimestamp1456339309957__endTimestamp 10:41:49 INFO - PROCESS | 17004 | 10:41:49 INFO - PROCESS | 17004 | ------- Summary: start ------- 10:41:49 INFO - PROCESS | 17004 | Number of tests: 14 10:41:49 INFO - PROCESS | 17004 | 10:41:49 INFO - PROCESS | 17004 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:3.55 (3.2%) stddev-sans-first:3.77 10:41:49 INFO - PROCESS | 17004 | Values: 112.0 110.0 112.0 111.0 112.0 122.0 112.0 111.0 110.0 110.0 10:41:49 INFO - PROCESS | 17004 | 10:41:49 INFO - PROCESS | 17004 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:151.50 stddev:13.95 (9.2%) stddev-sans-first:14.57 10:41:49 INFO - PROCESS | 17004 | Values: 151.0 127.0 156.0 162.0 128.0 147.0 152.0 130.0 158.0 129.0 10:41:49 INFO - PROCESS | 17004 | 10:41:49 INFO - PROCESS | 17004 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:1.72 (1.1%) stddev-sans-first:1.56 10:41:49 INFO - PROCESS | 17004 | Values: 165.0 163.0 162.0 161.0 164.0 161.0 162.0 160.0 165.0 162.0 10:41:49 INFO - PROCESS | 17004 | 10:41:49 INFO - PROCESS | 17004 | [#3] audio-fft Cycles:10 Average:91.20 Median:76.00 stddev:32.24 (42.4%) stddev-sans-first:33.52 10:41:49 INFO - PROCESS | 17004 | Values: 73.0 76.0 76.0 154.0 85.0 76.0 76.0 73.0 150.0 73.0 10:41:49 INFO - PROCESS | 17004 | 10:41:49 INFO - PROCESS | 17004 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:96.50 stddev:20.80 (21.6%) stddev-sans-first:21.57 10:41:49 INFO - PROCESS | 17004 | Values: 97.0 97.0 145.0 96.0 98.0 97.0 136.0 96.0 95.0 137.0 10:41:49 INFO - PROCESS | 17004 | 10:41:49 INFO - PROCESS | 17004 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 10:41:49 INFO - PROCESS | 17004 | Values: 109.0 110.0 110.0 111.0 109.0 110.0 109.0 110.0 109.0 110.0 10:41:49 INFO - PROCESS | 17004 | 10:41:49 INFO - PROCESS | 17004 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 10:41:49 INFO - PROCESS | 17004 | Values: 147.0 147.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 148.0 10:41:49 INFO - PROCESS | 17004 | 10:41:49 INFO - PROCESS | 17004 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:41:49 INFO - PROCESS | 17004 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 97.0 97.0 97.0 96.0 10:41:49 INFO - PROCESS | 17004 | 10:41:49 INFO - PROCESS | 17004 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.00 stddev:3.29 (5.8%) stddev-sans-first:3.33 10:41:49 INFO - PROCESS | 17004 | Values: 55.0 57.0 56.0 60.0 57.0 59.0 57.0 66.0 55.0 56.0 10:41:49 INFO - PROCESS | 17004 | 10:41:49 INFO - PROCESS | 17004 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:65.50 stddev:2.42 (3.7%) stddev-sans-first:2.45 10:41:49 INFO - PROCESS | 17004 | Values: 64.0 65.0 64.0 65.0 65.0 70.0 65.0 66.0 66.0 71.0 10:41:49 INFO - PROCESS | 17004 | 10:41:49 INFO - PROCESS | 17004 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:2.31 (2.8%) stddev-sans-first:1.22 10:41:49 INFO - PROCESS | 17004 | Values: 88.0 81.0 81.0 82.0 81.0 80.0 82.0 81.0 83.0 84.0 10:41:49 INFO - PROCESS | 17004 | 10:41:49 INFO - PROCESS | 17004 | [#11] stanford-crypto-ccm Cycles:10 Average:117.50 Median:116.50 stddev:4.88 (4.2%) stddev-sans-first:4.76 10:41:49 INFO - PROCESS | 17004 | Values: 112.0 125.0 115.0 114.0 115.0 121.0 118.0 126.0 115.0 114.0 10:41:49 INFO - PROCESS | 17004 | 10:41:49 INFO - PROCESS | 17004 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.90 Median:140.00 stddev:6.10 (4.4%) stddev-sans-first:5.56 10:41:49 INFO - PROCESS | 17004 | Values: 131.0 139.0 141.0 146.0 139.0 139.0 130.0 139.0 148.0 147.0 10:41:49 INFO - PROCESS | 17004 | 10:41:49 INFO - PROCESS | 17004 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:2.01 (3.1%) stddev-sans-first:2.12 10:41:49 INFO - PROCESS | 17004 | Values: 66.0 65.0 67.0 63.0 66.0 64.0 64.0 65.0 70.0 64.0 10:41:49 INFO - PROCESS | 17004 | -------- Summary: end -------- 10:41:49 INFO - PROCESS | 17004 | 10:41:50 INFO - TEST-INFO | 17004: exit 0 10:41:50 INFO - TEST-OK | kraken | took 59880ms 10:41:50 INFO - TEST-START | v8_7 10:41:50 INFO - operating with platform_type : linux_ 10:41:50 INFO - Initialising browser for v8_7 test... 10:41:51 INFO - TEST-INFO | started process 17297 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKOLr4i/profile http://localhost:53344/getInfo.html) 10:41:54 INFO - PROCESS | 17297 | 10:41:54 INFO - PROCESS | 17297 | (process:17380): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:41:55 INFO - PROCESS | 17297 | __metrics Screen width/height:1600/1200 10:41:55 INFO - PROCESS | 17297 | colorDepth:24 10:41:55 INFO - PROCESS | 17297 | Browser inner width/height: 1024/697 10:41:55 INFO - PROCESS | 17297 | __metrics 10:41:56 INFO - TEST-INFO | 17297: exit 0 10:41:56 INFO - Browser initialized. 10:41:56 INFO - Running cycle 1/1 for v8_7 test... 10:41:56 INFO - TEST-INFO | started process 17429 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKOLr4i/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:41:58 INFO - PROCESS | 17429 | 10:41:58 INFO - PROCESS | 17429 | (process:17494): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:42:08 INFO - PROCESS | 17429 | RSS: Main: 141348864 10:42:08 INFO - PROCESS | 17429 | 10:42:31 INFO - PROCESS | 17429 | Cycle 1(1): loaded http://localhost:53344/tests/v8_7/run.html (next: http://localhost:53344/tests/v8_7/run.html) 10:42:31 INFO - PROCESS | 17429 | RSS: Main: 145223680 10:42:31 INFO - PROCESS | 17429 | 10:42:31 INFO - PROCESS | 17429 | __start_tp_report 10:42:31 INFO - PROCESS | 17429 | _x_x_mozilla_page_load 10:42:31 INFO - PROCESS | 17429 | _x_x_mozilla_page_load_details 10:42:31 INFO - PROCESS | 17429 | |i|pagename|runs| 10:42:31 INFO - PROCESS | 17429 | |0;Richards;167.000668002672 10:42:31 INFO - PROCESS | 17429 | |1;DeltaBlue;171.32088401576152 10:42:31 INFO - PROCESS | 17429 | |2;Encrypt;279.01785714285717 10:42:31 INFO - PROCESS | 17429 | |3;Decrypt;5296.2962962962965 10:42:31 INFO - PROCESS | 17429 | |4;RayTrace;924.2144177449168 10:42:31 INFO - PROCESS | 17429 | |5;Earley;561.4823133071309 10:42:31 INFO - PROCESS | 17429 | |6;Boyer;11258.426966292134 10:42:31 INFO - PROCESS | 17429 | |7;RegExp;39019.230769230766 10:42:31 INFO - PROCESS | 17429 | |8;Splay;506.84237202230105 10:42:31 INFO - PROCESS | 17429 | |9;NavierStokes;4822.115384615385 10:42:31 INFO - PROCESS | 17429 | __end_tp_report 10:42:31 INFO - PROCESS | 17429 | __startTimestamp1456339351367__endTimestamp 10:42:31 INFO - PROCESS | 17429 | 10:42:31 INFO - PROCESS | 17429 | ------- Summary: start ------- 10:42:31 INFO - PROCESS | 17429 | Number of tests: 10 10:42:31 INFO - PROCESS | 17429 | 10:42:31 INFO - PROCESS | 17429 | [#0] Richards Cycles:1 Average:167.00 Median:167.00 stddev:0.00 (0.0%) 10:42:31 INFO - PROCESS | 17429 | Values: 167.0 10:42:31 INFO - PROCESS | 17429 | 10:42:31 INFO - PROCESS | 17429 | [#1] DeltaBlue Cycles:1 Average:171.32 Median:171.32 stddev:0.00 (0.0%) 10:42:31 INFO - PROCESS | 17429 | Values: 171.3 10:42:31 INFO - PROCESS | 17429 | 10:42:31 INFO - PROCESS | 17429 | [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 10:42:31 INFO - PROCESS | 17429 | Values: 279.0 10:42:31 INFO - PROCESS | 17429 | 10:42:31 INFO - PROCESS | 17429 | [#3] Decrypt Cycles:1 Average:5296.30 Median:5296.30 stddev:0.00 (0.0%) 10:42:31 INFO - PROCESS | 17429 | Values: 5296.3 10:42:31 INFO - PROCESS | 17429 | 10:42:31 INFO - PROCESS | 17429 | [#4] RayTrace Cycles:1 Average:924.21 Median:924.21 stddev:0.00 (0.0%) 10:42:31 INFO - PROCESS | 17429 | Values: 924.2 10:42:31 INFO - PROCESS | 17429 | 10:42:31 INFO - PROCESS | 17429 | [#5] Earley Cycles:1 Average:561.48 Median:561.48 stddev:0.00 (0.0%) 10:42:31 INFO - PROCESS | 17429 | Values: 561.5 10:42:31 INFO - PROCESS | 17429 | 10:42:31 INFO - PROCESS | 17429 | [#6] Boyer Cycles:1 Average:11258.43 Median:11258.43 stddev:0.00 (0.0%) 10:42:31 INFO - PROCESS | 17429 | Values: 11258.4 10:42:31 INFO - PROCESS | 17429 | 10:42:31 INFO - PROCESS | 17429 | [#7] RegExp Cycles:1 Average:39019.23 Median:39019.23 stddev:0.00 (0.0%) 10:42:31 INFO - PROCESS | 17429 | Values: 39019.2 10:42:31 INFO - PROCESS | 17429 | 10:42:31 INFO - PROCESS | 17429 | [#8] Splay Cycles:1 Average:506.84 Median:506.84 stddev:0.00 (0.0%) 10:42:31 INFO - PROCESS | 17429 | Values: 506.8 10:42:31 INFO - PROCESS | 17429 | 10:42:31 INFO - PROCESS | 17429 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 10:42:31 INFO - PROCESS | 17429 | Values: 4822.1 10:42:31 INFO - PROCESS | 17429 | -------- Summary: end -------- 10:42:31 INFO - PROCESS | 17429 | 10:42:32 INFO - TEST-INFO | 17429: exit 0 10:42:32 INFO - TEST-OK | v8_7 | took 41208ms 10:42:32 INFO - SUITE-END | took 1210s 10:42:32 INFO - Completed test suite (00:20:10) 10:42:32 INFO - Working with test: dromaeo_css 10:42:32 INFO - Generating results file: dromaeo_css 10:42:32 INFO - Working with test: kraken 10:42:32 INFO - Generating results file: kraken 10:42:32 INFO - javascript benchmark 10:42:32 INFO - Working with test: v8_7 10:42:32 INFO - Generating results file: v8_7 10:42:32 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:42:32 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 10:42:32 INFO - process_Request line: dromaeo_css 7316.49 graph.html#tests=[[72,52,43]] 10:42:32 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:42:32 INFO - process_Request line: kraken 1501.10 graph.html#tests=[[232,52,43]] 10:42:32 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:42:32 INFO - process_Request line: v8_7 22020.15 graph.html#tests=[[230,52,43]] 10:42:32 INFO - RETURN: dromaeo_css: 7316.49 10:42:32 INFO - RETURN: kraken: 1501.10 10:42:32 INFO - RETURN: v8_7: 22020.15 10:42:32 INFO - javascript benchmark 10:42:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3321.7342612590987, 3371.662833716628, 3372.5615669962917, 3388.9322213555747, 3414.129397003765, 5441.211024401459, 5461.453854614541, 5477.20580515825, 5485.6434331768405, 5496.7526461309235, 5398.48714372135, 5486.725663716818, 5504.2018907258525, 5528.5024347808685, 5528.889422211553, 4965.106280869451, 5033.672811267256, 5101.923471147936, 5114.3095682083, 5136.768845401947, 4904.36243288372, 4986.675866068712, 5041.495850414965, 5058.772355244023, 5078.289039534468, 5085.644004919639, 5115.693058416488, 5149.459306772772, 5152.381714194302, 5159.587233021368, 4989.0, 5040.798368065273, 5051.494850514956, 5056.165732654108, 5070.492950704918, 4896.706197628154, 4917.557419832232, 4955.554000140005, 4965.081459929925, 4972.95567930735, 5248.685078895279, 5255.290535777659, 5279.577633789288, 5281.970015846911, 5285.7885684572575, 5888.440598143169, 5905.4980326672285, 5925.170476133345, 5926.644401335933, 5928.6739229342365, 5768.336641286264, 5925.91111133329, 5946.97026514869, 5962.433568810956, 6052.21321228242, 5505.119180931032, 5521.585881058896, 5522.3649280332875, 5532.474414930575, 5551.500364967173, 5982.4316689914385, 5998.0, 6012.098185272244, 6013.9699301503215, 6014.7594096236535, 5660.264165658438, 5747.971260143756, 5800.4199580042505, 5887.8233652990475, 5918.556108291896, 5883.735231914574, 5885.264341957255, 5887.646741195542, 5893.381194974551, 5899.734511946973, 5812.82561523155, 5825.2135961644635, 5846.590738648254, 5847.736851841677, 5852.619579727304, 5778.046622307273, 5823.213866128103, 5831.650100993954, 5843.474087332075, 5898.174255604219, 4490.214212512862, 4499.955000450019, 4519.728816271035, 4534.45586529612, 4535.387722657399, 3970.9930973945497, 4073.042834933788, 4082.040720430696, 4090.4886889138857, 4098.221337945781, 5469.781208751685, 5527.778888844401, 5592.273004509388, 5602.1036634138345, 5614.9719251403485, 5916.556258280646, 5928.525717942641, 5972.492338151219, 5990.6405615662325, 5993.490553303018, 5465.480779325958, 5520.696361700065, 5564.248826408464, 5592.328920529562, 5617.101263797773, 5003.0, 5013.649044566845, 5031.572316353077, 5049.899002020013, 5054.91319366338, 6022.57841951068, 6023.247094113236, 6026.7890623828835, 6034.151238344423, 6043.546733994968, 5841.707914604168, 5845.736941837543, 5914.64512129265, 5925.940740592711, 5960.046392577166, 6031.969840150771, 6046.909296360646, 6052.909206361996, 6057.606255593372, 6059.909101363572, 5779.797707080232, 5825.213596164633, 5830.387809280134, 5830.708464576839, 5839.474447299764, 5779.566532509994, 5906.881862362643, 5944.405559444021, 5988.730507127277, 6040.546958978182, 5756.94243057564, 5762.193292939076, 5767.423257674367, 5775.393583673822, 5781.797637082682, 5600.663960162403, 5710.600257981901, 5711.286089238845, 5717.342505611741, 5734.7132643368495, 5620.353659329229, 5627.0434026214825, 5629.408912064175, 5662.405447428126, 5698.088305871041, 5785.929603023455, 5808.651480911159, 5828.504577110993, 5831.504322132666, 5850.0, 5613.719314034201, 5673.092305231144, 5709.914351284817, 5747.19539264495, 5766.423357664368], "unit": "score", "name": "dojo.html", "value": 5435.21988427101}, {"lowerIsBetter": false, "replicates": [522.7490804413882, 548.363897878461, 558.888222355529, 573.9770409183633, 592.0349829777462, 30650.54024189636, 37385.813070934644, 37460.43809342855, 37543.99999999996, 37736.81131594345, 41644.16711665765, 42164.36753448693, 42183.57816421835, 42335.0, 42427.78786106073, 8668.826623467543, 8893.466392016468, 8894.155055269772, 8922.910770892306, 8924.732258032236, 8637.654493820271, 8759.255463285597, 8803.867941980876, 8822.206001459866, 8911.509866957314, 9017.639294428214, 9063.818723625523, 9091.909080909172, 9092.8636070459, 9093.40892841963, 8921.910780892205, 9028.0, 9035.548222588877, 9044.3668943174, 9051.954740226289, 8868.822623547492, 8951.73144805657, 8955.328350373748, 8994.86507702385, 9015.41399809017, 41336.379954300406, 41851.372229416585, 41881.37177942333, 41990.37014444786, 42098.78950605258, 3362.546056282395, 3563.1092226943265, 3665.9450108248398, 3738.36447803874, 3770.7171962102952, 31667.84166079178, 31819.204519886956, 31887.202819929455, 32113.1971700707, 32231.6776832231, 4215.2623290924275, 4337.954110898647, 4342.652587793001, 4349.869503914888, 4365.257906155961, 266990.0, 267609.0, 267671.0, 268540.0, 269240.0, 59218.40781592129, 59477.40522594719, 59654.40345596575, 59878.0, 59905.70047149737, 62098.0, 62194.68902655548, 62261.0, 62301.37698622956, 62475.68762156251, 16563.91718041402, 17101.0, 17125.14374281281, 17150.399736009178, 17171.914140429217, 11843.23019003762, 11934.462949167308, 11946.402679865972, 12038.097142714332, 12051.457684404222, 19039.048047597564, 19482.123304451332, 19591.706124408145, 19688.409347719593, 19729.704054439197, 7956.562389068657, 7962.243586859239, 8015.679372825021, 8066.757997259974, 8101.351891848638, 1043.9634612788516, 1171.1918776044672, 1171.718787490996, 1194.5938380950518, 1223.8959688426582, 29941.40117197644, 30084.548731769042, 30164.095077147722, 30289.394212116076, 30341.544876826865, 1101.4767985207122, 1122.5509796081633, 1134.6425875849245, 1144.1075960750627, 1196.186593116689, 13932.37304321308, 14117.08238964464, 16002.439914602934, 16734.832651673572, 16739.832601674072, 356014.0, 356707.0, 356970.0, 358254.0, 359623.0, 48414.75792621085, 48604.27093593599, 48651.27023094657, 48782.26826597604, 48806.26790598073, 1467.8091848059685, 1489.865912067919, 1489.9851001489847, 1506.0210862939177, 1506.344740038087, 26560.468790623694, 27012.86493567598, 27468.17595472139, 27775.861120695077, 29614.111576652736, 44230.0, 44595.55404445914, 44931.0, 44934.55065449304, 45085.77457112693, 225301.0, 225396.0, 226330.0, 226479.0, 227169.0, 31793.682063179996, 31855.0, 32258.677413225567, 32691.673083269816, 32851.50722739113, 44573.77713111414, 44835.327470088625, 44980.100397991206, 45069.54930450654, 46612.7669361651, 37995.81002094972, 38406.6159338403, 38742.80628596839, 39598.80200599094, 40055.59944400519, 34993.65006349904, 36701.63298366982, 37682.91292080539, 37771.0, 37854.62145378511, 38195.61804381921, 38463.230735384575, 38764.41853372258, 39023.414648779726, 39061.609383905794, 32223.35553288968, 32292.19269518281, 32564.83717581397, 32719.836400817843, 33005.834970824995, 25349.873250634366, 26141.869290653423, 26254.737452625228, 26259.21222363332, 26350.868245659414], "unit": "score", "name": "ext.html", "value": 18961.057280197958}, {"lowerIsBetter": false, "replicates": [398.9062570295982, 403.60245158518853, 403.800118941124, 404.0524968947817, 406.8718353718579, 17749.0, 18106.728399074007, 18367.54081147972, 18532.166052527635, 18798.436046918596, 11772.764544709122, 13464.394102265396, 17064.829351706478, 17407.564810879736, 17415.738763918518, 5163.354580677425, 5295.8146464873735, 5312.0, 5324.281222035033, 5349.919751203735, 5125.846224613268, 5227.660202086871, 5292.073887069767, 5296.496832800878, 5323.494268044529, 5285.973570132163, 5295.7881684732565, 5750.769969201227, 5953.464188223059, 5987.760489580412, 5782.248307720011, 5855.502282305988, 5891.293044834626, 6218.253809542884, 6223.7821676241565, 5381.434949330303, 5588.0, 5602.0, 5607.074832652607, 5621.297337832771, 13809.033367664268, 14036.649083772987, 14088.436462541486, 14092.718145637133, 18994.14526346318, 2280.920167794119, 2324.9651255231183, 2360.2919124262653, 2366.432056306491, 2442.7435119312395, 9861.063198996084, 10228.74428139295, 10601.416922069284, 13716.519921802688, 13813.240271785047, 1863.1615772902248, 1901.8288354048063, 1939.6896496560482, 1986.6622674145285, 1999.7700264469627, 60594.69702651502, 61448.0782788263, 63530.68234658843, 63917.0, 64339.3566064338, 10964.06805421548, 11050.226484146033, 11096.389698566656, 11123.888761112285, 11145.498452569655, 14444.277786110863, 14549.490767823076, 14561.854381456262, 14638.926805365905, 14650.926745366205, 7976.521408715495, 8028.879566806502, 8030.277275045274, 8140.267375936194, 8190.836183276301, 7663.770086897402, 7680.884786728204, 7749.7675069748, 7752.806179845549, 7758.7672369829, 4580.633549316047, 4835.758212089381, 4845.515448455127, 4879.950810575743, 4883.145449546386, 1949.814767597076, 1951.9316823911095, 2036.9898150509448, 2039.1945181653164, 2065.266830275261, 475.3653872080811, 1001.449202938381, 1002.904724051214, 1015.3400289811682, 1087.8205096159045, 11085.334879907232, 11240.887591124148, 11246.66260012201, 11387.089032877515, 11529.884701153049, 505.3304371707502, 513.3557385481197, 518.4219595151379, 541.7291354322839, 1020.3010937507831, 9281.02549232321, 9992.950035249778, 10563.630272940563, 10584.947075264574, 10585.523651435704, 584902.0, 598953.0, 602241.0, 630011.0, 640131.0, 76675.61662191653, 77351.0, 78145.21854781493, 79547.60226198948, 81111.0, 1246.7880460321767, 1258.5783762439685, 1268.7081971146688, 1271.0911698135876, 1271.1038717703996, 15807.13060781668, 15975.20123993819, 16035.198240088183, 16100.436484722979, 16173.595660108122, 34867.0, 36183.819080904424, 36417.27165456623, 36908.26183476262, 37469.625303746616, 42059.0, 43393.566064340215, 44084.11831763283, 44756.55243447524, 46822.0, 7534.475950556625, 7707.8073048172, 7976.7208147714555, 8002.3198028165925, 8052.154523775153, 9680.515974201402, 10610.734731631772, 10702.357858528514, 10755.408452535186, 11945.04439644809, 3013.560523255545, 3056.0984509569284, 7538.09542854861, 9851.408915465096, 10105.747356315856, 9464.905350946678, 9720.708378748648, 10305.278630495794, 10468.581256749949, 10726.249162558546, 9313.953430232805, 9441.669541566287, 9562.0, 9672.516374181403, 10166.288359815038, 7858.528488290721, 8051.4766540174705, 8152.184781522037, 8152.714654987047, 8170.7957301067945, 9473.763155921157, 10305.53625086888, 10334.276600637882, 10420.68737937863, 10593.311434756715], "unit": "score", "name": "jquery.html", "value": 8325.37629809257}, {"lowerIsBetter": false, "replicates": [1565.1391734545998, 1585.556044307594, 1831.1576674729624, 1907.2180406033528, 1946.7469229000228, 8129.837403251931, 8299.709510167131, 8325.5004699718, 8331.333493320535, 8593.699220527284, 8311.584420778967, 8378.204070613281, 8415.873761893576, 8441.860348852902, 8492.575371231445, 2418.987905060477, 2425.9514809703796, 2432.136591510015, 2441.56051910656, 2442.3771938155746, 2458.1887976967646, 2474.084588702183, 2484.8633325167107, 2489.0666000249907, 2492.6884139482563, 2383.92848214553, 2421.757824217582, 2426.5996110641813, 2429.708434987804, 2441.914532991346, 2446.584080706284, 2455.2511483997373, 2487.266256454332, 2491.252624212738, 2500.0, 2462.889169987337, 2481.2184161988916, 2490.6762120924345, 2494.3140636324974, 2525.5454018276705, 8396.286315663176, 8420.115887831751, 8444.324454043663, 8466.280366168821, 8477.83044339116, 5158.974205128988, 5281.313429254211, 5285.048691235576, 5314.760835762361, 5322.04203243416, 3223.4358987177384, 3253.137918451612, 3293.6541663125504, 3324.069260607034, 3339.432296509575, 1174.1487421619343, 1189.1141099880558, 1193.6777070191088, 1215.598852378713, 1215.8966487848543, 11905.28568285897, 12041.157119001673, 12051.457684404135, 12058.819117713241, 12130.575429859913, 4603.263477843596, 4620.237660785932, 4626.1210370029585, 4667.813287468532, 4691.7184968901975, 9719.222462203006, 9743.415395076176, 9791.804163916824, 9797.16724078447, 9803.852942205873, 5145.819896303611, 5230.869228269324, 5262.60530460217, 5278.129108697099, 5283.365996080495, 4768.928466073012, 4791.95208047922, 4843.903121937541, 4860.902781944412, 4862.197737373364, 3804.4483549885113, 3832.559255685632, 3891.9416208756893, 3915.1778126593163, 3923.2545816295383, 1129.9378534180535, 1168.9532418703157, 1194.8028575285155, 1198.3049831097942, 1200.7778560966249, 1122.0686829931137, 1178.5344788808372, 1180.8819118088122, 1201.567435723139, 1226.3316492511603, 7879.487833290817, 7930.682772689143, 7946.364290856717, 7961.840763184704, 8091.676332946617, 1204.3978010994504, 1208.7401208740164, 1217.391304347826, 1219.6463025722442, 1220.9084318676134, 6035.547333949971, 6083.482903953125, 6105.786297479567, 6131.785387511505, 6141.07883817431, 10057.69826905194, 10349.120324772328, 10356.0, 10481.475926203659, 10499.580016799242, 9770.0, 10283.07452329294, 10493.9475302623, 10502.264841461178, 10580.047795698423, 7978.042634883851, 8033.799155021171, 8042.758717238492, 8060.193980601893, 8103.392245581605, 7636.618169091412, 7698.384129269757, 7738.993930788962, 7800.180980996914, 7801.804954876174, 8932.06213347615, 9062.229710474683, 9065.093490650883, 9121.087891210826, 9146.49694266795, 9176.26589872822, 9272.350935434455, 9313.767155821159, 9568.378055426376, 9618.807623847344, 7670.961645191738, 7688.46180767341, 7795.532268063935, 7819.257170568787, 7834.177411371724, 8131.878021829795, 8188.181181882002, 8304.128066552925, 8309.750707478785, 8335.95832020836, 7842.490238134731, 7845.882311765442, 7956.9602151988865, 8022.759317220492, 8054.637541310773, 7394.186639469762, 7466.141393739789, 7506.8498630026, 7555.093388793161, 7597.392208623407, 7397.223291554525, 7458.440616953859, 7466.514676546007, 7481.588512631857, 7513.098428188434, 6941.722331106699, 6987.0567473392475, 7000.159980802337, 7000.719971201299, 7012.7545535906, 6820.488463365168, 6863.519553631198, 6990.196127445409, 7012.1935977363255, 7048.400885924754], "unit": "score", "name": "mootools.html", "value": 4894.201897315848}, {"lowerIsBetter": false, "replicates": [373.5256224594765, 378.19633279281527, 384.4444777296807, 387.0826142043357, 388.8055972013993, 6302.9054564181515, 6389.105525226472, 6392.840178995528, 6400.871982560352, 6534.215894092716, 6238.656873871935, 6342.904856427146, 6380.521460890429, 6409.13476680648, 6431.903521447182, 5003.2995380646735, 5039.798408063673, 5040.261109917073, 5044.82343117991, 5047.318611987372, 4973.676711013791, 5029.5221953914315, 5032.144535428986, 5035.320231768719, 5041.672291301072, 4987.576056035241, 4997.800087996494, 5001.7499125043605, 5011.749412529377, 5011.824586139486, 4974.87562810929, 4998.0, 5003.17447621142, 5005.874853128683, 5006.098902197603, 4402.0, 4403.493598236212, 4410.8090815479645, 4435.179491793996, 4446.977765111186, 6038.154658347835, 6140.17107690465, 6143.907841382383, 6152.784652537184, 6168.167297414837, 5870.853228669274, 5875.735591898375, 5880.705964701748, 5892.204552385416, 5904.586678932434, 6827.044213810071, 6842.178938527359, 6842.281560436132, 6849.965750171267, 6864.656767161672, 4912.0, 4924.532169443897, 4926.507349265081, 4932.432770231433, 4937.481564435719, 6994.2656021117555, 7122.501424900259, 7169.175544812361, 7169.426445884316, 7195.89206161908, 5038.949610503922, 5054.69671819692, 5068.290439338495, 5072.721000344943, 5076.822311219164, 5137.152369859006, 5138.3577052868395, 5145.07388670043, 5150.4849515048945, 5152.613553983466, 5591.4688104629995, 5797.652140871477, 5807.186993820868, 5843.474087332075, 5879.823605291848, 6865.347791959756, 6877.105976223059, 6877.828054298582, 6905.620190889449, 6915.066466027122, 1724.5516165796982, 1758.850497707709, 1759.9912000440172, 1760.938367157169, 1762.5153082902305, 1177.3348058347005, 1178.505027888289, 1191.6186820217447, 1206.2943178240653, 1210.5278941212935, 6468.482521398277, 6496.350364963466, 6512.088307636935, 6535.477161827042, 6550.148480697479, 7019.613921234279, 7024.789256322319, 7036.19083805369, 7037.788866334018, 7067.505274630829, 6420.422162005442, 6485.902711459332, 6520.934790652128, 6545.0, 6575.704093315812, 3771.3777226757825, 3845.2117315950163, 3845.8846234613006, 3846.0961674006585, 3848.288066707668, 7147.499675022803, 7151.499395042297, 7156.389812292193, 7157.391621712109, 7159.427245820426, 7116.359527642434, 7246.49274550787, 7255.673494692752, 7257.419406447471, 7333.1200255969625, 7294.343509084208, 7303.269673032654, 7319.451041171933, 7329.633518324169, 7332.413406927433, 7168.17565979919, 7206.783796486114, 7212.386947109345, 7214.386777123793, 7214.567125972459, 6840.486963477859, 7019.6841142147705, 7029.402500787491, 7054.047703559953, 7081.398081163159, 7320.96339518299, 7329.560226386434, 7347.302006309392, 7366.77899663011, 7395.0, 4915.877103072309, 4945.307656927961, 4968.0312339093525, 4970.204767237225, 4989.727619457015, 7021.964890175516, 7051.5063945523325, 7168.0, 7171.282871712996, 7192.532485388433, 6931.09895713554, 6953.513254072166, 6981.581105133709, 6988.580685158907, 6991.265917078634, 6890.276520965427, 6967.163940327193, 6973.965130174317, 6977.406920411822, 6983.755568555076, 6648.434883034803, 6776.051352810512, 6825.488088393489, 6838.521303508706, 6850.520463567702, 6994.160700715946, 7006.159260888726, 7008.633316503233, 7018.473614479037, 7029.683664235224, 6707.4969377297875, 6785.762498312535, 6804.76183333581, 6839.213490448463, 6842.692078856364], "unit": "score", "name": "prototype.html", "value": 5229.273885130655}, {"lowerIsBetter": false, "replicates": [858.1075681291458, 893.4014210478979, 914.5015966298366, 920.5857364186118, 959.1942768074816, 14048.227347495897, 14048.297585120741, 14075.859241407583, 14102.506412275572, 14123.929380353084, 13911.513097041605, 14037.578872633838, 14061.296935153227, 14075.57773266801, 14082.92958535206, 917.8623206519009, 921.5714692667908, 924.7456949338952, 925.1812146250583, 931.2829121576382, 910.0580898769774, 910.0626354854511, 910.81328327693, 912.4434095201922, 913.6162811619103, 949.7862980829293, 951.196239177897, 952.4523399045542, 953.2183609440261, 956.2636769687336, 943.3302355327726, 944.0135058863505, 950.3442624589012, 950.3632566180676, 956.741679746468, 698.6227437183915, 699.4264702943589, 703.1456780012259, 703.6481759120439, 704.799132247307, 14264.85735142656, 14285.071470354394, 14293.0, 14294.571162865132, 14300.785488217685, 13761.243131627756, 13784.655383615389, 13793.793093103612, 13839.584812455643, 13890.58328250144, 11576.594819181373, 11669.008134308593, 11686.357250351228, 11716.179867409284, 11836.822447663291, 3844.4041173618134, 3849.480320156771, 3875.7286989910717, 3887.280853042168, 3892.2799282132896, 54288.18567721448, 56676.14985775216, 57632.13551796768, 58490.0, 58512.41487585112, 11031.944840275748, 11380.430978451044, 11589.536418543164, 11645.12661550387, 11648.70878228034, 19023.904880475788, 19101.904490477737, 19108.522286942938, 19127.33054343091, 19146.80853191478, 8056.073551541648, 8159.388045896581, 8429.367797415096, 8536.231739143506, 8650.0, 4606.631469482433, 4858.882457034902, 4870.878228044327, 4894.632902532324, 4969.105560998983, 3189.091109033914, 3206.3587282543585, 3206.551082848403, 3218.5815843940136, 3234.4178047951596, 606.884691908536, 607.3895734786511, 608.5071092415158, 610.3987572241339, 610.7801191571031, 679.3953381490477, 717.7272636398135, 722.2524686948983, 722.4256715910758, 743.5835931878165, 9129.315301352424, 9615.56729947154, 9626.855597166048, 9687.2734544908, 9759.463229522302, 579.658001778944, 695.8121307247117, 738.3613174604036, 741.1809950005166, 745.2175216023154, 4204.285271503852, 4343.7176583522605, 4495.527969563214, 4549.953510692493, 4597.011642496879, 61684.0, 61706.69146654238, 62421.0, 62551.0, 62609.0, 55905.7204713982, 56093.15860262099, 56351.71824140935, 57038.0, 57293.0, 49242.0, 52846.73576632169, 53867.19199212015, 55233.0, 55685.44314556884, 9733.0, 9738.707838764849, 10004.0, 10087.848682269625, 10092.444915529717, 37356.439653404675, 38174.42738358983, 38809.80595097006, 38879.80560097181, 39201.2159756809, 47750.0, 48054.75972620115, 48776.26835597398, 48807.75596121997, 49019.50980490292, 11805.0, 12177.878221217674, 12211.26732396059, 12288.631341059425, 12388.318642474751, 13269.325089547197, 13401.0, 13647.11293765902, 13691.246981416118, 14439.350229239499, 12282.75434491323, 12433.0, 12788.744225115259, 12971.610851674464, 13111.541096061592, 12464.813027804408, 12717.173383730398, 12735.872641273469, 12992.675183120498, 13020.41408136655, 12059.939700301442, 12671.87328126707, 12758.808617870925, 12784.74430511403, 12870.549530766379, 10220.488975551045, 10458.320209186379, 10609.310394824312, 10903.182261330274, 11022.50398732043, 10169.949150254497, 10433.373997560171, 10762.139028877828, 10838.891611083789, 10958.56165753361], "unit": "score", "name": "yui.html", "value": 6985.195515153027}], "name": "dromaeo_css", "value": 7316.4940806845025}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 112.0, 111.0, 112.0, 122.0, 112.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [151.0, 127.0, 156.0, 162.0, 128.0, 147.0, 152.0, 130.0, 158.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 144.0}, {"lowerIsBetter": true, "replicates": [165.0, 163.0, 162.0, 161.0, 164.0, 161.0, 162.0, 160.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 76.0, 154.0, 85.0, 76.0, 76.0, 73.0, 150.0, 73.0], "unit": "score", "name": "audio-fft", "value": 91.2}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 145.0, 96.0, 98.0, 97.0, 136.0, 96.0, 95.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 111.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 56.0, 60.0, 57.0, 59.0, 57.0, 66.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 70.0, 65.0, 66.0, 66.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.1}, {"lowerIsBetter": true, "replicates": [88.0, 81.0, 81.0, 82.0, 81.0, 80.0, 82.0, 81.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [112.0, 125.0, 115.0, 114.0, 115.0, 121.0, 118.0, 126.0, 115.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.5}, {"lowerIsBetter": true, "replicates": [131.0, 139.0, 141.0, 146.0, 139.0, 139.0, 130.0, 139.0, 148.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.9}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 67.0, 63.0, 66.0, 64.0, 64.0, 65.0, 70.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.4}], "name": "kraken", "value": 1501.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.000668002672], "unit": "score", "name": "Richards", "value": 211.38837599999997}, {"lowerIsBetter": false, "replicates": [171.32088401576152], "unit": "score", "name": "DeltaBlue", "value": 385.93076599999995}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5296.2962962962965], "unit": "score", "name": "Decrypt", "value": 50.25795104895107}, {"lowerIsBetter": false, "replicates": [924.2144177449168], "unit": "score", "name": "RayTrace", "value": 800.6680980000003}, {"lowerIsBetter": false, "replicates": [561.4823133071309], "unit": "score", "name": "Earley", "value": 1186.970603}, {"lowerIsBetter": false, "replicates": [11258.426966292134], "unit": "score", "name": "Boyer", "value": 59.196813373253526}, {"lowerIsBetter": false, "replicates": [39019.230769230766], "unit": "score", "name": "RegExp", "value": 23.347077378018717}, {"lowerIsBetter": false, "replicates": [506.84237202230105], "unit": "score", "name": "Splay", "value": 160.781743}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 22020.149911920642}]} 10:42:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22020.15"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1501.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7316.49"}}} 10:42:32 INFO - Return code: 0 10:42:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:42:32 INFO - # TBPL SUCCESS # 10:42:32 INFO - Running post-action listener: _resource_record_post_action 10:42:32 INFO - Running post-run listener: _resource_record_post_run 10:42:33 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 282624; Write bytes: 525463552; Read time: 56; Write time: 541160 10:42:33 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 241967104; Read time: 0; Write time: 295492 10:42:33 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 282624; Write bytes: 268701696; Read time: 56; Write time: 238064 10:42:33 INFO - Running post-run listener: _upload_blobber_files 10:42:33 INFO - Blob upload gear active. 10:42:33 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:42:33 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 10:42:33 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', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 10:42:33 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 Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 10:42:34 INFO - (blobuploader) - INFO - Open directory for files ... 10:42:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:42:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:42:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:42:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:42:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:42:35 INFO - (blobuploader) - INFO - Done attempting. 10:42:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:42:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:42:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:42:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:42:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:42:35 INFO - (blobuploader) - INFO - Done attempting. 10:42:35 INFO - (blobuploader) - INFO - Iteration through files over. 10:42:35 INFO - Return code: 0 10:42:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:42:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:42:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe48e127a6c66e6505cc8f9b15115cbf7a273b0f2ece98887b5f2f7730034d0e314a9f54364e2fb0f82fb9e186c43c73fcb2d9ba7e8f58bd9a2b633b73807136", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4292b268823313b5d28e657941e05cf3e35b82d947ebbffab967dcf20fe48ebbd1933977a7b2545883e6e6c7b7b72288139dcd9bceae13546cd9dbce4fe1fb66"} 10:42:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:42:35 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:42:35 INFO - Contents: 10:42:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe48e127a6c66e6505cc8f9b15115cbf7a273b0f2ece98887b5f2f7730034d0e314a9f54364e2fb0f82fb9e186c43c73fcb2d9ba7e8f58bd9a2b633b73807136", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4292b268823313b5d28e657941e05cf3e35b82d947ebbffab967dcf20fe48ebbd1933977a7b2545883e6e6c7b7b72288139dcd9bceae13546cd9dbce4fe1fb66"} 10:42:35 INFO - Running post-run listener: copy_logs_to_upload_dir 10:42:35 INFO - Copying logs to upload dir... 10:42:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 10:42:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.200631 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-24 10:42:35.907080) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 10:42:35.911081) ========= 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=eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790 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/Mozilla-Aurora/sha512/fe48e127a6c66e6505cc8f9b15115cbf7a273b0f2ece98887b5f2f7730034d0e314a9f54364e2fb0f82fb9e186c43c73fcb2d9ba7e8f58bd9a2b633b73807136", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4292b268823313b5d28e657941e05cf3e35b82d947ebbffab967dcf20fe48ebbd1933977a7b2545883e6e6c7b7b72288139dcd9bceae13546cd9dbce4fe1fb66"} build_url:https://queue.taskcluster.net/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/X6Ja4s_9Qe63XCfwoL0AhA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe48e127a6c66e6505cc8f9b15115cbf7a273b0f2ece98887b5f2f7730034d0e314a9f54364e2fb0f82fb9e186c43c73fcb2d9ba7e8f58bd9a2b633b73807136", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4292b268823313b5d28e657941e05cf3e35b82d947ebbffab967dcf20fe48ebbd1933977a7b2545883e6e6c7b7b72288139dcd9bceae13546cd9dbce4fe1fb66"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 10:42:35.938671) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:42:35.938992) ========= 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=eca2ab57546de7b41f256b19000001ef-1456337580.163401-1540540790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:42:36.021623) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 10:42:36.021944) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 10:42:36.022250) ========= ========= Total master_lag: 0.26 =========