builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1457347294.13 results: success (0) buildid: 20160307001309 builduid: 090105e84f324fee8344e69bd3985864 revision: 259032c2660ac93e0dad6302532d9bc314b67029 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 02:41:34.128434) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 02:41:34.128860) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 02:41:34.129137) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006338 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 02:41:34.168518) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 02:41:34.168851) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 02:41:34.206731) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 02:41:34.207072) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 02:41:34.259222) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 02:41:34.263010) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 02:41:34.263472) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 02:41:34.263783) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-07 02:41:35-- 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% 89.0M=0s 2016-03-07 02:41:35 (89.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098903 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 02:41:34.395242) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 02:41:34.395510) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017898 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 02:41:34.448128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-07 02:41:34.448441) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 259032c2660ac93e0dad6302532d9bc314b67029 --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 259032c2660ac93e0dad6302532d9bc314b67029 --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=934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-07 02:41:35,333 truncating revision to first 12 chars 2016-03-07 02:41:35,333 Setting DEBUG logging. 2016-03-07 02:41:35,333 attempt 1/10 2016-03-07 02:41:35,333 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/259032c2660a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 02:41:36,672 unpacking tar archive at: mozilla-aurora-259032c2660a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.637380 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-07 02:41:36.102850) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 02:41:36.103176) ========= echo 259032c2660ac93e0dad6302532d9bc314b67029 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'259032c2660ac93e0dad6302532d9bc314b67029'] 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=934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 259032c2660ac93e0dad6302532d9bc314b67029 program finished with exit code 0 elapsedTime=0.004622 script_repo_revision: '259032c2660ac93e0dad6302532d9bc314b67029' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 02:41:36.155541) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 02:41:36.156184) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 02:41:36.169956) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-03-07 02:41:36.170334) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:41:37 INFO - MultiFileLogger online at 20160307 02:41:37 in /builds/slave/test-pgo 02:41:37 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 02:41:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:41:37 INFO - {'append_to_log': False, 02:41:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:41:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:41:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:41:37 INFO - 'branch': 'Mozilla-Aurora', 02:41:37 INFO - 'buildbot_json_path': 'buildprops.json', 02:41:37 INFO - 'config_files': ('talos/linux_config.py',), 02:41:37 INFO - 'default_actions': ('clobber', 02:41:37 INFO - 'read-buildbot-config', 02:41:37 INFO - 'download-and-extract', 02:41:37 INFO - 'populate-webroot', 02:41:37 INFO - 'create-virtualenv', 02:41:37 INFO - 'install', 02:41:37 INFO - 'run-tests'), 02:41:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:41:37 INFO - 'download_minidump_stackwalk': True, 02:41:37 INFO - 'download_symbols': 'ondemand', 02:41:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:41:37 INFO - 'tooltool.py': '/tools/tooltool.py', 02:41:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:41:37 INFO - '/tools/misc-python/virtualenv.py')}, 02:41:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:41:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:41:37 INFO - 'installer_path': 'installer.exe', 02:41:37 INFO - 'log_level': 'info', 02:41:37 INFO - 'log_name': 'talos', 02:41:37 INFO - 'log_to_console': True, 02:41:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:41:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:41:37 INFO - 'opt_config_files': (), 02:41:37 INFO - 'pip_index': False, 02:41:37 INFO - 'sps_profile': False, 02:41:37 INFO - 'sps_profile_interval': 0, 02:41:37 INFO - 'suite': 'dromaeojs-e10s', 02:41:37 INFO - 'system_bits': '32', 02:41:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:41:37 INFO - 'title': 'talos-linux64-ix-057', 02:41:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:41:37 INFO - 'use_talos_json': True, 02:41:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:41:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:41:37 INFO - 'work_dir': 'build'} 02:41:37 INFO - ##### 02:41:37 INFO - ##### Running clobber step. 02:41:37 INFO - ##### 02:41:37 INFO - Running pre-action listener: _resource_record_pre_action 02:41:37 INFO - Running main action method: clobber 02:41:37 INFO - rmtree: /builds/slave/test-pgo/build 02:41:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:41:38 INFO - Running post-action listener: _resource_record_post_action 02:41:38 INFO - ##### 02:41:38 INFO - ##### Running read-buildbot-config step. 02:41:38 INFO - ##### 02:41:38 INFO - Running pre-action listener: _resource_record_pre_action 02:41:38 INFO - Running main action method: read_buildbot_config 02:41:38 INFO - Using buildbot properties: 02:41:38 INFO - { 02:41:38 INFO - "project": "", 02:41:38 INFO - "product": "firefox", 02:41:38 INFO - "script_repo_revision": "production", 02:41:38 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 02:41:38 INFO - "repository": "", 02:41:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 02:41:38 INFO - "buildid": "20160307001309", 02:41:38 INFO - "pgo_build": "True", 02:41:38 INFO - "basedir": "/builds/slave/test-pgo", 02:41:38 INFO - "buildnumber": 214, 02:41:38 INFO - "slavename": "talos-linux64-ix-057", 02:41:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:41:38 INFO - "platform": "ubuntu64_hw", 02:41:38 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:41:38 INFO - "branch": "mozilla-aurora", 02:41:38 INFO - "repo_path": "releases/mozilla-aurora", 02:41:38 INFO - "revision": "259032c2660ac93e0dad6302532d9bc314b67029", 02:41:38 INFO - "stage_platform": "linux64-pgo", 02:41:38 INFO - "builduid": "090105e84f324fee8344e69bd3985864", 02:41:38 INFO - "slavebuilddir": "test" 02:41:38 INFO - } 02:41:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 02:41:38 INFO - Running post-action listener: _resource_record_post_action 02:41:38 INFO - ##### 02:41:38 INFO - ##### Running download-and-extract step. 02:41:38 INFO - ##### 02:41:38 INFO - Running pre-action listener: _resource_record_pre_action 02:41:38 INFO - Running main action method: download_and_extract 02:41:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 02:41: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')]} 02:41:38 INFO - https://queue.taskcluster.net/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:41:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/test_packages.json 02:41:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/test_packages.json 02:41:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 02:41:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 02:41:41 INFO - Downloaded 1448 bytes. 02:41:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 02:41:41 INFO - Using the following test package requirements: 02:41:41 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 02:41:41 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:41:41 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:41:41 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:41:41 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:41:41 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:41:41 INFO - u'jsshell-linux-x86_64.zip'], 02:41:41 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:41:41 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:41:41 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 02:41:41 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:41:41 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:41:41 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:41:41 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:41:41 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:41:41 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:41:41 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 02:41:41 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:41:41 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:41:41 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:41 INFO - https://queue.taskcluster.net/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:41:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:41:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:41:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/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 02:41:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/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 02:41:45 INFO - Downloaded 23097952 bytes. 02:41:45 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'] 02:41:45 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 02:41:46 INFO - Return code: 0 02:41:46 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 02:41: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')]} 02:41:46 INFO - https://queue.taskcluster.net/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:41:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:41:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:41:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/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 02:41:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/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 02:41:47 INFO - Downloaded 23097952 bytes. 02:41:47 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'] 02:41:47 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 02:41:49 INFO - Return code: 0 02:41: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')]} 02:41:49 INFO - https://queue.taskcluster.net/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:41:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 02:41:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 02:41:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/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 02:41:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/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 02:41:50 INFO - Downloaded 10801536 bytes. 02:41:50 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'] 02:41:50 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 02:41:50 INFO - Return code: 0 02:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:50 INFO - https://queue.taskcluster.net/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:41:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 02:41:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 02:41:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/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 02:41:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATf9j_tgQUuGRT4htvaKxQ/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 02:41:53 INFO - Downloaded 59969473 bytes. 02:41:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 02:41:53 INFO - mkdir: /builds/slave/test-pgo/properties 02:41:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:41:53 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:41:53 INFO - Contents: 02:41:53 INFO - build_url:https://queue.taskcluster.net/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 02:41:53 INFO - Running post-action listener: _resource_record_post_action 02:41:54 INFO - Running post-action listener: set_extra_try_arguments 02:41:54 INFO - ##### 02:41:54 INFO - ##### Running populate-webroot step. 02:41:54 INFO - ##### 02:41:54 INFO - Running pre-action listener: _resource_record_pre_action 02:41:54 INFO - Running main action method: populate_webroot 02:41:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:41:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:41:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:41:54 INFO - '--tppagecycles', 02:41:54 INFO - '7'], 02:41:54 INFO - 'tests': ['tsvgm']}}, 02:41:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:41:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:41:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:41:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:41:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:41:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:41:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:41:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:54 INFO - 'talos_options': ['--e10s'], 02:41:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:41:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:54 INFO - 'tests': ['damp', 'tps']}, 02:41:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:54 INFO - 'talos_options': ['--e10s'], 02:41:54 INFO - 'tests': ['damp', 'tps']}, 02:41:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:41:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:41:54 INFO - 'other': {'tests': ['a11yr', 02:41:54 INFO - 'ts_paint', 02:41:54 INFO - 'tpaint', 02:41:54 INFO - 'sessionrestore', 02:41:54 INFO - 'sessionrestore_no_auto_restore']}, 02:41:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:41:54 INFO - 'tests': ['a11yr', 02:41:54 INFO - 'ts_paint', 02:41:54 INFO - 'tpaint', 02:41:54 INFO - 'sessionrestore', 02:41:54 INFO - 'sessionrestore_no_auto_restore']}, 02:41:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:41:54 INFO - 'tests': ['a11yr', 02:41:54 INFO - 'ts_paint', 02:41:54 INFO - 'tpaint', 02:41:54 INFO - 'sessionrestore', 02:41:54 INFO - 'sessionrestore_no_auto_restore']}, 02:41:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:41:54 INFO - 'tests': ['a11yr', 02:41:54 INFO - 'ts_paint', 02:41:54 INFO - 'tpaint', 02:41:54 INFO - 'sessionrestore', 02:41:54 INFO - 'sessionrestore_no_auto_restore']}, 02:41:54 INFO - 'other_l64': {'tests': ['a11yr', 02:41:54 INFO - 'ts_paint', 02:41:54 INFO - 'tpaint', 02:41:54 INFO - 'sessionrestore', 02:41:54 INFO - 'sessionrestore_no_auto_restore']}, 02:41:54 INFO - 'other_nol64': {'tests': ['a11yr', 02:41:54 INFO - 'ts_paint', 02:41:54 INFO - 'tpaint', 02:41:54 INFO - 'sessionrestore', 02:41:54 INFO - 'sessionrestore_no_auto_restore']}, 02:41:54 INFO - 'svgr': {'tests': ['tsvgx', 02:41:54 INFO - 'tsvgr_opacity', 02:41:54 INFO - 'tart', 02:41:54 INFO - 'tscrollx', 02:41:54 INFO - 'cart']}, 02:41:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:41:54 INFO - 'tests': ['tsvgx', 02:41:54 INFO - 'tsvgr_opacity', 02:41:54 INFO - 'tart', 02:41:54 INFO - 'tscrollx', 02:41:54 INFO - 'cart']}, 02:41:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:54 INFO - 'tests': ['tp5o']}, 02:41:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:54 INFO - 'talos_options': ['--e10s'], 02:41:54 INFO - 'tests': ['tp5o']}, 02:41:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:54 INFO - 'talos_options': ['--xperf_path', 02:41:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:41:54 INFO - 'tests': ['tp5n']}, 02:41:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:54 INFO - 'talos_options': ['--e10s', 02:41:54 INFO - '--xperf_path', 02:41:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:41:54 INFO - 'tests': ['tp5n']}}, 02:41:54 INFO - 'talos.zip': {'path': '', 02:41:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:41:54 INFO - Running post-action listener: _resource_record_post_action 02:41:54 INFO - ##### 02:41:54 INFO - ##### Running create-virtualenv step. 02:41:54 INFO - ##### 02:41:54 INFO - Running pre-action listener: _resource_record_pre_action 02:41:54 INFO - Running main action method: create_virtualenv 02:41:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:41:54 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 02:41:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:41:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:41:54 INFO - Using real prefix '/usr' 02:41:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:41:54 INFO - Installing distribute.............................................................................................................................................................................................done. 02:41:56 INFO - Installing pip.................done. 02:41:56 INFO - Return code: 0 02:41:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ad8a08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb850>, '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 0x1037330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10377c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769', '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 02:41:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 02:41:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:41:56 INFO - Using env: {'DISPLAY': ':0', 02:41:56 INFO - 'HOME': '/home/cltbld', 02:41:56 INFO - 'LANG': 'en_US.UTF-8', 02:41:56 INFO - 'LANGUAGE': 'en_US:en', 02:41:56 INFO - 'LOGNAME': 'cltbld', 02:41:56 INFO - 'MAIL': '/var/mail/cltbld', 02:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:56 INFO - 'MOZ_NO_REMOTE': '1', 02:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:56 INFO - 'NO_EM_RESTART': '1', 02:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:41:56 INFO - 'PWD': '/builds/slave/test-pgo', 02:41:56 INFO - 'SHELL': '/bin/bash', 02:41:56 INFO - 'SHLVL': '1', 02:41:56 INFO - 'TERM': 'linux', 02:41:56 INFO - 'TMOUT': '86400', 02:41:56 INFO - 'USER': 'cltbld', 02:41:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769', 02:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:56 INFO - '_': '/tools/buildbot/bin/python'} 02:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:56 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 02:41:56 INFO - Cleaning up... 02:41:56 INFO - Return code: 0 02:41:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6ad8a08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb850>, '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 0x1037330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10377c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769', '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 02:41:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 02:41:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:41:56 INFO - Using env: {'DISPLAY': ':0', 02:41:56 INFO - 'HOME': '/home/cltbld', 02:41:56 INFO - 'LANG': 'en_US.UTF-8', 02:41:56 INFO - 'LANGUAGE': 'en_US:en', 02:41:56 INFO - 'LOGNAME': 'cltbld', 02:41:56 INFO - 'MAIL': '/var/mail/cltbld', 02:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:56 INFO - 'MOZ_NO_REMOTE': '1', 02:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:56 INFO - 'NO_EM_RESTART': '1', 02:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:41:56 INFO - 'PWD': '/builds/slave/test-pgo', 02:41:56 INFO - 'SHELL': '/bin/bash', 02:41:56 INFO - 'SHLVL': '1', 02:41:56 INFO - 'TERM': 'linux', 02:41:56 INFO - 'TMOUT': '86400', 02:41:56 INFO - 'USER': 'cltbld', 02:41:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769', 02:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:56 INFO - '_': '/tools/buildbot/bin/python'} 02:41:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:57 INFO - Downloading/unpacking psutil>=0.7.1 02:41: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 02:41: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 02:41: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 02:41: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 02:41: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 02:41: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 02:41:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:41:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:41:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:41:58 INFO - Installing collected packages: psutil 02:41:58 INFO - Running setup.py install for psutil 02:41:59 INFO - building 'psutil._psutil_linux' extension 02:41:59 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 02:41:59 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 02:41:59 INFO - building 'psutil._psutil_posix' extension 02:41:59 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 02:41:59 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 02:41:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:41:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:41:59 INFO - Successfully installed psutil 02:41:59 INFO - Cleaning up... 02:41:59 INFO - Return code: 0 02:41:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:41: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')]} 02:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41: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')]} 02:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41: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', '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 0x7f6ad8a08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb850>, '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 0x1037330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10377c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769', '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 02:41: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 02:41: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 mozsystemmonitor==0.0.0 02:41:59 INFO - Using env: {'DISPLAY': ':0', 02:41:59 INFO - 'HOME': '/home/cltbld', 02:41:59 INFO - 'LANG': 'en_US.UTF-8', 02:41:59 INFO - 'LANGUAGE': 'en_US:en', 02:41:59 INFO - 'LOGNAME': 'cltbld', 02:41:59 INFO - 'MAIL': '/var/mail/cltbld', 02:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:59 INFO - 'MOZ_NO_REMOTE': '1', 02:41:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:59 INFO - 'NO_EM_RESTART': '1', 02:41:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:41:59 INFO - 'PWD': '/builds/slave/test-pgo', 02:41:59 INFO - 'SHELL': '/bin/bash', 02:41:59 INFO - 'SHLVL': '1', 02:41:59 INFO - 'TERM': 'linux', 02:41:59 INFO - 'TMOUT': '86400', 02:41:59 INFO - 'USER': 'cltbld', 02:41:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769', 02:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:59 INFO - '_': '/tools/buildbot/bin/python'} 02:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:41: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 02:41: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 02:41: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 02:41: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 02:41: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 02:41: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 02:42:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:42:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:42:01 INFO - Installing collected packages: mozsystemmonitor 02:42:01 INFO - Running setup.py install for mozsystemmonitor 02:42:01 INFO - Successfully installed mozsystemmonitor 02:42:01 INFO - Cleaning up... 02:42:01 INFO - Return code: 0 02:42:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:42:01 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')]} 02:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:01 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')]} 02:42:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:01 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 0x7f6ad8a08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb850>, '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 0x1037330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10377c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769', '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 02:42:01 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 02:42:01 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 02:42:01 INFO - Using env: {'DISPLAY': ':0', 02:42:01 INFO - 'HOME': '/home/cltbld', 02:42:01 INFO - 'LANG': 'en_US.UTF-8', 02:42:01 INFO - 'LANGUAGE': 'en_US:en', 02:42:01 INFO - 'LOGNAME': 'cltbld', 02:42:01 INFO - 'MAIL': '/var/mail/cltbld', 02:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:01 INFO - 'MOZ_NO_REMOTE': '1', 02:42:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:01 INFO - 'NO_EM_RESTART': '1', 02:42:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:42:01 INFO - 'PWD': '/builds/slave/test-pgo', 02:42:01 INFO - 'SHELL': '/bin/bash', 02:42:01 INFO - 'SHLVL': '1', 02:42:01 INFO - 'TERM': 'linux', 02:42:01 INFO - 'TMOUT': '86400', 02:42:01 INFO - 'USER': 'cltbld', 02:42:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769', 02:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:01 INFO - '_': '/tools/buildbot/bin/python'} 02:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:01 INFO - Downloading/unpacking blobuploader==1.2.4 02:42: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 02:42: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 02:42: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 02:42: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 02:42: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 02:42: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 02:42:03 INFO - Downloading blobuploader-1.2.4.tar.gz 02:42:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:42:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:42:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:42: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 02:42: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 02:42: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 02:42: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 02:42: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 02:42: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 02:42:04 INFO - Downloading docopt-0.6.1.tar.gz 02:42:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:42:04 INFO - Installing collected packages: blobuploader, requests, docopt 02:42:04 INFO - Running setup.py install for blobuploader 02:42:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:42:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:42:04 INFO - Running setup.py install for requests 02:42:05 INFO - Running setup.py install for docopt 02:42:05 INFO - Successfully installed blobuploader requests docopt 02:42:05 INFO - Cleaning up... 02:42:05 INFO - Return code: 0 02:42:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:05 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 0x7f6ad8a08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb850>, '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 0x1037330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10377c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769', '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 02:42:05 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 02:42:05 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 02:42:05 INFO - Using env: {'DISPLAY': ':0', 02:42:05 INFO - 'HOME': '/home/cltbld', 02:42:05 INFO - 'LANG': 'en_US.UTF-8', 02:42:05 INFO - 'LANGUAGE': 'en_US:en', 02:42:05 INFO - 'LOGNAME': 'cltbld', 02:42:05 INFO - 'MAIL': '/var/mail/cltbld', 02:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:05 INFO - 'MOZ_NO_REMOTE': '1', 02:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:05 INFO - 'NO_EM_RESTART': '1', 02:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:42:05 INFO - 'PWD': '/builds/slave/test-pgo', 02:42:05 INFO - 'SHELL': '/bin/bash', 02:42:05 INFO - 'SHLVL': '1', 02:42:05 INFO - 'TERM': 'linux', 02:42:05 INFO - 'TMOUT': '86400', 02:42:05 INFO - 'USER': 'cltbld', 02:42:05 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769', 02:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:05 INFO - '_': '/tools/buildbot/bin/python'} 02:42:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:42:05 INFO - Running setup.py (path:/tmp/pip-0OYDZP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:42:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:42:05 INFO - Running setup.py (path:/tmp/pip-gYKlAk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:42:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:42:05 INFO - Running setup.py (path:/tmp/pip-irqFUq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:42:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:42:05 INFO - Running setup.py (path:/tmp/pip-SEa4xC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:42:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:42:05 INFO - Running setup.py (path:/tmp/pip-O4N2Nz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:42:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:42:05 INFO - Running setup.py (path:/tmp/pip-_3B3zC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:42:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:42:05 INFO - Running setup.py (path:/tmp/pip-mPzUj1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:42:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:42:05 INFO - Running setup.py (path:/tmp/pip-X_Ma5L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:42:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:42:05 INFO - Running setup.py (path:/tmp/pip-Ziq2y6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:42:06 INFO - Running setup.py (path:/tmp/pip-TKzt7p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:42:06 INFO - Running setup.py (path:/tmp/pip-9kR7Tg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:42:06 INFO - Running setup.py (path:/tmp/pip-oaP4mU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:42:06 INFO - Running setup.py (path:/tmp/pip-3_5hON-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:42:06 INFO - Running setup.py (path:/tmp/pip-mq3FyI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:42:06 INFO - Running setup.py (path:/tmp/pip-SbjpNH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:42:06 INFO - Running setup.py (path:/tmp/pip-NmMfUb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:42:06 INFO - Running setup.py (path:/tmp/pip-qSItCN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:42:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:42:06 INFO - Running setup.py install for manifestparser 02:42:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:42:06 INFO - Running setup.py install for mozcrash 02:42:06 INFO - Running setup.py install for mozdebug 02:42:06 INFO - Running setup.py install for mozdevice 02:42:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:42:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:42:07 INFO - Running setup.py install for mozfile 02:42:07 INFO - Running setup.py install for mozhttpd 02:42:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:42:07 INFO - Running setup.py install for mozinfo 02:42:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:42:07 INFO - Running setup.py install for mozInstall 02:42:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:42:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:42:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:42:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:42:07 INFO - Running setup.py install for mozleak 02:42:07 INFO - Running setup.py install for mozlog 02:42:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:42:07 INFO - Running setup.py install for moznetwork 02:42:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:42:07 INFO - Running setup.py install for mozprocess 02:42:07 INFO - Running setup.py install for mozprofile 02:42:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:42:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:42:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:42:07 INFO - Running setup.py install for mozrunner 02:42:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:42:08 INFO - Running setup.py install for mozscreenshot 02:42:08 INFO - Running setup.py install for moztest 02:42:08 INFO - Running setup.py install for mozversion 02:42:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:42:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:42:08 INFO - Cleaning up... 02:42:08 INFO - Return code: 0 02:42:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:08 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 0x7f6ad8a08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb850>, '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 0x1037330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10377c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769', '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 02:42:08 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 02:42:08 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 02:42:08 INFO - Using env: {'DISPLAY': ':0', 02:42:08 INFO - 'HOME': '/home/cltbld', 02:42:08 INFO - 'LANG': 'en_US.UTF-8', 02:42:08 INFO - 'LANGUAGE': 'en_US:en', 02:42:08 INFO - 'LOGNAME': 'cltbld', 02:42:08 INFO - 'MAIL': '/var/mail/cltbld', 02:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:08 INFO - 'MOZ_NO_REMOTE': '1', 02:42:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:08 INFO - 'NO_EM_RESTART': '1', 02:42:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:42:08 INFO - 'PWD': '/builds/slave/test-pgo', 02:42:08 INFO - 'SHELL': '/bin/bash', 02:42:08 INFO - 'SHLVL': '1', 02:42:08 INFO - 'TERM': 'linux', 02:42:08 INFO - 'TMOUT': '86400', 02:42:08 INFO - 'USER': 'cltbld', 02:42:08 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769', 02:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:08 INFO - '_': '/tools/buildbot/bin/python'} 02:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:42:08 INFO - Running setup.py (path:/tmp/pip-syk2Fd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:42:08 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)) 02:42:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:42:08 INFO - Running setup.py (path:/tmp/pip-GDloLF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:42:08 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)) 02:42:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:42:08 INFO - Running setup.py (path:/tmp/pip-EZH1TA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:42:08 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)) 02:42:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:42:08 INFO - Running setup.py (path:/tmp/pip-kOr2eL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:42:08 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)) 02:42:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:42:08 INFO - Running setup.py (path:/tmp/pip-ZzDMEf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:42:08 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)) 02:42:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:42:08 INFO - Running setup.py (path:/tmp/pip-ZWfluP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:42:09 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)) 02:42:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:42:09 INFO - Running setup.py (path:/tmp/pip-2ViH4N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:42:09 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)) 02:42:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:42:09 INFO - Running setup.py (path:/tmp/pip-txKA9A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:42:09 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)) 02:42:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:42:09 INFO - Running setup.py (path:/tmp/pip-gMnaSb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:42:09 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)) 02:42:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:42:09 INFO - Running setup.py (path:/tmp/pip-4SGxdr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:42:09 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)) 02:42:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:42:09 INFO - Running setup.py (path:/tmp/pip-1pnuR4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:42:09 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)) 02:42:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:42:09 INFO - Running setup.py (path:/tmp/pip-P31wbk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:42:09 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)) 02:42:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:42:09 INFO - Running setup.py (path:/tmp/pip-1XFskN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:42:09 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)) 02:42:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:42:09 INFO - Running setup.py (path:/tmp/pip-n2YSyg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:42:09 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)) 02:42:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:42:09 INFO - Running setup.py (path:/tmp/pip-QcrWax-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:42:09 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)) 02:42:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:42:09 INFO - Running setup.py (path:/tmp/pip-BGj6pJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:42:09 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)) 02:42:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:42:09 INFO - Running setup.py (path:/tmp/pip-mq_VAi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:42:09 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)) 02:42:09 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)) 02:42:09 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)) 02:42:09 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)) 02:42:09 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)) 02:42:09 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)) 02:42:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:11 INFO - Downloading blessings-1.6.tar.gz 02:42:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:42:11 INFO - Installing collected packages: blessings 02:42:11 INFO - Running setup.py install for blessings 02:42:11 INFO - Successfully installed blessings 02:42:11 INFO - Cleaning up... 02:42:11 INFO - Return code: 0 02:42:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:42:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:42:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:42:12 INFO - Reading from file tmpfile_stdout 02:42:12 INFO - Current package versions: 02:42:12 INFO - argparse == 1.2.1 02:42:12 INFO - blessings == 1.6 02:42:12 INFO - blobuploader == 1.2.4 02:42:12 INFO - docopt == 0.6.1 02:42:12 INFO - manifestparser == 1.1 02:42:12 INFO - mozInstall == 1.12 02:42:12 INFO - mozcrash == 0.16 02:42:12 INFO - mozdebug == 0.1 02:42:12 INFO - mozdevice == 0.48 02:42:12 INFO - mozfile == 1.2 02:42:12 INFO - mozhttpd == 0.7 02:42:12 INFO - mozinfo == 0.9 02:42:12 INFO - mozleak == 0.1 02:42:12 INFO - mozlog == 3.1 02:42:12 INFO - moznetwork == 0.27 02:42:12 INFO - mozprocess == 0.22 02:42:12 INFO - mozprofile == 0.28 02:42:12 INFO - mozrunner == 6.11 02:42:12 INFO - mozscreenshot == 0.1 02:42:12 INFO - mozsystemmonitor == 0.0 02:42:12 INFO - moztest == 0.7 02:42:12 INFO - mozversion == 1.4 02:42:12 INFO - psutil == 3.1.1 02:42:12 INFO - requests == 1.2.3 02:42:12 INFO - wsgiref == 0.1.2 02:42:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:42:12 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')]} 02:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:12 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')]} 02:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:12 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 0x7f6ad8a08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb850>, '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 0x1037330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10377c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769', '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 02:42:12 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 02:42:12 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 02:42:12 INFO - Using env: {'DISPLAY': ':0', 02:42:12 INFO - 'HOME': '/home/cltbld', 02:42:12 INFO - 'LANG': 'en_US.UTF-8', 02:42:12 INFO - 'LANGUAGE': 'en_US:en', 02:42:12 INFO - 'LOGNAME': 'cltbld', 02:42:12 INFO - 'MAIL': '/var/mail/cltbld', 02:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:12 INFO - 'MOZ_NO_REMOTE': '1', 02:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:12 INFO - 'NO_EM_RESTART': '1', 02:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:42:12 INFO - 'PWD': '/builds/slave/test-pgo', 02:42:12 INFO - 'SHELL': '/bin/bash', 02:42:12 INFO - 'SHLVL': '1', 02:42:12 INFO - 'TERM': 'linux', 02:42:12 INFO - 'TMOUT': '86400', 02:42:12 INFO - 'USER': 'cltbld', 02:42:12 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769', 02:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:12 INFO - '_': '/tools/buildbot/bin/python'} 02:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:12 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)) 02:42:12 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)) 02:42:12 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)) 02:42:12 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)) 02:42:12 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)) 02:42:12 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)) 02:42:12 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)) 02:42:12 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)) 02:42:12 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)) 02:42:12 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)) 02:42:12 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)) 02:42:12 INFO - Cleaning up... 02:42:12 INFO - Return code: 0 02:42:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:42:12 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')]} 02:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:12 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')]} 02:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:12 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 0x7f6ad8a08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb850>, '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 0x1037330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10377c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769', '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 02:42:12 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 02:42:12 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 02:42:12 INFO - Using env: {'DISPLAY': ':0', 02:42:12 INFO - 'HOME': '/home/cltbld', 02:42:12 INFO - 'LANG': 'en_US.UTF-8', 02:42:12 INFO - 'LANGUAGE': 'en_US:en', 02:42:12 INFO - 'LOGNAME': 'cltbld', 02:42:12 INFO - 'MAIL': '/var/mail/cltbld', 02:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:12 INFO - 'MOZ_NO_REMOTE': '1', 02:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:12 INFO - 'NO_EM_RESTART': '1', 02:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:42:12 INFO - 'PWD': '/builds/slave/test-pgo', 02:42:12 INFO - 'SHELL': '/bin/bash', 02:42:12 INFO - 'SHLVL': '1', 02:42:12 INFO - 'TERM': 'linux', 02:42:12 INFO - 'TMOUT': '86400', 02:42:12 INFO - 'USER': 'cltbld', 02:42:12 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769', 02:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:12 INFO - '_': '/tools/buildbot/bin/python'} 02:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:12 INFO - Downloading/unpacking jsonschema 02:42:12 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 02:42:12 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 02:42:12 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 02:42:12 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 02:42:12 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 02:42:12 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 02:42:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:42:14 INFO - Downloading/unpacking functools32 (from jsonschema) 02:42:14 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 02:42:14 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 02:42:14 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 02:42:14 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 02:42:14 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 02:42:14 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 02:42:14 INFO - Downloading functools32-3.2.3-2.tar.gz 02:42:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:42:14 INFO - warning: no files found matching '*.txt' 02:42:14 INFO - no previously-included directories found matching 'build' 02:42:14 INFO - no previously-included directories found matching 'dist' 02:42:14 INFO - no previously-included directories found matching '.git*' 02:42:14 INFO - Installing collected packages: jsonschema, functools32 02:42:14 INFO - Running setup.py install for functools32 02:42:14 INFO - warning: no files found matching '*.txt' 02:42:14 INFO - no previously-included directories found matching 'build' 02:42:14 INFO - no previously-included directories found matching 'dist' 02:42:14 INFO - no previously-included directories found matching '.git*' 02:42:14 INFO - Successfully installed jsonschema functools32 02:42:14 INFO - Cleaning up... 02:42:14 INFO - Return code: 0 02:42:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:14 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 0x7f6ad8a08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb850>, '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 0x1037330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10377c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769', '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 02:42:14 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 02:42:14 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 02:42:14 INFO - Using env: {'DISPLAY': ':0', 02:42:14 INFO - 'HOME': '/home/cltbld', 02:42:14 INFO - 'LANG': 'en_US.UTF-8', 02:42:14 INFO - 'LANGUAGE': 'en_US:en', 02:42:14 INFO - 'LOGNAME': 'cltbld', 02:42:14 INFO - 'MAIL': '/var/mail/cltbld', 02:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:14 INFO - 'MOZ_NO_REMOTE': '1', 02:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:14 INFO - 'NO_EM_RESTART': '1', 02:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:42:14 INFO - 'PWD': '/builds/slave/test-pgo', 02:42:14 INFO - 'SHELL': '/bin/bash', 02:42:14 INFO - 'SHLVL': '1', 02:42:14 INFO - 'TERM': 'linux', 02:42:14 INFO - 'TMOUT': '86400', 02:42:14 INFO - 'USER': 'cltbld', 02:42:14 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769', 02:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:14 INFO - '_': '/tools/buildbot/bin/python'} 02:42:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:15 INFO - Downloading/unpacking flake8 02:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:42:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:42:16 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 02:42:16 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 02:42:16 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 02:42:16 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 02:42:16 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 02:42:16 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 02:42:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:42:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:42:17 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 02:42:17 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 02:42:17 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 02:42:17 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 02:42:17 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 02:42:17 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 02:42:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:42:17 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 02:42:17 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 02:42:17 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 02:42:17 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 02:42:17 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 02:42:17 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 02:42:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:42:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:42:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:42:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:42:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:42:17 INFO - no previously-included directories found matching 'docs/_build' 02:42:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:42:17 INFO - Running setup.py install for pep8 02:42:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:42:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:42:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:42:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:42:17 INFO - no previously-included directories found matching 'docs/_build' 02:42:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:42:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:42:17 INFO - Cleaning up... 02:42:17 INFO - Return code: 0 02:42:17 INFO - Running post-action listener: _resource_record_post_action 02:42:17 INFO - Running post-action listener: _start_resource_monitoring 02:42:17 INFO - Starting resource monitoring. 02:42:17 INFO - ##### 02:42:17 INFO - ##### Running install step. 02:42:17 INFO - ##### 02:42:17 INFO - Running pre-action listener: _resource_record_pre_action 02:42:17 INFO - Running main action method: install 02:42:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:42:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:42:18 INFO - Reading from file tmpfile_stdout 02:42:18 INFO - Detecting whether we're running mozinstall >=1.0... 02:42:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:42:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:42:18 INFO - Reading from file tmpfile_stdout 02:42:18 INFO - Output received: 02:42:18 INFO - Usage: mozinstall [options] installer 02:42:18 INFO - Options: 02:42:18 INFO - -h, --help show this help message and exit 02:42:18 INFO - -d DEST, --destination=DEST 02:42:18 INFO - Directory to install application into. [default: 02:42:18 INFO - "/builds/slave/test-pgo"] 02:42:18 INFO - --app=APP Application being installed. [default: firefox] 02:42:18 INFO - mkdir: /builds/slave/test-pgo/build/application 02:42:18 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'] 02:42:18 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 02:42:33 INFO - Reading from file tmpfile_stdout 02:42:33 INFO - Output received: 02:42:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:42:33 INFO - Running post-action listener: _resource_record_post_action 02:42:33 INFO - ##### 02:42:33 INFO - ##### Running run-tests step. 02:42:33 INFO - ##### 02:42:33 INFO - Running pre-action listener: _resource_record_pre_action 02:42:33 INFO - Running main action method: run_tests 02:42:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:42:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:42:33 INFO - Python 2.7.3 02:42:33 INFO - Return code: 0 02:42:33 INFO - grabbing minidump binary from tooltool 02:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:33 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 0x10cb850>, '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 0x1037330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10377c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:42:33 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 02:42:33 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 02:42:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:42:33 INFO - Return code: 0 02:42:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:42:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:42:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:42:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:42:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:42:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:42:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:42:34 INFO - Return code: 0 02:42:34 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/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 02:42:34 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/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 02:42:34 INFO - Using env: {'DISPLAY': ':0', 02:42:34 INFO - 'HOME': '/home/cltbld', 02:42:34 INFO - 'LANG': 'en_US.UTF-8', 02:42:34 INFO - 'LANGUAGE': 'en_US:en', 02:42:34 INFO - 'LOGNAME': 'cltbld', 02:42:34 INFO - 'MAIL': '/var/mail/cltbld', 02:42:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:42:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:34 INFO - 'MOZ_NO_REMOTE': '1', 02:42:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:34 INFO - 'NO_EM_RESTART': '1', 02:42:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:42:34 INFO - 'PWD': '/builds/slave/test-pgo', 02:42:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:42:34 INFO - 'SHELL': '/bin/bash', 02:42:34 INFO - 'SHLVL': '1', 02:42:34 INFO - 'TERM': 'linux', 02:42:34 INFO - 'TMOUT': '86400', 02:42:34 INFO - 'USER': 'cltbld', 02:42:34 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769', 02:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:34 INFO - '_': '/tools/buildbot/bin/python'} 02:42:34 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/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 02:42:34 INFO - mozversion application_buildid: 20160307001309 02:42:34 INFO - mozversion application_changeset: 259032c2660ac93e0dad6302532d9bc314b67029 02:42:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:42:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:42:34 INFO - mozversion application_name: Firefox 02:42:34 INFO - mozversion application_remotingname: firefox-dev 02:42:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:42:34 INFO - mozversion application_vendor: Mozilla 02:42:34 INFO - mozversion application_version: 46.0a2 02:42:34 INFO - mozversion platform_buildid: 20160307001309 02:42:34 INFO - mozversion platform_changeset: 259032c2660ac93e0dad6302532d9bc314b67029 02:42:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:42:34 INFO - mozversion platform_version: 46.0a2 02:42:34 INFO - using testdate: 1457347354 02:42:34 INFO - actual date: 1457347354 02:42:34 INFO - starting webserver on 'localhost:40736' 02:42:34 INFO - SUITE-START | Running 3 tests 02:42:34 INFO - TEST-START | dromaeo_css 02:42:34 INFO - operating with platform_type : linux_ 02:42:34 INFO - Initialising browser for dromaeo_css test... 02:42:34 INFO - TEST-INFO | started process 12258 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpV8L87i/profile http://localhost:40736/getInfo.html) 02:42:38 INFO - PROCESS | 12258 | 02:42:38 INFO - PROCESS | 12258 | (process:12338): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:42:39 INFO - PROCESS | 12258 | __metrics Screen width/height:1600/1200 02:42:39 INFO - PROCESS | 12258 | colorDepth:24 02:42:39 INFO - PROCESS | 12258 | Browser inner width/height: 1024/697 02:42:39 INFO - PROCESS | 12258 | __metrics 02:42:40 INFO - TEST-INFO | 12258: exit 0 02:42:40 INFO - Browser initialized. 02:42:40 INFO - Running cycle 1/1 for dromaeo_css test... 02:42:40 INFO - TEST-INFO | started process 12387 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpV8L87i/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:42:41 INFO - PROCESS | 12387 | 02:42:41 INFO - PROCESS | 12387 | (process:12450): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:42:51 INFO - PROCESS | 12387 | RSS: Main: 141783040 02:42:51 INFO - PROCESS | 12387 | 02:43:41 INFO - PROCESS | 12387 | 1457347421558 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] 02:45:49 INFO - PROCESS | 12387 | Cycle 1(1): loaded http://localhost:40736/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40736/tests/dromaeo/cssquery-ext.html) 02:45:50 INFO - PROCESS | 12387 | RSS: Main: 146722816 02:45:50 INFO - PROCESS | 12387 | 02:48:52 INFO - PROCESS | 12387 | Cycle 1(1): loaded http://localhost:40736/tests/dromaeo/cssquery-ext.html (next: http://localhost:40736/tests/dromaeo/cssquery-jquery.html) 02:48:52 INFO - PROCESS | 12387 | RSS: Main: 145453056 02:48:52 INFO - PROCESS | 12387 | 02:51:54 INFO - PROCESS | 12387 | Cycle 1(1): loaded http://localhost:40736/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40736/tests/dromaeo/cssquery-mootools.html) 02:51:54 INFO - PROCESS | 12387 | RSS: Main: 144269312 02:51:54 INFO - PROCESS | 12387 | 02:54:56 INFO - PROCESS | 12387 | Cycle 1(1): loaded http://localhost:40736/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40736/tests/dromaeo/cssquery-prototype.html) 02:54:57 INFO - PROCESS | 12387 | RSS: Main: 144568320 02:54:57 INFO - PROCESS | 12387 | 02:57:59 INFO - PROCESS | 12387 | Cycle 1(1): loaded http://localhost:40736/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40736/tests/dromaeo/cssquery-yui.html) 02:58:00 INFO - PROCESS | 12387 | RSS: Main: 144011264 02:58:00 INFO - PROCESS | 12387 | 03:01:02 INFO - PROCESS | 12387 | Cycle 1(1): loaded http://localhost:40736/tests/dromaeo/cssquery-yui.html (next: http://localhost:40736/tests/dromaeo/cssquery-dojo.html) 03:01:02 INFO - PROCESS | 12387 | RSS: Main: 147386368 03:01:02 INFO - PROCESS | 12387 | 03:01:02 INFO - PROCESS | 12387 | __start_tp_report 03:01:02 INFO - PROCESS | 12387 | _x_x_mozilla_page_load 03:01:02 INFO - PROCESS | 12387 | _x_x_mozilla_page_load_details 03:01:02 INFO - PROCESS | 12387 | |i|pagename|runs| 03:01:02 INFO - PROCESS | 12387 | |0;dojo.html;3274.8035117892928;3295.967040329596;3298.983505082474;3312.354090952264;3329.317489914568;5324.387695415028;5344.759485823138;5355.544778693806;5357.54460870826;5362;5408.567314614831;5408.648437851537;5411.621186516945;5421.21392398102;5424.430434804348;4913.705177689341;4935.136351138536;4980.825671101512;5003.249512573125;5053.317802096725;4723.527647235266;4891.241857512074;4917.950820491803;4918.311436398889;5020.698758074527;5019.322391477141;5046.7224302663335;5054.317667114948;5067.670601410915;5076.111680455905;4975.975120124376;5019.924701129467;5025.346704928336;5047.369078865142;5053.343065401493;4889.535494128052;4905.583025442842;4927.334809800703;4944;4989.900201995976;5186.247994040843;5226.5818734501145;5256.290400795881;5265.631405801595;5275.973620131913;5802.332731735863;5814.563907706939;5815.621984571032;5830.4169583041785;5832.795852145197;5678.914816277759;5779.595428320019;5859.1797148399255;5927.2590926134235;5938.138969849348;5538.280023596947;5550.888982220374;5571.944280557183;5573.693446860421;5595.412481689405;5744.425557444222;6009.278886533644;6012.549058820606;6053.213082299273;6064.332923378425;5678.517326027251;5725.312962444534;5849.532037436995;5851.297844258716;5887.852803679943;5854.941450585525;5863.824085277449;5869.090291004901;5874.030784920526;5878.088896221093;5681.34664513578;5751.741171647286;5822.184894114827;5822.184894114827;5847.26909136358;5903.498202652737;5966.19456373384;5973.163757074013;5975.910361344583;6008.309044459856;4395.340698895127;4441.133978874089;4444.622207112367;4477.910441791146;4493.707908985905;3981.8606348778235;4009.4386785850006;4019.879403617896;4038.071243613985;4075.3886916962692;5458.372287187024;5497.257870187554;5589.776408943597;5591.7483713233005;5650.576206784508;5855.414458554111;5908.350081491032;5922.022866227025;5932.228810254639;5958.910616340759;5335.919961200585;5338.679679219259;5457.808976685797;5607.495325420732;5624.803131890364;5054.848354549369;5057.721825299644;5070.670406423571;5078.771455284521;5094.643374963717;5984.461398474158;6022.939770602326;6044.972354699712;6046.486048685823;6052.6065805723365;5733.512651424676;5790.044642634087;5848.385919478394;5897.203877476486;5922.703864806743;5977.163197152315;5987.042073268256;6005.819825405245;6006.849828754316;6020.759169633166;5749.425057494384;5769.653820770767;5773.509251713652;5786.94213057864;5801.506871915765;5720.656760594377;5745.224394706661;5783.971080144573;5847.795327163529;5922.289325280822;5790.826275211751;5796.565257605781;5796.768129274782;5798.884022319446;5811.912821307768;5761.020626493422;5761.798337058183;5768.278965129359;5770.105633626795;5772.1630363596205;5519.116941289374;5564.970480461127;5590.5527557796095;5646.491815736604;5676;5652.123920792284;5718.742656580381;5732.369439361583;5736.856578585569;5737.856553586027;5535.39110697831;5576.33084029919;5578.609497335147;5591.664500130005;5603.607747457801 03:01:02 INFO - PROCESS | 12387 | |1;ext.html;539.1131588536855;555.0065382964493;566.5892228134601;570.957178211634;614.7571709174877;30763.384732305367;41359.37960930585;42026.47841129527;42204.15591688168;42384.78807605958;45227.547724522745;45493.54506454935;45815.541844581545;45818.54181458185;45871.31193032099;8996.145366190201;9191.770205744842;9204.40171388861;9206.723798286062;9211.769705757342;8842.159994800515;8906.510141942223;8930;8949.552522373888;8955.865662015074;8853.778655533599;8873.20141187293;8939.687110951118;8965;8998.640054397816;8866.778330541723;8889.599968001456;8914.821703565925;8933.10668933108;8983.371164018521;8886.955565222133;8979.012308646044;9012.594433250519;9038;9052.637894484213;42397.728068158;42467.575324246674;42676;42924.57075429237;42992;3681;3686.299603075407;3817.3319669058083;3867.477890484805;4247;29044;29185.416291674046;29249.70750292491;29354.266143346373;30042.84978575115;4211.410402543646;4332.090261045184;4333.523312435629;4401.207782599131;4456.064226512404;290023;293274;295962;296359;297805;66412;66866;67121.66439167772;67244.6637766808;67624.32375676278;70915.64542177359;71463.28536714567;71533.64233178904;71579;71606;18135.818641813676;18582.44252672422;18652.53368665767;18699.34552290663;18733.250669973047;13100.148490348098;13114.672133196746;13151.408186631625;13181.275029873257;13181.802272965913;22489.212877549206;22821.31536053921;22945.426364340692;22967.88516057409;23007.424814379774;8533.658653653909;8713.869291960626;8858.29133669305;8931.71277786653;8936.151065648754;991.4596544883057;1045.1064339989352;1050.2858056521638;1200.885915837994;1216.9959783178913;29700.554491682644;29856.701432985825;30359.848200758854;30609.23476913095;30716.846415768225;1184.2953442701578;1192.8807119288;1193.1230545549015;1279.7632437998814;1340.0418700629098;15242.695146097238;15347.309371078329;16135.435259765853;17419.303227870998;17953.820461795476;431195;549389;807795;808169;814968;59780.40219597836;60884.086738698956;60915;61070;61268;1471.5217554295111;1479.423025020243;1505.3526983397244;1512.0625212368402;1537.7078355112492;32047.519287211177;32779.836100819346;33264.33471330608;33514.162145946546;34006.48990265198;50016;50085;50374;50618;50766.23850642317;246807;248668;249331;249742;251883;41399.37900931428;42465.787671061444;42639.36040959326;42661;42663.3600495999;49918.251226232365;50510.747446264;50990;51148;51392.22911656403;35816.64183358133;36184.09539761527;36690.44964325484;36965.445518317785;37067;36344;36402.817985909904;36559.26881462409;36904.44643330406;37050.44424333691;37836.81081594574;37845.810770945965;38107.42838857364;38148;43093.13813723771;32663.836680816443;32874.83562582172;37406.812965934994;37934.810325948194;38075.80962095172;27503.724962750915;27850.303742406602;27852.72147278501;27879.721202787714;28013.579796302663 03:01:02 INFO - PROCESS | 12387 | |2;jquery.html;387.38405934564037;401.06951871657753;401.3217662150965;403.94142849286857;404.8785364390682;15150.84849151511;15684.921575392136;17450.127493625314;17941.7308740369;18001.189946452407;12486.875131248686;12544.247345159296;12617.621471355851;14918.328675209614;16769.496915092535;5189.662671926322;5297.920531192016;5828.970855145718;5837;5839.620424672383;5535.501804837564;5653.971730141344;5666.54667626591;5687.573431992597;5702.942970570303;5560.582956278296;5675.432456754333;5676.971615141939;5715.857103572403;5747.109198074305;5766.1639062335935;5813.563982701315;5814.825555233349;5831.30024397073;5837.066069428871;5443.156310771837;5658.490735833795;5682.261306030231;5696.2594862668;5792.304923409176;21420.357389278346;21557.67663485049;21876.343709688575;22016.559668806534;22226.666600001012;2280.304507125326;2291.3698732848434;2298.2990187992655;2332.918347857817;2399.5320912422085;10371.377717336909;10399.740006499822;12884.613461596167;13371.933140334237;13407.793298603076;1913.3685883658359;1933.7002764571514;1937.2347922570507;1945.6886898096377;1971.4578490914969;61893.6905315475;62441.687791561206;62942.37057629411;63157.052644209914;64094;10688.358698478116;10747.032767050847;10767.6231331903;10907.400092994803;11197.832032519518;14143.717125657635;14151.85848141526;14192.787108193384;14197.077189982618;15105.47130850415;8322.292605128632;8389.286910612665;8472.534010629352;8513.31893448535;8550.74347769568;7888.960555197187;7917.445778795429;8151.388645851584;8201.261886430131;8274.338052955749;4515.209838278354;4770.284457331428;4775.594074503706;4840.056189043174;4888.388951381077;1770.6193168468842;1962.9966151787787;1964.79369666183;1979.0896187753506;1985.2654517828496;1019.4962430415227;1109.6504601050642;1113.5935383585095;1125.094299089241;1166.381817636654;15999.040057596581;16336.509904702878;17868.910655446638;17947.910260448876;18211.72682409765;1059.957601695939;1068.6740544134113;1082.480409403475;1092.8415379769888;1175.8236264560385;9356.625734970661;9575.521223938775;9727.9027209727;10278.383297002203;10795.46022698862;586685;601082;601997;605045;608865;73650.63174684093;75697.62151189208;77126.22873771303;78722;78937.60531197423;1241.6771639373828;1244.993775031119;1246.1401632873287;1253.6489782860813;1260.9180403273942;15442.536723898302;16146.757798633265;16568.17159142062;16786.32854685799;16804.663906722042;31971.360572787948;32460.188495287806;32785.67214327922;33141.502877456376;33328.83335583306;43743.56256437395;43753;44907.55092449034;45467.09065818731;45682.08635827198;8189.426740128372;8423.32613390915;8462.534560599226;8512.914870851213;8632.482051076955;8853.15894989975;9130.269578433843;9405.482698451377;11669.416529173677;12334;7990.240927111915;7998.84002319962;8197.672093116447;8273.379496537904;8315.792105197177;7904.367650588054;8455.873161902453;8495.108013658724;8506.447080939966;8596.054434012129;3052.175912503656;5213.618391126279;8545.273651739422;8667.956660216658;8708.521031343336;10768.46157692128;10834.512446939749;11126.388048657078;11144.387058711849;11312.321260724382;11288.32270063766;11359.148063895076;11372.488238029144;11561.826572601249;11660.416979151178 03:01:02 INFO - PROCESS | 12387 | |3;mootools.html;1594.9122798246096;1622.0105735501345;1889.0460317539648;1930.3436831477295;1968.1536939116183;7294.525855819368;7464.925350746491;8201.26188643022;8364.832703345937;8440;7985.800354991128;8128.349732021439;8169.795755106125;8225.6298466569;8232.794180145484;2371.905123795046;2434.47658753368;2434.987825060872;2435.196385192891;2440.548498527769;2436.3421876093444;2459.1515927005244;2480.255923223035;2510.447701505666;2519.3071905226025;2409.819263555232;2414.7705967933107;2436.5979613363775;2463.6427717980882;2465.1125594785863;2439.85360878347;2446.131623273739;2453.3621258472836;2455.3616059824394;2502.036715864387;2490.6762120924345;2514.1577571513567;2518.7355327690693;2534.594464885628;2547.38862672959;8422.915770842274;8463.915360846375;8464.32285417165;8496.78758031048;8531.74404767858;5157.6647517911215;5246.31797866275;5251.054810134175;5274.05067087924;5305.283786688786;3296.3572103439838;3317.7345812334956;3336.4161271777343;3434.845431955568;3438.0717206354393;1195.5755706724074;1200.5173610590914;1202.3867827408085;1221.694576355911;1273.8089286607083;11683.591074312359;11827.586034488751;11832.645020649394;11835.822462663067;11908.46411911466;4737.123632128068;4744.122337367529;4765.285207218875;4846.61227101831;4862.927056094161;10163.695089147337;10252.179825614083;10266.743331416774;10285.691429257135;10329.896701033043;5230.0585894539345;5255.500727430888;5302.257683924254;5311.256424100629;5311.920321195185;4178.874633760992;4267.5732426757695;4590.42619672541;4727.5745182933015;4798.448178459522;4136.44158038667;4149.315362965137;4157.854475093357;4158.189153115113;4192.559781222989;1367.459853357918;1403.7262733766818;1404.592668126232;1404.9648758781111;1419.5883193873867;1170.455738081796;1182.7385710809986;1196.9162158648985;1504.8194216694067;1518.293993293124;7970.601469926481;8057.919420805717;8066.596670166468;8084.83830323402;8149.103598604149;552.3013388064102;554.6200852416108;558.3055426779704;560.5767645427676;560.742058653016;5900.4984576310635;5998.970005149947;6000.789972350947;6043.667598282137;6047.546434017467;10050.849237261447;10146.289759716748;10308.536115874804;10322.071013608811;10374.325668831501;9946.701598952042;10175.185985121172;10209.642662506776;10230.079292863678;10262.897371026194;7915.12933577306;7945.960270198612;7946.125926148119;7961.681532738626;7963.323117534958;7618.466707330434;7624.656890439833;7694.769156925301;7705.922940770744;7767.844643107219;8961.50711710836;9134.314926380415;9235.953820230856;9236.307276954121;9272.350935434455;9295.163435290857;9340.159385655325;9373.625054997996;9561.665341713007;9692.369995950241;6472.708728107153;6649.168853893263;7099.574025558483;7502.849943001219;7585.848283034419;7973.800654983672;7985.560794156378;8010.3992200584025;8032.59837008159;8062.475939063942;7222.530535515175;7393.96303018503;7729.690812367442;7779.96110019469;7802.29779319864;7288.890666640111;7295.197528271992;7340.706371745284;7418.703251869865;7471.8879216812875;7517.774466766005;7524.134724506533;7576.204498527795;7624.27569380908;7632.313091821763;6593.835154121185;6617.834554136185;6764.695588698619;6851.794446166623;6854.451643868379;7048.083749112788;7091.361777440055;7138.928610714034;7278.599677017814;7313.634318284171 03:01:02 INFO - PROCESS | 12387 | |4;prototype.html;370.023138913269;374.67029014467266;374.91189570450956;375.25324604037957;385.9112404147044;6339.112524246603;6352.936470635293;6393.584417012891;6465.612063276207;6565.0480680301325;6366.427021568058;6394.7761828336015;6411.294757576663;6451.06459563363;6464.741410343592;4935.555799978001;4940.827071052514;4950.727709975949;4956.7199088419375;4970.950290497103;4963.379577552806;4964.280179373988;4970.751462426882;4971.1549036663855;4976.004799040188;4842.491538388471;4928.433230178522;4928.901421971558;4930.926036109461;4933.506649335073;4901.607871370282;4907.067657145131;4918.458969513333;4919.557239848413;4921.507849215086;4233.724807887477;4241.724287921306;4246.575342465729;4251.893702657428;4261.2329780639475;6081.6351018939;6124.816255512342;6131.356207598227;6137.846553836145;6150.108234306045;5508;5696.943030569724;5717.914231286534;5731.369549349568;5731.770729170828;6728.158980127484;6773.356531129535;6802.761903333359;6803.48973826965;6811.4550835933005;4745.881352966169;4762.666613337068;4766.880827979294;4768.380110585602;4776.832810851638;6977.651117444158;7019.964900175466;7075.2570980047385;7087.610181440019;7104.857902841966;4847.127517046965;4879.097366987119;4892.168331383673;4900.093482705711;4901.313816065754;4933.136701077297;4969.360111163307;4971.651984361132;4972.5276098770555;4973.303737476756;5567.443255674481;5711.228984087178;5712.200291959129;5713.971430142823;5714.828555143353;6745.5952642841585;6795.694193761194;6796.626185559743;6813.897791533131;6816.591004539743;1732.688116139107;1758.2000189913558;1809.3215044358365;1810.4749622609295;1815.3101821307819;1240.8883200511998;1242.0250103668577;1244.2596654990266;1250.6185613387822;1265.8227848101274;6489.935100649028;6534.346565343428;6543.607383557001;6552.886009378417;6578.342165783383;6938.687759050855;6958.860822783516;6959.095317608679;6972.477064220204;6987.755428559976;6345.365463453618;6493.967530162319;6519.217693876765;6543.836404089936;6556.213254409501;3760.623937606272;3781.205946751158;3783.5270591176104;3800.0309920969976;3805.5813860475328;7154.962530433162;7155.141383033965;7218.917162425573;7226.602536860418;7235.746748863765;6984.7648752398745;7165.820854478679;7190.741620216441;7192.208857025723;7198.084775665864;7201.675924583406;7209.6034718091005;7212.639368031578;7223.024891639667;7226;6905.1713794342995;6958.686859091455;6971.26801685836;6985.511014228955;6997;6765.391114799691;6860.588364698134;6875.621840798804;6976.953456981493;6988.266232045562;7328.230535793665;7342.19235884063;7358.374538164316;7361.668724907285;7382.852342953003;4859.173940430206;4864.562189402971;4870.78081486341;4874.122657921608;4886.315915771866;6994.215941477679;7000.544964577286;7032.824179395556;7105.6447177639875;7136.9286307138345;6940.99355593426;6942.444604431533;6950.652467376712;6952.826179345355;6969.163700355787;6908.689108990007;6946.826329341807;6958.443324533924;7026.789196324118;7042.471814613822;6630.701618427086;6781.559198652072;6817;6830.624315662686;6831.146106736658;6919.20429150634;6931.653417329214;6968.745625787407;6972.895406568804;6990.056342393712;6723.058771772054;6769.052332673528;6771.492138089565;6808.319168083152;6811.591304521745 03:01:02 INFO - PROCESS | 12387 | |5;yui.html;831.8377916306318;911.8632205169228;919.1222382624594;940.2055263302507;963.872096644242;14773.26133693315;14796.18620975846;14903.47837825675;14911.030782999098;14971.850281497182;13748.518801841938;13768.105073170236;13883;13904.860951390483;13974.790378144337;904.4618452021037;922.547951503765;922.7370199493146;924.3529529329462;926.6756635177701;905.0496978172926;908.8273228086642;916.3951791817402;919.3794188922484;919.3794188922484;945.1540870920522;950.4724877692878;951.3720944176845;958.2094771813282;958.5399008475936;948.0850978805452;948.2224575847807;949.8147861167075;953.704351650987;953.9284553658434;694.8124006518262;698.6611493425685;698.9510734248605;702.5889854435162;703.496999645251;13337.199768013854;13515.391807368595;13591.320433978262;13591.728165436734;13608.523701670492;12034.097442691833;12355.75288494225;12369.69075773104;12383.318917459535;12492.0630952678;10577.84133238002;10581.206409519316;10650.840237396445;10664.613600231998;10794.78410431787;3777;3846.8653597123966;3890.105275786557;3891.7081218908697;3901.6878649707955;46275.76862115702;47420;49873.50126498725;51120.48879511232;51140;11009.504572294267;11045.116390688725;11159.107271418266;11166.888331116746;11317.71705707364;18875.528111797314;18941.715874261896;18961.051947402575;18969;18983.71524427135;7685.23147685227;7755.573443460551;7926.088499822479;7991.520508769492;8114.756557303291;4470.731756094579;4534.863954081383;4579.977100114545;4673.953260467351;4872.025594880967;3042.6957304269395;3064.586280852101;3069.5395690646583;3070.6775788542327;3084.6606873243927;610.9694515274218;620.3827191944044;621.2917274307293;628.5631486117196;629.2071989293431;586.6480111932891;594.5303210463685;637.3881074168758;653.6927644007309;693.639307560066;8984.59569319369;8993.325500587482;9022.548872556346;9178.173964343108;9297.814043719087;549.9862503437446;673.8685956238486;709.4643544124153;710.7454401268814;723.1105739939903;4249.532551419341;4341.869743907688;4448.599626033608;4473;4474.910501790011;59841.40158598445;60055;60732.392676073556;64566;65021.34978650153;52124;54342;55342.44657553454;56803.71598141983;56981.43018569844;45324.546754532035;46004.7699761499;46165.53834461612;47505.76247118742;47684;9420.340576159877;9932.950335248277;10027.398356098658;10102.696919092145;10281.588736450458;36453.45319820152;36806;37699.62300377071;37840;37876.431853521666;46967.530324696316;48532.27201591909;48913.2663010048;49520.257196142804;49988.25017624811;12322.445489953154;12535.435905384462;12799.42402591867;12837;13043.739125217253;12966.935165324114;13391.933040334736;13735.725285494435;13861.168329900238;14053.36759845789;12037.398130093636;12422.813657794959;12500.624981250578;12616;12641.431135599105;12144.574939877062;12227.104798756207;12746.426410811351;13062.150960187557;13202.471901123847;11669.88330116688;11871.465784039912;11952.462139203582;12220.691841972246;12573.87426125727;10237.232207584311;10418.895811041793;10443.425611591436;10528.263021588415;10548.630797922342;10747;11108;11122.888771112186;11160.88839111631;11314 03:01:02 INFO - PROCESS | 12387 | __end_tp_report 03:01:02 INFO - PROCESS | 12387 | __start_cc_report 03:01:02 INFO - PROCESS | 12387 | _x_x_mozilla_cycle_collect,300 03:01:02 INFO - PROCESS | 12387 | __end_cc_report 03:01:02 INFO - PROCESS | 12387 | __startTimestamp1457348462462__endTimestamp 03:01:02 INFO - PROCESS | 12387 | 03:01:02 INFO - PROCESS | 12387 | ------- Summary: start ------- 03:01:02 INFO - PROCESS | 12387 | Number of tests: 6 03:01:02 INFO - PROCESS | 12387 | 03:01:02 INFO - PROCESS | 12387 | [#0] dojo.html Cycles:165 Average:5430.38 Median:5646.49 stddev:602.11 (10.7%) stddev-sans-first:579.72 03:01:02 INFO - PROCESS | 12387 | Values: 3274.8 3296.0 3299.0 3312.4 3329.3 5324.4 5344.8 5355.5 5357.5 5362.0 5408.6 5408.6 5411.6 5421.2 5424.4 4913.7 4935.1 4980.8 5003.2 5053.3 4723.5 4891.2 4918.0 4918.3 5020.7 5019.3 5046.7 5054.3 5067.7 5076.1 4976.0 5019.9 5025.3 5047.4 5053.3 4889.5 4905.6 4927.3 4944.0 4989.9 5186.2 5226.6 5256.3 5265.6 5276.0 5802.3 5814.6 5815.6 5830.4 5832.8 5678.9 5779.6 5859.2 5927.3 5938.1 5538.3 5550.9 5571.9 5573.7 5595.4 5744.4 6009.3 6012.5 6053.2 6064.3 5678.5 5725.3 5849.5 5851.3 5887.9 5854.9 5863.8 5869.1 5874.0 5878.1 5681.3 5751.7 5822.2 5822.2 5847.3 5903.5 5966.2 5973.2 5975.9 6008.3 4395.3 4441.1 4444.6 4477.9 4493.7 3981.9 4009.4 4019.9 4038.1 4075.4 5458.4 5497.3 5589.8 5591.7 5650.6 5855.4 5908.4 5922.0 5932.2 5958.9 5335.9 5338.7 5457.8 5607.5 5624.8 5054.8 5057.7 5070.7 5078.8 5094.6 5984.5 6022.9 6045.0 6046.5 6052.6 5733.5 5790.0 5848.4 5897.2 5922.7 5977.2 5987.0 6005.8 6006.8 6020.8 5749.4 5769.7 5773.5 5786.9 5801.5 5720.7 5745.2 5784.0 5847.8 5922.3 5790.8 5796.6 5796.8 5798.9 5811.9 5761.0 5761.8 5768.3 5770.1 5772.2 5519.1 5565.0 5590.6 5646.5 5676.0 5652.1 5718.7 5732.4 5736.9 5737.9 5535.4 5576.3 5578.6 5591.7 5603.6 03:01:02 INFO - PROCESS | 12387 | 03:01:02 INFO - PROCESS | 12387 | [#1] ext.html Cycles:180 Average:58416.81 Median:23118.94 stddev:124436.73 (538.2%) stddev-sans-first:124709.93 03:01:02 INFO - PROCESS | 12387 | Values: 539.1 555.0 566.6 571.0 614.8 30763.4 41359.4 42026.5 42204.2 42384.8 45227.5 45493.5 45815.5 45818.5 45871.3 8996.1 9191.8 9204.4 9206.7 9211.8 8842.2 8906.5 8930.0 8949.6 8955.9 8853.8 8873.2 8939.7 8965.0 8998.6 8866.8 8889.6 8914.8 8933.1 8983.4 8887.0 8979.0 9012.6 9038.0 9052.6 42397.7 42467.6 42676.0 42924.6 42992.0 3681.0 3686.3 3817.3 3867.5 4247.0 29044.0 29185.4 29249.7 29354.3 30042.8 4211.4 4332.1 4333.5 4401.2 4456.1 290023.0 293274.0 295962.0 296359.0 297805.0 66412.0 66866.0 67121.7 67244.7 67624.3 70915.6 71463.3 71533.6 71579.0 71606.0 18135.8 18582.4 18652.5 18699.3 18733.3 13100.1 13114.7 13151.4 13181.3 13181.8 22489.2 22821.3 22945.4 22967.9 23007.4 8533.7 8713.9 8858.3 8931.7 8936.2 991.5 1045.1 1050.3 1200.9 1217.0 29700.6 29856.7 30359.8 30609.2 30716.8 1184.3 1192.9 1193.1 1279.8 1340.0 15242.7 15347.3 16135.4 17419.3 17953.8 431195.0 549389.0 807795.0 808169.0 814968.0 59780.4 60884.1 60915.0 61070.0 61268.0 1471.5 1479.4 1505.4 1512.1 1537.7 32047.5 32779.8 33264.3 33514.2 34006.5 50016.0 50085.0 50374.0 50618.0 50766.2 246807.0 248668.0 249331.0 249742.0 251883.0 41399.4 42465.8 42639.4 42661.0 42663.4 49918.3 50510.7 50990.0 51148.0 51392.2 35816.6 36184.1 36690.4 36965.4 37067.0 36344.0 36402.8 36559.3 36904.4 37050.4 37836.8 37845.8 38107.4 38148.0 43093.1 32663.8 32874.8 37406.8 37934.8 38075.8 27503.7 27850.3 27852.7 27879.7 28013.6 03:01:02 INFO - PROCESS | 12387 | 03:01:02 INFO - PROCESS | 12387 | [#2] jquery.html Cycles:180 Average:29879.07 Median:394.23 stddev:98137.58 (24893.7%) stddev-sans-first:98387.90 03:01:02 INFO - PROCESS | 12387 | Values: 387.4 401.1 401.3 403.9 404.9 15150.8 15684.9 17450.1 17941.7 18001.2 12486.9 12544.2 12617.6 14918.3 16769.5 5189.7 5297.9 5829.0 5837.0 5839.6 5535.5 5654.0 5666.5 5687.6 5702.9 5560.6 5675.4 5677.0 5715.9 5747.1 5766.2 5813.6 5814.8 5831.3 5837.1 5443.2 5658.5 5682.3 5696.3 5792.3 21420.4 21557.7 21876.3 22016.6 22226.7 2280.3 2291.4 2298.3 2332.9 2399.5 10371.4 10399.7 12884.6 13371.9 13407.8 1913.4 1933.7 1937.2 1945.7 1971.5 61893.7 62441.7 62942.4 63157.1 64094.0 10688.4 10747.0 10767.6 10907.4 11197.8 14143.7 14151.9 14192.8 14197.1 15105.5 8322.3 8389.3 8472.5 8513.3 8550.7 7889.0 7917.4 8151.4 8201.3 8274.3 4515.2 4770.3 4775.6 4840.1 4888.4 1770.6 1963.0 1964.8 1979.1 1985.3 1019.5 1109.7 1113.6 1125.1 1166.4 15999.0 16336.5 17868.9 17947.9 18211.7 1060.0 1068.7 1082.5 1092.8 1175.8 9356.6 9575.5 9727.9 10278.4 10795.5 586685.0 601082.0 601997.0 605045.0 608865.0 73650.6 75697.6 77126.2 78722.0 78937.6 1241.7 1245.0 1246.1 1253.6 1260.9 15442.5 16146.8 16568.2 16786.3 16804.7 31971.4 32460.2 32785.7 33141.5 33328.8 43743.6 43753.0 44907.6 45467.1 45682.1 8189.4 8423.3 8462.5 8512.9 8632.5 8853.2 9130.3 9405.5 11669.4 12334.0 7990.2 7998.8 8197.7 8273.4 8315.8 7904.4 8455.9 8495.1 8506.4 8596.1 3052.2 5213.6 8545.3 8668.0 8708.5 10768.5 10834.5 11126.4 11144.4 11312.3 11288.3 11359.1 11372.5 11561.8 11660.4 03:01:02 INFO - PROCESS | 12387 | 03:01:02 INFO - PROCESS | 12387 | [#3] mootools.html Cycles:180 Average:5912.61 Median:5303.77 stddev:3081.52 (58.1%) stddev-sans-first:3073.08 03:01:02 INFO - PROCESS | 12387 | Values: 1594.9 1622.0 1889.0 1930.3 1968.2 7294.5 7464.9 8201.3 8364.8 8440.0 7985.8 8128.3 8169.8 8225.6 8232.8 2371.9 2434.5 2435.0 2435.2 2440.5 2436.3 2459.2 2480.3 2510.4 2519.3 2409.8 2414.8 2436.6 2463.6 2465.1 2439.9 2446.1 2453.4 2455.4 2502.0 2490.7 2514.2 2518.7 2534.6 2547.4 8422.9 8463.9 8464.3 8496.8 8531.7 5157.7 5246.3 5251.1 5274.1 5305.3 3296.4 3317.7 3336.4 3434.8 3438.1 1195.6 1200.5 1202.4 1221.7 1273.8 11683.6 11827.6 11832.6 11835.8 11908.5 4737.1 4744.1 4765.3 4846.6 4862.9 10163.7 10252.2 10266.7 10285.7 10329.9 5230.1 5255.5 5302.3 5311.3 5311.9 4178.9 4267.6 4590.4 4727.6 4798.4 4136.4 4149.3 4157.9 4158.2 4192.6 1367.5 1403.7 1404.6 1405.0 1419.6 1170.5 1182.7 1196.9 1504.8 1518.3 7970.6 8057.9 8066.6 8084.8 8149.1 552.3 554.6 558.3 560.6 560.7 5900.5 5999.0 6000.8 6043.7 6047.5 10050.8 10146.3 10308.5 10322.1 10374.3 9946.7 10175.2 10209.6 10230.1 10262.9 7915.1 7946.0 7946.1 7961.7 7963.3 7618.5 7624.7 7694.8 7705.9 7767.8 8961.5 9134.3 9236.0 9236.3 9272.4 9295.2 9340.2 9373.6 9561.7 9692.4 6472.7 6649.2 7099.6 7502.8 7585.8 7973.8 7985.6 8010.4 8032.6 8062.5 7222.5 7394.0 7729.7 7780.0 7802.3 7288.9 7295.2 7340.7 7418.7 7471.9 7517.8 7524.1 7576.2 7624.3 7632.3 6593.8 6617.8 6764.7 6851.8 6854.5 7048.1 7091.4 7138.9 7278.6 7313.6 03:01:02 INFO - PROCESS | 12387 | 03:01:02 INFO - PROCESS | 12387 | [#4] prototype.html Cycles:180 Average:5719.16 Median:6491.95 stddev:1705.06 (26.3%) stddev-sans-first:1661.90 03:01:02 INFO - PROCESS | 12387 | Values: 370.0 374.7 374.9 375.3 385.9 6339.1 6352.9 6393.6 6465.6 6565.0 6366.4 6394.8 6411.3 6451.1 6464.7 4935.6 4940.8 4950.7 4956.7 4971.0 4963.4 4964.3 4970.8 4971.2 4976.0 4842.5 4928.4 4928.9 4930.9 4933.5 4901.6 4907.1 4918.5 4919.6 4921.5 4233.7 4241.7 4246.6 4251.9 4261.2 6081.6 6124.8 6131.4 6137.8 6150.1 5508.0 5696.9 5717.9 5731.4 5731.8 6728.2 6773.4 6802.8 6803.5 6811.5 4745.9 4762.7 4766.9 4768.4 4776.8 6977.7 7020.0 7075.3 7087.6 7104.9 4847.1 4879.1 4892.2 4900.1 4901.3 4933.1 4969.4 4971.7 4972.5 4973.3 5567.4 5711.2 5712.2 5714.0 5714.8 6745.6 6795.7 6796.6 6813.9 6816.6 1732.7 1758.2 1809.3 1810.5 1815.3 1240.9 1242.0 1244.3 1250.6 1265.8 6489.9 6534.3 6543.6 6552.9 6578.3 6938.7 6958.9 6959.1 6972.5 6987.8 6345.4 6494.0 6519.2 6543.8 6556.2 3760.6 3781.2 3783.5 3800.0 3805.6 7155.0 7155.1 7218.9 7226.6 7235.7 6984.8 7165.8 7190.7 7192.2 7198.1 7201.7 7209.6 7212.6 7223.0 7226.0 6905.2 6958.7 6971.3 6985.5 6997.0 6765.4 6860.6 6875.6 6977.0 6988.3 7328.2 7342.2 7358.4 7361.7 7382.9 4859.2 4864.6 4870.8 4874.1 4886.3 6994.2 7000.5 7032.8 7105.6 7136.9 6941.0 6942.4 6950.7 6952.8 6969.2 6908.7 6946.8 6958.4 7026.8 7042.5 6630.7 6781.6 6817.0 6830.6 6831.1 6919.2 6931.7 6968.7 6972.9 6990.1 6723.1 6769.1 6771.5 6808.3 6811.6 03:01:02 INFO - PROCESS | 12387 | 03:01:02 INFO - PROCESS | 12387 | [#5] yui.html Cycles:180 Average:14708.16 Median:4459.67 stddev:16855.36 (378.0%) stddev-sans-first:16870.43 03:01:02 INFO - PROCESS | 12387 | Values: 831.8 911.9 919.1 940.2 963.9 14773.3 14796.2 14903.5 14911.0 14971.9 13748.5 13768.1 13883.0 13904.9 13974.8 904.5 922.5 922.7 924.4 926.7 905.0 908.8 916.4 919.4 919.4 945.2 950.5 951.4 958.2 958.5 948.1 948.2 949.8 953.7 953.9 694.8 698.7 699.0 702.6 703.5 13337.2 13515.4 13591.3 13591.7 13608.5 12034.1 12355.8 12369.7 12383.3 12492.1 10577.8 10581.2 10650.8 10664.6 10794.8 3777.0 3846.9 3890.1 3891.7 3901.7 46275.8 47420.0 49873.5 51120.5 51140.0 11009.5 11045.1 11159.1 11166.9 11317.7 18875.5 18941.7 18961.1 18969.0 18983.7 7685.2 7755.6 7926.1 7991.5 8114.8 4470.7 4534.9 4580.0 4674.0 4872.0 3042.7 3064.6 3069.5 3070.7 3084.7 611.0 620.4 621.3 628.6 629.2 586.6 594.5 637.4 653.7 693.6 8984.6 8993.3 9022.5 9178.2 9297.8 550.0 673.9 709.5 710.7 723.1 4249.5 4341.9 4448.6 4473.0 4474.9 59841.4 60055.0 60732.4 64566.0 65021.3 52124.0 54342.0 55342.4 56803.7 56981.4 45324.5 46004.8 46165.5 47505.8 47684.0 9420.3 9933.0 10027.4 10102.7 10281.6 36453.5 36806.0 37699.6 37840.0 37876.4 46967.5 48532.3 48913.3 49520.3 49988.3 12322.4 12535.4 12799.4 12837.0 13043.7 12966.9 13391.9 13735.7 13861.2 14053.4 12037.4 12422.8 12500.6 12616.0 12641.4 12144.6 12227.1 12746.4 13062.2 13202.5 11669.9 11871.5 11952.5 12220.7 12573.9 10237.2 10418.9 10443.4 10528.3 10548.6 10747.0 11108.0 11122.9 11160.9 11314.0 03:01:02 INFO - PROCESS | 12387 | -------- Summary: end -------- 03:01:02 INFO - PROCESS | 12387 | 03:01:03 INFO - TEST-INFO | 12387: exit 0 03:01:03 INFO - TEST-OK | dromaeo_css | took 1108554ms 03:01:03 INFO - TEST-START | kraken 03:01:03 INFO - operating with platform_type : linux_ 03:01:03 INFO - Initialising browser for kraken test... 03:01:03 INFO - TEST-INFO | started process 12628 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0x3wkO/profile http://localhost:40736/getInfo.html) 03:01:06 INFO - PROCESS | 12628 | 03:01:06 INFO - PROCESS | 12628 | (process:12705): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:01:07 INFO - PROCESS | 12628 | __metrics Screen width/height:1600/1200 03:01:07 INFO - PROCESS | 12628 | colorDepth:24 03:01:07 INFO - PROCESS | 12628 | Browser inner width/height: 1024/697 03:01:07 INFO - PROCESS | 12628 | __metrics 03:01:08 INFO - TEST-INFO | 12628: exit 0 03:01:08 INFO - Browser initialized. 03:01:08 INFO - Running cycle 1/1 for kraken test... 03:01:08 INFO - TEST-INFO | started process 12754 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0x3wkO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:01:09 INFO - PROCESS | 12754 | 03:01:09 INFO - PROCESS | 12754 | (process:12819): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:01:20 INFO - PROCESS | 12754 | RSS: Main: 141783040 03:01:20 INFO - PROCESS | 12754 | 03:01:22 INFO - PROCESS | 12754 | Cycle 1(1): loaded http://localhost:40736/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40736/tests/kraken/driver.html?testName=audio-beat-detection) 03:01:23 INFO - PROCESS | 12754 | RSS: Main: 146374656 03:01:23 INFO - PROCESS | 12754 | 03:01:26 INFO - PROCESS | 12754 | Cycle 1(1): loaded http://localhost:40736/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40736/tests/kraken/driver.html?testName=audio-dft) 03:01:26 INFO - PROCESS | 12754 | RSS: Main: 145739776 03:01:26 INFO - PROCESS | 12754 | 03:01:29 INFO - PROCESS | 12754 | Cycle 1(1): loaded http://localhost:40736/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40736/tests/kraken/driver.html?testName=audio-fft) 03:01:30 INFO - PROCESS | 12754 | RSS: Main: 146014208 03:01:30 INFO - PROCESS | 12754 | 03:01:32 INFO - PROCESS | 12754 | Cycle 1(1): loaded http://localhost:40736/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40736/tests/kraken/driver.html?testName=audio-oscillator) 03:01:32 INFO - PROCESS | 12754 | RSS: Main: 145170432 03:01:32 INFO - PROCESS | 12754 | 03:01:34 INFO - PROCESS | 12754 | Cycle 1(1): loaded http://localhost:40736/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40736/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:01:35 INFO - PROCESS | 12754 | RSS: Main: 145162240 03:01:35 INFO - PROCESS | 12754 | 03:01:38 INFO - PROCESS | 12754 | Cycle 1(1): loaded http://localhost:40736/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40736/tests/kraken/driver.html?testName=imaging-darkroom) 03:01:38 INFO - PROCESS | 12754 | RSS: Main: 146554880 03:01:38 INFO - PROCESS | 12754 | 03:01:42 INFO - PROCESS | 12754 | Cycle 1(1): loaded http://localhost:40736/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40736/tests/kraken/driver.html?testName=imaging-desaturate) 03:01:42 INFO - PROCESS | 12754 | RSS: Main: 146550784 03:01:42 INFO - PROCESS | 12754 | 03:01:45 INFO - PROCESS | 12754 | Cycle 1(1): loaded http://localhost:40736/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40736/tests/kraken/driver.html?testName=json-parse-financial) 03:01:46 INFO - PROCESS | 12754 | RSS: Main: 147017728 03:01:46 INFO - PROCESS | 12754 | 03:01:47 INFO - PROCESS | 12754 | Cycle 1(1): loaded http://localhost:40736/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40736/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:01:48 INFO - PROCESS | 12754 | RSS: Main: 146927616 03:01:48 INFO - PROCESS | 12754 | 03:01:50 INFO - PROCESS | 12754 | Cycle 1(1): loaded http://localhost:40736/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40736/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:01:50 INFO - PROCESS | 12754 | RSS: Main: 145805312 03:01:50 INFO - PROCESS | 12754 | 03:01:52 INFO - PROCESS | 12754 | Cycle 1(1): loaded http://localhost:40736/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40736/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:01:53 INFO - PROCESS | 12754 | RSS: Main: 146784256 03:01:53 INFO - PROCESS | 12754 | 03:01:55 INFO - PROCESS | 12754 | Cycle 1(1): loaded http://localhost:40736/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40736/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:01:56 INFO - PROCESS | 12754 | RSS: Main: 146321408 03:01:56 INFO - PROCESS | 12754 | 03:01:58 INFO - PROCESS | 12754 | Cycle 1(1): loaded http://localhost:40736/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40736/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:01:59 INFO - PROCESS | 12754 | RSS: Main: 147345408 03:01:59 INFO - PROCESS | 12754 | 03:02:01 INFO - PROCESS | 12754 | Cycle 1(1): loaded http://localhost:40736/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40736/tests/kraken/driver.html?testName=ai-astar) 03:02:01 INFO - PROCESS | 12754 | RSS: Main: 148488192 03:02:01 INFO - PROCESS | 12754 | 03:02:01 INFO - PROCESS | 12754 | __start_tp_report 03:02:01 INFO - PROCESS | 12754 | _x_x_mozilla_page_load 03:02:01 INFO - PROCESS | 12754 | _x_x_mozilla_page_load_details 03:02:01 INFO - PROCESS | 12754 | |i|pagename|runs| 03:02:01 INFO - PROCESS | 12754 | |0;ai-astar;112;106;112;112;111;122;110;110;110;111 03:02:01 INFO - PROCESS | 12754 | |1;audio-beat-detection;150;126;153;162;126;158;147;128;161;126 03:02:01 INFO - PROCESS | 12754 | |2;audio-dft;162;164;162;165;166;163;162;162;166;164 03:02:01 INFO - PROCESS | 12754 | |3;audio-fft;76;73;76;155;77;73;73;75;158;73 03:02:01 INFO - PROCESS | 12754 | |4;audio-oscillator;98;96;143;96;95;97;133;96;95;143 03:02:01 INFO - PROCESS | 12754 | |5;imaging-gaussian-blur;110;110;111;110;110;109;109;110;109;112 03:02:01 INFO - PROCESS | 12754 | |6;imaging-darkroom;149;148;148;150;148;147;148;147;146;147 03:02:01 INFO - PROCESS | 12754 | |7;imaging-desaturate;97;98;96;97;96;97;98;96;97;96 03:02:01 INFO - PROCESS | 12754 | |8;json-parse-financial;55;56;56;59;55;56;59;64;56;55 03:02:01 INFO - PROCESS | 12754 | |9;json-stringify-tinderbox;64;64;64;64;65;65;64;64;64;65 03:02:01 INFO - PROCESS | 12754 | |10;stanford-crypto-aes;85;78;80;79;83;79;79;79;79;78 03:02:01 INFO - PROCESS | 12754 | |11;stanford-crypto-ccm;114;112;112;116;111;113;125;117;109;111 03:02:01 INFO - PROCESS | 12754 | |12;stanford-crypto-pbkdf2;138;144;140;141;136;137;138;126;135;135 03:02:01 INFO - PROCESS | 12754 | |13;stanford-crypto-sha256-iterative;65;64;65;66;67;66;62;64;65;63 03:02:01 INFO - PROCESS | 12754 | __end_tp_report 03:02:01 INFO - PROCESS | 12754 | __start_cc_report 03:02:01 INFO - PROCESS | 12754 | _x_x_mozilla_cycle_collect,714 03:02:01 INFO - PROCESS | 12754 | __end_cc_report 03:02:01 INFO - PROCESS | 12754 | __startTimestamp1457348521339__endTimestamp 03:02:01 INFO - PROCESS | 12754 | 03:02:01 INFO - PROCESS | 12754 | ------- Summary: start ------- 03:02:01 INFO - PROCESS | 12754 | Number of tests: 14 03:02:01 INFO - PROCESS | 12754 | 03:02:01 INFO - PROCESS | 12754 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.50 stddev:4.06 (3.6%) stddev-sans-first:4.30 03:02:01 INFO - PROCESS | 12754 | Values: 112.0 106.0 112.0 112.0 111.0 122.0 110.0 110.0 110.0 111.0 03:02:01 INFO - PROCESS | 12754 | 03:02:01 INFO - PROCESS | 12754 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:151.50 stddev:15.50 (10.2%) stddev-sans-first:16.27 03:02:01 INFO - PROCESS | 12754 | Values: 150.0 126.0 153.0 162.0 126.0 158.0 147.0 128.0 161.0 126.0 03:02:01 INFO - PROCESS | 12754 | 03:02:01 INFO - PROCESS | 12754 | [#2] audio-dft Cycles:10 Average:163.60 Median:164.00 stddev:1.65 (1.0%) stddev-sans-first:1.64 03:02:01 INFO - PROCESS | 12754 | Values: 162.0 164.0 162.0 165.0 166.0 163.0 162.0 162.0 166.0 164.0 03:02:01 INFO - PROCESS | 12754 | 03:02:01 INFO - PROCESS | 12754 | [#3] audio-fft Cycles:10 Average:90.90 Median:74.00 stddev:34.61 (46.8%) stddev-sans-first:36.29 03:02:01 INFO - PROCESS | 12754 | Values: 76.0 73.0 76.0 155.0 77.0 73.0 73.0 75.0 158.0 73.0 03:02:01 INFO - PROCESS | 12754 | 03:02:01 INFO - PROCESS | 12754 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:96.00 stddev:21.22 (22.1%) stddev-sans-first:22.11 03:02:01 INFO - PROCESS | 12754 | Values: 98.0 96.0 143.0 96.0 95.0 97.0 133.0 96.0 95.0 143.0 03:02:01 INFO - PROCESS | 12754 | 03:02:01 INFO - PROCESS | 12754 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.94 (0.9%) stddev-sans-first:1.00 03:02:01 INFO - PROCESS | 12754 | Values: 110.0 110.0 111.0 110.0 110.0 109.0 109.0 110.0 109.0 112.0 03:02:01 INFO - PROCESS | 12754 | 03:02:01 INFO - PROCESS | 12754 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.14 (0.8%) stddev-sans-first:1.12 03:02:01 INFO - PROCESS | 12754 | Values: 149.0 148.0 148.0 150.0 148.0 147.0 148.0 147.0 146.0 147.0 03:02:01 INFO - PROCESS | 12754 | 03:02:01 INFO - PROCESS | 12754 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 03:02:01 INFO - PROCESS | 12754 | Values: 97.0 98.0 96.0 97.0 96.0 97.0 98.0 96.0 97.0 96.0 03:02:01 INFO - PROCESS | 12754 | 03:02:01 INFO - PROCESS | 12754 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:56.00 stddev:2.85 (5.1%) stddev-sans-first:2.92 03:02:01 INFO - PROCESS | 12754 | Values: 55.0 56.0 56.0 59.0 55.0 56.0 59.0 64.0 56.0 55.0 03:02:01 INFO - PROCESS | 12754 | 03:02:01 INFO - PROCESS | 12754 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 03:02:01 INFO - PROCESS | 12754 | Values: 64.0 64.0 64.0 64.0 65.0 65.0 64.0 64.0 64.0 65.0 03:02:01 INFO - PROCESS | 12754 | 03:02:01 INFO - PROCESS | 12754 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.00 stddev:2.28 (2.9%) stddev-sans-first:1.50 03:02:01 INFO - PROCESS | 12754 | Values: 85.0 78.0 80.0 79.0 83.0 79.0 79.0 79.0 79.0 78.0 03:02:01 INFO - PROCESS | 12754 | 03:02:01 INFO - PROCESS | 12754 | [#11] stanford-crypto-ccm Cycles:10 Average:114.00 Median:113.50 stddev:4.55 (4.0%) stddev-sans-first:4.82 03:02:01 INFO - PROCESS | 12754 | Values: 114.0 112.0 112.0 116.0 111.0 113.0 125.0 117.0 109.0 111.0 03:02:01 INFO - PROCESS | 12754 | 03:02:01 INFO - PROCESS | 12754 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.00 Median:138.00 stddev:4.78 (3.5%) stddev-sans-first:5.06 03:02:01 INFO - PROCESS | 12754 | Values: 138.0 144.0 140.0 141.0 136.0 137.0 138.0 126.0 135.0 135.0 03:02:01 INFO - PROCESS | 12754 | 03:02:01 INFO - PROCESS | 12754 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.49 (2.3%) stddev-sans-first:1.58 03:02:01 INFO - PROCESS | 12754 | Values: 65.0 64.0 65.0 66.0 67.0 66.0 62.0 64.0 65.0 63.0 03:02:01 INFO - PROCESS | 12754 | -------- Summary: end -------- 03:02:01 INFO - PROCESS | 12754 | 03:02:02 INFO - TEST-INFO | 12754: exit 0 03:02:02 INFO - TEST-OK | kraken | took 59085ms 03:02:02 INFO - TEST-START | v8_7 03:02:02 INFO - operating with platform_type : linux_ 03:02:02 INFO - Initialising browser for v8_7 test... 03:02:02 INFO - TEST-INFO | started process 13047 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzDUdB3/profile http://localhost:40736/getInfo.html) 03:02:05 INFO - PROCESS | 13047 | 03:02:05 INFO - PROCESS | 13047 | (process:13128): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:02:06 INFO - PROCESS | 13047 | __metrics Screen width/height:1600/1200 03:02:06 INFO - PROCESS | 13047 | colorDepth:24 03:02:06 INFO - PROCESS | 13047 | Browser inner width/height: 1024/697 03:02:06 INFO - PROCESS | 13047 | __metrics 03:02:07 INFO - TEST-INFO | 13047: exit 0 03:02:07 INFO - Browser initialized. 03:02:07 INFO - Running cycle 1/1 for v8_7 test... 03:02:07 INFO - TEST-INFO | started process 13177 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzDUdB3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:02:09 INFO - PROCESS | 13177 | 03:02:09 INFO - PROCESS | 13177 | (process:13237): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:02:19 INFO - PROCESS | 13177 | RSS: Main: 141295616 03:02:19 INFO - PROCESS | 13177 | 03:02:42 INFO - PROCESS | 13177 | Cycle 1(1): loaded http://localhost:40736/tests/v8_7/run.html (next: http://localhost:40736/tests/v8_7/run.html) 03:02:42 INFO - PROCESS | 13177 | RSS: Main: 144932864 03:02:42 INFO - PROCESS | 13177 | 03:02:42 INFO - PROCESS | 13177 | __start_tp_report 03:02:42 INFO - PROCESS | 13177 | _x_x_mozilla_page_load 03:02:42 INFO - PROCESS | 13177 | _x_x_mozilla_page_load_details 03:02:42 INFO - PROCESS | 13177 | |i|pagename|runs| 03:02:42 INFO - PROCESS | 13177 | |0;Richards;169.26201760324983 03:02:42 INFO - PROCESS | 13177 | |1;DeltaBlue;175.5001755001755 03:02:42 INFO - PROCESS | 13177 | |2;Encrypt;278.78449958182324 03:02:42 INFO - PROCESS | 13177 | |3;Decrypt;5202.072538860104 03:02:42 INFO - PROCESS | 13177 | |4;RayTrace;922.509225092251 03:02:42 INFO - PROCESS | 13177 | |5;Earley;566.57223796034 03:02:42 INFO - PROCESS | 13177 | |6;Boyer;10934.782608695652 03:02:42 INFO - PROCESS | 13177 | |7;RegExp;39403.846153846156 03:02:42 INFO - PROCESS | 13177 | |8;Splay;520.2913631633714 03:02:42 INFO - PROCESS | 13177 | |9;NavierStokes;4826.923076923077 03:02:42 INFO - PROCESS | 13177 | __end_tp_report 03:02:42 INFO - PROCESS | 13177 | __startTimestamp1457348562281__endTimestamp 03:02:42 INFO - PROCESS | 13177 | 03:02:42 INFO - PROCESS | 13177 | ------- Summary: start ------- 03:02:42 INFO - PROCESS | 13177 | Number of tests: 10 03:02:42 INFO - PROCESS | 13177 | 03:02:42 INFO - PROCESS | 13177 | [#0] Richards Cycles:1 Average:169.26 Median:169.26 stddev:0.00 (0.0%) 03:02:42 INFO - PROCESS | 13177 | Values: 169.3 03:02:42 INFO - PROCESS | 13177 | 03:02:42 INFO - PROCESS | 13177 | [#1] DeltaBlue Cycles:1 Average:175.50 Median:175.50 stddev:0.00 (0.0%) 03:02:42 INFO - PROCESS | 13177 | Values: 175.5 03:02:42 INFO - PROCESS | 13177 | 03:02:42 INFO - PROCESS | 13177 | [#2] Encrypt Cycles:1 Average:278.78 Median:278.78 stddev:0.00 (0.0%) 03:02:42 INFO - PROCESS | 13177 | Values: 278.8 03:02:42 INFO - PROCESS | 13177 | 03:02:42 INFO - PROCESS | 13177 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 03:02:42 INFO - PROCESS | 13177 | Values: 5202.1 03:02:42 INFO - PROCESS | 13177 | 03:02:42 INFO - PROCESS | 13177 | [#4] RayTrace Cycles:1 Average:922.51 Median:922.51 stddev:0.00 (0.0%) 03:02:42 INFO - PROCESS | 13177 | Values: 922.5 03:02:42 INFO - PROCESS | 13177 | 03:02:42 INFO - PROCESS | 13177 | [#5] Earley Cycles:1 Average:566.57 Median:566.57 stddev:0.00 (0.0%) 03:02:42 INFO - PROCESS | 13177 | Values: 566.6 03:02:42 INFO - PROCESS | 13177 | 03:02:42 INFO - PROCESS | 13177 | [#6] Boyer Cycles:1 Average:10934.78 Median:10934.78 stddev:0.00 (0.0%) 03:02:42 INFO - PROCESS | 13177 | Values: 10934.8 03:02:42 INFO - PROCESS | 13177 | 03:02:42 INFO - PROCESS | 13177 | [#7] RegExp Cycles:1 Average:39403.85 Median:39403.85 stddev:0.00 (0.0%) 03:02:42 INFO - PROCESS | 13177 | Values: 39403.8 03:02:42 INFO - PROCESS | 13177 | 03:02:42 INFO - PROCESS | 13177 | [#8] Splay Cycles:1 Average:520.29 Median:520.29 stddev:0.00 (0.0%) 03:02:42 INFO - PROCESS | 13177 | Values: 520.3 03:02:42 INFO - PROCESS | 13177 | 03:02:42 INFO - PROCESS | 13177 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 03:02:42 INFO - PROCESS | 13177 | Values: 4826.9 03:02:42 INFO - PROCESS | 13177 | -------- Summary: end -------- 03:02:42 INFO - PROCESS | 13177 | 03:02:43 INFO - TEST-INFO | 13177: exit 0 03:02:43 INFO - TEST-OK | v8_7 | took 41040ms 03:02:43 INFO - SUITE-END | took 1208s 03:02:43 INFO - Completed test suite (00:20:08) 03:02:43 INFO - Working with test: dromaeo_css 03:02:43 INFO - Generating results file: dromaeo_css 03:02:43 INFO - Working with test: kraken 03:02:43 INFO - Generating results file: kraken 03:02:43 INFO - javascript benchmark 03:02:43 INFO - Working with test: v8_7 03:02:43 INFO - Generating results file: v8_7 03:02:43 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:02:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 03:02:43 INFO - process_Request line: dromaeo_css 7386.64 graph.html#tests=[[72,52,43]] 03:02:43 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:02:43 INFO - process_Request line: kraken 1490.60 graph.html#tests=[[232,52,43]] 03:02:43 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:02:43 INFO - process_Request line: v8_7 21945.31 graph.html#tests=[[230,52,43]] 03:02:43 INFO - RETURN: dromaeo_css: 7386.64 03:02:43 INFO - RETURN: kraken: 1490.60 03:02:43 INFO - RETURN: v8_7: 21945.31 03:02:43 INFO - javascript benchmark 03:02:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3274.8035117892928, 3295.967040329596, 3298.983505082474, 3312.354090952264, 3329.317489914568, 5324.387695415028, 5344.759485823138, 5355.544778693806, 5357.54460870826, 5362.0, 5408.567314614831, 5408.648437851537, 5411.621186516945, 5421.21392398102, 5424.430434804348, 4913.705177689341, 4935.136351138536, 4980.825671101512, 5003.249512573125, 5053.317802096725, 4723.527647235266, 4891.241857512074, 4917.950820491803, 4918.311436398889, 5020.698758074527, 5019.322391477141, 5046.7224302663335, 5054.317667114948, 5067.670601410915, 5076.111680455905, 4975.975120124376, 5019.924701129467, 5025.346704928336, 5047.369078865142, 5053.343065401493, 4889.535494128052, 4905.583025442842, 4927.334809800703, 4944.0, 4989.900201995976, 5186.247994040843, 5226.5818734501145, 5256.290400795881, 5265.631405801595, 5275.973620131913, 5802.332731735863, 5814.563907706939, 5815.621984571032, 5830.4169583041785, 5832.795852145197, 5678.914816277759, 5779.595428320019, 5859.1797148399255, 5927.2590926134235, 5938.138969849348, 5538.280023596947, 5550.888982220374, 5571.944280557183, 5573.693446860421, 5595.412481689405, 5744.425557444222, 6009.278886533644, 6012.549058820606, 6053.213082299273, 6064.332923378425, 5678.517326027251, 5725.312962444534, 5849.532037436995, 5851.297844258716, 5887.852803679943, 5854.941450585525, 5863.824085277449, 5869.090291004901, 5874.030784920526, 5878.088896221093, 5681.34664513578, 5751.741171647286, 5822.184894114827, 5822.184894114827, 5847.26909136358, 5903.498202652737, 5966.19456373384, 5973.163757074013, 5975.910361344583, 6008.309044459856, 4395.340698895127, 4441.133978874089, 4444.622207112367, 4477.910441791146, 4493.707908985905, 3981.8606348778235, 4009.4386785850006, 4019.879403617896, 4038.071243613985, 4075.3886916962692, 5458.372287187024, 5497.257870187554, 5589.776408943597, 5591.7483713233005, 5650.576206784508, 5855.414458554111, 5908.350081491032, 5922.022866227025, 5932.228810254639, 5958.910616340759, 5335.919961200585, 5338.679679219259, 5457.808976685797, 5607.495325420732, 5624.803131890364, 5054.848354549369, 5057.721825299644, 5070.670406423571, 5078.771455284521, 5094.643374963717, 5984.461398474158, 6022.939770602326, 6044.972354699712, 6046.486048685823, 6052.6065805723365, 5733.512651424676, 5790.044642634087, 5848.385919478394, 5897.203877476486, 5922.703864806743, 5977.163197152315, 5987.042073268256, 6005.819825405245, 6006.849828754316, 6020.759169633166, 5749.425057494384, 5769.653820770767, 5773.509251713652, 5786.94213057864, 5801.506871915765, 5720.656760594377, 5745.224394706661, 5783.971080144573, 5847.795327163529, 5922.289325280822, 5790.826275211751, 5796.565257605781, 5796.768129274782, 5798.884022319446, 5811.912821307768, 5761.020626493422, 5761.798337058183, 5768.278965129359, 5770.105633626795, 5772.1630363596205, 5519.116941289374, 5564.970480461127, 5590.5527557796095, 5646.491815736604, 5676.0, 5652.123920792284, 5718.742656580381, 5732.369439361583, 5736.856578585569, 5737.856553586027, 5535.39110697831, 5576.33084029919, 5578.609497335147, 5591.664500130005, 5603.607747457801], "unit": "score", "name": "dojo.html", "value": 5391.578188914229}, {"lowerIsBetter": false, "replicates": [539.1131588536855, 555.0065382964493, 566.5892228134601, 570.957178211634, 614.7571709174877, 30763.384732305367, 41359.37960930585, 42026.47841129527, 42204.15591688168, 42384.78807605958, 45227.547724522745, 45493.54506454935, 45815.541844581545, 45818.54181458185, 45871.31193032099, 8996.145366190201, 9191.770205744842, 9204.40171388861, 9206.723798286062, 9211.769705757342, 8842.159994800515, 8906.510141942223, 8930.0, 8949.552522373888, 8955.865662015074, 8853.778655533599, 8873.20141187293, 8939.687110951118, 8965.0, 8998.640054397816, 8866.778330541723, 8889.599968001456, 8914.821703565925, 8933.10668933108, 8983.371164018521, 8886.955565222133, 8979.012308646044, 9012.594433250519, 9038.0, 9052.637894484213, 42397.728068158, 42467.575324246674, 42676.0, 42924.57075429237, 42992.0, 3681.0, 3686.299603075407, 3817.3319669058083, 3867.477890484805, 4247.0, 29044.0, 29185.416291674046, 29249.70750292491, 29354.266143346373, 30042.84978575115, 4211.410402543646, 4332.090261045184, 4333.523312435629, 4401.207782599131, 4456.064226512404, 290023.0, 293274.0, 295962.0, 296359.0, 297805.0, 66412.0, 66866.0, 67121.66439167772, 67244.6637766808, 67624.32375676278, 70915.64542177359, 71463.28536714567, 71533.64233178904, 71579.0, 71606.0, 18135.818641813676, 18582.44252672422, 18652.53368665767, 18699.34552290663, 18733.250669973047, 13100.148490348098, 13114.672133196746, 13151.408186631625, 13181.275029873257, 13181.802272965913, 22489.212877549206, 22821.31536053921, 22945.426364340692, 22967.88516057409, 23007.424814379774, 8533.658653653909, 8713.869291960626, 8858.29133669305, 8931.71277786653, 8936.151065648754, 991.4596544883057, 1045.1064339989352, 1050.2858056521638, 1200.885915837994, 1216.9959783178913, 29700.554491682644, 29856.701432985825, 30359.848200758854, 30609.23476913095, 30716.846415768225, 1184.2953442701578, 1192.8807119288, 1193.1230545549015, 1279.7632437998814, 1340.0418700629098, 15242.695146097238, 15347.309371078329, 16135.435259765853, 17419.303227870998, 17953.820461795476, 431195.0, 549389.0, 807795.0, 808169.0, 814968.0, 59780.40219597836, 60884.086738698956, 60915.0, 61070.0, 61268.0, 1471.5217554295111, 1479.423025020243, 1505.3526983397244, 1512.0625212368402, 1537.7078355112492, 32047.519287211177, 32779.836100819346, 33264.33471330608, 33514.162145946546, 34006.48990265198, 50016.0, 50085.0, 50374.0, 50618.0, 50766.23850642317, 246807.0, 248668.0, 249331.0, 249742.0, 251883.0, 41399.37900931428, 42465.787671061444, 42639.36040959326, 42661.0, 42663.3600495999, 49918.251226232365, 50510.747446264, 50990.0, 51148.0, 51392.22911656403, 35816.64183358133, 36184.09539761527, 36690.44964325484, 36965.445518317785, 37067.0, 36344.0, 36402.817985909904, 36559.26881462409, 36904.44643330406, 37050.44424333691, 37836.81081594574, 37845.810770945965, 38107.42838857364, 38148.0, 43093.13813723771, 32663.836680816443, 32874.83562582172, 37406.812965934994, 37934.810325948194, 38075.80962095172, 27503.724962750915, 27850.303742406602, 27852.72147278501, 27879.721202787714, 28013.579796302663], "unit": "score", "name": "ext.html", "value": 20520.528144212487}, {"lowerIsBetter": false, "replicates": [387.38405934564037, 401.06951871657753, 401.3217662150965, 403.94142849286857, 404.8785364390682, 15150.84849151511, 15684.921575392136, 17450.127493625314, 17941.7308740369, 18001.189946452407, 12486.875131248686, 12544.247345159296, 12617.621471355851, 14918.328675209614, 16769.496915092535, 5189.662671926322, 5297.920531192016, 5828.970855145718, 5837.0, 5839.620424672383, 5535.501804837564, 5653.971730141344, 5666.54667626591, 5687.573431992597, 5702.942970570303, 5560.582956278296, 5675.432456754333, 5676.971615141939, 5715.857103572403, 5747.109198074305, 5766.1639062335935, 5813.563982701315, 5814.825555233349, 5831.30024397073, 5837.066069428871, 5443.156310771837, 5658.490735833795, 5682.261306030231, 5696.2594862668, 5792.304923409176, 21420.357389278346, 21557.67663485049, 21876.343709688575, 22016.559668806534, 22226.666600001012, 2280.304507125326, 2291.3698732848434, 2298.2990187992655, 2332.918347857817, 2399.5320912422085, 10371.377717336909, 10399.740006499822, 12884.613461596167, 13371.933140334237, 13407.793298603076, 1913.3685883658359, 1933.7002764571514, 1937.2347922570507, 1945.6886898096377, 1971.4578490914969, 61893.6905315475, 62441.687791561206, 62942.37057629411, 63157.052644209914, 64094.0, 10688.358698478116, 10747.032767050847, 10767.6231331903, 10907.400092994803, 11197.832032519518, 14143.717125657635, 14151.85848141526, 14192.787108193384, 14197.077189982618, 15105.47130850415, 8322.292605128632, 8389.286910612665, 8472.534010629352, 8513.31893448535, 8550.74347769568, 7888.960555197187, 7917.445778795429, 8151.388645851584, 8201.261886430131, 8274.338052955749, 4515.209838278354, 4770.284457331428, 4775.594074503706, 4840.056189043174, 4888.388951381077, 1770.6193168468842, 1962.9966151787787, 1964.79369666183, 1979.0896187753506, 1985.2654517828496, 1019.4962430415227, 1109.6504601050642, 1113.5935383585095, 1125.094299089241, 1166.381817636654, 15999.040057596581, 16336.509904702878, 17868.910655446638, 17947.910260448876, 18211.72682409765, 1059.957601695939, 1068.6740544134113, 1082.480409403475, 1092.8415379769888, 1175.8236264560385, 9356.625734970661, 9575.521223938775, 9727.9027209727, 10278.383297002203, 10795.46022698862, 586685.0, 601082.0, 601997.0, 605045.0, 608865.0, 73650.63174684093, 75697.62151189208, 77126.22873771303, 78722.0, 78937.60531197423, 1241.6771639373828, 1244.993775031119, 1246.1401632873287, 1253.6489782860813, 1260.9180403273942, 15442.536723898302, 16146.757798633265, 16568.17159142062, 16786.32854685799, 16804.663906722042, 31971.360572787948, 32460.188495287806, 32785.67214327922, 33141.502877456376, 33328.83335583306, 43743.56256437395, 43753.0, 44907.55092449034, 45467.09065818731, 45682.08635827198, 8189.426740128372, 8423.32613390915, 8462.534560599226, 8512.914870851213, 8632.482051076955, 8853.15894989975, 9130.269578433843, 9405.482698451377, 11669.416529173677, 12334.0, 7990.240927111915, 7998.84002319962, 8197.672093116447, 8273.379496537904, 8315.792105197177, 7904.367650588054, 8455.873161902453, 8495.108013658724, 8506.447080939966, 8596.054434012129, 3052.175912503656, 5213.618391126279, 8545.273651739422, 8667.956660216658, 8708.521031343336, 10768.46157692128, 10834.512446939749, 11126.388048657078, 11144.387058711849, 11312.321260724382, 11288.32270063766, 11359.148063895076, 11372.488238029144, 11561.826572601249, 11660.416979151178], "unit": "score", "name": "jquery.html", "value": 8674.543287103144}, {"lowerIsBetter": false, "replicates": [1594.9122798246096, 1622.0105735501345, 1889.0460317539648, 1930.3436831477295, 1968.1536939116183, 7294.525855819368, 7464.925350746491, 8201.26188643022, 8364.832703345937, 8440.0, 7985.800354991128, 8128.349732021439, 8169.795755106125, 8225.6298466569, 8232.794180145484, 2371.905123795046, 2434.47658753368, 2434.987825060872, 2435.196385192891, 2440.548498527769, 2436.3421876093444, 2459.1515927005244, 2480.255923223035, 2510.447701505666, 2519.3071905226025, 2409.819263555232, 2414.7705967933107, 2436.5979613363775, 2463.6427717980882, 2465.1125594785863, 2439.85360878347, 2446.131623273739, 2453.3621258472836, 2455.3616059824394, 2502.036715864387, 2490.6762120924345, 2514.1577571513567, 2518.7355327690693, 2534.594464885628, 2547.38862672959, 8422.915770842274, 8463.915360846375, 8464.32285417165, 8496.78758031048, 8531.74404767858, 5157.6647517911215, 5246.31797866275, 5251.054810134175, 5274.05067087924, 5305.283786688786, 3296.3572103439838, 3317.7345812334956, 3336.4161271777343, 3434.845431955568, 3438.0717206354393, 1195.5755706724074, 1200.5173610590914, 1202.3867827408085, 1221.694576355911, 1273.8089286607083, 11683.591074312359, 11827.586034488751, 11832.645020649394, 11835.822462663067, 11908.46411911466, 4737.123632128068, 4744.122337367529, 4765.285207218875, 4846.61227101831, 4862.927056094161, 10163.695089147337, 10252.179825614083, 10266.743331416774, 10285.691429257135, 10329.896701033043, 5230.0585894539345, 5255.500727430888, 5302.257683924254, 5311.256424100629, 5311.920321195185, 4178.874633760992, 4267.5732426757695, 4590.42619672541, 4727.5745182933015, 4798.448178459522, 4136.44158038667, 4149.315362965137, 4157.854475093357, 4158.189153115113, 4192.559781222989, 1367.459853357918, 1403.7262733766818, 1404.592668126232, 1404.9648758781111, 1419.5883193873867, 1170.455738081796, 1182.7385710809986, 1196.9162158648985, 1504.8194216694067, 1518.293993293124, 7970.601469926481, 8057.919420805717, 8066.596670166468, 8084.83830323402, 8149.103598604149, 552.3013388064102, 554.6200852416108, 558.3055426779704, 560.5767645427676, 560.742058653016, 5900.4984576310635, 5998.970005149947, 6000.789972350947, 6043.667598282137, 6047.546434017467, 10050.849237261447, 10146.289759716748, 10308.536115874804, 10322.071013608811, 10374.325668831501, 9946.701598952042, 10175.185985121172, 10209.642662506776, 10230.079292863678, 10262.897371026194, 7915.12933577306, 7945.960270198612, 7946.125926148119, 7961.681532738626, 7963.323117534958, 7618.466707330434, 7624.656890439833, 7694.769156925301, 7705.922940770744, 7767.844643107219, 8961.50711710836, 9134.314926380415, 9235.953820230856, 9236.307276954121, 9272.350935434455, 9295.163435290857, 9340.159385655325, 9373.625054997996, 9561.665341713007, 9692.369995950241, 6472.708728107153, 6649.168853893263, 7099.574025558483, 7502.849943001219, 7585.848283034419, 7973.800654983672, 7985.560794156378, 8010.3992200584025, 8032.59837008159, 8062.475939063942, 7222.530535515175, 7393.96303018503, 7729.690812367442, 7779.96110019469, 7802.29779319864, 7288.890666640111, 7295.197528271992, 7340.706371745284, 7418.703251869865, 7471.8879216812875, 7517.774466766005, 7524.134724506533, 7576.204498527795, 7624.27569380908, 7632.313091821763, 6593.835154121185, 6617.834554136185, 6764.695588698619, 6851.794446166623, 6854.451643868379, 7048.083749112788, 7091.361777440055, 7138.928610714034, 7278.599677017814, 7313.634318284171], "unit": "score", "name": "mootools.html", "value": 4807.228332834478}, {"lowerIsBetter": false, "replicates": [370.023138913269, 374.67029014467266, 374.91189570450956, 375.25324604037957, 385.9112404147044, 6339.112524246603, 6352.936470635293, 6393.584417012891, 6465.612063276207, 6565.0480680301325, 6366.427021568058, 6394.7761828336015, 6411.294757576663, 6451.06459563363, 6464.741410343592, 4935.555799978001, 4940.827071052514, 4950.727709975949, 4956.7199088419375, 4970.950290497103, 4963.379577552806, 4964.280179373988, 4970.751462426882, 4971.1549036663855, 4976.004799040188, 4842.491538388471, 4928.433230178522, 4928.901421971558, 4930.926036109461, 4933.506649335073, 4901.607871370282, 4907.067657145131, 4918.458969513333, 4919.557239848413, 4921.507849215086, 4233.724807887477, 4241.724287921306, 4246.575342465729, 4251.893702657428, 4261.2329780639475, 6081.6351018939, 6124.816255512342, 6131.356207598227, 6137.846553836145, 6150.108234306045, 5508.0, 5696.943030569724, 5717.914231286534, 5731.369549349568, 5731.770729170828, 6728.158980127484, 6773.356531129535, 6802.761903333359, 6803.48973826965, 6811.4550835933005, 4745.881352966169, 4762.666613337068, 4766.880827979294, 4768.380110585602, 4776.832810851638, 6977.651117444158, 7019.964900175466, 7075.2570980047385, 7087.610181440019, 7104.857902841966, 4847.127517046965, 4879.097366987119, 4892.168331383673, 4900.093482705711, 4901.313816065754, 4933.136701077297, 4969.360111163307, 4971.651984361132, 4972.5276098770555, 4973.303737476756, 5567.443255674481, 5711.228984087178, 5712.200291959129, 5713.971430142823, 5714.828555143353, 6745.5952642841585, 6795.694193761194, 6796.626185559743, 6813.897791533131, 6816.591004539743, 1732.688116139107, 1758.2000189913558, 1809.3215044358365, 1810.4749622609295, 1815.3101821307819, 1240.8883200511998, 1242.0250103668577, 1244.2596654990266, 1250.6185613387822, 1265.8227848101274, 6489.935100649028, 6534.346565343428, 6543.607383557001, 6552.886009378417, 6578.342165783383, 6938.687759050855, 6958.860822783516, 6959.095317608679, 6972.477064220204, 6987.755428559976, 6345.365463453618, 6493.967530162319, 6519.217693876765, 6543.836404089936, 6556.213254409501, 3760.623937606272, 3781.205946751158, 3783.5270591176104, 3800.0309920969976, 3805.5813860475328, 7154.962530433162, 7155.141383033965, 7218.917162425573, 7226.602536860418, 7235.746748863765, 6984.7648752398745, 7165.820854478679, 7190.741620216441, 7192.208857025723, 7198.084775665864, 7201.675924583406, 7209.6034718091005, 7212.639368031578, 7223.024891639667, 7226.0, 6905.1713794342995, 6958.686859091455, 6971.26801685836, 6985.511014228955, 6997.0, 6765.391114799691, 6860.588364698134, 6875.621840798804, 6976.953456981493, 6988.266232045562, 7328.230535793665, 7342.19235884063, 7358.374538164316, 7361.668724907285, 7382.852342953003, 4859.173940430206, 4864.562189402971, 4870.78081486341, 4874.122657921608, 4886.315915771866, 6994.215941477679, 7000.544964577286, 7032.824179395556, 7105.6447177639875, 7136.9286307138345, 6940.99355593426, 6942.444604431533, 6950.652467376712, 6952.826179345355, 6969.163700355787, 6908.689108990007, 6946.826329341807, 6958.443324533924, 7026.789196324118, 7042.471814613822, 6630.701618427086, 6781.559198652072, 6817.0, 6830.624315662686, 6831.146106736658, 6919.20429150634, 6931.653417329214, 6968.745625787407, 6972.895406568804, 6990.056342393712, 6723.058771772054, 6769.052332673528, 6771.492138089565, 6808.319168083152, 6811.591304521745], "unit": "score", "name": "prototype.html", "value": 5176.268417378415}, {"lowerIsBetter": false, "replicates": [831.8377916306318, 911.8632205169228, 919.1222382624594, 940.2055263302507, 963.872096644242, 14773.26133693315, 14796.18620975846, 14903.47837825675, 14911.030782999098, 14971.850281497182, 13748.518801841938, 13768.105073170236, 13883.0, 13904.860951390483, 13974.790378144337, 904.4618452021037, 922.547951503765, 922.7370199493146, 924.3529529329462, 926.6756635177701, 905.0496978172926, 908.8273228086642, 916.3951791817402, 919.3794188922484, 919.3794188922484, 945.1540870920522, 950.4724877692878, 951.3720944176845, 958.2094771813282, 958.5399008475936, 948.0850978805452, 948.2224575847807, 949.8147861167075, 953.704351650987, 953.9284553658434, 694.8124006518262, 698.6611493425685, 698.9510734248605, 702.5889854435162, 703.496999645251, 13337.199768013854, 13515.391807368595, 13591.320433978262, 13591.728165436734, 13608.523701670492, 12034.097442691833, 12355.75288494225, 12369.69075773104, 12383.318917459535, 12492.0630952678, 10577.84133238002, 10581.206409519316, 10650.840237396445, 10664.613600231998, 10794.78410431787, 3777.0, 3846.8653597123966, 3890.105275786557, 3891.7081218908697, 3901.6878649707955, 46275.76862115702, 47420.0, 49873.50126498725, 51120.48879511232, 51140.0, 11009.504572294267, 11045.116390688725, 11159.107271418266, 11166.888331116746, 11317.71705707364, 18875.528111797314, 18941.715874261896, 18961.051947402575, 18969.0, 18983.71524427135, 7685.23147685227, 7755.573443460551, 7926.088499822479, 7991.520508769492, 8114.756557303291, 4470.731756094579, 4534.863954081383, 4579.977100114545, 4673.953260467351, 4872.025594880967, 3042.6957304269395, 3064.586280852101, 3069.5395690646583, 3070.6775788542327, 3084.6606873243927, 610.9694515274218, 620.3827191944044, 621.2917274307293, 628.5631486117196, 629.2071989293431, 586.6480111932891, 594.5303210463685, 637.3881074168758, 653.6927644007309, 693.639307560066, 8984.59569319369, 8993.325500587482, 9022.548872556346, 9178.173964343108, 9297.814043719087, 549.9862503437446, 673.8685956238486, 709.4643544124153, 710.7454401268814, 723.1105739939903, 4249.532551419341, 4341.869743907688, 4448.599626033608, 4473.0, 4474.910501790011, 59841.40158598445, 60055.0, 60732.392676073556, 64566.0, 65021.34978650153, 52124.0, 54342.0, 55342.44657553454, 56803.71598141983, 56981.43018569844, 45324.546754532035, 46004.7699761499, 46165.53834461612, 47505.76247118742, 47684.0, 9420.340576159877, 9932.950335248277, 10027.398356098658, 10102.696919092145, 10281.588736450458, 36453.45319820152, 36806.0, 37699.62300377071, 37840.0, 37876.431853521666, 46967.530324696316, 48532.27201591909, 48913.2663010048, 49520.257196142804, 49988.25017624811, 12322.445489953154, 12535.435905384462, 12799.42402591867, 12837.0, 13043.739125217253, 12966.935165324114, 13391.933040334736, 13735.725285494435, 13861.168329900238, 14053.36759845789, 12037.398130093636, 12422.813657794959, 12500.624981250578, 12616.0, 12641.431135599105, 12144.574939877062, 12227.104798756207, 12746.426410811351, 13062.150960187557, 13202.471901123847, 11669.88330116688, 11871.465784039912, 11952.462139203582, 12220.691841972246, 12573.87426125727, 10237.232207584311, 10418.895811041793, 10443.425611591436, 10528.263021588415, 10548.630797922342, 10747.0, 11108.0, 11122.888771112186, 11160.88839111631, 11314.0], "unit": "score", "name": "yui.html", "value": 6801.133721780537}], "name": "dromaeo_css", "value": 7386.638342052443}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 112.0, 112.0, 111.0, 122.0, 110.0, 110.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [150.0, 126.0, 153.0, 162.0, 126.0, 158.0, 147.0, 128.0, 161.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 143.7}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 162.0, 165.0, 166.0, 163.0, 162.0, 162.0, 166.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 76.0, 155.0, 77.0, 73.0, 73.0, 75.0, 158.0, 73.0], "unit": "score", "name": "audio-fft", "value": 90.9}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 143.0, 96.0, 95.0, 97.0, 133.0, 96.0, 95.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 112.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 148.0, 150.0, 148.0, 147.0, 148.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 96.0, 97.0, 96.0, 97.0, 98.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 56.0, 59.0, 55.0, 56.0, 59.0, 64.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.3}, {"lowerIsBetter": true, "replicates": [85.0, 78.0, 80.0, 79.0, 83.0, 79.0, 79.0, 79.0, 79.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.9}, {"lowerIsBetter": true, "replicates": [114.0, 112.0, 112.0, 116.0, 111.0, 113.0, 125.0, 117.0, 109.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.0}, {"lowerIsBetter": true, "replicates": [138.0, 144.0, 140.0, 141.0, 136.0, 137.0, 138.0, 126.0, 135.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.0}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 65.0, 66.0, 67.0, 66.0, 62.0, 64.0, 65.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.7}], "name": "kraken", "value": 1490.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.26201760324983], "unit": "score", "name": "Richards", "value": 208.56421600000007}, {"lowerIsBetter": false, "replicates": [175.5001755001755], "unit": "score", "name": "DeltaBlue", "value": 376.74036399999994}, {"lowerIsBetter": false, "replicates": [278.78449958182324], "unit": "score", "name": "Encrypt", "value": 954.7912470000005}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [922.509225092251], "unit": "score", "name": "RayTrace", "value": 802.1480759999998}, {"lowerIsBetter": false, "replicates": [566.57223796034], "unit": "score", "name": "Earley", "value": 1176.307195}, {"lowerIsBetter": false, "replicates": [10934.782608695652], "unit": "score", "name": "Boyer", "value": 60.94890258449304}, {"lowerIsBetter": false, "replicates": [39403.846153846156], "unit": "score", "name": "RegExp", "value": 23.119189848706686}, {"lowerIsBetter": false, "replicates": [520.2913631633714], "unit": "score", "name": "Splay", "value": 156.62570200000002}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21945.31225326159}]} 03:02:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21945.31"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1490.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7386.64"}}} 03:02:43 INFO - Return code: 0 03:02:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:02:43 INFO - # TBPL SUCCESS # 03:02:43 INFO - Running post-action listener: _resource_record_post_action 03:02:43 INFO - Running post-run listener: _resource_record_post_run 03:02:44 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 266240; Write bytes: 499691520; Read time: 36; Write time: 402280 03:02:44 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 242352128; Read time: 0; Write time: 277908 03:02:44 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 266240; Write bytes: 257339392; Read time: 36; Write time: 124372 03:02:44 INFO - Running post-run listener: _upload_blobber_files 03:02:44 INFO - Blob upload gear active. 03:02:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 03:02:44 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 03:02:44 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'] 03:02:44 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 03:02:45 INFO - (blobuploader) - INFO - Open directory for files ... 03:02:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:02:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:02:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:02:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:02:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:02:45 INFO - (blobuploader) - INFO - Done attempting. 03:02:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:02:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:02:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:02:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:02:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:02:46 INFO - (blobuploader) - INFO - Done attempting. 03:02:46 INFO - (blobuploader) - INFO - Iteration through files over. 03:02:46 INFO - Return code: 0 03:02:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 03:02:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 03:02:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e475ea3cbbe9c1a772b0e6eaec63a7a9a75f1e80e2c6e5e0fca7eee90ba5be0bf135ed3e9d63c9131c78611ce1e2c23fab2ae4b5de80d47e999f7e745b5b88a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db424caab371babae97cb3c905021ae8aedf367a7ff282608dbb3cd2af163dc52f5f1c2caad812ac0f58fa3f8acd52a6ba3393f5304048c956f1515c9a2a7737"} 03:02:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 03:02:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 03:02:46 INFO - Contents: 03:02:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e475ea3cbbe9c1a772b0e6eaec63a7a9a75f1e80e2c6e5e0fca7eee90ba5be0bf135ed3e9d63c9131c78611ce1e2c23fab2ae4b5de80d47e999f7e745b5b88a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db424caab371babae97cb3c905021ae8aedf367a7ff282608dbb3cd2af163dc52f5f1c2caad812ac0f58fa3f8acd52a6ba3393f5304048c956f1515c9a2a7737"} 03:02:46 INFO - Running post-run listener: copy_logs_to_upload_dir 03:02:46 INFO - Copying logs to upload dir... 03:02:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 03:02:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.698126 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-03-07 03:02:45.884875) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 03:02:45.887962) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769 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/e475ea3cbbe9c1a772b0e6eaec63a7a9a75f1e80e2c6e5e0fca7eee90ba5be0bf135ed3e9d63c9131c78611ce1e2c23fab2ae4b5de80d47e999f7e745b5b88a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db424caab371babae97cb3c905021ae8aedf367a7ff282608dbb3cd2af163dc52f5f1c2caad812ac0f58fa3f8acd52a6ba3393f5304048c956f1515c9a2a7737"} build_url:https://queue.taskcluster.net/v1/task/ATf9j_tgQUuGRT4htvaKxQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/ATf9j_tgQUuGRT4htvaKxQ/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/e475ea3cbbe9c1a772b0e6eaec63a7a9a75f1e80e2c6e5e0fca7eee90ba5be0bf135ed3e9d63c9131c78611ce1e2c23fab2ae4b5de80d47e999f7e745b5b88a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db424caab371babae97cb3c905021ae8aedf367a7ff282608dbb3cd2af163dc52f5f1c2caad812ac0f58fa3f8acd52a6ba3393f5304048c956f1515c9a2a7737"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 03:02:45.917316) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 03:02:45.917614) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457344199.297933-1839908769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 03:02:45.997787) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 03:02:45.998460) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 03:02:45.999079) ========= ========= Total master_lag: 0.32 =========