builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1464390437.81 results: success (0) buildid: 20160527133022 builduid: 3123e7c80ba74725bb147cea1bf69125 revision: 21263fbfdcc22d62b72836a3bd37c6cadb860704 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 16:07:17.812427) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 16:07:17.814109) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 16:07:17.814393) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 16:07:17.828609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:07:17.828883) ========= 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=52faae308a556c440401f8e5000001e8-1464390205.852169-814171526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 16:07:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-05-27 16:07:18 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076145 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:07:17.918155) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:07:17.918430) ========= 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=52faae308a556c440401f8e5000001e8-1464390205.852169-814171526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019745 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:07:17.968680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 16:07:17.969178) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 21263fbfdcc22d62b72836a3bd37c6cadb860704 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 21263fbfdcc22d62b72836a3bd37c6cadb860704 --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=52faae308a556c440401f8e5000001e8-1464390205.852169-814171526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 16:07:18,154 truncating revision to first 12 chars 2016-05-27 16:07:18,154 Setting DEBUG logging. 2016-05-27 16:07:18,154 attempt 1/10 2016-05-27 16:07:18,154 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/21263fbfdcc2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 16:07:19,403 unpacking tar archive at: mozilla-inbound-21263fbfdcc2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.582049 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 16:07:19.564720) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 16:07:19.565029) ========= script_repo_revision: 21263fbfdcc22d62b72836a3bd37c6cadb860704 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 16:07:19.565426) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 16:07:19.565713) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 16:07:19.575029) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-27 16:07:19.575318) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=52faae308a556c440401f8e5000001e8-1464390205.852169-814171526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:07:19 INFO - MultiFileLogger online at 20160527 16:07:19 in /builds/slave/test 16:07:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:07:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:07:19 INFO - {'append_to_log': False, 16:07:19 INFO - 'base_work_dir': '/builds/slave/test', 16:07:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:07:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:07:19 INFO - 'branch': 'Mozilla-Inbound', 16:07:19 INFO - 'buildbot_json_path': 'buildprops.json', 16:07:19 INFO - 'config_files': ('talos/linux_config.py',), 16:07:19 INFO - 'default_actions': ('clobber', 16:07:19 INFO - 'read-buildbot-config', 16:07:19 INFO - 'download-and-extract', 16:07:19 INFO - 'populate-webroot', 16:07:19 INFO - 'create-virtualenv', 16:07:19 INFO - 'install', 16:07:19 INFO - 'run-tests'), 16:07:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:07:19 INFO - 'download_minidump_stackwalk': True, 16:07:19 INFO - 'download_symbols': 'ondemand', 16:07:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:07:19 INFO - 'tooltool.py': '/tools/tooltool.py', 16:07:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:07:19 INFO - '/tools/misc-python/virtualenv.py')}, 16:07:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:07:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:07:19 INFO - 'installer_path': 'installer.exe', 16:07:19 INFO - 'log_level': 'info', 16:07:19 INFO - 'log_name': 'talos', 16:07:19 INFO - 'log_to_console': True, 16:07:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:07:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:07:19 INFO - 'opt_config_files': (), 16:07:19 INFO - 'pip_index': False, 16:07:19 INFO - 'sps_profile': False, 16:07:19 INFO - 'sps_profile_interval': 0, 16:07:19 INFO - 'suite': 'dromaeojs-e10s', 16:07:19 INFO - 'system_bits': '32', 16:07:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:07:19 INFO - 'title': 'talos-linux64-ix-056', 16:07:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:07:19 INFO - 'use_talos_json': True, 16:07:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:07:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:07:19 INFO - 'work_dir': 'build'} 16:07:19 INFO - ##### 16:07:19 INFO - ##### Running clobber step. 16:07:19 INFO - ##### 16:07:19 INFO - Running pre-action listener: _resource_record_pre_action 16:07:19 INFO - Running main action method: clobber 16:07:19 INFO - rmtree: /builds/slave/test/build 16:07:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:07:20 INFO - Running post-action listener: _resource_record_post_action 16:07:20 INFO - ##### 16:07:20 INFO - ##### Finished clobber step (success) 16:07:20 INFO - ##### 16:07:20 INFO - ##### 16:07:20 INFO - ##### Running read-buildbot-config step. 16:07:20 INFO - ##### 16:07:20 INFO - Running pre-action listener: _resource_record_pre_action 16:07:20 INFO - Running main action method: read_buildbot_config 16:07:20 INFO - Using buildbot properties: 16:07:20 INFO - { 16:07:20 INFO - "project": "", 16:07:20 INFO - "product": "firefox", 16:07:20 INFO - "script_repo_revision": "production", 16:07:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 16:07:20 INFO - "repository": "", 16:07:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 16:07:20 INFO - "buildid": "20160527133022", 16:07:20 INFO - "pgo_build": "True", 16:07:20 INFO - "basedir": "/builds/slave/test", 16:07:20 INFO - "buildnumber": 617, 16:07:20 INFO - "slavename": "talos-linux64-ix-056", 16:07:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:07:20 INFO - "platform": "ubuntu64_hw", 16:07:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:07:20 INFO - "branch": "mozilla-inbound", 16:07:20 INFO - "repo_path": "integration/mozilla-inbound", 16:07:20 INFO - "revision": "21263fbfdcc22d62b72836a3bd37c6cadb860704", 16:07:20 INFO - "stage_platform": "linux64-pgo", 16:07:20 INFO - "builduid": "3123e7c80ba74725bb147cea1bf69125", 16:07:20 INFO - "slavebuilddir": "test" 16:07:20 INFO - } 16:07:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 16:07:20 INFO - Running post-action listener: _resource_record_post_action 16:07:20 INFO - ##### 16:07:20 INFO - ##### Finished read-buildbot-config step (success) 16:07:20 INFO - ##### 16:07:20 INFO - ##### 16:07:20 INFO - ##### Running download-and-extract step. 16:07:20 INFO - ##### 16:07:20 INFO - Running pre-action listener: _resource_record_pre_action 16:07:20 INFO - Running main action method: download_and_extract 16:07:20 INFO - mkdir: /builds/slave/test/build/tests 16:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:20 INFO - https://queue.taskcluster.net/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:07:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:07:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:07:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:07:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:07:23 INFO - Downloaded 1361 bytes. 16:07:23 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:07:23 INFO - Using the following test package requirements: 16:07:23 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:07:23 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:07:23 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:07:23 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:23 INFO - u'jsshell-linux-x86_64.zip'], 16:07:23 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:07:23 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:07:23 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:07:23 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:07:23 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:07:23 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:07:23 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:07:23 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')]} 16:07:23 INFO - https://queue.taskcluster.net/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:07:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:07:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:07:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:07:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:07:25 INFO - Downloaded 24409996 bytes. 16:07:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:07:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:07:26 INFO - Return code: 0 16:07:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:07:26 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')]} 16:07:26 INFO - https://queue.taskcluster.net/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:07:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:07:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:07:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:07:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:07:38 INFO - Downloaded 24409996 bytes. 16:07:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:07:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:07:39 INFO - Return code: 0 16:07: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')]} 16:07:39 INFO - https://queue.taskcluster.net/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:07:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:07:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:07:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:07:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:07:42 INFO - Downloaded 10834055 bytes. 16:07:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:07:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:07:42 INFO - Return code: 0 16:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:42 INFO - https://queue.taskcluster.net/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:07:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:07:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:07:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:07:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:07:43 INFO - Downloaded 58801803 bytes. 16:07:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:07:43 INFO - mkdir: /builds/slave/test/properties 16:07:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:07:43 INFO - Writing to file /builds/slave/test/properties/build_url 16:07:43 INFO - Contents: 16:07:43 INFO - build_url:https://queue.taskcluster.net/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:07:44 INFO - Running post-action listener: _resource_record_post_action 16:07:44 INFO - Running post-action listener: set_extra_try_arguments 16:07:44 INFO - ##### 16:07:44 INFO - ##### Finished download-and-extract step (success) 16:07:44 INFO - ##### 16:07:44 INFO - ##### 16:07:44 INFO - ##### Running populate-webroot step. 16:07:44 INFO - ##### 16:07:44 INFO - Running pre-action listener: _resource_record_pre_action 16:07:44 INFO - Running main action method: populate_webroot 16:07:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:07:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:07:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:07:44 INFO - '--tppagecycles', 16:07:44 INFO - '7'], 16:07:44 INFO - 'tests': ['tsvgm']}}, 16:07:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:07:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:07:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:07:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:07:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:44 INFO - 'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:07:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:07:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:44 INFO - 'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['damp', 'tps']}, 16:07:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:44 INFO - 'tests': ['damp', 'tps']}, 16:07:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['dromaeo_dom']}, 16:07:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:07:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['a11yr', 16:07:44 INFO - 'ts_paint', 16:07:44 INFO - 'tpaint', 16:07:44 INFO - 'sessionrestore', 16:07:44 INFO - 'sessionrestore_no_auto_restore', 16:07:44 INFO - 'tabpaint']}, 16:07:44 INFO - 'other-e10s': {'tests': ['a11yr', 16:07:44 INFO - 'ts_paint', 16:07:44 INFO - 'tpaint', 16:07:44 INFO - 'sessionrestore', 16:07:44 INFO - 'sessionrestore_no_auto_restore', 16:07:44 INFO - 'tabpaint']}, 16:07:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:07:44 INFO - 'ts_paint', 16:07:44 INFO - 'tpaint', 16:07:44 INFO - 'sessionrestore', 16:07:44 INFO - 'sessionrestore_no_auto_restore', 16:07:44 INFO - 'tabpaint']}, 16:07:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:07:44 INFO - 'ts_paint', 16:07:44 INFO - 'tpaint', 16:07:44 INFO - 'sessionrestore', 16:07:44 INFO - 'sessionrestore_no_auto_restore', 16:07:44 INFO - 'tabpaint']}, 16:07:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['a11yr', 16:07:44 INFO - 'ts_paint', 16:07:44 INFO - 'tpaint', 16:07:44 INFO - 'sessionrestore', 16:07:44 INFO - 'sessionrestore_no_auto_restore', 16:07:44 INFO - 'tabpaint']}, 16:07:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['a11yr', 16:07:44 INFO - 'ts_paint', 16:07:44 INFO - 'tpaint', 16:07:44 INFO - 'sessionrestore', 16:07:44 INFO - 'sessionrestore_no_auto_restore', 16:07:44 INFO - 'tabpaint']}, 16:07:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['tsvgx', 16:07:44 INFO - 'tsvgr_opacity', 16:07:44 INFO - 'tart', 16:07:44 INFO - 'tscrollx', 16:07:44 INFO - 'cart']}, 16:07:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:07:44 INFO - 'tsvgr_opacity', 16:07:44 INFO - 'tart', 16:07:44 INFO - 'tscrollx', 16:07:44 INFO - 'cart']}, 16:07:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:44 INFO - 'talos_options': ['--disable-e10s'], 16:07:44 INFO - 'tests': ['tp5o']}, 16:07:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:44 INFO - 'tests': ['tp5o']}, 16:07:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:44 INFO - 'talos_options': ['--disable-e10s', 16:07:44 INFO - '--xperf_path', 16:07:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:07:44 INFO - 'tests': ['tp5n']}, 16:07:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:44 INFO - 'talos_options': ['--xperf_path', 16:07:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:07:44 INFO - 'tests': ['tp5n']}}, 16:07:44 INFO - 'talos.zip': {'path': '', 16:07:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:07:44 INFO - Running post-action listener: _resource_record_post_action 16:07:44 INFO - ##### 16:07:44 INFO - ##### Finished populate-webroot step (success) 16:07:44 INFO - ##### 16:07:44 INFO - ##### 16:07:44 INFO - ##### Running create-virtualenv step. 16:07:44 INFO - ##### 16:07:44 INFO - Running pre-action listener: _resource_record_pre_action 16:07:44 INFO - Running main action method: create_virtualenv 16:07:44 INFO - Creating virtualenv /builds/slave/test/build/venv 16:07:44 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 16:07:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:07:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:07:44 INFO - Using real prefix '/usr' 16:07:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:07:45 INFO - Installing distribute.............................................................................................................................................................................................done. 16:07:47 INFO - Installing pip.................done. 16:07:47 INFO - Return code: 0 16:07:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:07:47 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')]} 16:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:47 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')]} 16:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:47 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 0x7f9b3667df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd9c0>, '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 0x28fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fed50>, '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': '52faae308a556c440401f8e5000001e8-1464390205.852169-814171526', '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 16:07:47 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 16:07:47 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 16:07:47 INFO - Using env: {'DISPLAY': ':0', 16:07:47 INFO - 'HOME': '/home/cltbld', 16:07:47 INFO - 'LANG': 'en_US.UTF-8', 16:07:47 INFO - 'LANGUAGE': 'en_US:en', 16:07:47 INFO - 'LOGNAME': 'cltbld', 16:07:47 INFO - 'MAIL': '/var/mail/cltbld', 16:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:47 INFO - 'MOZ_NO_REMOTE': '1', 16:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:47 INFO - 'NO_EM_RESTART': '1', 16:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:47 INFO - 'PWD': '/builds/slave/test', 16:07:47 INFO - 'SHELL': '/bin/bash', 16:07:47 INFO - 'SHLVL': '1', 16:07:47 INFO - 'TERM': 'linux', 16:07:47 INFO - 'TMOUT': '86400', 16:07:47 INFO - 'USER': 'cltbld', 16:07:47 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464390205.852169-814171526', 16:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:47 INFO - '_': '/tools/buildbot/bin/python'} 16:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:47 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 16:07:47 INFO - Cleaning up... 16:07:47 INFO - Return code: 0 16:07:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:07:47 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')]} 16:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:47 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')]} 16:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:47 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b3667df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd9c0>, '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 0x28fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fed50>, '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': '52faae308a556c440401f8e5000001e8-1464390205.852169-814171526', '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 16:07:47 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>=3.1.1'] in /builds/slave/test/build 16:07:47 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>=3.1.1 16:07:47 INFO - Using env: {'DISPLAY': ':0', 16:07:47 INFO - 'HOME': '/home/cltbld', 16:07:47 INFO - 'LANG': 'en_US.UTF-8', 16:07:47 INFO - 'LANGUAGE': 'en_US:en', 16:07:47 INFO - 'LOGNAME': 'cltbld', 16:07:47 INFO - 'MAIL': '/var/mail/cltbld', 16:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:47 INFO - 'MOZ_NO_REMOTE': '1', 16:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:47 INFO - 'NO_EM_RESTART': '1', 16:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:47 INFO - 'PWD': '/builds/slave/test', 16:07:47 INFO - 'SHELL': '/bin/bash', 16:07:47 INFO - 'SHLVL': '1', 16:07:47 INFO - 'TERM': 'linux', 16:07:47 INFO - 'TMOUT': '86400', 16:07:47 INFO - 'USER': 'cltbld', 16:07:47 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464390205.852169-814171526', 16:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:47 INFO - '_': '/tools/buildbot/bin/python'} 16:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:47 INFO - Downloading/unpacking psutil>=3.1.1 16:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:07:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:07:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:07:49 INFO - Installing collected packages: psutil 16:07:49 INFO - Running setup.py install for psutil 16:07:49 INFO - building 'psutil._psutil_linux' extension 16:07:49 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 16:07:49 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 16:07:50 INFO - building 'psutil._psutil_posix' extension 16:07:50 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 16:07:50 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 16:07:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:07:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:07:50 INFO - Successfully installed psutil 16:07:50 INFO - Cleaning up... 16:07:50 INFO - Return code: 0 16:07:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:50 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b3667df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd9c0>, '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 0x28fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fed50>, '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': '52faae308a556c440401f8e5000001e8-1464390205.852169-814171526', '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 16:07:50 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.3'] in /builds/slave/test/build 16:07:50 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.3 16:07:50 INFO - Using env: {'DISPLAY': ':0', 16:07:50 INFO - 'HOME': '/home/cltbld', 16:07:50 INFO - 'LANG': 'en_US.UTF-8', 16:07:50 INFO - 'LANGUAGE': 'en_US:en', 16:07:50 INFO - 'LOGNAME': 'cltbld', 16:07:50 INFO - 'MAIL': '/var/mail/cltbld', 16:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:50 INFO - 'MOZ_NO_REMOTE': '1', 16:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:50 INFO - 'NO_EM_RESTART': '1', 16:07:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:50 INFO - 'PWD': '/builds/slave/test', 16:07:50 INFO - 'SHELL': '/bin/bash', 16:07:50 INFO - 'SHLVL': '1', 16:07:50 INFO - 'TERM': 'linux', 16:07:50 INFO - 'TMOUT': '86400', 16:07:50 INFO - 'USER': 'cltbld', 16:07:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464390205.852169-814171526', 16:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:50 INFO - '_': '/tools/buildbot/bin/python'} 16:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:07:50 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 16:07:50 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 16:07:50 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 16:07:50 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 16:07:50 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 16:07:50 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 16:07:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:07:52 INFO - Installing collected packages: mozsystemmonitor 16:07:52 INFO - Running setup.py install for mozsystemmonitor 16:07:52 INFO - Successfully installed mozsystemmonitor 16:07:52 INFO - Cleaning up... 16:07:52 INFO - Return code: 0 16:07:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:07: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')]} 16:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07: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')]} 16:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:52 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 0x7f9b3667df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd9c0>, '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 0x28fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fed50>, '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': '52faae308a556c440401f8e5000001e8-1464390205.852169-814171526', '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 16:07:52 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 16:07:52 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 16:07:52 INFO - Using env: {'DISPLAY': ':0', 16:07:52 INFO - 'HOME': '/home/cltbld', 16:07:52 INFO - 'LANG': 'en_US.UTF-8', 16:07:52 INFO - 'LANGUAGE': 'en_US:en', 16:07:52 INFO - 'LOGNAME': 'cltbld', 16:07:52 INFO - 'MAIL': '/var/mail/cltbld', 16:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:52 INFO - 'MOZ_NO_REMOTE': '1', 16:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:52 INFO - 'NO_EM_RESTART': '1', 16:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:52 INFO - 'PWD': '/builds/slave/test', 16:07:52 INFO - 'SHELL': '/bin/bash', 16:07:52 INFO - 'SHLVL': '1', 16:07:52 INFO - 'TERM': 'linux', 16:07:52 INFO - 'TMOUT': '86400', 16:07:52 INFO - 'USER': 'cltbld', 16:07:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464390205.852169-814171526', 16:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:52 INFO - '_': '/tools/buildbot/bin/python'} 16:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:52 INFO - Downloading/unpacking blobuploader==1.2.4 16:07:52 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 16:07:52 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 16:07:52 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 16:07:52 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 16:07:52 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 16:07:52 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 16:07:54 INFO - Downloading blobuploader-1.2.4.tar.gz 16:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:07:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:07:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:55 INFO - Downloading docopt-0.6.1.tar.gz 16:07:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:07:55 INFO - Installing collected packages: blobuploader, requests, docopt 16:07:55 INFO - Running setup.py install for blobuploader 16:07:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:07:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:07:55 INFO - Running setup.py install for requests 16:07:55 INFO - Running setup.py install for docopt 16:07:56 INFO - Successfully installed blobuploader requests docopt 16:07:56 INFO - Cleaning up... 16:07:56 INFO - Return code: 0 16:07:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:07: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')]} 16:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07: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')]} 16:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:56 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 0x7f9b3667df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd9c0>, '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 0x28fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fed50>, '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': '52faae308a556c440401f8e5000001e8-1464390205.852169-814171526', '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 16:07:56 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 16:07:56 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 16:07:56 INFO - Using env: {'DISPLAY': ':0', 16:07:56 INFO - 'HOME': '/home/cltbld', 16:07:56 INFO - 'LANG': 'en_US.UTF-8', 16:07:56 INFO - 'LANGUAGE': 'en_US:en', 16:07:56 INFO - 'LOGNAME': 'cltbld', 16:07:56 INFO - 'MAIL': '/var/mail/cltbld', 16:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:56 INFO - 'MOZ_NO_REMOTE': '1', 16:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:56 INFO - 'NO_EM_RESTART': '1', 16:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:56 INFO - 'PWD': '/builds/slave/test', 16:07:56 INFO - 'SHELL': '/bin/bash', 16:07:56 INFO - 'SHLVL': '1', 16:07:56 INFO - 'TERM': 'linux', 16:07:56 INFO - 'TMOUT': '86400', 16:07:56 INFO - 'USER': 'cltbld', 16:07:56 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464390205.852169-814171526', 16:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:56 INFO - '_': '/tools/buildbot/bin/python'} 16:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:07:56 INFO - Running setup.py (path:/tmp/pip-dcpUzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:07:56 INFO - Running setup.py (path:/tmp/pip-_o47PO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:07:56 INFO - Running setup.py (path:/tmp/pip-OxfpfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:07:56 INFO - Running setup.py (path:/tmp/pip-opxWAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:07:56 INFO - Running setup.py (path:/tmp/pip-5VFmml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:07:56 INFO - Running setup.py (path:/tmp/pip-mXLaj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:07:56 INFO - Running setup.py (path:/tmp/pip-SdIKI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:07:56 INFO - Running setup.py (path:/tmp/pip-9bISrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:07:56 INFO - Running setup.py (path:/tmp/pip-1wsYJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:07:56 INFO - Running setup.py (path:/tmp/pip-zzpnS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:07:57 INFO - Running setup.py (path:/tmp/pip-QDN9pK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:07:57 INFO - Running setup.py (path:/tmp/pip-Fa5sGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:07:57 INFO - Running setup.py (path:/tmp/pip-Y9qL9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:07:57 INFO - Running setup.py (path:/tmp/pip-DRj1gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:57 INFO - Running setup.py (path:/tmp/pip-lOep6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:07:57 INFO - Running setup.py (path:/tmp/pip-oczIt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:07:57 INFO - Running setup.py (path:/tmp/pip-4EsHcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:07:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:07:57 INFO - Running setup.py install for manifestparser 16:07:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:07:57 INFO - Running setup.py install for mozcrash 16:07:57 INFO - Running setup.py install for mozdebug 16:07:57 INFO - Running setup.py install for mozdevice 16:07:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:07:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:07:57 INFO - Running setup.py install for mozfile 16:07:58 INFO - Running setup.py install for mozhttpd 16:07:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:07:58 INFO - Running setup.py install for mozinfo 16:07:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:07:58 INFO - Running setup.py install for mozInstall 16:07:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:07:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:07:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:07:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:07:58 INFO - Running setup.py install for mozleak 16:07:58 INFO - Running setup.py install for mozlog 16:07:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:07:58 INFO - Running setup.py install for moznetwork 16:07:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:07:58 INFO - Running setup.py install for mozprocess 16:07:58 INFO - Running setup.py install for mozprofile 16:07:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:07:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:07:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:07:58 INFO - Running setup.py install for mozrunner 16:07:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:07:59 INFO - Running setup.py install for mozscreenshot 16:07:59 INFO - Running setup.py install for moztest 16:07:59 INFO - Running setup.py install for mozversion 16:07:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:07:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:07:59 INFO - Cleaning up... 16:07:59 INFO - Return code: 0 16:07:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:07: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')]} 16:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07: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')]} 16:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:59 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 0x7f9b3667df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd9c0>, '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 0x28fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fed50>, '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': '52faae308a556c440401f8e5000001e8-1464390205.852169-814171526', '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 16:07:59 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 16:07:59 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 16:07:59 INFO - Using env: {'DISPLAY': ':0', 16:07:59 INFO - 'HOME': '/home/cltbld', 16:07:59 INFO - 'LANG': 'en_US.UTF-8', 16:07:59 INFO - 'LANGUAGE': 'en_US:en', 16:07:59 INFO - 'LOGNAME': 'cltbld', 16:07:59 INFO - 'MAIL': '/var/mail/cltbld', 16:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:59 INFO - 'MOZ_NO_REMOTE': '1', 16:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:59 INFO - 'NO_EM_RESTART': '1', 16:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:59 INFO - 'PWD': '/builds/slave/test', 16:07:59 INFO - 'SHELL': '/bin/bash', 16:07:59 INFO - 'SHLVL': '1', 16:07:59 INFO - 'TERM': 'linux', 16:07:59 INFO - 'TMOUT': '86400', 16:07:59 INFO - 'USER': 'cltbld', 16:07:59 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464390205.852169-814171526', 16:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:59 INFO - '_': '/tools/buildbot/bin/python'} 16:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:07:59 INFO - Running setup.py (path:/tmp/pip-lNBxQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:07:59 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)) 16:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:07:59 INFO - Running setup.py (path:/tmp/pip-FqV74G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:07:59 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)) 16:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:07:59 INFO - Running setup.py (path:/tmp/pip-KjlIuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:07:59 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)) 16:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:07:59 INFO - Running setup.py (path:/tmp/pip-7GLO5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:07:59 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)) 16:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:07:59 INFO - Running setup.py (path:/tmp/pip-F1D9lI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:07:59 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)) 16:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:07:59 INFO - Running setup.py (path:/tmp/pip-6MDoG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:07:59 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)) 16:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:07:59 INFO - Running setup.py (path:/tmp/pip-GXWTy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:08:00 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)) 16:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:08:00 INFO - Running setup.py (path:/tmp/pip-W5g7X6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:08:00 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)) 16:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:08:00 INFO - Running setup.py (path:/tmp/pip-amCFP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:08:00 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)) 16:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:08:00 INFO - Running setup.py (path:/tmp/pip-us1Ocs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 16:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:08:00 INFO - Running setup.py (path:/tmp/pip-gZ72Kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:08:00 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)) 16:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:08:00 INFO - Running setup.py (path:/tmp/pip-yGiBlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:08:00 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)) 16:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:08:00 INFO - Running setup.py (path:/tmp/pip-Dln5fE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:08:00 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)) 16:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:08:00 INFO - Running setup.py (path:/tmp/pip-z6dpWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:08:00 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)) 16:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:08:00 INFO - Running setup.py (path:/tmp/pip-62YS_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:08:00 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)) 16:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:08:00 INFO - Running setup.py (path:/tmp/pip-yslpWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:08:00 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)) 16:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:08:00 INFO - Running setup.py (path:/tmp/pip-6WF0jS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:08:00 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)) 16:08:00 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)) 16:08:00 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)) 16:08:00 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)) 16:08:00 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)) 16:08:00 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)) 16:08:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:08:00 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 16:08:00 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 16:08:00 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 16:08:00 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 16:08:00 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 16:08:00 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 16:08:02 INFO - Downloading blessings-1.6.tar.gz 16:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:08:02 INFO - Installing collected packages: blessings 16:08:02 INFO - Running setup.py install for blessings 16:08:02 INFO - Successfully installed blessings 16:08:02 INFO - Cleaning up... 16:08:02 INFO - Return code: 0 16:08:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:08:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:08:03 INFO - Reading from file tmpfile_stdout 16:08:03 INFO - Current package versions: 16:08:03 INFO - argparse == 1.2.1 16:08:03 INFO - blessings == 1.6 16:08:03 INFO - blobuploader == 1.2.4 16:08:03 INFO - docopt == 0.6.1 16:08:03 INFO - manifestparser == 1.1 16:08:03 INFO - mozInstall == 1.12 16:08:03 INFO - mozcrash == 0.17 16:08:03 INFO - mozdebug == 0.1 16:08:03 INFO - mozdevice == 0.48 16:08:03 INFO - mozfile == 1.2 16:08:03 INFO - mozhttpd == 0.7 16:08:03 INFO - mozinfo == 0.9 16:08:03 INFO - mozleak == 0.1 16:08:03 INFO - mozlog == 3.2 16:08:03 INFO - moznetwork == 0.27 16:08:03 INFO - mozprocess == 0.22 16:08:03 INFO - mozprofile == 0.28 16:08:03 INFO - mozrunner == 6.11 16:08:03 INFO - mozscreenshot == 0.1 16:08:03 INFO - mozsystemmonitor == 0.3 16:08:03 INFO - moztest == 0.7 16:08:03 INFO - mozversion == 1.4 16:08:03 INFO - psutil == 3.1.1 16:08:03 INFO - requests == 1.2.3 16:08:03 INFO - wsgiref == 0.1.2 16:08:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:03 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 0x7f9b3667df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd9c0>, '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 0x28fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fed50>, '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': '52faae308a556c440401f8e5000001e8-1464390205.852169-814171526', '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 16:08:03 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 16:08:03 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 16:08:03 INFO - Using env: {'DISPLAY': ':0', 16:08:03 INFO - 'HOME': '/home/cltbld', 16:08:03 INFO - 'LANG': 'en_US.UTF-8', 16:08:03 INFO - 'LANGUAGE': 'en_US:en', 16:08:03 INFO - 'LOGNAME': 'cltbld', 16:08:03 INFO - 'MAIL': '/var/mail/cltbld', 16:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:03 INFO - 'MOZ_NO_REMOTE': '1', 16:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:03 INFO - 'NO_EM_RESTART': '1', 16:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:03 INFO - 'PWD': '/builds/slave/test', 16:08:03 INFO - 'SHELL': '/bin/bash', 16:08:03 INFO - 'SHLVL': '1', 16:08:03 INFO - 'TERM': 'linux', 16:08:03 INFO - 'TMOUT': '86400', 16:08:03 INFO - 'USER': 'cltbld', 16:08:03 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464390205.852169-814171526', 16:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:03 INFO - '_': '/tools/buildbot/bin/python'} 16:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:03 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)) 16:08:03 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)) 16:08:03 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)) 16:08:03 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)) 16:08:03 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)) 16:08:03 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)) 16:08:03 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)) 16:08:03 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)) 16:08:03 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)) 16:08:03 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)) 16:08:03 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)) 16:08:03 INFO - Cleaning up... 16:08:03 INFO - Return code: 0 16:08:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:03 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 0x7f9b3667df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd9c0>, '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 0x28fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fed50>, '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': '52faae308a556c440401f8e5000001e8-1464390205.852169-814171526', '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 16:08:03 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 16:08:03 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 16:08:03 INFO - Using env: {'DISPLAY': ':0', 16:08:03 INFO - 'HOME': '/home/cltbld', 16:08:03 INFO - 'LANG': 'en_US.UTF-8', 16:08:03 INFO - 'LANGUAGE': 'en_US:en', 16:08:03 INFO - 'LOGNAME': 'cltbld', 16:08:03 INFO - 'MAIL': '/var/mail/cltbld', 16:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:03 INFO - 'MOZ_NO_REMOTE': '1', 16:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:03 INFO - 'NO_EM_RESTART': '1', 16:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:03 INFO - 'PWD': '/builds/slave/test', 16:08:03 INFO - 'SHELL': '/bin/bash', 16:08:03 INFO - 'SHLVL': '1', 16:08:03 INFO - 'TERM': 'linux', 16:08:03 INFO - 'TMOUT': '86400', 16:08:03 INFO - 'USER': 'cltbld', 16:08:03 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464390205.852169-814171526', 16:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:03 INFO - '_': '/tools/buildbot/bin/python'} 16:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:03 INFO - Downloading/unpacking jsonschema 16:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:08:05 INFO - Downloading/unpacking functools32 (from jsonschema) 16:08:05 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 16:08:05 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 16:08:05 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 16:08:05 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 16:08:05 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 16:08:05 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 16:08:05 INFO - Downloading functools32-3.2.3-2.tar.gz 16:08:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:08:05 INFO - warning: no files found matching '*.txt' 16:08:05 INFO - no previously-included directories found matching 'build' 16:08:05 INFO - no previously-included directories found matching 'dist' 16:08:05 INFO - no previously-included directories found matching '.git*' 16:08:05 INFO - Installing collected packages: jsonschema, functools32 16:08:05 INFO - Running setup.py install for functools32 16:08:05 INFO - warning: no files found matching '*.txt' 16:08:05 INFO - no previously-included directories found matching 'build' 16:08:05 INFO - no previously-included directories found matching 'dist' 16:08:05 INFO - no previously-included directories found matching '.git*' 16:08:05 INFO - Successfully installed jsonschema functools32 16:08:05 INFO - Cleaning up... 16:08:05 INFO - Return code: 0 16:08:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:05 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 0x7f9b3667df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd9c0>, '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 0x28fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fed50>, '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': '52faae308a556c440401f8e5000001e8-1464390205.852169-814171526', '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 16:08:05 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 16:08:05 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 16:08:05 INFO - Using env: {'DISPLAY': ':0', 16:08:05 INFO - 'HOME': '/home/cltbld', 16:08:05 INFO - 'LANG': 'en_US.UTF-8', 16:08:05 INFO - 'LANGUAGE': 'en_US:en', 16:08:05 INFO - 'LOGNAME': 'cltbld', 16:08:05 INFO - 'MAIL': '/var/mail/cltbld', 16:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:05 INFO - 'MOZ_NO_REMOTE': '1', 16:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:05 INFO - 'NO_EM_RESTART': '1', 16:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:05 INFO - 'PWD': '/builds/slave/test', 16:08:05 INFO - 'SHELL': '/bin/bash', 16:08:05 INFO - 'SHLVL': '1', 16:08:05 INFO - 'TERM': 'linux', 16:08:05 INFO - 'TMOUT': '86400', 16:08:05 INFO - 'USER': 'cltbld', 16:08:05 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464390205.852169-814171526', 16:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:05 INFO - '_': '/tools/buildbot/bin/python'} 16:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:06 INFO - Downloading/unpacking flake8 16:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:08:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:08:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:08:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:08:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:08:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:08:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:08:08 INFO - no previously-included directories found matching 'docs/_build' 16:08:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:08:08 INFO - Running setup.py install for pep8 16:08:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:08:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:08:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:08:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:08:08 INFO - no previously-included directories found matching 'docs/_build' 16:08:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:08:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:08:08 INFO - Cleaning up... 16:08:09 INFO - Return code: 0 16:08:09 INFO - Running post-action listener: _resource_record_post_action 16:08:09 INFO - Running post-action listener: _start_resource_monitoring 16:08:09 INFO - Starting resource monitoring. 16:08:09 INFO - ##### 16:08:09 INFO - ##### Finished create-virtualenv step (success) 16:08:09 INFO - ##### 16:08:09 INFO - ##### 16:08:09 INFO - ##### Running install step. 16:08:09 INFO - ##### 16:08:09 INFO - Running pre-action listener: _resource_record_pre_action 16:08:09 INFO - Running main action method: install 16:08:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:08:09 INFO - Reading from file tmpfile_stdout 16:08:09 INFO - Detecting whether we're running mozinstall >=1.0... 16:08:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:08:09 INFO - Reading from file tmpfile_stdout 16:08:09 INFO - Output received: 16:08:09 INFO - Usage: mozinstall [options] installer 16:08:09 INFO - Options: 16:08:09 INFO - -h, --help show this help message and exit 16:08:09 INFO - -d DEST, --destination=DEST 16:08:09 INFO - Directory to install application into. [default: 16:08:09 INFO - "/builds/slave/test"] 16:08:09 INFO - --app=APP Application being installed. [default: firefox] 16:08:09 INFO - mkdir: /builds/slave/test/build/application 16:08:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:08:26 INFO - Reading from file tmpfile_stdout 16:08:26 INFO - Output received: 16:08:26 INFO - /builds/slave/test/build/application/firefox/firefox 16:08:26 INFO - Running post-action listener: _resource_record_post_action 16:08:26 INFO - ##### 16:08:26 INFO - ##### Finished install step (success) 16:08:26 INFO - ##### 16:08:26 INFO - ##### 16:08:26 INFO - ##### Running run-tests step. 16:08:26 INFO - ##### 16:08:26 INFO - Running pre-action listener: _resource_record_pre_action 16:08:26 INFO - Running main action method: run_tests 16:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:08:26 INFO - Python 2.7.3 16:08:26 INFO - Return code: 0 16:08:26 INFO - grabbing minidump binary from tooltool 16:08:26 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')]} 16:08:26 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd9c0>, '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 0x28fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:08:26 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 16:08:26 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 16:08:26 INFO - Calling ['/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'] with output_timeout 600 16:08:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:08:26 INFO - Return code: 0 16:08:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:08:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:08:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:08:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:08:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:08:27 INFO - Return code: 0 16:08:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 16:08:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 16:08:27 INFO - Using env: {'DISPLAY': ':0', 16:08:27 INFO - 'HOME': '/home/cltbld', 16:08:27 INFO - 'LANG': 'en_US.UTF-8', 16:08:27 INFO - 'LANGUAGE': 'en_US:en', 16:08:27 INFO - 'LOGNAME': 'cltbld', 16:08:27 INFO - 'MAIL': '/var/mail/cltbld', 16:08:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:08:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:08:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:27 INFO - 'MOZ_NO_REMOTE': '1', 16:08:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:08:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:27 INFO - 'NO_EM_RESTART': '1', 16:08:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:27 INFO - 'PWD': '/builds/slave/test', 16:08:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:08:27 INFO - 'SHELL': '/bin/bash', 16:08:27 INFO - 'SHLVL': '1', 16:08:27 INFO - 'TERM': 'linux', 16:08:27 INFO - 'TMOUT': '86400', 16:08:27 INFO - 'USER': 'cltbld', 16:08:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464390205.852169-814171526', 16:08:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:27 INFO - '_': '/tools/buildbot/bin/python'} 16:08:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 16:08:27 INFO - mozversion application_buildid: 20160527133022 16:08:27 INFO - mozversion application_changeset: 21263fbfdcc22d62b72836a3bd37c6cadb860704 16:08:27 INFO - mozversion application_display_name: Nightly 16:08:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:08:27 INFO - mozversion application_name: Firefox 16:08:27 INFO - mozversion application_remotingname: firefox 16:08:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:08:27 INFO - mozversion application_vendor: Mozilla 16:08:27 INFO - mozversion application_version: 49.0a1 16:08:27 INFO - mozversion platform_buildid: 20160527133022 16:08:27 INFO - mozversion platform_changeset: 21263fbfdcc22d62b72836a3bd37c6cadb860704 16:08:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:08:27 INFO - mozversion platform_version: 49.0a1 16:08:27 INFO - using testdate: 1464390507 16:08:27 INFO - actual date: 1464390507 16:08:27 INFO - starting webserver on 'localhost:35256' 16:08:27 INFO - SUITE-START | Running 2 tests 16:08:27 INFO - TEST-START | dromaeo_css 16:08:27 INFO - operating with platform_type : linux_ 16:08:27 INFO - Initialising browser for dromaeo_css test... 16:08:27 INFO - TEST-INFO | started process 24404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Ts0Mo/profile http://localhost:35256/getInfo.html) 16:08:31 INFO - PROCESS | 24404 | 16:08:31 INFO - PROCESS | 24404 | (process:24471): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:08:32 INFO - PROCESS | 24404 | __metrics Screen width/height:1600/1200 16:08:32 INFO - PROCESS | 24404 | colorDepth:24 16:08:32 INFO - PROCESS | 24404 | Browser inner width/height: 1024/697 16:08:32 INFO - PROCESS | 24404 | __metrics 16:08:33 ERROR - PROCESS | 24404 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 16:08:34 INFO - TEST-INFO | 24404: exit 0 16:08:34 INFO - Browser initialized. 16:08:34 INFO - Running cycle 1/1 for dromaeo_css test... 16:08:34 INFO - TEST-INFO | started process 24522 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Ts0Mo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:36 INFO - PROCESS | 24522 | 16:08:36 INFO - PROCESS | 24522 | (process:24585): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:08:46 INFO - PROCESS | 24522 | RSS: Main: 166572032 16:08:46 INFO - PROCESS | 24522 | 16:09:35 INFO - PROCESS | 24522 | 1464390575626 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] 16:11:43 INFO - PROCESS | 24522 | Cycle 1(1): loaded http://localhost:35256/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35256/tests/dromaeo/cssquery-ext.html) 16:11:44 INFO - PROCESS | 24522 | RSS: Main: 171294720 16:11:44 INFO - PROCESS | 24522 | 16:14:46 INFO - PROCESS | 24522 | Cycle 1(1): loaded http://localhost:35256/tests/dromaeo/cssquery-ext.html (next: http://localhost:35256/tests/dromaeo/cssquery-jquery.html) 16:14:47 INFO - PROCESS | 24522 | RSS: Main: 169451520 16:14:47 INFO - PROCESS | 24522 | 16:17:49 INFO - PROCESS | 24522 | Cycle 1(1): loaded http://localhost:35256/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35256/tests/dromaeo/cssquery-mootools.html) 16:17:49 INFO - PROCESS | 24522 | RSS: Main: 169730048 16:17:49 INFO - PROCESS | 24522 | 16:20:51 INFO - PROCESS | 24522 | Cycle 1(1): loaded http://localhost:35256/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35256/tests/dromaeo/cssquery-prototype.html) 16:20:52 INFO - PROCESS | 24522 | RSS: Main: 168513536 16:20:52 INFO - PROCESS | 24522 | 16:23:54 INFO - PROCESS | 24522 | Cycle 1(1): loaded http://localhost:35256/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35256/tests/dromaeo/cssquery-yui.html) 16:23:55 INFO - PROCESS | 24522 | RSS: Main: 170258432 16:23:55 INFO - PROCESS | 24522 | 16:26:58 INFO - PROCESS | 24522 | Cycle 1(1): loaded http://localhost:35256/tests/dromaeo/cssquery-yui.html (next: http://localhost:35256/tests/dromaeo/cssquery-dojo.html) 16:26:58 INFO - PROCESS | 24522 | RSS: Main: 171384832 16:26:58 INFO - PROCESS | 24522 | 16:26:58 INFO - PROCESS | 24522 | __start_tp_report 16:26:58 INFO - PROCESS | 24522 | _x_x_mozilla_page_load 16:26:58 INFO - PROCESS | 24522 | _x_x_mozilla_page_load_details 16:26:58 INFO - PROCESS | 24522 | |i|pagename|runs| 16:26:58 INFO - PROCESS | 24522 | |0;dojo.html;3033.332666813301;3099.8915037973675;3139.387819375222;3150.590423244978;3153.4008538377707;5441.537469315103;5453.700046497441;5457.181422786579;5465.316835395575;5467.5899307551945;5201;5384.5692344612435;5417.918731219035;5429.4027656957705;5447.428020057896;4862.63530235232;4890.902181956359;4928.876778080541;5023.3971923369245;5061.746912654353;4858.858168330439;5034.942662040976;5048.368953880765;5068.8732781680565;5069.771860266278;4807.543283388072;4857.198562237262;4883.169861123618;4946.233333833262;4958.8512344629535;4855.927161092586;4880.487548807395;4889.29105279736;4890.779914903838;4901.362822833044;4846.248831431134;4878.731669758162;4893.608511319086;4903.4851340609075;4923.310736496857;5072;5186.222066689989;5193.68837869729;5198.324217851655;5212.895742085175;5697.658140511582;5716.342620598602;5730.7421166047625;5733.369329373765;5737.110747834093;5600.915986260209;5726.484616384545;5772.163036359704;5786.07422812348;5797.710114494258;5341.03861304965;5361.544268737162;5451.182322651634;5475.260839786618;5512.310961129859;5994.130851026664;5996.5202783777195;6002.459778619857;6006.279246490449;6013.338532761392;5557.083081291542;5657.094864821609;5721.742521586539;5754.4533269339345;5773.1051686988585;5782.855428614318;5783.479486846204;5836.06622940336;5861.794837180678;5882.529397648178;5525.502704756511;5536.7231638418725;5784.971075144597;5788.681622510802;5817.447342502455;5585.357683866326;5592.440755924456;5596.244506991586;5614.803481878114;5656;4279.614834664895;4342.305231162999;4350.32569951658;4389.824407023683;4404.295312749945;3910.4916360872903;3924.489816323917;3929.4891664084057;3954.8615798446917;3962.663173630274;5287;5539.584531160179;5546.306711661043;5554.250176226238;5560.971220324253;5780.768769249267;5827.213326200908;5838.824835254949;5857.472827445466;5881.176635271066;5564.86087847799;5586.190002449704;5590.804321848797;5607.43925607436;5609.074502707089;4810.59109975656;4970;5033.572146367526;5039.899202015939;5100.132977393852;5892;5985.880282394415;6003.6998150093195;6006.519478441714;6037.72830222641;5830.154627578892;5852.122181672783;5857.652739869939;5860.794872179454;5868.765249389977;5658.094704847369;5871.324797648325;5958.523318134452;5961.7615295387695;5974.9103763444455;5733.283339582552;5747.683877386784;5754.482096611325;5792.102224155263;5795.840831833734;5812.302523697014;5848.707564621837;5862.267216597926;5892;5903.409659034062;5441.292631957978;5510.944890551204;5512.5314348280845;5678.148277758204;5689.829305120853;5408.405075441777;5543.417941116286;5584.804531841366;5629.6903670298525;5655.349634792052;5562.332520097614;5573.804916828054;5578.944210558005;5586.916196257141;5594.356648985256;5561.4716601922755;5594.804181853616;5670.60305778608;5680.034394152921;5689.743961521659;5520.227168196376;5558.24963629921;5589.357223919302;5602.467765562265;5662.688552129673 16:26:58 INFO - PROCESS | 24522 | |1;ext.html;577.48603742669;622.8131560531839;634.6794868591361;647.3267801486453;662.427000644442;35579.64420355796;40594.7970260149;40642.187156256856;40819.38770918431;40971.79514102429;42552;42725;42824.357634635424;43001.35497967533;43312.78343608278;8467.618957146944;8516;8601.440906341099;8607.311415086779;8611.913880861173;8522.062573116953;8522.786930326729;8571.057183709787;8590.656373745043;8665.610047547843;8539.701110461136;8625.784355391133;8629.309655227598;8666.653333866638;8692.521911294876;8547.786305342353;8592.226699597004;8600.655973761042;8635.52504612246;8676.783080423009;8517.06312305646;8617.439866408664;8640.913590864075;8708.042115367305;8712.607932643046;31886;39045;39051.21897562033;39450.408243876365;39458;3327.783694059878;3380.4591265397416;3509.7192224621967;3620.475031120499;3628.4920111184456;30685.386292274252;31021.84489077563;31130.533042004387;31317.686823131706;32286.192845178823;4046.514418269797;4101.241270364992;4103.322951712994;4260.403543503912;4311.8490852820005;299906.99999999785;300747;301342;303197;303253;32497.675023249463;32525.349493010006;33182.66817331796;33209.33581328408;33806.66193338084;36491.817540912125;36564.63435365666;36759.4486082709;36883.815580921924;37159.256814863555;15257.237138143048;15559.22203889801;15606.843931560767;15611.531654050397;15652.295646695926;13027;13090.803637945439;13182.011349148852;13288.402021909038;13352.599422017354;7756.883646745303;7978.880316795253;8049.114597394282;8126.593670316579;8133;3078.538219267083;3165.4776961801504;3180.427523045874;3226.5321528378254;3263.282077942849;1067.5750157653501;1088.9074428673493;1100.9064229540418;1124.6569796212234;1170.1224081938547;32140.357192856012;32257.51613725796;32426.67573324284;32459.513107302937;33215;992.0426788149471;1121.6466812953893;1157.479134389528;1165.35905252111;1176.847009888726;16574.502764917073;16577;16804.831951680328;16819.243134058997;16832.410865619644;150625;151237;151867;153617;154080.22959885353;56885.715571421875;57815.13277300844;58113.4188658108;58441;58678.706606467545;1399.5941177058742;1403.6701375176826;1408.7886816977536;1411.724713680843;1426.700392917499;30564.847175763978;32210.516842247853;32258;32690;32838.83580582082;51617.741911290206;51621.7418912903;51751.74124129355;51981;52498;401892;403516;404269;405589;407720;27676.169714908585;28647.71352286534;28818;28841.71158288474;28856.278593035342;47347.76326118347;49384.75307623583;49703.75148124381;49928;50127.74936125296;40971.79514102411;40981.59018409897;41130;41406.585934141476;41613.37579936243;40472.595274046886;40753.38869917013;41127.1774564501;41160.38259426051;41177.79411102925;36968.26063478662;39947.2010559793;40108.79945600253;40409.797951010056;41042.58957410388;35613;36510.817445913664;36523.452148217264;37107.44338834973;37293.254134916606;27702.554708189447;27769.861150694116;27945.58038990166;28098.2975425616;28139.63473693667 16:26:58 INFO - PROCESS | 24522 | |2;jquery.html;382.8200745649544;391.745365512417;394.46943860507605;396.6945452001958;416.6833206762859;17682.29270829167;18425.170867310968;18699.813001869978;20261.290854820083;20269.898650506762;18216.726749098772;18538.72191917119;19126.71309930352;19224.03879806011;19242.326518571852;4111.218868415007;5571.4428557144265;5735.11105778605;5776.046952252873;5777.075667893117;5976;6382.680865956683;6403.679816009204;6409.583377080498;6480.6435646039445;5760.0783874580075;5783.913241301363;5851.678157701324;6402.679866006704;6409.294977552466;5696.629719068247;5731.828045158652;5735.627184233053;5749.712514374285;5761.395053519383;4838.758062096881;5043.243513472972;5070.72111033893;5136.5377116059735;5149.0474262261605;12956;13255.734885302336;13453.260070696108;14080.718385632332;14091.647708807259;2083.0938541734245;2107.230860735836;2180.324099529151;2351.1770880191966;2374.5963186258377;9467.621295148187;9542.284328675378;9878.357906736039;9989.300748947577;13866.584002479942;1850.8241717036994;1893.3089422360877;1943.8833669979706;1953.2089503751004;1961.7842037375876;61503;78309.99999999943;79982.20017799806;80664.23726187063;80788.59605702052;9626.759331016641;10378.740531486774;10646;10693.732656683489;10720.73198170052;15084.170370629501;15283.770743438858;15378.077315361114;15423.614409639624;15437.768433473508;7835.2948234658015;7951.602419878983;7980.880286795703;8090.878636820453;8311.584420779058;7513.737019204302;7705.267999540035;8109.878351824727;8229.917700822914;8270.214329638795;4399.64802815774;4561.703489273186;4567.269236922143;4617.515160908123;4663.300504924221;1860.1635747057542;1875.7655293088364;1892.782330032064;1946.5984491166337;1988.4929343017727;950.7908260182749;1006.3157053203745;1087.853139826129;1091.6943255888364;1104.4256986367045;18211.271549137888;18898.960557169212;19195;19195.32816351421;19495.22019119248;977.9119879210763;979.911807937289;996.785691076422;1010.6765834932751;1043.2280112716687;9657.806843863083;10350.068493835592;10786.406747628957;10840.837387439195;10909;430187;436169;443041;443653;445108;88667.55666221627;90119.54940225257;91605;91788;92181;880.9695642435881;884.0496466298755;905.3164860530258;908.5230254116642;917.5274733512247;14966.48287652379;15767.68464630724;15909.204539772734;16011.679766404373;16249.431269905497;40143;40289.59710402859;41133.794331028155;42178.36732449077;42678.35982460328;55379.44620553743;55881.441185587624;56020.159697605384;56397;57435.138472923776;8085.434019618806;8119.391045671717;8201.384896132933;8379.622916968628;8448.070712221774;12337.414399270041;12992.8051079232;13307.334633268105;13451.663708407368;13516.79724804109;11139.944300278446;11359.943200283946;11501.827472588086;11566.479508421973;11578.768424631291;11411.087113030771;11498.13763967689;11583;11616.88383116158;11690.357030363411;11635.592754253561;11766.411679416165;11780.410979451164;11950.880491195325;12034.939825300817;8359.373047021376;8435.367347448842;8572.27135693473;8611.784705382164;8644.740657780276;10379.896201037893;11508.48211830453;11643.59247426336;11826.290422574673;11850.881491184979 16:26:58 INFO - PROCESS | 24522 | |3;mootools.html;1498.1760031982408;1527.6715506166174;1676.0530300380285;1797.9910100449497;1801.7027190513566;7671.2712292332135;8608.268297194745;8655.653773849046;9202.309826762994;9248;8550.144985501447;8944.59749311281;8998.100189981014;9010.18908298253;9013.54932253388;2327.895244713992;2353.0705371378294;2371.21749822559;2371.312319427364;2381.3927448500694;2298.885055747214;2309.261036468331;2329.1964272326104;2350.96473552896;2356.8703721295324;2342.4261056041296;2342.496363281894;2360.6459031145378;2373.062640257106;2375.3824005758456;2261.0729600863565;2274.4655006073644;2290.931272061841;2291.3927809130596;2320.060375547906;2254.6956160918394;2255.28958378112;2257.6049191391603;2259.299617118682;2259.299617118682;8831;8846.15961483658;8881.777955551099;8883.11168883113;8906.465612063232;5201.817936372209;5341.305630268079;5344.251804747339;5345.4387289334445;5376.301080859464;3167.524871269305;3218.09893229896;3371.1403592084107;3383.2387712764676;3384.069380920242;1133.6372360844532;1139.5327915554583;1142.1148609827367;1163.2292514441103;1180.4038960325067;12379.195352302071;12432.813507797391;12526.123171377916;12531.248125112523;12571.559995400208;4645.744484053342;4724.905501889943;4812.590929770939;4825.4933232010835;4851.223804191383;10385.480725963671;10397.272190946562;10401.53193106297;10426.426546540013;10460.476976151314;5236.162214045735;5292.52367286946;5312.893742125136;5317.601179911522;5451.173856757951;4279.828806847691;4804.42346918365;4913.992631510532;4971.527704868032;4987.950120498821;4008;4025.6578190854107;4115.259253334369;4145.3781932709735;4157.729747566398;1144.753877916252;1270.7712611729978;1281.653953432568;1290.4128621477394;1299.226959958842;823.3331001888489;941.3410612571228;957.3394357893031;1000.3278134840631;1004.0461561516588;5920.082387229986;5920.727043685542;5959.523238140939;6128.754849806047;6142.815715528542;948.6869333120054;957.7940742740205;990.1237404896718;1008.4251976373544;1016.506994107857;3990.780507072139;3992.161646054303;4038.8586399475876;4057.14799892026;4083.244599749056;10953.397563134104;11313.604023859125;11334.886651133547;11394.259373140885;11395.316281023164;10971.725706857393;11021.393823339633;11048.447577621087;11055.502502387411;11087.944560277308;8204.548749818698;8205.343572514184;8231.05342885564;8278.544680042534;8308.584570771438;5807.622504537191;5813;5820.388859169726;5910.231669882888;5993.880122397615;9819;10262.538185781508;10301.74245643865;10348.068673819393;10448.738781530219;10362.274640775375;10395.532201050819;10450.843237351293;10484.737881553023;10506.789864202521;7834.764957051298;7840.490368126054;7844;7885.5662938538935;7887.40844436681;8561.743147705578;8593.355498337774;8613.3109351253;8643.524606146722;8696.739097827076;7537.6984920604755;7874.094479134973;8010.879836802336;8040.678372865254;8102.351811855156;7817.475592259455;7851.293383595504;7907.2488113629115;7949.165337639464;8004.759857204293;7218.242084581043;7282.781516554512;7298.306660867209;7347.19180890091;7349.118105827335;5066.898662026812;5087.084324821568;5147.716875571729;5185.585153187812;5237.607179461479;5242.711650859239;5350.705711185922;5353.304070470814;5406.135018397038;5437.32033495813 16:26:58 INFO - PROCESS | 24522 | |4;prototype.html;336.86525389844076;340.156412097997;342.7052734648202;345.5680399500626;350.45679197244266;5504.80733174339;5508.807191748289;5583.469570390816;5603.842520629556;5619.6066275360745;5472.1244600863865;5509.47659972303;5513.2005859150395;5523.972380138103;5533.142362933741;4151.481064866892;4179.958200417987;4236.872893813191;4285.142971405716;4286.39990401344;4234.894127646818;4253.680973926952;4268.530461649216;4273.316269396897;4276.379924910886;4242.809073591696;4250.596193361625;4252.766097864616;4282.421873047146;4288.726974703412;3998.5801490843332;4190.497140343178;4261.595148460891;4274.380214868842;4275.743455392686;3631.564212294515;3635.2184280379847;3646.781193128421;3657.7622454540638;3658.359787037258;5263.184206448007;5296.417394086648;5311.150215965466;5348.171033489815;5363.766333743222;4759.690620109682;4866.31871537985;4867.075255701406;4870.391201099863;4907.9263811042865;5631.577631677641;5699.316082070137;5746.913796293059;5774.566907481955;5790.7104644768015;4004.83980640774;4059.939100913489;4066.674666026711;4077.0011347219825;4094.5086589609436;5778.739956701958;5993.670348130851;6036.849078772978;6052.54605904559;6075.848103797396;4129.752214867118;4136.462259906253;4148.398482220122;4154.937675934863;4184.8744537663915;4187.685923555746;4199.538050814408;4211.052513184571;4219.535851056381;4226.006888381228;4701.200795864711;4825.613950883921;4830.154722923475;4832.806687732522;4877.146499362598;5665.773369065274;5720.656760594377;5784.768609255582;5784.855378615568;5897.051474262868;1436.5833908166724;1436.906601070927;1439.3738723655244;1442.834074081473;1444.7905053767145;902.5126431726925;906.1436942089794;918.6725182111918;920.6777627830206;920.9263258939269;5010.448850626428;5011.346255735599;5028.270900719375;5097.847064588068;5110.6678065926335;5314.4951229633125;5351.384590772033;5362.517373436332;5373.731313434313;5412.404635490093;4771.08000718812;4987.476314986874;5001.049800537886;5011.824586139468;5013.39839219296;2846.302655849289;2854.942901142007;2866.6846646869244;2877.5971364009056;2884.97115028847;5419.756110975016;5436;5444.428335024765;5482.8081017165005;5489.533389661923;5139.913242870387;5226.353698584933;5432.538234250133;5435.581166380923;5454.8909021819345;5357.6605848537865;5425.565954723613;5523.8066667666435;5546.639468434539;5554.750036248298;4909.312696222603;5201.375834899836;5248.790048398021;5266.603695318698;5368.624196306221;5228.333549889508;5248.504176309733;5248.921266180934;5680.857978550569;5701.201831743642;6092.299385570716;6120.602160859708;6152.384761523812;6185.6907154641185;6192.81421557354;4100.630943215125;4103.733257338264;4134.503859536754;4149.97925010373;4173.353130264813;5721.914171287517;5932.64404135736;6019.765947980741;6031.8237943602335;6081.483073938764;5825.563082768725;5846.41535846429;5868.3251426086545;5885.910501771809;5890.087036509348;5499.780008799603;5841.94158058414;5868.970655146697;5888.970555147197;5891.852703682443;5674.404187560412;5825;5828.213191219301;5878.353381128158;5891.852703682443;5917.733701983335;5918;5926.67403292823;5971.731272092679;6002.879942401215;5563.358809151229;5753.395893431297;5771.163181338598;5811.389804070681;5814.592978491465 16:26:58 INFO - PROCESS | 24522 | |5;yui.html;804.1556365815892;811.08347567249;851.9957400212998;856.2636132925687;857.7212405968062;14001.579952601425;14418.134911905294;14621.926890365547;16334.673306533863;16823.41118060868;15254.542363729079;15407.768883466757;15517.612059698486;15518.224088795543;15552.066875987448;786.9291763741262;790.9881351779713;791.0428381658201;792.6512334572799;795.0538858758089;806.1293802693077;807.64059993303;808.789714674186;811.7199566149669;812.0458461307969;845.3237410071948;848.6308455821707;849.4478588917223;850.5874650794391;853.7225401744458;835.1356346181673;840.0675250472002;844.0715213265389;845.0957475501216;845.691322667222;607.2803727582784;612.5038718637918;616.9537284703665;617.2346290599625;620.8292719502128;14809.111453312837;14818.481353152696;14954.775678364833;14973.401063957428;14997.250137493082;13255.204687718768;13329.133606315558;13383.130096543693;13479.258640774753;13481.662958426019;12432.010878259434;12488.12583119182;12563.874361256361;12583.559575414816;12713.364331783374;4449.733016019017;4486.775661216926;4496.123255965088;4565.863024109282;4686.390769200017;60825;61068.69465652643;61741.691291543706;62003.37996620021;62135;10977.560897564168;11121.999999999838;11129.220954533104;11203.271787333797;11471.827922581168;17256.913715431343;17474.038927858837;17645.117744112744;17920.731189032176;18258.54353641143;8426.452280601741;8435.493870367798;8444;8584.270337021424;9111.453312801254;4611.492735799059;4732.834350797705;4781.354517140142;4785.3300537924715;4896.804127834846;3476.5828100628087;3534;3546.716262698978;3564.4118720410843;3564.500969864221;610.6702380714364;635.6916895305773;645.602954183174;654.5025780406925;664.2162248546762;676.7935779587273;680.8093733754557;692.8510370270416;763.4007304266236;775.4494309040532;9669.760844137956;9981.900180998242;10414.791704165875;10800.675979720621;11155.498002589902;702.2766550453042;708.8653155900363;717.5013365710781;719.0917364125992;748.5658318175446;4421.690481666253;4662.300654901792;4701.130290896195;4729.929051064237;4809.326694262806;69109.30890691129;69311;69431.65284173547;70001.2999870005;70399.64800176068;57129;61549;62028.68985655043;62662.060069099;63951;52139.47860521422;57416;57551.42448575461;57641.42358576361;57647.42352576504;9772.85340719904;9872.35829671069;9922.801543969224;9926.553305101143;9954.950225249117;38308.425373619975;39025.60974390333;39064;39083.413748793224;39728.80813575597;51588.22617660663;51853.7407312961;51970.740146299024;52003.73998129985;53766.73116634392;12511.687207819878;12584.244945303311;12649.177803442746;12777.808332874829;13016.934915325362;12934.482620695067;13139.671508212372;13223.140495867738;13628.386722597308;14338.856611433752;12660.620181394574;12789.61631151067;12807.487700491876;13092.279924604238;13366.599002029954;13075.934620326838;13377.398017089448;13439.395227214995;13446.327683615977;13449.260290684106;12300.50797968107;12467.1273010892;12476.313802740573;12766.042546809213;12810.231386116862;10021.899781002097;10046.397216167054;10292.228082893962;10407.865045677294;10494.370337779757;9898.752531186778;10272.743181420225;10796.730081748019;11014.944925275322;11029.61396351124 16:26:58 INFO - PROCESS | 24522 | __end_tp_report 16:26:58 INFO - PROCESS | 24522 | __start_cc_report 16:26:58 INFO - PROCESS | 24522 | _x_x_mozilla_cycle_collect,345 16:26:58 INFO - PROCESS | 24522 | __end_cc_report 16:26:58 INFO - PROCESS | 24522 | __startTimestamp1464391618303__endTimestamp 16:26:58 INFO - PROCESS | 24522 | 16:26:58 INFO - PROCESS | 24522 | ------- Summary: start ------- 16:26:58 INFO - PROCESS | 24522 | Number of tests: 6 16:26:58 INFO - PROCESS | 24522 | 16:26:58 INFO - PROCESS | 24522 | [#0] dojo.html Cycles:165 Average:5362.47 Median:5564.86 stddev:615.49 (11.1%) stddev-sans-first:589.64 16:26:58 INFO - PROCESS | 24522 | Values: 3033.3 3099.9 3139.4 3150.6 3153.4 5441.5 5453.7 5457.2 5465.3 5467.6 5201.0 5384.6 5417.9 5429.4 5447.4 4862.6 4890.9 4928.9 5023.4 5061.7 4858.9 5034.9 5048.4 5068.9 5069.8 4807.5 4857.2 4883.2 4946.2 4958.9 4855.9 4880.5 4889.3 4890.8 4901.4 4846.2 4878.7 4893.6 4903.5 4923.3 5072.0 5186.2 5193.7 5198.3 5212.9 5697.7 5716.3 5730.7 5733.4 5737.1 5600.9 5726.5 5772.2 5786.1 5797.7 5341.0 5361.5 5451.2 5475.3 5512.3 5994.1 5996.5 6002.5 6006.3 6013.3 5557.1 5657.1 5721.7 5754.5 5773.1 5782.9 5783.5 5836.1 5861.8 5882.5 5525.5 5536.7 5785.0 5788.7 5817.4 5585.4 5592.4 5596.2 5614.8 5656.0 4279.6 4342.3 4350.3 4389.8 4404.3 3910.5 3924.5 3929.5 3954.9 3962.7 5287.0 5539.6 5546.3 5554.3 5561.0 5780.8 5827.2 5838.8 5857.5 5881.2 5564.9 5586.2 5590.8 5607.4 5609.1 4810.6 4970.0 5033.6 5039.9 5100.1 5892.0 5985.9 6003.7 6006.5 6037.7 5830.2 5852.1 5857.7 5860.8 5868.8 5658.1 5871.3 5958.5 5961.8 5974.9 5733.3 5747.7 5754.5 5792.1 5795.8 5812.3 5848.7 5862.3 5892.0 5903.4 5441.3 5510.9 5512.5 5678.1 5689.8 5408.4 5543.4 5584.8 5629.7 5655.3 5562.3 5573.8 5578.9 5586.9 5594.4 5561.5 5594.8 5670.6 5680.0 5689.7 5520.2 5558.2 5589.4 5602.5 5662.7 16:26:58 INFO - PROCESS | 24522 | 16:26:58 INFO - PROCESS | 24522 | [#1] ext.html Cycles:180 Average:45288.85 Median:37226.26 stddev:80500.32 (216.2%) stddev-sans-first:80656.15 16:26:58 INFO - PROCESS | 24522 | Values: 577.5 622.8 634.7 647.3 662.4 35579.6 40594.8 40642.2 40819.4 40971.8 42552.0 42725.0 42824.4 43001.4 43312.8 8467.6 8516.0 8601.4 8607.3 8611.9 8522.1 8522.8 8571.1 8590.7 8665.6 8539.7 8625.8 8629.3 8666.7 8692.5 8547.8 8592.2 8600.7 8635.5 8676.8 8517.1 8617.4 8640.9 8708.0 8712.6 31886.0 39045.0 39051.2 39450.4 39458.0 3327.8 3380.5 3509.7 3620.5 3628.5 30685.4 31021.8 31130.5 31317.7 32286.2 4046.5 4101.2 4103.3 4260.4 4311.8 299907.0 300747.0 301342.0 303197.0 303253.0 32497.7 32525.3 33182.7 33209.3 33806.7 36491.8 36564.6 36759.4 36883.8 37159.3 15257.2 15559.2 15606.8 15611.5 15652.3 13027.0 13090.8 13182.0 13288.4 13352.6 7756.9 7978.9 8049.1 8126.6 8133.0 3078.5 3165.5 3180.4 3226.5 3263.3 1067.6 1088.9 1100.9 1124.7 1170.1 32140.4 32257.5 32426.7 32459.5 33215.0 992.0 1121.6 1157.5 1165.4 1176.8 16574.5 16577.0 16804.8 16819.2 16832.4 150625.0 151237.0 151867.0 153617.0 154080.2 56885.7 57815.1 58113.4 58441.0 58678.7 1399.6 1403.7 1408.8 1411.7 1426.7 30564.8 32210.5 32258.0 32690.0 32838.8 51617.7 51621.7 51751.7 51981.0 52498.0 401892.0 403516.0 404269.0 405589.0 407720.0 27676.2 28647.7 28818.0 28841.7 28856.3 47347.8 49384.8 49703.8 49928.0 50127.7 40971.8 40981.6 41130.0 41406.6 41613.4 40472.6 40753.4 41127.2 41160.4 41177.8 36968.3 39947.2 40108.8 40409.8 41042.6 35613.0 36510.8 36523.5 37107.4 37293.3 27702.6 27769.9 27945.6 28098.3 28139.6 16:26:58 INFO - PROCESS | 24522 | 16:26:58 INFO - PROCESS | 24522 | [#2] jquery.html Cycles:180 Average:27000.12 Median:22200.41 stddev:72720.51 (327.6%) stddev-sans-first:72897.05 16:26:58 INFO - PROCESS | 24522 | Values: 382.8 391.7 394.5 396.7 416.7 17682.3 18425.2 18699.8 20261.3 20269.9 18216.7 18538.7 19126.7 19224.0 19242.3 4111.2 5571.4 5735.1 5776.0 5777.1 5976.0 6382.7 6403.7 6409.6 6480.6 5760.1 5783.9 5851.7 6402.7 6409.3 5696.6 5731.8 5735.6 5749.7 5761.4 4838.8 5043.2 5070.7 5136.5 5149.0 12956.0 13255.7 13453.3 14080.7 14091.6 2083.1 2107.2 2180.3 2351.2 2374.6 9467.6 9542.3 9878.4 9989.3 13866.6 1850.8 1893.3 1943.9 1953.2 1961.8 61503.0 78310.0 79982.2 80664.2 80788.6 9626.8 10378.7 10646.0 10693.7 10720.7 15084.2 15283.8 15378.1 15423.6 15437.8 7835.3 7951.6 7980.9 8090.9 8311.6 7513.7 7705.3 8109.9 8229.9 8270.2 4399.6 4561.7 4567.3 4617.5 4663.3 1860.2 1875.8 1892.8 1946.6 1988.5 950.8 1006.3 1087.9 1091.7 1104.4 18211.3 18899.0 19195.0 19195.3 19495.2 977.9 979.9 996.8 1010.7 1043.2 9657.8 10350.1 10786.4 10840.8 10909.0 430187.0 436169.0 443041.0 443653.0 445108.0 88667.6 90119.5 91605.0 91788.0 92181.0 881.0 884.0 905.3 908.5 917.5 14966.5 15767.7 15909.2 16011.7 16249.4 40143.0 40289.6 41133.8 42178.4 42678.4 55379.4 55881.4 56020.2 56397.0 57435.1 8085.4 8119.4 8201.4 8379.6 8448.1 12337.4 12992.8 13307.3 13451.7 13516.8 11139.9 11359.9 11501.8 11566.5 11578.8 11411.1 11498.1 11583.0 11616.9 11690.4 11635.6 11766.4 11780.4 11950.9 12034.9 8359.4 8435.4 8572.3 8611.8 8644.7 10379.9 11508.5 11643.6 11826.3 11850.9 16:26:58 INFO - PROCESS | 24522 | 16:26:58 INFO - PROCESS | 24522 | [#3] mootools.html Cycles:180 Average:5883.39 Median:4764.66 stddev:3359.06 (70.5%) stddev-sans-first:3352.32 16:26:58 INFO - PROCESS | 24522 | Values: 1498.2 1527.7 1676.1 1798.0 1801.7 7671.3 8608.3 8655.7 9202.3 9248.0 8550.1 8944.6 8998.1 9010.2 9013.5 2327.9 2353.1 2371.2 2371.3 2381.4 2298.9 2309.3 2329.2 2351.0 2356.9 2342.4 2342.5 2360.6 2373.1 2375.4 2261.1 2274.5 2290.9 2291.4 2320.1 2254.7 2255.3 2257.6 2259.3 2259.3 8831.0 8846.2 8881.8 8883.1 8906.5 5201.8 5341.3 5344.3 5345.4 5376.3 3167.5 3218.1 3371.1 3383.2 3384.1 1133.6 1139.5 1142.1 1163.2 1180.4 12379.2 12432.8 12526.1 12531.2 12571.6 4645.7 4724.9 4812.6 4825.5 4851.2 10385.5 10397.3 10401.5 10426.4 10460.5 5236.2 5292.5 5312.9 5317.6 5451.2 4279.8 4804.4 4914.0 4971.5 4988.0 4008.0 4025.7 4115.3 4145.4 4157.7 1144.8 1270.8 1281.7 1290.4 1299.2 823.3 941.3 957.3 1000.3 1004.0 5920.1 5920.7 5959.5 6128.8 6142.8 948.7 957.8 990.1 1008.4 1016.5 3990.8 3992.2 4038.9 4057.1 4083.2 10953.4 11313.6 11334.9 11394.3 11395.3 10971.7 11021.4 11048.4 11055.5 11087.9 8204.5 8205.3 8231.1 8278.5 8308.6 5807.6 5813.0 5820.4 5910.2 5993.9 9819.0 10262.5 10301.7 10348.1 10448.7 10362.3 10395.5 10450.8 10484.7 10506.8 7834.8 7840.5 7844.0 7885.6 7887.4 8561.7 8593.4 8613.3 8643.5 8696.7 7537.7 7874.1 8010.9 8040.7 8102.4 7817.5 7851.3 7907.2 7949.2 8004.8 7218.2 7282.8 7298.3 7347.2 7349.1 5066.9 5087.1 5147.7 5185.6 5237.6 5242.7 5350.7 5353.3 5406.1 5437.3 16:26:58 INFO - PROCESS | 24522 | 16:26:58 INFO - PROCESS | 24522 | [#4] prototype.html Cycles:180 Average:4716.78 Median:5303.78 stddev:1393.87 (26.3%) stddev-sans-first:1358.46 16:26:58 INFO - PROCESS | 24522 | Values: 336.9 340.2 342.7 345.6 350.5 5504.8 5508.8 5583.5 5603.8 5619.6 5472.1 5509.5 5513.2 5524.0 5533.1 4151.5 4180.0 4236.9 4285.1 4286.4 4234.9 4253.7 4268.5 4273.3 4276.4 4242.8 4250.6 4252.8 4282.4 4288.7 3998.6 4190.5 4261.6 4274.4 4275.7 3631.6 3635.2 3646.8 3657.8 3658.4 5263.2 5296.4 5311.2 5348.2 5363.8 4759.7 4866.3 4867.1 4870.4 4907.9 5631.6 5699.3 5746.9 5774.6 5790.7 4004.8 4059.9 4066.7 4077.0 4094.5 5778.7 5993.7 6036.8 6052.5 6075.8 4129.8 4136.5 4148.4 4154.9 4184.9 4187.7 4199.5 4211.1 4219.5 4226.0 4701.2 4825.6 4830.2 4832.8 4877.1 5665.8 5720.7 5784.8 5784.9 5897.1 1436.6 1436.9 1439.4 1442.8 1444.8 902.5 906.1 918.7 920.7 920.9 5010.4 5011.3 5028.3 5097.8 5110.7 5314.5 5351.4 5362.5 5373.7 5412.4 4771.1 4987.5 5001.0 5011.8 5013.4 2846.3 2854.9 2866.7 2877.6 2885.0 5419.8 5436.0 5444.4 5482.8 5489.5 5139.9 5226.4 5432.5 5435.6 5454.9 5357.7 5425.6 5523.8 5546.6 5554.8 4909.3 5201.4 5248.8 5266.6 5368.6 5228.3 5248.5 5248.9 5680.9 5701.2 6092.3 6120.6 6152.4 6185.7 6192.8 4100.6 4103.7 4134.5 4150.0 4173.4 5721.9 5932.6 6019.8 6031.8 6081.5 5825.6 5846.4 5868.3 5885.9 5890.1 5499.8 5841.9 5869.0 5889.0 5891.9 5674.4 5825.0 5828.2 5878.4 5891.9 5917.7 5918.0 5926.7 5971.7 6002.9 5563.4 5753.4 5771.2 5811.4 5814.6 16:26:58 INFO - PROCESS | 24522 | 16:26:58 INFO - PROCESS | 24522 | [#5] yui.html Cycles:180 Average:16110.01 Median:4715.53 stddev:19366.32 (410.7%) stddev-sans-first:19386.54 16:26:58 INFO - PROCESS | 24522 | Values: 804.2 811.1 852.0 856.3 857.7 14001.6 14418.1 14621.9 16334.7 16823.4 15254.5 15407.8 15517.6 15518.2 15552.1 786.9 791.0 791.0 792.7 795.1 806.1 807.6 808.8 811.7 812.0 845.3 848.6 849.4 850.6 853.7 835.1 840.1 844.1 845.1 845.7 607.3 612.5 617.0 617.2 620.8 14809.1 14818.5 14954.8 14973.4 14997.3 13255.2 13329.1 13383.1 13479.3 13481.7 12432.0 12488.1 12563.9 12583.6 12713.4 4449.7 4486.8 4496.1 4565.9 4686.4 60825.0 61068.7 61741.7 62003.4 62135.0 10977.6 11122.0 11129.2 11203.3 11471.8 17256.9 17474.0 17645.1 17920.7 18258.5 8426.5 8435.5 8444.0 8584.3 9111.5 4611.5 4732.8 4781.4 4785.3 4896.8 3476.6 3534.0 3546.7 3564.4 3564.5 610.7 635.7 645.6 654.5 664.2 676.8 680.8 692.9 763.4 775.4 9669.8 9981.9 10414.8 10800.7 11155.5 702.3 708.9 717.5 719.1 748.6 4421.7 4662.3 4701.1 4729.9 4809.3 69109.3 69311.0 69431.7 70001.3 70399.6 57129.0 61549.0 62028.7 62662.1 63951.0 52139.5 57416.0 57551.4 57641.4 57647.4 9772.9 9872.4 9922.8 9926.6 9955.0 38308.4 39025.6 39064.0 39083.4 39728.8 51588.2 51853.7 51970.7 52003.7 53766.7 12511.7 12584.2 12649.2 12777.8 13016.9 12934.5 13139.7 13223.1 13628.4 14338.9 12660.6 12789.6 12807.5 13092.3 13366.6 13075.9 13377.4 13439.4 13446.3 13449.3 12300.5 12467.1 12476.3 12766.0 12810.2 10021.9 10046.4 10292.2 10407.9 10494.4 9898.8 10272.7 10796.7 11014.9 11029.6 16:26:58 INFO - PROCESS | 24522 | -------- Summary: end -------- 16:26:58 INFO - PROCESS | 24522 | 16:26:59 INFO - TEST-INFO | 24522: exit 0 16:26:59 INFO - TEST-OK | dromaeo_css | took 1111829ms 16:26:59 INFO - TEST-START | kraken 16:26:59 INFO - operating with platform_type : linux_ 16:26:59 INFO - Initialising browser for kraken test... 16:26:59 INFO - TEST-INFO | started process 24761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoiGG6x/profile http://localhost:35256/getInfo.html) 16:27:03 INFO - PROCESS | 24761 | 16:27:03 INFO - PROCESS | 24761 | (process:24830): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:27:03 INFO - PROCESS | 24761 | __metrics Screen width/height:1600/1200 16:27:03 INFO - PROCESS | 24761 | colorDepth:24 16:27:03 INFO - PROCESS | 24761 | Browser inner width/height: 1024/697 16:27:03 INFO - PROCESS | 24761 | __metrics 16:27:04 ERROR - PROCESS | 24761 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 16:27:05 INFO - TEST-INFO | 24761: exit 0 16:27:05 INFO - Browser initialized. 16:27:05 INFO - Running cycle 1/1 for kraken test... 16:27:05 INFO - TEST-INFO | started process 24881 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoiGG6x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:27:07 INFO - PROCESS | 24881 | 16:27:07 INFO - PROCESS | 24881 | (process:24943): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:27:17 INFO - PROCESS | 24881 | RSS: Main: 166637568 16:27:17 INFO - PROCESS | 24881 | 16:27:19 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:35256/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35256/tests/kraken/driver.html?testName=audio-beat-detection) 16:27:20 INFO - PROCESS | 24881 | RSS: Main: 171978752 16:27:20 INFO - PROCESS | 24881 | 16:27:23 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:35256/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35256/tests/kraken/driver.html?testName=audio-dft) 16:27:24 INFO - PROCESS | 24881 | RSS: Main: 171315200 16:27:24 INFO - PROCESS | 24881 | 16:27:26 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:35256/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35256/tests/kraken/driver.html?testName=audio-fft) 16:27:27 INFO - PROCESS | 24881 | RSS: Main: 166227968 16:27:27 INFO - PROCESS | 24881 | 16:27:29 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:35256/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35256/tests/kraken/driver.html?testName=audio-oscillator) 16:27:30 INFO - PROCESS | 24881 | RSS: Main: 167309312 16:27:30 INFO - PROCESS | 24881 | 16:27:32 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:35256/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35256/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:27:33 INFO - PROCESS | 24881 | RSS: Main: 167321600 16:27:33 INFO - PROCESS | 24881 | 16:27:36 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:35256/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35256/tests/kraken/driver.html?testName=imaging-darkroom) 16:27:36 INFO - PROCESS | 24881 | RSS: Main: 167055360 16:27:36 INFO - PROCESS | 24881 | 16:27:40 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:35256/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35256/tests/kraken/driver.html?testName=imaging-desaturate) 16:27:40 INFO - PROCESS | 24881 | RSS: Main: 165154816 16:27:40 INFO - PROCESS | 24881 | 16:27:43 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:35256/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35256/tests/kraken/driver.html?testName=json-parse-financial) 16:27:44 INFO - PROCESS | 24881 | RSS: Main: 166952960 16:27:44 INFO - PROCESS | 24881 | 16:27:45 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:35256/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35256/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:27:46 INFO - PROCESS | 24881 | RSS: Main: 167383040 16:27:46 INFO - PROCESS | 24881 | 16:27:48 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:35256/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35256/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:27:48 INFO - PROCESS | 24881 | RSS: Main: 167096320 16:27:48 INFO - PROCESS | 24881 | 16:27:51 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:35256/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35256/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:27:51 INFO - PROCESS | 24881 | RSS: Main: 167636992 16:27:51 INFO - PROCESS | 24881 | 16:27:54 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:35256/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35256/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:27:54 INFO - PROCESS | 24881 | RSS: Main: 167620608 16:27:54 INFO - PROCESS | 24881 | 16:27:57 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:35256/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35256/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:27:58 INFO - PROCESS | 24881 | RSS: Main: 168226816 16:27:58 INFO - PROCESS | 24881 | 16:27:59 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:35256/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35256/tests/kraken/driver.html?testName=ai-astar) 16:28:00 INFO - PROCESS | 24881 | RSS: Main: 168497152 16:28:00 INFO - PROCESS | 24881 | 16:28:00 INFO - PROCESS | 24881 | __start_tp_report 16:28:00 INFO - PROCESS | 24881 | _x_x_mozilla_page_load 16:28:00 INFO - PROCESS | 24881 | _x_x_mozilla_page_load_details 16:28:00 INFO - PROCESS | 24881 | |i|pagename|runs| 16:28:00 INFO - PROCESS | 24881 | |0;ai-astar;112;105;111;111;112;112;111;111;112;113 16:28:00 INFO - PROCESS | 24881 | |1;audio-beat-detection;157;126;162;188;127;157;152;131;179;125 16:28:00 INFO - PROCESS | 24881 | |2;audio-dft;164;163;164;163;163;165;182;163;165;164 16:28:00 INFO - PROCESS | 24881 | |3;audio-fft;74;75;75;158;77;76;76;75;163;78 16:28:00 INFO - PROCESS | 24881 | |4;audio-oscillator;83;83;148;84;83;84;139;84;84;148 16:28:00 INFO - PROCESS | 24881 | |5;imaging-gaussian-blur;118;117;118;118;119;118;118;119;117;119 16:28:00 INFO - PROCESS | 24881 | |6;imaging-darkroom;147;148;147;148;146;149;148;147;149;171 16:28:00 INFO - PROCESS | 24881 | |7;imaging-desaturate;96;97;96;95;96;96;96;96;95;95 16:28:00 INFO - PROCESS | 24881 | |8;json-parse-financial;54;53;56;54;54;54;58;53;55;53 16:28:00 INFO - PROCESS | 24881 | |9;json-stringify-tinderbox;62;63;63;61;61;61;61;62;61;63 16:28:00 INFO - PROCESS | 24881 | |10;stanford-crypto-aes;82;80;79;85;81;81;81;81;111;82 16:28:00 INFO - PROCESS | 24881 | |11;stanford-crypto-ccm;143;129;129;130;122;123;129;130;130;122 16:28:00 INFO - PROCESS | 24881 | |12;stanford-crypto-pbkdf2;161;162;164;162;166;158;171;165;165;159 16:28:00 INFO - PROCESS | 24881 | |13;stanford-crypto-sha256-iterative;64;65;65;62;64;62;62;66;65;64 16:28:00 INFO - PROCESS | 24881 | __end_tp_report 16:28:00 INFO - PROCESS | 24881 | __start_cc_report 16:28:00 INFO - PROCESS | 24881 | _x_x_mozilla_cycle_collect,874 16:28:00 INFO - PROCESS | 24881 | __end_cc_report 16:28:00 INFO - PROCESS | 24881 | __startTimestamp1464391680191__endTimestamp 16:28:00 INFO - PROCESS | 24881 | 16:28:00 INFO - PROCESS | 24881 | ------- Summary: start ------- 16:28:00 INFO - PROCESS | 24881 | Number of tests: 14 16:28:00 INFO - PROCESS | 24881 | 16:28:00 INFO - PROCESS | 24881 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.21 (2.0%) stddev-sans-first:2.32 16:28:00 INFO - PROCESS | 24881 | Values: 112.0 105.0 111.0 111.0 112.0 112.0 111.0 111.0 112.0 113.0 16:28:00 INFO - PROCESS | 24881 | 16:28:00 INFO - PROCESS | 24881 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:157.00 stddev:22.66 (14.4%) stddev-sans-first:23.91 16:28:00 INFO - PROCESS | 24881 | Values: 157.0 126.0 162.0 188.0 127.0 157.0 152.0 131.0 179.0 125.0 16:28:00 INFO - PROCESS | 24881 | 16:28:00 INFO - PROCESS | 24881 | [#2] audio-dft Cycles:10 Average:165.60 Median:164.00 stddev:5.82 (3.5%) stddev-sans-first:6.14 16:28:00 INFO - PROCESS | 24881 | Values: 164.0 163.0 164.0 163.0 163.0 165.0 182.0 163.0 165.0 164.0 16:28:00 INFO - PROCESS | 24881 | 16:28:00 INFO - PROCESS | 24881 | [#3] audio-fft Cycles:10 Average:92.70 Median:75.50 stddev:35.77 (47.4%) stddev-sans-first:37.30 16:28:00 INFO - PROCESS | 24881 | Values: 74.0 75.0 75.0 158.0 77.0 76.0 76.0 75.0 163.0 78.0 16:28:00 INFO - PROCESS | 24881 | 16:28:00 INFO - PROCESS | 24881 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:83.50 stddev:29.78 (35.7%) stddev-sans-first:30.78 16:28:00 INFO - PROCESS | 24881 | Values: 83.0 83.0 148.0 84.0 83.0 84.0 139.0 84.0 84.0 148.0 16:28:00 INFO - PROCESS | 24881 | 16:28:00 INFO - PROCESS | 24881 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 16:28:00 INFO - PROCESS | 24881 | Values: 118.0 117.0 118.0 118.0 119.0 118.0 118.0 119.0 117.0 119.0 16:28:00 INFO - PROCESS | 24881 | 16:28:00 INFO - PROCESS | 24881 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:148.00 stddev:7.44 (5.0%) stddev-sans-first:7.81 16:28:00 INFO - PROCESS | 24881 | Values: 147.0 148.0 147.0 148.0 146.0 149.0 148.0 147.0 149.0 171.0 16:28:00 INFO - PROCESS | 24881 | 16:28:00 INFO - PROCESS | 24881 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 16:28:00 INFO - PROCESS | 24881 | Values: 96.0 97.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 16:28:00 INFO - PROCESS | 24881 | 16:28:00 INFO - PROCESS | 24881 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:1.58 (2.9%) stddev-sans-first:1.67 16:28:00 INFO - PROCESS | 24881 | Values: 54.0 53.0 56.0 54.0 54.0 54.0 58.0 53.0 55.0 53.0 16:28:00 INFO - PROCESS | 24881 | 16:28:00 INFO - PROCESS | 24881 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 16:28:00 INFO - PROCESS | 24881 | Values: 62.0 63.0 63.0 61.0 61.0 61.0 61.0 62.0 61.0 63.0 16:28:00 INFO - PROCESS | 24881 | 16:28:00 INFO - PROCESS | 24881 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:81.00 stddev:9.51 (11.7%) stddev-sans-first:10.05 16:28:00 INFO - PROCESS | 24881 | Values: 82.0 80.0 79.0 85.0 81.0 81.0 81.0 81.0 111.0 82.0 16:28:00 INFO - PROCESS | 24881 | 16:28:00 INFO - PROCESS | 24881 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:129.50 stddev:6.07 (4.7%) stddev-sans-first:3.62 16:28:00 INFO - PROCESS | 24881 | Values: 143.0 129.0 129.0 130.0 122.0 123.0 129.0 130.0 130.0 122.0 16:28:00 INFO - PROCESS | 24881 | 16:28:00 INFO - PROCESS | 24881 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.30 Median:164.50 stddev:3.77 (2.3%) stddev-sans-first:3.91 16:28:00 INFO - PROCESS | 24881 | Values: 161.0 162.0 164.0 162.0 166.0 158.0 171.0 165.0 165.0 159.0 16:28:00 INFO - PROCESS | 24881 | 16:28:00 INFO - PROCESS | 24881 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.50 stddev:1.45 (2.2%) stddev-sans-first:1.54 16:28:00 INFO - PROCESS | 24881 | Values: 64.0 65.0 65.0 62.0 64.0 62.0 62.0 66.0 65.0 64.0 16:28:00 INFO - PROCESS | 24881 | -------- Summary: end -------- 16:28:00 INFO - PROCESS | 24881 | 16:28:01 INFO - TEST-INFO | 24881: exit 0 16:28:01 INFO - TEST-OK | kraken | took 62109ms 16:28:01 INFO - SUITE-END | took 1173s 16:28:01 INFO - Completed test suite (00:19:34) 16:28:01 INFO - javascript benchmark 16:28:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7015.93931726335, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3033.332666813301, 3099.8915037973675, 3139.387819375222, 3150.590423244978, 3153.4008538377707, 5441.537469315103, 5453.700046497441, 5457.181422786579, 5465.316835395575, 5467.5899307551945, 5201.0, 5384.5692344612435, 5417.918731219035, 5429.4027656957705, 5447.428020057896, 4862.63530235232, 4890.902181956359, 4928.876778080541, 5023.3971923369245, 5061.746912654353, 4858.858168330439, 5034.942662040976, 5048.368953880765, 5068.8732781680565, 5069.771860266278, 4807.543283388072, 4857.198562237262, 4883.169861123618, 4946.233333833262, 4958.8512344629535, 4855.927161092586, 4880.487548807395, 4889.29105279736, 4890.779914903838, 4901.362822833044, 4846.248831431134, 4878.731669758162, 4893.608511319086, 4903.4851340609075, 4923.310736496857, 5072.0, 5186.222066689989, 5193.68837869729, 5198.324217851655, 5212.895742085175, 5697.658140511582, 5716.342620598602, 5730.7421166047625, 5733.369329373765, 5737.110747834093, 5600.915986260209, 5726.484616384545, 5772.163036359704, 5786.07422812348, 5797.710114494258, 5341.03861304965, 5361.544268737162, 5451.182322651634, 5475.260839786618, 5512.310961129859, 5994.130851026664, 5996.5202783777195, 6002.459778619857, 6006.279246490449, 6013.338532761392, 5557.083081291542, 5657.094864821609, 5721.742521586539, 5754.4533269339345, 5773.1051686988585, 5782.855428614318, 5783.479486846204, 5836.06622940336, 5861.794837180678, 5882.529397648178, 5525.502704756511, 5536.7231638418725, 5784.971075144597, 5788.681622510802, 5817.447342502455, 5585.357683866326, 5592.440755924456, 5596.244506991586, 5614.803481878114, 5656.0, 4279.614834664895, 4342.305231162999, 4350.32569951658, 4389.824407023683, 4404.295312749945, 3910.4916360872903, 3924.489816323917, 3929.4891664084057, 3954.8615798446917, 3962.663173630274, 5287.0, 5539.584531160179, 5546.306711661043, 5554.250176226238, 5560.971220324253, 5780.768769249267, 5827.213326200908, 5838.824835254949, 5857.472827445466, 5881.176635271066, 5564.86087847799, 5586.190002449704, 5590.804321848797, 5607.43925607436, 5609.074502707089, 4810.59109975656, 4970.0, 5033.572146367526, 5039.899202015939, 5100.132977393852, 5892.0, 5985.880282394415, 6003.6998150093195, 6006.519478441714, 6037.72830222641, 5830.154627578892, 5852.122181672783, 5857.652739869939, 5860.794872179454, 5868.765249389977, 5658.094704847369, 5871.324797648325, 5958.523318134452, 5961.7615295387695, 5974.9103763444455, 5733.283339582552, 5747.683877386784, 5754.482096611325, 5792.102224155263, 5795.840831833734, 5812.302523697014, 5848.707564621837, 5862.267216597926, 5892.0, 5903.409659034062, 5441.292631957978, 5510.944890551204, 5512.5314348280845, 5678.148277758204, 5689.829305120853, 5408.405075441777, 5543.417941116286, 5584.804531841366, 5629.6903670298525, 5655.349634792052, 5562.332520097614, 5573.804916828054, 5578.944210558005, 5586.916196257141, 5594.356648985256, 5561.4716601922755, 5594.804181853616, 5670.60305778608, 5680.034394152921, 5689.743961521659, 5520.227168196376, 5558.24963629921, 5589.357223919302, 5602.467765562265, 5662.688552129673], "value": 5320.602732609425, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.48603742669, 622.8131560531839, 634.6794868591361, 647.3267801486453, 662.427000644442, 35579.64420355796, 40594.7970260149, 40642.187156256856, 40819.38770918431, 40971.79514102429, 42552.0, 42725.0, 42824.357634635424, 43001.35497967533, 43312.78343608278, 8467.618957146944, 8516.0, 8601.440906341099, 8607.311415086779, 8611.913880861173, 8522.062573116953, 8522.786930326729, 8571.057183709787, 8590.656373745043, 8665.610047547843, 8539.701110461136, 8625.784355391133, 8629.309655227598, 8666.653333866638, 8692.521911294876, 8547.786305342353, 8592.226699597004, 8600.655973761042, 8635.52504612246, 8676.783080423009, 8517.06312305646, 8617.439866408664, 8640.913590864075, 8708.042115367305, 8712.607932643046, 31886.0, 39045.0, 39051.21897562033, 39450.408243876365, 39458.0, 3327.783694059878, 3380.4591265397416, 3509.7192224621967, 3620.475031120499, 3628.4920111184456, 30685.386292274252, 31021.84489077563, 31130.533042004387, 31317.686823131706, 32286.192845178823, 4046.514418269797, 4101.241270364992, 4103.322951712994, 4260.403543503912, 4311.8490852820005, 299906.99999999785, 300747.0, 301342.0, 303197.0, 303253.0, 32497.675023249463, 32525.349493010006, 33182.66817331796, 33209.33581328408, 33806.66193338084, 36491.817540912125, 36564.63435365666, 36759.4486082709, 36883.815580921924, 37159.256814863555, 15257.237138143048, 15559.22203889801, 15606.843931560767, 15611.531654050397, 15652.295646695926, 13027.0, 13090.803637945439, 13182.011349148852, 13288.402021909038, 13352.599422017354, 7756.883646745303, 7978.880316795253, 8049.114597394282, 8126.593670316579, 8133.0, 3078.538219267083, 3165.4776961801504, 3180.427523045874, 3226.5321528378254, 3263.282077942849, 1067.5750157653501, 1088.9074428673493, 1100.9064229540418, 1124.6569796212234, 1170.1224081938547, 32140.357192856012, 32257.51613725796, 32426.67573324284, 32459.513107302937, 33215.0, 992.0426788149471, 1121.6466812953893, 1157.479134389528, 1165.35905252111, 1176.847009888726, 16574.502764917073, 16577.0, 16804.831951680328, 16819.243134058997, 16832.410865619644, 150625.0, 151237.0, 151867.0, 153617.0, 154080.22959885353, 56885.715571421875, 57815.13277300844, 58113.4188658108, 58441.0, 58678.706606467545, 1399.5941177058742, 1403.6701375176826, 1408.7886816977536, 1411.724713680843, 1426.700392917499, 30564.847175763978, 32210.516842247853, 32258.0, 32690.0, 32838.83580582082, 51617.741911290206, 51621.7418912903, 51751.74124129355, 51981.0, 52498.0, 401892.0, 403516.0, 404269.0, 405589.0, 407720.0, 27676.169714908585, 28647.71352286534, 28818.0, 28841.71158288474, 28856.278593035342, 47347.76326118347, 49384.75307623583, 49703.75148124381, 49928.0, 50127.74936125296, 40971.79514102411, 40981.59018409897, 41130.0, 41406.585934141476, 41613.37579936243, 40472.595274046886, 40753.38869917013, 41127.1774564501, 41160.38259426051, 41177.79411102925, 36968.26063478662, 39947.2010559793, 40108.79945600253, 40409.797951010056, 41042.58957410388, 35613.0, 36510.817445913664, 36523.452148217264, 37107.44338834973, 37293.254134916606, 27702.554708189447, 27769.861150694116, 27945.58038990166, 28098.2975425616, 28139.63473693667], "value": 17739.592618650222, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.8200745649544, 391.745365512417, 394.46943860507605, 396.6945452001958, 416.6833206762859, 17682.29270829167, 18425.170867310968, 18699.813001869978, 20261.290854820083, 20269.898650506762, 18216.726749098772, 18538.72191917119, 19126.71309930352, 19224.03879806011, 19242.326518571852, 4111.218868415007, 5571.4428557144265, 5735.11105778605, 5776.046952252873, 5777.075667893117, 5976.0, 6382.680865956683, 6403.679816009204, 6409.583377080498, 6480.6435646039445, 5760.0783874580075, 5783.913241301363, 5851.678157701324, 6402.679866006704, 6409.294977552466, 5696.629719068247, 5731.828045158652, 5735.627184233053, 5749.712514374285, 5761.395053519383, 4838.758062096881, 5043.243513472972, 5070.72111033893, 5136.5377116059735, 5149.0474262261605, 12956.0, 13255.734885302336, 13453.260070696108, 14080.718385632332, 14091.647708807259, 2083.0938541734245, 2107.230860735836, 2180.324099529151, 2351.1770880191966, 2374.5963186258377, 9467.621295148187, 9542.284328675378, 9878.357906736039, 9989.300748947577, 13866.584002479942, 1850.8241717036994, 1893.3089422360877, 1943.8833669979706, 1953.2089503751004, 1961.7842037375876, 61503.0, 78309.99999999943, 79982.20017799806, 80664.23726187063, 80788.59605702052, 9626.759331016641, 10378.740531486774, 10646.0, 10693.732656683489, 10720.73198170052, 15084.170370629501, 15283.770743438858, 15378.077315361114, 15423.614409639624, 15437.768433473508, 7835.2948234658015, 7951.602419878983, 7980.880286795703, 8090.878636820453, 8311.584420779058, 7513.737019204302, 7705.267999540035, 8109.878351824727, 8229.917700822914, 8270.214329638795, 4399.64802815774, 4561.703489273186, 4567.269236922143, 4617.515160908123, 4663.300504924221, 1860.1635747057542, 1875.7655293088364, 1892.782330032064, 1946.5984491166337, 1988.4929343017727, 950.7908260182749, 1006.3157053203745, 1087.853139826129, 1091.6943255888364, 1104.4256986367045, 18211.271549137888, 18898.960557169212, 19195.0, 19195.32816351421, 19495.22019119248, 977.9119879210763, 979.911807937289, 996.785691076422, 1010.6765834932751, 1043.2280112716687, 9657.806843863083, 10350.068493835592, 10786.406747628957, 10840.837387439195, 10909.0, 430187.0, 436169.0, 443041.0, 443653.0, 445108.0, 88667.55666221627, 90119.54940225257, 91605.0, 91788.0, 92181.0, 880.9695642435881, 884.0496466298755, 905.3164860530258, 908.5230254116642, 917.5274733512247, 14966.48287652379, 15767.68464630724, 15909.204539772734, 16011.679766404373, 16249.431269905497, 40143.0, 40289.59710402859, 41133.794331028155, 42178.36732449077, 42678.35982460328, 55379.44620553743, 55881.441185587624, 56020.159697605384, 56397.0, 57435.138472923776, 8085.434019618806, 8119.391045671717, 8201.384896132933, 8379.622916968628, 8448.070712221774, 12337.414399270041, 12992.8051079232, 13307.334633268105, 13451.663708407368, 13516.79724804109, 11139.944300278446, 11359.943200283946, 11501.827472588086, 11566.479508421973, 11578.768424631291, 11411.087113030771, 11498.13763967689, 11583.0, 11616.88383116158, 11690.357030363411, 11635.592754253561, 11766.411679416165, 11780.410979451164, 11950.880491195325, 12034.939825300817, 8359.373047021376, 8435.367347448842, 8572.27135693473, 8611.784705382164, 8644.740657780276, 10379.896201037893, 11508.48211830453, 11643.59247426336, 11826.290422574673, 11850.881491184979], "value": 8917.427617264553, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1498.1760031982408, 1527.6715506166174, 1676.0530300380285, 1797.9910100449497, 1801.7027190513566, 7671.2712292332135, 8608.268297194745, 8655.653773849046, 9202.309826762994, 9248.0, 8550.144985501447, 8944.59749311281, 8998.100189981014, 9010.18908298253, 9013.54932253388, 2327.895244713992, 2353.0705371378294, 2371.21749822559, 2371.312319427364, 2381.3927448500694, 2298.885055747214, 2309.261036468331, 2329.1964272326104, 2350.96473552896, 2356.8703721295324, 2342.4261056041296, 2342.496363281894, 2360.6459031145378, 2373.062640257106, 2375.3824005758456, 2261.0729600863565, 2274.4655006073644, 2290.931272061841, 2291.3927809130596, 2320.060375547906, 2254.6956160918394, 2255.28958378112, 2257.6049191391603, 2259.299617118682, 2259.299617118682, 8831.0, 8846.15961483658, 8881.777955551099, 8883.11168883113, 8906.465612063232, 5201.817936372209, 5341.305630268079, 5344.251804747339, 5345.4387289334445, 5376.301080859464, 3167.524871269305, 3218.09893229896, 3371.1403592084107, 3383.2387712764676, 3384.069380920242, 1133.6372360844532, 1139.5327915554583, 1142.1148609827367, 1163.2292514441103, 1180.4038960325067, 12379.195352302071, 12432.813507797391, 12526.123171377916, 12531.248125112523, 12571.559995400208, 4645.744484053342, 4724.905501889943, 4812.590929770939, 4825.4933232010835, 4851.223804191383, 10385.480725963671, 10397.272190946562, 10401.53193106297, 10426.426546540013, 10460.476976151314, 5236.162214045735, 5292.52367286946, 5312.893742125136, 5317.601179911522, 5451.173856757951, 4279.828806847691, 4804.42346918365, 4913.992631510532, 4971.527704868032, 4987.950120498821, 4008.0, 4025.6578190854107, 4115.259253334369, 4145.3781932709735, 4157.729747566398, 1144.753877916252, 1270.7712611729978, 1281.653953432568, 1290.4128621477394, 1299.226959958842, 823.3331001888489, 941.3410612571228, 957.3394357893031, 1000.3278134840631, 1004.0461561516588, 5920.082387229986, 5920.727043685542, 5959.523238140939, 6128.754849806047, 6142.815715528542, 948.6869333120054, 957.7940742740205, 990.1237404896718, 1008.4251976373544, 1016.506994107857, 3990.780507072139, 3992.161646054303, 4038.8586399475876, 4057.14799892026, 4083.244599749056, 10953.397563134104, 11313.604023859125, 11334.886651133547, 11394.259373140885, 11395.316281023164, 10971.725706857393, 11021.393823339633, 11048.447577621087, 11055.502502387411, 11087.944560277308, 8204.548749818698, 8205.343572514184, 8231.05342885564, 8278.544680042534, 8308.584570771438, 5807.622504537191, 5813.0, 5820.388859169726, 5910.231669882888, 5993.880122397615, 9819.0, 10262.538185781508, 10301.74245643865, 10348.068673819393, 10448.738781530219, 10362.274640775375, 10395.532201050819, 10450.843237351293, 10484.737881553023, 10506.789864202521, 7834.764957051298, 7840.490368126054, 7844.0, 7885.5662938538935, 7887.40844436681, 8561.743147705578, 8593.355498337774, 8613.3109351253, 8643.524606146722, 8696.739097827076, 7537.6984920604755, 7874.094479134973, 8010.879836802336, 8040.678372865254, 8102.351811855156, 7817.475592259455, 7851.293383595504, 7907.2488113629115, 7949.165337639464, 8004.759857204293, 7218.242084581043, 7282.781516554512, 7298.306660867209, 7347.19180890091, 7349.118105827335, 5066.898662026812, 5087.084324821568, 5147.716875571729, 5185.585153187812, 5237.607179461479, 5242.711650859239, 5350.705711185922, 5353.304070470814, 5406.135018397038, 5437.32033495813], "value": 4699.36204249846, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.86525389844076, 340.156412097997, 342.7052734648202, 345.5680399500626, 350.45679197244266, 5504.80733174339, 5508.807191748289, 5583.469570390816, 5603.842520629556, 5619.6066275360745, 5472.1244600863865, 5509.47659972303, 5513.2005859150395, 5523.972380138103, 5533.142362933741, 4151.481064866892, 4179.958200417987, 4236.872893813191, 4285.142971405716, 4286.39990401344, 4234.894127646818, 4253.680973926952, 4268.530461649216, 4273.316269396897, 4276.379924910886, 4242.809073591696, 4250.596193361625, 4252.766097864616, 4282.421873047146, 4288.726974703412, 3998.5801490843332, 4190.497140343178, 4261.595148460891, 4274.380214868842, 4275.743455392686, 3631.564212294515, 3635.2184280379847, 3646.781193128421, 3657.7622454540638, 3658.359787037258, 5263.184206448007, 5296.417394086648, 5311.150215965466, 5348.171033489815, 5363.766333743222, 4759.690620109682, 4866.31871537985, 4867.075255701406, 4870.391201099863, 4907.9263811042865, 5631.577631677641, 5699.316082070137, 5746.913796293059, 5774.566907481955, 5790.7104644768015, 4004.83980640774, 4059.939100913489, 4066.674666026711, 4077.0011347219825, 4094.5086589609436, 5778.739956701958, 5993.670348130851, 6036.849078772978, 6052.54605904559, 6075.848103797396, 4129.752214867118, 4136.462259906253, 4148.398482220122, 4154.937675934863, 4184.8744537663915, 4187.685923555746, 4199.538050814408, 4211.052513184571, 4219.535851056381, 4226.006888381228, 4701.200795864711, 4825.613950883921, 4830.154722923475, 4832.806687732522, 4877.146499362598, 5665.773369065274, 5720.656760594377, 5784.768609255582, 5784.855378615568, 5897.051474262868, 1436.5833908166724, 1436.906601070927, 1439.3738723655244, 1442.834074081473, 1444.7905053767145, 902.5126431726925, 906.1436942089794, 918.6725182111918, 920.6777627830206, 920.9263258939269, 5010.448850626428, 5011.346255735599, 5028.270900719375, 5097.847064588068, 5110.6678065926335, 5314.4951229633125, 5351.384590772033, 5362.517373436332, 5373.731313434313, 5412.404635490093, 4771.08000718812, 4987.476314986874, 5001.049800537886, 5011.824586139468, 5013.39839219296, 2846.302655849289, 2854.942901142007, 2866.6846646869244, 2877.5971364009056, 2884.97115028847, 5419.756110975016, 5436.0, 5444.428335024765, 5482.8081017165005, 5489.533389661923, 5139.913242870387, 5226.353698584933, 5432.538234250133, 5435.581166380923, 5454.8909021819345, 5357.6605848537865, 5425.565954723613, 5523.8066667666435, 5546.639468434539, 5554.750036248298, 4909.312696222603, 5201.375834899836, 5248.790048398021, 5266.603695318698, 5368.624196306221, 5228.333549889508, 5248.504176309733, 5248.921266180934, 5680.857978550569, 5701.201831743642, 6092.299385570716, 6120.602160859708, 6152.384761523812, 6185.6907154641185, 6192.81421557354, 4100.630943215125, 4103.733257338264, 4134.503859536754, 4149.97925010373, 4173.353130264813, 5721.914171287517, 5932.64404135736, 6019.765947980741, 6031.8237943602335, 6081.483073938764, 5825.563082768725, 5846.41535846429, 5868.3251426086545, 5885.910501771809, 5890.087036509348, 5499.780008799603, 5841.94158058414, 5868.970655146697, 5888.970555147197, 5891.852703682443, 5674.404187560412, 5825.0, 5828.213191219301, 5878.353381128158, 5891.852703682443, 5917.733701983335, 5918.0, 5926.67403292823, 5971.731272092679, 6002.879942401215, 5563.358809151229, 5753.395893431297, 5771.163181338598, 5811.389804070681, 5814.592978491465], "value": 4272.071012092675, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.1556365815892, 811.08347567249, 851.9957400212998, 856.2636132925687, 857.7212405968062, 14001.579952601425, 14418.134911905294, 14621.926890365547, 16334.673306533863, 16823.41118060868, 15254.542363729079, 15407.768883466757, 15517.612059698486, 15518.224088795543, 15552.066875987448, 786.9291763741262, 790.9881351779713, 791.0428381658201, 792.6512334572799, 795.0538858758089, 806.1293802693077, 807.64059993303, 808.789714674186, 811.7199566149669, 812.0458461307969, 845.3237410071948, 848.6308455821707, 849.4478588917223, 850.5874650794391, 853.7225401744458, 835.1356346181673, 840.0675250472002, 844.0715213265389, 845.0957475501216, 845.691322667222, 607.2803727582784, 612.5038718637918, 616.9537284703665, 617.2346290599625, 620.8292719502128, 14809.111453312837, 14818.481353152696, 14954.775678364833, 14973.401063957428, 14997.250137493082, 13255.204687718768, 13329.133606315558, 13383.130096543693, 13479.258640774753, 13481.662958426019, 12432.010878259434, 12488.12583119182, 12563.874361256361, 12583.559575414816, 12713.364331783374, 4449.733016019017, 4486.775661216926, 4496.123255965088, 4565.863024109282, 4686.390769200017, 60825.0, 61068.69465652643, 61741.691291543706, 62003.37996620021, 62135.0, 10977.560897564168, 11121.999999999838, 11129.220954533104, 11203.271787333797, 11471.827922581168, 17256.913715431343, 17474.038927858837, 17645.117744112744, 17920.731189032176, 18258.54353641143, 8426.452280601741, 8435.493870367798, 8444.0, 8584.270337021424, 9111.453312801254, 4611.492735799059, 4732.834350797705, 4781.354517140142, 4785.3300537924715, 4896.804127834846, 3476.5828100628087, 3534.0, 3546.716262698978, 3564.4118720410843, 3564.500969864221, 610.6702380714364, 635.6916895305773, 645.602954183174, 654.5025780406925, 664.2162248546762, 676.7935779587273, 680.8093733754557, 692.8510370270416, 763.4007304266236, 775.4494309040532, 9669.760844137956, 9981.900180998242, 10414.791704165875, 10800.675979720621, 11155.498002589902, 702.2766550453042, 708.8653155900363, 717.5013365710781, 719.0917364125992, 748.5658318175446, 4421.690481666253, 4662.300654901792, 4701.130290896195, 4729.929051064237, 4809.326694262806, 69109.30890691129, 69311.0, 69431.65284173547, 70001.2999870005, 70399.64800176068, 57129.0, 61549.0, 62028.68985655043, 62662.060069099, 63951.0, 52139.47860521422, 57416.0, 57551.42448575461, 57641.42358576361, 57647.42352576504, 9772.85340719904, 9872.35829671069, 9922.801543969224, 9926.553305101143, 9954.950225249117, 38308.425373619975, 39025.60974390333, 39064.0, 39083.413748793224, 39728.80813575597, 51588.22617660663, 51853.7407312961, 51970.740146299024, 52003.73998129985, 53766.73116634392, 12511.687207819878, 12584.244945303311, 12649.177803442746, 12777.808332874829, 13016.934915325362, 12934.482620695067, 13139.671508212372, 13223.140495867738, 13628.386722597308, 14338.856611433752, 12660.620181394574, 12789.61631151067, 12807.487700491876, 13092.279924604238, 13366.599002029954, 13075.934620326838, 13377.398017089448, 13439.395227214995, 13446.327683615977, 13449.260290684106, 12300.50797968107, 12467.1273010892, 12476.313802740573, 12766.042546809213, 12810.231386116862, 10021.899781002097, 10046.397216167054, 10292.228082893962, 10407.865045677294, 10494.370337779757, 9898.752531186778, 10272.743181420225, 10796.730081748019, 11014.944925275322, 11029.61396351124], "value": 7057.558821044027, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 111.0, 112.0, 112.0, 111.0, 111.0, 112.0, 113.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 162.0, 188.0, 127.0, 157.0, 152.0, 131.0, 179.0, 125.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 163.0, 163.0, 165.0, 182.0, 163.0, 165.0, 164.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 158.0, 77.0, 76.0, 76.0, 75.0, 163.0, 78.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 148.0, 84.0, 83.0, 84.0, 139.0, 84.0, 84.0, 148.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 119.0, 118.0, 118.0, 119.0, 117.0, 119.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 146.0, 149.0, 148.0, 147.0, 149.0, 171.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 56.0, 54.0, 54.0, 54.0, 58.0, 53.0, 55.0, 53.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 63.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 79.0, 85.0, 81.0, 81.0, 81.0, 81.0, 111.0, 82.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 129.0, 129.0, 130.0, 122.0, 123.0, 129.0, 130.0, 130.0, 122.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 164.0, 162.0, 166.0, 158.0, 171.0, 165.0, 165.0, 159.0], "value": 163.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 62.0, 64.0, 62.0, 62.0, 66.0, 65.0, 64.0], "value": 63.9, "unit": "score"}]}]} 16:28:01 INFO - Return code: 0 16:28:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:28:01 ERROR - # TBPL SUCCESS # 16:28:01 INFO - Running post-action listener: _resource_record_post_action 16:28:01 INFO - ##### 16:28:01 INFO - ##### Finished run-tests step (success) 16:28:01 INFO - ##### 16:28:01 INFO - Running post-run listener: _resource_record_post_run 16:28:01 INFO - Total resource usage - Wall time: 1192s; CPU: 14.0%; Read bytes: 12288; Write bytes: 538677248; Read time: 260; Write time: 774448 16:28:01 INFO - TinderboxPrint: CPU usage
13.6% 16:28:01 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 260 16:28:01 INFO - TinderboxPrint: I/O write bytes / time
538,677,248 / 774,448 16:28:01 INFO - TinderboxPrint: CPU idle
8,218.2 (86.4%) 16:28:01 INFO - TinderboxPrint: CPU user
1,229.8 (12.9%) 16:28:01 INFO - TinderboxPrint: Swap in / out
0 / 0 16:28:01 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 4096; Write bytes: 247222272; Read time: 232; Write time: 479684 16:28:01 INFO - run-tests - Wall time: 1175s; CPU: 14.0%; Read bytes: 8192; Write bytes: 289644544; Read time: 28; Write time: 294692 16:28:02 INFO - Running post-run listener: _upload_blobber_files 16:28:02 INFO - Blob upload gear active. 16:28:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:28:02 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 16:28:02 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:28:02 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:28:02 INFO - (blobuploader) - INFO - Open directory for files ... 16:28:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:28:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:28:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:28:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:28:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:28:03 INFO - (blobuploader) - INFO - Done attempting. 16:28:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:28:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:28:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:28:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:28:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:28:08 INFO - (blobuploader) - INFO - Done attempting. 16:28:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:28:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:28:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:28:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:28:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:28:09 INFO - (blobuploader) - INFO - Done attempting. 16:28:09 INFO - (blobuploader) - INFO - Iteration through files over. 16:28:09 INFO - Return code: 0 16:28:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:28:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:28:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1e05dfb62ff4c01854d21c0049660854718c96a8df4f83a3ea6477ccea8e86f45653ee6fc4be95e377ca3cedd7898a533fe57f43827484e8a99c8e5fa28292bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/077adfb76f7419e0927102ec0e9d1004ce4aa1d2bd91fbe15272defad1be6d13857dbb193d613f1783b83daf81f2dd78322709a87030bcd78c966e64f6a4d805", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c714ba9b0c215b36f6c4217ed61f3a81374d4392abece29e32a4dbfad7274bee85b58bf4dc1d0922519957446c1ee8cf2379816d2acd3ca6f37662f88b0f9ac"} 16:28:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:28:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:28:09 INFO - Contents: 16:28:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1e05dfb62ff4c01854d21c0049660854718c96a8df4f83a3ea6477ccea8e86f45653ee6fc4be95e377ca3cedd7898a533fe57f43827484e8a99c8e5fa28292bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/077adfb76f7419e0927102ec0e9d1004ce4aa1d2bd91fbe15272defad1be6d13857dbb193d613f1783b83daf81f2dd78322709a87030bcd78c966e64f6a4d805", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c714ba9b0c215b36f6c4217ed61f3a81374d4392abece29e32a4dbfad7274bee85b58bf4dc1d0922519957446c1ee8cf2379816d2acd3ca6f37662f88b0f9ac"} 16:28:09 INFO - Running post-run listener: copy_logs_to_upload_dir 16:28:09 INFO - Copying logs to upload dir... 16:28:09 INFO - mkdir: /builds/slave/test/build/upload/logs 16:28:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.940512 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-27 16:28:09.510446) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 16:28:09.514076) ========= 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=52faae308a556c440401f8e5000001e8-1464390205.852169-814171526 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-Inbound/sha512/1e05dfb62ff4c01854d21c0049660854718c96a8df4f83a3ea6477ccea8e86f45653ee6fc4be95e377ca3cedd7898a533fe57f43827484e8a99c8e5fa28292bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/077adfb76f7419e0927102ec0e9d1004ce4aa1d2bd91fbe15272defad1be6d13857dbb193d613f1783b83daf81f2dd78322709a87030bcd78c966e64f6a4d805", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c714ba9b0c215b36f6c4217ed61f3a81374d4392abece29e32a4dbfad7274bee85b58bf4dc1d0922519957446c1ee8cf2379816d2acd3ca6f37662f88b0f9ac"} build_url:https://queue.taskcluster.net/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011229 build_url: 'https://queue.taskcluster.net/v1/task/PPHPyO1DRB6olR7OtKO64w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1e05dfb62ff4c01854d21c0049660854718c96a8df4f83a3ea6477ccea8e86f45653ee6fc4be95e377ca3cedd7898a533fe57f43827484e8a99c8e5fa28292bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/077adfb76f7419e0927102ec0e9d1004ce4aa1d2bd91fbe15272defad1be6d13857dbb193d613f1783b83daf81f2dd78322709a87030bcd78c966e64f6a4d805", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c714ba9b0c215b36f6c4217ed61f3a81374d4392abece29e32a4dbfad7274bee85b58bf4dc1d0922519957446c1ee8cf2379816d2acd3ca6f37662f88b0f9ac"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 16:28:09.539872) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:28:09.540214) ========= 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=52faae308a556c440401f8e5000001e8-1464390205.852169-814171526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:28:09.621397) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 16:28:09.621732) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 16:28:09.622133) ========= ========= Total master_lag: 0.14 =========