builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1463510532.35 results: success (0) buildid: 20160517085406 builduid: c9d6cbc506de4be79cb468632ed1bb63 revision: 9f9aae87248d444ff93d1a213b6de0a6ee39fb26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 11:42:12.347673) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 11:42:12.348192) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 11:42:12.348477) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 11:42:12.363976) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:42:12.364263) ========= 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=df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 11:42:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 82.1M=0s 2016-05-17 11:42:12 (82.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136932 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:42:12.514967) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:42:12.515330) ========= 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=df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019032 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:42:12.565828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 11:42:12.566209) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9f9aae87248d444ff93d1a213b6de0a6ee39fb26 --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 9f9aae87248d444ff93d1a213b6de0a6ee39fb26 --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=df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 11:42:12,869 truncating revision to first 12 chars 2016-05-17 11:42:12,869 Setting DEBUG logging. 2016-05-17 11:42:12,869 attempt 1/10 2016-05-17 11:42:12,869 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/9f9aae87248d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 11:42:13,846 unpacking tar archive at: mozilla-inbound-9f9aae87248d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.275617 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 11:42:13.856481) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 11:42:13.857235) ========= script_repo_revision: 9f9aae87248d444ff93d1a213b6de0a6ee39fb26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 11:42:13.858033) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 11:42:13.858588) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 11:42:13.870088) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-17 11:42:13.870450) ========= /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=df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:42:14 INFO - MultiFileLogger online at 20160517 11:42:14 in /builds/slave/test 11:42:14 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 11:42:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:42:14 INFO - {'append_to_log': False, 11:42:14 INFO - 'base_work_dir': '/builds/slave/test', 11:42:14 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:42:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:42:14 INFO - 'branch': 'Mozilla-Inbound', 11:42:14 INFO - 'buildbot_json_path': 'buildprops.json', 11:42:14 INFO - 'config_files': ('talos/linux_config.py',), 11:42:14 INFO - 'default_actions': ('clobber', 11:42:14 INFO - 'read-buildbot-config', 11:42:14 INFO - 'download-and-extract', 11:42:14 INFO - 'populate-webroot', 11:42:14 INFO - 'create-virtualenv', 11:42:14 INFO - 'install', 11:42:14 INFO - 'run-tests'), 11:42:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:42:14 INFO - 'download_minidump_stackwalk': True, 11:42:14 INFO - 'download_symbols': 'ondemand', 11:42:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:42:14 INFO - 'tooltool.py': '/tools/tooltool.py', 11:42:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:42:14 INFO - '/tools/misc-python/virtualenv.py')}, 11:42:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:42:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:42:14 INFO - 'installer_path': 'installer.exe', 11:42:14 INFO - 'log_level': 'info', 11:42:14 INFO - 'log_name': 'talos', 11:42:14 INFO - 'log_to_console': True, 11:42:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:42:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:42:14 INFO - 'opt_config_files': (), 11:42:14 INFO - 'pip_index': False, 11:42:14 INFO - 'sps_profile': False, 11:42:14 INFO - 'sps_profile_interval': 0, 11:42:14 INFO - 'suite': 'dromaeojs-e10s', 11:42:14 INFO - 'system_bits': '32', 11:42:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:42:14 INFO - 'title': 'talos-linux64-ix-021', 11:42:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:42:14 INFO - 'use_talos_json': True, 11:42:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:42:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:42:14 INFO - 'work_dir': 'build'} 11:42:14 INFO - ##### 11:42:14 INFO - ##### Running clobber step. 11:42:14 INFO - ##### 11:42:14 INFO - Running pre-action listener: _resource_record_pre_action 11:42:14 INFO - Running main action method: clobber 11:42:14 INFO - rmtree: /builds/slave/test/build 11:42:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:42:15 INFO - Running post-action listener: _resource_record_post_action 11:42:15 INFO - ##### 11:42:15 INFO - ##### Finished clobber step (success) 11:42:15 INFO - ##### 11:42:15 INFO - ##### 11:42:15 INFO - ##### Running read-buildbot-config step. 11:42:15 INFO - ##### 11:42:15 INFO - Running pre-action listener: _resource_record_pre_action 11:42:15 INFO - Running main action method: read_buildbot_config 11:42:15 INFO - Using buildbot properties: 11:42:15 INFO - { 11:42:15 INFO - "project": "", 11:42:15 INFO - "product": "firefox", 11:42:15 INFO - "script_repo_revision": "production", 11:42:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 11:42:15 INFO - "repository": "", 11:42:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 11:42:15 INFO - "buildid": "20160517085406", 11:42:15 INFO - "pgo_build": "True", 11:42:15 INFO - "basedir": "/builds/slave/test", 11:42:15 INFO - "buildnumber": 559, 11:42:15 INFO - "slavename": "talos-linux64-ix-021", 11:42:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:42:15 INFO - "platform": "ubuntu64_hw", 11:42:15 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 11:42:15 INFO - "branch": "mozilla-inbound", 11:42:15 INFO - "repo_path": "integration/mozilla-inbound", 11:42:15 INFO - "revision": "9f9aae87248d444ff93d1a213b6de0a6ee39fb26", 11:42:15 INFO - "stage_platform": "linux64-pgo", 11:42:15 INFO - "builduid": "c9d6cbc506de4be79cb468632ed1bb63", 11:42:15 INFO - "slavebuilddir": "test" 11:42:15 INFO - } 11:42:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:42:15 INFO - Running post-action listener: _resource_record_post_action 11:42:15 INFO - ##### 11:42:15 INFO - ##### Finished read-buildbot-config step (success) 11:42:15 INFO - ##### 11:42:15 INFO - ##### 11:42:15 INFO - ##### Running download-and-extract step. 11:42:15 INFO - ##### 11:42:15 INFO - Running pre-action listener: _resource_record_pre_action 11:42:15 INFO - Running main action method: download_and_extract 11:42:15 INFO - mkdir: /builds/slave/test/build/tests 11:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:15 INFO - https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:42:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:42:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:42:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/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 11:42:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/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 11:42:15 INFO - Downloaded 1361 bytes. 11:42:15 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:42:15 INFO - Using the following test package requirements: 11:42:15 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:42:15 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:42:15 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:42:15 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:15 INFO - u'jsshell-linux-x86_64.zip'], 11:42:15 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:42:15 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:42:15 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:42:15 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:42:15 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:42:15 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:42:15 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:15 INFO - https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:42:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:42:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:42:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/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 11:42:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/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 11:42:16 INFO - Downloaded 24024596 bytes. 11:42:16 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'] 11:42:16 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 11:42:18 INFO - Return code: 0 11:42:18 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 11:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:18 INFO - https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:42:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:42:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:42:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/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 11:42:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/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 11:42:19 INFO - Downloaded 24024596 bytes. 11:42:19 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'] 11:42:19 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 11:42:20 INFO - Return code: 0 11:42: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')]} 11:42:20 INFO - https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:42:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:42:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:42:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/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 11:42:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/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 11:42:21 INFO - Downloaded 10840194 bytes. 11:42:21 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'] 11:42:21 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 11:42:21 INFO - Return code: 0 11:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:21 INFO - https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:42:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:42:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:42:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/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 11:42:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/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 11:42:23 INFO - Downloaded 58417234 bytes. 11:42:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:42:23 INFO - mkdir: /builds/slave/test/properties 11:42:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:42:23 INFO - Writing to file /builds/slave/test/properties/build_url 11:42:23 INFO - Contents: 11:42:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:42:24 INFO - Running post-action listener: _resource_record_post_action 11:42:24 INFO - Running post-action listener: set_extra_try_arguments 11:42:24 INFO - ##### 11:42:24 INFO - ##### Finished download-and-extract step (success) 11:42:24 INFO - ##### 11:42:24 INFO - ##### 11:42:24 INFO - ##### Running populate-webroot step. 11:42:24 INFO - ##### 11:42:24 INFO - Running pre-action listener: _resource_record_pre_action 11:42:24 INFO - Running main action method: populate_webroot 11:42:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:42:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:42:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:42:24 INFO - '--tppagecycles', 11:42:24 INFO - '7'], 11:42:24 INFO - 'tests': ['tsvgm']}}, 11:42:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:42:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:42:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:42:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:42:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:42:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:42:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:24 INFO - 'talos_options': ['--disable-e10s'], 11:42:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:24 INFO - 'talos_options': ['--disable-e10s'], 11:42:24 INFO - 'tests': ['damp', 'tps']}, 11:42:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:24 INFO - 'tests': ['damp', 'tps']}, 11:42:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:42:24 INFO - 'tests': ['dromaeo_dom']}, 11:42:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:42:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:42:24 INFO - 'tests': ['a11yr', 11:42:24 INFO - 'ts_paint', 11:42:24 INFO - 'tpaint', 11:42:24 INFO - 'sessionrestore', 11:42:24 INFO - 'sessionrestore_no_auto_restore', 11:42:24 INFO - 'tabpaint']}, 11:42:24 INFO - 'other-e10s': {'tests': ['a11yr', 11:42:24 INFO - 'ts_paint', 11:42:24 INFO - 'tpaint', 11:42:24 INFO - 'sessionrestore', 11:42:24 INFO - 'sessionrestore_no_auto_restore', 11:42:24 INFO - 'tabpaint']}, 11:42:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:42:24 INFO - 'ts_paint', 11:42:24 INFO - 'tpaint', 11:42:24 INFO - 'sessionrestore', 11:42:24 INFO - 'sessionrestore_no_auto_restore', 11:42:24 INFO - 'tabpaint']}, 11:42:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:42:24 INFO - 'ts_paint', 11:42:24 INFO - 'tpaint', 11:42:24 INFO - 'sessionrestore', 11:42:24 INFO - 'sessionrestore_no_auto_restore', 11:42:24 INFO - 'tabpaint']}, 11:42:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:42:24 INFO - 'tests': ['a11yr', 11:42:24 INFO - 'ts_paint', 11:42:24 INFO - 'tpaint', 11:42:24 INFO - 'sessionrestore', 11:42:24 INFO - 'sessionrestore_no_auto_restore', 11:42:24 INFO - 'tabpaint']}, 11:42:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:42:24 INFO - 'tests': ['a11yr', 11:42:24 INFO - 'ts_paint', 11:42:24 INFO - 'tpaint', 11:42:24 INFO - 'sessionrestore', 11:42:24 INFO - 'sessionrestore_no_auto_restore', 11:42:24 INFO - 'tabpaint']}, 11:42:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:42:24 INFO - 'tests': ['tsvgx', 11:42:24 INFO - 'tsvgr_opacity', 11:42:24 INFO - 'tart', 11:42:24 INFO - 'tscrollx', 11:42:24 INFO - 'cart']}, 11:42:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:42:24 INFO - 'tsvgr_opacity', 11:42:24 INFO - 'tart', 11:42:24 INFO - 'tscrollx', 11:42:24 INFO - 'cart']}, 11:42:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:24 INFO - 'talos_options': ['--disable-e10s'], 11:42:24 INFO - 'tests': ['tp5o']}, 11:42:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:24 INFO - 'tests': ['tp5o']}, 11:42:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:24 INFO - 'talos_options': ['--disable-e10s', 11:42:24 INFO - '--xperf_path', 11:42:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:24 INFO - 'tests': ['tp5n']}, 11:42:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:24 INFO - 'talos_options': ['--xperf_path', 11:42:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:24 INFO - 'tests': ['tp5n']}}, 11:42:24 INFO - 'talos.zip': {'path': '', 11:42:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:42:24 INFO - Running post-action listener: _resource_record_post_action 11:42:24 INFO - ##### 11:42:24 INFO - ##### Finished populate-webroot step (success) 11:42:24 INFO - ##### 11:42:24 INFO - ##### 11:42:24 INFO - ##### Running create-virtualenv step. 11:42:24 INFO - ##### 11:42:24 INFO - Running pre-action listener: _resource_record_pre_action 11:42:24 INFO - Running main action method: create_virtualenv 11:42:24 INFO - Creating virtualenv /builds/slave/test/build/venv 11:42:24 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 11:42:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:42:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:42:24 INFO - Using real prefix '/usr' 11:42:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:42:25 INFO - Installing distribute.............................................................................................................................................................................................done. 11:42:27 INFO - Installing pip.................done. 11:42:27 INFO - Return code: 0 11:42:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:27 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 0x7f7d96e5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1575770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16049c0>, '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 0x16058c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1605d50>, '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': 'df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685', '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 11:42:27 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 11:42:27 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 11:42:27 INFO - Using env: {'DISPLAY': ':0', 11:42:27 INFO - 'HOME': '/home/cltbld', 11:42:27 INFO - 'LANG': 'en_US.UTF-8', 11:42:27 INFO - 'LANGUAGE': 'en_US:en', 11:42:27 INFO - 'LOGNAME': 'cltbld', 11:42:27 INFO - 'MAIL': '/var/mail/cltbld', 11:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:27 INFO - 'MOZ_NO_REMOTE': '1', 11:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:27 INFO - 'NO_EM_RESTART': '1', 11:42:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:27 INFO - 'PWD': '/builds/slave/test', 11:42:27 INFO - 'SHELL': '/bin/bash', 11:42:27 INFO - 'SHLVL': '1', 11:42:27 INFO - 'TERM': 'linux', 11:42:27 INFO - 'TMOUT': '86400', 11:42:27 INFO - 'USER': 'cltbld', 11:42:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685', 11:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:27 INFO - '_': '/tools/buildbot/bin/python'} 11:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:42:27 INFO - Cleaning up... 11:42:27 INFO - Return code: 0 11:42:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:27 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 0x7f7d96e5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1575770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16049c0>, '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 0x16058c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1605d50>, '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': 'df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685', '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 11:42:27 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 11:42:27 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 11:42:27 INFO - Using env: {'DISPLAY': ':0', 11:42:27 INFO - 'HOME': '/home/cltbld', 11:42:27 INFO - 'LANG': 'en_US.UTF-8', 11:42:27 INFO - 'LANGUAGE': 'en_US:en', 11:42:27 INFO - 'LOGNAME': 'cltbld', 11:42:27 INFO - 'MAIL': '/var/mail/cltbld', 11:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:27 INFO - 'MOZ_NO_REMOTE': '1', 11:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:27 INFO - 'NO_EM_RESTART': '1', 11:42:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:27 INFO - 'PWD': '/builds/slave/test', 11:42:27 INFO - 'SHELL': '/bin/bash', 11:42:27 INFO - 'SHLVL': '1', 11:42:27 INFO - 'TERM': 'linux', 11:42:27 INFO - 'TMOUT': '86400', 11:42:27 INFO - 'USER': 'cltbld', 11:42:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685', 11:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:27 INFO - '_': '/tools/buildbot/bin/python'} 11:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:27 INFO - Downloading/unpacking psutil>=3.1.1 11:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:42:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:29 INFO - Installing collected packages: psutil 11:42:29 INFO - Running setup.py install for psutil 11:42:29 INFO - building 'psutil._psutil_linux' extension 11:42:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:42:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:42:29 INFO - building 'psutil._psutil_posix' extension 11:42:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:42:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:42:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:30 INFO - Successfully installed psutil 11:42:30 INFO - Cleaning up... 11:42:30 INFO - Return code: 0 11:42:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:30 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 0x7f7d96e5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1575770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16049c0>, '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 0x16058c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1605d50>, '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': 'df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685', '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 11:42:30 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 11:42:30 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 11:42:30 INFO - Using env: {'DISPLAY': ':0', 11:42:30 INFO - 'HOME': '/home/cltbld', 11:42:30 INFO - 'LANG': 'en_US.UTF-8', 11:42:30 INFO - 'LANGUAGE': 'en_US:en', 11:42:30 INFO - 'LOGNAME': 'cltbld', 11:42:30 INFO - 'MAIL': '/var/mail/cltbld', 11:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:30 INFO - 'MOZ_NO_REMOTE': '1', 11:42:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:30 INFO - 'NO_EM_RESTART': '1', 11:42:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:30 INFO - 'PWD': '/builds/slave/test', 11:42:30 INFO - 'SHELL': '/bin/bash', 11:42:30 INFO - 'SHLVL': '1', 11:42:30 INFO - 'TERM': 'linux', 11:42:30 INFO - 'TMOUT': '86400', 11:42:30 INFO - 'USER': 'cltbld', 11:42:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685', 11:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:30 INFO - '_': '/tools/buildbot/bin/python'} 11:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:42:31 INFO - Installing collected packages: mozsystemmonitor 11:42:31 INFO - Running setup.py install for mozsystemmonitor 11:42:31 INFO - Successfully installed mozsystemmonitor 11:42:31 INFO - Cleaning up... 11:42:31 INFO - Return code: 0 11:42:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:31 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 0x7f7d96e5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1575770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16049c0>, '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 0x16058c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1605d50>, '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': 'df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685', '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 11:42:31 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 11:42:31 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 11:42:31 INFO - Using env: {'DISPLAY': ':0', 11:42:31 INFO - 'HOME': '/home/cltbld', 11:42:31 INFO - 'LANG': 'en_US.UTF-8', 11:42:31 INFO - 'LANGUAGE': 'en_US:en', 11:42:31 INFO - 'LOGNAME': 'cltbld', 11:42:31 INFO - 'MAIL': '/var/mail/cltbld', 11:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:31 INFO - 'MOZ_NO_REMOTE': '1', 11:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:31 INFO - 'NO_EM_RESTART': '1', 11:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:31 INFO - 'PWD': '/builds/slave/test', 11:42:31 INFO - 'SHELL': '/bin/bash', 11:42:31 INFO - 'SHLVL': '1', 11:42:31 INFO - 'TERM': 'linux', 11:42:31 INFO - 'TMOUT': '86400', 11:42:31 INFO - 'USER': 'cltbld', 11:42:31 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685', 11:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:31 INFO - '_': '/tools/buildbot/bin/python'} 11:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:31 INFO - Downloading/unpacking blobuploader==1.2.4 11:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:33 INFO - Downloading blobuploader-1.2.4.tar.gz 11:42:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:42:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:42:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:34 INFO - Downloading docopt-0.6.1.tar.gz 11:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:42:34 INFO - Installing collected packages: blobuploader, requests, docopt 11:42:34 INFO - Running setup.py install for blobuploader 11:42:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:42:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:42:34 INFO - Running setup.py install for requests 11:42:35 INFO - Running setup.py install for docopt 11:42:35 INFO - Successfully installed blobuploader requests docopt 11:42:35 INFO - Cleaning up... 11:42:35 INFO - Return code: 0 11:42:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:35 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 0x7f7d96e5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1575770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16049c0>, '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 0x16058c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1605d50>, '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': 'df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685', '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 11:42:35 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 11:42:35 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 11:42:35 INFO - Using env: {'DISPLAY': ':0', 11:42:35 INFO - 'HOME': '/home/cltbld', 11:42:35 INFO - 'LANG': 'en_US.UTF-8', 11:42:35 INFO - 'LANGUAGE': 'en_US:en', 11:42:35 INFO - 'LOGNAME': 'cltbld', 11:42:35 INFO - 'MAIL': '/var/mail/cltbld', 11:42:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:35 INFO - 'MOZ_NO_REMOTE': '1', 11:42:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:35 INFO - 'NO_EM_RESTART': '1', 11:42:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:35 INFO - 'PWD': '/builds/slave/test', 11:42:35 INFO - 'SHELL': '/bin/bash', 11:42:35 INFO - 'SHLVL': '1', 11:42:35 INFO - 'TERM': 'linux', 11:42:35 INFO - 'TMOUT': '86400', 11:42:35 INFO - 'USER': 'cltbld', 11:42:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685', 11:42:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:35 INFO - '_': '/tools/buildbot/bin/python'} 11:42:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:35 INFO - Running setup.py (path:/tmp/pip-xuC6RY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:35 INFO - Running setup.py (path:/tmp/pip-GzdsX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:35 INFO - Running setup.py (path:/tmp/pip-a9JJ2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:35 INFO - Running setup.py (path:/tmp/pip-FRVf32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:35 INFO - Running setup.py (path:/tmp/pip-bjyW15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:35 INFO - Running setup.py (path:/tmp/pip-ZGaffG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:35 INFO - Running setup.py (path:/tmp/pip-aK7yGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:35 INFO - Running setup.py (path:/tmp/pip-pTKrlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:35 INFO - Running setup.py (path:/tmp/pip-YxhJEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:36 INFO - Running setup.py (path:/tmp/pip-g2Iy2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:36 INFO - Running setup.py (path:/tmp/pip-SiK2ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:36 INFO - Running setup.py (path:/tmp/pip-KSI9JC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:36 INFO - Running setup.py (path:/tmp/pip-EWM1x5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:36 INFO - Running setup.py (path:/tmp/pip-TtE8db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:36 INFO - Running setup.py (path:/tmp/pip-VTCv5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:36 INFO - Running setup.py (path:/tmp/pip-k8s9Js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:36 INFO - Running setup.py (path:/tmp/pip-McU4yX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:42:36 INFO - Running setup.py install for manifestparser 11:42:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:42:36 INFO - Running setup.py install for mozcrash 11:42:36 INFO - Running setup.py install for mozdebug 11:42:36 INFO - Running setup.py install for mozdevice 11:42:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Running setup.py install for mozfile 11:42:37 INFO - Running setup.py install for mozhttpd 11:42:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Running setup.py install for mozinfo 11:42:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Running setup.py install for mozInstall 11:42:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Running setup.py install for mozleak 11:42:37 INFO - Running setup.py install for mozlog 11:42:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Running setup.py install for moznetwork 11:42:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Running setup.py install for mozprocess 11:42:37 INFO - Running setup.py install for mozprofile 11:42:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Running setup.py install for mozrunner 11:42:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Running setup.py install for mozscreenshot 11:42:38 INFO - Running setup.py install for moztest 11:42:38 INFO - Running setup.py install for mozversion 11:42:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:42:38 INFO - Cleaning up... 11:42:38 INFO - Return code: 0 11:42:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:38 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 0x7f7d96e5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1575770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16049c0>, '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 0x16058c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1605d50>, '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': 'df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685', '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 11:42:38 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 11:42:38 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 11:42:38 INFO - Using env: {'DISPLAY': ':0', 11:42:38 INFO - 'HOME': '/home/cltbld', 11:42:38 INFO - 'LANG': 'en_US.UTF-8', 11:42:38 INFO - 'LANGUAGE': 'en_US:en', 11:42:38 INFO - 'LOGNAME': 'cltbld', 11:42:38 INFO - 'MAIL': '/var/mail/cltbld', 11:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:38 INFO - 'MOZ_NO_REMOTE': '1', 11:42:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:38 INFO - 'NO_EM_RESTART': '1', 11:42:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:38 INFO - 'PWD': '/builds/slave/test', 11:42:38 INFO - 'SHELL': '/bin/bash', 11:42:38 INFO - 'SHLVL': '1', 11:42:38 INFO - 'TERM': 'linux', 11:42:38 INFO - 'TMOUT': '86400', 11:42:38 INFO - 'USER': 'cltbld', 11:42:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685', 11:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:38 INFO - '_': '/tools/buildbot/bin/python'} 11:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:38 INFO - Running setup.py (path:/tmp/pip-SPnR1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:38 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)) 11:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:38 INFO - Running setup.py (path:/tmp/pip-G5MYJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:38 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)) 11:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:38 INFO - Running setup.py (path:/tmp/pip-Skxt6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:38 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)) 11:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:38 INFO - Running setup.py (path:/tmp/pip-fbDjan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:38 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)) 11:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:38 INFO - Running setup.py (path:/tmp/pip-4D9TLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:39 INFO - Running setup.py (path:/tmp/pip-go6X6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:39 INFO - Running setup.py (path:/tmp/pip-11pRJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:39 INFO - Running setup.py (path:/tmp/pip-sWzZLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:39 INFO - Running setup.py (path:/tmp/pip-FlRc5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:39 INFO - Running setup.py (path:/tmp/pip-CbxF55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:39 INFO - Running setup.py (path:/tmp/pip-ffH0BL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:39 INFO - Running setup.py (path:/tmp/pip-LpeVs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:39 INFO - Running setup.py (path:/tmp/pip-yw1a17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:39 INFO - Running setup.py (path:/tmp/pip-lr3dMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:39 INFO - Running setup.py (path:/tmp/pip-AKk4SF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:39 INFO - Running setup.py (path:/tmp/pip-X6zLP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:39 INFO - Running setup.py (path:/tmp/pip-1Paz98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:39 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)) 11:42:39 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)) 11:42:39 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)) 11:42:39 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)) 11:42:39 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)) 11:42:39 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)) 11:42:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:41 INFO - Downloading blessings-1.6.tar.gz 11:42:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:42:41 INFO - Installing collected packages: blessings 11:42:41 INFO - Running setup.py install for blessings 11:42:41 INFO - Successfully installed blessings 11:42:41 INFO - Cleaning up... 11:42:42 INFO - Return code: 0 11:42:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:42:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:42:42 INFO - Reading from file tmpfile_stdout 11:42:42 INFO - Current package versions: 11:42:42 INFO - argparse == 1.2.1 11:42:42 INFO - blessings == 1.6 11:42:42 INFO - blobuploader == 1.2.4 11:42:42 INFO - docopt == 0.6.1 11:42:42 INFO - manifestparser == 1.1 11:42:42 INFO - mozInstall == 1.12 11:42:42 INFO - mozcrash == 0.17 11:42:42 INFO - mozdebug == 0.1 11:42:42 INFO - mozdevice == 0.48 11:42:42 INFO - mozfile == 1.2 11:42:42 INFO - mozhttpd == 0.7 11:42:42 INFO - mozinfo == 0.9 11:42:42 INFO - mozleak == 0.1 11:42:42 INFO - mozlog == 3.2 11:42:42 INFO - moznetwork == 0.27 11:42:42 INFO - mozprocess == 0.22 11:42:42 INFO - mozprofile == 0.28 11:42:42 INFO - mozrunner == 6.11 11:42:42 INFO - mozscreenshot == 0.1 11:42:42 INFO - mozsystemmonitor == 0.3 11:42:42 INFO - moztest == 0.7 11:42:42 INFO - mozversion == 1.4 11:42:42 INFO - psutil == 3.1.1 11:42:42 INFO - requests == 1.2.3 11:42:42 INFO - wsgiref == 0.1.2 11:42:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:42 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 0x7f7d96e5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1575770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16049c0>, '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 0x16058c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1605d50>, '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': 'df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685', '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 11:42:42 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 11:42:42 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 11:42:42 INFO - Using env: {'DISPLAY': ':0', 11:42:42 INFO - 'HOME': '/home/cltbld', 11:42:42 INFO - 'LANG': 'en_US.UTF-8', 11:42:42 INFO - 'LANGUAGE': 'en_US:en', 11:42:42 INFO - 'LOGNAME': 'cltbld', 11:42:42 INFO - 'MAIL': '/var/mail/cltbld', 11:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:42 INFO - 'MOZ_NO_REMOTE': '1', 11:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:42 INFO - 'NO_EM_RESTART': '1', 11:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:42 INFO - 'PWD': '/builds/slave/test', 11:42:42 INFO - 'SHELL': '/bin/bash', 11:42:42 INFO - 'SHLVL': '1', 11:42:42 INFO - 'TERM': 'linux', 11:42:42 INFO - 'TMOUT': '86400', 11:42:42 INFO - 'USER': 'cltbld', 11:42:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685', 11:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:42 INFO - '_': '/tools/buildbot/bin/python'} 11:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:42 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)) 11:42:42 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)) 11:42:42 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)) 11:42:42 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)) 11:42:42 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)) 11:42:42 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)) 11:42:42 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)) 11:42:42 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)) 11:42:42 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)) 11:42:42 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)) 11:42:42 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)) 11:42:42 INFO - Cleaning up... 11:42:42 INFO - Return code: 0 11:42:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d96e5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1575770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16049c0>, '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 0x16058c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1605d50>, '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': 'df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685', '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 11:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:42:42 INFO - Using env: {'DISPLAY': ':0', 11:42:42 INFO - 'HOME': '/home/cltbld', 11:42:42 INFO - 'LANG': 'en_US.UTF-8', 11:42:42 INFO - 'LANGUAGE': 'en_US:en', 11:42:42 INFO - 'LOGNAME': 'cltbld', 11:42:42 INFO - 'MAIL': '/var/mail/cltbld', 11:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:42 INFO - 'MOZ_NO_REMOTE': '1', 11:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:42 INFO - 'NO_EM_RESTART': '1', 11:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:42 INFO - 'PWD': '/builds/slave/test', 11:42:42 INFO - 'SHELL': '/bin/bash', 11:42:42 INFO - 'SHLVL': '1', 11:42:42 INFO - 'TERM': 'linux', 11:42:42 INFO - 'TMOUT': '86400', 11:42:42 INFO - 'USER': 'cltbld', 11:42:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685', 11:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:42 INFO - '_': '/tools/buildbot/bin/python'} 11:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:42 INFO - Downloading/unpacking jsonschema 11:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:42:44 INFO - Downloading/unpacking functools32 (from jsonschema) 11:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:44 INFO - Downloading functools32-3.2.3-2.tar.gz 11:42:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:42:44 INFO - warning: no files found matching '*.txt' 11:42:44 INFO - no previously-included directories found matching 'build' 11:42:44 INFO - no previously-included directories found matching 'dist' 11:42:44 INFO - no previously-included directories found matching '.git*' 11:42:44 INFO - Installing collected packages: jsonschema, functools32 11:42:44 INFO - Running setup.py install for functools32 11:42:44 INFO - warning: no files found matching '*.txt' 11:42:44 INFO - no previously-included directories found matching 'build' 11:42:44 INFO - no previously-included directories found matching 'dist' 11:42:44 INFO - no previously-included directories found matching '.git*' 11:42:44 INFO - Successfully installed jsonschema functools32 11:42:44 INFO - Cleaning up... 11:42:45 INFO - Return code: 0 11:42:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d96e5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1575770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16049c0>, '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 0x16058c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1605d50>, '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': 'df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685', '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 11:42:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:42:45 INFO - Using env: {'DISPLAY': ':0', 11:42:45 INFO - 'HOME': '/home/cltbld', 11:42:45 INFO - 'LANG': 'en_US.UTF-8', 11:42:45 INFO - 'LANGUAGE': 'en_US:en', 11:42:45 INFO - 'LOGNAME': 'cltbld', 11:42:45 INFO - 'MAIL': '/var/mail/cltbld', 11:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:45 INFO - 'MOZ_NO_REMOTE': '1', 11:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:45 INFO - 'NO_EM_RESTART': '1', 11:42:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:45 INFO - 'PWD': '/builds/slave/test', 11:42:45 INFO - 'SHELL': '/bin/bash', 11:42:45 INFO - 'SHLVL': '1', 11:42:45 INFO - 'TERM': 'linux', 11:42:45 INFO - 'TMOUT': '86400', 11:42:45 INFO - 'USER': 'cltbld', 11:42:45 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685', 11:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:45 INFO - '_': '/tools/buildbot/bin/python'} 11:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:45 INFO - Downloading/unpacking flake8 11:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:42:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:42:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:42:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:42:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:42:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:42:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:42:47 INFO - no previously-included directories found matching 'docs/_build' 11:42:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:42:47 INFO - Running setup.py install for pep8 11:42:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:42:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:42:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:42:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:42:47 INFO - no previously-included directories found matching 'docs/_build' 11:42:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:42:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:42:48 INFO - Cleaning up... 11:42:48 INFO - Return code: 0 11:42:48 INFO - Running post-action listener: _resource_record_post_action 11:42:48 INFO - Running post-action listener: _start_resource_monitoring 11:42:48 INFO - Starting resource monitoring. 11:42:48 INFO - ##### 11:42:48 INFO - ##### Finished create-virtualenv step (success) 11:42:48 INFO - ##### 11:42:48 INFO - ##### 11:42:48 INFO - ##### Running install step. 11:42:48 INFO - ##### 11:42:48 INFO - Running pre-action listener: _resource_record_pre_action 11:42:48 INFO - Running main action method: install 11:42:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:42:48 INFO - Reading from file tmpfile_stdout 11:42:48 INFO - Detecting whether we're running mozinstall >=1.0... 11:42:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:42:48 INFO - Reading from file tmpfile_stdout 11:42:48 INFO - Output received: 11:42:48 INFO - Usage: mozinstall [options] installer 11:42:48 INFO - Options: 11:42:48 INFO - -h, --help show this help message and exit 11:42:48 INFO - -d DEST, --destination=DEST 11:42:48 INFO - Directory to install application into. [default: 11:42:48 INFO - "/builds/slave/test"] 11:42:48 INFO - --app=APP Application being installed. [default: firefox] 11:42:48 INFO - mkdir: /builds/slave/test/build/application 11:42:48 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'] 11:42:48 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 11:43:05 INFO - Reading from file tmpfile_stdout 11:43:05 INFO - Output received: 11:43:05 INFO - /builds/slave/test/build/application/firefox/firefox 11:43:05 INFO - Running post-action listener: _resource_record_post_action 11:43:05 INFO - ##### 11:43:05 INFO - ##### Finished install step (success) 11:43:05 INFO - ##### 11:43:05 INFO - ##### 11:43:05 INFO - ##### Running run-tests step. 11:43:05 INFO - ##### 11:43:05 INFO - Running pre-action listener: _resource_record_pre_action 11:43:05 INFO - Running main action method: run_tests 11:43:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:43:05 INFO - Python 2.7.3 11:43:05 INFO - Return code: 0 11:43:05 INFO - grabbing minidump binary from tooltool 11:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:05 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 0x16049c0>, '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 0x16058c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1605d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:43:05 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 11:43:05 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 11:43:05 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 11:43:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:43:05 INFO - Return code: 0 11:43:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:43:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:43:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:43:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:43:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:43:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:43:06 INFO - Return code: 0 11:43:06 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/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 11:43:06 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/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 11:43:06 INFO - Using env: {'DISPLAY': ':0', 11:43:06 INFO - 'HOME': '/home/cltbld', 11:43:06 INFO - 'LANG': 'en_US.UTF-8', 11:43:06 INFO - 'LANGUAGE': 'en_US:en', 11:43:06 INFO - 'LOGNAME': 'cltbld', 11:43:06 INFO - 'MAIL': '/var/mail/cltbld', 11:43:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:43:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:06 INFO - 'MOZ_NO_REMOTE': '1', 11:43:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:43:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:06 INFO - 'NO_EM_RESTART': '1', 11:43:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:06 INFO - 'PWD': '/builds/slave/test', 11:43:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:43:06 INFO - 'SHELL': '/bin/bash', 11:43:06 INFO - 'SHLVL': '1', 11:43:06 INFO - 'TERM': 'linux', 11:43:06 INFO - 'TMOUT': '86400', 11:43:06 INFO - 'USER': 'cltbld', 11:43:06 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685', 11:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:06 INFO - '_': '/tools/buildbot/bin/python'} 11:43:06 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/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 11:43:06 INFO - mozversion application_buildid: 20160517085406 11:43:06 INFO - mozversion application_changeset: 9f9aae87248d444ff93d1a213b6de0a6ee39fb26 11:43:06 INFO - mozversion application_display_name: Nightly 11:43:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:43:06 INFO - mozversion application_name: Firefox 11:43:06 INFO - mozversion application_remotingname: firefox 11:43:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:43:06 INFO - mozversion application_vendor: Mozilla 11:43:06 INFO - mozversion application_version: 49.0a1 11:43:06 INFO - mozversion platform_buildid: 20160517085406 11:43:06 INFO - mozversion platform_changeset: 9f9aae87248d444ff93d1a213b6de0a6ee39fb26 11:43:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:43:06 INFO - mozversion platform_version: 49.0a1 11:43:06 INFO - using testdate: 1463510586 11:43:06 INFO - actual date: 1463510586 11:43:06 INFO - starting webserver on 'localhost:47605' 11:43:06 INFO - SUITE-START | Running 2 tests 11:43:06 INFO - TEST-START | dromaeo_css 11:43:06 INFO - operating with platform_type : linux_ 11:43:06 INFO - Initialising browser for dromaeo_css test... 11:43:06 INFO - TEST-INFO | started process 2462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpitgcnb/profile http://localhost:47605/getInfo.html) 11:43:11 INFO - PROCESS | 2462 | 11:43:11 INFO - PROCESS | 2462 | (process:2549): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:43:12 INFO - PROCESS | 2462 | __metrics Screen width/height:1600/1200 11:43:12 INFO - PROCESS | 2462 | colorDepth:24 11:43:12 INFO - PROCESS | 2462 | Browser inner width/height: 1024/697 11:43:12 INFO - PROCESS | 2462 | __metrics 11:43:13 ERROR - PROCESS | 2462 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 11:43:14 INFO - TEST-INFO | 2462: exit 0 11:43:14 INFO - Browser initialized. 11:43:14 INFO - Running cycle 1/1 for dromaeo_css test... 11:43:14 INFO - TEST-INFO | started process 2600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpitgcnb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:43:15 INFO - PROCESS | 2600 | 11:43:15 INFO - PROCESS | 2600 | (process:2671): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:43:25 INFO - PROCESS | 2600 | RSS: Main: 163590144 11:43:25 INFO - PROCESS | 2600 | 11:44:15 INFO - PROCESS | 2600 | 1463510655536 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:46:23 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:47605/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47605/tests/dromaeo/cssquery-ext.html) 11:46:24 INFO - PROCESS | 2600 | RSS: Main: 166699008 11:46:24 INFO - PROCESS | 2600 | 11:49:26 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:47605/tests/dromaeo/cssquery-ext.html (next: http://localhost:47605/tests/dromaeo/cssquery-jquery.html) 11:49:27 INFO - PROCESS | 2600 | RSS: Main: 166412288 11:49:27 INFO - PROCESS | 2600 | 11:52:28 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:47605/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47605/tests/dromaeo/cssquery-mootools.html) 11:52:29 INFO - PROCESS | 2600 | RSS: Main: 167686144 11:52:29 INFO - PROCESS | 2600 | 11:55:31 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:47605/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47605/tests/dromaeo/cssquery-prototype.html) 11:55:31 INFO - PROCESS | 2600 | RSS: Main: 165552128 11:55:31 INFO - PROCESS | 2600 | 11:58:34 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:47605/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47605/tests/dromaeo/cssquery-yui.html) 11:58:34 INFO - PROCESS | 2600 | RSS: Main: 166326272 11:58:34 INFO - PROCESS | 2600 | 12:01:37 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:47605/tests/dromaeo/cssquery-yui.html (next: http://localhost:47605/tests/dromaeo/cssquery-dojo.html) 12:01:37 INFO - PROCESS | 2600 | RSS: Main: 168771584 12:01:37 INFO - PROCESS | 2600 | 12:01:37 INFO - PROCESS | 2600 | __start_tp_report 12:01:37 INFO - PROCESS | 2600 | _x_x_mozilla_page_load 12:01:37 INFO - PROCESS | 2600 | _x_x_mozilla_page_load_details 12:01:37 INFO - PROCESS | 2600 | |i|pagename|runs| 12:01:37 INFO - PROCESS | 2600 | |0;dojo.html;3063.47920853455;3123.9531407028885;3128.8748450062;3153.731932785713;3178.44377233984;5398.784048638059;5409.350877894648;5410.2425660407525;5508.091164957787;5539.362973258067;5383.219433182187;5442.074847275962;5475.67145971242;5492.093804522249;5508.3114610673565;4903.264510323454;4929.704217746928;5053.292539044537;5054.342935418391;5111.08000559899;4943.184374578191;5092.770825312869;5131.897362052757;5142.665726727751;5162.561182299509;4939.876503087416;4984.651074424792;4986.077575648516;4989.975050124726;5000.849974500735;4992.850214493535;5033.949660503385;5034.244863270502;5040.7731652075745;5094.261332106824;5007.148784706608;5029.270755740434;5034.84895453137;5038.874028149289;5042.218456139304;5357.624966252364;5366.785328586851;5398.190271459273;5405.081136206854;5431.755570999315;5823.2138661280605;5835.35811060783;5839.6204246724255;5857.76568937242;5887.381824908409;5726.169705392695;5826.067829147316;5905.173275741399;5923.763049478016;5928.318243402021;5465.863353416156;5538.169274608801;5588.245586845765;5596.412376700469;5607.102863541854;6046.818595442144;6060.878782424327;6076;6077.088436734525;6108.847278817976;5602;5728.083506639001;5763.510101641407;5815.88368232633;5835.94164058354;5807.361190269067;5819.70901454934;5831.737571809279;5851;5885.028970219952;5689.487946084872;5811.535077193815;5870.090136028923;5873.177755114288;5904.321003084614;5896.528277737771;5907.940920590825;5914.497267732205;5922.911156332659;5974.2233509643465;4482.21561226784;4494.505604383515;4499.932501012488;4504.81980720774;4534.591886730144;3907.7069219808627;3962.8612998544913;3971.6425521703186;3994.1811928554575;4057.69567282455;5586.944130558723;5601.019821531216;5603.8599035023635;5606.299212598426;5693.772249110072;5901.17383566301;5918.911216331759;5921.467067963904;5947.851303717355;5966.522678185822;5492.038893193675;5606.21512988182;5611.7474713637985;5614.101743720985;5618.297712785902;4911.7298548580175;4949.82675606352;4973.055119527278;4981.825636102719;5006.574441172468;6068.4538391544975;6150.753969841246;6152.446279834837;6154.261488621304;6154.569180157346;5810.099434587646;5889.646621202656;5933.9109913352195;5964.224650795369;5977.9103313451205;6117.908231376444;6128.32588415265;6208.689565521616;6215.502759779297;6224.221972253468;5872.265966754156;5895;5902.704864756659;5907.793227237198;5923;5742.5405967521665;5855;5865.589408741347;5910.852228694145;5998.520118390606;5709.8287051388525;5739.8852022960145;5741.311042674905;5744.3681195067675;5804.158397032322;5714.285714285715;5767.5674324425;5772.9711351442975;5773.913391299218;5785.797497087582;5515.751791169327;5617.634853734494;5641.717914104361;5660.547156227574;5671.801486948102;5644.238027866186;5664.915026274527;5723.8569035774435;5741.799037033684;5759.827205183851;5680;5683.2895888014;5687.374388817144;5694.544436445157;5707 12:01:37 INFO - PROCESS | 2600 | |1;ext.html;604.8276241271238;641.6535071061627;657.5791493444196;659.2846761264028;659.6207180870999;43402;44775.77612111939;45158.32262516061;47578.762106189504;47871.76064119674;44518.777406112924;44952;45014;45142;45348;8770.605322760475;8897.33270004749;8951.910480895205;8978.326625503081;8998.460092394445;8887.20015198632;8969.103089691043;8970.327225458084;8994.640214391417;9003.95498022509;8970.50662213578;9046.909530904673;9047.140521650466;9057.320700947423;9089.181973622373;8991.55042247885;9015.188633023026;9031.503267320328;9068.7279381618;9071.63713451461;8961.059088795648;8993.415427997159;9058.456492610465;9058.682946096855;9083.909160908372;41506.792466037776;41580.54468093633;41739.7913010436;42160.57839421628;42240.57759422397;3622.5366750609574;3740.382836831947;3880.4955355803845;3883.165119499321;4367.10474352757;31632.683673163203;31990.9217248722;32195.839020804746;32474;32798.836005820056;4437.600615944548;4495.235809912323;4563.77181140945;4655.348251244828;4686.039361930796;340843;343143;343256;343914;344142;35038.64961350405;57694.134587981214;57981.4201857976;57983.130253046234;58044.70977645085;30725;31189.688103119133;31230.843845780626;31571.52642710361;31612.364578073815;14767.40930362795;14835.480758173411;14972.47596334123;14972.775408368883;14997.325120369609;10872.728181795519;10936.507857146447;10939.07017903487;10940.12479001678;11034.944825275983;8407.201315874981;8473.279771219515;8506.74479765608;8518.361122915681;8582.656693732306;3304.140923359944;3318.8008719476907;3333.71663408613;3342.19787251058;3346.782459140148;1080.2330345454816;1179.4279774309452;1200.5857978997233;1225.08730995409;1235.4625737804083;31698;31751.206219844225;32163.356732865213;32206;32615.51076733851;1100.4839537677044;1163.7672465506932;1170.3446070200544;1178.3460179600233;1254.8745125487378;16687.249073791707;17136.22886970089;17296.740548891776;17366.13169341528;17683.823161768476;583391;584327;586001;587954;589971;59477.40522594805;60417;60442;60450.69774651099;60579.69710151421;1227.3249712658003;1228.975420491585;1233.734747029393;1277.5847849448967;1373.368250604733;31412.842935785175;31882;32071.83964080258;32188.678113218568;32566.34867302688;51278;51776.22335664893;52122.47877521176;52183.478165217864;52226.73886630542;452469;458041;460163;460501;461556;27651.44697106087;28055.0180743673;28239.15282541527;28414.573781392883;28500.42999140047;49764;50123.74938125286;50128.498715012385;50671;51433.74283128561;40132.59867401289;40251.396229056;40378.59621403748;41421;41770.53803116998;34538;35041.824790875886;35106.47340289847;35108.824455877555;35467.29065418729;35170.64829351674;42187.578124218366;43234.13531729285;43414.782926085165;45101.77449112865;35054.64945350514;37080;37372.81313593415;37452;38075.428868566436;28992.275193119498;29601.407971840872;29954.85022574873;30039.69960300369;30109.397812044073 12:01:37 INFO - PROCESS | 2600 | |2;jquery.html;401.2536681771905;404.75714571257265;408.03906799487225;408.5179488203919;421.95147558030817;18118.547036324082;19471.221151153935;19865.801341986575;19903.502412439695;19976;18501.7224741629;18897.149628266725;19092.809071909276;19171.520711982208;19188;5582.972085139579;5618.8595285118;5828.329742079652;5830.3586605473365;5833.3874943130995;5748.223989761371;5777.277840269966;5786.103154011135;5787.045137552299;5806.7096645167785;5464.562834973192;5672.68800215988;5720.427957204288;5748.223989761371;5753.942460575404;5484.451554844523;5673.29083864519;5680.4319568043275;5733.312002559678;5737.483626473596;5124.590032797404;5135.897282054375;5149.768260428253;5151.150060240056;5151.381834179922;23034.42413939648;23144.7685523146;23693.644595331083;23737.16919907795;24008.039678413017;2384.7972922301624;2490.7509249074947;2498.475320182764;2633.6049592561076;2939.6325459317586;15013.774793378108;15039.624009399744;15066.698666026618;15368.231588420535;15480.22598870052;2016.3245312820222;2019.5153163240864;2027.833995452606;2054.900628163925;2086.2072412483158;77995.22004779993;78513;78624;79527.20472795256;79570.6021469889;10569.63006294776;10605.82580570981;10884.67345979606;10966.519519864716;11174.44127793607;15222.543323700307;15229.847701523064;15302.846971530365;15316.157611331484;15346.15596142223;7593.202713715091;7634.198409166957;7728.111267204231;7839;7928.286454219148;7151.463640227003;7196.892046619305;7326.084239470067;7328.193898671142;7386.926130738624;6604.603723776589;6666.733330666719;6675.9332406676285;6746.156730408699;6800.31996800316;1964.1946801811189;1975.1210711233364;1997.500624843789;1997.5705223376754;2023.2817349840889;999.6900960702205;1035.5650626736788;1069.315637991686;1092.5848177692426;1166.8191430328313;19768.90115549442;19915.502112447306;19945.501362465766;20136.684281307836;20297;1025.0529727034775;1033.9379637221791;1075.086176749772;1120.9047230985295;1163;10867.184961127947;11419.200655954004;11536.711582210512;11633.59282425111;11753.529858805552;456029;467273;482000;487085;487383;79466.60266698629;79548.60225698835;80541;80940;81702;1055.4406164732704;1055.593596465351;1057.3761480726255;1058.4654749351528;1060.4538662588773;17502.562435939202;17504.562385939946;17633.647327053644;17746.29014839392;17890;38398;38450.42324365081;38604;38807.805960970014;40164;53713;55425.722871385384;56202.718986404805;60796.39203608084;62214.68892655508;7570.470067095251;7643.464957452925;8554.700585479479;9066.138716821892;9088.727338179866;10209.438480883622;12117.394130293274;13058.738825223632;13215.60353189406;13444.126131801402;12201.816972745593;12215.938920305696;12522.87477125217;12681.365931703562;12709.93645031769;12187.451564679433;12212.633620991384;12213.206141600767;12252;12328.691782705146;12242.938785306016;12520.123591348882;12569.183003104768;12620.674829142808;12835.486580537048;7328.413726901942;7712.267334603203;8459.873101903353;8693.304535637008;9183.540822958692;11518.308901465938;11734.471948762497;11737.823932641188;11960.58137965167;12122.818157727464 12:01:37 INFO - PROCESS | 2600 | |3;mootools.html;1405.8875289976802;1510.8262549806773;1634.8201697813238;1831.166819097311;1875.287390791499;8271.958640206805;8383.203595658419;9021.684241051556;9552.331336806426;9577.329586928918;8596.828063438728;8698.695545655903;8785.209331160195;8854.335924805633;8887.28901687865;2350.9059637614473;2404.4229384947575;2404.483036147228;2407.3861165402886;2409.0965887792077;2173.5544213436287;2337.263761915;2400.603900356439;2403.6995375578053;2416.0456619635233;2387.4270175157926;2391.079434417753;2405.530921470314;2410.4817464245184;2412.601920683085;2312.919047833326;2338.5673650374733;2353.670486131943;2368.6802281691926;2373.596488596943;2299.482616411311;2305.631099024148;2308.699869017034;2319.3158018384615;2322.581935251654;9114.86327705085;9123.543822808899;9125.224355929753;9138.497382643953;9146.95426522863;5252.527272545489;5370.624056316059;5370.677759334452;5383;5404.027275090482;3576.141725985745;3599.5320608321013;3636.254567813592;3642.526471558707;3652.926941461156;1172.9589464368792;1179.7935361311822;1189.2567145534042;1198.0595232742255;2214.878181700006;12543.372831358396;12898.355082245944;12921.160124591872;12925.224486530838;12935.935320323339;4780.617550596014;4859.1010663027455;4863.2461968394955;4867.58625516835;4922.901541969212;11195.160362972809;11205.103591712643;11207.775844483065;11235.550577976954;11242.94378528102;5306.867328316745;5325.733713314319;5399.00118478075;5413.7834486620095;5428.809991650273;4514.61625761814;4923.655344125948;4971.37857767779;5047.87380315495;5076.060928728197;4210.642095421924;4229.851955181615;4291.699581029298;4297.9055080342105;4327.394164816928;1277.2208952538945;1343.8387393512842;1344.126317893377;1346.6498710335384;1353.8713822186876;1012.1295685710284;1018.0837246478229;1032.3496197395743;1037.9532921018572;1063.112301228483;6029.427204415573;6044.365341639153;6117.877642447215;6246.656433896179;6411.743530258737;429.4009856250513;437.1781051622992;443.8135982887195;449.46064722332676;456.18798538601345;3856.787876666754;4057.857974970862;4131.793410329532;4134;4155.709100362946;11356.886431135583;11608.6517404478;11767.705807354714;11779.057675385948;11827.994620457186;11344;11542;11581.478833452515;11587.362695051854;11606.593769218036;7685.4620176587105;7925.682972681144;8520.105388934197;8569.614367353359;8694.217520423192;5999.442652971798;6097.817065488042;6210.937890621036;6259.3427690091885;6331.746730130927;10567.154627629925;10884.945575272073;11034.834477483004;11060.446977650925;11129.332240065622;10359.171266298828;10791.40647264408;11027.944860275968;11121.888781112086;11192.832107518556;7247.782566523013;7708.8458230836195;7902.960485197537;8078.6364613593705;8246.917530824854;8386.916130838614;8408.075111737582;8414.326853851555;8430.873536896828;8461.788455288666;7472.701091956261;7712.537247765152;7726.18875018115;7780.805479863048;7787.532748035136;7535.13345965221;7586.924130758843;7662.540247585162;7664.885026724715;7786.532808031537;6929;6972.477064220305;6974.4769142315545;6975.720971161097;7006.649667516705;4795.568398844121;4833.202521583899;5058.696478211319;5060.924086138784;5064.898702026013;5221.347331583552;5231.738413079407;5282.735863206901;5334.626576139633;5343.5457986071615 12:01:37 INFO - PROCESS | 2600 | |4;prototype.html;301.4107419993911;304.6085779772991;312.1836397819701;312.676379946755;316.9714725674689;5635.295588051494;5670.3479099903425;5708.372079071299;5728.369879313277;5754.223179870716;5636.408177141392;5638.605297629168;5639.830805075854;5688.203651488795;5702;4120.896977575562;4249.150169966004;4341.78291085446;4368.366586844905;4382.12357528494;4307.655387569002;4335.848245311415;4357.12857428514;4384.714993525411;4417.8292752420475;4295.248331541968;4327.4374331336885;4354.303311470166;4367.781610919457;4373.125374925012;4167.395727619493;4286.97856510717;4335.739855608642;4348.564973558718;4351.151525452538;3783.5270591176104;3806.4686983156166;3818.1218319786326;3820.9426858597144;3823.560290566593;5431.2396264522995;5469.398366179717;5472.577129946203;5479.4520547945285;5499.752511137009;4871.244957031666;4892.363992680965;4902.112686615643;4943.9258411123865;5011.398632164127;5860.941390586082;5881.647101173943;5884.823455296348;5885.264341957255;5905.911411328833;4108.424820525129;4120.763770868757;4126.8761937141935;4127.772972486512;4152.273352163359;5885.763409904252;6195.783147589857;6209.441150296495;6221.471174950089;6271.560990730651;4123.649489793401;4135.669146468275;4144.171165766858;4149.419081328617;4155.8961025974595;4155.439015732837;4179.665626749914;4184.979075104605;4191.64371028466;4206.789660516962;4743.905121897543;4807.543283388072;4817.590504807131;4821.855344339676;4857.344258525124;5961.791337303173;5985.34161242263;6004.759809607567;6014.037753959433;6033.336333003366;1463.1733070814955;1468.155810409019;1469.390203065737;1475.129673492623;1477.697072100217;892.6607889002267;908.9500077495801;909.6907051602354;912.780932576177;921.7234829551107;5077.289179514871;5079.263506791494;5131.87170320745;5133.383993920754;5206.661566998133;5319.972625868594;5362.544183744425;5428.185772134132;5494.340679118452;5515.227868098469;5097;5121.2574176744165;5254.42201357858;5730.541556675456;5769.1538707614;3265.297960938362;3303.9504407433906;3304.7686661933913;3308.652591477908;3310.851011704431;6150.846228844314;6288.9056664150075;6343.333949935282;6396.008618664115;6428.5178611604315;6251.937480625226;6269.185005949289;6296.244450665949;6297.433231009231;6300.558960872787;6253.906191407133;6323.30443651198;6329.461995730322;6421.711023003976;6449.774257900951;5909.438603332676;6094.141286907536;6129.601575897553;6158.476529494864;6168.537359697951;6041.066858605204;6076.848078798065;6141.263048434216;6145.8156255312415;6168.290646575701;6070.332263450929;6332.683365831782;6356.841078973062;6398.5201109916015;6405;4107.445494858275;4177.394277829637;4179.582041795796;4202;4237.427947227085;5925.288965324016;5955.344912059757;6243.37566243372;6259.467945224706;6268.780592679234;5944.375840536854;5974.133750606225;5974.1934838796205;5978.880422391615;6002.909956350745;5901.527877769682;5906.143609176559;5941.2176347096565;5948.762049518144;5987.31145918225;5637.408072152365;5848.356680765198;5854.707264636666;5860.882782344414;5932.703364831655;5924.229850119457;6023.819285421444;6024.246969128859;6031.939680603138;6066.787662431793;5707.736389684814;5893.528517718658;5899.734511947058;5938.317093534299;5946.256717910262 12:01:37 INFO - PROCESS | 2600 | |5;yui.html;786.6145588661556;818.2308629887905;833.4332653795417;837.5895811052584;876.6624849432974;13229.073964822453;13840.653983650402;13913.304334783259;13929.442822287096;14127.71744565108;13210.339483025858;13227.404766785517;13298.867011329883;13312.334383280846;13478.595642130751;698.863721574292;811.2495941254346;834.1491678487939;840.0717207485732;842.1788755962948;836.8953880764905;838.0739283092187;839.8530257204995;845.0662018469595;853.0957185383483;870.9564521773885;879.3580686099151;880.7842078690697;887.6848718704864;891.745852432057;867.1501928110424;878.1569693094636;880.3617377401397;885.313881741649;886.6187539358074;637.6046850952439;641.1728869758007;646.1245013007355;647.6502688548178;649.574528683713;12667.429965651569;12728.299943503103;12852.293123878182;12904;12928.612141635766;13474.663133421645;13584.864151358459;13620.250886201255;13904.930475347659;13934.442622295095;11288.661340159808;11363.715907102305;11492.482838272297;11572.710682232928;11605.477753501113;3739.476473293741;3863.150106976461;3870.78710670913;3884.6892248620043;3913.4521167036355;56136.43863561394;56575.71712141413;56692.43307566954;56748.716256418455;57237.71381143068;11025;11167.944160279147;11399.48702308398;11410.543578256942;11434.714132146597;20019.0591181914;20159.798402015793;20177.899110504353;20224.191032358834;20473;8368.874466883002;8379.078301386964;8386.37102217324;8440.662373505114;8468.107580241634;4650.325702773079;4685.250359942461;4739.857804265877;4773.95226047742;4883.096627123993;3348.11275012122;3432.673895979878;3434.9313013739584;3453.033150717803;3463.428534291814;587.3128439725531;593.8782549577327;596.242771679964;598.7664810723821;599.1372423709844;632.3865850125371;681.2336121862904;742.7029188324714;756.1153450462972;767.7581561808013;9301.209397201179;9649.758756031155;9661.082197191396;9663.613455461844;9737.659181928599;731.378328420838;743.5055687967549;763.3511515212025;767.4627760567626;789.5736302396641;4673.415823022122;4692.859214223578;4731.602226987582;4783.378160839069;4820.4456487503685;64504;68047.65976170187;68872;68999;69005.30994689988;63152.36847631557;64062.67968660127;64875.35124648787;65346.34653653498;65744.6712766433;56277.43722562722;56735;56981.71509142428;57150.42849571534;57839.71080144656;8719.084496127814;8979.191872731486;9084.318676099187;9134.543272836465;9200.171984521425;38047.619523805515;38140.427893581065;38352;38422.423663644506;38676.41985370166;45890;48361.27458088202;51161.48838511567;51735;51933.48066519287;11908.76182476363;11926.403679815801;11936.820947685965;12004.279743215435;12378.938105309417;12710.237385756884;12792;12804.935975320064;13234.073614846868;13617.319134043457;11707.356095414834;11923.463444144862;11936.164468487123;12024.218425802295;12182.939085304517;12366.690832729253;12679.746405072032;12688.619341419771;12805.103642745291;12894.355282236038;11285.71785705364;12107.818382724443;12153.939230303791;13286.468541258242;13926.442942282196;10619.415932123808;10814.89185108139;11496.137789665976;11605.825912611486;12264.018878489878;11282.435878205893;11315.151363647925;11448.542058317575;11642.476088576204;11748.177627565989 12:01:37 INFO - PROCESS | 2600 | __end_tp_report 12:01:37 INFO - PROCESS | 2600 | __start_cc_report 12:01:37 INFO - PROCESS | 2600 | _x_x_mozilla_cycle_collect,344 12:01:37 INFO - PROCESS | 2600 | __end_cc_report 12:01:37 INFO - PROCESS | 2600 | __startTimestamp1463511697500__endTimestamp 12:01:37 INFO - PROCESS | 2600 | 12:01:37 INFO - PROCESS | 2600 | ------- Summary: start ------- 12:01:37 INFO - PROCESS | 2600 | Number of tests: 6 12:01:37 INFO - PROCESS | 2600 | 12:01:37 INFO - PROCESS | 2600 | [#0] dojo.html Cycles:165 Average:5466.48 Median:5680.00 stddev:634.22 (11.2%) stddev-sans-first:607.50 12:01:37 INFO - PROCESS | 2600 | Values: 3063.5 3124.0 3128.9 3153.7 3178.4 5398.8 5409.4 5410.2 5508.1 5539.4 5383.2 5442.1 5475.7 5492.1 5508.3 4903.3 4929.7 5053.3 5054.3 5111.1 4943.2 5092.8 5131.9 5142.7 5162.6 4939.9 4984.7 4986.1 4990.0 5000.8 4992.9 5033.9 5034.2 5040.8 5094.3 5007.1 5029.3 5034.8 5038.9 5042.2 5357.6 5366.8 5398.2 5405.1 5431.8 5823.2 5835.4 5839.6 5857.8 5887.4 5726.2 5826.1 5905.2 5923.8 5928.3 5465.9 5538.2 5588.2 5596.4 5607.1 6046.8 6060.9 6076.0 6077.1 6108.8 5602.0 5728.1 5763.5 5815.9 5835.9 5807.4 5819.7 5831.7 5851.0 5885.0 5689.5 5811.5 5870.1 5873.2 5904.3 5896.5 5907.9 5914.5 5922.9 5974.2 4482.2 4494.5 4499.9 4504.8 4534.6 3907.7 3962.9 3971.6 3994.2 4057.7 5586.9 5601.0 5603.9 5606.3 5693.8 5901.2 5918.9 5921.5 5947.9 5966.5 5492.0 5606.2 5611.7 5614.1 5618.3 4911.7 4949.8 4973.1 4981.8 5006.6 6068.5 6150.8 6152.4 6154.3 6154.6 5810.1 5889.6 5933.9 5964.2 5977.9 6117.9 6128.3 6208.7 6215.5 6224.2 5872.3 5895.0 5902.7 5907.8 5923.0 5742.5 5855.0 5865.6 5910.9 5998.5 5709.8 5739.9 5741.3 5744.4 5804.2 5714.3 5767.6 5773.0 5773.9 5785.8 5515.8 5617.6 5641.7 5660.5 5671.8 5644.2 5664.9 5723.9 5741.8 5759.8 5680.0 5683.3 5687.4 5694.5 5707.0 12:01:37 INFO - PROCESS | 2600 | 12:01:37 INFO - PROCESS | 2600 | [#1] ext.html Cycles:180 Average:60814.44 Median:41543.67 stddev:126096.05 (303.5%) stddev-sans-first:126368.75 12:01:37 INFO - PROCESS | 2600 | Values: 604.8 641.7 657.6 659.3 659.6 43402.0 44775.8 45158.3 47578.8 47871.8 44518.8 44952.0 45014.0 45142.0 45348.0 8770.6 8897.3 8951.9 8978.3 8998.5 8887.2 8969.1 8970.3 8994.6 9004.0 8970.5 9046.9 9047.1 9057.3 9089.2 8991.6 9015.2 9031.5 9068.7 9071.6 8961.1 8993.4 9058.5 9058.7 9083.9 41506.8 41580.5 41739.8 42160.6 42240.6 3622.5 3740.4 3880.5 3883.2 4367.1 31632.7 31990.9 32195.8 32474.0 32798.8 4437.6 4495.2 4563.8 4655.3 4686.0 340843.0 343143.0 343256.0 343914.0 344142.0 35038.6 57694.1 57981.4 57983.1 58044.7 30725.0 31189.7 31230.8 31571.5 31612.4 14767.4 14835.5 14972.5 14972.8 14997.3 10872.7 10936.5 10939.1 10940.1 11034.9 8407.2 8473.3 8506.7 8518.4 8582.7 3304.1 3318.8 3333.7 3342.2 3346.8 1080.2 1179.4 1200.6 1225.1 1235.5 31698.0 31751.2 32163.4 32206.0 32615.5 1100.5 1163.8 1170.3 1178.3 1254.9 16687.2 17136.2 17296.7 17366.1 17683.8 583391.0 584327.0 586001.0 587954.0 589971.0 59477.4 60417.0 60442.0 60450.7 60579.7 1227.3 1229.0 1233.7 1277.6 1373.4 31412.8 31882.0 32071.8 32188.7 32566.3 51278.0 51776.2 52122.5 52183.5 52226.7 452469.0 458041.0 460163.0 460501.0 461556.0 27651.4 28055.0 28239.2 28414.6 28500.4 49764.0 50123.7 50128.5 50671.0 51433.7 40132.6 40251.4 40378.6 41421.0 41770.5 34538.0 35041.8 35106.5 35108.8 35467.3 35170.6 42187.6 43234.1 43414.8 45101.8 35054.6 37080.0 37372.8 37452.0 38075.4 28992.3 29601.4 29954.9 30039.7 30109.4 12:01:37 INFO - PROCESS | 2600 | 12:01:37 INFO - PROCESS | 2600 | [#2] jquery.html Cycles:180 Average:28397.01 Median:23419.21 stddev:78238.55 (334.1%) stddev-sans-first:78429.79 12:01:37 INFO - PROCESS | 2600 | Values: 401.3 404.8 408.0 408.5 422.0 18118.5 19471.2 19865.8 19903.5 19976.0 18501.7 18897.1 19092.8 19171.5 19188.0 5583.0 5618.9 5828.3 5830.4 5833.4 5748.2 5777.3 5786.1 5787.0 5806.7 5464.6 5672.7 5720.4 5748.2 5753.9 5484.5 5673.3 5680.4 5733.3 5737.5 5124.6 5135.9 5149.8 5151.2 5151.4 23034.4 23144.8 23693.6 23737.2 24008.0 2384.8 2490.8 2498.5 2633.6 2939.6 15013.8 15039.6 15066.7 15368.2 15480.2 2016.3 2019.5 2027.8 2054.9 2086.2 77995.2 78513.0 78624.0 79527.2 79570.6 10569.6 10605.8 10884.7 10966.5 11174.4 15222.5 15229.8 15302.8 15316.2 15346.2 7593.2 7634.2 7728.1 7839.0 7928.3 7151.5 7196.9 7326.1 7328.2 7386.9 6604.6 6666.7 6675.9 6746.2 6800.3 1964.2 1975.1 1997.5 1997.6 2023.3 999.7 1035.6 1069.3 1092.6 1166.8 19768.9 19915.5 19945.5 20136.7 20297.0 1025.1 1033.9 1075.1 1120.9 1163.0 10867.2 11419.2 11536.7 11633.6 11753.5 456029.0 467273.0 482000.0 487085.0 487383.0 79466.6 79548.6 80541.0 80940.0 81702.0 1055.4 1055.6 1057.4 1058.5 1060.5 17502.6 17504.6 17633.6 17746.3 17890.0 38398.0 38450.4 38604.0 38807.8 40164.0 53713.0 55425.7 56202.7 60796.4 62214.7 7570.5 7643.5 8554.7 9066.1 9088.7 10209.4 12117.4 13058.7 13215.6 13444.1 12201.8 12215.9 12522.9 12681.4 12709.9 12187.5 12212.6 12213.2 12252.0 12328.7 12242.9 12520.1 12569.2 12620.7 12835.5 7328.4 7712.3 8459.9 8693.3 9183.5 11518.3 11734.5 11737.8 11960.6 12122.8 12:01:37 INFO - PROCESS | 2600 | 12:01:37 INFO - PROCESS | 2600 | [#3] mootools.html Cycles:180 Average:5986.40 Median:2382.29 stddev:3483.83 (146.2%) stddev-sans-first:3476.60 12:01:37 INFO - PROCESS | 2600 | Values: 1405.9 1510.8 1634.8 1831.2 1875.3 8272.0 8383.2 9021.7 9552.3 9577.3 8596.8 8698.7 8785.2 8854.3 8887.3 2350.9 2404.4 2404.5 2407.4 2409.1 2173.6 2337.3 2400.6 2403.7 2416.0 2387.4 2391.1 2405.5 2410.5 2412.6 2312.9 2338.6 2353.7 2368.7 2373.6 2299.5 2305.6 2308.7 2319.3 2322.6 9114.9 9123.5 9125.2 9138.5 9147.0 5252.5 5370.6 5370.7 5383.0 5404.0 3576.1 3599.5 3636.3 3642.5 3652.9 1173.0 1179.8 1189.3 1198.1 2214.9 12543.4 12898.4 12921.2 12925.2 12935.9 4780.6 4859.1 4863.2 4867.6 4922.9 11195.2 11205.1 11207.8 11235.6 11242.9 5306.9 5325.7 5399.0 5413.8 5428.8 4514.6 4923.7 4971.4 5047.9 5076.1 4210.6 4229.9 4291.7 4297.9 4327.4 1277.2 1343.8 1344.1 1346.6 1353.9 1012.1 1018.1 1032.3 1038.0 1063.1 6029.4 6044.4 6117.9 6246.7 6411.7 429.4 437.2 443.8 449.5 456.2 3856.8 4057.9 4131.8 4134.0 4155.7 11356.9 11608.7 11767.7 11779.1 11828.0 11344.0 11542.0 11581.5 11587.4 11606.6 7685.5 7925.7 8520.1 8569.6 8694.2 5999.4 6097.8 6210.9 6259.3 6331.7 10567.2 10884.9 11034.8 11060.4 11129.3 10359.2 10791.4 11027.9 11121.9 11192.8 7247.8 7708.8 7903.0 8078.6 8246.9 8386.9 8408.1 8414.3 8430.9 8461.8 7472.7 7712.5 7726.2 7780.8 7787.5 7535.1 7586.9 7662.5 7664.9 7786.5 6929.0 6972.5 6974.5 6975.7 7006.6 4795.6 4833.2 5058.7 5060.9 5064.9 5221.3 5231.7 5282.7 5334.6 5343.5 12:01:37 INFO - PROCESS | 2600 | 12:01:37 INFO - PROCESS | 2600 | [#4] prototype.html Cycles:180 Average:4931.00 Median:5638.01 stddev:1493.58 (26.5%) stddev-sans-first:1456.79 12:01:37 INFO - PROCESS | 2600 | Values: 301.4 304.6 312.2 312.7 317.0 5635.3 5670.3 5708.4 5728.4 5754.2 5636.4 5638.6 5639.8 5688.2 5702.0 4120.9 4249.2 4341.8 4368.4 4382.1 4307.7 4335.8 4357.1 4384.7 4417.8 4295.2 4327.4 4354.3 4367.8 4373.1 4167.4 4287.0 4335.7 4348.6 4351.2 3783.5 3806.5 3818.1 3820.9 3823.6 5431.2 5469.4 5472.6 5479.5 5499.8 4871.2 4892.4 4902.1 4943.9 5011.4 5860.9 5881.6 5884.8 5885.3 5905.9 4108.4 4120.8 4126.9 4127.8 4152.3 5885.8 6195.8 6209.4 6221.5 6271.6 4123.6 4135.7 4144.2 4149.4 4155.9 4155.4 4179.7 4185.0 4191.6 4206.8 4743.9 4807.5 4817.6 4821.9 4857.3 5961.8 5985.3 6004.8 6014.0 6033.3 1463.2 1468.2 1469.4 1475.1 1477.7 892.7 909.0 909.7 912.8 921.7 5077.3 5079.3 5131.9 5133.4 5206.7 5320.0 5362.5 5428.2 5494.3 5515.2 5097.0 5121.3 5254.4 5730.5 5769.2 3265.3 3304.0 3304.8 3308.7 3310.9 6150.8 6288.9 6343.3 6396.0 6428.5 6251.9 6269.2 6296.2 6297.4 6300.6 6253.9 6323.3 6329.5 6421.7 6449.8 5909.4 6094.1 6129.6 6158.5 6168.5 6041.1 6076.8 6141.3 6145.8 6168.3 6070.3 6332.7 6356.8 6398.5 6405.0 4107.4 4177.4 4179.6 4202.0 4237.4 5925.3 5955.3 6243.4 6259.5 6268.8 5944.4 5974.1 5974.2 5978.9 6002.9 5901.5 5906.1 5941.2 5948.8 5987.3 5637.4 5848.4 5854.7 5860.9 5932.7 5924.2 6023.8 6024.2 6031.9 6066.8 5707.7 5893.5 5899.7 5938.3 5946.3 12:01:37 INFO - PROCESS | 2600 | 12:01:37 INFO - PROCESS | 2600 | [#5] yui.html Cycles:180 Average:15744.40 Median:4735.73 stddev:19078.75 (402.9%) stddev-sans-first:19099.21 12:01:37 INFO - PROCESS | 2600 | Values: 786.6 818.2 833.4 837.6 876.7 13229.1 13840.7 13913.3 13929.4 14127.7 13210.3 13227.4 13298.9 13312.3 13478.6 698.9 811.2 834.1 840.1 842.2 836.9 838.1 839.9 845.1 853.1 871.0 879.4 880.8 887.7 891.7 867.2 878.2 880.4 885.3 886.6 637.6 641.2 646.1 647.7 649.6 12667.4 12728.3 12852.3 12904.0 12928.6 13474.7 13584.9 13620.3 13904.9 13934.4 11288.7 11363.7 11492.5 11572.7 11605.5 3739.5 3863.2 3870.8 3884.7 3913.5 56136.4 56575.7 56692.4 56748.7 57237.7 11025.0 11167.9 11399.5 11410.5 11434.7 20019.1 20159.8 20177.9 20224.2 20473.0 8368.9 8379.1 8386.4 8440.7 8468.1 4650.3 4685.3 4739.9 4774.0 4883.1 3348.1 3432.7 3434.9 3453.0 3463.4 587.3 593.9 596.2 598.8 599.1 632.4 681.2 742.7 756.1 767.8 9301.2 9649.8 9661.1 9663.6 9737.7 731.4 743.5 763.4 767.5 789.6 4673.4 4692.9 4731.6 4783.4 4820.4 64504.0 68047.7 68872.0 68999.0 69005.3 63152.4 64062.7 64875.4 65346.3 65744.7 56277.4 56735.0 56981.7 57150.4 57839.7 8719.1 8979.2 9084.3 9134.5 9200.2 38047.6 38140.4 38352.0 38422.4 38676.4 45890.0 48361.3 51161.5 51735.0 51933.5 11908.8 11926.4 11936.8 12004.3 12378.9 12710.2 12792.0 12804.9 13234.1 13617.3 11707.4 11923.5 11936.2 12024.2 12182.9 12366.7 12679.7 12688.6 12805.1 12894.4 11285.7 12107.8 12153.9 13286.5 13926.4 10619.4 10814.9 11496.1 11605.8 12264.0 11282.4 11315.2 11448.5 11642.5 11748.2 12:01:37 INFO - PROCESS | 2600 | -------- Summary: end -------- 12:01:37 INFO - PROCESS | 2600 | 12:01:38 INFO - TEST-INFO | 2600: exit 0 12:01:38 INFO - TEST-OK | dromaeo_css | took 1111838ms 12:01:38 INFO - TEST-START | kraken 12:01:38 INFO - operating with platform_type : linux_ 12:01:38 INFO - Initialising browser for kraken test... 12:01:38 INFO - TEST-INFO | started process 2941 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKsefQm/profile http://localhost:47605/getInfo.html) 12:01:42 INFO - PROCESS | 2941 | 12:01:42 INFO - PROCESS | 2941 | (process:3010): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:01:43 INFO - PROCESS | 2941 | __metrics Screen width/height:1600/1200 12:01:43 INFO - PROCESS | 2941 | colorDepth:24 12:01:43 INFO - PROCESS | 2941 | Browser inner width/height: 1024/697 12:01:43 INFO - PROCESS | 2941 | __metrics 12:01:44 ERROR - PROCESS | 2941 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 12:01:45 INFO - TEST-INFO | 2941: exit 0 12:01:45 INFO - Browser initialized. 12:01:45 INFO - Running cycle 1/1 for kraken test... 12:01:45 INFO - TEST-INFO | started process 3061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKsefQm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:01:47 INFO - PROCESS | 3061 | 12:01:47 INFO - PROCESS | 3061 | (process:3120): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:01:57 INFO - PROCESS | 3061 | RSS: Main: 163450880 12:01:57 INFO - PROCESS | 3061 | 12:01:59 INFO - PROCESS | 3061 | Cycle 1(1): loaded http://localhost:47605/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47605/tests/kraken/driver.html?testName=audio-beat-detection) 12:02:00 INFO - PROCESS | 3061 | RSS: Main: 168550400 12:02:00 INFO - PROCESS | 3061 | 12:02:03 INFO - PROCESS | 3061 | Cycle 1(1): loaded http://localhost:47605/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47605/tests/kraken/driver.html?testName=audio-dft) 12:02:03 INFO - PROCESS | 3061 | RSS: Main: 168607744 12:02:03 INFO - PROCESS | 3061 | 12:02:06 INFO - PROCESS | 3061 | Cycle 1(1): loaded http://localhost:47605/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47605/tests/kraken/driver.html?testName=audio-fft) 12:02:07 INFO - PROCESS | 3061 | RSS: Main: 163172352 12:02:07 INFO - PROCESS | 3061 | 12:02:09 INFO - PROCESS | 3061 | Cycle 1(1): loaded http://localhost:47605/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47605/tests/kraken/driver.html?testName=audio-oscillator) 12:02:10 INFO - PROCESS | 3061 | RSS: Main: 163442688 12:02:10 INFO - PROCESS | 3061 | 12:02:12 INFO - PROCESS | 3061 | Cycle 1(1): loaded http://localhost:47605/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47605/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:02:13 INFO - PROCESS | 3061 | RSS: Main: 164044800 12:02:13 INFO - PROCESS | 3061 | 12:02:16 INFO - PROCESS | 3061 | Cycle 1(1): loaded http://localhost:47605/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47605/tests/kraken/driver.html?testName=imaging-darkroom) 12:02:17 INFO - PROCESS | 3061 | RSS: Main: 164200448 12:02:17 INFO - PROCESS | 3061 | 12:02:20 INFO - PROCESS | 3061 | Cycle 1(1): loaded http://localhost:47605/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47605/tests/kraken/driver.html?testName=imaging-desaturate) 12:02:21 INFO - PROCESS | 3061 | RSS: Main: 163016704 12:02:21 INFO - PROCESS | 3061 | 12:02:24 INFO - PROCESS | 3061 | Cycle 1(1): loaded http://localhost:47605/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47605/tests/kraken/driver.html?testName=json-parse-financial) 12:02:24 INFO - PROCESS | 3061 | RSS: Main: 163606528 12:02:24 INFO - PROCESS | 3061 | 12:02:26 INFO - PROCESS | 3061 | Cycle 1(1): loaded http://localhost:47605/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47605/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:02:27 INFO - PROCESS | 3061 | RSS: Main: 164216832 12:02:27 INFO - PROCESS | 3061 | 12:02:28 INFO - PROCESS | 3061 | Cycle 1(1): loaded http://localhost:47605/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47605/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:02:29 INFO - PROCESS | 3061 | RSS: Main: 164003840 12:02:29 INFO - PROCESS | 3061 | 12:02:31 INFO - PROCESS | 3061 | Cycle 1(1): loaded http://localhost:47605/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47605/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:02:32 INFO - PROCESS | 3061 | RSS: Main: 164089856 12:02:32 INFO - PROCESS | 3061 | 12:02:34 INFO - PROCESS | 3061 | Cycle 1(1): loaded http://localhost:47605/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47605/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:02:35 INFO - PROCESS | 3061 | RSS: Main: 165117952 12:02:35 INFO - PROCESS | 3061 | 12:02:38 INFO - PROCESS | 3061 | Cycle 1(1): loaded http://localhost:47605/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47605/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:02:38 INFO - PROCESS | 3061 | RSS: Main: 165019648 12:02:38 INFO - PROCESS | 3061 | 12:02:40 INFO - PROCESS | 3061 | Cycle 1(1): loaded http://localhost:47605/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47605/tests/kraken/driver.html?testName=ai-astar) 12:02:40 INFO - PROCESS | 3061 | RSS: Main: 166408192 12:02:40 INFO - PROCESS | 3061 | 12:02:40 INFO - PROCESS | 3061 | __start_tp_report 12:02:40 INFO - PROCESS | 3061 | _x_x_mozilla_page_load 12:02:40 INFO - PROCESS | 3061 | _x_x_mozilla_page_load_details 12:02:40 INFO - PROCESS | 3061 | |i|pagename|runs| 12:02:40 INFO - PROCESS | 3061 | |0;ai-astar;109;115;104;110;111;111;105;114;110;111 12:02:40 INFO - PROCESS | 3061 | |1;audio-beat-detection;153;133;154;215;130;153;163;131;180;126 12:02:40 INFO - PROCESS | 3061 | |2;audio-dft;171;168;163;164;166;177;166;165;165;164 12:02:40 INFO - PROCESS | 3061 | |3;audio-fft;75;76;76;155;76;77;74;76;160;76 12:02:40 INFO - PROCESS | 3061 | |4;audio-oscillator;93;92;182;92;93;92;147;94;91;150 12:02:40 INFO - PROCESS | 3061 | |5;imaging-gaussian-blur;120;118;117;117;117;118;117;117;118;118 12:02:40 INFO - PROCESS | 3061 | |6;imaging-darkroom;147;147;148;147;147;146;146;146;146;146 12:02:40 INFO - PROCESS | 3061 | |7;imaging-desaturate;95;95;95;95;95;97;95;95;96;95 12:02:40 INFO - PROCESS | 3061 | |8;json-parse-financial;59;59;56;55;56;55;60;112;53;54 12:02:40 INFO - PROCESS | 3061 | |9;json-stringify-tinderbox;58;58;58;59;58;58;58;59;58;59 12:02:40 INFO - PROCESS | 3061 | |10;stanford-crypto-aes;79;84;77;78;80;85;81;80;80;78 12:02:40 INFO - PROCESS | 3061 | |11;stanford-crypto-ccm;124;123;126;131;121;126;130;122;194;140 12:02:40 INFO - PROCESS | 3061 | |12;stanford-crypto-pbkdf2;160;163;160;159;161;160;160;161;161;159 12:02:40 INFO - PROCESS | 3061 | |13;stanford-crypto-sha256-iterative;63;64;64;64;64;71;62;62;61;62 12:02:40 INFO - PROCESS | 3061 | __end_tp_report 12:02:40 INFO - PROCESS | 3061 | __start_cc_report 12:02:40 INFO - PROCESS | 3061 | _x_x_mozilla_cycle_collect,867 12:02:40 INFO - PROCESS | 3061 | __end_cc_report 12:02:40 INFO - PROCESS | 3061 | __startTimestamp1463511760917__endTimestamp 12:02:40 INFO - PROCESS | 3061 | 12:02:40 INFO - PROCESS | 3061 | ------- Summary: start ------- 12:02:40 INFO - PROCESS | 3061 | Number of tests: 14 12:02:40 INFO - PROCESS | 3061 | 12:02:40 INFO - PROCESS | 3061 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:3.43 (3.1%) stddev-sans-first:3.62 12:02:40 INFO - PROCESS | 3061 | Values: 109.0 115.0 104.0 110.0 111.0 111.0 105.0 114.0 110.0 111.0 12:02:40 INFO - PROCESS | 3061 | 12:02:40 INFO - PROCESS | 3061 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:153.50 stddev:27.51 (17.9%) stddev-sans-first:29.17 12:02:40 INFO - PROCESS | 3061 | Values: 153.0 133.0 154.0 215.0 130.0 153.0 163.0 131.0 180.0 126.0 12:02:40 INFO - PROCESS | 3061 | 12:02:40 INFO - PROCESS | 3061 | [#2] audio-dft Cycles:10 Average:166.90 Median:166.00 stddev:4.23 (2.5%) stddev-sans-first:4.22 12:02:40 INFO - PROCESS | 3061 | Values: 171.0 168.0 163.0 164.0 166.0 177.0 166.0 165.0 165.0 164.0 12:02:40 INFO - PROCESS | 3061 | 12:02:40 INFO - PROCESS | 3061 | [#3] audio-fft Cycles:10 Average:92.10 Median:76.00 stddev:34.50 (45.4%) stddev-sans-first:36.03 12:02:40 INFO - PROCESS | 3061 | Values: 75.0 76.0 76.0 155.0 76.0 77.0 74.0 76.0 160.0 76.0 12:02:40 INFO - PROCESS | 3061 | 12:02:40 INFO - PROCESS | 3061 | [#4] audio-oscillator Cycles:10 Average:112.60 Median:92.00 stddev:33.75 (36.7%) stddev-sans-first:35.05 12:02:40 INFO - PROCESS | 3061 | Values: 93.0 92.0 182.0 92.0 93.0 92.0 147.0 94.0 91.0 150.0 12:02:40 INFO - PROCESS | 3061 | 12:02:40 INFO - PROCESS | 3061 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:0.53 12:02:40 INFO - PROCESS | 3061 | Values: 120.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 118.0 12:02:40 INFO - PROCESS | 3061 | 12:02:40 INFO - PROCESS | 3061 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 12:02:40 INFO - PROCESS | 3061 | Values: 147.0 147.0 148.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 12:02:40 INFO - PROCESS | 3061 | 12:02:40 INFO - PROCESS | 3061 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 12:02:40 INFO - PROCESS | 3061 | Values: 95.0 95.0 95.0 95.0 95.0 97.0 95.0 95.0 96.0 95.0 12:02:40 INFO - PROCESS | 3061 | 12:02:40 INFO - PROCESS | 3061 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:56.00 stddev:17.75 (31.7%) stddev-sans-first:18.80 12:02:40 INFO - PROCESS | 3061 | Values: 59.0 59.0 56.0 55.0 56.0 55.0 60.0 112.0 53.0 54.0 12:02:40 INFO - PROCESS | 3061 | 12:02:40 INFO - PROCESS | 3061 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 12:02:40 INFO - PROCESS | 3061 | Values: 58.0 58.0 58.0 59.0 58.0 58.0 58.0 59.0 58.0 59.0 12:02:40 INFO - PROCESS | 3061 | 12:02:40 INFO - PROCESS | 3061 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:2.57 (3.2%) stddev-sans-first:2.69 12:02:40 INFO - PROCESS | 3061 | Values: 79.0 84.0 77.0 78.0 80.0 85.0 81.0 80.0 80.0 78.0 12:02:40 INFO - PROCESS | 3061 | 12:02:40 INFO - PROCESS | 3061 | [#11] stanford-crypto-ccm Cycles:10 Average:133.70 Median:128.00 stddev:21.91 (17.1%) stddev-sans-first:22.96 12:02:40 INFO - PROCESS | 3061 | Values: 124.0 123.0 126.0 131.0 121.0 126.0 130.0 122.0 194.0 140.0 12:02:40 INFO - PROCESS | 3061 | 12:02:40 INFO - PROCESS | 3061 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:160.50 stddev:1.17 (0.7%) stddev-sans-first:1.24 12:02:40 INFO - PROCESS | 3061 | Values: 160.0 163.0 160.0 159.0 161.0 160.0 160.0 161.0 161.0 159.0 12:02:40 INFO - PROCESS | 3061 | 12:02:40 INFO - PROCESS | 3061 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:2.79 (4.4%) stddev-sans-first:2.95 12:02:40 INFO - PROCESS | 3061 | Values: 63.0 64.0 64.0 64.0 64.0 71.0 62.0 62.0 61.0 62.0 12:02:40 INFO - PROCESS | 3061 | -------- Summary: end -------- 12:02:40 INFO - PROCESS | 3061 | 12:02:41 INFO - TEST-INFO | 3061: exit 0 12:02:41 INFO - TEST-OK | kraken | took 63658ms 12:02:41 INFO - SUITE-END | took 1175s 12:02:42 INFO - Completed test suite (00:19:35) 12:02:42 INFO - javascript benchmark 12:02:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7215.923778108748, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3063.47920853455, 3123.9531407028885, 3128.8748450062, 3153.731932785713, 3178.44377233984, 5398.784048638059, 5409.350877894648, 5410.2425660407525, 5508.091164957787, 5539.362973258067, 5383.219433182187, 5442.074847275962, 5475.67145971242, 5492.093804522249, 5508.3114610673565, 4903.264510323454, 4929.704217746928, 5053.292539044537, 5054.342935418391, 5111.08000559899, 4943.184374578191, 5092.770825312869, 5131.897362052757, 5142.665726727751, 5162.561182299509, 4939.876503087416, 4984.651074424792, 4986.077575648516, 4989.975050124726, 5000.849974500735, 4992.850214493535, 5033.949660503385, 5034.244863270502, 5040.7731652075745, 5094.261332106824, 5007.148784706608, 5029.270755740434, 5034.84895453137, 5038.874028149289, 5042.218456139304, 5357.624966252364, 5366.785328586851, 5398.190271459273, 5405.081136206854, 5431.755570999315, 5823.2138661280605, 5835.35811060783, 5839.6204246724255, 5857.76568937242, 5887.381824908409, 5726.169705392695, 5826.067829147316, 5905.173275741399, 5923.763049478016, 5928.318243402021, 5465.863353416156, 5538.169274608801, 5588.245586845765, 5596.412376700469, 5607.102863541854, 6046.818595442144, 6060.878782424327, 6076.0, 6077.088436734525, 6108.847278817976, 5602.0, 5728.083506639001, 5763.510101641407, 5815.88368232633, 5835.94164058354, 5807.361190269067, 5819.70901454934, 5831.737571809279, 5851.0, 5885.028970219952, 5689.487946084872, 5811.535077193815, 5870.090136028923, 5873.177755114288, 5904.321003084614, 5896.528277737771, 5907.940920590825, 5914.497267732205, 5922.911156332659, 5974.2233509643465, 4482.21561226784, 4494.505604383515, 4499.932501012488, 4504.81980720774, 4534.591886730144, 3907.7069219808627, 3962.8612998544913, 3971.6425521703186, 3994.1811928554575, 4057.69567282455, 5586.944130558723, 5601.019821531216, 5603.8599035023635, 5606.299212598426, 5693.772249110072, 5901.17383566301, 5918.911216331759, 5921.467067963904, 5947.851303717355, 5966.522678185822, 5492.038893193675, 5606.21512988182, 5611.7474713637985, 5614.101743720985, 5618.297712785902, 4911.7298548580175, 4949.82675606352, 4973.055119527278, 4981.825636102719, 5006.574441172468, 6068.4538391544975, 6150.753969841246, 6152.446279834837, 6154.261488621304, 6154.569180157346, 5810.099434587646, 5889.646621202656, 5933.9109913352195, 5964.224650795369, 5977.9103313451205, 6117.908231376444, 6128.32588415265, 6208.689565521616, 6215.502759779297, 6224.221972253468, 5872.265966754156, 5895.0, 5902.704864756659, 5907.793227237198, 5923.0, 5742.5405967521665, 5855.0, 5865.589408741347, 5910.852228694145, 5998.520118390606, 5709.8287051388525, 5739.8852022960145, 5741.311042674905, 5744.3681195067675, 5804.158397032322, 5714.285714285715, 5767.5674324425, 5772.9711351442975, 5773.913391299218, 5785.797497087582, 5515.751791169327, 5617.634853734494, 5641.717914104361, 5660.547156227574, 5671.801486948102, 5644.238027866186, 5664.915026274527, 5723.8569035774435, 5741.799037033684, 5759.827205183851, 5680.0, 5683.2895888014, 5687.374388817144, 5694.544436445157, 5707.0], "value": 5422.435983667812, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.8276241271238, 641.6535071061627, 657.5791493444196, 659.2846761264028, 659.6207180870999, 43402.0, 44775.77612111939, 45158.32262516061, 47578.762106189504, 47871.76064119674, 44518.777406112924, 44952.0, 45014.0, 45142.0, 45348.0, 8770.605322760475, 8897.33270004749, 8951.910480895205, 8978.326625503081, 8998.460092394445, 8887.20015198632, 8969.103089691043, 8970.327225458084, 8994.640214391417, 9003.95498022509, 8970.50662213578, 9046.909530904673, 9047.140521650466, 9057.320700947423, 9089.181973622373, 8991.55042247885, 9015.188633023026, 9031.503267320328, 9068.7279381618, 9071.63713451461, 8961.059088795648, 8993.415427997159, 9058.456492610465, 9058.682946096855, 9083.909160908372, 41506.792466037776, 41580.54468093633, 41739.7913010436, 42160.57839421628, 42240.57759422397, 3622.5366750609574, 3740.382836831947, 3880.4955355803845, 3883.165119499321, 4367.10474352757, 31632.683673163203, 31990.9217248722, 32195.839020804746, 32474.0, 32798.836005820056, 4437.600615944548, 4495.235809912323, 4563.77181140945, 4655.348251244828, 4686.039361930796, 340843.0, 343143.0, 343256.0, 343914.0, 344142.0, 35038.64961350405, 57694.134587981214, 57981.4201857976, 57983.130253046234, 58044.70977645085, 30725.0, 31189.688103119133, 31230.843845780626, 31571.52642710361, 31612.364578073815, 14767.40930362795, 14835.480758173411, 14972.47596334123, 14972.775408368883, 14997.325120369609, 10872.728181795519, 10936.507857146447, 10939.07017903487, 10940.12479001678, 11034.944825275983, 8407.201315874981, 8473.279771219515, 8506.74479765608, 8518.361122915681, 8582.656693732306, 3304.140923359944, 3318.8008719476907, 3333.71663408613, 3342.19787251058, 3346.782459140148, 1080.2330345454816, 1179.4279774309452, 1200.5857978997233, 1225.08730995409, 1235.4625737804083, 31698.0, 31751.206219844225, 32163.356732865213, 32206.0, 32615.51076733851, 1100.4839537677044, 1163.7672465506932, 1170.3446070200544, 1178.3460179600233, 1254.8745125487378, 16687.249073791707, 17136.22886970089, 17296.740548891776, 17366.13169341528, 17683.823161768476, 583391.0, 584327.0, 586001.0, 587954.0, 589971.0, 59477.40522594805, 60417.0, 60442.0, 60450.69774651099, 60579.69710151421, 1227.3249712658003, 1228.975420491585, 1233.734747029393, 1277.5847849448967, 1373.368250604733, 31412.842935785175, 31882.0, 32071.83964080258, 32188.678113218568, 32566.34867302688, 51278.0, 51776.22335664893, 52122.47877521176, 52183.478165217864, 52226.73886630542, 452469.0, 458041.0, 460163.0, 460501.0, 461556.0, 27651.44697106087, 28055.0180743673, 28239.15282541527, 28414.573781392883, 28500.42999140047, 49764.0, 50123.74938125286, 50128.498715012385, 50671.0, 51433.74283128561, 40132.59867401289, 40251.396229056, 40378.59621403748, 41421.0, 41770.53803116998, 34538.0, 35041.824790875886, 35106.47340289847, 35108.824455877555, 35467.29065418729, 35170.64829351674, 42187.578124218366, 43234.13531729285, 43414.782926085165, 45101.77449112865, 35054.64945350514, 37080.0, 37372.81313593415, 37452.0, 38075.428868566436, 28992.275193119498, 29601.407971840872, 29954.85022574873, 30039.69960300369, 30109.397812044073], "value": 19064.18252912864, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.2536681771905, 404.75714571257265, 408.03906799487225, 408.5179488203919, 421.95147558030817, 18118.547036324082, 19471.221151153935, 19865.801341986575, 19903.502412439695, 19976.0, 18501.7224741629, 18897.149628266725, 19092.809071909276, 19171.520711982208, 19188.0, 5582.972085139579, 5618.8595285118, 5828.329742079652, 5830.3586605473365, 5833.3874943130995, 5748.223989761371, 5777.277840269966, 5786.103154011135, 5787.045137552299, 5806.7096645167785, 5464.562834973192, 5672.68800215988, 5720.427957204288, 5748.223989761371, 5753.942460575404, 5484.451554844523, 5673.29083864519, 5680.4319568043275, 5733.312002559678, 5737.483626473596, 5124.590032797404, 5135.897282054375, 5149.768260428253, 5151.150060240056, 5151.381834179922, 23034.42413939648, 23144.7685523146, 23693.644595331083, 23737.16919907795, 24008.039678413017, 2384.7972922301624, 2490.7509249074947, 2498.475320182764, 2633.6049592561076, 2939.6325459317586, 15013.774793378108, 15039.624009399744, 15066.698666026618, 15368.231588420535, 15480.22598870052, 2016.3245312820222, 2019.5153163240864, 2027.833995452606, 2054.900628163925, 2086.2072412483158, 77995.22004779993, 78513.0, 78624.0, 79527.20472795256, 79570.6021469889, 10569.63006294776, 10605.82580570981, 10884.67345979606, 10966.519519864716, 11174.44127793607, 15222.543323700307, 15229.847701523064, 15302.846971530365, 15316.157611331484, 15346.15596142223, 7593.202713715091, 7634.198409166957, 7728.111267204231, 7839.0, 7928.286454219148, 7151.463640227003, 7196.892046619305, 7326.084239470067, 7328.193898671142, 7386.926130738624, 6604.603723776589, 6666.733330666719, 6675.9332406676285, 6746.156730408699, 6800.31996800316, 1964.1946801811189, 1975.1210711233364, 1997.500624843789, 1997.5705223376754, 2023.2817349840889, 999.6900960702205, 1035.5650626736788, 1069.315637991686, 1092.5848177692426, 1166.8191430328313, 19768.90115549442, 19915.502112447306, 19945.501362465766, 20136.684281307836, 20297.0, 1025.0529727034775, 1033.9379637221791, 1075.086176749772, 1120.9047230985295, 1163.0, 10867.184961127947, 11419.200655954004, 11536.711582210512, 11633.59282425111, 11753.529858805552, 456029.0, 467273.0, 482000.0, 487085.0, 487383.0, 79466.60266698629, 79548.60225698835, 80541.0, 80940.0, 81702.0, 1055.4406164732704, 1055.593596465351, 1057.3761480726255, 1058.4654749351528, 1060.4538662588773, 17502.562435939202, 17504.562385939946, 17633.647327053644, 17746.29014839392, 17890.0, 38398.0, 38450.42324365081, 38604.0, 38807.805960970014, 40164.0, 53713.0, 55425.722871385384, 56202.718986404805, 60796.39203608084, 62214.68892655508, 7570.470067095251, 7643.464957452925, 8554.700585479479, 9066.138716821892, 9088.727338179866, 10209.438480883622, 12117.394130293274, 13058.738825223632, 13215.60353189406, 13444.126131801402, 12201.816972745593, 12215.938920305696, 12522.87477125217, 12681.365931703562, 12709.93645031769, 12187.451564679433, 12212.633620991384, 12213.206141600767, 12252.0, 12328.691782705146, 12242.938785306016, 12520.123591348882, 12569.183003104768, 12620.674829142808, 12835.486580537048, 7328.413726901942, 7712.267334603203, 8459.873101903353, 8693.304535637008, 9183.540822958692, 11518.308901465938, 11734.471948762497, 11737.823932641188, 11960.58137965167, 12122.818157727464], "value": 9445.689105320043, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.8875289976802, 1510.8262549806773, 1634.8201697813238, 1831.166819097311, 1875.287390791499, 8271.958640206805, 8383.203595658419, 9021.684241051556, 9552.331336806426, 9577.329586928918, 8596.828063438728, 8698.695545655903, 8785.209331160195, 8854.335924805633, 8887.28901687865, 2350.9059637614473, 2404.4229384947575, 2404.483036147228, 2407.3861165402886, 2409.0965887792077, 2173.5544213436287, 2337.263761915, 2400.603900356439, 2403.6995375578053, 2416.0456619635233, 2387.4270175157926, 2391.079434417753, 2405.530921470314, 2410.4817464245184, 2412.601920683085, 2312.919047833326, 2338.5673650374733, 2353.670486131943, 2368.6802281691926, 2373.596488596943, 2299.482616411311, 2305.631099024148, 2308.699869017034, 2319.3158018384615, 2322.581935251654, 9114.86327705085, 9123.543822808899, 9125.224355929753, 9138.497382643953, 9146.95426522863, 5252.527272545489, 5370.624056316059, 5370.677759334452, 5383.0, 5404.027275090482, 3576.141725985745, 3599.5320608321013, 3636.254567813592, 3642.526471558707, 3652.926941461156, 1172.9589464368792, 1179.7935361311822, 1189.2567145534042, 1198.0595232742255, 2214.878181700006, 12543.372831358396, 12898.355082245944, 12921.160124591872, 12925.224486530838, 12935.935320323339, 4780.617550596014, 4859.1010663027455, 4863.2461968394955, 4867.58625516835, 4922.901541969212, 11195.160362972809, 11205.103591712643, 11207.775844483065, 11235.550577976954, 11242.94378528102, 5306.867328316745, 5325.733713314319, 5399.00118478075, 5413.7834486620095, 5428.809991650273, 4514.61625761814, 4923.655344125948, 4971.37857767779, 5047.87380315495, 5076.060928728197, 4210.642095421924, 4229.851955181615, 4291.699581029298, 4297.9055080342105, 4327.394164816928, 1277.2208952538945, 1343.8387393512842, 1344.126317893377, 1346.6498710335384, 1353.8713822186876, 1012.1295685710284, 1018.0837246478229, 1032.3496197395743, 1037.9532921018572, 1063.112301228483, 6029.427204415573, 6044.365341639153, 6117.877642447215, 6246.656433896179, 6411.743530258737, 429.4009856250513, 437.1781051622992, 443.8135982887195, 449.46064722332676, 456.18798538601345, 3856.787876666754, 4057.857974970862, 4131.793410329532, 4134.0, 4155.709100362946, 11356.886431135583, 11608.6517404478, 11767.705807354714, 11779.057675385948, 11827.994620457186, 11344.0, 11542.0, 11581.478833452515, 11587.362695051854, 11606.593769218036, 7685.4620176587105, 7925.682972681144, 8520.105388934197, 8569.614367353359, 8694.217520423192, 5999.442652971798, 6097.817065488042, 6210.937890621036, 6259.3427690091885, 6331.746730130927, 10567.154627629925, 10884.945575272073, 11034.834477483004, 11060.446977650925, 11129.332240065622, 10359.171266298828, 10791.40647264408, 11027.944860275968, 11121.888781112086, 11192.832107518556, 7247.782566523013, 7708.8458230836195, 7902.960485197537, 8078.6364613593705, 8246.917530824854, 8386.916130838614, 8408.075111737582, 8414.326853851555, 8430.873536896828, 8461.788455288666, 7472.701091956261, 7712.537247765152, 7726.18875018115, 7780.805479863048, 7787.532748035136, 7535.13345965221, 7586.924130758843, 7662.540247585162, 7664.885026724715, 7786.532808031537, 6929.0, 6972.477064220305, 6974.4769142315545, 6975.720971161097, 7006.649667516705, 4795.568398844121, 4833.202521583899, 5058.696478211319, 5060.924086138784, 5064.898702026013, 5221.347331583552, 5231.738413079407, 5282.735863206901, 5334.626576139633, 5343.5457986071615], "value": 4706.843071608533, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.4107419993911, 304.6085779772991, 312.1836397819701, 312.676379946755, 316.9714725674689, 5635.295588051494, 5670.3479099903425, 5708.372079071299, 5728.369879313277, 5754.223179870716, 5636.408177141392, 5638.605297629168, 5639.830805075854, 5688.203651488795, 5702.0, 4120.896977575562, 4249.150169966004, 4341.78291085446, 4368.366586844905, 4382.12357528494, 4307.655387569002, 4335.848245311415, 4357.12857428514, 4384.714993525411, 4417.8292752420475, 4295.248331541968, 4327.4374331336885, 4354.303311470166, 4367.781610919457, 4373.125374925012, 4167.395727619493, 4286.97856510717, 4335.739855608642, 4348.564973558718, 4351.151525452538, 3783.5270591176104, 3806.4686983156166, 3818.1218319786326, 3820.9426858597144, 3823.560290566593, 5431.2396264522995, 5469.398366179717, 5472.577129946203, 5479.4520547945285, 5499.752511137009, 4871.244957031666, 4892.363992680965, 4902.112686615643, 4943.9258411123865, 5011.398632164127, 5860.941390586082, 5881.647101173943, 5884.823455296348, 5885.264341957255, 5905.911411328833, 4108.424820525129, 4120.763770868757, 4126.8761937141935, 4127.772972486512, 4152.273352163359, 5885.763409904252, 6195.783147589857, 6209.441150296495, 6221.471174950089, 6271.560990730651, 4123.649489793401, 4135.669146468275, 4144.171165766858, 4149.419081328617, 4155.8961025974595, 4155.439015732837, 4179.665626749914, 4184.979075104605, 4191.64371028466, 4206.789660516962, 4743.905121897543, 4807.543283388072, 4817.590504807131, 4821.855344339676, 4857.344258525124, 5961.791337303173, 5985.34161242263, 6004.759809607567, 6014.037753959433, 6033.336333003366, 1463.1733070814955, 1468.155810409019, 1469.390203065737, 1475.129673492623, 1477.697072100217, 892.6607889002267, 908.9500077495801, 909.6907051602354, 912.780932576177, 921.7234829551107, 5077.289179514871, 5079.263506791494, 5131.87170320745, 5133.383993920754, 5206.661566998133, 5319.972625868594, 5362.544183744425, 5428.185772134132, 5494.340679118452, 5515.227868098469, 5097.0, 5121.2574176744165, 5254.42201357858, 5730.541556675456, 5769.1538707614, 3265.297960938362, 3303.9504407433906, 3304.7686661933913, 3308.652591477908, 3310.851011704431, 6150.846228844314, 6288.9056664150075, 6343.333949935282, 6396.008618664115, 6428.5178611604315, 6251.937480625226, 6269.185005949289, 6296.244450665949, 6297.433231009231, 6300.558960872787, 6253.906191407133, 6323.30443651198, 6329.461995730322, 6421.711023003976, 6449.774257900951, 5909.438603332676, 6094.141286907536, 6129.601575897553, 6158.476529494864, 6168.537359697951, 6041.066858605204, 6076.848078798065, 6141.263048434216, 6145.8156255312415, 6168.290646575701, 6070.332263450929, 6332.683365831782, 6356.841078973062, 6398.5201109916015, 6405.0, 4107.445494858275, 4177.394277829637, 4179.582041795796, 4202.0, 4237.427947227085, 5925.288965324016, 5955.344912059757, 6243.37566243372, 6259.467945224706, 6268.780592679234, 5944.375840536854, 5974.133750606225, 5974.1934838796205, 5978.880422391615, 6002.909956350745, 5901.527877769682, 5906.143609176559, 5941.2176347096565, 5948.762049518144, 5987.31145918225, 5637.408072152365, 5848.356680765198, 5854.707264636666, 5860.882782344414, 5932.703364831655, 5924.229850119457, 6023.819285421444, 6024.246969128859, 6031.939680603138, 6066.787662431793, 5707.736389684814, 5893.528517718658, 5899.734511947058, 5938.317093534299, 5946.256717910262], "value": 4437.151783330025, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.6145588661556, 818.2308629887905, 833.4332653795417, 837.5895811052584, 876.6624849432974, 13229.073964822453, 13840.653983650402, 13913.304334783259, 13929.442822287096, 14127.71744565108, 13210.339483025858, 13227.404766785517, 13298.867011329883, 13312.334383280846, 13478.595642130751, 698.863721574292, 811.2495941254346, 834.1491678487939, 840.0717207485732, 842.1788755962948, 836.8953880764905, 838.0739283092187, 839.8530257204995, 845.0662018469595, 853.0957185383483, 870.9564521773885, 879.3580686099151, 880.7842078690697, 887.6848718704864, 891.745852432057, 867.1501928110424, 878.1569693094636, 880.3617377401397, 885.313881741649, 886.6187539358074, 637.6046850952439, 641.1728869758007, 646.1245013007355, 647.6502688548178, 649.574528683713, 12667.429965651569, 12728.299943503103, 12852.293123878182, 12904.0, 12928.612141635766, 13474.663133421645, 13584.864151358459, 13620.250886201255, 13904.930475347659, 13934.442622295095, 11288.661340159808, 11363.715907102305, 11492.482838272297, 11572.710682232928, 11605.477753501113, 3739.476473293741, 3863.150106976461, 3870.78710670913, 3884.6892248620043, 3913.4521167036355, 56136.43863561394, 56575.71712141413, 56692.43307566954, 56748.716256418455, 57237.71381143068, 11025.0, 11167.944160279147, 11399.48702308398, 11410.543578256942, 11434.714132146597, 20019.0591181914, 20159.798402015793, 20177.899110504353, 20224.191032358834, 20473.0, 8368.874466883002, 8379.078301386964, 8386.37102217324, 8440.662373505114, 8468.107580241634, 4650.325702773079, 4685.250359942461, 4739.857804265877, 4773.95226047742, 4883.096627123993, 3348.11275012122, 3432.673895979878, 3434.9313013739584, 3453.033150717803, 3463.428534291814, 587.3128439725531, 593.8782549577327, 596.242771679964, 598.7664810723821, 599.1372423709844, 632.3865850125371, 681.2336121862904, 742.7029188324714, 756.1153450462972, 767.7581561808013, 9301.209397201179, 9649.758756031155, 9661.082197191396, 9663.613455461844, 9737.659181928599, 731.378328420838, 743.5055687967549, 763.3511515212025, 767.4627760567626, 789.5736302396641, 4673.415823022122, 4692.859214223578, 4731.602226987582, 4783.378160839069, 4820.4456487503685, 64504.0, 68047.65976170187, 68872.0, 68999.0, 69005.30994689988, 63152.36847631557, 64062.67968660127, 64875.35124648787, 65346.34653653498, 65744.6712766433, 56277.43722562722, 56735.0, 56981.71509142428, 57150.42849571534, 57839.71080144656, 8719.084496127814, 8979.191872731486, 9084.318676099187, 9134.543272836465, 9200.171984521425, 38047.619523805515, 38140.427893581065, 38352.0, 38422.423663644506, 38676.41985370166, 45890.0, 48361.27458088202, 51161.48838511567, 51735.0, 51933.48066519287, 11908.76182476363, 11926.403679815801, 11936.820947685965, 12004.279743215435, 12378.938105309417, 12710.237385756884, 12792.0, 12804.935975320064, 13234.073614846868, 13617.319134043457, 11707.356095414834, 11923.463444144862, 11936.164468487123, 12024.218425802295, 12182.939085304517, 12366.690832729253, 12679.746405072032, 12688.619341419771, 12805.103642745291, 12894.355282236038, 11285.71785705364, 12107.818382724443, 12153.939230303791, 13286.468541258242, 13926.442942282196, 10619.415932123808, 10814.89185108139, 11496.137789665976, 11605.825912611486, 12264.018878489878, 11282.435878205893, 11315.151363647925, 11448.542058317575, 11642.476088576204, 11748.177627565989], "value": 6921.986323260375, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 104.0, 110.0, 111.0, 111.0, 105.0, 114.0, 110.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 133.0, 154.0, 215.0, 130.0, 153.0, 163.0, 131.0, 180.0, 126.0], "value": 153.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 163.0, 164.0, 166.0, 177.0, 166.0, 165.0, 165.0, 164.0], "value": 166.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 155.0, 76.0, 77.0, 74.0, 76.0, 160.0, 76.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 182.0, 92.0, 93.0, 92.0, 147.0, 94.0, 91.0, 150.0], "value": 112.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 97.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 56.0, 55.0, 56.0, 55.0, 60.0, 112.0, 53.0, 54.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 59.0, 58.0, 58.0, 58.0, 59.0, 58.0, 59.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 77.0, 78.0, 80.0, 85.0, 81.0, 80.0, 80.0, 78.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 126.0, 131.0, 121.0, 126.0, 130.0, 122.0, 194.0, 140.0], "value": 133.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 160.0, 159.0, 161.0, 160.0, 160.0, 161.0, 161.0, 159.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 71.0, 62.0, 62.0, 61.0, 62.0], "value": 63.7, "unit": "score"}]}]} 12:02:42 INFO - Return code: 0 12:02:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:02:42 ERROR - # TBPL SUCCESS # 12:02:42 INFO - Running post-action listener: _resource_record_post_action 12:02:42 INFO - ##### 12:02:42 INFO - ##### Finished run-tests step (success) 12:02:42 INFO - ##### 12:02:42 INFO - Running post-run listener: _resource_record_post_run 12:02:42 INFO - Total resource usage - Wall time: 1194s; CPU: 14.0%; Read bytes: 258048; Write bytes: 552038400; Read time: 52; Write time: 1643140 12:02:42 INFO - TinderboxPrint: CPU usage
13.5% 12:02:42 INFO - TinderboxPrint: I/O read bytes / time
258,048 / 52 12:02:42 INFO - TinderboxPrint: I/O write bytes / time
552,038,400 / 1,643,140 12:02:42 INFO - TinderboxPrint: CPU idle
8,237.6 (86.5%) 12:02:42 INFO - TinderboxPrint: CPU user
1,218.2 (12.8%) 12:02:42 INFO - TinderboxPrint: Swap in / out
0 / 0 12:02:42 INFO - install - Wall time: 17s; CPU: 20.0%; Read bytes: 0; Write bytes: 265474048; Read time: 0; Write time: 1204028 12:02:42 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 258048; Write bytes: 284389376; Read time: 52; Write time: 438784 12:02:42 INFO - Running post-run listener: _upload_blobber_files 12:02:42 INFO - Blob upload gear active. 12:02:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:02:42 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 12:02:42 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'] 12:02:42 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 12:02:43 INFO - (blobuploader) - INFO - Open directory for files ... 12:02:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:02:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:02:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:02:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:02:46 INFO - (blobuploader) - INFO - Done attempting. 12:02:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:02:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:02:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:02:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:02:47 INFO - (blobuploader) - INFO - Done attempting. 12:02:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:02:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:02:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:02:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:02:48 INFO - (blobuploader) - INFO - Done attempting. 12:02:48 INFO - (blobuploader) - INFO - Iteration through files over. 12:02:48 INFO - Return code: 0 12:02:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:02:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:02:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b291212b313247f6e77efbae0d952e07421d1556800fe0b4ee11d62fc59d275e03f0be79856fe23f4b50a9fcb219373ec66229a905db297195ddfde4e848cfdc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1653184682d3a949d4967e597bc2f725288114e7fb65cf47c3e649010b36928a619c010133dcc54a84ddc0a62ba4b738608af21774a39732dadafef44241b237", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f06ac3ba78510c46f3bdaf638586a728599f729fceaa0a0d799b2b69084d2af2dbbe5d5d412abfe3b53cca3916e8eeab44b05523e38035ab47b63254b65520ec"} 12:02:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:02:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:02:48 INFO - Contents: 12:02:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b291212b313247f6e77efbae0d952e07421d1556800fe0b4ee11d62fc59d275e03f0be79856fe23f4b50a9fcb219373ec66229a905db297195ddfde4e848cfdc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1653184682d3a949d4967e597bc2f725288114e7fb65cf47c3e649010b36928a619c010133dcc54a84ddc0a62ba4b738608af21774a39732dadafef44241b237", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f06ac3ba78510c46f3bdaf638586a728599f729fceaa0a0d799b2b69084d2af2dbbe5d5d412abfe3b53cca3916e8eeab44b05523e38035ab47b63254b65520ec"} 12:02:48 INFO - Running post-run listener: copy_logs_to_upload_dir 12:02:48 INFO - Copying logs to upload dir... 12:02:48 INFO - mkdir: /builds/slave/test/build/upload/logs 12:02:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.409291 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-17 12:02:48.294814) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 12:02:48.297908) ========= 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=df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685 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/b291212b313247f6e77efbae0d952e07421d1556800fe0b4ee11d62fc59d275e03f0be79856fe23f4b50a9fcb219373ec66229a905db297195ddfde4e848cfdc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1653184682d3a949d4967e597bc2f725288114e7fb65cf47c3e649010b36928a619c010133dcc54a84ddc0a62ba4b738608af21774a39732dadafef44241b237", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f06ac3ba78510c46f3bdaf638586a728599f729fceaa0a0d799b2b69084d2af2dbbe5d5d412abfe3b53cca3916e8eeab44b05523e38035ab47b63254b65520ec"} build_url:https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/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/b291212b313247f6e77efbae0d952e07421d1556800fe0b4ee11d62fc59d275e03f0be79856fe23f4b50a9fcb219373ec66229a905db297195ddfde4e848cfdc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1653184682d3a949d4967e597bc2f725288114e7fb65cf47c3e649010b36928a619c010133dcc54a84ddc0a62ba4b738608af21774a39732dadafef44241b237", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f06ac3ba78510c46f3bdaf638586a728599f729fceaa0a0d799b2b69084d2af2dbbe5d5d412abfe3b53cca3916e8eeab44b05523e38035ab47b63254b65520ec"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 12:02:48.322264) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 12:02:48.322645) ========= 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=df17445c3590ff7897617a0e00000225-1463510531.921498-2000320685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 12:02:48.406429) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 12:02:48.406759) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 12:02:48.407055) ========= ========= Total master_lag: 0.17 =========