builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1456774006.77 results: success (0) buildid: 20160229085316 builduid: e1e60dbf7fa6400691bb1c4cf3a0c501 revision: 6aaf9904a81dd8635e056cacb1a4834fe13f9cd3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:46.773289) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:46.773773) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:46.774059) ========= 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=232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006252 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:46.800507) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:46.800840) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:46.825604) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:46.826016) ========= 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=232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019138 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:46.872819) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:46.873112) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:46.873453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:46.873735) ========= 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=232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 11:26:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 57.7M=0s 2016-02-29 11:26:47 (57.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.207971 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:47.094751) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:47.095055) ========= 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=232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.093865 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:47.203688) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:47.204026) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6aaf9904a81dd8635e056cacb1a4834fe13f9cd3 --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 6aaf9904a81dd8635e056cacb1a4834fe13f9cd3 --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=232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 11:26:47,450 truncating revision to first 12 chars 2016-02-29 11:26:47,450 Setting DEBUG logging. 2016-02-29 11:26:47,450 attempt 1/10 2016-02-29 11:26:47,451 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6aaf9904a81d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 11:26:47,724 unpacking tar archive at: mozilla-aurora-6aaf9904a81d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613320 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:47.833789) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:47.834616) ========= echo 6aaf9904a81dd8635e056cacb1a4834fe13f9cd3 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6aaf9904a81dd8635e056cacb1a4834fe13f9cd3'] 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=232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 6aaf9904a81dd8635e056cacb1a4834fe13f9cd3 program finished with exit code 0 elapsedTime=0.004647 script_repo_revision: '6aaf9904a81dd8635e056cacb1a4834fe13f9cd3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:47.890490) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:47.891204) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 11:26:47.902605) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-02-29 11:26:47.903304) ========= /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=232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:26:48 INFO - MultiFileLogger online at 20160229 11:26:48 in /builds/slave/test-pgo 11:26:48 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 11:26:48 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:26:48 INFO - {'append_to_log': False, 11:26:48 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:26:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:26:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:26:48 INFO - 'branch': 'Mozilla-Aurora', 11:26:48 INFO - 'buildbot_json_path': 'buildprops.json', 11:26:48 INFO - 'config_files': ('talos/linux_config.py',), 11:26:48 INFO - 'default_actions': ('clobber', 11:26:48 INFO - 'read-buildbot-config', 11:26:48 INFO - 'download-and-extract', 11:26:48 INFO - 'populate-webroot', 11:26:48 INFO - 'create-virtualenv', 11:26:48 INFO - 'install', 11:26:48 INFO - 'run-tests'), 11:26:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:26:48 INFO - 'download_minidump_stackwalk': True, 11:26:48 INFO - 'download_symbols': 'ondemand', 11:26:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:26:48 INFO - 'tooltool.py': '/tools/tooltool.py', 11:26:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:26:48 INFO - '/tools/misc-python/virtualenv.py')}, 11:26:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:26:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:26:48 INFO - 'installer_path': 'installer.exe', 11:26:48 INFO - 'log_level': 'info', 11:26:48 INFO - 'log_name': 'talos', 11:26:48 INFO - 'log_to_console': True, 11:26:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:26:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:26:48 INFO - 'opt_config_files': (), 11:26:48 INFO - 'pip_index': False, 11:26:48 INFO - 'sps_profile': False, 11:26:48 INFO - 'sps_profile_interval': 0, 11:26:48 INFO - 'suite': 'dromaeojs-e10s', 11:26:48 INFO - 'system_bits': '32', 11:26:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:26:48 INFO - 'title': 'talos-linux64-ix-025', 11:26:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:26:48 INFO - 'use_talos_json': True, 11:26:48 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:26:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:26:48 INFO - 'work_dir': 'build'} 11:26:48 INFO - ##### 11:26:48 INFO - ##### Running clobber step. 11:26:48 INFO - ##### 11:26:48 INFO - Running pre-action listener: _resource_record_pre_action 11:26:48 INFO - Running main action method: clobber 11:26:48 INFO - rmtree: /builds/slave/test-pgo/build 11:26:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:26:53 INFO - Running post-action listener: _resource_record_post_action 11:26:53 INFO - ##### 11:26:53 INFO - ##### Running read-buildbot-config step. 11:26:53 INFO - ##### 11:26:53 INFO - Running pre-action listener: _resource_record_pre_action 11:26:53 INFO - Running main action method: read_buildbot_config 11:26:53 INFO - Using buildbot properties: 11:26:53 INFO - { 11:26:53 INFO - "project": "", 11:26:53 INFO - "product": "firefox", 11:26:53 INFO - "script_repo_revision": "production", 11:26:53 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:26:53 INFO - "repository": "", 11:26:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:26:53 INFO - "buildid": "20160229085316", 11:26:53 INFO - "pgo_build": "True", 11:26:53 INFO - "basedir": "/builds/slave/test-pgo", 11:26:53 INFO - "buildnumber": 185, 11:26:53 INFO - "slavename": "talos-linux64-ix-025", 11:26:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:26:53 INFO - "platform": "ubuntu64_hw", 11:26:53 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:26:53 INFO - "branch": "mozilla-aurora", 11:26:53 INFO - "repo_path": "releases/mozilla-aurora", 11:26:53 INFO - "revision": "6aaf9904a81dd8635e056cacb1a4834fe13f9cd3", 11:26:53 INFO - "stage_platform": "linux64-pgo", 11:26:53 INFO - "builduid": "e1e60dbf7fa6400691bb1c4cf3a0c501", 11:26:53 INFO - "slavebuilddir": "test" 11:26:53 INFO - } 11:26:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 11:26:53 INFO - Running post-action listener: _resource_record_post_action 11:26:53 INFO - ##### 11:26:53 INFO - ##### Running download-and-extract step. 11:26:53 INFO - ##### 11:26:53 INFO - Running pre-action listener: _resource_record_pre_action 11:26:53 INFO - Running main action method: download_and_extract 11:26:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:53 INFO - https://queue.taskcluster.net/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:26:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/test_packages.json 11:26:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/test_packages.json 11:26:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:26:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:26:54 INFO - Downloaded 1448 bytes. 11:26:54 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:26:54 INFO - Using the following test package requirements: 11:26:54 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 11:26:54 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 11:26:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:26:54 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 11:26:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:26:54 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 11:26:54 INFO - u'jsshell-linux-x86_64.zip'], 11:26:54 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 11:26:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:26:54 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 11:26:54 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 11:26:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:26:54 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 11:26:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:26:54 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 11:26:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:26:54 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 11:26:54 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 11:26:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:26:54 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:54 INFO - https://queue.taskcluster.net/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:26:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 11:26:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 11:26:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/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 11:26:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/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 11:26:55 INFO - Downloaded 23081650 bytes. 11:26:55 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'] 11:26:55 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 11:26:56 INFO - Return code: 0 11:26:56 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 11:26: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')]} 11:26:56 INFO - https://queue.taskcluster.net/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:26:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 11:26:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 11:26:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/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 11:26:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/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 11:26:58 INFO - Downloaded 23081650 bytes. 11:26:58 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'] 11:26:58 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 11:26:59 INFO - Return code: 0 11:26: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')]} 11:26:59 INFO - https://queue.taskcluster.net/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:26:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 11:26:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 11:26:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/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 11:26:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/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 11:27:00 INFO - Downloaded 10706649 bytes. 11:27:00 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'] 11:27:00 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 11:27:00 INFO - Return code: 0 11:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:00 INFO - https://queue.taskcluster.net/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:27:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 11:27:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 11:27:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/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 11:27:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/etP8sKq2RTSW56aCYPm6uQ/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 11:27:02 INFO - Downloaded 59967306 bytes. 11:27:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 11:27:02 INFO - mkdir: /builds/slave/test-pgo/properties 11:27:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:27:02 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:27:02 INFO - Contents: 11:27:02 INFO - build_url:https://queue.taskcluster.net/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 11:27:03 INFO - Running post-action listener: _resource_record_post_action 11:27:03 INFO - Running post-action listener: set_extra_try_arguments 11:27:03 INFO - ##### 11:27:03 INFO - ##### Running populate-webroot step. 11:27:03 INFO - ##### 11:27:03 INFO - Running pre-action listener: _resource_record_pre_action 11:27:03 INFO - Running main action method: populate_webroot 11:27:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:27:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:27:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:27:03 INFO - '--tppagecycles', 11:27:03 INFO - '7'], 11:27:03 INFO - 'tests': ['tsvgm']}}, 11:27:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:27:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:27:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:27:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:27:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:27:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:27:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:27:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:03 INFO - 'talos_options': ['--e10s'], 11:27:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:27:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:03 INFO - 'tests': ['damp', 'tps']}, 11:27:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:03 INFO - 'talos_options': ['--e10s'], 11:27:03 INFO - 'tests': ['damp', 'tps']}, 11:27:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:27:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:27:03 INFO - 'other': {'tests': ['a11yr', 11:27:03 INFO - 'ts_paint', 11:27:03 INFO - 'tpaint', 11:27:03 INFO - 'sessionrestore', 11:27:03 INFO - 'sessionrestore_no_auto_restore']}, 11:27:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:27:03 INFO - 'tests': ['a11yr', 11:27:03 INFO - 'ts_paint', 11:27:03 INFO - 'tpaint', 11:27:03 INFO - 'sessionrestore', 11:27:03 INFO - 'sessionrestore_no_auto_restore']}, 11:27:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:27:03 INFO - 'tests': ['a11yr', 11:27:03 INFO - 'ts_paint', 11:27:03 INFO - 'tpaint', 11:27:03 INFO - 'sessionrestore', 11:27:03 INFO - 'sessionrestore_no_auto_restore']}, 11:27:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:27:03 INFO - 'tests': ['a11yr', 11:27:03 INFO - 'ts_paint', 11:27:03 INFO - 'tpaint', 11:27:03 INFO - 'sessionrestore', 11:27:03 INFO - 'sessionrestore_no_auto_restore']}, 11:27:03 INFO - 'other_l64': {'tests': ['a11yr', 11:27:03 INFO - 'ts_paint', 11:27:03 INFO - 'tpaint', 11:27:03 INFO - 'sessionrestore', 11:27:03 INFO - 'sessionrestore_no_auto_restore']}, 11:27:03 INFO - 'other_nol64': {'tests': ['a11yr', 11:27:03 INFO - 'ts_paint', 11:27:03 INFO - 'tpaint', 11:27:03 INFO - 'sessionrestore', 11:27:03 INFO - 'sessionrestore_no_auto_restore']}, 11:27:03 INFO - 'svgr': {'tests': ['tsvgx', 11:27:03 INFO - 'tsvgr_opacity', 11:27:03 INFO - 'tart', 11:27:03 INFO - 'tscrollx', 11:27:03 INFO - 'cart']}, 11:27:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:27:03 INFO - 'tests': ['tsvgx', 11:27:03 INFO - 'tsvgr_opacity', 11:27:03 INFO - 'tart', 11:27:03 INFO - 'tscrollx', 11:27:03 INFO - 'cart']}, 11:27:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:03 INFO - 'tests': ['tp5o']}, 11:27:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:03 INFO - 'talos_options': ['--e10s'], 11:27:03 INFO - 'tests': ['tp5o']}, 11:27:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:03 INFO - 'talos_options': ['--xperf_path', 11:27:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:27:03 INFO - 'tests': ['tp5n']}, 11:27:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:03 INFO - 'talos_options': ['--e10s', 11:27:03 INFO - '--xperf_path', 11:27:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:27:03 INFO - 'tests': ['tp5n']}}, 11:27:03 INFO - 'talos.zip': {'path': '', 11:27:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:27:03 INFO - Running post-action listener: _resource_record_post_action 11:27:03 INFO - ##### 11:27:03 INFO - ##### Running create-virtualenv step. 11:27:03 INFO - ##### 11:27:03 INFO - Running pre-action listener: _resource_record_pre_action 11:27:03 INFO - Running main action method: create_virtualenv 11:27:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:27:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 11:27:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:27:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:27:03 INFO - Using real prefix '/usr' 11:27:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:27:03 INFO - Installing distribute.............................................................................................................................................................................................done. 11:27:05 INFO - Installing pip.................done. 11:27:05 INFO - Return code: 0 11:27:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:27: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')]} 11:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27: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')]} 11:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:05 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 0x7fb454d31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b28660>, '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 0x2b29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29a10>, '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': '232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:27:05 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 11:27:05 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 11:27:05 INFO - Using env: {'DISPLAY': ':0', 11:27:05 INFO - 'HOME': '/home/cltbld', 11:27:05 INFO - 'LANG': 'en_US.UTF-8', 11:27:05 INFO - 'LANGUAGE': 'en_US:en', 11:27:05 INFO - 'LOGNAME': 'cltbld', 11:27:05 INFO - 'MAIL': '/var/mail/cltbld', 11:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:05 INFO - 'MOZ_NO_REMOTE': '1', 11:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:05 INFO - 'NO_EM_RESTART': '1', 11:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:27:05 INFO - 'PWD': '/builds/slave/test-pgo', 11:27:05 INFO - 'SHELL': '/bin/bash', 11:27:05 INFO - 'SHLVL': '1', 11:27:05 INFO - 'TERM': 'linux', 11:27:05 INFO - 'TMOUT': '86400', 11:27:05 INFO - 'USER': 'cltbld', 11:27:05 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461', 11:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:05 INFO - '_': '/tools/buildbot/bin/python'} 11:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:27:06 INFO - Cleaning up... 11:27:06 INFO - Return code: 0 11:27:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb454d31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b28660>, '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 0x2b29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29a10>, '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': '232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:27:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 11:27:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:27:06 INFO - Using env: {'DISPLAY': ':0', 11:27:06 INFO - 'HOME': '/home/cltbld', 11:27:06 INFO - 'LANG': 'en_US.UTF-8', 11:27:06 INFO - 'LANGUAGE': 'en_US:en', 11:27:06 INFO - 'LOGNAME': 'cltbld', 11:27:06 INFO - 'MAIL': '/var/mail/cltbld', 11:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:06 INFO - 'MOZ_NO_REMOTE': '1', 11:27:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:06 INFO - 'NO_EM_RESTART': '1', 11:27:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:27:06 INFO - 'PWD': '/builds/slave/test-pgo', 11:27:06 INFO - 'SHELL': '/bin/bash', 11:27:06 INFO - 'SHLVL': '1', 11:27:06 INFO - 'TERM': 'linux', 11:27:06 INFO - 'TMOUT': '86400', 11:27:06 INFO - 'USER': 'cltbld', 11:27:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461', 11:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:06 INFO - '_': '/tools/buildbot/bin/python'} 11:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:06 INFO - Downloading/unpacking psutil>=0.7.1 11:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:27:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:27:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:27:08 INFO - Installing collected packages: psutil 11:27:08 INFO - Running setup.py install for psutil 11:27:08 INFO - building 'psutil._psutil_linux' extension 11:27:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:27:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:27:08 INFO - building 'psutil._psutil_posix' extension 11:27:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:27:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:27:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:27:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:27:08 INFO - Successfully installed psutil 11:27:08 INFO - Cleaning up... 11:27:08 INFO - Return code: 0 11:27:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:08 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 0x7fb454d31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b28660>, '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 0x2b29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29a10>, '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': '232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:27:08 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 11:27:08 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 11:27:08 INFO - Using env: {'DISPLAY': ':0', 11:27:08 INFO - 'HOME': '/home/cltbld', 11:27:08 INFO - 'LANG': 'en_US.UTF-8', 11:27:08 INFO - 'LANGUAGE': 'en_US:en', 11:27:08 INFO - 'LOGNAME': 'cltbld', 11:27:08 INFO - 'MAIL': '/var/mail/cltbld', 11:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:08 INFO - 'MOZ_NO_REMOTE': '1', 11:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:08 INFO - 'NO_EM_RESTART': '1', 11:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:27:08 INFO - 'PWD': '/builds/slave/test-pgo', 11:27:08 INFO - 'SHELL': '/bin/bash', 11:27:08 INFO - 'SHLVL': '1', 11:27:08 INFO - 'TERM': 'linux', 11:27:08 INFO - 'TMOUT': '86400', 11:27:08 INFO - 'USER': 'cltbld', 11:27:08 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461', 11:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:08 INFO - '_': '/tools/buildbot/bin/python'} 11:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:27: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 11:27: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 11:27: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 11:27: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 11:27: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 11:27: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 11:27:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:27:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:27:10 INFO - Installing collected packages: mozsystemmonitor 11:27:10 INFO - Running setup.py install for mozsystemmonitor 11:27:10 INFO - Successfully installed mozsystemmonitor 11:27:10 INFO - Cleaning up... 11:27:11 INFO - Return code: 0 11:27:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:11 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 0x7fb454d31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b28660>, '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 0x2b29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29a10>, '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': '232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:27:11 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 11:27:11 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 11:27:11 INFO - Using env: {'DISPLAY': ':0', 11:27:11 INFO - 'HOME': '/home/cltbld', 11:27:11 INFO - 'LANG': 'en_US.UTF-8', 11:27:11 INFO - 'LANGUAGE': 'en_US:en', 11:27:11 INFO - 'LOGNAME': 'cltbld', 11:27:11 INFO - 'MAIL': '/var/mail/cltbld', 11:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:11 INFO - 'MOZ_NO_REMOTE': '1', 11:27:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:11 INFO - 'NO_EM_RESTART': '1', 11:27:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:27:11 INFO - 'PWD': '/builds/slave/test-pgo', 11:27:11 INFO - 'SHELL': '/bin/bash', 11:27:11 INFO - 'SHLVL': '1', 11:27:11 INFO - 'TERM': 'linux', 11:27:11 INFO - 'TMOUT': '86400', 11:27:11 INFO - 'USER': 'cltbld', 11:27:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461', 11:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:11 INFO - '_': '/tools/buildbot/bin/python'} 11:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:11 INFO - Downloading/unpacking blobuploader==1.2.4 11:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:13 INFO - Downloading blobuploader-1.2.4.tar.gz 11:27:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:27:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:27:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:13 INFO - Downloading docopt-0.6.1.tar.gz 11:27:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:27:13 INFO - Installing collected packages: blobuploader, requests, docopt 11:27:13 INFO - Running setup.py install for blobuploader 11:27:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:27:13 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:27:13 INFO - Running setup.py install for requests 11:27:14 INFO - Running setup.py install for docopt 11:27:14 INFO - Successfully installed blobuploader requests docopt 11:27:14 INFO - Cleaning up... 11:27:14 INFO - Return code: 0 11:27:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:27: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')]} 11:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27: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')]} 11:27:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:14 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 0x7fb454d31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b28660>, '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 0x2b29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29a10>, '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': '232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:27:14 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 11:27:14 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 11:27:14 INFO - Using env: {'DISPLAY': ':0', 11:27:14 INFO - 'HOME': '/home/cltbld', 11:27:14 INFO - 'LANG': 'en_US.UTF-8', 11:27:14 INFO - 'LANGUAGE': 'en_US:en', 11:27:14 INFO - 'LOGNAME': 'cltbld', 11:27:14 INFO - 'MAIL': '/var/mail/cltbld', 11:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:14 INFO - 'MOZ_NO_REMOTE': '1', 11:27:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:14 INFO - 'NO_EM_RESTART': '1', 11:27:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:27:14 INFO - 'PWD': '/builds/slave/test-pgo', 11:27:14 INFO - 'SHELL': '/bin/bash', 11:27:14 INFO - 'SHLVL': '1', 11:27:14 INFO - 'TERM': 'linux', 11:27:14 INFO - 'TMOUT': '86400', 11:27:14 INFO - 'USER': 'cltbld', 11:27:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461', 11:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:14 INFO - '_': '/tools/buildbot/bin/python'} 11:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:27:14 INFO - Running setup.py (path:/tmp/pip-81stP4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:27:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:27:14 INFO - Running setup.py (path:/tmp/pip-049731-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:27:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:27:14 INFO - Running setup.py (path:/tmp/pip-AUZPCM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:27:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:27:14 INFO - Running setup.py (path:/tmp/pip-x5zRYx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:27:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:27:14 INFO - Running setup.py (path:/tmp/pip-tZB2Ed-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:27:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:27:15 INFO - Running setup.py (path:/tmp/pip-FqWg4Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:27:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:27:15 INFO - Running setup.py (path:/tmp/pip-XNFPiw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:27:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:27:15 INFO - Running setup.py (path:/tmp/pip-wy2ZPz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:27:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:27:15 INFO - Running setup.py (path:/tmp/pip-MywMFW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:27:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:27:15 INFO - Running setup.py (path:/tmp/pip-ZLCvNN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:27:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:27:15 INFO - Running setup.py (path:/tmp/pip-gTVLNl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:27:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:27:15 INFO - Running setup.py (path:/tmp/pip-zpnmFq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:27:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:27:15 INFO - Running setup.py (path:/tmp/pip-2zDdnr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:27:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:27:15 INFO - Running setup.py (path:/tmp/pip-qmvJQc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:27:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:27:15 INFO - Running setup.py (path:/tmp/pip-sswQ5r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:27:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:27:15 INFO - Running setup.py (path:/tmp/pip-q8fpt9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:27:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:27:15 INFO - Running setup.py (path:/tmp/pip-GKXjTk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:27:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:27:15 INFO - Running setup.py install for manifestparser 11:27:15 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:27:15 INFO - Running setup.py install for mozcrash 11:27:16 INFO - Running setup.py install for mozdebug 11:27:16 INFO - Running setup.py install for mozdevice 11:27:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:27:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:27:16 INFO - Running setup.py install for mozfile 11:27:16 INFO - Running setup.py install for mozhttpd 11:27:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:27:16 INFO - Running setup.py install for mozinfo 11:27:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:27:16 INFO - Running setup.py install for mozInstall 11:27:16 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:27:16 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:27:16 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:27:16 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:27:16 INFO - Running setup.py install for mozleak 11:27:16 INFO - Running setup.py install for mozlog 11:27:16 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:27:16 INFO - Running setup.py install for moznetwork 11:27:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:27:17 INFO - Running setup.py install for mozprocess 11:27:17 INFO - Running setup.py install for mozprofile 11:27:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:27:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:27:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:27:17 INFO - Running setup.py install for mozrunner 11:27:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:27:17 INFO - Running setup.py install for mozscreenshot 11:27:17 INFO - Running setup.py install for moztest 11:27:17 INFO - Running setup.py install for mozversion 11:27:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:27:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:27:17 INFO - Cleaning up... 11:27:17 INFO - Return code: 0 11:27:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:17 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 0x7fb454d31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b28660>, '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 0x2b29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29a10>, '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': '232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:27:17 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 11:27:17 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 11:27:17 INFO - Using env: {'DISPLAY': ':0', 11:27:17 INFO - 'HOME': '/home/cltbld', 11:27:17 INFO - 'LANG': 'en_US.UTF-8', 11:27:17 INFO - 'LANGUAGE': 'en_US:en', 11:27:17 INFO - 'LOGNAME': 'cltbld', 11:27:17 INFO - 'MAIL': '/var/mail/cltbld', 11:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:17 INFO - 'MOZ_NO_REMOTE': '1', 11:27:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:17 INFO - 'NO_EM_RESTART': '1', 11:27:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:27:17 INFO - 'PWD': '/builds/slave/test-pgo', 11:27:17 INFO - 'SHELL': '/bin/bash', 11:27:17 INFO - 'SHLVL': '1', 11:27:17 INFO - 'TERM': 'linux', 11:27:17 INFO - 'TMOUT': '86400', 11:27:17 INFO - 'USER': 'cltbld', 11:27:17 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461', 11:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:17 INFO - '_': '/tools/buildbot/bin/python'} 11:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:27:17 INFO - Running setup.py (path:/tmp/pip-EO3WM3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:27:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 11:27:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:27:17 INFO - Running setup.py (path:/tmp/pip-DZQqIO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:27:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:27:18 INFO - Running setup.py (path:/tmp/pip-dpjHUv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 11:27:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:27:18 INFO - Running setup.py (path:/tmp/pip-6fjRMD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:27:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:27:18 INFO - Running setup.py (path:/tmp/pip-hBn6ts-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 11:27:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:27:18 INFO - Running setup.py (path:/tmp/pip-kXgenu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 11:27:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:27:18 INFO - Running setup.py (path:/tmp/pip-5APTsV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 11:27:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:27:18 INFO - Running setup.py (path:/tmp/pip-bKJrXc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 11:27:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:27:18 INFO - Running setup.py (path:/tmp/pip-Q8IwSB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 11:27:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:27:18 INFO - Running setup.py (path:/tmp/pip-BNC4Pz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:27:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:27:18 INFO - Running setup.py (path:/tmp/pip-H3BeFE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 11:27:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:27:18 INFO - Running setup.py (path:/tmp/pip-0JgKNA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 11:27:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:27:18 INFO - Running setup.py (path:/tmp/pip-xL_Xt5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 11:27:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:27:18 INFO - Running setup.py (path:/tmp/pip-gqgxR9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 11:27:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:27:18 INFO - Running setup.py (path:/tmp/pip-UDujxY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 11:27:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:27:19 INFO - Running setup.py (path:/tmp/pip-3rkcuP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 11:27:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:27:19 INFO - Running setup.py (path:/tmp/pip-CXgKrJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 11:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 11:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:27:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:20 INFO - Downloading blessings-1.6.tar.gz 11:27:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:27:21 INFO - Installing collected packages: blessings 11:27:21 INFO - Running setup.py install for blessings 11:27:21 INFO - Successfully installed blessings 11:27:21 INFO - Cleaning up... 11:27:21 INFO - Return code: 0 11:27:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:27:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:27:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:27:21 INFO - Reading from file tmpfile_stdout 11:27:21 INFO - Current package versions: 11:27:21 INFO - argparse == 1.2.1 11:27:21 INFO - blessings == 1.6 11:27:21 INFO - blobuploader == 1.2.4 11:27:21 INFO - docopt == 0.6.1 11:27:21 INFO - manifestparser == 1.1 11:27:21 INFO - mozInstall == 1.12 11:27:21 INFO - mozcrash == 0.16 11:27:21 INFO - mozdebug == 0.1 11:27:21 INFO - mozdevice == 0.48 11:27:21 INFO - mozfile == 1.2 11:27:21 INFO - mozhttpd == 0.7 11:27:21 INFO - mozinfo == 0.9 11:27:21 INFO - mozleak == 0.1 11:27:21 INFO - mozlog == 3.1 11:27:21 INFO - moznetwork == 0.27 11:27:21 INFO - mozprocess == 0.22 11:27:21 INFO - mozprofile == 0.28 11:27:21 INFO - mozrunner == 6.11 11:27:21 INFO - mozscreenshot == 0.1 11:27:21 INFO - mozsystemmonitor == 0.0 11:27:21 INFO - moztest == 0.7 11:27:21 INFO - mozversion == 1.4 11:27:21 INFO - psutil == 3.1.1 11:27:21 INFO - requests == 1.2.3 11:27:21 INFO - wsgiref == 0.1.2 11:27:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:21 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 0x7fb454d31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b28660>, '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 0x2b29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29a10>, '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': '232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:27:21 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 11:27:21 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 11:27:21 INFO - Using env: {'DISPLAY': ':0', 11:27:21 INFO - 'HOME': '/home/cltbld', 11:27:21 INFO - 'LANG': 'en_US.UTF-8', 11:27:21 INFO - 'LANGUAGE': 'en_US:en', 11:27:21 INFO - 'LOGNAME': 'cltbld', 11:27:21 INFO - 'MAIL': '/var/mail/cltbld', 11:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:21 INFO - 'MOZ_NO_REMOTE': '1', 11:27:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:21 INFO - 'NO_EM_RESTART': '1', 11:27:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:27:21 INFO - 'PWD': '/builds/slave/test-pgo', 11:27:21 INFO - 'SHELL': '/bin/bash', 11:27:21 INFO - 'SHLVL': '1', 11:27:21 INFO - 'TERM': 'linux', 11:27:21 INFO - 'TMOUT': '86400', 11:27:21 INFO - 'USER': 'cltbld', 11:27:21 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461', 11:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:21 INFO - '_': '/tools/buildbot/bin/python'} 11:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 11:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 11:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 11:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 11:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 11:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 11:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 11:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 11:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 11:27:21 INFO - Cleaning up... 11:27:21 INFO - Return code: 0 11:27:21 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:21 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 0x7fb454d31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b28660>, '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 0x2b29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29a10>, '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': '232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:27:21 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 11:27:21 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 11:27:21 INFO - Using env: {'DISPLAY': ':0', 11:27:21 INFO - 'HOME': '/home/cltbld', 11:27:21 INFO - 'LANG': 'en_US.UTF-8', 11:27:21 INFO - 'LANGUAGE': 'en_US:en', 11:27:21 INFO - 'LOGNAME': 'cltbld', 11:27:21 INFO - 'MAIL': '/var/mail/cltbld', 11:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:21 INFO - 'MOZ_NO_REMOTE': '1', 11:27:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:21 INFO - 'NO_EM_RESTART': '1', 11:27:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:27:21 INFO - 'PWD': '/builds/slave/test-pgo', 11:27:21 INFO - 'SHELL': '/bin/bash', 11:27:21 INFO - 'SHLVL': '1', 11:27:21 INFO - 'TERM': 'linux', 11:27:21 INFO - 'TMOUT': '86400', 11:27:21 INFO - 'USER': 'cltbld', 11:27:21 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461', 11:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:21 INFO - '_': '/tools/buildbot/bin/python'} 11:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:21 INFO - Downloading/unpacking jsonschema 11:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:27:23 INFO - Downloading/unpacking functools32 (from jsonschema) 11:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:23 INFO - Downloading functools32-3.2.3-2.tar.gz 11:27:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:27:23 INFO - warning: no files found matching '*.txt' 11:27:23 INFO - no previously-included directories found matching 'build' 11:27:23 INFO - no previously-included directories found matching 'dist' 11:27:23 INFO - no previously-included directories found matching '.git*' 11:27:23 INFO - Installing collected packages: jsonschema, functools32 11:27:24 INFO - Running setup.py install for functools32 11:27:24 INFO - warning: no files found matching '*.txt' 11:27:24 INFO - no previously-included directories found matching 'build' 11:27:24 INFO - no previously-included directories found matching 'dist' 11:27:24 INFO - no previously-included directories found matching '.git*' 11:27:24 INFO - Successfully installed jsonschema functools32 11:27:24 INFO - Cleaning up... 11:27:24 INFO - Return code: 0 11:27:24 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:24 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 0x7fb454d31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b28660>, '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 0x2b29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29a10>, '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': '232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:27:24 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 11:27:24 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 11:27:24 INFO - Using env: {'DISPLAY': ':0', 11:27:24 INFO - 'HOME': '/home/cltbld', 11:27:24 INFO - 'LANG': 'en_US.UTF-8', 11:27:24 INFO - 'LANGUAGE': 'en_US:en', 11:27:24 INFO - 'LOGNAME': 'cltbld', 11:27:24 INFO - 'MAIL': '/var/mail/cltbld', 11:27:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:24 INFO - 'MOZ_NO_REMOTE': '1', 11:27:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:24 INFO - 'NO_EM_RESTART': '1', 11:27:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:27:24 INFO - 'PWD': '/builds/slave/test-pgo', 11:27:24 INFO - 'SHELL': '/bin/bash', 11:27:24 INFO - 'SHLVL': '1', 11:27:24 INFO - 'TERM': 'linux', 11:27:24 INFO - 'TMOUT': '86400', 11:27:24 INFO - 'USER': 'cltbld', 11:27:24 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461', 11:27:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:24 INFO - '_': '/tools/buildbot/bin/python'} 11:27:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:24 INFO - Downloading/unpacking flake8 11:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:27:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:27:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:27:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:27:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:27:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:27:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:27:26 INFO - no previously-included directories found matching 'docs/_build' 11:27:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:27:26 INFO - Running setup.py install for pep8 11:27:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:27:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:27:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:27:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:27:27 INFO - no previously-included directories found matching 'docs/_build' 11:27:27 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:27:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:27:27 INFO - Cleaning up... 11:27:27 INFO - Return code: 0 11:27:27 INFO - Running post-action listener: _resource_record_post_action 11:27:27 INFO - Running post-action listener: _start_resource_monitoring 11:27:27 INFO - Starting resource monitoring. 11:27:27 INFO - ##### 11:27:27 INFO - ##### Running install step. 11:27:27 INFO - ##### 11:27:27 INFO - Running pre-action listener: _resource_record_pre_action 11:27:27 INFO - Running main action method: install 11:27:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:27:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:27:27 INFO - Reading from file tmpfile_stdout 11:27:27 INFO - Detecting whether we're running mozinstall >=1.0... 11:27:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:27:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:27:27 INFO - Reading from file tmpfile_stdout 11:27:27 INFO - Output received: 11:27:27 INFO - Usage: mozinstall [options] installer 11:27:27 INFO - Options: 11:27:27 INFO - -h, --help show this help message and exit 11:27:27 INFO - -d DEST, --destination=DEST 11:27:27 INFO - Directory to install application into. [default: 11:27:27 INFO - "/builds/slave/test-pgo"] 11:27:27 INFO - --app=APP Application being installed. [default: firefox] 11:27:27 INFO - mkdir: /builds/slave/test-pgo/build/application 11:27:27 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'] 11:27:27 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 11:27:42 INFO - Reading from file tmpfile_stdout 11:27:42 INFO - Output received: 11:27:42 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:27:42 INFO - Running post-action listener: _resource_record_post_action 11:27:42 INFO - ##### 11:27:42 INFO - ##### Running run-tests step. 11:27:42 INFO - ##### 11:27:42 INFO - Running pre-action listener: _resource_record_pre_action 11:27:42 INFO - Running main action method: run_tests 11:27:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:27:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:27:42 INFO - Python 2.7.3 11:27:42 INFO - Return code: 0 11:27:42 INFO - grabbing minidump binary from tooltool 11:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:42 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 0x2b28660>, '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 0x2b29560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:27:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 11:27:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:27:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:27:42 INFO - Return code: 0 11:27:42 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:27:42 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:27:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:27:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:27:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:27:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:27:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:27:43 INFO - Return code: 0 11:27:43 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/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 11:27:43 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/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 11:27:43 INFO - Using env: {'DISPLAY': ':0', 11:27:43 INFO - 'HOME': '/home/cltbld', 11:27:43 INFO - 'LANG': 'en_US.UTF-8', 11:27:43 INFO - 'LANGUAGE': 'en_US:en', 11:27:43 INFO - 'LOGNAME': 'cltbld', 11:27:43 INFO - 'MAIL': '/var/mail/cltbld', 11:27:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:27:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:43 INFO - 'MOZ_NO_REMOTE': '1', 11:27:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:27:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:43 INFO - 'NO_EM_RESTART': '1', 11:27:43 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:27:43 INFO - 'PWD': '/builds/slave/test-pgo', 11:27:43 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:27:43 INFO - 'SHELL': '/bin/bash', 11:27:43 INFO - 'SHLVL': '1', 11:27:43 INFO - 'TERM': 'linux', 11:27:43 INFO - 'TMOUT': '86400', 11:27:43 INFO - 'USER': 'cltbld', 11:27:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461', 11:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:43 INFO - '_': '/tools/buildbot/bin/python'} 11:27:43 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/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 11:27:43 INFO - mozversion application_buildid: 20160229085316 11:27:43 INFO - mozversion application_changeset: 6aaf9904a81dd8635e056cacb1a4834fe13f9cd3 11:27:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:27:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:27:43 INFO - mozversion application_name: Firefox 11:27:43 INFO - mozversion application_remotingname: firefox-dev 11:27:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:27:43 INFO - mozversion application_vendor: Mozilla 11:27:43 INFO - mozversion application_version: 46.0a2 11:27:43 INFO - mozversion platform_buildid: 20160229085316 11:27:43 INFO - mozversion platform_changeset: 6aaf9904a81dd8635e056cacb1a4834fe13f9cd3 11:27:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:27:43 INFO - mozversion platform_version: 46.0a2 11:27:43 INFO - using testdate: 1456774063 11:27:43 INFO - actual date: 1456774063 11:27:43 INFO - starting webserver on 'localhost:52222' 11:27:43 INFO - SUITE-START | Running 3 tests 11:27:43 INFO - TEST-START | dromaeo_css 11:27:43 INFO - operating with platform_type : linux_ 11:27:43 INFO - Initialising browser for dromaeo_css test... 11:27:43 INFO - TEST-INFO | started process 6216 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu8scb7/profile http://localhost:52222/getInfo.html) 11:27:47 INFO - PROCESS | 6216 | 11:27:47 INFO - PROCESS | 6216 | (process:6294): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:27:48 INFO - PROCESS | 6216 | __metrics Screen width/height:1600/1200 11:27:48 INFO - PROCESS | 6216 | colorDepth:24 11:27:48 INFO - PROCESS | 6216 | Browser inner width/height: 1024/697 11:27:48 INFO - PROCESS | 6216 | __metrics 11:27:49 INFO - TEST-INFO | 6216: exit 0 11:27:49 INFO - Browser initialized. 11:27:49 INFO - Running cycle 1/1 for dromaeo_css test... 11:27:49 INFO - TEST-INFO | started process 6343 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu8scb7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:27:51 INFO - PROCESS | 6343 | 11:27:51 INFO - PROCESS | 6343 | (process:6405): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:28:01 INFO - PROCESS | 6343 | RSS: Main: 141357056 11:28:01 INFO - PROCESS | 6343 | 11:28:51 INFO - PROCESS | 6343 | 1456774131141 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:30:59 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52222/tests/dromaeo/cssquery-ext.html) 11:31:00 INFO - PROCESS | 6343 | RSS: Main: 145252352 11:31:00 INFO - PROCESS | 6343 | 11:34:01 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-ext.html (next: http://localhost:52222/tests/dromaeo/cssquery-jquery.html) 11:34:02 INFO - PROCESS | 6343 | RSS: Main: 143474688 11:34:02 INFO - PROCESS | 6343 | 11:37:04 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52222/tests/dromaeo/cssquery-mootools.html) 11:37:04 INFO - PROCESS | 6343 | RSS: Main: 143708160 11:37:04 INFO - PROCESS | 6343 | 11:40:06 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52222/tests/dromaeo/cssquery-prototype.html) 11:40:07 INFO - PROCESS | 6343 | RSS: Main: 143343616 11:40:07 INFO - PROCESS | 6343 | 11:43:09 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52222/tests/dromaeo/cssquery-yui.html) 11:43:10 INFO - PROCESS | 6343 | RSS: Main: 143613952 11:43:10 INFO - PROCESS | 6343 | 11:46:12 INFO - PROCESS | 6343 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-yui.html (next: http://localhost:52222/tests/dromaeo/cssquery-dojo.html) 11:46:12 INFO - PROCESS | 6343 | RSS: Main: 146665472 11:46:12 INFO - PROCESS | 6343 | 11:46:12 INFO - PROCESS | 6343 | __start_tp_report 11:46:12 INFO - PROCESS | 6343 | _x_x_mozilla_page_load 11:46:12 INFO - PROCESS | 6343 | _x_x_mozilla_page_load_details 11:46:12 INFO - PROCESS | 6343 | |i|pagename|runs| 11:46:12 INFO - PROCESS | 6343 | |0;dojo.html;3338.5326054352395;3374.3926093303194;3398.507216453616;3400.5579274694287;3418.8290585470722;5502.174673798927;5557.972210138953;5581.748821303041;5588.552915766739;5596.664200147989;5544;5574.9721251393685;5579.079451890433;5586.581006424514;5588.050031494646;5089.898202035948;5101.464346243628;5169.043726910515;5174.301469301652;5208.947910520884;4954.455009948902;5083.771230294646;5089.694618322894;5120.283160357553;5167.044096842096;5156.484351564851;5205.427402985669;5216.217567364906;5219.347581552306;5221.477852214786;5169.508896654812;5180.5337519623035;5194.844154675366;5202.583793296527;5245.423003469616;4950.356453661037;4997.950020499785;5078.162103252959;5108.795648174068;5113.054084994288;5324.1215199492035;5362.329708786402;5370.301860758115;5377.0321342158395;5382.327209098863;5942.227510423617;5947.791827286068;5966.463018328372;5988.8502787430225;6007.729652165663;5878.382769809194;5960.284765828128;5971.343152253248;6033.064874944391;6140;5650.85872853182;5657.9434205658235;5669.724312029843;5701.201831743518;5709.286339207599;6117.051856962089;6192.411720886508;6193.040078787795;6202.1937148171355;6203.193584833943;5778.133280008033;5870.501007414332;5910.734016969247;6061.818145455643;6086.239220097488;5926.170336152942;5935.7625694972585;5941.31674857397;5948.821535353946;5955.285365756137;5834.474897259182;5856.560757943172;5905.084711869667;5911.556633252523;5923.141144534018;5831.358550559435;5858.384869588717;5872.559558033079;5905.261842269716;5913.46778789911;4521.886952826206;4539.046800171935;4553.931691024637;4555.954440455619;4579.564941330568;3993.0815912339745;4037.7981100944835;4068.4100805383646;4086.1214838809797;4105.199486100241;5665.716714164275;5673.971630141823;5675.290588676416;5686.061799802987;5716.971415142898;6039.486643635252;6117.265928088658;6118.082287656887;6123.357047510036;6126.877462450726;5462.126059830488;5567.498925096761;5674.177244299636;5727.627704199213;5741.110127930177;5029.220470827027;5035.899282014339;5037.19404895215;5039.798408063636;5066.341375621219;5934.554908381889;5947.821565353046;5981.700914954235;5989.401059893976;5993.970030149909;5843.2695913010875;5878.764849405976;5995.010823214121;6093.756249750138;6164.568480206342;6153.169322141633;6218.9378106218355;6219.906701399392;6224.906626400517;6242.968785156045;5893.557983151367;5942.31663358702;5998.070299103646;6011.819645410645;6026.186464827192;5781;5947.6431414115295;5949.7802950395935;5950.821475355746;5961.672108034099;5796.101604251347;5804.477597016289;5818.44724751148;5840.357560668408;5890.911636325544;5800.361960184461;5806.216160818235;5821.330546987151;5827;5827.970860145672;5628.521575665951;5722.484976352148;5742.253507044057;5790.478856902899;5916.615419997686;5864.501517371071;5865.14955331466;5867.20792692998;5900.203472531153;5910.290765108214;5705.286839145107;5731.083026715705;5745.511631511368;5761.308642962704;5778.566607504538 11:46:12 INFO - PROCESS | 6343 | |1;ext.html;535.2479765928871;561.6265183652871;564.4327450911833;582.956278279129;593.9991114971274;30662.233444163878;38137.80931095344;38728.419073713914;38859;38953.610463895355;45718.54281457193;46941;47003.76498117513;47047.29429058567;47194.52805471953;8943.731688049369;9154.267658587298;9205.30960177986;9209.907900921005;9218;8887.644494220223;8948.239399651038;9025.232855207316;9060.320475964296;9070.319726020542;8983.685571005017;9101.40840845343;9167.633294668205;9185.265178785714;9192.98877123516;9020;9030.638774448982;9048.457092574467;9074.45553266806;9109.635614575409;8781.736547903573;8984.371094023421;9031.909680903173;9055.954720226422;9056.230220431271;41726.1654766906;42618.786906065274;42984.35523467151;42997.35503967443;43030.139397212195;3682.3739964206147;3696.2237930034726;3753.2868754936476;3770.26479836432;3932.390479475686;32100.851257391532;32135.357292854245;32174.356512869846;32303.83848080768;32764.6723532764;4121.216968775953;4126.277901367249;4142.809529257855;4203.579642035803;4217.304144816102;289102;289643;289771;291343;291693;45228.77385613051;64409.67795160994;65208;65474;65492.67253663701;57504;57552.136717949266;57623.42376576264;57761.55596110131;57771.71114144402;16371.836281637032;16372.345106195618;16533.256003479873;16582.17089145538;16644.3342266308;12285.754284914252;12323.507059717691;12329.630111096682;12482.126251162514;12496.87503124957;20974.580508389747;21013.26453574148;21030.57938841245;21039.263625773023;21117.89441052785;7497.512661676974;7506.622020090981;7543;7606.619669016638;7609.6575654095695;1025.4308858583559;1097.24838485636;1097.91765617579;1123.1576317761678;1158.9246698964541;31263.374732505676;31308.686913131034;31353.216169595944;32089.839550802095;32218.19454513656;1167.8948894599357;1229.8954588859867;1276.2278821313157;1280.6414204022888;1283.1210620724833;15657.921710391374;15740.60648483797;15944.681106377808;16129.516114516584;16370.263338149813;479079;482707;491382;492121.53939230077;492975;50194.74902625536;50690;50865;50929.23606145911;51001.489985100416;1442.8701416872323;1453.6801903581195;1476.5596160944972;1478.3938585180024;1482.05148704829;29558;30291.242718932204;30866.382672346877;30959.226019349695;31757.523637145;46252;46362.53637463717;46690.29964550603;46706.53293467158;47115.05769884652;209897;211738;211909;212249;212728;31612.683873160975;31738;32306.35387292194;32320.191995199366;32491.837540812143;46864.297035545176;47978.080876764536;48081;48210;48225.276620851415;39269.60730392774;39750;39802.60197397989;39811.40282895817;40937.59062409338;37574.43638345372;40325.79837100796;40731.38902916518;40797.38803917884;41274.79362603168;38611.227775444895;39021;39089;39191.2161756769;39563.80218098891;32943.50584741279;33232.335353292314;33532.49701254532;33763;33876.49185262174;24786.62820057737;25546.489070218864;26750.732492674822;27053.458930821667;27232.591511126953 11:46:12 INFO - PROCESS | 6343 | |2;jquery.html;388.21580407576704;389.3925476257041;390.759682795081;397.0767964482579;399.4487607102202;15543.222838858068;16420.850540462172;16571.83428165718;19122.521936951565;19166.71249931252;11584.768304633903;12345;12607.936960315186;17815.37646182384;17962.281508739667;4791.616670666356;5074.898502029957;5236.947630523703;5255.343082114736;5309.575233981292;5183.118869792125;5240.633155679104;5278.630495865291;5279.155335146377;5286.788528458857;5083.898322033557;5624.100143976964;5627.212190293362;5629.577781666391;5634.0703783875615;5356.678599284055;5559.9444005559835;5592.7762889484375;5597.160425936101;5617.241672374238;5060.418051924039;5061.316722242524;5071;5091.66904151229;5097.311862898536;19709.211631534723;20334.288299909433;21140.260090896743;21203.36389908305;21216.151353945977;1931.5750534882443;2286.302677683306;2292.56441276157;2304.5275718477674;2368.325027367192;9978.850317245247;10007.349522281102;10033.444816053512;10182.439965801877;10206.285560010801;1863.170888954416;1904.476269026015;1960.6274807786474;1970.6748386516208;1989.2242025610024;54289;54854;55545;59314.40685593132;60806.39193608096;10398.480075996169;10760.354378737144;10824.567017319376;10837.83743243852;10869.076128529163;14678.559643210507;14705.485308014167;14751.704965900622;14854.70290594182;14867.702645947236;8071.798205044804;8091.959540202261;8131.14622964592;8158.469699469515;8164.591770411455;7578.696852125963;7645.464817462725;7673.079230492265;7673.232676732394;7720.45956783031;4773.474917759044;4875.390576177978;4895.997447300717;4904.2643603459765;4921.212605983025;1964.8526360522733;1966.6853303471376;1967.4687834284948;1975.565375617362;1979.1984246380239;998.4708104704519;1020.4540570794737;1070.400575677623;1107.3743335015852;1114.1142791480793;17472.563185920455;17545.29818807259;17600.471985840446;17803.910980445016;18134.45596632103;1002.4236064263077;1012.4785735346303;1025.374521541859;1050.7478205230689;1113.732704150998;7904.6838126474295;10391.116755075753;10429.852716201212;10445.425501597334;10503.107235884883;506821;507979;523197;554873;557016;72003.27996720071;75620;75794.62102689451;75979.24020759722;76237.23762762413;1059.6609085092696;1091.110744743032;1125.4597793059377;1172.865120511135;1176.6058370445996;14974.251287435802;15815.16271378903;16437.09595972233;16487.34050638009;16507.174641268128;34377;34676.47985280273;35209.82395088008;35736.821315893256;36219.63780362268;40054.79972600118;40314.798426007685;40561;41854.16291674088;43536;7762.5730584818375;8002.279794818494;8022.318102961313;8067.193280671886;8131.146229645802;10150.289479736643;11292.604758833402;11615.303081815118;11698.181127321006;12242.449089791158;10014.849777253201;10158.847617285599;10559.102476289601;10586.735331616772;10640;9908.256880734118;10135.7466063349;10245.590176392861;10260;10474.162067034771;10372.792544149226;10384.169266458513;10433.739156521147;10457.9477102614;10514.947425262824;7938.722144724907;8016.95991520062;8097.554634495159;8194.713185038496;8265.132161122996;10457.790844182922;10881.183911206534;10956.561737530728;11005.119590432907;11099.278546894426 11:46:12 INFO - PROCESS | 6343 | |3;mootools.html;1479.4673917389741;1497.1391449916298;1658.668266346731;1794.9551261218476;1822.9544261393455;7789.182135875736;7825.843483130334;7900.170482099383;7922.088959769614;7981.241782030705;8057.19428057194;8115.553644549547;8150.75547733569;8163.714270000552;8222.588870556478;2397.952040959184;2409.867457289857;2413.3966508372905;2414.6619473273754;2424.212131057405;2417.867017314047;2435.038159926828;2441.121196369306;2445.144199530168;2455.877206139695;2291.8510296830655;2368.9763102369016;2369.4431808524982;2390.366552863484;2412.360724408033;2337.053493335202;2395.4490467192554;2398.2445529658103;2402.1712509184304;2405.434722840131;2405.194259922928;2417.3231495181203;2434.4522482441484;2438.1100898172217;2438.987805060981;7951.642176102089;7966.681332746741;7999.320057795095;8012.919870801334;8013.198680131998;4785.569298763093;4923.138450771101;4926.729029903389;4933.062718083553;4944.678595891256;3107.192130046204;3114.9688503114903;3130.264387868849;3148.4175427545747;3164.7942883712485;993.4138858073699;1006.6527048168371;1044.4412239451856;1070.1011150633506;1107.0479387726548;10823.729406764895;10910.345379277269;10936.945315273453;10966.670999870017;11040.944795276053;4263.424437700933;4335.761533115646;4355.128974205171;4360.127974405132;4391.6486681065435;8927.732168034969;9007.729768106967;9024.232940200156;9043.77390565228;9072.727818165466;4884.902301954012;4900.950990490121;4920.8769780755765;4924.482929292444;4988.775505102279;4568.291914753218;4568.428946381702;4574.908501830011;4586.770661466913;4589.724616523019;3520.5247291615306;3574.267275208576;3602.85588576454;3604.4953706481115;3621.3662609043313;1070.208046045936;1092.2900114925362;1094.5731164845718;1103.001783386037;1106.6016234155697;1383.7855132454486;1387.3756809435592;1400.0479673821899;1405.2341473896752;1425.543825975678;7496.400287976949;7613.352865006536;7653.808654783675;7674.769756907302;7680.769576912701;1141.8686851012073;1148.8334191542347;1152.8731839497648;1160.8548931383577;1163.7730642524627;5964.7315870785915;5971.7611295547695;5992.131140984533;6007.849803754853;6036;8990.145936136056;9617.086376794194;9688.12806847373;9690.12788849007;9842.065003824626;9633.373830700983;9644.18024467914;9669.081437263449;9686.70939871805;9713.320067595341;7254.637268136572;7567.054118235221;7587.810304742426;7609.086909570776;7636.08366995964;7311.561306321638;7382.9630851845395;7409.740659076906;7497.362724168507;7533.962330188314;8618.655253789779;8709.259712924473;8715.956420217859;8780.341474389319;8813.589825627869;8372.916270837457;8957.865632015655;8960.86558701607;8991.235744961752;9003.729888103368;7379.483436159632;7428.182899880901;7439.218882017527;7472.364848987897;7490.812729681802;7257.782266532013;7387.039684841151;7396.9260307396235;7459.254074592497;7516.962415187889;7065.788026359218;7097.432205423451;7121.109861267341;7230.927690723025;7355.926440735739;6807.319268073153;6992.2308546058875;7032.894506582303;7089.858202836018;7164.426845852424;7048.471364647569;7167.068281123421;7221.061262035902;7225.421966242793;7236.565806051653;6598.60408375499;6655;6667.599944003376;6673.899891501728;6730.5625134368065;6890.138732658418;6931.4108300795;6957.408620267334;6973.12835895513;6987.9301206987275 11:46:12 INFO - PROCESS | 6343 | |4;prototype.html;360.4233226837061;369.7485709717391;370.18189800540813;371.2667481723596;376.45978021539094;6355;6381.904271435927;6401.39186777256;6448.903266451007;6548.869022619545;6378.904316435257;6395.520335974809;6423.1328770615955;6432.807015789522;6512.120863683402;4875.463698993108;4891.021795640868;4897.7795999180125;4911.066897289522;4916.754162291871;4917.606591472673;4917.704937703749;4921.950780492185;4926.827561035347;4939.25911113334;4730.763461826912;4750.97624511877;4817.108834865561;4833.3958255218095;4844.394450693663;4831.685940413897;4845.709257444564;4852.296417019547;4853.587445067174;4856.830010949635;4234;4237.597428244312;4238.788060596958;4246.830126794925;4251.766152861592;6030.03519436888;6040.426159514839;6059.454649081604;6068.9062273515565;6092.238470191226;5559.8888022239735;5682.829515114512;5690.004249256405;5695.886082278373;5697.9715101424645;6693.6318502482345;6767.221769496522;6793.864122717518;6799.11611490508;6810.250872404032;4656.906861862778;4720.0559888022535;4721.929171062437;4726.26742854858;4739.36018637483;6979.4765392595755;7045.718171273143;7135.5361901476235;7149.14210294768;7153.177384600734;4779.259214821708;4802.231642937113;4807.855764327006;4808.807647694123;4814.9518504815205;4865.756712164378;4871.585915197177;4873.415190177201;4874.512548745097;4885.218365061644;5623.831285061455;5642.7178641067785;5648.802291919763;5649.209110724501;5663.886722265532;6700.237795495869;6802.6258555779905;6832.0776695146515;6886.380225779704;6891.4486841053595;1706.9061201634029;1723.9051852148252;1725.5427311762394;1727.4558514068028;1735;1111.8165502691966;1134.2910680824484;1136.187625847523;1158.3571118029574;1179.3277831635885;6591.934080659228;6604.2074951005225;6604.933950660528;6611.404973552403;6632.1046658701425;7042;7086.291370862872;7087.787366379017;7100.786976390613;7101.538400003983;6380.361963803675;6398.552101352953;6490.545661803629;6587;6616.3714447128405;3798.3352913240074;3832.693384529231;3857.807109644563;3867.9749866285456;3872.206197729459;7345.559266443924;7378.225286344964;7393.260673932564;7420.628968551551;7420.628968551551;7164.0328555645365;7313.524620899624;7357.742479013209;7369.742059027908;7390.076240469942;7367.852642947111;7370.6683199255085;7380.446466515033;7383.335499804936;7392.928025436174;6857.657117144223;7130.857382852418;7134.607596582237;7139.785806425815;7159.821004474721;7013.088298521159;7032.12098487689;7039.577625342496;7084.787456376317;7093.255208203064;7369.631518424165;7425;7427.8143046424275;7432.702691892264;7439.665215065444;4929.309896614549;4954.1825598775795;4998.60011199096;5011.148104822262;5045.11710450677;7052.753153639598;7075.080239568823;7106.253843346374;7106.7157313706875;7115.786526404217;6812.863742725217;6850.451963842781;6868.313168683291;6873.2783057778215;6900.758473453405;6757.864842703217;6759.99180364733;6829.351211634887;6833;6892.586444813327;6724.562903411263;6737.461003119836;6757.3242675734;6757.3580509853455;6762.459003279628;6869.141357330333;6883.65581720922;6887.276835932155;6888.621125837926;6896.827579310357;6564.015397690385;6661.700223490052;6686.3313668632745;6729;6729.125213722381 11:46:12 INFO - PROCESS | 6343 | |5;yui.html;843.7679638099522;931.2782593490044;937.7889974755681;956.5026186383085;958.4393130018939;13990.930045349773;14072.085314454553;14149.434022639094;14154.71690566188;14157;13768.655783605414;13805.585832425018;13821.308934553283;13865.861341386582;13994.860051399482;869.1395518436734;884.0673089890163;884.305819931354;905.0632595263903;922.0594993107027;918.3296193778546;919.2232563483846;922.5617831530037;923.4505469245788;926.263620421763;936.7143021378477;939.1876027236425;939.1969865764776;939.8825146856643;942.1661829281102;929.3866048408086;933.5192375926404;934.1405906565908;934.4206591912989;935.4667839331584;693.4313862632644;693.4868197533839;698.6541661877352;699.7096205074888;701.3302296307014;15096.924515377354;15140.848591514054;15166.848331516654;15182.164980926045;15263.389464421522;13014.414351354117;13308.134971226937;13473.461061557526;13652;13678;11417.94291028548;12394.62816115518;12428.254304741744;12503.312317822516;12816.48734050646;3663.688586470153;3714.461403096536;3714.647108524686;3750.49368335274;3804.1250512382308;50163.24755128676;51057;51064.234036489484;51487.74256128733;51881.481185188044;10510.684679459628;10699.679009629723;10966.506507207196;10977.83533247002;11052.447377631086;18577.53556161107;18685.532861678566;18710.906445467685;18713.81286187148;18802.52993675169;8045.678172873137;8108.310793582612;8110.797230069177;8161.551114688749;8166.877496837552;4594.081183763261;4706.10583989041;4706.458757242961;4793.784279707422;4880.755962201947;3117.875284988575;3133.6239651242;3137.1372872460256;3139.748820094387;3140.733037691776;568.4940403041296;570.2586637371401;571.5713215088683;576.7260551238128;590.8759160576327;613.414189449075;679.4598294355999;735.9632018399166;754.528419737664;782.4170992610542;9500.287478439144;9520.095590918852;9546.474943878015;9654.806903861883;9679.37084089546;607.7903123422412;610.7282259394527;735.1252010107954;778.6729573579111;802.6227672993683;4332.783360831946;4406.625436837905;4644.00153966892;4691.50739172382;4694.155052090657;58963;59795.701021495486;60489;60693.69653151706;60894;52740.20889686658;53857;54154;54681.72659136679;55072;48574.75712621414;48629.756851216225;48713.756431218324;49056.264156036974;49461;9199.264058875407;9238.399504032217;9331.393459425115;9336.206422453895;9521.523923803921;35952;36178.8191059043;36586;36997.26005479929;37273.627263727016;45291.77354113208;47442.28836567523;47460.7626961863;47477.52522474731;47989.76005119952;12504.187227830162;12513.499460021498;12813.615591532269;12893.806592901301;12946.870531294566;13174.736505270033;13399.464021439033;13488.325583720578;13536.187828730308;13602.591922241952;12600.11799174049;12855.485780568673;12867.292298923649;12921.160124591872;13412.798808017693;12090.697732556757;12128.09039322072;12163.087768417226;12244.448999794853;12347.62957111288;12117.636470905887;12357.75284494287;12827.037972152313;13061.934690326487;13456.25990570528;9612.279079068958;10049.346792458467;10193.796124077626;10459.94770026145;10739.409332486475;10609.20430967665;10872;11000.834987475035;11122.721931951442;11191.216614836883 11:46:12 INFO - PROCESS | 6343 | __end_tp_report 11:46:12 INFO - PROCESS | 6343 | __start_cc_report 11:46:12 INFO - PROCESS | 6343 | _x_x_mozilla_cycle_collect,303 11:46:12 INFO - PROCESS | 6343 | __end_cc_report 11:46:12 INFO - PROCESS | 6343 | __startTimestamp1456775172489__endTimestamp 11:46:12 INFO - PROCESS | 6343 | 11:46:12 INFO - PROCESS | 6343 | ------- Summary: start ------- 11:46:12 INFO - PROCESS | 6343 | Number of tests: 6 11:46:12 INFO - PROCESS | 6343 | 11:46:12 INFO - PROCESS | 6343 | [#0] dojo.html Cycles:165 Average:5552.11 Median:5778.13 stddev:611.99 (10.6%) stddev-sans-first:588.71 11:46:12 INFO - PROCESS | 6343 | Values: 3338.5 3374.4 3398.5 3400.6 3418.8 5502.2 5558.0 5581.7 5588.6 5596.7 5544.0 5575.0 5579.1 5586.6 5588.1 5089.9 5101.5 5169.0 5174.3 5208.9 4954.5 5083.8 5089.7 5120.3 5167.0 5156.5 5205.4 5216.2 5219.3 5221.5 5169.5 5180.5 5194.8 5202.6 5245.4 4950.4 4998.0 5078.2 5108.8 5113.1 5324.1 5362.3 5370.3 5377.0 5382.3 5942.2 5947.8 5966.5 5988.9 6007.7 5878.4 5960.3 5971.3 6033.1 6140.0 5650.9 5657.9 5669.7 5701.2 5709.3 6117.1 6192.4 6193.0 6202.2 6203.2 5778.1 5870.5 5910.7 6061.8 6086.2 5926.2 5935.8 5941.3 5948.8 5955.3 5834.5 5856.6 5905.1 5911.6 5923.1 5831.4 5858.4 5872.6 5905.3 5913.5 4521.9 4539.0 4553.9 4556.0 4579.6 3993.1 4037.8 4068.4 4086.1 4105.2 5665.7 5674.0 5675.3 5686.1 5717.0 6039.5 6117.3 6118.1 6123.4 6126.9 5462.1 5567.5 5674.2 5727.6 5741.1 5029.2 5035.9 5037.2 5039.8 5066.3 5934.6 5947.8 5981.7 5989.4 5994.0 5843.3 5878.8 5995.0 6093.8 6164.6 6153.2 6218.9 6219.9 6224.9 6243.0 5893.6 5942.3 5998.1 6011.8 6026.2 5781.0 5947.6 5949.8 5950.8 5961.7 5796.1 5804.5 5818.4 5840.4 5890.9 5800.4 5806.2 5821.3 5827.0 5828.0 5628.5 5722.5 5742.3 5790.5 5916.6 5864.5 5865.1 5867.2 5900.2 5910.3 5705.3 5731.1 5745.5 5761.3 5778.6 11:46:12 INFO - PROCESS | 6343 | 11:46:12 INFO - PROCESS | 6343 | [#1] ext.html Cycles:180 Average:50469.58 Median:21748.10 stddev:92602.45 (425.8%) stddev-sans-first:92786.33 11:46:12 INFO - PROCESS | 6343 | Values: 535.2 561.6 564.4 583.0 594.0 30662.2 38137.8 38728.4 38859.0 38953.6 45718.5 46941.0 47003.8 47047.3 47194.5 8943.7 9154.3 9205.3 9209.9 9218.0 8887.6 8948.2 9025.2 9060.3 9070.3 8983.7 9101.4 9167.6 9185.3 9193.0 9020.0 9030.6 9048.5 9074.5 9109.6 8781.7 8984.4 9031.9 9056.0 9056.2 41726.2 42618.8 42984.4 42997.4 43030.1 3682.4 3696.2 3753.3 3770.3 3932.4 32100.9 32135.4 32174.4 32303.8 32764.7 4121.2 4126.3 4142.8 4203.6 4217.3 289102.0 289643.0 289771.0 291343.0 291693.0 45228.8 64409.7 65208.0 65474.0 65492.7 57504.0 57552.1 57623.4 57761.6 57771.7 16371.8 16372.3 16533.3 16582.2 16644.3 12285.8 12323.5 12329.6 12482.1 12496.9 20974.6 21013.3 21030.6 21039.3 21117.9 7497.5 7506.6 7543.0 7606.6 7609.7 1025.4 1097.2 1097.9 1123.2 1158.9 31263.4 31308.7 31353.2 32089.8 32218.2 1167.9 1229.9 1276.2 1280.6 1283.1 15657.9 15740.6 15944.7 16129.5 16370.3 479079.0 482707.0 491382.0 492121.5 492975.0 50194.7 50690.0 50865.0 50929.2 51001.5 1442.9 1453.7 1476.6 1478.4 1482.1 29558.0 30291.2 30866.4 30959.2 31757.5 46252.0 46362.5 46690.3 46706.5 47115.1 209897.0 211738.0 211909.0 212249.0 212728.0 31612.7 31738.0 32306.4 32320.2 32491.8 46864.3 47978.1 48081.0 48210.0 48225.3 39269.6 39750.0 39802.6 39811.4 40937.6 37574.4 40325.8 40731.4 40797.4 41274.8 38611.2 39021.0 39089.0 39191.2 39563.8 32943.5 33232.3 33532.5 33763.0 33876.5 24786.6 25546.5 26750.7 27053.5 27232.6 11:46:12 INFO - PROCESS | 6343 | 11:46:12 INFO - PROCESS | 6343 | [#2] jquery.html Cycles:180 Average:27687.88 Median:21209.76 stddev:86629.67 (408.4%) stddev-sans-first:86848.44 11:46:12 INFO - PROCESS | 6343 | Values: 388.2 389.4 390.8 397.1 399.4 15543.2 16420.9 16571.8 19122.5 19166.7 11584.8 12345.0 12607.9 17815.4 17962.3 4791.6 5074.9 5236.9 5255.3 5309.6 5183.1 5240.6 5278.6 5279.2 5286.8 5083.9 5624.1 5627.2 5629.6 5634.1 5356.7 5559.9 5592.8 5597.2 5617.2 5060.4 5061.3 5071.0 5091.7 5097.3 19709.2 20334.3 21140.3 21203.4 21216.2 1931.6 2286.3 2292.6 2304.5 2368.3 9978.9 10007.3 10033.4 10182.4 10206.3 1863.2 1904.5 1960.6 1970.7 1989.2 54289.0 54854.0 55545.0 59314.4 60806.4 10398.5 10760.4 10824.6 10837.8 10869.1 14678.6 14705.5 14751.7 14854.7 14867.7 8071.8 8092.0 8131.1 8158.5 8164.6 7578.7 7645.5 7673.1 7673.2 7720.5 4773.5 4875.4 4896.0 4904.3 4921.2 1964.9 1966.7 1967.5 1975.6 1979.2 998.5 1020.5 1070.4 1107.4 1114.1 17472.6 17545.3 17600.5 17803.9 18134.5 1002.4 1012.5 1025.4 1050.7 1113.7 7904.7 10391.1 10429.9 10445.4 10503.1 506821.0 507979.0 523197.0 554873.0 557016.0 72003.3 75620.0 75794.6 75979.2 76237.2 1059.7 1091.1 1125.5 1172.9 1176.6 14974.3 15815.2 16437.1 16487.3 16507.2 34377.0 34676.5 35209.8 35736.8 36219.6 40054.8 40314.8 40561.0 41854.2 43536.0 7762.6 8002.3 8022.3 8067.2 8131.1 10150.3 11292.6 11615.3 11698.2 12242.4 10014.8 10158.8 10559.1 10586.7 10640.0 9908.3 10135.7 10245.6 10260.0 10474.2 10372.8 10384.2 10433.7 10457.9 10514.9 7938.7 8017.0 8097.6 8194.7 8265.1 10457.8 10881.2 10956.6 11005.1 11099.3 11:46:12 INFO - PROCESS | 6343 | 11:46:12 INFO - PROCESS | 6343 | [#3] mootools.html Cycles:180 Average:5639.70 Median:6661.30 stddev:2880.77 (43.2%) stddev-sans-first:2871.87 11:46:12 INFO - PROCESS | 6343 | Values: 1479.5 1497.1 1658.7 1795.0 1823.0 7789.2 7825.8 7900.2 7922.1 7981.2 8057.2 8115.6 8150.8 8163.7 8222.6 2398.0 2409.9 2413.4 2414.7 2424.2 2417.9 2435.0 2441.1 2445.1 2455.9 2291.9 2369.0 2369.4 2390.4 2412.4 2337.1 2395.4 2398.2 2402.2 2405.4 2405.2 2417.3 2434.5 2438.1 2439.0 7951.6 7966.7 7999.3 8012.9 8013.2 4785.6 4923.1 4926.7 4933.1 4944.7 3107.2 3115.0 3130.3 3148.4 3164.8 993.4 1006.7 1044.4 1070.1 1107.0 10823.7 10910.3 10936.9 10966.7 11040.9 4263.4 4335.8 4355.1 4360.1 4391.6 8927.7 9007.7 9024.2 9043.8 9072.7 4884.9 4901.0 4920.9 4924.5 4988.8 4568.3 4568.4 4574.9 4586.8 4589.7 3520.5 3574.3 3602.9 3604.5 3621.4 1070.2 1092.3 1094.6 1103.0 1106.6 1383.8 1387.4 1400.0 1405.2 1425.5 7496.4 7613.4 7653.8 7674.8 7680.8 1141.9 1148.8 1152.9 1160.9 1163.8 5964.7 5971.8 5992.1 6007.8 6036.0 8990.1 9617.1 9688.1 9690.1 9842.1 9633.4 9644.2 9669.1 9686.7 9713.3 7254.6 7567.1 7587.8 7609.1 7636.1 7311.6 7383.0 7409.7 7497.4 7534.0 8618.7 8709.3 8716.0 8780.3 8813.6 8372.9 8957.9 8960.9 8991.2 9003.7 7379.5 7428.2 7439.2 7472.4 7490.8 7257.8 7387.0 7396.9 7459.3 7517.0 7065.8 7097.4 7121.1 7230.9 7355.9 6807.3 6992.2 7032.9 7089.9 7164.4 7048.5 7167.1 7221.1 7225.4 7236.6 6598.6 6655.0 6667.6 6673.9 6730.6 6890.1 6931.4 6957.4 6973.1 6987.9 11:46:12 INFO - PROCESS | 6343 | 11:46:12 INFO - PROCESS | 6343 | [#4] prototype.html Cycles:180 Average:5721.90 Median:6501.33 stddev:1738.88 (26.7%) stddev-sans-first:1696.55 11:46:12 INFO - PROCESS | 6343 | Values: 360.4 369.7 370.2 371.3 376.5 6355.0 6381.9 6401.4 6448.9 6548.9 6378.9 6395.5 6423.1 6432.8 6512.1 4875.5 4891.0 4897.8 4911.1 4916.8 4917.6 4917.7 4922.0 4926.8 4939.3 4730.8 4751.0 4817.1 4833.4 4844.4 4831.7 4845.7 4852.3 4853.6 4856.8 4234.0 4237.6 4238.8 4246.8 4251.8 6030.0 6040.4 6059.5 6068.9 6092.2 5559.9 5682.8 5690.0 5695.9 5698.0 6693.6 6767.2 6793.9 6799.1 6810.3 4656.9 4720.1 4721.9 4726.3 4739.4 6979.5 7045.7 7135.5 7149.1 7153.2 4779.3 4802.2 4807.9 4808.8 4815.0 4865.8 4871.6 4873.4 4874.5 4885.2 5623.8 5642.7 5648.8 5649.2 5663.9 6700.2 6802.6 6832.1 6886.4 6891.4 1706.9 1723.9 1725.5 1727.5 1735.0 1111.8 1134.3 1136.2 1158.4 1179.3 6591.9 6604.2 6604.9 6611.4 6632.1 7042.0 7086.3 7087.8 7100.8 7101.5 6380.4 6398.6 6490.5 6587.0 6616.4 3798.3 3832.7 3857.8 3868.0 3872.2 7345.6 7378.2 7393.3 7420.6 7420.6 7164.0 7313.5 7357.7 7369.7 7390.1 7367.9 7370.7 7380.4 7383.3 7392.9 6857.7 7130.9 7134.6 7139.8 7159.8 7013.1 7032.1 7039.6 7084.8 7093.3 7369.6 7425.0 7427.8 7432.7 7439.7 4929.3 4954.2 4998.6 5011.1 5045.1 7052.8 7075.1 7106.3 7106.7 7115.8 6812.9 6850.5 6868.3 6873.3 6900.8 6757.9 6760.0 6829.4 6833.0 6892.6 6724.6 6737.5 6757.3 6757.4 6762.5 6869.1 6883.7 6887.3 6888.6 6896.8 6564.0 6661.7 6686.3 6729.0 6729.1 11:46:12 INFO - PROCESS | 6343 | 11:46:12 INFO - PROCESS | 6343 | [#5] yui.html Cycles:180 Average:14781.61 Median:4700.13 stddev:16741.16 (356.2%) stddev-sans-first:16755.40 11:46:12 INFO - PROCESS | 6343 | Values: 843.8 931.3 937.8 956.5 958.4 13990.9 14072.1 14149.4 14154.7 14157.0 13768.7 13805.6 13821.3 13865.9 13994.9 869.1 884.1 884.3 905.1 922.1 918.3 919.2 922.6 923.5 926.3 936.7 939.2 939.2 939.9 942.2 929.4 933.5 934.1 934.4 935.5 693.4 693.5 698.7 699.7 701.3 15096.9 15140.8 15166.8 15182.2 15263.4 13014.4 13308.1 13473.5 13652.0 13678.0 11417.9 12394.6 12428.3 12503.3 12816.5 3663.7 3714.5 3714.6 3750.5 3804.1 50163.2 51057.0 51064.2 51487.7 51881.5 10510.7 10699.7 10966.5 10977.8 11052.4 18577.5 18685.5 18710.9 18713.8 18802.5 8045.7 8108.3 8110.8 8161.6 8166.9 4594.1 4706.1 4706.5 4793.8 4880.8 3117.9 3133.6 3137.1 3139.7 3140.7 568.5 570.3 571.6 576.7 590.9 613.4 679.5 736.0 754.5 782.4 9500.3 9520.1 9546.5 9654.8 9679.4 607.8 610.7 735.1 778.7 802.6 4332.8 4406.6 4644.0 4691.5 4694.2 58963.0 59795.7 60489.0 60693.7 60894.0 52740.2 53857.0 54154.0 54681.7 55072.0 48574.8 48629.8 48713.8 49056.3 49461.0 9199.3 9238.4 9331.4 9336.2 9521.5 35952.0 36178.8 36586.0 36997.3 37273.6 45291.8 47442.3 47460.8 47477.5 47989.8 12504.2 12513.5 12813.6 12893.8 12946.9 13174.7 13399.5 13488.3 13536.2 13602.6 12600.1 12855.5 12867.3 12921.2 13412.8 12090.7 12128.1 12163.1 12244.4 12347.6 12117.6 12357.8 12827.0 13061.9 13456.3 9612.3 10049.3 10193.8 10459.9 10739.4 10609.2 10872.0 11000.8 11122.7 11191.2 11:46:12 INFO - PROCESS | 6343 | -------- Summary: end -------- 11:46:12 INFO - PROCESS | 6343 | 11:46:13 INFO - TEST-INFO | 6343: exit 0 11:46:13 INFO - TEST-OK | dromaeo_css | took 1109342ms 11:46:13 INFO - TEST-START | kraken 11:46:13 INFO - operating with platform_type : linux_ 11:46:13 INFO - Initialising browser for kraken test... 11:46:13 INFO - TEST-INFO | started process 6585 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiV4VwO/profile http://localhost:52222/getInfo.html) 11:46:16 INFO - PROCESS | 6585 | 11:46:16 INFO - PROCESS | 6585 | (process:6666): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:46:17 INFO - PROCESS | 6585 | __metrics Screen width/height:1600/1200 11:46:17 INFO - PROCESS | 6585 | colorDepth:24 11:46:17 INFO - PROCESS | 6585 | Browser inner width/height: 1024/697 11:46:17 INFO - PROCESS | 6585 | __metrics 11:46:18 INFO - TEST-INFO | 6585: exit 0 11:46:18 INFO - Browser initialized. 11:46:18 INFO - Running cycle 1/1 for kraken test... 11:46:18 INFO - TEST-INFO | started process 6715 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiV4VwO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:46:19 INFO - PROCESS | 6715 | 11:46:19 INFO - PROCESS | 6715 | (process:6777): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:46:30 INFO - PROCESS | 6715 | RSS: Main: 141070336 11:46:30 INFO - PROCESS | 6715 | 11:46:32 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52222/tests/kraken/driver.html?testName=audio-beat-detection) 11:46:33 INFO - PROCESS | 6715 | RSS: Main: 146112512 11:46:33 INFO - PROCESS | 6715 | 11:46:35 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52222/tests/kraken/driver.html?testName=audio-dft) 11:46:36 INFO - PROCESS | 6715 | RSS: Main: 145485824 11:46:36 INFO - PROCESS | 6715 | 11:46:39 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52222/tests/kraken/driver.html?testName=audio-fft) 11:46:39 INFO - PROCESS | 6715 | RSS: Main: 145530880 11:46:39 INFO - PROCESS | 6715 | 11:46:41 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52222/tests/kraken/driver.html?testName=audio-oscillator) 11:46:42 INFO - PROCESS | 6715 | RSS: Main: 144670720 11:46:42 INFO - PROCESS | 6715 | 11:46:44 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52222/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:46:45 INFO - PROCESS | 6715 | RSS: Main: 144703488 11:46:45 INFO - PROCESS | 6715 | 11:46:48 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52222/tests/kraken/driver.html?testName=imaging-darkroom) 11:46:48 INFO - PROCESS | 6715 | RSS: Main: 145317888 11:46:48 INFO - PROCESS | 6715 | 11:46:52 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52222/tests/kraken/driver.html?testName=imaging-desaturate) 11:46:52 INFO - PROCESS | 6715 | RSS: Main: 145924096 11:46:52 INFO - PROCESS | 6715 | 11:46:55 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52222/tests/kraken/driver.html?testName=json-parse-financial) 11:46:55 INFO - PROCESS | 6715 | RSS: Main: 145199104 11:46:56 INFO - PROCESS | 6715 | 11:46:57 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52222/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:46:58 INFO - PROCESS | 6715 | RSS: Main: 144596992 11:46:58 INFO - PROCESS | 6715 | 11:46:59 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:47:00 INFO - PROCESS | 6715 | RSS: Main: 146898944 11:47:00 INFO - PROCESS | 6715 | 11:47:02 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:47:03 INFO - PROCESS | 6715 | RSS: Main: 146939904 11:47:03 INFO - PROCESS | 6715 | 11:47:05 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:47:06 INFO - PROCESS | 6715 | RSS: Main: 147017728 11:47:06 INFO - PROCESS | 6715 | 11:47:08 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:47:09 INFO - PROCESS | 6715 | RSS: Main: 146997248 11:47:09 INFO - PROCESS | 6715 | 11:47:10 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52222/tests/kraken/driver.html?testName=ai-astar) 11:47:11 INFO - PROCESS | 6715 | RSS: Main: 147628032 11:47:11 INFO - PROCESS | 6715 | 11:47:11 INFO - PROCESS | 6715 | __start_tp_report 11:47:11 INFO - PROCESS | 6715 | _x_x_mozilla_page_load 11:47:11 INFO - PROCESS | 6715 | _x_x_mozilla_page_load_details 11:47:11 INFO - PROCESS | 6715 | |i|pagename|runs| 11:47:11 INFO - PROCESS | 6715 | |0;ai-astar;111;104;112;111;111;122;111;111;111;111 11:47:11 INFO - PROCESS | 6715 | |1;audio-beat-detection;158;125;158;154;126;152;157;131;172;129 11:47:11 INFO - PROCESS | 6715 | |2;audio-dft;161;162;162;162;163;163;162;160;163;161 11:47:11 INFO - PROCESS | 6715 | |3;audio-fft;75;75;76;154;74;75;76;77;161;73 11:47:11 INFO - PROCESS | 6715 | |4;audio-oscillator;96;96;137;95;95;95;134;95;95;136 11:47:11 INFO - PROCESS | 6715 | |5;imaging-gaussian-blur;111;110;110;110;109;110;109;109;109;109 11:47:11 INFO - PROCESS | 6715 | |6;imaging-darkroom;147;146;147;147;147;147;147;146;147;147 11:47:11 INFO - PROCESS | 6715 | |7;imaging-desaturate;97;96;96;96;97;96;97;98;97;96 11:47:11 INFO - PROCESS | 6715 | |8;json-parse-financial;54;58;56;55;56;56;55;62;57;57 11:47:11 INFO - PROCESS | 6715 | |9;json-stringify-tinderbox;63;64;64;64;64;64;64;65;64;65 11:47:11 INFO - PROCESS | 6715 | |10;stanford-crypto-aes;83;84;84;89;89;91;82;82;84;82 11:47:11 INFO - PROCESS | 6715 | |11;stanford-crypto-ccm;114;113;113;115;123;113;119;120;113;126 11:47:11 INFO - PROCESS | 6715 | |12;stanford-crypto-pbkdf2;138;140;136;137;148;138;127;137;143;141 11:47:11 INFO - PROCESS | 6715 | |13;stanford-crypto-sha256-iterative;65;66;64;68;67;76;64;65;66;66 11:47:11 INFO - PROCESS | 6715 | __end_tp_report 11:47:11 INFO - PROCESS | 6715 | __start_cc_report 11:47:11 INFO - PROCESS | 6715 | _x_x_mozilla_cycle_collect,723 11:47:11 INFO - PROCESS | 6715 | __end_cc_report 11:47:11 INFO - PROCESS | 6715 | __startTimestamp1456775231126__endTimestamp 11:47:11 INFO - PROCESS | 6715 | 11:47:11 INFO - PROCESS | 6715 | ------- Summary: start ------- 11:47:11 INFO - PROCESS | 6715 | Number of tests: 14 11:47:11 INFO - PROCESS | 6715 | 11:47:11 INFO - PROCESS | 6715 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.00 stddev:4.33 (3.9%) stddev-sans-first:4.59 11:47:11 INFO - PROCESS | 6715 | Values: 111.0 104.0 112.0 111.0 111.0 122.0 111.0 111.0 111.0 111.0 11:47:11 INFO - PROCESS | 6715 | 11:47:11 INFO - PROCESS | 6715 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:155.50 stddev:16.80 (10.8%) stddev-sans-first:17.27 11:47:11 INFO - PROCESS | 6715 | Values: 158.0 125.0 158.0 154.0 126.0 152.0 157.0 131.0 172.0 129.0 11:47:11 INFO - PROCESS | 6715 | 11:47:11 INFO - PROCESS | 6715 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.00 11:47:11 INFO - PROCESS | 6715 | Values: 161.0 162.0 162.0 162.0 163.0 163.0 162.0 160.0 163.0 161.0 11:47:11 INFO - PROCESS | 6715 | 11:47:11 INFO - PROCESS | 6715 | [#3] audio-fft Cycles:10 Average:91.60 Median:75.00 stddev:34.79 (46.4%) stddev-sans-first:36.38 11:47:11 INFO - PROCESS | 6715 | Values: 75.0 75.0 76.0 154.0 74.0 75.0 76.0 77.0 161.0 73.0 11:47:11 INFO - PROCESS | 6715 | 11:47:11 INFO - PROCESS | 6715 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:95.00 stddev:19.52 (20.6%) stddev-sans-first:20.27 11:47:11 INFO - PROCESS | 6715 | Values: 96.0 96.0 137.0 95.0 95.0 95.0 134.0 95.0 95.0 136.0 11:47:11 INFO - PROCESS | 6715 | 11:47:11 INFO - PROCESS | 6715 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 11:47:11 INFO - PROCESS | 6715 | Values: 111.0 110.0 110.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 11:47:11 INFO - PROCESS | 6715 | 11:47:11 INFO - PROCESS | 6715 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 11:47:11 INFO - PROCESS | 6715 | Values: 147.0 146.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 11:47:11 INFO - PROCESS | 6715 | 11:47:11 INFO - PROCESS | 6715 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 11:47:11 INFO - PROCESS | 6715 | Values: 97.0 96.0 96.0 96.0 97.0 96.0 97.0 98.0 97.0 96.0 11:47:11 INFO - PROCESS | 6715 | 11:47:11 INFO - PROCESS | 6715 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.50 stddev:2.22 (3.9%) stddev-sans-first:2.15 11:47:11 INFO - PROCESS | 6715 | Values: 54.0 58.0 56.0 55.0 56.0 56.0 55.0 62.0 57.0 57.0 11:47:11 INFO - PROCESS | 6715 | 11:47:11 INFO - PROCESS | 6715 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 11:47:11 INFO - PROCESS | 6715 | Values: 63.0 64.0 64.0 64.0 64.0 64.0 64.0 65.0 64.0 65.0 11:47:11 INFO - PROCESS | 6715 | 11:47:11 INFO - PROCESS | 6715 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.00 stddev:3.37 (4.0%) stddev-sans-first:3.49 11:47:11 INFO - PROCESS | 6715 | Values: 83.0 84.0 84.0 89.0 89.0 91.0 82.0 82.0 84.0 82.0 11:47:11 INFO - PROCESS | 6715 | 11:47:11 INFO - PROCESS | 6715 | [#11] stanford-crypto-ccm Cycles:10 Average:116.90 Median:117.00 stddev:4.79 (4.1%) stddev-sans-first:4.97 11:47:11 INFO - PROCESS | 6715 | Values: 114.0 113.0 113.0 115.0 123.0 113.0 119.0 120.0 113.0 126.0 11:47:11 INFO - PROCESS | 6715 | 11:47:11 INFO - PROCESS | 6715 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.50 Median:139.00 stddev:5.40 (3.9%) stddev-sans-first:5.73 11:47:11 INFO - PROCESS | 6715 | Values: 138.0 140.0 136.0 137.0 148.0 138.0 127.0 137.0 143.0 141.0 11:47:11 INFO - PROCESS | 6715 | 11:47:11 INFO - PROCESS | 6715 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.00 stddev:3.50 (5.3%) stddev-sans-first:3.66 11:47:11 INFO - PROCESS | 6715 | Values: 65.0 66.0 64.0 68.0 67.0 76.0 64.0 65.0 66.0 66.0 11:47:11 INFO - PROCESS | 6715 | -------- Summary: end -------- 11:47:11 INFO - PROCESS | 6715 | 11:47:12 INFO - TEST-INFO | 6715: exit 0 11:47:12 INFO - TEST-OK | kraken | took 58905ms 11:47:12 INFO - TEST-START | v8_7 11:47:12 INFO - operating with platform_type : linux_ 11:47:12 INFO - Initialising browser for v8_7 test... 11:47:12 INFO - TEST-INFO | started process 7005 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpI9wjVq/profile http://localhost:52222/getInfo.html) 11:47:15 INFO - PROCESS | 7005 | 11:47:15 INFO - PROCESS | 7005 | (process:7088): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:47:16 INFO - PROCESS | 7005 | __metrics Screen width/height:1600/1200 11:47:16 INFO - PROCESS | 7005 | colorDepth:24 11:47:16 INFO - PROCESS | 7005 | Browser inner width/height: 1024/697 11:47:16 INFO - PROCESS | 7005 | __metrics 11:47:17 INFO - TEST-INFO | 7005: exit 0 11:47:17 INFO - Browser initialized. 11:47:17 INFO - Running cycle 1/1 for v8_7 test... 11:47:17 INFO - TEST-INFO | started process 7137 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpI9wjVq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:47:18 INFO - PROCESS | 7137 | 11:47:18 INFO - PROCESS | 7137 | (process:7201): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:47:29 INFO - PROCESS | 7137 | RSS: Main: 141443072 11:47:29 INFO - PROCESS | 7137 | 11:47:51 INFO - PROCESS | 7137 | Cycle 1(1): loaded http://localhost:52222/tests/v8_7/run.html (next: http://localhost:52222/tests/v8_7/run.html) 11:47:51 INFO - PROCESS | 7137 | RSS: Main: 145285120 11:47:51 INFO - PROCESS | 7137 | 11:47:51 INFO - PROCESS | 7137 | __start_tp_report 11:47:51 INFO - PROCESS | 7137 | _x_x_mozilla_page_load 11:47:51 INFO - PROCESS | 7137 | _x_x_mozilla_page_load_details 11:47:51 INFO - PROCESS | 7137 | |i|pagename|runs| 11:47:51 INFO - PROCESS | 7137 | |0;Richards;170.15484090522375 11:47:51 INFO - PROCESS | 7137 | |1;DeltaBlue;170.32873445750297 11:47:51 INFO - PROCESS | 7137 | |2;Encrypt;278.9400278940028 11:47:51 INFO - PROCESS | 7137 | |3;Decrypt;5196.891191709845 11:47:51 INFO - PROCESS | 7137 | |4;RayTrace;939.8496240601504 11:47:51 INFO - PROCESS | 7137 | |5;Earley;561.1672278338945 11:47:51 INFO - PROCESS | 7137 | |6;Boyer;11133.333333333334 11:47:51 INFO - PROCESS | 7137 | |7;RegExp;39038.46153846154 11:47:51 INFO - PROCESS | 7137 | |8;Splay;524.3838489774515 11:47:51 INFO - PROCESS | 7137 | |9;NavierStokes;4826.923076923077 11:47:51 INFO - PROCESS | 7137 | __end_tp_report 11:47:51 INFO - PROCESS | 7137 | __startTimestamp1456775271957__endTimestamp 11:47:51 INFO - PROCESS | 7137 | 11:47:51 INFO - PROCESS | 7137 | ------- Summary: start ------- 11:47:51 INFO - PROCESS | 7137 | Number of tests: 10 11:47:51 INFO - PROCESS | 7137 | 11:47:51 INFO - PROCESS | 7137 | [#0] Richards Cycles:1 Average:170.15 Median:170.15 stddev:0.00 (0.0%) 11:47:51 INFO - PROCESS | 7137 | Values: 170.2 11:47:51 INFO - PROCESS | 7137 | 11:47:51 INFO - PROCESS | 7137 | [#1] DeltaBlue Cycles:1 Average:170.33 Median:170.33 stddev:0.00 (0.0%) 11:47:51 INFO - PROCESS | 7137 | Values: 170.3 11:47:51 INFO - PROCESS | 7137 | 11:47:51 INFO - PROCESS | 7137 | [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 11:47:51 INFO - PROCESS | 7137 | Values: 278.9 11:47:51 INFO - PROCESS | 7137 | 11:47:51 INFO - PROCESS | 7137 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 11:47:51 INFO - PROCESS | 7137 | Values: 5196.9 11:47:51 INFO - PROCESS | 7137 | 11:47:51 INFO - PROCESS | 7137 | [#4] RayTrace Cycles:1 Average:939.85 Median:939.85 stddev:0.00 (0.0%) 11:47:51 INFO - PROCESS | 7137 | Values: 939.8 11:47:51 INFO - PROCESS | 7137 | 11:47:51 INFO - PROCESS | 7137 | [#5] Earley Cycles:1 Average:561.17 Median:561.17 stddev:0.00 (0.0%) 11:47:51 INFO - PROCESS | 7137 | Values: 561.2 11:47:51 INFO - PROCESS | 7137 | 11:47:51 INFO - PROCESS | 7137 | [#6] Boyer Cycles:1 Average:11133.33 Median:11133.33 stddev:0.00 (0.0%) 11:47:51 INFO - PROCESS | 7137 | Values: 11133.3 11:47:51 INFO - PROCESS | 7137 | 11:47:51 INFO - PROCESS | 7137 | [#7] RegExp Cycles:1 Average:39038.46 Median:39038.46 stddev:0.00 (0.0%) 11:47:51 INFO - PROCESS | 7137 | Values: 39038.5 11:47:51 INFO - PROCESS | 7137 | 11:47:51 INFO - PROCESS | 7137 | [#8] Splay Cycles:1 Average:524.38 Median:524.38 stddev:0.00 (0.0%) 11:47:51 INFO - PROCESS | 7137 | Values: 524.4 11:47:51 INFO - PROCESS | 7137 | 11:47:51 INFO - PROCESS | 7137 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 11:47:51 INFO - PROCESS | 7137 | Values: 4826.9 11:47:51 INFO - PROCESS | 7137 | -------- Summary: end -------- 11:47:51 INFO - PROCESS | 7137 | 11:47:52 INFO - TEST-INFO | 7137: exit 0 11:47:52 INFO - TEST-OK | v8_7 | took 40834ms 11:47:52 INFO - SUITE-END | took 1209s 11:47:53 INFO - Completed test suite (00:20:09) 11:47:53 INFO - Working with test: dromaeo_css 11:47:53 INFO - Generating results file: dromaeo_css 11:47:53 INFO - Working with test: kraken 11:47:53 INFO - Generating results file: kraken 11:47:53 INFO - javascript benchmark 11:47:53 INFO - Working with test: v8_7 11:47:53 INFO - Generating results file: v8_7 11:47:53 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:47:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 11:47:58 INFO - process_Request line: dromaeo_css 7304.30 graph.html#tests=[[72,52,43]] 11:47:58 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:47:58 INFO - process_Request line: kraken 1499.40 graph.html#tests=[[232,52,43]] 11:47:58 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:47:58 INFO - process_Request line: v8_7 21944.08 graph.html#tests=[[230,52,43]] 11:47:58 INFO - RETURN: dromaeo_css: 7304.30 11:47:58 INFO - RETURN: kraken: 1499.40 11:47:58 INFO - RETURN: v8_7: 21944.08 11:47:58 INFO - javascript benchmark 11:47:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3338.5326054352395, 3374.3926093303194, 3398.507216453616, 3400.5579274694287, 3418.8290585470722, 5502.174673798927, 5557.972210138953, 5581.748821303041, 5588.552915766739, 5596.664200147989, 5544.0, 5574.9721251393685, 5579.079451890433, 5586.581006424514, 5588.050031494646, 5089.898202035948, 5101.464346243628, 5169.043726910515, 5174.301469301652, 5208.947910520884, 4954.455009948902, 5083.771230294646, 5089.694618322894, 5120.283160357553, 5167.044096842096, 5156.484351564851, 5205.427402985669, 5216.217567364906, 5219.347581552306, 5221.477852214786, 5169.508896654812, 5180.5337519623035, 5194.844154675366, 5202.583793296527, 5245.423003469616, 4950.356453661037, 4997.950020499785, 5078.162103252959, 5108.795648174068, 5113.054084994288, 5324.1215199492035, 5362.329708786402, 5370.301860758115, 5377.0321342158395, 5382.327209098863, 5942.227510423617, 5947.791827286068, 5966.463018328372, 5988.8502787430225, 6007.729652165663, 5878.382769809194, 5960.284765828128, 5971.343152253248, 6033.064874944391, 6140.0, 5650.85872853182, 5657.9434205658235, 5669.724312029843, 5701.201831743518, 5709.286339207599, 6117.051856962089, 6192.411720886508, 6193.040078787795, 6202.1937148171355, 6203.193584833943, 5778.133280008033, 5870.501007414332, 5910.734016969247, 6061.818145455643, 6086.239220097488, 5926.170336152942, 5935.7625694972585, 5941.31674857397, 5948.821535353946, 5955.285365756137, 5834.474897259182, 5856.560757943172, 5905.084711869667, 5911.556633252523, 5923.141144534018, 5831.358550559435, 5858.384869588717, 5872.559558033079, 5905.261842269716, 5913.46778789911, 4521.886952826206, 4539.046800171935, 4553.931691024637, 4555.954440455619, 4579.564941330568, 3993.0815912339745, 4037.7981100944835, 4068.4100805383646, 4086.1214838809797, 4105.199486100241, 5665.716714164275, 5673.971630141823, 5675.290588676416, 5686.061799802987, 5716.971415142898, 6039.486643635252, 6117.265928088658, 6118.082287656887, 6123.357047510036, 6126.877462450726, 5462.126059830488, 5567.498925096761, 5674.177244299636, 5727.627704199213, 5741.110127930177, 5029.220470827027, 5035.899282014339, 5037.19404895215, 5039.798408063636, 5066.341375621219, 5934.554908381889, 5947.821565353046, 5981.700914954235, 5989.401059893976, 5993.970030149909, 5843.2695913010875, 5878.764849405976, 5995.010823214121, 6093.756249750138, 6164.568480206342, 6153.169322141633, 6218.9378106218355, 6219.906701399392, 6224.906626400517, 6242.968785156045, 5893.557983151367, 5942.31663358702, 5998.070299103646, 6011.819645410645, 6026.186464827192, 5781.0, 5947.6431414115295, 5949.7802950395935, 5950.821475355746, 5961.672108034099, 5796.101604251347, 5804.477597016289, 5818.44724751148, 5840.357560668408, 5890.911636325544, 5800.361960184461, 5806.216160818235, 5821.330546987151, 5827.0, 5827.970860145672, 5628.521575665951, 5722.484976352148, 5742.253507044057, 5790.478856902899, 5916.615419997686, 5864.501517371071, 5865.14955331466, 5867.20792692998, 5900.203472531153, 5910.290765108214, 5705.286839145107, 5731.083026715705, 5745.511631511368, 5761.308642962704, 5778.566607504538], "unit": "score", "name": "dojo.html", "value": 5512.730412064294}, {"lowerIsBetter": false, "replicates": [535.2479765928871, 561.6265183652871, 564.4327450911833, 582.956278279129, 593.9991114971274, 30662.233444163878, 38137.80931095344, 38728.419073713914, 38859.0, 38953.610463895355, 45718.54281457193, 46941.0, 47003.76498117513, 47047.29429058567, 47194.52805471953, 8943.731688049369, 9154.267658587298, 9205.30960177986, 9209.907900921005, 9218.0, 8887.644494220223, 8948.239399651038, 9025.232855207316, 9060.320475964296, 9070.319726020542, 8983.685571005017, 9101.40840845343, 9167.633294668205, 9185.265178785714, 9192.98877123516, 9020.0, 9030.638774448982, 9048.457092574467, 9074.45553266806, 9109.635614575409, 8781.736547903573, 8984.371094023421, 9031.909680903173, 9055.954720226422, 9056.230220431271, 41726.1654766906, 42618.786906065274, 42984.35523467151, 42997.35503967443, 43030.139397212195, 3682.3739964206147, 3696.2237930034726, 3753.2868754936476, 3770.26479836432, 3932.390479475686, 32100.851257391532, 32135.357292854245, 32174.356512869846, 32303.83848080768, 32764.6723532764, 4121.216968775953, 4126.277901367249, 4142.809529257855, 4203.579642035803, 4217.304144816102, 289102.0, 289643.0, 289771.0, 291343.0, 291693.0, 45228.77385613051, 64409.67795160994, 65208.0, 65474.0, 65492.67253663701, 57504.0, 57552.136717949266, 57623.42376576264, 57761.55596110131, 57771.71114144402, 16371.836281637032, 16372.345106195618, 16533.256003479873, 16582.17089145538, 16644.3342266308, 12285.754284914252, 12323.507059717691, 12329.630111096682, 12482.126251162514, 12496.87503124957, 20974.580508389747, 21013.26453574148, 21030.57938841245, 21039.263625773023, 21117.89441052785, 7497.512661676974, 7506.622020090981, 7543.0, 7606.619669016638, 7609.6575654095695, 1025.4308858583559, 1097.24838485636, 1097.91765617579, 1123.1576317761678, 1158.9246698964541, 31263.374732505676, 31308.686913131034, 31353.216169595944, 32089.839550802095, 32218.19454513656, 1167.8948894599357, 1229.8954588859867, 1276.2278821313157, 1280.6414204022888, 1283.1210620724833, 15657.921710391374, 15740.60648483797, 15944.681106377808, 16129.516114516584, 16370.263338149813, 479079.0, 482707.0, 491382.0, 492121.53939230077, 492975.0, 50194.74902625536, 50690.0, 50865.0, 50929.23606145911, 51001.489985100416, 1442.8701416872323, 1453.6801903581195, 1476.5596160944972, 1478.3938585180024, 1482.05148704829, 29558.0, 30291.242718932204, 30866.382672346877, 30959.226019349695, 31757.523637145, 46252.0, 46362.53637463717, 46690.29964550603, 46706.53293467158, 47115.05769884652, 209897.0, 211738.0, 211909.0, 212249.0, 212728.0, 31612.683873160975, 31738.0, 32306.35387292194, 32320.191995199366, 32491.837540812143, 46864.297035545176, 47978.080876764536, 48081.0, 48210.0, 48225.276620851415, 39269.60730392774, 39750.0, 39802.60197397989, 39811.40282895817, 40937.59062409338, 37574.43638345372, 40325.79837100796, 40731.38902916518, 40797.38803917884, 41274.79362603168, 38611.227775444895, 39021.0, 39089.0, 39191.2161756769, 39563.80218098891, 32943.50584741279, 33232.335353292314, 33532.49701254532, 33763.0, 33876.49185262174, 24786.62820057737, 25546.489070218864, 26750.732492674822, 27053.458930821667, 27232.591511126953], "unit": "score", "name": "ext.html", "value": 19507.10308376424}, {"lowerIsBetter": false, "replicates": [388.21580407576704, 389.3925476257041, 390.759682795081, 397.0767964482579, 399.4487607102202, 15543.222838858068, 16420.850540462172, 16571.83428165718, 19122.521936951565, 19166.71249931252, 11584.768304633903, 12345.0, 12607.936960315186, 17815.37646182384, 17962.281508739667, 4791.616670666356, 5074.898502029957, 5236.947630523703, 5255.343082114736, 5309.575233981292, 5183.118869792125, 5240.633155679104, 5278.630495865291, 5279.155335146377, 5286.788528458857, 5083.898322033557, 5624.100143976964, 5627.212190293362, 5629.577781666391, 5634.0703783875615, 5356.678599284055, 5559.9444005559835, 5592.7762889484375, 5597.160425936101, 5617.241672374238, 5060.418051924039, 5061.316722242524, 5071.0, 5091.66904151229, 5097.311862898536, 19709.211631534723, 20334.288299909433, 21140.260090896743, 21203.36389908305, 21216.151353945977, 1931.5750534882443, 2286.302677683306, 2292.56441276157, 2304.5275718477674, 2368.325027367192, 9978.850317245247, 10007.349522281102, 10033.444816053512, 10182.439965801877, 10206.285560010801, 1863.170888954416, 1904.476269026015, 1960.6274807786474, 1970.6748386516208, 1989.2242025610024, 54289.0, 54854.0, 55545.0, 59314.40685593132, 60806.39193608096, 10398.480075996169, 10760.354378737144, 10824.567017319376, 10837.83743243852, 10869.076128529163, 14678.559643210507, 14705.485308014167, 14751.704965900622, 14854.70290594182, 14867.702645947236, 8071.798205044804, 8091.959540202261, 8131.14622964592, 8158.469699469515, 8164.591770411455, 7578.696852125963, 7645.464817462725, 7673.079230492265, 7673.232676732394, 7720.45956783031, 4773.474917759044, 4875.390576177978, 4895.997447300717, 4904.2643603459765, 4921.212605983025, 1964.8526360522733, 1966.6853303471376, 1967.4687834284948, 1975.565375617362, 1979.1984246380239, 998.4708104704519, 1020.4540570794737, 1070.400575677623, 1107.3743335015852, 1114.1142791480793, 17472.563185920455, 17545.29818807259, 17600.471985840446, 17803.910980445016, 18134.45596632103, 1002.4236064263077, 1012.4785735346303, 1025.374521541859, 1050.7478205230689, 1113.732704150998, 7904.6838126474295, 10391.116755075753, 10429.852716201212, 10445.425501597334, 10503.107235884883, 506821.0, 507979.0, 523197.0, 554873.0, 557016.0, 72003.27996720071, 75620.0, 75794.62102689451, 75979.24020759722, 76237.23762762413, 1059.6609085092696, 1091.110744743032, 1125.4597793059377, 1172.865120511135, 1176.6058370445996, 14974.251287435802, 15815.16271378903, 16437.09595972233, 16487.34050638009, 16507.174641268128, 34377.0, 34676.47985280273, 35209.82395088008, 35736.821315893256, 36219.63780362268, 40054.79972600118, 40314.798426007685, 40561.0, 41854.16291674088, 43536.0, 7762.5730584818375, 8002.279794818494, 8022.318102961313, 8067.193280671886, 8131.146229645802, 10150.289479736643, 11292.604758833402, 11615.303081815118, 11698.181127321006, 12242.449089791158, 10014.849777253201, 10158.847617285599, 10559.102476289601, 10586.735331616772, 10640.0, 9908.256880734118, 10135.7466063349, 10245.590176392861, 10260.0, 10474.162067034771, 10372.792544149226, 10384.169266458513, 10433.739156521147, 10457.9477102614, 10514.947425262824, 7938.722144724907, 8016.95991520062, 8097.554634495159, 8194.713185038496, 8265.132161122996, 10457.790844182922, 10881.183911206534, 10956.561737530728, 11005.119590432907, 11099.278546894426], "unit": "score", "name": "jquery.html", "value": 8557.949494218126}, {"lowerIsBetter": false, "replicates": [1479.4673917389741, 1497.1391449916298, 1658.668266346731, 1794.9551261218476, 1822.9544261393455, 7789.182135875736, 7825.843483130334, 7900.170482099383, 7922.088959769614, 7981.241782030705, 8057.19428057194, 8115.553644549547, 8150.75547733569, 8163.714270000552, 8222.588870556478, 2397.952040959184, 2409.867457289857, 2413.3966508372905, 2414.6619473273754, 2424.212131057405, 2417.867017314047, 2435.038159926828, 2441.121196369306, 2445.144199530168, 2455.877206139695, 2291.8510296830655, 2368.9763102369016, 2369.4431808524982, 2390.366552863484, 2412.360724408033, 2337.053493335202, 2395.4490467192554, 2398.2445529658103, 2402.1712509184304, 2405.434722840131, 2405.194259922928, 2417.3231495181203, 2434.4522482441484, 2438.1100898172217, 2438.987805060981, 7951.642176102089, 7966.681332746741, 7999.320057795095, 8012.919870801334, 8013.198680131998, 4785.569298763093, 4923.138450771101, 4926.729029903389, 4933.062718083553, 4944.678595891256, 3107.192130046204, 3114.9688503114903, 3130.264387868849, 3148.4175427545747, 3164.7942883712485, 993.4138858073699, 1006.6527048168371, 1044.4412239451856, 1070.1011150633506, 1107.0479387726548, 10823.729406764895, 10910.345379277269, 10936.945315273453, 10966.670999870017, 11040.944795276053, 4263.424437700933, 4335.761533115646, 4355.128974205171, 4360.127974405132, 4391.6486681065435, 8927.732168034969, 9007.729768106967, 9024.232940200156, 9043.77390565228, 9072.727818165466, 4884.902301954012, 4900.950990490121, 4920.8769780755765, 4924.482929292444, 4988.775505102279, 4568.291914753218, 4568.428946381702, 4574.908501830011, 4586.770661466913, 4589.724616523019, 3520.5247291615306, 3574.267275208576, 3602.85588576454, 3604.4953706481115, 3621.3662609043313, 1070.208046045936, 1092.2900114925362, 1094.5731164845718, 1103.001783386037, 1106.6016234155697, 1383.7855132454486, 1387.3756809435592, 1400.0479673821899, 1405.2341473896752, 1425.543825975678, 7496.400287976949, 7613.352865006536, 7653.808654783675, 7674.769756907302, 7680.769576912701, 1141.8686851012073, 1148.8334191542347, 1152.8731839497648, 1160.8548931383577, 1163.7730642524627, 5964.7315870785915, 5971.7611295547695, 5992.131140984533, 6007.849803754853, 6036.0, 8990.145936136056, 9617.086376794194, 9688.12806847373, 9690.12788849007, 9842.065003824626, 9633.373830700983, 9644.18024467914, 9669.081437263449, 9686.70939871805, 9713.320067595341, 7254.637268136572, 7567.054118235221, 7587.810304742426, 7609.086909570776, 7636.08366995964, 7311.561306321638, 7382.9630851845395, 7409.740659076906, 7497.362724168507, 7533.962330188314, 8618.655253789779, 8709.259712924473, 8715.956420217859, 8780.341474389319, 8813.589825627869, 8372.916270837457, 8957.865632015655, 8960.86558701607, 8991.235744961752, 9003.729888103368, 7379.483436159632, 7428.182899880901, 7439.218882017527, 7472.364848987897, 7490.812729681802, 7257.782266532013, 7387.039684841151, 7396.9260307396235, 7459.254074592497, 7516.962415187889, 7065.788026359218, 7097.432205423451, 7121.109861267341, 7230.927690723025, 7355.926440735739, 6807.319268073153, 6992.2308546058875, 7032.894506582303, 7089.858202836018, 7164.426845852424, 7048.471364647569, 7167.068281123421, 7221.061262035902, 7225.421966242793, 7236.565806051653, 6598.60408375499, 6655.0, 6667.599944003376, 6673.899891501728, 6730.5625134368065, 6890.138732658418, 6931.4108300795, 6957.408620267334, 6973.12835895513, 6987.9301206987275], "unit": "score", "name": "mootools.html", "value": 4657.437267771504}, {"lowerIsBetter": false, "replicates": [360.4233226837061, 369.7485709717391, 370.18189800540813, 371.2667481723596, 376.45978021539094, 6355.0, 6381.904271435927, 6401.39186777256, 6448.903266451007, 6548.869022619545, 6378.904316435257, 6395.520335974809, 6423.1328770615955, 6432.807015789522, 6512.120863683402, 4875.463698993108, 4891.021795640868, 4897.7795999180125, 4911.066897289522, 4916.754162291871, 4917.606591472673, 4917.704937703749, 4921.950780492185, 4926.827561035347, 4939.25911113334, 4730.763461826912, 4750.97624511877, 4817.108834865561, 4833.3958255218095, 4844.394450693663, 4831.685940413897, 4845.709257444564, 4852.296417019547, 4853.587445067174, 4856.830010949635, 4234.0, 4237.597428244312, 4238.788060596958, 4246.830126794925, 4251.766152861592, 6030.03519436888, 6040.426159514839, 6059.454649081604, 6068.9062273515565, 6092.238470191226, 5559.8888022239735, 5682.829515114512, 5690.004249256405, 5695.886082278373, 5697.9715101424645, 6693.6318502482345, 6767.221769496522, 6793.864122717518, 6799.11611490508, 6810.250872404032, 4656.906861862778, 4720.0559888022535, 4721.929171062437, 4726.26742854858, 4739.36018637483, 6979.4765392595755, 7045.718171273143, 7135.5361901476235, 7149.14210294768, 7153.177384600734, 4779.259214821708, 4802.231642937113, 4807.855764327006, 4808.807647694123, 4814.9518504815205, 4865.756712164378, 4871.585915197177, 4873.415190177201, 4874.512548745097, 4885.218365061644, 5623.831285061455, 5642.7178641067785, 5648.802291919763, 5649.209110724501, 5663.886722265532, 6700.237795495869, 6802.6258555779905, 6832.0776695146515, 6886.380225779704, 6891.4486841053595, 1706.9061201634029, 1723.9051852148252, 1725.5427311762394, 1727.4558514068028, 1735.0, 1111.8165502691966, 1134.2910680824484, 1136.187625847523, 1158.3571118029574, 1179.3277831635885, 6591.934080659228, 6604.2074951005225, 6604.933950660528, 6611.404973552403, 6632.1046658701425, 7042.0, 7086.291370862872, 7087.787366379017, 7100.786976390613, 7101.538400003983, 6380.361963803675, 6398.552101352953, 6490.545661803629, 6587.0, 6616.3714447128405, 3798.3352913240074, 3832.693384529231, 3857.807109644563, 3867.9749866285456, 3872.206197729459, 7345.559266443924, 7378.225286344964, 7393.260673932564, 7420.628968551551, 7420.628968551551, 7164.0328555645365, 7313.524620899624, 7357.742479013209, 7369.742059027908, 7390.076240469942, 7367.852642947111, 7370.6683199255085, 7380.446466515033, 7383.335499804936, 7392.928025436174, 6857.657117144223, 7130.857382852418, 7134.607596582237, 7139.785806425815, 7159.821004474721, 7013.088298521159, 7032.12098487689, 7039.577625342496, 7084.787456376317, 7093.255208203064, 7369.631518424165, 7425.0, 7427.8143046424275, 7432.702691892264, 7439.665215065444, 4929.309896614549, 4954.1825598775795, 4998.60011199096, 5011.148104822262, 5045.11710450677, 7052.753153639598, 7075.080239568823, 7106.253843346374, 7106.7157313706875, 7115.786526404217, 6812.863742725217, 6850.451963842781, 6868.313168683291, 6873.2783057778215, 6900.758473453405, 6757.864842703217, 6759.99180364733, 6829.351211634887, 6833.0, 6892.586444813327, 6724.562903411263, 6737.461003119836, 6757.3242675734, 6757.3580509853455, 6762.459003279628, 6869.141357330333, 6883.65581720922, 6887.276835932155, 6888.621125837926, 6896.827579310357, 6564.015397690385, 6661.700223490052, 6686.3313668632745, 6729.0, 6729.125213722381], "unit": "score", "name": "prototype.html", "value": 5158.173102551043}, {"lowerIsBetter": false, "replicates": [843.7679638099522, 931.2782593490044, 937.7889974755681, 956.5026186383085, 958.4393130018939, 13990.930045349773, 14072.085314454553, 14149.434022639094, 14154.71690566188, 14157.0, 13768.655783605414, 13805.585832425018, 13821.308934553283, 13865.861341386582, 13994.860051399482, 869.1395518436734, 884.0673089890163, 884.305819931354, 905.0632595263903, 922.0594993107027, 918.3296193778546, 919.2232563483846, 922.5617831530037, 923.4505469245788, 926.263620421763, 936.7143021378477, 939.1876027236425, 939.1969865764776, 939.8825146856643, 942.1661829281102, 929.3866048408086, 933.5192375926404, 934.1405906565908, 934.4206591912989, 935.4667839331584, 693.4313862632644, 693.4868197533839, 698.6541661877352, 699.7096205074888, 701.3302296307014, 15096.924515377354, 15140.848591514054, 15166.848331516654, 15182.164980926045, 15263.389464421522, 13014.414351354117, 13308.134971226937, 13473.461061557526, 13652.0, 13678.0, 11417.94291028548, 12394.62816115518, 12428.254304741744, 12503.312317822516, 12816.48734050646, 3663.688586470153, 3714.461403096536, 3714.647108524686, 3750.49368335274, 3804.1250512382308, 50163.24755128676, 51057.0, 51064.234036489484, 51487.74256128733, 51881.481185188044, 10510.684679459628, 10699.679009629723, 10966.506507207196, 10977.83533247002, 11052.447377631086, 18577.53556161107, 18685.532861678566, 18710.906445467685, 18713.81286187148, 18802.52993675169, 8045.678172873137, 8108.310793582612, 8110.797230069177, 8161.551114688749, 8166.877496837552, 4594.081183763261, 4706.10583989041, 4706.458757242961, 4793.784279707422, 4880.755962201947, 3117.875284988575, 3133.6239651242, 3137.1372872460256, 3139.748820094387, 3140.733037691776, 568.4940403041296, 570.2586637371401, 571.5713215088683, 576.7260551238128, 590.8759160576327, 613.414189449075, 679.4598294355999, 735.9632018399166, 754.528419737664, 782.4170992610542, 9500.287478439144, 9520.095590918852, 9546.474943878015, 9654.806903861883, 9679.37084089546, 607.7903123422412, 610.7282259394527, 735.1252010107954, 778.6729573579111, 802.6227672993683, 4332.783360831946, 4406.625436837905, 4644.00153966892, 4691.50739172382, 4694.155052090657, 58963.0, 59795.701021495486, 60489.0, 60693.69653151706, 60894.0, 52740.20889686658, 53857.0, 54154.0, 54681.72659136679, 55072.0, 48574.75712621414, 48629.756851216225, 48713.756431218324, 49056.264156036974, 49461.0, 9199.264058875407, 9238.399504032217, 9331.393459425115, 9336.206422453895, 9521.523923803921, 35952.0, 36178.8191059043, 36586.0, 36997.26005479929, 37273.627263727016, 45291.77354113208, 47442.28836567523, 47460.7626961863, 47477.52522474731, 47989.76005119952, 12504.187227830162, 12513.499460021498, 12813.615591532269, 12893.806592901301, 12946.870531294566, 13174.736505270033, 13399.464021439033, 13488.325583720578, 13536.187828730308, 13602.591922241952, 12600.11799174049, 12855.485780568673, 12867.292298923649, 12921.160124591872, 13412.798808017693, 12090.697732556757, 12128.09039322072, 12163.087768417226, 12244.448999794853, 12347.62957111288, 12117.636470905887, 12357.75284494287, 12827.037972152313, 13061.934690326487, 13456.25990570528, 9612.279079068958, 10049.346792458467, 10193.796124077626, 10459.94770026145, 10739.409332486475, 10609.20430967665, 10872.0, 11000.834987475035, 11122.721931951442, 11191.216614836883], "unit": "score", "name": "yui.html", "value": 6868.522237735446}], "name": "dromaeo_css", "value": 7304.298839096775}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 112.0, 111.0, 111.0, 122.0, 111.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [158.0, 125.0, 158.0, 154.0, 126.0, 152.0, 157.0, 131.0, 172.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 162.0, 163.0, 163.0, 162.0, 160.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 76.0, 154.0, 74.0, 75.0, 76.0, 77.0, 161.0, 73.0], "unit": "score", "name": "audio-fft", "value": 91.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 137.0, 95.0, 95.0, 95.0, 134.0, 95.0, 95.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 98.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [54.0, 58.0, 56.0, 55.0, 56.0, 56.0, 55.0, 62.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 84.0, 89.0, 89.0, 91.0, 82.0, 82.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [114.0, 113.0, 113.0, 115.0, 123.0, 113.0, 119.0, 120.0, 113.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.9}, {"lowerIsBetter": true, "replicates": [138.0, 140.0, 136.0, 137.0, 148.0, 138.0, 127.0, 137.0, 143.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.5}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 64.0, 68.0, 67.0, 76.0, 64.0, 65.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1499.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.15484090522375], "unit": "score", "name": "Richards", "value": 207.46985400000003}, {"lowerIsBetter": false, "replicates": [170.32873445750297], "unit": "score", "name": "DeltaBlue", "value": 388.1787779999999}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [939.8496240601504], "unit": "score", "name": "RayTrace", "value": 787.3482960000001}, {"lowerIsBetter": false, "replicates": [561.1672278338945], "unit": "score", "name": "Earley", "value": 1187.6370659999998}, {"lowerIsBetter": false, "replicates": [11133.333333333334], "unit": "score", "name": "Boyer", "value": 59.86194610778439}, {"lowerIsBetter": false, "replicates": [39038.46153846154], "unit": "score", "name": "RegExp", "value": 23.3355763546798}, {"lowerIsBetter": false, "replicates": [524.3838489774515], "unit": "score", "name": "Splay", "value": 155.40333699999996}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21944.07633253885}]} 11:47:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21944.08"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1499.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7304.30"}}} 11:47:58 INFO - Return code: 0 11:47:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:47:58 INFO - # TBPL SUCCESS # 11:47:58 INFO - Running post-action listener: _resource_record_post_action 11:47:58 INFO - Running post-run listener: _resource_record_post_run 11:47:59 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 278528; Write bytes: 501768192; Read time: 40; Write time: 520224 11:47:59 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 241623040; Read time: 0; Write time: 361960 11:47:59 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 278528; Write bytes: 259547136; Read time: 40; Write time: 157488 11:47:59 INFO - Running post-run listener: _upload_blobber_files 11:47:59 INFO - Blob upload gear active. 11:47:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:47:59 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:47:59 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'] 11:47:59 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 11:47:59 INFO - (blobuploader) - INFO - Open directory for files ... 11:47:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:47:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:48:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:00 INFO - (blobuploader) - INFO - Done attempting. 11:48:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:48:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:48:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:01 INFO - (blobuploader) - INFO - Done attempting. 11:48:01 INFO - (blobuploader) - INFO - Iteration through files over. 11:48:01 INFO - Return code: 0 11:48:01 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:48:01 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:48:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01e75881e5bf57285be591511e9d124cf7399fbed1fc6690184fbd3fec3e201753083784a590b755fe4bfe2dda754d6d75d1bcc005435abb41c9c4ed61e1ba44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab7d5fc21348bcc77e9f06314931adaac5cf0d1364dc7549d080f76da40a7eebef5422bf7cfe951c911e8feb8770b76889ddd74c7594edde46b34dacb68b349e"} 11:48:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:48:01 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:48:01 INFO - Contents: 11:48:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01e75881e5bf57285be591511e9d124cf7399fbed1fc6690184fbd3fec3e201753083784a590b755fe4bfe2dda754d6d75d1bcc005435abb41c9c4ed61e1ba44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab7d5fc21348bcc77e9f06314931adaac5cf0d1364dc7549d080f76da40a7eebef5422bf7cfe951c911e8feb8770b76889ddd74c7594edde46b34dacb68b349e"} 11:48:01 INFO - Running post-run listener: copy_logs_to_upload_dir 11:48:01 INFO - Copying logs to upload dir... 11:48:01 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 11:48:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.540478 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-02-29 11:48:01.501671) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 11:48:01.506073) ========= 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=232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461 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/01e75881e5bf57285be591511e9d124cf7399fbed1fc6690184fbd3fec3e201753083784a590b755fe4bfe2dda754d6d75d1bcc005435abb41c9c4ed61e1ba44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab7d5fc21348bcc77e9f06314931adaac5cf0d1364dc7549d080f76da40a7eebef5422bf7cfe951c911e8feb8770b76889ddd74c7594edde46b34dacb68b349e"} build_url:https://queue.taskcluster.net/v1/task/etP8sKq2RTSW56aCYPm6uQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011199 build_url: 'https://queue.taskcluster.net/v1/task/etP8sKq2RTSW56aCYPm6uQ/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/01e75881e5bf57285be591511e9d124cf7399fbed1fc6690184fbd3fec3e201753083784a590b755fe4bfe2dda754d6d75d1bcc005435abb41c9c4ed61e1ba44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab7d5fc21348bcc77e9f06314931adaac5cf0d1364dc7549d080f76da40a7eebef5422bf7cfe951c911e8feb8770b76889ddd74c7594edde46b34dacb68b349e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 11:48:01.534105) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:48:01.534438) ========= 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=232498196343f89f466a4a9a000001c8-1456774004.870142-1003506461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 11:48:01.584919) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 11:48:01.585264) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 11:48:01.585595) ========= ========= Total master_lag: 0.26 =========