builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1468753754.2 results: success (0) buildid: 20160717013154 builduid: b29bf0c67b4642cdbf4ed5e6aa124749 revision: 92ec0fc8583e2a8bf38f0d8e98a3b78cda4eebaa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 04:09:14.204628) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 04:09:14.205152) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 04:09:14.205466) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 04:09:14.221334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 04:09:14.221799) ========= 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/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-17 04:09:14-- 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% 38.3M=0s 2016-07-17 04:09:14 (38.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.389958 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 04:09:14.626556) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 04:09:14.626897) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020418 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 04:09:14.676547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 04:09:14.676881) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 92ec0fc8583e2a8bf38f0d8e98a3b78cda4eebaa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 92ec0fc8583e2a8bf38f0d8e98a3b78cda4eebaa --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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-17 04:09:14,852 truncating revision to first 12 chars 2016-07-17 04:09:14,852 Setting DEBUG logging. 2016-07-17 04:09:14,852 attempt 1/10 2016-07-17 04:09:14,852 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/92ec0fc8583e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-17 04:09:15,482 unpacking tar archive at: mozilla-beta-92ec0fc8583e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.966045 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 04:09:15.659980) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 04:09:15.660688) ========= script_repo_revision: 92ec0fc8583e2a8bf38f0d8e98a3b78cda4eebaa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 04:09:15.661657) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 04:09:15.662337) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 04:09:15.676705) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-17 04:09:15.677015) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:09:15 INFO - MultiFileLogger online at 20160717 04:09:15 in /builds/slave/test 04:09:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:09:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:09:15 INFO - {'append_to_log': False, 04:09:15 INFO - 'base_work_dir': '/builds/slave/test', 04:09:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:09:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:09:15 INFO - 'branch': 'Mozilla-Beta', 04:09:15 INFO - 'buildbot_json_path': 'buildprops.json', 04:09:15 INFO - 'config_files': ('talos/linux_config.py',), 04:09:15 INFO - 'default_actions': ('clobber', 04:09:15 INFO - 'read-buildbot-config', 04:09:15 INFO - 'download-and-extract', 04:09:15 INFO - 'populate-webroot', 04:09:15 INFO - 'create-virtualenv', 04:09:15 INFO - 'install', 04:09:15 INFO - 'run-tests'), 04:09:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:09:15 INFO - 'download_minidump_stackwalk': True, 04:09:15 INFO - 'download_symbols': 'ondemand', 04:09:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:09:15 INFO - 'tooltool.py': '/tools/tooltool.py', 04:09:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:09:15 INFO - '/tools/misc-python/virtualenv.py')}, 04:09:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:09:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:09:15 INFO - 'installer_path': 'installer.exe', 04:09:15 INFO - 'log_level': 'info', 04:09:15 INFO - 'log_name': 'talos', 04:09:15 INFO - 'log_to_console': True, 04:09:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:09:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:09:15 INFO - 'opt_config_files': (), 04:09:15 INFO - 'pip_index': False, 04:09:15 INFO - 'sps_profile': False, 04:09:15 INFO - 'sps_profile_interval': 0, 04:09:15 INFO - 'suite': 'dromaeojs-e10s', 04:09:15 INFO - 'system_bits': '32', 04:09:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:09:15 INFO - 'title': 'talos-linux64-ix-029', 04:09:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:09:15 INFO - 'use_talos_json': True, 04:09:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:09:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:09:15 INFO - 'work_dir': 'build'} 04:09:15 INFO - ##### 04:09:15 INFO - ##### Running clobber step. 04:09:15 INFO - ##### 04:09:15 INFO - Running pre-action listener: _resource_record_pre_action 04:09:15 INFO - Running main action method: clobber 04:09:15 INFO - rmtree: /builds/slave/test/build 04:09:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:09:16 INFO - Running post-action listener: _resource_record_post_action 04:09:16 INFO - ##### 04:09:16 INFO - ##### Running read-buildbot-config step. 04:09:16 INFO - ##### 04:09:16 INFO - Running pre-action listener: _resource_record_pre_action 04:09:16 INFO - Running main action method: read_buildbot_config 04:09:16 INFO - Using buildbot properties: 04:09:16 INFO - { 04:09:16 INFO - "project": "", 04:09:16 INFO - "product": "firefox", 04:09:16 INFO - "script_repo_revision": "production", 04:09:16 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 04:09:16 INFO - "repository": "", 04:09:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 04:09:16 INFO - "buildid": "20160717013154", 04:09:16 INFO - "pgo_build": "True", 04:09:16 INFO - "basedir": "/builds/slave/test", 04:09:16 INFO - "buildnumber": 53, 04:09:16 INFO - "slavename": "talos-linux64-ix-029", 04:09:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:09:16 INFO - "platform": "ubuntu64_hw", 04:09:16 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:09:16 INFO - "branch": "mozilla-beta", 04:09:16 INFO - "repo_path": "releases/mozilla-beta", 04:09:16 INFO - "revision": "92ec0fc8583e2a8bf38f0d8e98a3b78cda4eebaa", 04:09:16 INFO - "stage_platform": "linux64-pgo", 04:09:16 INFO - "builduid": "b29bf0c67b4642cdbf4ed5e6aa124749", 04:09:16 INFO - "slavebuilddir": "test" 04:09:16 INFO - } 04:09:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 04:09:16 INFO - Running post-action listener: _resource_record_post_action 04:09:16 INFO - ##### 04:09:16 INFO - ##### Running download-and-extract step. 04:09:16 INFO - ##### 04:09:16 INFO - Running pre-action listener: _resource_record_pre_action 04:09:16 INFO - Running main action method: download_and_extract 04:09:16 INFO - mkdir: /builds/slave/test/build/tests 04:09:16 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')]} 04:09:16 INFO - https://queue.taskcluster.net/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:09:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:09:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:09:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:09:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:09:18 INFO - Downloaded 1327 bytes. 04:09:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:09:18 INFO - Using the following test package requirements: 04:09:18 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 04:09:18 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:09:18 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:09:18 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:09:18 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 04:09:18 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:09:18 INFO - u'jsshell-linux-x86_64.zip'], 04:09:18 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:09:18 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:09:18 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 04:09:18 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:09:18 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 04:09:18 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:09:18 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 04:09:18 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:09:18 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:09:18 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:09:18 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:09:18 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:09:18 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')]} 04:09:18 INFO - https://queue.taskcluster.net/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:09:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:09:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:09:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:09:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:09:19 INFO - Downloaded 24200755 bytes. 04:09:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:09:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:09:20 INFO - Return code: 0 04:09:20 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:20 INFO - https://queue.taskcluster.net/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:09:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:09:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:09:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:09:31 INFO - Downloaded 24200755 bytes. 04:09:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:09:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:09:33 INFO - Return code: 0 04:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:33 INFO - https://queue.taskcluster.net/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:09:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 04:09:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 04:09:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 04:09:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:09:34 INFO - Downloaded 10840145 bytes. 04:09:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:09:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:09:34 INFO - Return code: 0 04:09:34 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')]} 04:09:34 INFO - https://queue.taskcluster.net/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:09:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:09:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:09:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:09:36 INFO - Downloaded 56052136 bytes. 04:09:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:09:36 INFO - mkdir: /builds/slave/test/properties 04:09:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:09:36 INFO - Writing to file /builds/slave/test/properties/build_url 04:09:36 INFO - Contents: 04:09:36 INFO - build_url:https://queue.taskcluster.net/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:09:36 INFO - Running post-action listener: _resource_record_post_action 04:09:36 INFO - Running post-action listener: set_extra_try_arguments 04:09:37 INFO - ##### 04:09:37 INFO - ##### Running populate-webroot step. 04:09:37 INFO - ##### 04:09:37 INFO - Running pre-action listener: _resource_record_pre_action 04:09:37 INFO - Running main action method: populate_webroot 04:09:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:09:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:09:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:09:37 INFO - '--tppagecycles', 04:09:37 INFO - '7'], 04:09:37 INFO - 'tests': ['tsvgm']}}, 04:09:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:09:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:09:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:09:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:09:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:09:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:09:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:37 INFO - 'talos_options': ['--disable-e10s'], 04:09:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:37 INFO - 'talos_options': ['--disable-e10s'], 04:09:37 INFO - 'tests': ['damp', 'tps']}, 04:09:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:37 INFO - 'tests': ['damp', 'tps']}, 04:09:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:09:37 INFO - 'tests': ['dromaeo_dom']}, 04:09:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:09:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:09:37 INFO - 'tests': ['a11yr', 04:09:37 INFO - 'ts_paint', 04:09:37 INFO - 'tpaint', 04:09:37 INFO - 'sessionrestore', 04:09:37 INFO - 'sessionrestore_no_auto_restore', 04:09:37 INFO - 'tabpaint']}, 04:09:37 INFO - 'other-e10s': {'tests': ['a11yr', 04:09:37 INFO - 'ts_paint', 04:09:37 INFO - 'tpaint', 04:09:37 INFO - 'sessionrestore', 04:09:37 INFO - 'sessionrestore_no_auto_restore', 04:09:37 INFO - 'tabpaint']}, 04:09:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:09:37 INFO - 'ts_paint', 04:09:37 INFO - 'tpaint', 04:09:37 INFO - 'sessionrestore', 04:09:37 INFO - 'sessionrestore_no_auto_restore', 04:09:37 INFO - 'tabpaint']}, 04:09:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:09:37 INFO - 'ts_paint', 04:09:37 INFO - 'tpaint', 04:09:37 INFO - 'sessionrestore', 04:09:37 INFO - 'sessionrestore_no_auto_restore', 04:09:37 INFO - 'tabpaint']}, 04:09:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:09:37 INFO - 'tests': ['a11yr', 04:09:37 INFO - 'ts_paint', 04:09:37 INFO - 'tpaint', 04:09:37 INFO - 'sessionrestore', 04:09:37 INFO - 'sessionrestore_no_auto_restore', 04:09:37 INFO - 'tabpaint']}, 04:09:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:09:37 INFO - 'tests': ['a11yr', 04:09:37 INFO - 'ts_paint', 04:09:37 INFO - 'tpaint', 04:09:37 INFO - 'sessionrestore', 04:09:37 INFO - 'sessionrestore_no_auto_restore', 04:09:37 INFO - 'tabpaint']}, 04:09:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:09:37 INFO - 'tests': ['tsvgx', 04:09:37 INFO - 'tsvgr_opacity', 04:09:37 INFO - 'tart', 04:09:37 INFO - 'tscrollx', 04:09:37 INFO - 'cart']}, 04:09:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:09:37 INFO - 'tsvgr_opacity', 04:09:37 INFO - 'tart', 04:09:37 INFO - 'tscrollx', 04:09:37 INFO - 'cart']}, 04:09:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:37 INFO - 'talos_options': ['--disable-e10s'], 04:09:37 INFO - 'tests': ['tp5o']}, 04:09:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:37 INFO - 'tests': ['tp5o']}, 04:09:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:37 INFO - 'talos_options': ['--disable-e10s', 04:09:37 INFO - '--xperf_path', 04:09:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:37 INFO - 'tests': ['tp5n']}, 04:09:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:37 INFO - 'talos_options': ['--xperf_path', 04:09:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:37 INFO - 'tests': ['tp5n']}}, 04:09:37 INFO - 'talos.zip': {'path': '', 04:09:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:09:37 INFO - Running post-action listener: _resource_record_post_action 04:09:37 INFO - ##### 04:09:37 INFO - ##### Running create-virtualenv step. 04:09:37 INFO - ##### 04:09:37 INFO - Running pre-action listener: _resource_record_pre_action 04:09:37 INFO - Running main action method: create_virtualenv 04:09:37 INFO - Creating virtualenv /builds/slave/test/build/venv 04:09:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:09:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:09:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:09:37 INFO - Using real prefix '/usr' 04:09:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:09:37 INFO - Installing distribute.............................................................................................................................................................................................done. 04:09:39 INFO - Installing pip.................done. 04:09:39 INFO - Return code: 0 04:09:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f2ffd7a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2410>, '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 0x27f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f37a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 04:09:39 INFO - Running command: ['/builds/slave/test/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/build 04:09:39 INFO - Copy/paste: /builds/slave/test/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 04:09:39 INFO - Using env: {'DISPLAY': ':0', 04:09:39 INFO - 'HOME': '/home/cltbld', 04:09:39 INFO - 'LANG': 'en_US.UTF-8', 04:09:39 INFO - 'LANGUAGE': 'en_US:en', 04:09:39 INFO - 'LOGNAME': 'cltbld', 04:09:39 INFO - 'MAIL': '/var/mail/cltbld', 04:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:39 INFO - 'MOZ_NO_REMOTE': '1', 04:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:39 INFO - 'NO_EM_RESTART': '1', 04:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:39 INFO - 'PWD': '/builds/slave/test', 04:09:39 INFO - 'SHELL': '/bin/bash', 04:09:39 INFO - 'SHLVL': '1', 04:09:39 INFO - 'TERM': 'linux', 04:09:39 INFO - 'TMOUT': '86400', 04:09:39 INFO - 'USER': 'cltbld', 04:09:39 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103', 04:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:39 INFO - '_': '/tools/buildbot/bin/python'} 04:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:39 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 04:09:39 INFO - Cleaning up... 04:09:39 INFO - Return code: 0 04:09:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f2ffd7a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2410>, '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 0x27f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f37a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 04:09:39 INFO - Running command: ['/builds/slave/test/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/build 04:09:39 INFO - Copy/paste: /builds/slave/test/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 04:09:39 INFO - Using env: {'DISPLAY': ':0', 04:09:39 INFO - 'HOME': '/home/cltbld', 04:09:39 INFO - 'LANG': 'en_US.UTF-8', 04:09:39 INFO - 'LANGUAGE': 'en_US:en', 04:09:39 INFO - 'LOGNAME': 'cltbld', 04:09:39 INFO - 'MAIL': '/var/mail/cltbld', 04:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:39 INFO - 'MOZ_NO_REMOTE': '1', 04:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:39 INFO - 'NO_EM_RESTART': '1', 04:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:39 INFO - 'PWD': '/builds/slave/test', 04:09:39 INFO - 'SHELL': '/bin/bash', 04:09:39 INFO - 'SHLVL': '1', 04:09:39 INFO - 'TERM': 'linux', 04:09:39 INFO - 'TMOUT': '86400', 04:09:40 INFO - 'USER': 'cltbld', 04:09:40 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103', 04:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:40 INFO - '_': '/tools/buildbot/bin/python'} 04:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:40 INFO - Downloading/unpacking psutil>=0.7.1 04:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:09:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:42 INFO - Installing collected packages: psutil 04:09:42 INFO - Running setup.py install for psutil 04:09:42 INFO - building 'psutil._psutil_linux' extension 04:09:42 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 04:09:42 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 04:09:42 INFO - building 'psutil._psutil_posix' extension 04:09:42 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 04:09:42 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 04:09:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:42 INFO - Successfully installed psutil 04:09:42 INFO - Cleaning up... 04:09:42 INFO - Return code: 0 04:09:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f2ffd7a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2410>, '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 0x27f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f37a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 04:09:42 INFO - Running command: ['/builds/slave/test/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/build 04:09:42 INFO - Copy/paste: /builds/slave/test/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 04:09:42 INFO - Using env: {'DISPLAY': ':0', 04:09:42 INFO - 'HOME': '/home/cltbld', 04:09:42 INFO - 'LANG': 'en_US.UTF-8', 04:09:42 INFO - 'LANGUAGE': 'en_US:en', 04:09:42 INFO - 'LOGNAME': 'cltbld', 04:09:42 INFO - 'MAIL': '/var/mail/cltbld', 04:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:42 INFO - 'MOZ_NO_REMOTE': '1', 04:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:42 INFO - 'NO_EM_RESTART': '1', 04:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:42 INFO - 'PWD': '/builds/slave/test', 04:09:42 INFO - 'SHELL': '/bin/bash', 04:09:42 INFO - 'SHLVL': '1', 04:09:42 INFO - 'TERM': 'linux', 04:09:42 INFO - 'TMOUT': '86400', 04:09:42 INFO - 'USER': 'cltbld', 04:09:42 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103', 04:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:42 INFO - '_': '/tools/buildbot/bin/python'} 04:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:09:44 INFO - Installing collected packages: mozsystemmonitor 04:09:44 INFO - Running setup.py install for mozsystemmonitor 04:09:45 INFO - Successfully installed mozsystemmonitor 04:09:45 INFO - Cleaning up... 04:09:45 INFO - Return code: 0 04:09:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:09:45 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')]} 04:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:45 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')]} 04:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f2ffd7a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2410>, '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 0x27f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f37a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 04:09:45 INFO - Running command: ['/builds/slave/test/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/build 04:09:45 INFO - Copy/paste: /builds/slave/test/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 04:09:45 INFO - Using env: {'DISPLAY': ':0', 04:09:45 INFO - 'HOME': '/home/cltbld', 04:09:45 INFO - 'LANG': 'en_US.UTF-8', 04:09:45 INFO - 'LANGUAGE': 'en_US:en', 04:09:45 INFO - 'LOGNAME': 'cltbld', 04:09:45 INFO - 'MAIL': '/var/mail/cltbld', 04:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:45 INFO - 'MOZ_NO_REMOTE': '1', 04:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:45 INFO - 'NO_EM_RESTART': '1', 04:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:45 INFO - 'PWD': '/builds/slave/test', 04:09:45 INFO - 'SHELL': '/bin/bash', 04:09:45 INFO - 'SHLVL': '1', 04:09:45 INFO - 'TERM': 'linux', 04:09:45 INFO - 'TMOUT': '86400', 04:09:45 INFO - 'USER': 'cltbld', 04:09:45 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103', 04:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:45 INFO - '_': '/tools/buildbot/bin/python'} 04:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:46 INFO - Downloading/unpacking blobuploader==1.2.4 04:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:48 INFO - Downloading blobuploader-1.2.4.tar.gz 04:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:09:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:09:48 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 04:09:48 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 04:09:48 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 04:09:48 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 04:09:48 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 04:09:48 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 04:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:09:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:09:48 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 04:09:48 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 04:09:48 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 04:09:48 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 04:09:48 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 04:09:48 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 04:09:48 INFO - Downloading docopt-0.6.1.tar.gz 04:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:09:48 INFO - Installing collected packages: blobuploader, requests, docopt 04:09:48 INFO - Running setup.py install for blobuploader 04:09:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:09:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:09:48 INFO - Running setup.py install for requests 04:09:49 INFO - Running setup.py install for docopt 04:09:49 INFO - Successfully installed blobuploader requests docopt 04:09:49 INFO - Cleaning up... 04:09:49 INFO - Return code: 0 04:09:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f2ffd7a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2410>, '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 0x27f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f37a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 04:09:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 04:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/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 04:09:49 INFO - Using env: {'DISPLAY': ':0', 04:09:49 INFO - 'HOME': '/home/cltbld', 04:09:49 INFO - 'LANG': 'en_US.UTF-8', 04:09:49 INFO - 'LANGUAGE': 'en_US:en', 04:09:49 INFO - 'LOGNAME': 'cltbld', 04:09:49 INFO - 'MAIL': '/var/mail/cltbld', 04:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:49 INFO - 'MOZ_NO_REMOTE': '1', 04:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:49 INFO - 'NO_EM_RESTART': '1', 04:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:49 INFO - 'PWD': '/builds/slave/test', 04:09:49 INFO - 'SHELL': '/bin/bash', 04:09:49 INFO - 'SHLVL': '1', 04:09:49 INFO - 'TERM': 'linux', 04:09:49 INFO - 'TMOUT': '86400', 04:09:49 INFO - 'USER': 'cltbld', 04:09:49 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103', 04:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:49 INFO - '_': '/tools/buildbot/bin/python'} 04:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:49 INFO - Running setup.py (path:/tmp/pip-KCpn6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:49 INFO - Running setup.py (path:/tmp/pip-pHmedf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:49 INFO - Running setup.py (path:/tmp/pip-uM1Mxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:49 INFO - Running setup.py (path:/tmp/pip-P3TN9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:49 INFO - Running setup.py (path:/tmp/pip-cuXAGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:49 INFO - Running setup.py (path:/tmp/pip-2O2f2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:50 INFO - Running setup.py (path:/tmp/pip-pBRt92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:50 INFO - Running setup.py (path:/tmp/pip-0HEElB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:50 INFO - Running setup.py (path:/tmp/pip-VdFUru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:50 INFO - Running setup.py (path:/tmp/pip-16fnMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:50 INFO - Running setup.py (path:/tmp/pip-2s21uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:50 INFO - Running setup.py (path:/tmp/pip-Y6Afqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:50 INFO - Running setup.py (path:/tmp/pip-Knf7ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:50 INFO - Running setup.py (path:/tmp/pip-QO4Pml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:50 INFO - Running setup.py (path:/tmp/pip-2pMW7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:50 INFO - Running setup.py (path:/tmp/pip-eG15A6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:50 INFO - Running setup.py (path:/tmp/pip-EV9VDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:09:50 INFO - Running setup.py install for manifestparser 04:09:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:09:50 INFO - Running setup.py install for mozcrash 04:09:51 INFO - Running setup.py install for mozdebug 04:09:51 INFO - Running setup.py install for mozdevice 04:09:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:09:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:09:51 INFO - Running setup.py install for mozfile 04:09:51 INFO - Running setup.py install for mozhttpd 04:09:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:09:51 INFO - Running setup.py install for mozinfo 04:09:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:09:51 INFO - Running setup.py install for mozInstall 04:09:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:09:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:09:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:09:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:09:51 INFO - Running setup.py install for mozleak 04:09:51 INFO - Running setup.py install for mozlog 04:09:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:09:51 INFO - Running setup.py install for moznetwork 04:09:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:09:51 INFO - Running setup.py install for mozprocess 04:09:52 INFO - Running setup.py install for mozprofile 04:09:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Running setup.py install for mozrunner 04:09:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Running setup.py install for mozscreenshot 04:09:52 INFO - Running setup.py install for moztest 04:09:52 INFO - Running setup.py install for mozversion 04:09:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:09:52 INFO - Cleaning up... 04:09:52 INFO - Return code: 0 04:09:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f2ffd7a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2410>, '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 0x27f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f37a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 04:09:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 04:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 04:09:52 INFO - Using env: {'DISPLAY': ':0', 04:09:52 INFO - 'HOME': '/home/cltbld', 04:09:52 INFO - 'LANG': 'en_US.UTF-8', 04:09:52 INFO - 'LANGUAGE': 'en_US:en', 04:09:52 INFO - 'LOGNAME': 'cltbld', 04:09:52 INFO - 'MAIL': '/var/mail/cltbld', 04:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:52 INFO - 'MOZ_NO_REMOTE': '1', 04:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:52 INFO - 'NO_EM_RESTART': '1', 04:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:52 INFO - 'PWD': '/builds/slave/test', 04:09:52 INFO - 'SHELL': '/bin/bash', 04:09:52 INFO - 'SHLVL': '1', 04:09:52 INFO - 'TERM': 'linux', 04:09:52 INFO - 'TMOUT': '86400', 04:09:52 INFO - 'USER': 'cltbld', 04:09:52 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103', 04:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:52 INFO - '_': '/tools/buildbot/bin/python'} 04:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:52 INFO - Running setup.py (path:/tmp/pip-FRZ5p8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:52 INFO - Running setup.py (path:/tmp/pip-a2VmGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:52 INFO - Running setup.py (path:/tmp/pip-6MKyV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:53 INFO - Running setup.py (path:/tmp/pip-6nxFlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:53 INFO - Running setup.py (path:/tmp/pip-Z2ADi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:53 INFO - Running setup.py (path:/tmp/pip-N8Qgll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:53 INFO - Running setup.py (path:/tmp/pip-TUnzQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:53 INFO - Running setup.py (path:/tmp/pip-FIwYBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:53 INFO - Running setup.py (path:/tmp/pip-1ZMrW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:53 INFO - Running setup.py (path:/tmp/pip-T1V7iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:53 INFO - Running setup.py (path:/tmp/pip-pNb5dD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:53 INFO - Running setup.py (path:/tmp/pip-_L2ihN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:53 INFO - Running setup.py (path:/tmp/pip-mUgwdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:53 INFO - Running setup.py (path:/tmp/pip-kGQBXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:53 INFO - Running setup.py (path:/tmp/pip-JwEHbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:53 INFO - Running setup.py (path:/tmp/pip-LB1_s8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:53 INFO - Running setup.py (path:/tmp/pip-sVFdlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:09:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:55 INFO - Downloading blessings-1.6.tar.gz 04:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:09:56 INFO - Installing collected packages: blessings 04:09:56 INFO - Running setup.py install for blessings 04:09:56 INFO - Successfully installed blessings 04:09:56 INFO - Cleaning up... 04:09:56 INFO - Return code: 0 04:09:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:09:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:56 INFO - Reading from file tmpfile_stdout 04:09:56 INFO - Current package versions: 04:09:56 INFO - argparse == 1.2.1 04:09:56 INFO - blessings == 1.6 04:09:56 INFO - blobuploader == 1.2.4 04:09:56 INFO - docopt == 0.6.1 04:09:56 INFO - manifestparser == 1.1 04:09:56 INFO - mozInstall == 1.12 04:09:56 INFO - mozcrash == 0.17 04:09:56 INFO - mozdebug == 0.1 04:09:56 INFO - mozdevice == 0.48 04:09:56 INFO - mozfile == 1.2 04:09:56 INFO - mozhttpd == 0.7 04:09:56 INFO - mozinfo == 0.9 04:09:56 INFO - mozleak == 0.1 04:09:56 INFO - mozlog == 3.1 04:09:56 INFO - moznetwork == 0.27 04:09:56 INFO - mozprocess == 0.22 04:09:56 INFO - mozprofile == 0.28 04:09:56 INFO - mozrunner == 6.11 04:09:56 INFO - mozscreenshot == 0.1 04:09:56 INFO - mozsystemmonitor == 0.0 04:09:56 INFO - moztest == 0.7 04:09:56 INFO - mozversion == 1.4 04:09:56 INFO - psutil == 3.1.1 04:09:56 INFO - requests == 1.2.3 04:09:56 INFO - wsgiref == 0.1.2 04:09:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f2ffd7a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2410>, '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 0x27f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f37a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 04:09:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 04:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 04:09:56 INFO - Using env: {'DISPLAY': ':0', 04:09:56 INFO - 'HOME': '/home/cltbld', 04:09:56 INFO - 'LANG': 'en_US.UTF-8', 04:09:56 INFO - 'LANGUAGE': 'en_US:en', 04:09:56 INFO - 'LOGNAME': 'cltbld', 04:09:56 INFO - 'MAIL': '/var/mail/cltbld', 04:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:56 INFO - 'MOZ_NO_REMOTE': '1', 04:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:56 INFO - 'NO_EM_RESTART': '1', 04:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:56 INFO - 'PWD': '/builds/slave/test', 04:09:56 INFO - 'SHELL': '/bin/bash', 04:09:56 INFO - 'SHLVL': '1', 04:09:56 INFO - 'TERM': 'linux', 04:09:56 INFO - 'TMOUT': '86400', 04:09:56 INFO - 'USER': 'cltbld', 04:09:56 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103', 04:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:56 INFO - '_': '/tools/buildbot/bin/python'} 04:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:09:56 INFO - Cleaning up... 04:09:56 INFO - Return code: 0 04:09:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f2ffd7a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2410>, '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 0x27f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f37a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 04:09:56 INFO - Running command: ['/builds/slave/test/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/build 04:09:56 INFO - Copy/paste: /builds/slave/test/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 04:09:56 INFO - Using env: {'DISPLAY': ':0', 04:09:56 INFO - 'HOME': '/home/cltbld', 04:09:56 INFO - 'LANG': 'en_US.UTF-8', 04:09:56 INFO - 'LANGUAGE': 'en_US:en', 04:09:56 INFO - 'LOGNAME': 'cltbld', 04:09:56 INFO - 'MAIL': '/var/mail/cltbld', 04:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:56 INFO - 'MOZ_NO_REMOTE': '1', 04:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:56 INFO - 'NO_EM_RESTART': '1', 04:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:56 INFO - 'PWD': '/builds/slave/test', 04:09:56 INFO - 'SHELL': '/bin/bash', 04:09:56 INFO - 'SHLVL': '1', 04:09:56 INFO - 'TERM': 'linux', 04:09:56 INFO - 'TMOUT': '86400', 04:09:56 INFO - 'USER': 'cltbld', 04:09:56 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103', 04:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:56 INFO - '_': '/tools/buildbot/bin/python'} 04:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:56 INFO - Downloading/unpacking jsonschema 04:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:09:58 INFO - Downloading/unpacking functools32 (from jsonschema) 04:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:58 INFO - Downloading functools32-3.2.3-2.tar.gz 04:09:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:09:59 INFO - warning: no files found matching '*.txt' 04:09:59 INFO - no previously-included directories found matching 'build' 04:09:59 INFO - no previously-included directories found matching 'dist' 04:09:59 INFO - no previously-included directories found matching '.git*' 04:09:59 INFO - Installing collected packages: jsonschema, functools32 04:09:59 INFO - Running setup.py install for functools32 04:09:59 INFO - warning: no files found matching '*.txt' 04:09:59 INFO - no previously-included directories found matching 'build' 04:09:59 INFO - no previously-included directories found matching 'dist' 04:09:59 INFO - no previously-included directories found matching '.git*' 04:09:59 INFO - Successfully installed jsonschema functools32 04:09:59 INFO - Cleaning up... 04:09:59 INFO - Return code: 0 04:09:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f2ffd7a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2410>, '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 0x27f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f37a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 04:09:59 INFO - Running command: ['/builds/slave/test/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/build 04:09:59 INFO - Copy/paste: /builds/slave/test/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 04:09:59 INFO - Using env: {'DISPLAY': ':0', 04:09:59 INFO - 'HOME': '/home/cltbld', 04:09:59 INFO - 'LANG': 'en_US.UTF-8', 04:09:59 INFO - 'LANGUAGE': 'en_US:en', 04:09:59 INFO - 'LOGNAME': 'cltbld', 04:09:59 INFO - 'MAIL': '/var/mail/cltbld', 04:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:59 INFO - 'MOZ_NO_REMOTE': '1', 04:09:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:59 INFO - 'NO_EM_RESTART': '1', 04:09:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:59 INFO - 'PWD': '/builds/slave/test', 04:09:59 INFO - 'SHELL': '/bin/bash', 04:09:59 INFO - 'SHLVL': '1', 04:09:59 INFO - 'TERM': 'linux', 04:09:59 INFO - 'TMOUT': '86400', 04:09:59 INFO - 'USER': 'cltbld', 04:09:59 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103', 04:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:59 INFO - '_': '/tools/buildbot/bin/python'} 04:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:59 INFO - Downloading/unpacking flake8 04:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:10:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:10:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:10:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:10:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:10:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:10:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:10:02 INFO - no previously-included directories found matching 'docs/_build' 04:10:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:10:02 INFO - Running setup.py install for pep8 04:10:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:10:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:10:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:10:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:10:02 INFO - no previously-included directories found matching 'docs/_build' 04:10:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:10:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:10:02 INFO - Cleaning up... 04:10:02 INFO - Return code: 0 04:10:02 INFO - Running post-action listener: _resource_record_post_action 04:10:02 INFO - Running post-action listener: _start_resource_monitoring 04:10:02 INFO - Starting resource monitoring. 04:10:02 INFO - ##### 04:10:02 INFO - ##### Running install step. 04:10:02 INFO - ##### 04:10:02 INFO - Running pre-action listener: _resource_record_pre_action 04:10:02 INFO - Running main action method: install 04:10:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:10:02 INFO - Reading from file tmpfile_stdout 04:10:02 INFO - Detecting whether we're running mozinstall >=1.0... 04:10:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:10:02 INFO - Reading from file tmpfile_stdout 04:10:02 INFO - Output received: 04:10:02 INFO - Usage: mozinstall [options] installer 04:10:02 INFO - Options: 04:10:02 INFO - -h, --help show this help message and exit 04:10:02 INFO - -d DEST, --destination=DEST 04:10:02 INFO - Directory to install application into. [default: 04:10:02 INFO - "/builds/slave/test"] 04:10:02 INFO - --app=APP Application being installed. [default: firefox] 04:10:02 INFO - mkdir: /builds/slave/test/build/application 04:10:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:10:15 INFO - Reading from file tmpfile_stdout 04:10:15 INFO - Output received: 04:10:15 INFO - /builds/slave/test/build/application/firefox/firefox 04:10:15 INFO - Running post-action listener: _resource_record_post_action 04:10:15 INFO - ##### 04:10:15 INFO - ##### Running run-tests step. 04:10:15 INFO - ##### 04:10:15 INFO - Running pre-action listener: _resource_record_pre_action 04:10:15 INFO - Running main action method: run_tests 04:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:10:15 INFO - Python 2.7.3 04:10:15 INFO - Return code: 0 04:10:15 INFO - grabbing minidump binary from tooltool 04:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/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 0x27f2410>, '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 0x27f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f37a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:10:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:10:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:10:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:10:15 INFO - Return code: 0 04:10:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:10:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:10:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:10:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:10:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:10:16 INFO - Return code: 0 04:10:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:10:16 INFO - Using env: {'DISPLAY': ':0', 04:10:16 INFO - 'HOME': '/home/cltbld', 04:10:16 INFO - 'LANG': 'en_US.UTF-8', 04:10:16 INFO - 'LANGUAGE': 'en_US:en', 04:10:16 INFO - 'LOGNAME': 'cltbld', 04:10:16 INFO - 'MAIL': '/var/mail/cltbld', 04:10:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:10:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:16 INFO - 'MOZ_NO_REMOTE': '1', 04:10:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:10:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:16 INFO - 'NO_EM_RESTART': '1', 04:10:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:16 INFO - 'PWD': '/builds/slave/test', 04:10:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:10:16 INFO - 'SHELL': '/bin/bash', 04:10:16 INFO - 'SHLVL': '1', 04:10:16 INFO - 'TERM': 'linux', 04:10:16 INFO - 'TMOUT': '86400', 04:10:16 INFO - 'USER': 'cltbld', 04:10:16 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103', 04:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:16 INFO - '_': '/tools/buildbot/bin/python'} 04:10:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:10:17 INFO - mozversion application_buildid: 20160717013154 04:10:17 INFO - mozversion application_changeset: 92ec0fc8583e2a8bf38f0d8e98a3b78cda4eebaa 04:10:17 INFO - mozversion application_display_name: Firefox 04:10:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:10:17 INFO - mozversion application_name: Firefox 04:10:17 INFO - mozversion application_remotingname: firefox 04:10:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:10:17 INFO - mozversion application_vendor: Mozilla 04:10:17 INFO - mozversion application_version: 48.0 04:10:17 INFO - mozversion platform_buildid: 20160717013154 04:10:17 INFO - mozversion platform_changeset: 92ec0fc8583e2a8bf38f0d8e98a3b78cda4eebaa 04:10:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:10:17 INFO - mozversion platform_version: 48.0 04:10:17 INFO - using testdate: 1468753817 04:10:17 INFO - actual date: 1468753817 04:10:17 INFO - starting webserver on 'localhost:59452' 04:10:17 INFO - SUITE-START | Running 2 tests 04:10:17 INFO - TEST-START | dromaeo_css 04:10:17 INFO - operating with platform_type : linux_ 04:10:17 INFO - Initialising browser for dromaeo_css test... 04:10:17 INFO - TEST-INFO | started process 8301 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Ad_mx/profile http://localhost:59452/getInfo.html) 04:10:21 INFO - PROCESS | 8301 | 04:10:21 INFO - PROCESS | 8301 | (process:8379): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:10:21 INFO - PROCESS | 8301 | __metrics Screen width/height:1600/1200 04:10:21 INFO - PROCESS | 8301 | colorDepth:24 04:10:21 INFO - PROCESS | 8301 | Browser inner width/height: 1024/697 04:10:21 INFO - PROCESS | 8301 | __metrics 04:10:22 ERROR - PROCESS | 8301 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:10:23 INFO - TEST-INFO | 8301: exit 0 04:10:23 INFO - Browser initialized. 04:10:23 INFO - Running cycle 1/1 for dromaeo_css test... 04:10:23 INFO - TEST-INFO | started process 8429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Ad_mx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:10:25 INFO - PROCESS | 8429 | 04:10:25 INFO - PROCESS | 8429 | (process:8497): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:10:35 INFO - PROCESS | 8429 | RSS: Main: 150327296 04:10:35 INFO - PROCESS | 8429 | 04:11:24 INFO - PROCESS | 8429 | 1468753884743 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] 04:13:31 INFO - PROCESS | 8429 | Cycle 1(1): loaded http://localhost:59452/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59452/tests/dromaeo/cssquery-ext.html) 04:13:32 INFO - PROCESS | 8429 | RSS: Main: 154116096 04:13:32 INFO - PROCESS | 8429 | 04:16:34 INFO - PROCESS | 8429 | Cycle 1(1): loaded http://localhost:59452/tests/dromaeo/cssquery-ext.html (next: http://localhost:59452/tests/dromaeo/cssquery-jquery.html) 04:16:35 INFO - PROCESS | 8429 | RSS: Main: 152494080 04:16:35 INFO - PROCESS | 8429 | 04:19:37 INFO - PROCESS | 8429 | Cycle 1(1): loaded http://localhost:59452/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59452/tests/dromaeo/cssquery-mootools.html) 04:19:37 INFO - PROCESS | 8429 | RSS: Main: 152215552 04:19:37 INFO - PROCESS | 8429 | 04:22:39 INFO - PROCESS | 8429 | Cycle 1(1): loaded http://localhost:59452/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59452/tests/dromaeo/cssquery-prototype.html) 04:22:40 INFO - PROCESS | 8429 | RSS: Main: 153890816 04:22:40 INFO - PROCESS | 8429 | 04:25:42 INFO - PROCESS | 8429 | Cycle 1(1): loaded http://localhost:59452/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59452/tests/dromaeo/cssquery-yui.html) 04:25:42 INFO - PROCESS | 8429 | RSS: Main: 152084480 04:25:42 INFO - PROCESS | 8429 | 04:28:45 INFO - PROCESS | 8429 | Cycle 1(1): loaded http://localhost:59452/tests/dromaeo/cssquery-yui.html (next: http://localhost:59452/tests/dromaeo/cssquery-dojo.html) 04:28:45 INFO - PROCESS | 8429 | RSS: Main: 155541504 04:28:45 INFO - PROCESS | 8429 | 04:28:45 INFO - PROCESS | 8429 | __start_tp_report 04:28:45 INFO - PROCESS | 8429 | _x_x_mozilla_page_load 04:28:45 INFO - PROCESS | 8429 | _x_x_mozilla_page_load_details 04:28:45 INFO - PROCESS | 8429 | |i|pagename|runs| 04:28:45 INFO - PROCESS | 8429 | |0;dojo.html;3309.3546758382117;3360.983195084025;3370.3596316699827;3373.3590617782606;3415.538902248196;5527.806526771564;5532.446755324466;5564.10974244121;5598.9160162597545;5606.467385598372;5503.559715222783;5522.91715624265;5572.60991730578;5582.385937546866;5628.971855140719;5017.999999999991;5046.798128074873;5106.693598384109;5115.053715062707;5157.458466860982;4995.550400463958;4999.925001124986;5043.067032598962;5149.716765577892;5202.193659982709;5047.848564543069;5072.416672082721;5110.105731496973;5146.459621739719;5168.147255702824;5093.465186155456;5108.6168537359845;5110.591152707793;5122.974385128088;5154.20109882965;4946.703197808143;4973.62697797663;5012.373453318335;5022.698638081691;5100.566451851597;5301.231321458367;5357.7589008494715;5371.382291036542;5382.4886635769535;5391.81128660495;5835.008048631743;5871.471567558898;5872.823815285548;5878.470937615635;5879.617824841372;5835.270591176103;5912.260967379078;5912.438318359749;5918.467337939563;5979.701014949279;5611.943880561183;5615.80344687938;5615.887682246333;5619.719014049322;5621.634593751393;6090.908636370458;6109.5112391008615;6109.694515274218;6111.54163437744;6132.294786099566;5615.606907516516;5808.651480911074;5844.064949608042;5879.676617785977;5899.76400943966;5867.031939729982;5883.441073098049;5883.646981181143;5886.05823068307;5889.440503152194;5776.364599894008;5829.912551311733;5838.241028666246;5861;5865.266841644794;5670.06443936754;5740.6268592541355;5774.566907481955;5780.335261444903;5817.941820581825;4501.707389019703;4509.729416235036;4516.23224051912;4527.501974782771;4543.227651299287;4000.7799571023293;4073.796310184479;4077.5922407758985;4086.5096188457574;4108;5492.313460817398;5551.056320425538;5678.687672177987;5724.856878577985;5778.219940308089;5860.853478663067;5888.852778680567;5895.233619629421;5905.202797622352;5935.703214839241;5568.1091025435735;5587.357453892773;5613.045782217033;5666;5681;5070.062038522885;5072.721000345016;5078.949210507922;5079.466656001141;5104.540591346722;6144.139820425144;6144.600600960924;6167.5682702210415;6170;6178.7219575119225;5723.284589426322;5807.506361959112;5908.3500814911185;5909.556783241188;5935.169076329317;6094.939050609437;6129.233845769279;6136.723847426966;6136.815895523141;6142.846428839315;5766.135079738073;5770.13447982806;5776.220210271727;5779.971100144472;5785.913211301918;5793.391693872083;5861.384554621874;5956.672383018976;6005.549583781147;6017.458428741435;5843.912341314799;5849.327327357409;5856.0630299151935;5856.882862342814;5859.794907178229;5805.883882322414;5820.447057529528;5844.12338149281;5844.590878638454;5873.911891321548;5581.358143813513;5669.036263835075;5752.511036561939;5758.62568933018;5798.94201057984;5799.420057994167;5822.359540450631;5850.765969361178;5891.469767720926;5901.9966605678;5496.010718070625;5728.627639203439;5799.4780469757925;5809.622374545641;5815.82552523425 04:28:45 INFO - PROCESS | 8429 | |1;ext.html;680.217749587974;691.3017851969511;693.0262980512382;732.9670164842578;754.5812074298764;39205.411918821206;40023.39964900525;40097.193196476255;40152;40443;42893.57106428935;43585.56414435855;43639;43710.344344834855;43726;8814.294856411472;8984.19142277195;8985.595648195815;8993.955030224839;9015.504147271897;8686.218240358367;8801.075887031866;8869.911300887004;9066.093390660948;9080.182783549479;9069.863952040692;9103.54482275887;9111.544422778868;9114.498702571356;9132.497712625804;9021.323400744937;9061.728148155566;9073.13805188506;9117.635294588208;9121.771955701095;9039.954800226022;9063.41087829289;9132.497712625804;9141.222996045344;9153;42714.1457170858;43231.783841080905;43236.35145472789;43328.56671433277;43353.34969975453;3779.829907654162;4010.378391349316;4017.817194786068;4043.3732771420478;4712.976435117803;33141;33396.83301583501;33407.665923340945;34670.30659386798;35288;4546.249868771649;4614.953850461486;4632.18936686082;4660.603848672867;4660.790264438108;313049;313511;313672;315347;318065;39222.803885980386;39998.80000600037;59181.70409147927;60017.69991150016;60023.39976600266;38174.80912595419;38236.42645360322;38285;38320.80839595784;38387.80806095952;17165.914170429318;17225.052622105904;17233.56916077083;17323.133843307784;17333.13334333278;14593.343299551545;14638.414463421344;14682.119072855663;14741.484048058266;14766;9293;9427.528623568931;9440.433573985583;9455.810883782286;9513.334066615409;3585.480105384757;3628.691561217326;3641.417373220325;3692.0769807548113;3710.0910276982313;1094.441834664327;1111.5942680921567;1154.0536759856836;1156.9479373428217;1165.3998190931677;29446.705532944823;31178.532322015188;31387.843060785006;31938.840305798323;32258.677413226036;1284.4348486665838;1304.0350140895669;1310.33173081729;1311.8163457116011;1382.3641125082374;16275;16515;16544.255508502145;16657.583560410843;16718.164091795607;468805;476645;584784;615984;627570;57236.42763572394;58946.41053589495;59026;59058.704706476194;59131.70434147802;1537.36967843186;1543.9691206175814;1547.0640262641166;1551.8913676042794;1576.4246050191828;31060.68939310578;31330.843345783127;31596;32389;32419.35161296808;54655.453445465035;60821;62366.376336236055;62568;62585.68707156435;425360;427834;427835;431289;436170;46780.53219467898;46804.53195468138;47198;47373.289400659705;47520.52479475161;50147.24779128243;50620.746896265286;50651.493485064675;51793.7410312946;52235;43313.783431082644;43505.34741978809;43530;43614.78192609143;45357;43039;43057.56942430536;43340.34989475223;43443;43764;44466;44937.32594011158;45589;45813.31280030736;46510;33599.66400336063;34237;34663.306733865684;34814.47778283378;34923.126921826144;27582.310442239104;28918.855405722836;29763.55354669725;29839.850800746724;30128.548071778503 04:28:45 INFO - PROCESS | 8429 | |2;jquery.html;426.94663167104113;437.17464781782735;440.7707991844241;441.8387288639648;446.6159103171272;18741.34405295813;19051.23795048198;19544.31594894177;19696;19896.801031989675;19763;20038.699419508717;20258;20335.796642033576;20419.591608167826;5562.972185139069;5679.829605111843;5792.189093526909;5819.330776960662;5825.563082768809;5454.645448045884;5700.800471983482;5708.08670612702;5754.539636829044;5774.855628609276;5676.290463692038;5729.627574207663;5733.340665823421;5737.196792449061;5761.452661997104;5851.648901065907;5868.2371291732015;5902.2622172228475;5926.496247818897;5949.3158286796925;5620;5713.114467257582;5729.799457018984;5748.712564371806;5750.25246717924;13254.668633284246;13861.376238069312;14010.369533371022;14032.859671403257;14114.647133821634;2313.3753886450563;2321.68657231275;2536.112360673749;2573.858437785921;2703.9459210815676;9946;10106.039926206999;10317.948410257975;10508;10580.52387642558;1927.0075910905894;1979.9505012374661;2037.765656949455;2064.112431654388;2121.618108740426;82399;84810;86752;86937.56531217367;87159;11375.431228438545;11383.658490245305;11546.884531154581;11621.941890290494;11713;15804.60488487797;16007.679846403007;16058;16058.27737751804;16112.67774644524;8784.001987330766;9055.773605659911;9106.180443760093;9127.361084724005;9162.725118246462;9019.594118264562;9049.411788233743;9146.542672866462;9170.174684278447;9195.586198621078;4742.644301677388;4871.610271178297;4927.063857866994;4936.975315123402;5019.121653710586;1869;1889.1970912362192;1958.1971391729323;2043.5504189078379;2063.8245749111493;962.8892677342055;1041.7655078731727;1041.827173994082;1058.6347710040025;1124.5108377855659;17221;18496;18864.717029244573;18997.240110395705;19200.8079919199;1036.5231993283023;1067.2635881242074;1083.6478144603036;1085.4409978860892;1094.179365475893;9825.508724563742;10833.187510936554;10837.133029357632;10949.83575246372;11043.226974111734;163539;164425;376089;381468;385963;97799.51100244453;102545;103980.48009759902;104846;105209;1118.5805323003874;1145.3128123126223;1197.7963746163173;1212.3150420012664;1215.9027277817754;17296.394626188023;17380.913095434444;17528.649427011642;17618.735718964483;17662.470125896245;39463.60536394599;40326.798366007984;41544.376834346906;41747.7912610435;41778.58221417747;58776.4122358788;60356.39643603508;60781;60833.69583152233;61035.08447373382;8300.252977232078;8377.329813615019;8383.496990180609;8465;8548.487090774574;12399.132060756021;12565.120441569368;12608.684782880502;12691.492340306284;13048.347582620641;11339.716507087389;11541.192116551762;11777;11934.582289619822;12101.75796484083;11166.38584877807;11199.328040317607;11286.548538058385;11331.036861866834;11609.419529023684;8084.07033191167;11878.762424751629;11955.462004210005;12000.459979301128;12289.446974885972;8587.957060214909;8589.699360522602;8594.140585941355;8685.218330350299;8742.91257087421;8696.434731742416;11139.610113645984;11402.144839136932;11444.771104578029;11630 04:28:45 INFO - PROCESS | 8429 | |3;mootools.html;1581.87345012399;1601.6466086157193;1821.0621529912098;1888.924443022279;1896.0565420444052;7548.094228692551;8127.512349259048;8263.297619702325;8519.148085191486;8531.061583225848;7964.5619490927975;8059.91940080599;8131.064927533335;8169.754907352789;8176.509409435438;2355.9411014724596;2382.690250267463;2399.9760002399926;2400.6159014557675;2404.5431368040017;2370.514044620857;2405.2784164750506;2428.7449817769143;2436.768506991833;2439.4145405102736;2345.8827058647084;2346.5072334809624;2361.3506285771377;2365.44412063165;2373.299876536426;2392.174699728591;2418.4800267942387;2426.138720754142;2426.429788999575;2427.0655797517907;2383.4041489627593;2401.1955994741606;2401.8558886466867;2403.0267741564694;2415.6376543518613;8497.107803680587;8534.061253262136;8554.914450855475;8558.529280889548;8603.225709686096;5151.330327057459;5202.08963431398;5242.135047717122;5251.501107394792;5273.1299335609965;3237.0450717038293;3248.642649308574;3313.1385839681616;3318.983405082983;3319.0706602151436;1047.2459828923163;1092.6012005617893;1098.4397957041886;1101.7465982823915;1105.5688281570194;11734.706632334175;11976.221545599596;12007.759844803055;12021.038316934711;12040.698982525508;4533.297338912474;4538;4614.123316569841;4631.930521042187;4633.7683115844075;10313.896861031444;10321.74195645115;10322.948385258025;10360.637377691744;10364.222683298784;5318.97340513295;5319.069162896555;5340.626156169109;5341.412444631087;5354.250404943311;4632.907341853212;4717.693349932243;4769.165396055746;4785.59322457595;4887.633427492881;3828.693704503689;3873.8450461981206;3906.1015966327905;3906.140649057203;3949.328614135604;1145.2498613408231;1150.8446359741495;1152.1071169843271;1159.6694941941507;1182.5920057580122;889.6352495476823;1011.2163073618005;1016.5374754486838;1020.3418794877263;1022.539857064324;5461.453854614586;5529.723513824292;5530.723463826793;5618.213450116987;5670.177824215466;446.7252639626671;459.297275168992;468.0475232901098;474.2459489411852;476.792595221073;3775.452559378875;3819.3698039823116;3822.2546603412625;3836.5779764225913;3875.205582855508;10226;10640.946795266129;10658.946705266424;10741.033307002408;10811.83782243267;10183.694489165337;10531.473426328654;10549.9472502637;10699.893001070046;10707.250492465608;8211.507309561446;8224.506529608243;8242.052164001097;8254.0507841599;8316.251537361666;5528.723563821713;5542.695151766691;5551.945958546287;5617.747201375866;5684.8010319638615;9309.72070837876;9442.669506567237;9551.761205969906;9599.856002159833;9645.517724113626;9440.811183776148;9577.712668619952;9759.170470510086;9787.412755234709;10058.698239052841;6474.935250647433;6905.205901321211;7046.647667616701;7360.96319518399;7394.038774959221;7696.961515192388;7819.178986206366;7862.764117076496;7885.842283154419;7922.603869806371;6598.505112116706;6787.321267873173;6839;6977.267386924503;7098.183708873339;6934.965325173342;7022.964885175541;7058.964705176647;7068;7069.434445244471;6318.557700961072;6400.935990640221;6427.292997770148;6433.131527243762;6572.671366431755;4989.151844186425;5025.145725226794;5028.572571331331;5040;5046.596272298134;4951.306817045688;4962.3052772611145;4989.326440930573;4992.276119962513;5012.398512178562 04:28:45 INFO - PROCESS | 8429 | |4;prototype.html;326.42060342891364;327.2163169209743;328.9506574013898;338.41285369883263;341.0909925049741;6468.223813142429;6528.41244288014;6546.887029205035;6547.050677651738;6550.475961923046;6362.459190968773;6372.840678983028;6374.776882809103;6411.070394792752;6513.706883190256;4733.502982186872;4861.854144375674;4883.926741098886;4910.582600478946;4911.263310503417;4845.491223421543;4870.220764677652;4876.000419913909;4887.1447496688115;4895.192293271606;4814.566688997989;4823.155947709154;4831.782569784368;4839.080574690815;4841.225403935371;4835.854924352275;4847.418309802811;4850.12697714413;4854.563089321978;4857.757112144379;4197.874063778091;4200.201961627281;4200.474940632421;4200.768957707325;4202.306619407794;6118.1434599156155;6230.221222347207;6281.24625044993;6283.874322513524;6294.716737746812;5565.638233514849;5568.610197286192;5570.415106413809;5571.275734154534;5577.358603760579;6761.256261811197;6773.153355830521;6815.897761533532;6819.863602727967;6823;4567.406237189178;4570;4571.977140114278;4572.1312950539295;4590.770461476913;7125.144982602069;7146.071010768567;7182.856342873166;7189.856202875965;7205.4595905307315;4661.627069834473;4750.477447480775;4752.976235118802;4759.690620109682;4760.880977975509;4775.450823155312;4824.614030877521;4827.975860120677;4828.7102773833685;4828.927566086441;5624.184493248456;5640.294963129609;5641.858953526113;5641.971790141023;5646.97176514123;6878.828029299308;6891.483138764613;6898.103246577913;6902.344277293649;6903.240643529208;1672.7825382700414;1700.3793615330562;1702.0808763267696;1703.3016463250008;1707.487753673893;1068.0654427376046;1096.9067629251444;1102.2725001498973;1111.0944580167138;1121.103117505992;6733.158355205599;6751.527393082535;6753.763618273435;6762.087118239073;6770.052192693027;7147.3210045045635;7163.641817909083;7168.996340512333;7172.533785303938;7195.604241766753;6532.314107018695;6614.040964060185;6666.400023997767;6671.13275274221;6754.392104710501;3865.091703449687;3870.974191839165;3872.0319920019997;3873.24471728016;3888.4944957155953;7490.962545187239;7553.357964573072;7571.3942884569105;7575.560643477832;7581.090269167735;7196.46026548011;7369.77890663281;7371.705131794668;7382.926170738331;7390.22402647725;7460.403167746567;7530.1340345859835;7530.472866899374;7538.886916696254;7542.057242844645;7161.785146445615;7191.352778249982;7192.568445893263;7192.892106618509;7200.135983681992;7066.258042905421;7110;7111.466640002124;7130.322619351154;7162.89255661155;7356.154042285206;7484.925150748423;7529;7532.962335188289;7580.279873412238;4733.313669517832;4751.097291514601;4769.30845027476;4775.570198682135;4780.259059845729;7205.135383753983;7220.169680486812;7229.457790665616;7236.059312289369;7239.710411583477;6962.1297337832775;6966.616836074065;6973.232944376013;6991.825204369931;7011.228764835966;6723.428508576826;6964.26875178099;6964.477664175106;6971.163460384786;6980.162380514371;6812.557183783038;6867.656617169221;6878.415334696607;6880.346367095118;6891.241963384124;7026.1217347831525;7037.1555413350725;7040.331168538981;7043.2604576518725;7056.576605403692;6864.24493305726;6878.3465570770695;6951.16586009682;6960.512764106464;6965.268646792014 04:28:45 INFO - PROCESS | 8429 | |5;yui.html;824.4682179993907;831.3141658132042;838.3209600223819;885.1325700813203;898.5776684958072;14850.925745371285;15146.772798408032;15242;15463.768043479356;15526;14168.858311416883;14231.78652320216;14250.928745356285;14338.641533961656;14343.21112338821;878.7890906182502;884.5179377239419;908.3641450984304;909.417972497602;913.2283220678516;894.11929249689;902.5803001604253;906.4878343735768;906.6509393883337;906.6735975048977;927.508420537113;934.2712684106408;934.5374039850284;934.6962237272879;936.0545848692801;916.0930678628176;920.5719340506696;922.1700469577366;924.9260059195282;928.4058202750246;682.1200651159998;683.4327508168209;685.396850771323;685.9657017149123;689;15283.083015019023;15374;15425.460108896246;15429.382824687;15429.922850385676;14126.505572305023;14259.928700356535;14290.499832505813;14320.785188222186;14388.06477578954;11784.351860647661;12026;12051.517939282507;12181.573644922473;12266.509339626404;4039.7778122203267;4056.3307054336296;4072.328065869128;4102.548719640867;4106.856260030914;58241;58338.70830645862;58398.41601583972;58987.41012589862;59149.70425147847;10593.417362045007;10783.460826958777;11340.319580825177;11513.30920144794;11639.47622356996;20063.699044514346;20121.798782012283;20123.698144527843;20224.595508089755;20234.797652023586;8038.7186448475195;8325.333973282122;8461.576921153917;8895.998400359867;8901.332400070021;4701.95298047022;4767.69010014348;4770.689905156154;4797.808087676453;4822.252550854623;3513.8243087845503;3566;3569.232614987738;3570.2680950405106;3571.39286321326;618.0636335951037;638.9361063893573;646.6411141816243;659.1069101367577;673.8214373191108;734.949022897262;794.6185830801247;800.8296078713498;835.4277320035795;866.2853146154448;9371;9572.56923438433;9657.517124143766;10105.444200568892;10150.995059425823;815.3477218225396;838.4508147163617;842.6713581703141;847.9576021198916;849.4011721736161;4607.677462577654;4722.905541889212;5074.155759455506;5097.898042039213;5221.686698798008;60802;62335.37664623386;62336.68831655903;62555.37444625587;62585.37414625796;53107.73446132745;53480;53798.731006344715;54058;55733;49688.75155624199;49993;50135;50257.49742502601;50854;9699.6120155193;9903.752406189902;9935.05616966387;9988.200943924614;10103.696889093339;36285;37437.43843842399;37692;37970.81014594909;38719.419208711326;45467.772661136485;46633.83415414642;46822;47156;47370.76314618405;12235.510579576718;12347.62957111288;12432.937835310766;12751.426185821474;12759;13810.37853296584;14525.346359414063;14527.201003944885;14544.490942817374;14552.927235363755;13593.320333983063;13901.513447029305;14165.929170354082;14469.27653617336;14644.560663180122;13394.866051339362;13665;13709.931450342685;13788.172709637454;14345.569632911029;13485.39315730814;13545.390457429636;13978.580642580739;14256.215908125152;14495;11155.21913466082;11222.719432014264;11431.199816012799;11595.304281742785;11858;11337.829932551183;11538.423078846192;11737;11874.109441792072;11879.287242765462 04:28:45 INFO - PROCESS | 8429 | __end_tp_report 04:28:45 INFO - PROCESS | 8429 | __start_cc_report 04:28:45 INFO - PROCESS | 8429 | _x_x_mozilla_cycle_collect,317 04:28:45 INFO - PROCESS | 8429 | __end_cc_report 04:28:45 INFO - PROCESS | 8429 | __startTimestamp1468754925470__endTimestamp 04:28:45 INFO - PROCESS | 8429 | 04:28:45 INFO - PROCESS | 8429 | ------- Summary: start ------- 04:28:45 INFO - PROCESS | 8429 | Number of tests: 6 04:28:45 INFO - PROCESS | 8429 | 04:28:45 INFO - PROCESS | 8429 | [#0] dojo.html Cycles:165 Average:5506.65 Median:5752.51 stddev:597.77 (10.4%) stddev-sans-first:574.22 04:28:45 INFO - PROCESS | 8429 | Values: 3309.4 3361.0 3370.4 3373.4 3415.5 5527.8 5532.4 5564.1 5598.9 5606.5 5503.6 5522.9 5572.6 5582.4 5629.0 5018.0 5046.8 5106.7 5115.1 5157.5 4995.6 4999.9 5043.1 5149.7 5202.2 5047.8 5072.4 5110.1 5146.5 5168.1 5093.5 5108.6 5110.6 5123.0 5154.2 4946.7 4973.6 5012.4 5022.7 5100.6 5301.2 5357.8 5371.4 5382.5 5391.8 5835.0 5871.5 5872.8 5878.5 5879.6 5835.3 5912.3 5912.4 5918.5 5979.7 5611.9 5615.8 5615.9 5619.7 5621.6 6090.9 6109.5 6109.7 6111.5 6132.3 5615.6 5808.7 5844.1 5879.7 5899.8 5867.0 5883.4 5883.6 5886.1 5889.4 5776.4 5829.9 5838.2 5861.0 5865.3 5670.1 5740.6 5774.6 5780.3 5817.9 4501.7 4509.7 4516.2 4527.5 4543.2 4000.8 4073.8 4077.6 4086.5 4108.0 5492.3 5551.1 5678.7 5724.9 5778.2 5860.9 5888.9 5895.2 5905.2 5935.7 5568.1 5587.4 5613.0 5666.0 5681.0 5070.1 5072.7 5078.9 5079.5 5104.5 6144.1 6144.6 6167.6 6170.0 6178.7 5723.3 5807.5 5908.4 5909.6 5935.2 6094.9 6129.2 6136.7 6136.8 6142.8 5766.1 5770.1 5776.2 5780.0 5785.9 5793.4 5861.4 5956.7 6005.5 6017.5 5843.9 5849.3 5856.1 5856.9 5859.8 5805.9 5820.4 5844.1 5844.6 5873.9 5581.4 5669.0 5752.5 5758.6 5798.9 5799.4 5822.4 5850.8 5891.5 5902.0 5496.0 5728.6 5799.5 5809.6 5815.8 04:28:45 INFO - PROCESS | 8429 | 04:28:45 INFO - PROCESS | 8429 | [#1] ext.html Cycles:180 Average:59633.94 Median:43275.07 stddev:118425.02 (273.7%) stddev-sans-first:118674.51 04:28:45 INFO - PROCESS | 8429 | Values: 680.2 691.3 693.0 733.0 754.6 39205.4 40023.4 40097.2 40152.0 40443.0 42893.6 43585.6 43639.0 43710.3 43726.0 8814.3 8984.2 8985.6 8994.0 9015.5 8686.2 8801.1 8869.9 9066.1 9080.2 9069.9 9103.5 9111.5 9114.5 9132.5 9021.3 9061.7 9073.1 9117.6 9121.8 9040.0 9063.4 9132.5 9141.2 9153.0 42714.1 43231.8 43236.4 43328.6 43353.3 3779.8 4010.4 4017.8 4043.4 4713.0 33141.0 33396.8 33407.7 34670.3 35288.0 4546.2 4615.0 4632.2 4660.6 4660.8 313049.0 313511.0 313672.0 315347.0 318065.0 39222.8 39998.8 59181.7 60017.7 60023.4 38174.8 38236.4 38285.0 38320.8 38387.8 17165.9 17225.1 17233.6 17323.1 17333.1 14593.3 14638.4 14682.1 14741.5 14766.0 9293.0 9427.5 9440.4 9455.8 9513.3 3585.5 3628.7 3641.4 3692.1 3710.1 1094.4 1111.6 1154.1 1156.9 1165.4 29446.7 31178.5 31387.8 31938.8 32258.7 1284.4 1304.0 1310.3 1311.8 1382.4 16275.0 16515.0 16544.3 16657.6 16718.2 468805.0 476645.0 584784.0 615984.0 627570.0 57236.4 58946.4 59026.0 59058.7 59131.7 1537.4 1544.0 1547.1 1551.9 1576.4 31060.7 31330.8 31596.0 32389.0 32419.4 54655.5 60821.0 62366.4 62568.0 62585.7 425360.0 427834.0 427835.0 431289.0 436170.0 46780.5 46804.5 47198.0 47373.3 47520.5 50147.2 50620.7 50651.5 51793.7 52235.0 43313.8 43505.3 43530.0 43614.8 45357.0 43039.0 43057.6 43340.3 43443.0 43764.0 44466.0 44937.3 45589.0 45813.3 46510.0 33599.7 34237.0 34663.3 34814.5 34923.1 27582.3 28918.9 29763.6 29839.9 30128.5 04:28:45 INFO - PROCESS | 8429 | 04:28:45 INFO - PROCESS | 8429 | [#2] jquery.html Cycles:180 Average:23861.36 Median:11228.68 stddev:53929.14 (480.3%) stddev-sans-first:54051.73 04:28:45 INFO - PROCESS | 8429 | Values: 426.9 437.2 440.8 441.8 446.6 18741.3 19051.2 19544.3 19696.0 19896.8 19763.0 20038.7 20258.0 20335.8 20419.6 5563.0 5679.8 5792.2 5819.3 5825.6 5454.6 5700.8 5708.1 5754.5 5774.9 5676.3 5729.6 5733.3 5737.2 5761.5 5851.6 5868.2 5902.3 5926.5 5949.3 5620.0 5713.1 5729.8 5748.7 5750.3 13254.7 13861.4 14010.4 14032.9 14114.6 2313.4 2321.7 2536.1 2573.9 2703.9 9946.0 10106.0 10317.9 10508.0 10580.5 1927.0 1980.0 2037.8 2064.1 2121.6 82399.0 84810.0 86752.0 86937.6 87159.0 11375.4 11383.7 11546.9 11621.9 11713.0 15804.6 16007.7 16058.0 16058.3 16112.7 8784.0 9055.8 9106.2 9127.4 9162.7 9019.6 9049.4 9146.5 9170.2 9195.6 4742.6 4871.6 4927.1 4937.0 5019.1 1869.0 1889.2 1958.2 2043.6 2063.8 962.9 1041.8 1041.8 1058.6 1124.5 17221.0 18496.0 18864.7 18997.2 19200.8 1036.5 1067.3 1083.6 1085.4 1094.2 9825.5 10833.2 10837.1 10949.8 11043.2 163539.0 164425.0 376089.0 381468.0 385963.0 97799.5 102545.0 103980.5 104846.0 105209.0 1118.6 1145.3 1197.8 1212.3 1215.9 17296.4 17380.9 17528.6 17618.7 17662.5 39463.6 40326.8 41544.4 41747.8 41778.6 58776.4 60356.4 60781.0 60833.7 61035.1 8300.3 8377.3 8383.5 8465.0 8548.5 12399.1 12565.1 12608.7 12691.5 13048.3 11339.7 11541.2 11777.0 11934.6 12101.8 11166.4 11199.3 11286.5 11331.0 11609.4 8084.1 11878.8 11955.5 12000.5 12289.4 8588.0 8589.7 8594.1 8685.2 8742.9 8696.4 11139.6 11402.1 11444.8 11630.0 04:28:45 INFO - PROCESS | 8429 | 04:28:45 INFO - PROCESS | 8429 | [#3] mootools.html Cycles:180 Average:5568.98 Median:475.52 stddev:3140.28 (660.4%) stddev-sans-first:3134.80 04:28:45 INFO - PROCESS | 8429 | Values: 1581.9 1601.6 1821.1 1888.9 1896.1 7548.1 8127.5 8263.3 8519.1 8531.1 7964.6 8059.9 8131.1 8169.8 8176.5 2355.9 2382.7 2400.0 2400.6 2404.5 2370.5 2405.3 2428.7 2436.8 2439.4 2345.9 2346.5 2361.4 2365.4 2373.3 2392.2 2418.5 2426.1 2426.4 2427.1 2383.4 2401.2 2401.9 2403.0 2415.6 8497.1 8534.1 8554.9 8558.5 8603.2 5151.3 5202.1 5242.1 5251.5 5273.1 3237.0 3248.6 3313.1 3319.0 3319.1 1047.2 1092.6 1098.4 1101.7 1105.6 11734.7 11976.2 12007.8 12021.0 12040.7 4533.3 4538.0 4614.1 4631.9 4633.8 10313.9 10321.7 10322.9 10360.6 10364.2 5319.0 5319.1 5340.6 5341.4 5354.3 4632.9 4717.7 4769.2 4785.6 4887.6 3828.7 3873.8 3906.1 3906.1 3949.3 1145.2 1150.8 1152.1 1159.7 1182.6 889.6 1011.2 1016.5 1020.3 1022.5 5461.5 5529.7 5530.7 5618.2 5670.2 446.7 459.3 468.0 474.2 476.8 3775.5 3819.4 3822.3 3836.6 3875.2 10226.0 10640.9 10658.9 10741.0 10811.8 10183.7 10531.5 10549.9 10699.9 10707.3 8211.5 8224.5 8242.1 8254.1 8316.3 5528.7 5542.7 5551.9 5617.7 5684.8 9309.7 9442.7 9551.8 9599.9 9645.5 9440.8 9577.7 9759.2 9787.4 10058.7 6474.9 6905.2 7046.6 7361.0 7394.0 7697.0 7819.2 7862.8 7885.8 7922.6 6598.5 6787.3 6839.0 6977.3 7098.2 6935.0 7023.0 7059.0 7068.0 7069.4 6318.6 6400.9 6427.3 6433.1 6572.7 4989.2 5025.1 5028.6 5040.0 5046.6 4951.3 4962.3 4989.3 4992.3 5012.4 04:28:45 INFO - PROCESS | 8429 | 04:28:45 INFO - PROCESS | 8429 | [#4] prototype.html Cycles:180 Average:5764.05 Median:6582.26 stddev:1797.55 (27.3%) stddev-sans-first:1755.65 04:28:45 INFO - PROCESS | 8429 | Values: 326.4 327.2 329.0 338.4 341.1 6468.2 6528.4 6546.9 6547.1 6550.5 6362.5 6372.8 6374.8 6411.1 6513.7 4733.5 4861.9 4883.9 4910.6 4911.3 4845.5 4870.2 4876.0 4887.1 4895.2 4814.6 4823.2 4831.8 4839.1 4841.2 4835.9 4847.4 4850.1 4854.6 4857.8 4197.9 4200.2 4200.5 4200.8 4202.3 6118.1 6230.2 6281.2 6283.9 6294.7 5565.6 5568.6 5570.4 5571.3 5577.4 6761.3 6773.2 6815.9 6819.9 6823.0 4567.4 4570.0 4572.0 4572.1 4590.8 7125.1 7146.1 7182.9 7189.9 7205.5 4661.6 4750.5 4753.0 4759.7 4760.9 4775.5 4824.6 4828.0 4828.7 4828.9 5624.2 5640.3 5641.9 5642.0 5647.0 6878.8 6891.5 6898.1 6902.3 6903.2 1672.8 1700.4 1702.1 1703.3 1707.5 1068.1 1096.9 1102.3 1111.1 1121.1 6733.2 6751.5 6753.8 6762.1 6770.1 7147.3 7163.6 7169.0 7172.5 7195.6 6532.3 6614.0 6666.4 6671.1 6754.4 3865.1 3871.0 3872.0 3873.2 3888.5 7491.0 7553.4 7571.4 7575.6 7581.1 7196.5 7369.8 7371.7 7382.9 7390.2 7460.4 7530.1 7530.5 7538.9 7542.1 7161.8 7191.4 7192.6 7192.9 7200.1 7066.3 7110.0 7111.5 7130.3 7162.9 7356.2 7484.9 7529.0 7533.0 7580.3 4733.3 4751.1 4769.3 4775.6 4780.3 7205.1 7220.2 7229.5 7236.1 7239.7 6962.1 6966.6 6973.2 6991.8 7011.2 6723.4 6964.3 6964.5 6971.2 6980.2 6812.6 6867.7 6878.4 6880.3 6891.2 7026.1 7037.2 7040.3 7043.3 7056.6 6864.2 6878.3 6951.2 6960.5 6965.3 04:28:45 INFO - PROCESS | 8429 | 04:28:45 INFO - PROCESS | 8429 | [#5] yui.html Cycles:180 Average:15467.25 Median:46727.92 stddev:17400.54 (37.2%) stddev-sans-first:17414.61 04:28:45 INFO - PROCESS | 8429 | Values: 824.5 831.3 838.3 885.1 898.6 14850.9 15146.8 15242.0 15463.8 15526.0 14168.9 14231.8 14250.9 14338.6 14343.2 878.8 884.5 908.4 909.4 913.2 894.1 902.6 906.5 906.7 906.7 927.5 934.3 934.5 934.7 936.1 916.1 920.6 922.2 924.9 928.4 682.1 683.4 685.4 686.0 689.0 15283.1 15374.0 15425.5 15429.4 15429.9 14126.5 14259.9 14290.5 14320.8 14388.1 11784.4 12026.0 12051.5 12181.6 12266.5 4039.8 4056.3 4072.3 4102.5 4106.9 58241.0 58338.7 58398.4 58987.4 59149.7 10593.4 10783.5 11340.3 11513.3 11639.5 20063.7 20121.8 20123.7 20224.6 20234.8 8038.7 8325.3 8461.6 8896.0 8901.3 4702.0 4767.7 4770.7 4797.8 4822.3 3513.8 3566.0 3569.2 3570.3 3571.4 618.1 638.9 646.6 659.1 673.8 734.9 794.6 800.8 835.4 866.3 9371.0 9572.6 9657.5 10105.4 10151.0 815.3 838.5 842.7 848.0 849.4 4607.7 4722.9 5074.2 5097.9 5221.7 60802.0 62335.4 62336.7 62555.4 62585.4 53107.7 53480.0 53798.7 54058.0 55733.0 49688.8 49993.0 50135.0 50257.5 50854.0 9699.6 9903.8 9935.1 9988.2 10103.7 36285.0 37437.4 37692.0 37970.8 38719.4 45467.8 46633.8 46822.0 47156.0 47370.8 12235.5 12347.6 12432.9 12751.4 12759.0 13810.4 14525.3 14527.2 14544.5 14552.9 13593.3 13901.5 14165.9 14469.3 14644.6 13394.9 13665.0 13709.9 13788.2 14345.6 13485.4 13545.4 13978.6 14256.2 14495.0 11155.2 11222.7 11431.2 11595.3 11858.0 11337.8 11538.4 11737.0 11874.1 11879.3 04:28:45 INFO - PROCESS | 8429 | -------- Summary: end -------- 04:28:45 INFO - PROCESS | 8429 | 04:28:46 INFO - TEST-INFO | 8429: exit 0 04:28:46 INFO - TEST-OK | dromaeo_css | took 1109114ms 04:28:46 INFO - TEST-START | kraken 04:28:46 INFO - operating with platform_type : linux_ 04:28:46 INFO - Initialising browser for kraken test... 04:28:46 INFO - TEST-INFO | started process 8675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzZuI8P/profile http://localhost:59452/getInfo.html) 04:28:49 INFO - PROCESS | 8675 | 04:28:49 INFO - PROCESS | 8675 | (process:8752): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:28:50 INFO - PROCESS | 8675 | __metrics Screen width/height:1600/1200 04:28:50 INFO - PROCESS | 8675 | colorDepth:24 04:28:50 INFO - PROCESS | 8675 | Browser inner width/height: 1024/697 04:28:50 INFO - PROCESS | 8675 | __metrics 04:28:51 ERROR - PROCESS | 8675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:28:52 INFO - TEST-INFO | 8675: exit 0 04:28:52 INFO - Browser initialized. 04:28:52 INFO - Running cycle 1/1 for kraken test... 04:28:52 INFO - TEST-INFO | started process 8803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzZuI8P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:54 INFO - PROCESS | 8803 | 04:28:54 INFO - PROCESS | 8803 | (process:8869): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:29:04 INFO - PROCESS | 8803 | RSS: Main: 150347776 04:29:04 INFO - PROCESS | 8803 | 04:29:06 INFO - PROCESS | 8803 | Cycle 1(1): loaded http://localhost:59452/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59452/tests/kraken/driver.html?testName=audio-beat-detection) 04:29:07 INFO - PROCESS | 8803 | RSS: Main: 155795456 04:29:07 INFO - PROCESS | 8803 | 04:29:10 INFO - PROCESS | 8803 | Cycle 1(1): loaded http://localhost:59452/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59452/tests/kraken/driver.html?testName=audio-dft) 04:29:10 INFO - PROCESS | 8803 | RSS: Main: 155758592 04:29:10 INFO - PROCESS | 8803 | 04:29:13 INFO - PROCESS | 8803 | Cycle 1(1): loaded http://localhost:59452/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59452/tests/kraken/driver.html?testName=audio-fft) 04:29:14 INFO - PROCESS | 8803 | RSS: Main: 156016640 04:29:14 INFO - PROCESS | 8803 | 04:29:16 INFO - PROCESS | 8803 | Cycle 1(1): loaded http://localhost:59452/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59452/tests/kraken/driver.html?testName=audio-oscillator) 04:29:16 INFO - PROCESS | 8803 | RSS: Main: 155561984 04:29:16 INFO - PROCESS | 8803 | 04:29:18 INFO - PROCESS | 8803 | Cycle 1(1): loaded http://localhost:59452/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59452/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:29:19 INFO - PROCESS | 8803 | RSS: Main: 155443200 04:29:19 INFO - PROCESS | 8803 | 04:29:22 INFO - PROCESS | 8803 | Cycle 1(1): loaded http://localhost:59452/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59452/tests/kraken/driver.html?testName=imaging-darkroom) 04:29:23 INFO - PROCESS | 8803 | RSS: Main: 156168192 04:29:23 INFO - PROCESS | 8803 | 04:29:26 INFO - PROCESS | 8803 | Cycle 1(1): loaded http://localhost:59452/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59452/tests/kraken/driver.html?testName=imaging-desaturate) 04:29:27 INFO - PROCESS | 8803 | RSS: Main: 156073984 04:29:27 INFO - PROCESS | 8803 | 04:29:29 INFO - PROCESS | 8803 | Cycle 1(1): loaded http://localhost:59452/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59452/tests/kraken/driver.html?testName=json-parse-financial) 04:29:30 INFO - PROCESS | 8803 | RSS: Main: 156413952 04:29:30 INFO - PROCESS | 8803 | 04:29:32 INFO - PROCESS | 8803 | Cycle 1(1): loaded http://localhost:59452/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59452/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:29:32 INFO - PROCESS | 8803 | RSS: Main: 156667904 04:29:32 INFO - PROCESS | 8803 | 04:29:34 INFO - PROCESS | 8803 | Cycle 1(1): loaded http://localhost:59452/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59452/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:29:35 INFO - PROCESS | 8803 | RSS: Main: 156884992 04:29:35 INFO - PROCESS | 8803 | 04:29:37 INFO - PROCESS | 8803 | Cycle 1(1): loaded http://localhost:59452/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59452/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:29:37 INFO - PROCESS | 8803 | RSS: Main: 156553216 04:29:37 INFO - PROCESS | 8803 | 04:29:40 INFO - PROCESS | 8803 | Cycle 1(1): loaded http://localhost:59452/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59452/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:29:40 INFO - PROCESS | 8803 | RSS: Main: 156815360 04:29:40 INFO - PROCESS | 8803 | 04:29:43 INFO - PROCESS | 8803 | Cycle 1(1): loaded http://localhost:59452/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59452/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:29:44 INFO - PROCESS | 8803 | RSS: Main: 156561408 04:29:44 INFO - PROCESS | 8803 | 04:29:45 INFO - PROCESS | 8803 | Cycle 1(1): loaded http://localhost:59452/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59452/tests/kraken/driver.html?testName=ai-astar) 04:29:46 INFO - PROCESS | 8803 | RSS: Main: 157863936 04:29:46 INFO - PROCESS | 8803 | 04:29:46 INFO - PROCESS | 8803 | __start_tp_report 04:29:46 INFO - PROCESS | 8803 | _x_x_mozilla_page_load 04:29:46 INFO - PROCESS | 8803 | _x_x_mozilla_page_load_details 04:29:46 INFO - PROCESS | 8803 | |i|pagename|runs| 04:29:46 INFO - PROCESS | 8803 | |0;ai-astar;108;111;106;110;112;112;100;111;111;112 04:29:46 INFO - PROCESS | 8803 | |1;audio-beat-detection;153;125;150;179;127;154;152;128;183;128 04:29:46 INFO - PROCESS | 8803 | |2;audio-dft;162;162;164;163;162;162;160;163;161;161 04:29:46 INFO - PROCESS | 8803 | |3;audio-fft;76;74;75;184;77;76;77;75;163;76 04:29:46 INFO - PROCESS | 8803 | |4;audio-oscillator;93;92;147;93;93;92;152;92;92;155 04:29:46 INFO - PROCESS | 8803 | |5;imaging-gaussian-blur;118;116;117;118;118;116;117;117;118;117 04:29:46 INFO - PROCESS | 8803 | |6;imaging-darkroom;146;146;146;146;145;146;146;147;146;145 04:29:46 INFO - PROCESS | 8803 | |7;imaging-desaturate;95;95;95;96;96;94;95;95;97;95 04:29:46 INFO - PROCESS | 8803 | |8;json-parse-financial;55;58;57;56;57;59;60;80;55;54 04:29:46 INFO - PROCESS | 8803 | |9;json-stringify-tinderbox;58;58;58;59;59;58;58;58;59;59 04:29:46 INFO - PROCESS | 8803 | |10;stanford-crypto-aes;72;74;73;73;75;74;74;74;74;74 04:29:46 INFO - PROCESS | 8803 | |11;stanford-crypto-ccm;121;127;116;116;122;114;115;117;127;128 04:29:46 INFO - PROCESS | 8803 | |12;stanford-crypto-pbkdf2;161;162;165;166;170;164;161;162;162;167 04:29:46 INFO - PROCESS | 8803 | |13;stanford-crypto-sha256-iterative;68;67;73;66;69;67;66;70;67;72 04:29:46 INFO - PROCESS | 8803 | __end_tp_report 04:29:46 INFO - PROCESS | 8803 | __start_cc_report 04:29:46 INFO - PROCESS | 8803 | _x_x_mozilla_cycle_collect,857 04:29:46 INFO - PROCESS | 8803 | __end_cc_report 04:29:46 INFO - PROCESS | 8803 | __startTimestamp1468754986120__endTimestamp 04:29:46 INFO - PROCESS | 8803 | 04:29:46 INFO - PROCESS | 8803 | ------- Summary: start ------- 04:29:46 INFO - PROCESS | 8803 | Number of tests: 14 04:29:46 INFO - PROCESS | 8803 | 04:29:46 INFO - PROCESS | 8803 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:3.80 (3.4%) stddev-sans-first:4.00 04:29:46 INFO - PROCESS | 8803 | Values: 108.0 111.0 106.0 110.0 112.0 112.0 100.0 111.0 111.0 112.0 04:29:46 INFO - PROCESS | 8803 | 04:29:46 INFO - PROCESS | 8803 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:152.50 stddev:21.18 (13.9%) stddev-sans-first:22.38 04:29:46 INFO - PROCESS | 8803 | Values: 153.0 125.0 150.0 179.0 127.0 154.0 152.0 128.0 183.0 128.0 04:29:46 INFO - PROCESS | 8803 | 04:29:46 INFO - PROCESS | 8803 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.15 (0.7%) stddev-sans-first:1.22 04:29:46 INFO - PROCESS | 8803 | Values: 162.0 162.0 164.0 163.0 162.0 162.0 160.0 163.0 161.0 161.0 04:29:46 INFO - PROCESS | 8803 | 04:29:46 INFO - PROCESS | 8803 | [#3] audio-fft Cycles:10 Average:95.30 Median:76.00 stddev:41.52 (54.6%) stddev-sans-first:43.45 04:29:46 INFO - PROCESS | 8803 | Values: 76.0 74.0 75.0 184.0 77.0 76.0 77.0 75.0 163.0 76.0 04:29:46 INFO - PROCESS | 8803 | 04:29:46 INFO - PROCESS | 8803 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:92.00 stddev:28.52 (31.0%) stddev-sans-first:29.57 04:29:46 INFO - PROCESS | 8803 | Values: 93.0 92.0 147.0 93.0 93.0 92.0 152.0 92.0 92.0 155.0 04:29:46 INFO - PROCESS | 8803 | 04:29:46 INFO - PROCESS | 8803 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.50 stddev:0.79 (0.7%) stddev-sans-first:0.78 04:29:46 INFO - PROCESS | 8803 | Values: 118.0 116.0 117.0 118.0 118.0 116.0 117.0 117.0 118.0 117.0 04:29:46 INFO - PROCESS | 8803 | 04:29:46 INFO - PROCESS | 8803 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:29:46 INFO - PROCESS | 8803 | Values: 146.0 146.0 146.0 146.0 145.0 146.0 146.0 147.0 146.0 145.0 04:29:46 INFO - PROCESS | 8803 | 04:29:46 INFO - PROCESS | 8803 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 04:29:46 INFO - PROCESS | 8803 | Values: 95.0 95.0 95.0 96.0 96.0 94.0 95.0 95.0 97.0 95.0 04:29:46 INFO - PROCESS | 8803 | 04:29:46 INFO - PROCESS | 8803 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:57.50 stddev:7.58 (13.2%) stddev-sans-first:7.89 04:29:46 INFO - PROCESS | 8803 | Values: 55.0 58.0 57.0 56.0 57.0 59.0 60.0 80.0 55.0 54.0 04:29:46 INFO - PROCESS | 8803 | 04:29:46 INFO - PROCESS | 8803 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 04:29:46 INFO - PROCESS | 8803 | Values: 58.0 58.0 58.0 59.0 59.0 58.0 58.0 58.0 59.0 59.0 04:29:46 INFO - PROCESS | 8803 | 04:29:46 INFO - PROCESS | 8803 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:74.00 stddev:0.82 (1.1%) stddev-sans-first:0.60 04:29:46 INFO - PROCESS | 8803 | Values: 72.0 74.0 73.0 73.0 75.0 74.0 74.0 74.0 74.0 74.0 04:29:46 INFO - PROCESS | 8803 | 04:29:46 INFO - PROCESS | 8803 | [#11] stanford-crypto-ccm Cycles:10 Average:120.30 Median:121.50 stddev:5.46 (4.5%) stddev-sans-first:5.78 04:29:46 INFO - PROCESS | 8803 | Values: 121.0 127.0 116.0 116.0 122.0 114.0 115.0 117.0 127.0 128.0 04:29:46 INFO - PROCESS | 8803 | 04:29:46 INFO - PROCESS | 8803 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.00 Median:164.50 stddev:2.98 (1.8%) stddev-sans-first:2.96 04:29:46 INFO - PROCESS | 8803 | Values: 161.0 162.0 165.0 166.0 170.0 164.0 161.0 162.0 162.0 167.0 04:29:46 INFO - PROCESS | 8803 | 04:29:46 INFO - PROCESS | 8803 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:2.46 (3.6%) stddev-sans-first:2.60 04:29:46 INFO - PROCESS | 8803 | Values: 68.0 67.0 73.0 66.0 69.0 67.0 66.0 70.0 67.0 72.0 04:29:46 INFO - PROCESS | 8803 | -------- Summary: end -------- 04:29:46 INFO - PROCESS | 8803 | 04:29:47 INFO - TEST-INFO | 8803: exit 0 04:29:47 INFO - TEST-OK | kraken | took 60897ms 04:29:47 INFO - SUITE-END | took 1170s 04:29:47 INFO - Completed test suite (00:19:30) 04:29:47 INFO - javascript benchmark 04:29:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3309.3546758382117, 3360.983195084025, 3370.3596316699827, 3373.3590617782606, 3415.538902248196, 5527.806526771564, 5532.446755324466, 5564.10974244121, 5598.9160162597545, 5606.467385598372, 5503.559715222783, 5522.91715624265, 5572.60991730578, 5582.385937546866, 5628.971855140719, 5017.999999999991, 5046.798128074873, 5106.693598384109, 5115.053715062707, 5157.458466860982, 4995.550400463958, 4999.925001124986, 5043.067032598962, 5149.716765577892, 5202.193659982709, 5047.848564543069, 5072.416672082721, 5110.105731496973, 5146.459621739719, 5168.147255702824, 5093.465186155456, 5108.6168537359845, 5110.591152707793, 5122.974385128088, 5154.20109882965, 4946.703197808143, 4973.62697797663, 5012.373453318335, 5022.698638081691, 5100.566451851597, 5301.231321458367, 5357.7589008494715, 5371.382291036542, 5382.4886635769535, 5391.81128660495, 5835.008048631743, 5871.471567558898, 5872.823815285548, 5878.470937615635, 5879.617824841372, 5835.270591176103, 5912.260967379078, 5912.438318359749, 5918.467337939563, 5979.701014949279, 5611.943880561183, 5615.80344687938, 5615.887682246333, 5619.719014049322, 5621.634593751393, 6090.908636370458, 6109.5112391008615, 6109.694515274218, 6111.54163437744, 6132.294786099566, 5615.606907516516, 5808.651480911074, 5844.064949608042, 5879.676617785977, 5899.76400943966, 5867.031939729982, 5883.441073098049, 5883.646981181143, 5886.05823068307, 5889.440503152194, 5776.364599894008, 5829.912551311733, 5838.241028666246, 5861.0, 5865.266841644794, 5670.06443936754, 5740.6268592541355, 5774.566907481955, 5780.335261444903, 5817.941820581825, 4501.707389019703, 4509.729416235036, 4516.23224051912, 4527.501974782771, 4543.227651299287, 4000.7799571023293, 4073.796310184479, 4077.5922407758985, 4086.5096188457574, 4108.0, 5492.313460817398, 5551.056320425538, 5678.687672177987, 5724.856878577985, 5778.219940308089, 5860.853478663067, 5888.852778680567, 5895.233619629421, 5905.202797622352, 5935.703214839241, 5568.1091025435735, 5587.357453892773, 5613.045782217033, 5666.0, 5681.0, 5070.062038522885, 5072.721000345016, 5078.949210507922, 5079.466656001141, 5104.540591346722, 6144.139820425144, 6144.600600960924, 6167.5682702210415, 6170.0, 6178.7219575119225, 5723.284589426322, 5807.506361959112, 5908.3500814911185, 5909.556783241188, 5935.169076329317, 6094.939050609437, 6129.233845769279, 6136.723847426966, 6136.815895523141, 6142.846428839315, 5766.135079738073, 5770.13447982806, 5776.220210271727, 5779.971100144472, 5785.913211301918, 5793.391693872083, 5861.384554621874, 5956.672383018976, 6005.549583781147, 6017.458428741435, 5843.912341314799, 5849.327327357409, 5856.0630299151935, 5856.882862342814, 5859.794907178229, 5805.883882322414, 5820.447057529528, 5844.12338149281, 5844.590878638454, 5873.911891321548, 5581.358143813513, 5669.036263835075, 5752.511036561939, 5758.62568933018, 5798.94201057984, 5799.420057994167, 5822.359540450631, 5850.765969361178, 5891.469767720926, 5901.9966605678, 5496.010718070625, 5728.627639203439, 5799.4780469757925, 5809.622374545641, 5815.82552523425], "value": 5468.759705586948, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.217749587974, 691.3017851969511, 693.0262980512382, 732.9670164842578, 754.5812074298764, 39205.411918821206, 40023.39964900525, 40097.193196476255, 40152.0, 40443.0, 42893.57106428935, 43585.56414435855, 43639.0, 43710.344344834855, 43726.0, 8814.294856411472, 8984.19142277195, 8985.595648195815, 8993.955030224839, 9015.504147271897, 8686.218240358367, 8801.075887031866, 8869.911300887004, 9066.093390660948, 9080.182783549479, 9069.863952040692, 9103.54482275887, 9111.544422778868, 9114.498702571356, 9132.497712625804, 9021.323400744937, 9061.728148155566, 9073.13805188506, 9117.635294588208, 9121.771955701095, 9039.954800226022, 9063.41087829289, 9132.497712625804, 9141.222996045344, 9153.0, 42714.1457170858, 43231.783841080905, 43236.35145472789, 43328.56671433277, 43353.34969975453, 3779.829907654162, 4010.378391349316, 4017.817194786068, 4043.3732771420478, 4712.976435117803, 33141.0, 33396.83301583501, 33407.665923340945, 34670.30659386798, 35288.0, 4546.249868771649, 4614.953850461486, 4632.18936686082, 4660.603848672867, 4660.790264438108, 313049.0, 313511.0, 313672.0, 315347.0, 318065.0, 39222.803885980386, 39998.80000600037, 59181.70409147927, 60017.69991150016, 60023.39976600266, 38174.80912595419, 38236.42645360322, 38285.0, 38320.80839595784, 38387.80806095952, 17165.914170429318, 17225.052622105904, 17233.56916077083, 17323.133843307784, 17333.13334333278, 14593.343299551545, 14638.414463421344, 14682.119072855663, 14741.484048058266, 14766.0, 9293.0, 9427.528623568931, 9440.433573985583, 9455.810883782286, 9513.334066615409, 3585.480105384757, 3628.691561217326, 3641.417373220325, 3692.0769807548113, 3710.0910276982313, 1094.441834664327, 1111.5942680921567, 1154.0536759856836, 1156.9479373428217, 1165.3998190931677, 29446.705532944823, 31178.532322015188, 31387.843060785006, 31938.840305798323, 32258.677413226036, 1284.4348486665838, 1304.0350140895669, 1310.33173081729, 1311.8163457116011, 1382.3641125082374, 16275.0, 16515.0, 16544.255508502145, 16657.583560410843, 16718.164091795607, 468805.0, 476645.0, 584784.0, 615984.0, 627570.0, 57236.42763572394, 58946.41053589495, 59026.0, 59058.704706476194, 59131.70434147802, 1537.36967843186, 1543.9691206175814, 1547.0640262641166, 1551.8913676042794, 1576.4246050191828, 31060.68939310578, 31330.843345783127, 31596.0, 32389.0, 32419.35161296808, 54655.453445465035, 60821.0, 62366.376336236055, 62568.0, 62585.68707156435, 425360.0, 427834.0, 427835.0, 431289.0, 436170.0, 46780.53219467898, 46804.53195468138, 47198.0, 47373.289400659705, 47520.52479475161, 50147.24779128243, 50620.746896265286, 50651.493485064675, 51793.7410312946, 52235.0, 43313.783431082644, 43505.34741978809, 43530.0, 43614.78192609143, 45357.0, 43039.0, 43057.56942430536, 43340.34989475223, 43443.0, 43764.0, 44466.0, 44937.32594011158, 45589.0, 45813.31280030736, 46510.0, 33599.66400336063, 34237.0, 34663.306733865684, 34814.47778283378, 34923.126921826144, 27582.310442239104, 28918.855405722836, 29763.55354669725, 29839.850800746724, 30128.548071778503], "value": 20059.820212462473, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.94663167104113, 437.17464781782735, 440.7707991844241, 441.8387288639648, 446.6159103171272, 18741.34405295813, 19051.23795048198, 19544.31594894177, 19696.0, 19896.801031989675, 19763.0, 20038.699419508717, 20258.0, 20335.796642033576, 20419.591608167826, 5562.972185139069, 5679.829605111843, 5792.189093526909, 5819.330776960662, 5825.563082768809, 5454.645448045884, 5700.800471983482, 5708.08670612702, 5754.539636829044, 5774.855628609276, 5676.290463692038, 5729.627574207663, 5733.340665823421, 5737.196792449061, 5761.452661997104, 5851.648901065907, 5868.2371291732015, 5902.2622172228475, 5926.496247818897, 5949.3158286796925, 5620.0, 5713.114467257582, 5729.799457018984, 5748.712564371806, 5750.25246717924, 13254.668633284246, 13861.376238069312, 14010.369533371022, 14032.859671403257, 14114.647133821634, 2313.3753886450563, 2321.68657231275, 2536.112360673749, 2573.858437785921, 2703.9459210815676, 9946.0, 10106.039926206999, 10317.948410257975, 10508.0, 10580.52387642558, 1927.0075910905894, 1979.9505012374661, 2037.765656949455, 2064.112431654388, 2121.618108740426, 82399.0, 84810.0, 86752.0, 86937.56531217367, 87159.0, 11375.431228438545, 11383.658490245305, 11546.884531154581, 11621.941890290494, 11713.0, 15804.60488487797, 16007.679846403007, 16058.0, 16058.27737751804, 16112.67774644524, 8784.001987330766, 9055.773605659911, 9106.180443760093, 9127.361084724005, 9162.725118246462, 9019.594118264562, 9049.411788233743, 9146.542672866462, 9170.174684278447, 9195.586198621078, 4742.644301677388, 4871.610271178297, 4927.063857866994, 4936.975315123402, 5019.121653710586, 1869.0, 1889.1970912362192, 1958.1971391729323, 2043.5504189078379, 2063.8245749111493, 962.8892677342055, 1041.7655078731727, 1041.827173994082, 1058.6347710040025, 1124.5108377855659, 17221.0, 18496.0, 18864.717029244573, 18997.240110395705, 19200.8079919199, 1036.5231993283023, 1067.2635881242074, 1083.6478144603036, 1085.4409978860892, 1094.179365475893, 9825.508724563742, 10833.187510936554, 10837.133029357632, 10949.83575246372, 11043.226974111734, 163539.0, 164425.0, 376089.0, 381468.0, 385963.0, 97799.51100244453, 102545.0, 103980.48009759902, 104846.0, 105209.0, 1118.5805323003874, 1145.3128123126223, 1197.7963746163173, 1212.3150420012664, 1215.9027277817754, 17296.394626188023, 17380.913095434444, 17528.649427011642, 17618.735718964483, 17662.470125896245, 39463.60536394599, 40326.798366007984, 41544.376834346906, 41747.7912610435, 41778.58221417747, 58776.4122358788, 60356.39643603508, 60781.0, 60833.69583152233, 61035.08447373382, 8300.252977232078, 8377.329813615019, 8383.496990180609, 8465.0, 8548.487090774574, 12399.132060756021, 12565.120441569368, 12608.684782880502, 12691.492340306284, 13048.347582620641, 11339.716507087389, 11541.192116551762, 11777.0, 11934.582289619822, 12101.75796484083, 11166.38584877807, 11199.328040317607, 11286.548538058385, 11331.036861866834, 11609.419529023684, 8084.07033191167, 11878.762424751629, 11955.462004210005, 12000.459979301128, 12289.446974885972, 8587.957060214909, 8589.699360522602, 8594.140585941355, 8685.218330350299, 8742.91257087421, 8696.434731742416, 11139.610113645984, 11402.144839136932, 11444.771104578029, 11630.0], "value": 9202.697979414486, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1581.87345012399, 1601.6466086157193, 1821.0621529912098, 1888.924443022279, 1896.0565420444052, 7548.094228692551, 8127.512349259048, 8263.297619702325, 8519.148085191486, 8531.061583225848, 7964.5619490927975, 8059.91940080599, 8131.064927533335, 8169.754907352789, 8176.509409435438, 2355.9411014724596, 2382.690250267463, 2399.9760002399926, 2400.6159014557675, 2404.5431368040017, 2370.514044620857, 2405.2784164750506, 2428.7449817769143, 2436.768506991833, 2439.4145405102736, 2345.8827058647084, 2346.5072334809624, 2361.3506285771377, 2365.44412063165, 2373.299876536426, 2392.174699728591, 2418.4800267942387, 2426.138720754142, 2426.429788999575, 2427.0655797517907, 2383.4041489627593, 2401.1955994741606, 2401.8558886466867, 2403.0267741564694, 2415.6376543518613, 8497.107803680587, 8534.061253262136, 8554.914450855475, 8558.529280889548, 8603.225709686096, 5151.330327057459, 5202.08963431398, 5242.135047717122, 5251.501107394792, 5273.1299335609965, 3237.0450717038293, 3248.642649308574, 3313.1385839681616, 3318.983405082983, 3319.0706602151436, 1047.2459828923163, 1092.6012005617893, 1098.4397957041886, 1101.7465982823915, 1105.5688281570194, 11734.706632334175, 11976.221545599596, 12007.759844803055, 12021.038316934711, 12040.698982525508, 4533.297338912474, 4538.0, 4614.123316569841, 4631.930521042187, 4633.7683115844075, 10313.896861031444, 10321.74195645115, 10322.948385258025, 10360.637377691744, 10364.222683298784, 5318.97340513295, 5319.069162896555, 5340.626156169109, 5341.412444631087, 5354.250404943311, 4632.907341853212, 4717.693349932243, 4769.165396055746, 4785.59322457595, 4887.633427492881, 3828.693704503689, 3873.8450461981206, 3906.1015966327905, 3906.140649057203, 3949.328614135604, 1145.2498613408231, 1150.8446359741495, 1152.1071169843271, 1159.6694941941507, 1182.5920057580122, 889.6352495476823, 1011.2163073618005, 1016.5374754486838, 1020.3418794877263, 1022.539857064324, 5461.453854614586, 5529.723513824292, 5530.723463826793, 5618.213450116987, 5670.177824215466, 446.7252639626671, 459.297275168992, 468.0475232901098, 474.2459489411852, 476.792595221073, 3775.452559378875, 3819.3698039823116, 3822.2546603412625, 3836.5779764225913, 3875.205582855508, 10226.0, 10640.946795266129, 10658.946705266424, 10741.033307002408, 10811.83782243267, 10183.694489165337, 10531.473426328654, 10549.9472502637, 10699.893001070046, 10707.250492465608, 8211.507309561446, 8224.506529608243, 8242.052164001097, 8254.0507841599, 8316.251537361666, 5528.723563821713, 5542.695151766691, 5551.945958546287, 5617.747201375866, 5684.8010319638615, 9309.72070837876, 9442.669506567237, 9551.761205969906, 9599.856002159833, 9645.517724113626, 9440.811183776148, 9577.712668619952, 9759.170470510086, 9787.412755234709, 10058.698239052841, 6474.935250647433, 6905.205901321211, 7046.647667616701, 7360.96319518399, 7394.038774959221, 7696.961515192388, 7819.178986206366, 7862.764117076496, 7885.842283154419, 7922.603869806371, 6598.505112116706, 6787.321267873173, 6839.0, 6977.267386924503, 7098.183708873339, 6934.965325173342, 7022.964885175541, 7058.964705176647, 7068.0, 7069.434445244471, 6318.557700961072, 6400.935990640221, 6427.292997770148, 6433.131527243762, 6572.671366431755, 4989.151844186425, 5025.145725226794, 5028.572571331331, 5040.0, 5046.596272298134, 4951.306817045688, 4962.3052772611145, 4989.326440930573, 4992.276119962513, 5012.398512178562], "value": 4433.986978344238, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.42060342891364, 327.2163169209743, 328.9506574013898, 338.41285369883263, 341.0909925049741, 6468.223813142429, 6528.41244288014, 6546.887029205035, 6547.050677651738, 6550.475961923046, 6362.459190968773, 6372.840678983028, 6374.776882809103, 6411.070394792752, 6513.706883190256, 4733.502982186872, 4861.854144375674, 4883.926741098886, 4910.582600478946, 4911.263310503417, 4845.491223421543, 4870.220764677652, 4876.000419913909, 4887.1447496688115, 4895.192293271606, 4814.566688997989, 4823.155947709154, 4831.782569784368, 4839.080574690815, 4841.225403935371, 4835.854924352275, 4847.418309802811, 4850.12697714413, 4854.563089321978, 4857.757112144379, 4197.874063778091, 4200.201961627281, 4200.474940632421, 4200.768957707325, 4202.306619407794, 6118.1434599156155, 6230.221222347207, 6281.24625044993, 6283.874322513524, 6294.716737746812, 5565.638233514849, 5568.610197286192, 5570.415106413809, 5571.275734154534, 5577.358603760579, 6761.256261811197, 6773.153355830521, 6815.897761533532, 6819.863602727967, 6823.0, 4567.406237189178, 4570.0, 4571.977140114278, 4572.1312950539295, 4590.770461476913, 7125.144982602069, 7146.071010768567, 7182.856342873166, 7189.856202875965, 7205.4595905307315, 4661.627069834473, 4750.477447480775, 4752.976235118802, 4759.690620109682, 4760.880977975509, 4775.450823155312, 4824.614030877521, 4827.975860120677, 4828.7102773833685, 4828.927566086441, 5624.184493248456, 5640.294963129609, 5641.858953526113, 5641.971790141023, 5646.97176514123, 6878.828029299308, 6891.483138764613, 6898.103246577913, 6902.344277293649, 6903.240643529208, 1672.7825382700414, 1700.3793615330562, 1702.0808763267696, 1703.3016463250008, 1707.487753673893, 1068.0654427376046, 1096.9067629251444, 1102.2725001498973, 1111.0944580167138, 1121.103117505992, 6733.158355205599, 6751.527393082535, 6753.763618273435, 6762.087118239073, 6770.052192693027, 7147.3210045045635, 7163.641817909083, 7168.996340512333, 7172.533785303938, 7195.604241766753, 6532.314107018695, 6614.040964060185, 6666.400023997767, 6671.13275274221, 6754.392104710501, 3865.091703449687, 3870.974191839165, 3872.0319920019997, 3873.24471728016, 3888.4944957155953, 7490.962545187239, 7553.357964573072, 7571.3942884569105, 7575.560643477832, 7581.090269167735, 7196.46026548011, 7369.77890663281, 7371.705131794668, 7382.926170738331, 7390.22402647725, 7460.403167746567, 7530.1340345859835, 7530.472866899374, 7538.886916696254, 7542.057242844645, 7161.785146445615, 7191.352778249982, 7192.568445893263, 7192.892106618509, 7200.135983681992, 7066.258042905421, 7110.0, 7111.466640002124, 7130.322619351154, 7162.89255661155, 7356.154042285206, 7484.925150748423, 7529.0, 7532.962335188289, 7580.279873412238, 4733.313669517832, 4751.097291514601, 4769.30845027476, 4775.570198682135, 4780.259059845729, 7205.135383753983, 7220.169680486812, 7229.457790665616, 7236.059312289369, 7239.710411583477, 6962.1297337832775, 6966.616836074065, 6973.232944376013, 6991.825204369931, 7011.228764835966, 6723.428508576826, 6964.26875178099, 6964.477664175106, 6971.163460384786, 6980.162380514371, 6812.557183783038, 6867.656617169221, 6878.415334696607, 6880.346367095118, 6891.241963384124, 7026.1217347831525, 7037.1555413350725, 7040.331168538981, 7043.2604576518725, 7056.576605403692, 6864.24493305726, 6878.3465570770695, 6951.16586009682, 6960.512764106464, 6965.268646792014], "value": 5163.456623980392, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [824.4682179993907, 831.3141658132042, 838.3209600223819, 885.1325700813203, 898.5776684958072, 14850.925745371285, 15146.772798408032, 15242.0, 15463.768043479356, 15526.0, 14168.858311416883, 14231.78652320216, 14250.928745356285, 14338.641533961656, 14343.21112338821, 878.7890906182502, 884.5179377239419, 908.3641450984304, 909.417972497602, 913.2283220678516, 894.11929249689, 902.5803001604253, 906.4878343735768, 906.6509393883337, 906.6735975048977, 927.508420537113, 934.2712684106408, 934.5374039850284, 934.6962237272879, 936.0545848692801, 916.0930678628176, 920.5719340506696, 922.1700469577366, 924.9260059195282, 928.4058202750246, 682.1200651159998, 683.4327508168209, 685.396850771323, 685.9657017149123, 689.0, 15283.083015019023, 15374.0, 15425.460108896246, 15429.382824687, 15429.922850385676, 14126.505572305023, 14259.928700356535, 14290.499832505813, 14320.785188222186, 14388.06477578954, 11784.351860647661, 12026.0, 12051.517939282507, 12181.573644922473, 12266.509339626404, 4039.7778122203267, 4056.3307054336296, 4072.328065869128, 4102.548719640867, 4106.856260030914, 58241.0, 58338.70830645862, 58398.41601583972, 58987.41012589862, 59149.70425147847, 10593.417362045007, 10783.460826958777, 11340.319580825177, 11513.30920144794, 11639.47622356996, 20063.699044514346, 20121.798782012283, 20123.698144527843, 20224.595508089755, 20234.797652023586, 8038.7186448475195, 8325.333973282122, 8461.576921153917, 8895.998400359867, 8901.332400070021, 4701.95298047022, 4767.69010014348, 4770.689905156154, 4797.808087676453, 4822.252550854623, 3513.8243087845503, 3566.0, 3569.232614987738, 3570.2680950405106, 3571.39286321326, 618.0636335951037, 638.9361063893573, 646.6411141816243, 659.1069101367577, 673.8214373191108, 734.949022897262, 794.6185830801247, 800.8296078713498, 835.4277320035795, 866.2853146154448, 9371.0, 9572.56923438433, 9657.517124143766, 10105.444200568892, 10150.995059425823, 815.3477218225396, 838.4508147163617, 842.6713581703141, 847.9576021198916, 849.4011721736161, 4607.677462577654, 4722.905541889212, 5074.155759455506, 5097.898042039213, 5221.686698798008, 60802.0, 62335.37664623386, 62336.68831655903, 62555.37444625587, 62585.37414625796, 53107.73446132745, 53480.0, 53798.731006344715, 54058.0, 55733.0, 49688.75155624199, 49993.0, 50135.0, 50257.49742502601, 50854.0, 9699.6120155193, 9903.752406189902, 9935.05616966387, 9988.200943924614, 10103.696889093339, 36285.0, 37437.43843842399, 37692.0, 37970.81014594909, 38719.419208711326, 45467.772661136485, 46633.83415414642, 46822.0, 47156.0, 47370.76314618405, 12235.510579576718, 12347.62957111288, 12432.937835310766, 12751.426185821474, 12759.0, 13810.37853296584, 14525.346359414063, 14527.201003944885, 14544.490942817374, 14552.927235363755, 13593.320333983063, 13901.513447029305, 14165.929170354082, 14469.27653617336, 14644.560663180122, 13394.866051339362, 13665.0, 13709.931450342685, 13788.172709637454, 14345.569632911029, 13485.39315730814, 13545.390457429636, 13978.580642580739, 14256.215908125152, 14495.0, 11155.21913466082, 11222.719432014264, 11431.199816012799, 11595.304281742785, 11858.0, 11337.829932551183, 11538.423078846192, 11737.0, 11874.109441792072, 11879.287242765462], "value": 7206.416910621836, "unit": "score"}], "name": "dromaeo_css", "value": 7417.72580553534, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 106.0, 110.0, 112.0, 112.0, 100.0, 111.0, 111.0, 112.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 150.0, 179.0, 127.0, 154.0, 152.0, 128.0, 183.0, 128.0], "value": 147.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 163.0, 162.0, 162.0, 160.0, 163.0, 161.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 184.0, 77.0, 76.0, 77.0, 75.0, 163.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 147.0, 93.0, 93.0, 92.0, 152.0, 92.0, 92.0, 155.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 117.0, 118.0, 118.0, 116.0, 117.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 94.0, 95.0, 95.0, 97.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 57.0, 56.0, 57.0, 59.0, 60.0, 80.0, 55.0, 54.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 59.0, 59.0, 58.0, 58.0, 58.0, 59.0, 59.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 73.0, 73.0, 75.0, 74.0, 74.0, 74.0, 74.0, 74.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 127.0, 116.0, 116.0, 122.0, 114.0, 115.0, 117.0, 127.0, 128.0], "value": 120.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 165.0, 166.0, 170.0, 164.0, 161.0, 162.0, 162.0, 167.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 73.0, 66.0, 69.0, 67.0, 66.0, 70.0, 67.0, 72.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1527.0, "alertThreshold": 2.0}]} 04:29:47 INFO - Return code: 0 04:29:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:29:47 ERROR - # TBPL SUCCESS # 04:29:47 INFO - Running post-action listener: _resource_record_post_action 04:29:47 INFO - Running post-run listener: _resource_record_post_run 04:29:48 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 32768; Write bytes: 219418624; Read time: 172; Write time: 133608 04:29:48 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 741376; Read time: 0; Write time: 40 04:29:48 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8192; Write bytes: 218079232; Read time: 160; Write time: 133568 04:29:48 INFO - Running post-run listener: _upload_blobber_files 04:29:48 INFO - Blob upload gear active. 04:29:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:29:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:29:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:29:48 INFO - (blobuploader) - INFO - Open directory for files ... 04:29:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:29:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:29:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:49 INFO - (blobuploader) - INFO - Done attempting. 04:29:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:29:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:29:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:50 INFO - (blobuploader) - INFO - Done attempting. 04:29:50 INFO - (blobuploader) - INFO - Iteration through files over. 04:29:50 INFO - Return code: 0 04:29:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:29:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:29:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/639010abcf3665ca94248f5c1f753fe7e3697bda4fe9374eb48223745d826719b7719f1aee6af599799df449d0ccdecbbb07026c724d1be3eef09b27f700a868", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7815ca32703c6c3e7bc91a707e62d746606480c758ddd0ffb9fe063b203676b2092109c2b3bbac7b1c973573169d7bba82d8dc34e5637c303edb7f51173d503e"} 04:29:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:29:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:29:50 INFO - Contents: 04:29:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/639010abcf3665ca94248f5c1f753fe7e3697bda4fe9374eb48223745d826719b7719f1aee6af599799df449d0ccdecbbb07026c724d1be3eef09b27f700a868", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7815ca32703c6c3e7bc91a707e62d746606480c758ddd0ffb9fe063b203676b2092109c2b3bbac7b1c973573169d7bba82d8dc34e5637c303edb7f51173d503e"} 04:29:50 INFO - Running post-run listener: copy_logs_to_upload_dir 04:29:50 INFO - Copying logs to upload dir... 04:29:50 INFO - mkdir: /builds/slave/test/build/upload/logs 04:29:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.634083 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-17 04:29:50.388997) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 04:29:50.392939) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103 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-Beta/sha512/639010abcf3665ca94248f5c1f753fe7e3697bda4fe9374eb48223745d826719b7719f1aee6af599799df449d0ccdecbbb07026c724d1be3eef09b27f700a868", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7815ca32703c6c3e7bc91a707e62d746606480c758ddd0ffb9fe063b203676b2092109c2b3bbac7b1c973573169d7bba82d8dc34e5637c303edb7f51173d503e"} build_url:https://queue.taskcluster.net/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011368 build_url: 'https://queue.taskcluster.net/v1/task/GknIWnyQS2m5Hyb_g8XqrA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/639010abcf3665ca94248f5c1f753fe7e3697bda4fe9374eb48223745d826719b7719f1aee6af599799df449d0ccdecbbb07026c724d1be3eef09b27f700a868", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7815ca32703c6c3e7bc91a707e62d746606480c758ddd0ffb9fe063b203676b2092109c2b3bbac7b1c973573169d7bba82d8dc34e5637c303edb7f51173d503e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 04:29:50.437872) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 04:29:50.438160) ========= rm -f oauth.txt in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9ee515b9ec57ce2c386832a8000001b4-1468750191.77339-2094081103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 04:29:50.490221) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 04:29:50.490484) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 04:29:50.490740) ========= ========= Total master_lag: 0.22 =========