builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1463267477.74 results: success (0) buildid: 20160514133002 builduid: 958b083be23a4962b05c5f688c8c95cf revision: 403912ca555eb65f814b18ecf38ad8e8e98569f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 16:11:17.741161) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 16:11:17.741868) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 16:11:17.742152) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 16:11:17.758914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 16:11:17.759206) ========= 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=33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-14 16:11:19-- 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% 40.3M=0s 2016-05-14 16:11:19 (40.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120041 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 16:11:17.892600) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 16:11:17.892906) ========= 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=33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013856 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 16:11:17.943412) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 16:11:17.943809) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 403912ca555eb65f814b18ecf38ad8e8e98569f5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 403912ca555eb65f814b18ecf38ad8e8e98569f5 --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=33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-14 16:11:19,876 truncating revision to first 12 chars 2016-05-14 16:11:19,876 Setting DEBUG logging. 2016-05-14 16:11:19,876 attempt 1/10 2016-05-14 16:11:19,876 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/403912ca555e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-14 16:11:20,206 unpacking tar archive at: mozilla-central-403912ca555e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.587787 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 16:11:18.544383) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 16:11:18.544714) ========= script_repo_revision: 403912ca555eb65f814b18ecf38ad8e8e98569f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 16:11:18.545140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 16:11:18.545417) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 16:11:18.553725) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-14 16:11:18.553994) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:11:20 INFO - MultiFileLogger online at 20160514 16:11:20 in /builds/slave/test 16:11:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:11:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:11:20 INFO - {'append_to_log': False, 16:11:20 INFO - 'base_work_dir': '/builds/slave/test', 16:11:20 INFO - 'blob_upload_branch': 'Firefox', 16:11:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:11:20 INFO - 'branch': 'Firefox', 16:11:20 INFO - 'buildbot_json_path': 'buildprops.json', 16:11:20 INFO - 'config_files': ('talos/linux_config.py',), 16:11:20 INFO - 'default_actions': ('clobber', 16:11:20 INFO - 'read-buildbot-config', 16:11:20 INFO - 'download-and-extract', 16:11:20 INFO - 'populate-webroot', 16:11:20 INFO - 'create-virtualenv', 16:11:20 INFO - 'install', 16:11:20 INFO - 'run-tests'), 16:11:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:11:20 INFO - 'download_minidump_stackwalk': True, 16:11:20 INFO - 'download_symbols': 'ondemand', 16:11:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:11:20 INFO - 'tooltool.py': '/tools/tooltool.py', 16:11:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:11:20 INFO - '/tools/misc-python/virtualenv.py')}, 16:11:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:11:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:11:20 INFO - 'installer_path': 'installer.exe', 16:11:20 INFO - 'log_level': 'info', 16:11:20 INFO - 'log_name': 'talos', 16:11:20 INFO - 'log_to_console': True, 16:11:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:11:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:11:20 INFO - 'opt_config_files': (), 16:11:20 INFO - 'pip_index': False, 16:11:20 INFO - 'sps_profile': False, 16:11:20 INFO - 'sps_profile_interval': 0, 16:11:20 INFO - 'suite': 'dromaeojs-e10s', 16:11:20 INFO - 'system_bits': '32', 16:11:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:11:20 INFO - 'title': 'talos-linux64-ix-063', 16:11:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:11:20 INFO - 'use_talos_json': True, 16:11:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:11:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:11:20 INFO - 'work_dir': 'build'} 16:11:20 INFO - ##### 16:11:20 INFO - ##### Running clobber step. 16:11:20 INFO - ##### 16:11:20 INFO - Running pre-action listener: _resource_record_pre_action 16:11:20 INFO - Running main action method: clobber 16:11:20 INFO - rmtree: /builds/slave/test/build 16:11:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:11:21 INFO - Running post-action listener: _resource_record_post_action 16:11:21 INFO - ##### 16:11:21 INFO - ##### Finished clobber step (success) 16:11:21 INFO - ##### 16:11:21 INFO - ##### 16:11:21 INFO - ##### Running read-buildbot-config step. 16:11:21 INFO - ##### 16:11:21 INFO - Running pre-action listener: _resource_record_pre_action 16:11:21 INFO - Running main action method: read_buildbot_config 16:11:21 INFO - Using buildbot properties: 16:11:21 INFO - { 16:11:21 INFO - "project": "", 16:11:21 INFO - "product": "firefox", 16:11:21 INFO - "script_repo_revision": "production", 16:11:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:11:21 INFO - "repository": "", 16:11:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 16:11:21 INFO - "buildid": "20160514133002", 16:11:21 INFO - "pgo_build": "True", 16:11:21 INFO - "basedir": "/builds/slave/test", 16:11:21 INFO - "buildnumber": 200, 16:11:21 INFO - "slavename": "talos-linux64-ix-063", 16:11:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:11:21 INFO - "platform": "ubuntu64_hw", 16:11:21 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 16:11:21 INFO - "branch": "mozilla-central", 16:11:21 INFO - "repo_path": "mozilla-central", 16:11:21 INFO - "revision": "403912ca555eb65f814b18ecf38ad8e8e98569f5", 16:11:21 INFO - "stage_platform": "linux64-pgo", 16:11:21 INFO - "builduid": "958b083be23a4962b05c5f688c8c95cf", 16:11:21 INFO - "slavebuilddir": "test" 16:11:21 INFO - } 16:11:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 16:11:21 INFO - Running post-action listener: _resource_record_post_action 16:11:21 INFO - ##### 16:11:21 INFO - ##### Finished read-buildbot-config step (success) 16:11:21 INFO - ##### 16:11:21 INFO - ##### 16:11:21 INFO - ##### Running download-and-extract step. 16:11:21 INFO - ##### 16:11:21 INFO - Running pre-action listener: _resource_record_pre_action 16:11:21 INFO - Running main action method: download_and_extract 16:11:21 INFO - mkdir: /builds/slave/test/build/tests 16:11: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')]} 16:11:21 INFO - https://queue.taskcluster.net/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:11:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:11:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:11:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:11:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:11:23 INFO - Downloaded 1361 bytes. 16:11:23 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:11:23 INFO - Using the following test package requirements: 16:11:23 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:11:23 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:11:23 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:11:23 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:23 INFO - u'jsshell-linux-x86_64.zip'], 16:11:23 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:11:23 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:11:23 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:11:23 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:11:23 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:11:23 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:11:23 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:23 INFO - https://queue.taskcluster.net/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:11:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:11:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:11:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:11:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:11:25 INFO - Downloaded 24023644 bytes. 16:11:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:11:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:11:26 INFO - Return code: 0 16:11:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:26 INFO - https://queue.taskcluster.net/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:11:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:11:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:11:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:11:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:11:27 INFO - Downloaded 24023644 bytes. 16:11:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:11:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:11:29 INFO - Return code: 0 16:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:29 INFO - https://queue.taskcluster.net/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:11:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:11:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:11:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:11:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:11:30 INFO - Downloaded 10840194 bytes. 16:11:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:11:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:11:30 INFO - Return code: 0 16:11: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')]} 16:11:30 INFO - https://queue.taskcluster.net/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:11:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:11:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:11:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:11:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:11:32 INFO - Downloaded 58396911 bytes. 16:11:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:11:32 INFO - mkdir: /builds/slave/test/properties 16:11:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:11:32 INFO - Writing to file /builds/slave/test/properties/build_url 16:11:32 INFO - Contents: 16:11:32 INFO - build_url:https://queue.taskcluster.net/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:11:32 INFO - Running post-action listener: _resource_record_post_action 16:11:32 INFO - Running post-action listener: set_extra_try_arguments 16:11:32 INFO - ##### 16:11:32 INFO - ##### Finished download-and-extract step (success) 16:11:32 INFO - ##### 16:11:32 INFO - ##### 16:11:32 INFO - ##### Running populate-webroot step. 16:11:32 INFO - ##### 16:11:32 INFO - Running pre-action listener: _resource_record_pre_action 16:11:32 INFO - Running main action method: populate_webroot 16:11:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:11:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:11:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:11:32 INFO - '--tppagecycles', 16:11:32 INFO - '7'], 16:11:32 INFO - 'tests': ['tsvgm']}}, 16:11:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:11:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:11:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:11:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:11:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:11:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:11:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:32 INFO - 'talos_options': ['--disable-e10s'], 16:11:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:32 INFO - 'talos_options': ['--disable-e10s'], 16:11:32 INFO - 'tests': ['damp', 'tps']}, 16:11:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:32 INFO - 'tests': ['damp', 'tps']}, 16:11:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:11:32 INFO - 'tests': ['dromaeo_dom']}, 16:11:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:11:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:11:32 INFO - 'tests': ['a11yr', 16:11:32 INFO - 'ts_paint', 16:11:32 INFO - 'tpaint', 16:11:32 INFO - 'sessionrestore', 16:11:32 INFO - 'sessionrestore_no_auto_restore', 16:11:32 INFO - 'tabpaint']}, 16:11:32 INFO - 'other-e10s': {'tests': ['a11yr', 16:11:32 INFO - 'ts_paint', 16:11:32 INFO - 'tpaint', 16:11:32 INFO - 'sessionrestore', 16:11:32 INFO - 'sessionrestore_no_auto_restore', 16:11:32 INFO - 'tabpaint']}, 16:11:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:11:32 INFO - 'ts_paint', 16:11:32 INFO - 'tpaint', 16:11:32 INFO - 'sessionrestore', 16:11:32 INFO - 'sessionrestore_no_auto_restore', 16:11:32 INFO - 'tabpaint']}, 16:11:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:11:32 INFO - 'ts_paint', 16:11:32 INFO - 'tpaint', 16:11:32 INFO - 'sessionrestore', 16:11:32 INFO - 'sessionrestore_no_auto_restore', 16:11:32 INFO - 'tabpaint']}, 16:11:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:11:32 INFO - 'tests': ['a11yr', 16:11:32 INFO - 'ts_paint', 16:11:32 INFO - 'tpaint', 16:11:32 INFO - 'sessionrestore', 16:11:32 INFO - 'sessionrestore_no_auto_restore', 16:11:32 INFO - 'tabpaint']}, 16:11:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:11:32 INFO - 'tests': ['a11yr', 16:11:32 INFO - 'ts_paint', 16:11:32 INFO - 'tpaint', 16:11:32 INFO - 'sessionrestore', 16:11:32 INFO - 'sessionrestore_no_auto_restore', 16:11:32 INFO - 'tabpaint']}, 16:11:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:11:32 INFO - 'tests': ['tsvgx', 16:11:32 INFO - 'tsvgr_opacity', 16:11:32 INFO - 'tart', 16:11:32 INFO - 'tscrollx', 16:11:32 INFO - 'cart']}, 16:11:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:11:32 INFO - 'tsvgr_opacity', 16:11:32 INFO - 'tart', 16:11:32 INFO - 'tscrollx', 16:11:32 INFO - 'cart']}, 16:11:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:32 INFO - 'talos_options': ['--disable-e10s'], 16:11:32 INFO - 'tests': ['tp5o']}, 16:11:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:32 INFO - 'tests': ['tp5o']}, 16:11:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:32 INFO - 'talos_options': ['--disable-e10s', 16:11:32 INFO - '--xperf_path', 16:11:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:32 INFO - 'tests': ['tp5n']}, 16:11:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:32 INFO - 'talos_options': ['--xperf_path', 16:11:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:32 INFO - 'tests': ['tp5n']}}, 16:11:32 INFO - 'talos.zip': {'path': '', 16:11:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:11:32 INFO - Running post-action listener: _resource_record_post_action 16:11:32 INFO - ##### 16:11:32 INFO - ##### Finished populate-webroot step (success) 16:11:32 INFO - ##### 16:11:32 INFO - ##### 16:11:32 INFO - ##### Running create-virtualenv step. 16:11:32 INFO - ##### 16:11:32 INFO - Running pre-action listener: _resource_record_pre_action 16:11:32 INFO - Running main action method: create_virtualenv 16:11:32 INFO - Creating virtualenv /builds/slave/test/build/venv 16:11:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:11:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:11:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:11:33 INFO - Using real prefix '/usr' 16:11:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:11:33 INFO - Installing distribute.............................................................................................................................................................................................done. 16:11:35 INFO - Installing pip.................done. 16:11:35 INFO - Return code: 0 16:11:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:11: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')]} 16:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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')]} 16:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:35 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 0x7f09ff6e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db19c0>, '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 0x1db28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db2d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:11:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:11:35 INFO - Using env: {'DISPLAY': ':0', 16:11:35 INFO - 'HOME': '/home/cltbld', 16:11:35 INFO - 'LANG': 'en_US.UTF-8', 16:11:35 INFO - 'LANGUAGE': 'en_US:en', 16:11:35 INFO - 'LOGNAME': 'cltbld', 16:11:35 INFO - 'MAIL': '/var/mail/cltbld', 16:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:35 INFO - 'MOZ_NO_REMOTE': '1', 16:11:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:35 INFO - 'NO_EM_RESTART': '1', 16:11:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:35 INFO - 'PWD': '/builds/slave/test', 16:11:35 INFO - 'SHELL': '/bin/bash', 16:11:35 INFO - 'SHLVL': '1', 16:11:35 INFO - 'TERM': 'linux', 16:11:35 INFO - 'TMOUT': '86400', 16:11:35 INFO - 'USER': 'cltbld', 16:11:35 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293', 16:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:35 INFO - '_': '/tools/buildbot/bin/python'} 16:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:11:35 INFO - Cleaning up... 16:11:35 INFO - Return code: 0 16:11:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:11: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')]} 16:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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')]} 16:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:35 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 0x7f09ff6e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db19c0>, '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 0x1db28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db2d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:11:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:11:35 INFO - Using env: {'DISPLAY': ':0', 16:11:35 INFO - 'HOME': '/home/cltbld', 16:11:35 INFO - 'LANG': 'en_US.UTF-8', 16:11:35 INFO - 'LANGUAGE': 'en_US:en', 16:11:35 INFO - 'LOGNAME': 'cltbld', 16:11:35 INFO - 'MAIL': '/var/mail/cltbld', 16:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:35 INFO - 'MOZ_NO_REMOTE': '1', 16:11:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:35 INFO - 'NO_EM_RESTART': '1', 16:11:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:35 INFO - 'PWD': '/builds/slave/test', 16:11:35 INFO - 'SHELL': '/bin/bash', 16:11:35 INFO - 'SHLVL': '1', 16:11:35 INFO - 'TERM': 'linux', 16:11:35 INFO - 'TMOUT': '86400', 16:11:35 INFO - 'USER': 'cltbld', 16:11:35 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293', 16:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:35 INFO - '_': '/tools/buildbot/bin/python'} 16:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:35 INFO - Downloading/unpacking psutil>=3.1.1 16:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:11:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:37 INFO - Installing collected packages: psutil 16:11:37 INFO - Running setup.py install for psutil 16:11:38 INFO - building 'psutil._psutil_linux' extension 16:11:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:11:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:11:38 INFO - building 'psutil._psutil_posix' extension 16:11:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:11:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:11:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:38 INFO - Successfully installed psutil 16:11:38 INFO - Cleaning up... 16:11:38 INFO - Return code: 0 16:11:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:11: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')]} 16:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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')]} 16:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:38 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 0x7f09ff6e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db19c0>, '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 0x1db28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db2d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:11:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:11:38 INFO - Using env: {'DISPLAY': ':0', 16:11:38 INFO - 'HOME': '/home/cltbld', 16:11:38 INFO - 'LANG': 'en_US.UTF-8', 16:11:38 INFO - 'LANGUAGE': 'en_US:en', 16:11:38 INFO - 'LOGNAME': 'cltbld', 16:11:38 INFO - 'MAIL': '/var/mail/cltbld', 16:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:38 INFO - 'MOZ_NO_REMOTE': '1', 16:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:38 INFO - 'NO_EM_RESTART': '1', 16:11:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:38 INFO - 'PWD': '/builds/slave/test', 16:11:38 INFO - 'SHELL': '/bin/bash', 16:11:38 INFO - 'SHLVL': '1', 16:11:38 INFO - 'TERM': 'linux', 16:11:38 INFO - 'TMOUT': '86400', 16:11:38 INFO - 'USER': 'cltbld', 16:11:38 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293', 16:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:38 INFO - '_': '/tools/buildbot/bin/python'} 16:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:11:40 INFO - Installing collected packages: mozsystemmonitor 16:11:40 INFO - Running setup.py install for mozsystemmonitor 16:11:40 INFO - Successfully installed mozsystemmonitor 16:11:40 INFO - Cleaning up... 16:11:40 INFO - Return code: 0 16:11:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:40 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 0x7f09ff6e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db19c0>, '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 0x1db28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db2d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:11:40 INFO - Using env: {'DISPLAY': ':0', 16:11:40 INFO - 'HOME': '/home/cltbld', 16:11:40 INFO - 'LANG': 'en_US.UTF-8', 16:11:40 INFO - 'LANGUAGE': 'en_US:en', 16:11:40 INFO - 'LOGNAME': 'cltbld', 16:11:40 INFO - 'MAIL': '/var/mail/cltbld', 16:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:40 INFO - 'MOZ_NO_REMOTE': '1', 16:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:40 INFO - 'NO_EM_RESTART': '1', 16:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:40 INFO - 'PWD': '/builds/slave/test', 16:11:40 INFO - 'SHELL': '/bin/bash', 16:11:40 INFO - 'SHLVL': '1', 16:11:40 INFO - 'TERM': 'linux', 16:11:40 INFO - 'TMOUT': '86400', 16:11:40 INFO - 'USER': 'cltbld', 16:11:40 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293', 16:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:40 INFO - '_': '/tools/buildbot/bin/python'} 16:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:41 INFO - Downloading/unpacking blobuploader==1.2.4 16:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:42 INFO - Downloading blobuploader-1.2.4.tar.gz 16:11:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:11:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:11:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:43 INFO - Downloading docopt-0.6.1.tar.gz 16:11:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:11:43 INFO - Installing collected packages: blobuploader, requests, docopt 16:11:43 INFO - Running setup.py install for blobuploader 16:11:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:11:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:11:43 INFO - Running setup.py install for requests 16:11:44 INFO - Running setup.py install for docopt 16:11:44 INFO - Successfully installed blobuploader requests docopt 16:11:44 INFO - Cleaning up... 16:11:44 INFO - Return code: 0 16:11:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:44 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 0x7f09ff6e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db19c0>, '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 0x1db28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db2d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:11:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:11:44 INFO - Using env: {'DISPLAY': ':0', 16:11:44 INFO - 'HOME': '/home/cltbld', 16:11:44 INFO - 'LANG': 'en_US.UTF-8', 16:11:44 INFO - 'LANGUAGE': 'en_US:en', 16:11:44 INFO - 'LOGNAME': 'cltbld', 16:11:44 INFO - 'MAIL': '/var/mail/cltbld', 16:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:44 INFO - 'MOZ_NO_REMOTE': '1', 16:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:44 INFO - 'NO_EM_RESTART': '1', 16:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:44 INFO - 'PWD': '/builds/slave/test', 16:11:44 INFO - 'SHELL': '/bin/bash', 16:11:44 INFO - 'SHLVL': '1', 16:11:44 INFO - 'TERM': 'linux', 16:11:44 INFO - 'TMOUT': '86400', 16:11:44 INFO - 'USER': 'cltbld', 16:11:44 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293', 16:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:44 INFO - '_': '/tools/buildbot/bin/python'} 16:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:11:44 INFO - Running setup.py (path:/tmp/pip-yyWKZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:11:44 INFO - Running setup.py (path:/tmp/pip-NMwukL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:11:44 INFO - Running setup.py (path:/tmp/pip-N6WJVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:11:44 INFO - Running setup.py (path:/tmp/pip-4CgQIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:11:44 INFO - Running setup.py (path:/tmp/pip-HZO0TQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:11:44 INFO - Running setup.py (path:/tmp/pip-VXEnoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:11:44 INFO - Running setup.py (path:/tmp/pip-z68Hl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:11:44 INFO - Running setup.py (path:/tmp/pip-IoFc0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:11:45 INFO - Running setup.py (path:/tmp/pip-_siqTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:11:45 INFO - Running setup.py (path:/tmp/pip-toN5Dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:11:45 INFO - Running setup.py (path:/tmp/pip-tNgg3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:11:45 INFO - Running setup.py (path:/tmp/pip-nXNoks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:11:45 INFO - Running setup.py (path:/tmp/pip-eyS1vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:11:45 INFO - Running setup.py (path:/tmp/pip-x7wqWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:45 INFO - Running setup.py (path:/tmp/pip-3VdHLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:11:45 INFO - Running setup.py (path:/tmp/pip-O1NL6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:11:45 INFO - Running setup.py (path:/tmp/pip-nTwMrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:11:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:11:45 INFO - Running setup.py install for manifestparser 16:11:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:11:45 INFO - Running setup.py install for mozcrash 16:11:45 INFO - Running setup.py install for mozdebug 16:11:45 INFO - Running setup.py install for mozdevice 16:11:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:11:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:11:46 INFO - Running setup.py install for mozfile 16:11:46 INFO - Running setup.py install for mozhttpd 16:11:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:11:46 INFO - Running setup.py install for mozinfo 16:11:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:11:46 INFO - Running setup.py install for mozInstall 16:11:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:11:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:11:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:11:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:11:46 INFO - Running setup.py install for mozleak 16:11:46 INFO - Running setup.py install for mozlog 16:11:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:11:46 INFO - Running setup.py install for moznetwork 16:11:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:11:46 INFO - Running setup.py install for mozprocess 16:11:46 INFO - Running setup.py install for mozprofile 16:11:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:11:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:11:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:11:47 INFO - Running setup.py install for mozrunner 16:11:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:11:47 INFO - Running setup.py install for mozscreenshot 16:11:47 INFO - Running setup.py install for moztest 16:11:47 INFO - Running setup.py install for mozversion 16:11:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:11:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:11:47 INFO - Cleaning up... 16:11:47 INFO - Return code: 0 16:11:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:47 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 0x7f09ff6e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db19c0>, '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 0x1db28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db2d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:11:47 INFO - Using env: {'DISPLAY': ':0', 16:11:47 INFO - 'HOME': '/home/cltbld', 16:11:47 INFO - 'LANG': 'en_US.UTF-8', 16:11:47 INFO - 'LANGUAGE': 'en_US:en', 16:11:47 INFO - 'LOGNAME': 'cltbld', 16:11:47 INFO - 'MAIL': '/var/mail/cltbld', 16:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:47 INFO - 'MOZ_NO_REMOTE': '1', 16:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:47 INFO - 'NO_EM_RESTART': '1', 16:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:47 INFO - 'PWD': '/builds/slave/test', 16:11:47 INFO - 'SHELL': '/bin/bash', 16:11:47 INFO - 'SHLVL': '1', 16:11:47 INFO - 'TERM': 'linux', 16:11:47 INFO - 'TMOUT': '86400', 16:11:47 INFO - 'USER': 'cltbld', 16:11:47 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293', 16:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:47 INFO - '_': '/tools/buildbot/bin/python'} 16:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:11:47 INFO - Running setup.py (path:/tmp/pip-rRCEFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:11:47 INFO - Running setup.py (path:/tmp/pip-jX2XPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:11:47 INFO - Running setup.py (path:/tmp/pip-ytEbka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:11:47 INFO - Running setup.py (path:/tmp/pip-gK8mQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:11:47 INFO - Running setup.py (path:/tmp/pip-ODLvJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:11:48 INFO - Running setup.py (path:/tmp/pip-gkrnk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:11:48 INFO - Running setup.py (path:/tmp/pip-vnHIvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:11:48 INFO - Running setup.py (path:/tmp/pip-uLbA6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:11:48 INFO - Running setup.py (path:/tmp/pip-eyTUvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:11:48 INFO - Running setup.py (path:/tmp/pip-9L9cct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:11:48 INFO - Running setup.py (path:/tmp/pip-YPwO1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:11:48 INFO - Running setup.py (path:/tmp/pip-rRjAOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:11:48 INFO - Running setup.py (path:/tmp/pip-72Bxd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:11:48 INFO - Running setup.py (path:/tmp/pip-HC6LXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:48 INFO - Running setup.py (path:/tmp/pip-ZORXfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:11:48 INFO - Running setup.py (path:/tmp/pip-8AaJvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:11:48 INFO - Running setup.py (path:/tmp/pip-Djfy7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:11:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:50 INFO - Downloading blessings-1.6.tar.gz 16:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:11:50 INFO - Installing collected packages: blessings 16:11:50 INFO - Running setup.py install for blessings 16:11:50 INFO - Successfully installed blessings 16:11:50 INFO - Cleaning up... 16:11:51 INFO - Return code: 0 16:11:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:11:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:11:51 INFO - Reading from file tmpfile_stdout 16:11:51 INFO - Current package versions: 16:11:51 INFO - argparse == 1.2.1 16:11:51 INFO - blessings == 1.6 16:11:51 INFO - blobuploader == 1.2.4 16:11:51 INFO - docopt == 0.6.1 16:11:51 INFO - manifestparser == 1.1 16:11:51 INFO - mozInstall == 1.12 16:11:51 INFO - mozcrash == 0.17 16:11:51 INFO - mozdebug == 0.1 16:11:51 INFO - mozdevice == 0.48 16:11:51 INFO - mozfile == 1.2 16:11:51 INFO - mozhttpd == 0.7 16:11:51 INFO - mozinfo == 0.9 16:11:51 INFO - mozleak == 0.1 16:11:51 INFO - mozlog == 3.2 16:11:51 INFO - moznetwork == 0.27 16:11:51 INFO - mozprocess == 0.22 16:11:51 INFO - mozprofile == 0.28 16:11:51 INFO - mozrunner == 6.11 16:11:51 INFO - mozscreenshot == 0.1 16:11:51 INFO - mozsystemmonitor == 0.3 16:11:51 INFO - moztest == 0.7 16:11:51 INFO - mozversion == 1.4 16:11:51 INFO - psutil == 3.1.1 16:11:51 INFO - requests == 1.2.3 16:11:51 INFO - wsgiref == 0.1.2 16:11:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:51 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 0x7f09ff6e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db19c0>, '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 0x1db28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db2d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:11:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:11:51 INFO - Using env: {'DISPLAY': ':0', 16:11:51 INFO - 'HOME': '/home/cltbld', 16:11:51 INFO - 'LANG': 'en_US.UTF-8', 16:11:51 INFO - 'LANGUAGE': 'en_US:en', 16:11:51 INFO - 'LOGNAME': 'cltbld', 16:11:51 INFO - 'MAIL': '/var/mail/cltbld', 16:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:51 INFO - 'MOZ_NO_REMOTE': '1', 16:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:51 INFO - 'NO_EM_RESTART': '1', 16:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:51 INFO - 'PWD': '/builds/slave/test', 16:11:51 INFO - 'SHELL': '/bin/bash', 16:11:51 INFO - 'SHLVL': '1', 16:11:51 INFO - 'TERM': 'linux', 16:11:51 INFO - 'TMOUT': '86400', 16:11:51 INFO - 'USER': 'cltbld', 16:11:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293', 16:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:51 INFO - '_': '/tools/buildbot/bin/python'} 16:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:11:51 INFO - Cleaning up... 16:11:51 INFO - Return code: 0 16:11:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:51 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 0x7f09ff6e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db19c0>, '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 0x1db28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db2d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:11:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:11:51 INFO - Using env: {'DISPLAY': ':0', 16:11:51 INFO - 'HOME': '/home/cltbld', 16:11:51 INFO - 'LANG': 'en_US.UTF-8', 16:11:51 INFO - 'LANGUAGE': 'en_US:en', 16:11:51 INFO - 'LOGNAME': 'cltbld', 16:11:51 INFO - 'MAIL': '/var/mail/cltbld', 16:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:51 INFO - 'MOZ_NO_REMOTE': '1', 16:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:51 INFO - 'NO_EM_RESTART': '1', 16:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:51 INFO - 'PWD': '/builds/slave/test', 16:11:51 INFO - 'SHELL': '/bin/bash', 16:11:51 INFO - 'SHLVL': '1', 16:11:51 INFO - 'TERM': 'linux', 16:11:51 INFO - 'TMOUT': '86400', 16:11:51 INFO - 'USER': 'cltbld', 16:11:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293', 16:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:51 INFO - '_': '/tools/buildbot/bin/python'} 16:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:51 INFO - Downloading/unpacking jsonschema 16:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:11:53 INFO - Downloading/unpacking functools32 (from jsonschema) 16:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:53 INFO - Downloading functools32-3.2.3-2.tar.gz 16:11:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:11:53 INFO - warning: no files found matching '*.txt' 16:11:53 INFO - no previously-included directories found matching 'build' 16:11:53 INFO - no previously-included directories found matching 'dist' 16:11:53 INFO - no previously-included directories found matching '.git*' 16:11:53 INFO - Installing collected packages: jsonschema, functools32 16:11:53 INFO - Running setup.py install for functools32 16:11:54 INFO - warning: no files found matching '*.txt' 16:11:54 INFO - no previously-included directories found matching 'build' 16:11:54 INFO - no previously-included directories found matching 'dist' 16:11:54 INFO - no previously-included directories found matching '.git*' 16:11:54 INFO - Successfully installed jsonschema functools32 16:11:54 INFO - Cleaning up... 16:11:54 INFO - Return code: 0 16:11:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:54 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 0x7f09ff6e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db19c0>, '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 0x1db28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db2d50>, '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': '33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:11:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:11:54 INFO - Using env: {'DISPLAY': ':0', 16:11:54 INFO - 'HOME': '/home/cltbld', 16:11:54 INFO - 'LANG': 'en_US.UTF-8', 16:11:54 INFO - 'LANGUAGE': 'en_US:en', 16:11:54 INFO - 'LOGNAME': 'cltbld', 16:11:54 INFO - 'MAIL': '/var/mail/cltbld', 16:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:54 INFO - 'MOZ_NO_REMOTE': '1', 16:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:54 INFO - 'NO_EM_RESTART': '1', 16:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:54 INFO - 'PWD': '/builds/slave/test', 16:11:54 INFO - 'SHELL': '/bin/bash', 16:11:54 INFO - 'SHLVL': '1', 16:11:54 INFO - 'TERM': 'linux', 16:11:54 INFO - 'TMOUT': '86400', 16:11:54 INFO - 'USER': 'cltbld', 16:11:54 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293', 16:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:54 INFO - '_': '/tools/buildbot/bin/python'} 16:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:54 INFO - Downloading/unpacking flake8 16:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:11:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:11:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:11:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:11:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:11:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:11:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:11:56 INFO - no previously-included directories found matching 'docs/_build' 16:11:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:11:56 INFO - Running setup.py install for pep8 16:11:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:11:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:11:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:11:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:11:57 INFO - no previously-included directories found matching 'docs/_build' 16:11:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:11:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:11:57 INFO - Cleaning up... 16:11:57 INFO - Return code: 0 16:11:57 INFO - Running post-action listener: _resource_record_post_action 16:11:57 INFO - Running post-action listener: _start_resource_monitoring 16:11:57 INFO - Starting resource monitoring. 16:11:57 INFO - ##### 16:11:57 INFO - ##### Finished create-virtualenv step (success) 16:11:57 INFO - ##### 16:11:57 INFO - ##### 16:11:57 INFO - ##### Running install step. 16:11:57 INFO - ##### 16:11:57 INFO - Running pre-action listener: _resource_record_pre_action 16:11:57 INFO - Running main action method: install 16:11:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:11:57 INFO - Reading from file tmpfile_stdout 16:11:57 INFO - Detecting whether we're running mozinstall >=1.0... 16:11:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:11:57 INFO - Reading from file tmpfile_stdout 16:11:57 INFO - Output received: 16:11:57 INFO - Usage: mozinstall [options] installer 16:11:57 INFO - Options: 16:11:57 INFO - -h, --help show this help message and exit 16:11:57 INFO - -d DEST, --destination=DEST 16:11:57 INFO - Directory to install application into. [default: 16:11:57 INFO - "/builds/slave/test"] 16:11:57 INFO - --app=APP Application being installed. [default: firefox] 16:11:57 INFO - mkdir: /builds/slave/test/build/application 16:11:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:12:14 INFO - Reading from file tmpfile_stdout 16:12:14 INFO - Output received: 16:12:14 INFO - /builds/slave/test/build/application/firefox/firefox 16:12:14 INFO - Running post-action listener: _resource_record_post_action 16:12:14 INFO - ##### 16:12:14 INFO - ##### Finished install step (success) 16:12:14 INFO - ##### 16:12:14 INFO - ##### 16:12:14 INFO - ##### Running run-tests step. 16:12:14 INFO - ##### 16:12:14 INFO - Running pre-action listener: _resource_record_pre_action 16:12:14 INFO - Running main action method: run_tests 16:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:12:14 INFO - Python 2.7.3 16:12:14 INFO - Return code: 0 16:12:14 INFO - grabbing minidump binary from tooltool 16:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:14 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 0x1db19c0>, '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 0x1db28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db2d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:12:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:12:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:12:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:12:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:12:14 INFO - Return code: 0 16:12:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:12:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:12:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:12:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:12:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:12:15 INFO - Return code: 0 16:12:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:12:15 INFO - Using env: {'DISPLAY': ':0', 16:12:15 INFO - 'HOME': '/home/cltbld', 16:12:15 INFO - 'LANG': 'en_US.UTF-8', 16:12:15 INFO - 'LANGUAGE': 'en_US:en', 16:12:15 INFO - 'LOGNAME': 'cltbld', 16:12:15 INFO - 'MAIL': '/var/mail/cltbld', 16:12:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:12:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:15 INFO - 'MOZ_NO_REMOTE': '1', 16:12:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:12:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:15 INFO - 'NO_EM_RESTART': '1', 16:12:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:15 INFO - 'PWD': '/builds/slave/test', 16:12:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:12:15 INFO - 'SHELL': '/bin/bash', 16:12:15 INFO - 'SHLVL': '1', 16:12:15 INFO - 'TERM': 'linux', 16:12:15 INFO - 'TMOUT': '86400', 16:12:15 INFO - 'USER': 'cltbld', 16:12:15 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293', 16:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:15 INFO - '_': '/tools/buildbot/bin/python'} 16:12:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:12:15 INFO - mozversion application_buildid: 20160514133002 16:12:15 INFO - mozversion application_changeset: 403912ca555eb65f814b18ecf38ad8e8e98569f5 16:12:15 INFO - mozversion application_display_name: Nightly 16:12:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:12:15 INFO - mozversion application_name: Firefox 16:12:15 INFO - mozversion application_remotingname: firefox 16:12:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:12:15 INFO - mozversion application_vendor: Mozilla 16:12:15 INFO - mozversion application_version: 49.0a1 16:12:15 INFO - mozversion platform_buildid: 20160514133002 16:12:15 INFO - mozversion platform_changeset: 403912ca555eb65f814b18ecf38ad8e8e98569f5 16:12:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:12:15 INFO - mozversion platform_version: 49.0a1 16:12:15 INFO - using testdate: 1463267535 16:12:15 INFO - actual date: 1463267535 16:12:15 INFO - starting webserver on 'localhost:55935' 16:12:15 INFO - SUITE-START | Running 2 tests 16:12:15 INFO - TEST-START | dromaeo_css 16:12:15 INFO - operating with platform_type : linux_ 16:12:15 INFO - Initialising browser for dromaeo_css test... 16:12:15 INFO - TEST-INFO | started process 13813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp__NudC/profile http://localhost:55935/getInfo.html) 16:12:19 INFO - PROCESS | 13813 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 16:12:19 INFO - PROCESS | 13813 | 16:12:19 INFO - PROCESS | 13813 | (process:13883): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:12:20 INFO - PROCESS | 13813 | __metrics Screen width/height:1600/1200 16:12:20 INFO - PROCESS | 13813 | colorDepth:24 16:12:20 INFO - PROCESS | 13813 | Browser inner width/height: 1024/697 16:12:20 INFO - PROCESS | 13813 | __metrics 16:12:21 ERROR - PROCESS | 13813 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 16:12:22 INFO - TEST-INFO | 13813: exit 0 16:12:22 INFO - Browser initialized. 16:12:22 INFO - Running cycle 1/1 for dromaeo_css test... 16:12:22 INFO - TEST-INFO | started process 13934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp__NudC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:24 INFO - PROCESS | 13934 | 16:12:24 INFO - PROCESS | 13934 | (process:13994): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:12:34 INFO - PROCESS | 13934 | RSS: Main: 163692544 16:12:34 INFO - PROCESS | 13934 | 16:13:23 INFO - PROCESS | 13934 | 1463267603871 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:15:32 INFO - PROCESS | 13934 | Cycle 1(1): loaded http://localhost:55935/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55935/tests/dromaeo/cssquery-ext.html) 16:15:33 INFO - PROCESS | 13934 | RSS: Main: 167325696 16:15:33 INFO - PROCESS | 13934 | 16:18:34 INFO - PROCESS | 13934 | Cycle 1(1): loaded http://localhost:55935/tests/dromaeo/cssquery-ext.html (next: http://localhost:55935/tests/dromaeo/cssquery-jquery.html) 16:18:35 INFO - PROCESS | 13934 | RSS: Main: 166412288 16:18:35 INFO - PROCESS | 13934 | 16:21:37 INFO - PROCESS | 13934 | Cycle 1(1): loaded http://localhost:55935/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55935/tests/dromaeo/cssquery-mootools.html) 16:21:38 INFO - PROCESS | 13934 | RSS: Main: 167407616 16:21:38 INFO - PROCESS | 13934 | 16:24:39 INFO - PROCESS | 13934 | Cycle 1(1): loaded http://localhost:55935/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55935/tests/dromaeo/cssquery-prototype.html) 16:24:40 INFO - PROCESS | 13934 | RSS: Main: 165601280 16:24:40 INFO - PROCESS | 13934 | 16:27:42 INFO - PROCESS | 13934 | Cycle 1(1): loaded http://localhost:55935/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55935/tests/dromaeo/cssquery-yui.html) 16:27:43 INFO - PROCESS | 13934 | RSS: Main: 166670336 16:27:43 INFO - PROCESS | 13934 | 16:30:45 INFO - PROCESS | 13934 | Cycle 1(1): loaded http://localhost:55935/tests/dromaeo/cssquery-yui.html (next: http://localhost:55935/tests/dromaeo/cssquery-dojo.html) 16:30:46 INFO - PROCESS | 13934 | RSS: Main: 168919040 16:30:46 INFO - PROCESS | 13934 | 16:30:46 INFO - PROCESS | 13934 | __start_tp_report 16:30:46 INFO - PROCESS | 13934 | _x_x_mozilla_page_load 16:30:46 INFO - PROCESS | 13934 | _x_x_mozilla_page_load_details 16:30:46 INFO - PROCESS | 13934 | |i|pagename|runs| 16:30:46 INFO - PROCESS | 13934 | |0;dojo.html;3180.5706229658995;3187.7131058204786;3210.6468288488263;3215.4212241796467;3216.7909085909423;5421.539169170615;5491.780328786849;5534.972325138378;5553.555715542752;5573.526250268722;5387.730613469331;5541.390447050831;5564.443555644443;5599.552035837133;5605.915911261324;4967.4287456942375;4980.352554167953;5091.592672586185;5095.566876815456;5103.055934652083;4989.525995030466;5172.017316709832;5175;5176.66351687141;5177.767000484969;4953.083679519283;4994.525520075587;5021.748912554358;5038.992201559703;5046.84859454217;5024.874378140539;5034.320366750479;5034.320366750515;5035.3454050973505;5079.263506791532;5012.874678133039;5020.272060551236;5032.169692000815;5033.697978121324;5042.924356134661;5360.437154098802;5385.7576409061685;5386.973065134688;5421.159720243369;5429.4027656957705;5886.529077673776;5890.381509941437;5894.528437724972;5895.852603684899;5902.61632993854;5763.6541807491685;5866.2960444746905;5924.496417804448;5941.405859414067;5956.612820166675;5486.588505862036;5522.30971128609;5550.861228469321;5552.056150454432;5601.29983752031;6052.152698622196;6052.818415447544;6055.969720151371;6056.242969628796;6075.878482430327;5646.774129034875;5665.518430933417;5722.341930677942;5827.59206855516;5828.5337173026055;5824.446677565625;5827.650340979555;5828.94171058284;5840.2991641003355;5874.148248503943;5692.459216374438;5800.303963524319;5807.564432667482;5881.05903055509;5928.911066334009;5900.586958912835;5935.970320148458;5965.701714914237;5990.191324171181;6029.125776762345;4466.3747075409465;4480.215962206601;4495.865124046284;4526.298423744259;4533.569310915458;3935.626115519021;3980.900477488028;3996.740211886276;4014.7189696721534;4036.6367026967714;5682.488576028178;5711.914321285184;5722.313322401255;5733.168690539848;5786.594938354359;6008.579399442085;6024.849378765566;6028.728707208186;6051.667158306335;6062.545309101747;5520.834374968757;5581.832545023656;5590.832275031756;5647.463490968352;5727.312722473246;5066.594672426197;5093.388793344749;5094.032133894548;5102.336696229467;5124.948750512447;6085.908711369333;6168;6175.104609831549;6181.536384771161;6181.629102253879;5744.253247077937;5844.444777746107;5887.676177810262;5900.5574581907385;5932.139839723302;6037.818865434044;6111.786087487095;6121.540884433596;6126.356732543019;6131.938680613137;5764.567657425626;5787.884242315215;5811.186433899342;5819.0689489681445;5855.473007429352;5850.561207909339;5866.090755932837;5915.40845915405;5938.168656388196;5946.226990491382;5727.742251598771;5764.567657425626;5770.047942089508;5774.769009239583;5780.855478613068;5665.49010589049;5746.42535746422;5750.942490575041;5751.9424805751405;5766.452187042224;5592.972035139798;5646.745896434588;5682.659040457585;5724.570657200643;5806.274215723035;5846.269216347957;5852.473277404883;5881.088431293157;5896.70516474166;5908.940910590839;5581.6930068846605;5675.659460432387;5730.5702072345575;5741;5745.425457454221 16:30:46 INFO - PROCESS | 13934 | |1;ext.html;591.9052951527754;612.1766224428144;633.5755044120439;634.6985182038533;636.2873581588622;42282.78858605707;43483.69548913534;43521.34717979233;43667.34498982518;45809.54190458095;45132;45141.548584514145;45583.31625025627;45623.543764562346;45693;8909.198172164504;9052.094790520929;9085.091490850928;9086.227670648002;9102.317326200528;8824.073472285414;8898;8966.955165224164;8970.416922900024;8973;8963.462192268453;8992.550372481383;9029.322800789934;9055.275577953747;9063.909360906373;8949.686760963368;8993.415427997159;9006.099390061006;9007.459552426842;9027.729168124966;8953.418027828171;8963;8974.326925480615;9021.774455638595;9035.774105647346;42065.369019464735;42208.3668744969;42271.15457690829;42414.57585424137;42486;3507.91230219244;3549.2546565221332;3641.271745650854;3766.227923275722;4108.424820525129;31887.362252754814;31972.360552788814;32617.184570385692;32768.67231327704;32837.17907052319;4219.556946520602;4348.9782551087355;4401.185780630593;4406.096750166208;4423.469183697976;348833;352982;353319;354035;355437;31929.201769955936;32735.83632081824;58567;58666.4133358661;58746;37668;37945.430818537745;38066.61933380631;38156.6184338153;38160;15828.208589570475;15868.2065896707;15910.840891591168;15971.44099956496;15990.200489975454;12959.481620735254;13043.804342934864;13061;13080.345982701017;13082.803757943639;8632.35257355701;8676.78308042304;8700.91299087001;8722.084181161013;8748.8687669685;3342.49862520619;3409.6931276185264;3411.8294085296134;3422.3839708852647;3431.262278610111;1032.6540608895955;1052.479022883662;1069.8341757027674;1142.4173671427632;1254.799232122856;32354.514682279783;32368;32719.18202044968;32764.836175819444;32872.3425531488;1093.4751319366749;1170.631251155883;1178.8762179971152;1204.5482943896038;1347.8584748601256;16577.50267491977;16742.330306787837;16781.580460488585;16855.57861053459;17012.064336461364;558194;559879;560477;563005;569158;57204;57965;58217.12674309804;58268.417315827144;58336.41663583395;1428.978565321521;1435.3397437179015;1435.5478024422273;1442.1779585636086;1454.8763355114934;30365.392692145593;30964.535531966587;31035;31395;31699.366012679155;50440.24339634835;50670.74664626653;50712.23931641102;50887.74556127196;51048.489515104375;440139.3909395879;440385;441163;442461;442744;28312.71687283101;28996.710032899402;29424;29551.704482954894;29554.113376598736;48973.75513122412;49214;49554.75222623864;49673.25490117579;50060;41654.583454166284;42848;42940.141197176505;43209.3518597215;43437;41458.58541414668;42166;42429;42716;43060.35409468798;36789.44815827711;40785.38821917733;41153.588464114975;42188;42520.36219456772;35639.28721425609;35773;35927;36708;36821.63178368182;28187.57718634263;28229;28584.57123143196;28904.421911562073;28930 16:30:46 INFO - PROCESS | 13934 | |2;jquery.html;388.69099066242336;389.80120138729256;390.9960900390995;399.46072801717673;418.5354256774981;13922.860771392283;18238.817611823877;19147.712784308245;19808.504787380305;19905.900470497647;18891.622167556674;19153.521161970923;19559.706604400944;20015.399538013884;20146.395608131745;5326.174442961347;5365.946340536603;5571.387147413781;5710.971445142768;5742.454466825645;5743.5118014968775;5746.569007324447;5769;5776.451237132465;5785;5535.197396377523;5719.056355701325;5820.679862607576;5849.824505264827;5850.912236316459;5729.140628905677;5741.712914354307;5752.395998420189;5777.1623114648355;5777.277840269945;4988.800447982113;5119.180931051052;5143.202803565416;5144.794208231666;5146.279520867081;22537.0985160595;23115.306540803802;23431.297061088193;23791.197257014843;23893.88053059741;2339.6607491913746;2375.10933399975;2464.7658472445087;2636.156429942419;2790.497710412125;9541.90458095424;14131.222782746945;14865.331060102213;15119.16844573548;15176.089434633957;1988.8508361872916;2038.2152871144715;2063.6388631989344;2074.5228597422524;2105.2736805801974;53838.192427114016;53885;54951;79901.20098798996;85119.57440212759;10699.518521666543;11044.392558409203;11177.49701263445;11182.496787644575;11307.434628268553;14697.92651036738;14744.262786860614;15292.923535382251;15381.384744610314;15416.229188540752;7746.651400686983;8127.024757029076;8168.714095006646;8169.754907352789;8292.875606865902;7671.731489397956;7672.232776722283;7682.807929801688;7690.307872291409;7855.764327070083;4790.760461976887;4792.856214313576;4872.220444728827;4874.4150701916;4897.2898929655;2007.417848823854;2056.979430205709;2062.752469703645;2070.927517536879;2103.6844473329124;926.7451450850936;1022.0494939706144;1033.3180101133366;1048.638219814163;1085.7122862441458;18955.431337059912;18963;19218;19301.80698193028;19507.31724389668;1028.681108856257;1036.228010132441;1048.5910494906839;1081.9621313254;1109.8180437833842;10685.358878467317;10962.725931851608;11018.889811101786;11118.722031949266;11169;406031;406765;407037;439421;469437;85968.14031859726;88891.11108888958;91158;92334.53832730794;94608;1078.681788872269;1089.9237053406343;1128.1595211567435;1136.9602063927723;1148.3856136966683;17127.275996044926;17261.827381726023;17277;17317.740233896755;17465.38871139504;39556.20887582174;39796.40305395479;40000.799995999834;40335.19329613333;40887.59112408838;56165;56871.71564142153;57033.714831425576;57137.42862571321;57494.13758793705;5436.103042998019;7265.600391978492;7749;8720.345974051845;8994.550272486218;7675.961620192087;11498.82751758741;13656.317184140951;13745.312734363442;13860.792088118485;12042.879571204176;12072.517099315928;12274.263544187377;12321.199122057038;12380.938095309466;11783.587574434854;11878.703032424259;11969.281843089442;12078.456469459072;12347.876521234673;9982.700518984442;12268;12307.20003199789;12319.876801231872;12337.136400452242;8949.015608283215;8997.955010225169;9021.909780902108;9121.179093881583;9178.67874624385;12048.51805927753;12180.57367992116;12209.267443953391;12213.267203967791;12296.938515307365 16:30:46 INFO - PROCESS | 13934 | |3;mootools.html;1474.5944865162082;1523.9161846098466;1682.6129990102277;1858.238122369827;1892.290391103337;7834.490758100719;8908.599113039912;8983.146601072896;9598.712038638843;9611.375260608065;8880.1563851434;9086.591103400346;9129.68046118386;9164.221041211506;9166.770830729236;2432.939176520588;2479.652848601197;2483.838550494212;2486.577281862079;2486.714027886789;2385.3321070100315;2398.5368924955765;2418.5767490689145;2454.7913427358694;2460.8031357491445;2423.503181847717;2443.8900249488815;2488.464980029293;2488.464980029293;2496.700395952488;2351.953380745569;2352.752960939102;2378.726446458662;2382.3567636738157;2393.9521209575796;2420.310211589706;2428.562858685436;2447.5227330670527;2447.7185123710824;2457.1891275878916;9158.725238242863;9190;9217.815643687089;9240.168384845329;9264.39781414206;5431.945680543223;5581.358143813432;5680.602357834953;5710.057840456361;5717.428257174291;3370.1406141433777;3388.491726241059;3409.3181363727354;3588.2644057968314;3620.746547741659;1088.6733979806027;1129.232122156933;1141.5890279499456;1178.8054970929873;1189.881011898812;13096.476140954446;13268.60194194166;13283.136596121221;13327.067105302633;13334;4914.655974081851;4935.037667654845;4963.6277279204205;5056.797728090909;5075.8984820303385;11124.888751112385;11155.163362747664;11186.216964812385;11217.775644487065;11232.775344493064;5510.256115424367;5580.441955804387;5581.832545023656;5614.775408983676;5730.1404789281105;4449.644028477714;5120.231965205175;5129.79480820763;5210.322658054429;5242.7378631068295;4198;4234.428352172479;4247.129338485664;4254.723442976197;4284.892877678083;1270.314030423561;1291.3607764156616;1295.9049603085377;1296.623979046085;1303.7197002644286;1002.0880998291666;1011.4790882695418;1021.4126877045728;1029.696239609302;1053.7260312318851;6253.5622506425025;6311.621302721851;6371.872562548723;6391.360863913572;6529.216494020748;491.1282473609372;494.54995953681976;494.71374426490837;511.03924621710945;511.1744532579857;4160.084781348099;4256.297710877732;4279.251131052053;4307.978460107679;4320.308750599889;11421.200515963968;11643.76712465746;11668.241564298294;11772.234804737836;11793.587224447103;11559.537618495335;11653.766924661459;11663.76672466546;11667.241629294069;11669.59156429521;8069.596520173968;8339.24946754795;8446.704365347183;8462.576871156418;8516.74449766508;5965.582409231486;6241.188645476059;6353.8729225416155;6451.2924933575405;6486.9351306488215;10379.377237365783;10548.736281593021;10594.152467802403;10697.304675196086;10874.184436167478;10480.213983951082;10858.45707714627;10890.564377425131;10908.672739817817;10981.341119532854;7975.202479752211;8640.870386944076;8727.301815854844;8846.071162527842;8882.467051976902;8893.688720894737;8984.146506081912;8989.775255618662;9039.819203616022;9062.50156241413;7984.161663025531;8090.150534193825;8167.469114507538;8248.628811703367;8334;7990.560519171501;8013.118556958613;8026.277635012877;8076.353891688534;8111.675532978615;7128.144622645108;7277.490575659653;7342.596157211191;7365.153007404003;7400;5586.86032849182;5660.490555849993;5683.3748287687495;5704.058830293121;5761.625494342854;5442.074847275893;5650.463205995424;5662.405447427961;5712.828615141552;5756.65460072397 16:30:46 INFO - PROCESS | 13934 | |4;prototype.html;343.8968309507148;349.27002564639906;349.66082899587406;352.8002901906613;355.34261616010383;5550.222968784368;5636.971815140919;5667.8583035424135;5683.204351390808;5714.371419143891;5585.664860108386;5588.580856435763;5590.987244591954;5595.300587426572;5614.9157762633595;4165.104502531947;4247.384129301249;4343.478782546099;4359.346098085281;4367.148406060819;4334;4336.392904993288;4355.695101342907;4363.912721745563;4364.519902810688;4371.388005679208;4371.956280437187;4373.606375426211;4388.100439409929;4398.252297109483;4254.319308910575;4348.804303806336;4351.891202719926;4352.455943007124;4353.717008394444;3830.751001184914;3838.9232215355537;3857.691384689246;3864.3623802072625;3871.4386413970096;5447.101228297326;5451.809186678487;5487.286652735119;5491.395946445888;5502.826383578504;4957.058158949788;4997.775100120503;5017.623678224148;5037.420696619863;5043.62172837035;5750.706091129462;5808.738606762664;5851.385604511507;5879.4713374522935;5907.995640741041;4257.531671516131;4267.487901451846;4277.657787377002;4283.935740963888;4302.365101261532;5974.761009559613;6116.785912493041;6160.722767475474;6168.660723660197;6208.472279856218;4352.455943007124;4354.869353919387;4368.08270263242;4379.1022840317655;4381.539938306432;4398.75806830621;4407.779611019436;4408.589251439573;4416.4258646375765;4423.049044455457;4793.18515852306;5004.374453193351;5006.799728010911;5007.47421520735;5031.345925029796;5877.266206469102;5899.587028908021;5924.792632257937;5930.970345148333;5935.2877654681715;1500.1449173970732;1515.8938874278695;1537.2851623994673;1541.922903854825;1547.2727817925556;987.5654711926729;990.2721499697716;994.8109859126743;1030.3663247102977;1059.258519036662;5678.479342807485;5692.37383887772;5694.120940089843;5710.057840456361;5727.455891690282;5996.460318571262;6010.2186715726675;6045.969770151121;6059.091136329498;6073.908891366633;5532.5297349724915;5661.830145095653;5662.725886675465;5674.233978412862;5675.971620141873;3164.5253212018383;3200.5039218921106;3210.4221240176525;3221.4040402525607;3243.626982896997;5910.290765108214;6174.598651087755;6232.220972378453;6237.532185086136;6268.529860260499;6022;6031.974564323988;6051.576389652682;6110.816675499742;6124.468882779305;5994.250718660254;6205.6586887721605;6221.5333849961435;6265.592736472115;6282.780102696383;5997.760089596542;6003.429674180946;6010.9699451502465;6043.033114701627;6051.729136881304;5949.631584735448;5956.434138756811;5968.253968253968;5985.65322802366;5988;5942.851428714317;6176.7838125665385;6202.976508875985;6214.8135555933395;6226.283977342664;4350.32569951658;4355.194289056535;4355.346697995326;4364.214441400578;4366.279563871925;5896.882062358814;5899;5970.223870896755;6010.579259451796;6020.1270815730595;5789.334226563999;5806.303243610793;5819.883602327845;5824.446677565625;5833.857960847846;5776.162456443876;5800.361960184292;5803.158542011469;5822.505087067647;5833.970830145822;5196.740162991911;5708.571857110816;5779.739911704068;5806.867660806102;5816.447437493432;5861.560382971379;5896.823095307148;5914.142449344907;5924.674142922181;5928.822135335947;5573.7770489179975;5774.538036956949;5787;5842.649441033552;5856.3558008618165 16:30:46 INFO - PROCESS | 13934 | |5;yui.html;835.9916400835991;865.8311629232302;879.3932186791113;898.3711402018585;902.156483687752;15302.311395987179;15438.69122617547;15566.844331556695;15609.531714048582;15975.920120399382;16043.197840107978;16105.919470402632;16166;16224.918875405636;16235.594110147253;825.5088222507599;855.9486430814155;862.9223369896708;864.2999170671776;869.3002133282705;859.1451505751786;866.0559989611322;866.4498043742237;866.7659731872391;867.5141920524495;915.0757734687979;916.0656130746635;919.6321471411455;919.6919032124247;919.8666193401953;906.4742449379344;911.9407238529475;912.5756523216703;913.5340976102202;915.5376534849925;641.8972964325732;649.1398896462207;652.5236577298551;658.1838520234922;659.9835004124888;14983;15024.624384390369;15029.849701502955;15065.171415572138;15077.924610376987;13372.398242079129;13523.729525409437;13563.52527661537;13748.106373085817;13837.377318020612;11805.64583062501;11960.641180764504;12004.69988250292;12024.639260822189;12276.631701048893;3884.2037382336553;3925.3130702127014;3944;3956.7823769692654;4050.8177132029127;60793.69603151956;60799.392006080256;61239.38760612426;61490;61622;11186.272892261977;11201.66395008151;11202;11344.602938897098;11354.829677554842;20609.690854637192;20721;20747.066382012847;20808.167673292897;20831.583368332853;8374.916250837536;8526.445781024213;8611.827763444697;8742.694005709769;8744.956275218583;4977.203647416396;4995.275685025651;5029.7736601853;5034.471380505068;5072.391313042459;3612.096975756061;3697.5193224880595;3709.517762690833;3709.9258014840093;3710.8515659373325;714.8891921752137;717.6268340463034;727.9781606551812;730.4010711216857;734.6400263870665;609.9481544068803;760.1600231743954;787.649495974286;797.9945268961151;799.3605115907367;8896.332775041898;8963.50700711454;9021.233195178484;9098;9118.58966346516;617.6911544227886;698.5913240754215;774.632049776363;788.4520258420457;789.6683392974965;4460.1971645104195;4725.834595789131;4770.76146192689;4796.712197268175;4839.637027222902;78323;79262.20737792664;80536.59731701421;81242;81456.18543814486;69892.65053674801;71967;72560.2743972564;72738;73286;64690.67654661697;64845.866954634956;65163.999999999054;65233.673831630535;66013.33986660167;8835.779105522413;8980.955095224483;9088.272938164799;9144.908550914672;9199.35604507678;40255;40855.59144408637;41004.58995410127;41337.379939301536;41415;52206.47793522016;56864;57737;58221.417785823294;58538.7073064632;12012.819807703067;12353.62939111828;12364.62906112818;12416.75166496683;12704.682382940131;13584;13736.587902362946;13821.516246931309;14177.716445670823;14694.63263418423;12959.870401295866;13041.934790325988;13052.34738263064;13241.933790330986;13454.798178027533;12562.434690439135;12758.362081896053;12799.104062715893;12877.291748953898;13313.86686133165;12959.870401295866;12996.8050479241;13017.349132543524;13038.348082596021;13202.141860779018;10820.13158679369;11118.888811112109;11292.838361780776;11327.660170194908;11369.204155709022;10895.455227238448;11118.555257789598;11517.884821151682;11590.478428470908;11596.362200079077 16:30:46 INFO - PROCESS | 13934 | __end_tp_report 16:30:46 INFO - PROCESS | 13934 | __start_cc_report 16:30:46 INFO - PROCESS | 13934 | _x_x_mozilla_cycle_collect,351 16:30:46 INFO - PROCESS | 13934 | __end_cc_report 16:30:46 INFO - PROCESS | 13934 | __startTimestamp1463268646010__endTimestamp 16:30:46 INFO - PROCESS | 13934 | 16:30:46 INFO - PROCESS | 13934 | ------- Summary: start ------- 16:30:46 INFO - PROCESS | 13934 | Number of tests: 6 16:30:46 INFO - PROCESS | 13934 | 16:30:46 INFO - PROCESS | 13934 | [#0] dojo.html Cycles:165 Average:5491.98 Median:5724.57 stddev:624.60 (10.9%) stddev-sans-first:599.62 16:30:46 INFO - PROCESS | 13934 | Values: 3180.6 3187.7 3210.6 3215.4 3216.8 5421.5 5491.8 5535.0 5553.6 5573.5 5387.7 5541.4 5564.4 5599.6 5605.9 4967.4 4980.4 5091.6 5095.6 5103.1 4989.5 5172.0 5175.0 5176.7 5177.8 4953.1 4994.5 5021.7 5039.0 5046.8 5024.9 5034.3 5034.3 5035.3 5079.3 5012.9 5020.3 5032.2 5033.7 5042.9 5360.4 5385.8 5387.0 5421.2 5429.4 5886.5 5890.4 5894.5 5895.9 5902.6 5763.7 5866.3 5924.5 5941.4 5956.6 5486.6 5522.3 5550.9 5552.1 5601.3 6052.2 6052.8 6056.0 6056.2 6075.9 5646.8 5665.5 5722.3 5827.6 5828.5 5824.4 5827.7 5828.9 5840.3 5874.1 5692.5 5800.3 5807.6 5881.1 5928.9 5900.6 5936.0 5965.7 5990.2 6029.1 4466.4 4480.2 4495.9 4526.3 4533.6 3935.6 3980.9 3996.7 4014.7 4036.6 5682.5 5711.9 5722.3 5733.2 5786.6 6008.6 6024.8 6028.7 6051.7 6062.5 5520.8 5581.8 5590.8 5647.5 5727.3 5066.6 5093.4 5094.0 5102.3 5124.9 6085.9 6168.0 6175.1 6181.5 6181.6 5744.3 5844.4 5887.7 5900.6 5932.1 6037.8 6111.8 6121.5 6126.4 6131.9 5764.6 5787.9 5811.2 5819.1 5855.5 5850.6 5866.1 5915.4 5938.2 5946.2 5727.7 5764.6 5770.0 5774.8 5780.9 5665.5 5746.4 5750.9 5751.9 5766.5 5593.0 5646.7 5682.7 5724.6 5806.3 5846.3 5852.5 5881.1 5896.7 5908.9 5581.7 5675.7 5730.6 5741.0 5745.4 16:30:46 INFO - PROCESS | 13934 | 16:30:46 INFO - PROCESS | 13934 | [#1] ext.html Cycles:180 Average:60096.54 Median:23213.96 stddev:122365.24 (527.1%) stddev-sans-first:122626.95 16:30:46 INFO - PROCESS | 13934 | Values: 591.9 612.2 633.6 634.7 636.3 42282.8 43483.7 43521.3 43667.3 45809.5 45132.0 45141.5 45583.3 45623.5 45693.0 8909.2 9052.1 9085.1 9086.2 9102.3 8824.1 8898.0 8967.0 8970.4 8973.0 8963.5 8992.6 9029.3 9055.3 9063.9 8949.7 8993.4 9006.1 9007.5 9027.7 8953.4 8963.0 8974.3 9021.8 9035.8 42065.4 42208.4 42271.2 42414.6 42486.0 3507.9 3549.3 3641.3 3766.2 4108.4 31887.4 31972.4 32617.2 32768.7 32837.2 4219.6 4349.0 4401.2 4406.1 4423.5 348833.0 352982.0 353319.0 354035.0 355437.0 31929.2 32735.8 58567.0 58666.4 58746.0 37668.0 37945.4 38066.6 38156.6 38160.0 15828.2 15868.2 15910.8 15971.4 15990.2 12959.5 13043.8 13061.0 13080.3 13082.8 8632.4 8676.8 8700.9 8722.1 8748.9 3342.5 3409.7 3411.8 3422.4 3431.3 1032.7 1052.5 1069.8 1142.4 1254.8 32354.5 32368.0 32719.2 32764.8 32872.3 1093.5 1170.6 1178.9 1204.5 1347.9 16577.5 16742.3 16781.6 16855.6 17012.1 558194.0 559879.0 560477.0 563005.0 569158.0 57204.0 57965.0 58217.1 58268.4 58336.4 1429.0 1435.3 1435.5 1442.2 1454.9 30365.4 30964.5 31035.0 31395.0 31699.4 50440.2 50670.7 50712.2 50887.7 51048.5 440139.4 440385.0 441163.0 442461.0 442744.0 28312.7 28996.7 29424.0 29551.7 29554.1 48973.8 49214.0 49554.8 49673.3 50060.0 41654.6 42848.0 42940.1 43209.4 43437.0 41458.6 42166.0 42429.0 42716.0 43060.4 36789.4 40785.4 41153.6 42188.0 42520.4 35639.3 35773.0 35927.0 36708.0 36821.6 28187.6 28229.0 28584.6 28904.4 28930.0 16:30:46 INFO - PROCESS | 13934 | 16:30:46 INFO - PROCESS | 13934 | [#2] jquery.html Cycles:180 Average:26758.91 Median:13083.15 stddev:70407.95 (538.2%) stddev-sans-first:70577.62 16:30:46 INFO - PROCESS | 13934 | Values: 388.7 389.8 391.0 399.5 418.5 13922.9 18238.8 19147.7 19808.5 19905.9 18891.6 19153.5 19559.7 20015.4 20146.4 5326.2 5365.9 5571.4 5711.0 5742.5 5743.5 5746.6 5769.0 5776.5 5785.0 5535.2 5719.1 5820.7 5849.8 5850.9 5729.1 5741.7 5752.4 5777.2 5777.3 4988.8 5119.2 5143.2 5144.8 5146.3 22537.1 23115.3 23431.3 23791.2 23893.9 2339.7 2375.1 2464.8 2636.2 2790.5 9541.9 14131.2 14865.3 15119.2 15176.1 1988.9 2038.2 2063.6 2074.5 2105.3 53838.2 53885.0 54951.0 79901.2 85119.6 10699.5 11044.4 11177.5 11182.5 11307.4 14697.9 14744.3 15292.9 15381.4 15416.2 7746.7 8127.0 8168.7 8169.8 8292.9 7671.7 7672.2 7682.8 7690.3 7855.8 4790.8 4792.9 4872.2 4874.4 4897.3 2007.4 2057.0 2062.8 2070.9 2103.7 926.7 1022.0 1033.3 1048.6 1085.7 18955.4 18963.0 19218.0 19301.8 19507.3 1028.7 1036.2 1048.6 1082.0 1109.8 10685.4 10962.7 11018.9 11118.7 11169.0 406031.0 406765.0 407037.0 439421.0 469437.0 85968.1 88891.1 91158.0 92334.5 94608.0 1078.7 1089.9 1128.2 1137.0 1148.4 17127.3 17261.8 17277.0 17317.7 17465.4 39556.2 39796.4 40000.8 40335.2 40887.6 56165.0 56871.7 57033.7 57137.4 57494.1 5436.1 7265.6 7749.0 8720.3 8994.6 7676.0 11498.8 13656.3 13745.3 13860.8 12042.9 12072.5 12274.3 12321.2 12380.9 11783.6 11878.7 11969.3 12078.5 12347.9 9982.7 12268.0 12307.2 12319.9 12337.1 8949.0 8998.0 9021.9 9121.2 9178.7 12048.5 12180.6 12209.3 12213.3 12296.9 16:30:46 INFO - PROCESS | 13934 | 16:30:46 INFO - PROCESS | 13934 | [#3] mootools.html Cycles:180 Average:6139.35 Median:2470.39 stddev:3533.88 (143.0%) stddev-sans-first:3526.40 16:30:46 INFO - PROCESS | 13934 | Values: 1474.6 1523.9 1682.6 1858.2 1892.3 7834.5 8908.6 8983.1 9598.7 9611.4 8880.2 9086.6 9129.7 9164.2 9166.8 2432.9 2479.7 2483.8 2486.6 2486.7 2385.3 2398.5 2418.6 2454.8 2460.8 2423.5 2443.9 2488.5 2488.5 2496.7 2352.0 2352.8 2378.7 2382.4 2394.0 2420.3 2428.6 2447.5 2447.7 2457.2 9158.7 9190.0 9217.8 9240.2 9264.4 5431.9 5581.4 5680.6 5710.1 5717.4 3370.1 3388.5 3409.3 3588.3 3620.7 1088.7 1129.2 1141.6 1178.8 1189.9 13096.5 13268.6 13283.1 13327.1 13334.0 4914.7 4935.0 4963.6 5056.8 5075.9 11124.9 11155.2 11186.2 11217.8 11232.8 5510.3 5580.4 5581.8 5614.8 5730.1 4449.6 5120.2 5129.8 5210.3 5242.7 4198.0 4234.4 4247.1 4254.7 4284.9 1270.3 1291.4 1295.9 1296.6 1303.7 1002.1 1011.5 1021.4 1029.7 1053.7 6253.6 6311.6 6371.9 6391.4 6529.2 491.1 494.5 494.7 511.0 511.2 4160.1 4256.3 4279.3 4308.0 4320.3 11421.2 11643.8 11668.2 11772.2 11793.6 11559.5 11653.8 11663.8 11667.2 11669.6 8069.6 8339.2 8446.7 8462.6 8516.7 5965.6 6241.2 6353.9 6451.3 6486.9 10379.4 10548.7 10594.2 10697.3 10874.2 10480.2 10858.5 10890.6 10908.7 10981.3 7975.2 8640.9 8727.3 8846.1 8882.5 8893.7 8984.1 8989.8 9039.8 9062.5 7984.2 8090.2 8167.5 8248.6 8334.0 7990.6 8013.1 8026.3 8076.4 8111.7 7128.1 7277.5 7342.6 7365.2 7400.0 5586.9 5660.5 5683.4 5704.1 5761.6 5442.1 5650.5 5662.4 5712.8 5756.7 16:30:46 INFO - PROCESS | 13934 | 16:30:46 INFO - PROCESS | 13934 | [#4] prototype.html Cycles:180 Average:4949.20 Median:5675.10 stddev:1444.39 (25.5%) stddev-sans-first:1406.48 16:30:46 INFO - PROCESS | 13934 | Values: 343.9 349.3 349.7 352.8 355.3 5550.2 5637.0 5667.9 5683.2 5714.4 5585.7 5588.6 5591.0 5595.3 5614.9 4165.1 4247.4 4343.5 4359.3 4367.1 4334.0 4336.4 4355.7 4363.9 4364.5 4371.4 4372.0 4373.6 4388.1 4398.3 4254.3 4348.8 4351.9 4352.5 4353.7 3830.8 3838.9 3857.7 3864.4 3871.4 5447.1 5451.8 5487.3 5491.4 5502.8 4957.1 4997.8 5017.6 5037.4 5043.6 5750.7 5808.7 5851.4 5879.5 5908.0 4257.5 4267.5 4277.7 4283.9 4302.4 5974.8 6116.8 6160.7 6168.7 6208.5 4352.5 4354.9 4368.1 4379.1 4381.5 4398.8 4407.8 4408.6 4416.4 4423.0 4793.2 5004.4 5006.8 5007.5 5031.3 5877.3 5899.6 5924.8 5931.0 5935.3 1500.1 1515.9 1537.3 1541.9 1547.3 987.6 990.3 994.8 1030.4 1059.3 5678.5 5692.4 5694.1 5710.1 5727.5 5996.5 6010.2 6046.0 6059.1 6073.9 5532.5 5661.8 5662.7 5674.2 5676.0 3164.5 3200.5 3210.4 3221.4 3243.6 5910.3 6174.6 6232.2 6237.5 6268.5 6022.0 6032.0 6051.6 6110.8 6124.5 5994.3 6205.7 6221.5 6265.6 6282.8 5997.8 6003.4 6011.0 6043.0 6051.7 5949.6 5956.4 5968.3 5985.7 5988.0 5942.9 6176.8 6203.0 6214.8 6226.3 4350.3 4355.2 4355.3 4364.2 4366.3 5896.9 5899.0 5970.2 6010.6 6020.1 5789.3 5806.3 5819.9 5824.4 5833.9 5776.2 5800.4 5803.2 5822.5 5834.0 5196.7 5708.6 5779.7 5806.9 5816.4 5861.6 5896.8 5914.1 5924.7 5928.8 5573.8 5774.5 5787.0 5842.6 5856.4 16:30:46 INFO - PROCESS | 13934 | 16:30:46 INFO - PROCESS | 13934 | [#5] yui.html Cycles:180 Average:17222.52 Median:4986.24 stddev:21721.25 (435.6%) stddev-sans-first:21747.33 16:30:46 INFO - PROCESS | 13934 | Values: 836.0 865.8 879.4 898.4 902.2 15302.3 15438.7 15566.8 15609.5 15975.9 16043.2 16105.9 16166.0 16224.9 16235.6 825.5 855.9 862.9 864.3 869.3 859.1 866.1 866.4 866.8 867.5 915.1 916.1 919.6 919.7 919.9 906.5 911.9 912.6 913.5 915.5 641.9 649.1 652.5 658.2 660.0 14983.0 15024.6 15029.8 15065.2 15077.9 13372.4 13523.7 13563.5 13748.1 13837.4 11805.6 11960.6 12004.7 12024.6 12276.6 3884.2 3925.3 3944.0 3956.8 4050.8 60793.7 60799.4 61239.4 61490.0 61622.0 11186.3 11201.7 11202.0 11344.6 11354.8 20609.7 20721.0 20747.1 20808.2 20831.6 8374.9 8526.4 8611.8 8742.7 8745.0 4977.2 4995.3 5029.8 5034.5 5072.4 3612.1 3697.5 3709.5 3709.9 3710.9 714.9 717.6 728.0 730.4 734.6 609.9 760.2 787.6 798.0 799.4 8896.3 8963.5 9021.2 9098.0 9118.6 617.7 698.6 774.6 788.5 789.7 4460.2 4725.8 4770.8 4796.7 4839.6 78323.0 79262.2 80536.6 81242.0 81456.2 69892.7 71967.0 72560.3 72738.0 73286.0 64690.7 64845.9 65164.0 65233.7 66013.3 8835.8 8981.0 9088.3 9144.9 9199.4 40255.0 40855.6 41004.6 41337.4 41415.0 52206.5 56864.0 57737.0 58221.4 58538.7 12012.8 12353.6 12364.6 12416.8 12704.7 13584.0 13736.6 13821.5 14177.7 14694.6 12959.9 13041.9 13052.3 13241.9 13454.8 12562.4 12758.4 12799.1 12877.3 13313.9 12959.9 12996.8 13017.3 13038.3 13202.1 10820.1 11118.9 11292.8 11327.7 11369.2 10895.5 11118.6 11517.9 11590.5 11596.4 16:30:46 INFO - PROCESS | 13934 | -------- Summary: end -------- 16:30:46 INFO - PROCESS | 13934 | 16:30:46 INFO - TEST-INFO | 13934: exit 0 16:30:46 INFO - TEST-OK | dromaeo_css | took 1111499ms 16:30:46 INFO - TEST-START | kraken 16:30:46 INFO - operating with platform_type : linux_ 16:30:46 INFO - Initialising browser for kraken test... 16:30:46 INFO - TEST-INFO | started process 14167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNY1SMD/profile http://localhost:55935/getInfo.html) 16:30:50 INFO - PROCESS | 14167 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 16:30:50 INFO - PROCESS | 14167 | 16:30:50 INFO - PROCESS | 14167 | (process:14235): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:30:51 INFO - PROCESS | 14167 | __metrics Screen width/height:1600/1200 16:30:51 INFO - PROCESS | 14167 | colorDepth:24 16:30:51 INFO - PROCESS | 14167 | Browser inner width/height: 1024/697 16:30:51 INFO - PROCESS | 14167 | __metrics 16:30:52 ERROR - PROCESS | 14167 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 16:30:53 INFO - TEST-INFO | 14167: exit 0 16:30:53 INFO - Browser initialized. 16:30:53 INFO - Running cycle 1/1 for kraken test... 16:30:53 INFO - TEST-INFO | started process 14286 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNY1SMD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:30:55 INFO - PROCESS | 14286 | 16:30:55 INFO - PROCESS | 14286 | (process:14347): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:31:05 INFO - PROCESS | 14286 | RSS: Main: 163258368 16:31:05 INFO - PROCESS | 14286 | 16:31:07 INFO - PROCESS | 14286 | Cycle 1(1): loaded http://localhost:55935/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55935/tests/kraken/driver.html?testName=audio-beat-detection) 16:31:08 INFO - PROCESS | 14286 | RSS: Main: 168566784 16:31:08 INFO - PROCESS | 14286 | 16:31:11 INFO - PROCESS | 14286 | Cycle 1(1): loaded http://localhost:55935/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55935/tests/kraken/driver.html?testName=audio-dft) 16:31:12 INFO - PROCESS | 14286 | RSS: Main: 168865792 16:31:12 INFO - PROCESS | 14286 | 16:31:15 INFO - PROCESS | 14286 | Cycle 1(1): loaded http://localhost:55935/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55935/tests/kraken/driver.html?testName=audio-fft) 16:31:15 INFO - PROCESS | 14286 | RSS: Main: 163364864 16:31:15 INFO - PROCESS | 14286 | 16:31:17 INFO - PROCESS | 14286 | Cycle 1(1): loaded http://localhost:55935/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55935/tests/kraken/driver.html?testName=audio-oscillator) 16:31:18 INFO - PROCESS | 14286 | RSS: Main: 164388864 16:31:18 INFO - PROCESS | 14286 | 16:31:20 INFO - PROCESS | 14286 | Cycle 1(1): loaded http://localhost:55935/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55935/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:31:21 INFO - PROCESS | 14286 | RSS: Main: 163872768 16:31:21 INFO - PROCESS | 14286 | 16:31:24 INFO - PROCESS | 14286 | Cycle 1(1): loaded http://localhost:55935/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55935/tests/kraken/driver.html?testName=imaging-darkroom) 16:31:25 INFO - PROCESS | 14286 | RSS: Main: 164773888 16:31:25 INFO - PROCESS | 14286 | 16:31:28 INFO - PROCESS | 14286 | Cycle 1(1): loaded http://localhost:55935/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55935/tests/kraken/driver.html?testName=imaging-desaturate) 16:31:29 INFO - PROCESS | 14286 | RSS: Main: 163237888 16:31:29 INFO - PROCESS | 14286 | 16:31:32 INFO - PROCESS | 14286 | Cycle 1(1): loaded http://localhost:55935/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55935/tests/kraken/driver.html?testName=json-parse-financial) 16:31:33 INFO - PROCESS | 14286 | RSS: Main: 163307520 16:31:33 INFO - PROCESS | 14286 | 16:31:34 INFO - PROCESS | 14286 | Cycle 1(1): loaded http://localhost:55935/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55935/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:31:35 INFO - PROCESS | 14286 | RSS: Main: 163475456 16:31:35 INFO - PROCESS | 14286 | 16:31:37 INFO - PROCESS | 14286 | Cycle 1(1): loaded http://localhost:55935/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55935/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:31:37 INFO - PROCESS | 14286 | RSS: Main: 163590144 16:31:37 INFO - PROCESS | 14286 | 16:31:39 INFO - PROCESS | 14286 | Cycle 1(1): loaded http://localhost:55935/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55935/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:31:40 INFO - PROCESS | 14286 | RSS: Main: 163463168 16:31:40 INFO - PROCESS | 14286 | 16:31:43 INFO - PROCESS | 14286 | Cycle 1(1): loaded http://localhost:55935/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:31:43 INFO - PROCESS | 14286 | RSS: Main: 164356096 16:31:43 INFO - PROCESS | 14286 | 16:31:46 INFO - PROCESS | 14286 | Cycle 1(1): loaded http://localhost:55935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:31:47 INFO - PROCESS | 14286 | RSS: Main: 164794368 16:31:47 INFO - PROCESS | 14286 | 16:31:48 INFO - PROCESS | 14286 | Cycle 1(1): loaded http://localhost:55935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55935/tests/kraken/driver.html?testName=ai-astar) 16:31:49 INFO - PROCESS | 14286 | RSS: Main: 165928960 16:31:49 INFO - PROCESS | 14286 | 16:31:49 INFO - PROCESS | 14286 | __start_tp_report 16:31:49 INFO - PROCESS | 14286 | _x_x_mozilla_page_load 16:31:49 INFO - PROCESS | 14286 | _x_x_mozilla_page_load_details 16:31:49 INFO - PROCESS | 14286 | |i|pagename|runs| 16:31:49 INFO - PROCESS | 14286 | |0;ai-astar;108;109;104;108;112;112;103;110;108;108 16:31:49 INFO - PROCESS | 14286 | |1;audio-beat-detection;151;126;151;210;127;152;156;126;180;134 16:31:49 INFO - PROCESS | 14286 | |2;audio-dft;166;162;162;161;164;177;163;163;163;164 16:31:49 INFO - PROCESS | 14286 | |3;audio-fft;76;75;74;162;85;76;75;75;173;75 16:31:49 INFO - PROCESS | 14286 | |4;audio-oscillator;95;92;182;91;92;93;159;92;94;141 16:31:49 INFO - PROCESS | 14286 | |5;imaging-gaussian-blur;117;118;117;117;118;119;118;118;118;118 16:31:49 INFO - PROCESS | 14286 | |6;imaging-darkroom;147;147;148;146;146;147;147;146;146;146 16:31:49 INFO - PROCESS | 14286 | |7;imaging-desaturate;95;96;95;96;96;96;95;96;95;95 16:31:49 INFO - PROCESS | 14286 | |8;json-parse-financial;54;57;56;55;59;55;56;55;59;59 16:31:49 INFO - PROCESS | 14286 | |9;json-stringify-tinderbox;59;60;59;58;58;58;58;59;58;59 16:31:49 INFO - PROCESS | 14286 | |10;stanford-crypto-aes;84;86;78;79;82;79;79;79;140;79 16:31:49 INFO - PROCESS | 14286 | |11;stanford-crypto-ccm;119;124;127;125;118;127;124;128;137;131 16:31:49 INFO - PROCESS | 14286 | |12;stanford-crypto-pbkdf2;158;157;157;162;158;158;163;157;164;158 16:31:49 INFO - PROCESS | 14286 | |13;stanford-crypto-sha256-iterative;68;68;63;63;64;67;63;62;66;62 16:31:49 INFO - PROCESS | 14286 | __end_tp_report 16:31:49 INFO - PROCESS | 14286 | __start_cc_report 16:31:49 INFO - PROCESS | 14286 | _x_x_mozilla_cycle_collect,859 16:31:49 INFO - PROCESS | 14286 | __end_cc_report 16:31:49 INFO - PROCESS | 14286 | __startTimestamp1463268709073__endTimestamp 16:31:49 INFO - PROCESS | 14286 | 16:31:49 INFO - PROCESS | 14286 | ------- Summary: start ------- 16:31:49 INFO - PROCESS | 14286 | Number of tests: 14 16:31:49 INFO - PROCESS | 14286 | 16:31:49 INFO - PROCESS | 14286 | [#0] ai-astar Cycles:10 Average:108.20 Median:108.50 stddev:2.94 (2.7%) stddev-sans-first:3.11 16:31:49 INFO - PROCESS | 14286 | Values: 108.0 109.0 104.0 108.0 112.0 112.0 103.0 110.0 108.0 108.0 16:31:49 INFO - PROCESS | 14286 | 16:31:49 INFO - PROCESS | 14286 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:151.50 stddev:26.80 (17.7%) stddev-sans-first:28.42 16:31:49 INFO - PROCESS | 14286 | Values: 151.0 126.0 151.0 210.0 127.0 152.0 156.0 126.0 180.0 134.0 16:31:49 INFO - PROCESS | 14286 | 16:31:49 INFO - PROCESS | 14286 | [#2] audio-dft Cycles:10 Average:164.50 Median:163.50 stddev:4.60 (2.8%) stddev-sans-first:4.85 16:31:49 INFO - PROCESS | 14286 | Values: 166.0 162.0 162.0 161.0 164.0 177.0 163.0 163.0 163.0 164.0 16:31:49 INFO - PROCESS | 14286 | 16:31:49 INFO - PROCESS | 14286 | [#3] audio-fft Cycles:10 Average:94.60 Median:75.00 stddev:38.64 (51.5%) stddev-sans-first:40.39 16:31:49 INFO - PROCESS | 14286 | Values: 76.0 75.0 74.0 162.0 85.0 76.0 75.0 75.0 173.0 75.0 16:31:49 INFO - PROCESS | 14286 | 16:31:49 INFO - PROCESS | 14286 | [#4] audio-oscillator Cycles:10 Average:113.10 Median:92.00 stddev:34.24 (37.2%) stddev-sans-first:35.69 16:31:49 INFO - PROCESS | 14286 | Values: 95.0 92.0 182.0 91.0 92.0 93.0 159.0 92.0 94.0 141.0 16:31:49 INFO - PROCESS | 14286 | 16:31:49 INFO - PROCESS | 14286 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 16:31:49 INFO - PROCESS | 14286 | Values: 117.0 118.0 117.0 117.0 118.0 119.0 118.0 118.0 118.0 118.0 16:31:49 INFO - PROCESS | 14286 | 16:31:49 INFO - PROCESS | 14286 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 16:31:49 INFO - PROCESS | 14286 | Values: 147.0 147.0 148.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 16:31:49 INFO - PROCESS | 14286 | 16:31:49 INFO - PROCESS | 14286 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:31:49 INFO - PROCESS | 14286 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 16:31:49 INFO - PROCESS | 14286 | 16:31:49 INFO - PROCESS | 14286 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.50 stddev:1.90 (3.4%) stddev-sans-first:1.79 16:31:49 INFO - PROCESS | 14286 | Values: 54.0 57.0 56.0 55.0 59.0 55.0 56.0 55.0 59.0 59.0 16:31:49 INFO - PROCESS | 14286 | 16:31:49 INFO - PROCESS | 14286 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 16:31:49 INFO - PROCESS | 14286 | Values: 59.0 60.0 59.0 58.0 58.0 58.0 58.0 59.0 58.0 59.0 16:31:49 INFO - PROCESS | 14286 | 16:31:49 INFO - PROCESS | 14286 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:79.00 stddev:18.98 (24.0%) stddev-sans-first:20.11 16:31:49 INFO - PROCESS | 14286 | Values: 84.0 86.0 78.0 79.0 82.0 79.0 79.0 79.0 140.0 79.0 16:31:49 INFO - PROCESS | 14286 | 16:31:49 INFO - PROCESS | 14286 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:127.00 stddev:5.52 (4.3%) stddev-sans-first:5.24 16:31:49 INFO - PROCESS | 14286 | Values: 119.0 124.0 127.0 125.0 118.0 127.0 124.0 128.0 137.0 131.0 16:31:49 INFO - PROCESS | 14286 | 16:31:49 INFO - PROCESS | 14286 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:158.00 stddev:2.70 (1.7%) stddev-sans-first:2.83 16:31:49 INFO - PROCESS | 14286 | Values: 158.0 157.0 157.0 162.0 158.0 158.0 163.0 157.0 164.0 158.0 16:31:49 INFO - PROCESS | 14286 | 16:31:49 INFO - PROCESS | 14286 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:2.41 (3.7%) stddev-sans-first:2.22 16:31:49 INFO - PROCESS | 14286 | Values: 68.0 68.0 63.0 63.0 64.0 67.0 63.0 62.0 66.0 62.0 16:31:49 INFO - PROCESS | 14286 | -------- Summary: end -------- 16:31:49 INFO - PROCESS | 14286 | 16:31:49 INFO - TEST-INFO | 14286: exit 0 16:31:49 INFO - TEST-OK | kraken | took 63208ms 16:31:49 INFO - SUITE-END | took 1174s 16:31:50 INFO - Completed test suite (00:19:34) 16:31:50 INFO - javascript benchmark 16:31:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7316.797463082276, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3180.5706229658995, 3187.7131058204786, 3210.6468288488263, 3215.4212241796467, 3216.7909085909423, 5421.539169170615, 5491.780328786849, 5534.972325138378, 5553.555715542752, 5573.526250268722, 5387.730613469331, 5541.390447050831, 5564.443555644443, 5599.552035837133, 5605.915911261324, 4967.4287456942375, 4980.352554167953, 5091.592672586185, 5095.566876815456, 5103.055934652083, 4989.525995030466, 5172.017316709832, 5175.0, 5176.66351687141, 5177.767000484969, 4953.083679519283, 4994.525520075587, 5021.748912554358, 5038.992201559703, 5046.84859454217, 5024.874378140539, 5034.320366750479, 5034.320366750515, 5035.3454050973505, 5079.263506791532, 5012.874678133039, 5020.272060551236, 5032.169692000815, 5033.697978121324, 5042.924356134661, 5360.437154098802, 5385.7576409061685, 5386.973065134688, 5421.159720243369, 5429.4027656957705, 5886.529077673776, 5890.381509941437, 5894.528437724972, 5895.852603684899, 5902.61632993854, 5763.6541807491685, 5866.2960444746905, 5924.496417804448, 5941.405859414067, 5956.612820166675, 5486.588505862036, 5522.30971128609, 5550.861228469321, 5552.056150454432, 5601.29983752031, 6052.152698622196, 6052.818415447544, 6055.969720151371, 6056.242969628796, 6075.878482430327, 5646.774129034875, 5665.518430933417, 5722.341930677942, 5827.59206855516, 5828.5337173026055, 5824.446677565625, 5827.650340979555, 5828.94171058284, 5840.2991641003355, 5874.148248503943, 5692.459216374438, 5800.303963524319, 5807.564432667482, 5881.05903055509, 5928.911066334009, 5900.586958912835, 5935.970320148458, 5965.701714914237, 5990.191324171181, 6029.125776762345, 4466.3747075409465, 4480.215962206601, 4495.865124046284, 4526.298423744259, 4533.569310915458, 3935.626115519021, 3980.900477488028, 3996.740211886276, 4014.7189696721534, 4036.6367026967714, 5682.488576028178, 5711.914321285184, 5722.313322401255, 5733.168690539848, 5786.594938354359, 6008.579399442085, 6024.849378765566, 6028.728707208186, 6051.667158306335, 6062.545309101747, 5520.834374968757, 5581.832545023656, 5590.832275031756, 5647.463490968352, 5727.312722473246, 5066.594672426197, 5093.388793344749, 5094.032133894548, 5102.336696229467, 5124.948750512447, 6085.908711369333, 6168.0, 6175.104609831549, 6181.536384771161, 6181.629102253879, 5744.253247077937, 5844.444777746107, 5887.676177810262, 5900.5574581907385, 5932.139839723302, 6037.818865434044, 6111.786087487095, 6121.540884433596, 6126.356732543019, 6131.938680613137, 5764.567657425626, 5787.884242315215, 5811.186433899342, 5819.0689489681445, 5855.473007429352, 5850.561207909339, 5866.090755932837, 5915.40845915405, 5938.168656388196, 5946.226990491382, 5727.742251598771, 5764.567657425626, 5770.047942089508, 5774.769009239583, 5780.855478613068, 5665.49010589049, 5746.42535746422, 5750.942490575041, 5751.9424805751405, 5766.452187042224, 5592.972035139798, 5646.745896434588, 5682.659040457585, 5724.570657200643, 5806.274215723035, 5846.269216347957, 5852.473277404883, 5881.088431293157, 5896.70516474166, 5908.940910590839, 5581.6930068846605, 5675.659460432387, 5730.5702072345575, 5741.0, 5745.425457454221], "value": 5449.606235630152, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.9052951527754, 612.1766224428144, 633.5755044120439, 634.6985182038533, 636.2873581588622, 42282.78858605707, 43483.69548913534, 43521.34717979233, 43667.34498982518, 45809.54190458095, 45132.0, 45141.548584514145, 45583.31625025627, 45623.543764562346, 45693.0, 8909.198172164504, 9052.094790520929, 9085.091490850928, 9086.227670648002, 9102.317326200528, 8824.073472285414, 8898.0, 8966.955165224164, 8970.416922900024, 8973.0, 8963.462192268453, 8992.550372481383, 9029.322800789934, 9055.275577953747, 9063.909360906373, 8949.686760963368, 8993.415427997159, 9006.099390061006, 9007.459552426842, 9027.729168124966, 8953.418027828171, 8963.0, 8974.326925480615, 9021.774455638595, 9035.774105647346, 42065.369019464735, 42208.3668744969, 42271.15457690829, 42414.57585424137, 42486.0, 3507.91230219244, 3549.2546565221332, 3641.271745650854, 3766.227923275722, 4108.424820525129, 31887.362252754814, 31972.360552788814, 32617.184570385692, 32768.67231327704, 32837.17907052319, 4219.556946520602, 4348.9782551087355, 4401.185780630593, 4406.096750166208, 4423.469183697976, 348833.0, 352982.0, 353319.0, 354035.0, 355437.0, 31929.201769955936, 32735.83632081824, 58567.0, 58666.4133358661, 58746.0, 37668.0, 37945.430818537745, 38066.61933380631, 38156.6184338153, 38160.0, 15828.208589570475, 15868.2065896707, 15910.840891591168, 15971.44099956496, 15990.200489975454, 12959.481620735254, 13043.804342934864, 13061.0, 13080.345982701017, 13082.803757943639, 8632.35257355701, 8676.78308042304, 8700.91299087001, 8722.084181161013, 8748.8687669685, 3342.49862520619, 3409.6931276185264, 3411.8294085296134, 3422.3839708852647, 3431.262278610111, 1032.6540608895955, 1052.479022883662, 1069.8341757027674, 1142.4173671427632, 1254.799232122856, 32354.514682279783, 32368.0, 32719.18202044968, 32764.836175819444, 32872.3425531488, 1093.4751319366749, 1170.631251155883, 1178.8762179971152, 1204.5482943896038, 1347.8584748601256, 16577.50267491977, 16742.330306787837, 16781.580460488585, 16855.57861053459, 17012.064336461364, 558194.0, 559879.0, 560477.0, 563005.0, 569158.0, 57204.0, 57965.0, 58217.12674309804, 58268.417315827144, 58336.41663583395, 1428.978565321521, 1435.3397437179015, 1435.5478024422273, 1442.1779585636086, 1454.8763355114934, 30365.392692145593, 30964.535531966587, 31035.0, 31395.0, 31699.366012679155, 50440.24339634835, 50670.74664626653, 50712.23931641102, 50887.74556127196, 51048.489515104375, 440139.3909395879, 440385.0, 441163.0, 442461.0, 442744.0, 28312.71687283101, 28996.710032899402, 29424.0, 29551.704482954894, 29554.113376598736, 48973.75513122412, 49214.0, 49554.75222623864, 49673.25490117579, 50060.0, 41654.583454166284, 42848.0, 42940.141197176505, 43209.3518597215, 43437.0, 41458.58541414668, 42166.0, 42429.0, 42716.0, 43060.35409468798, 36789.44815827711, 40785.38821917733, 41153.588464114975, 42188.0, 42520.36219456772, 35639.28721425609, 35773.0, 35927.0, 36708.0, 36821.63178368182, 28187.57718634263, 28229.0, 28584.57123143196, 28904.421911562073, 28930.0], "value": 19235.773900969707, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.69099066242336, 389.80120138729256, 390.9960900390995, 399.46072801717673, 418.5354256774981, 13922.860771392283, 18238.817611823877, 19147.712784308245, 19808.504787380305, 19905.900470497647, 18891.622167556674, 19153.521161970923, 19559.706604400944, 20015.399538013884, 20146.395608131745, 5326.174442961347, 5365.946340536603, 5571.387147413781, 5710.971445142768, 5742.454466825645, 5743.5118014968775, 5746.569007324447, 5769.0, 5776.451237132465, 5785.0, 5535.197396377523, 5719.056355701325, 5820.679862607576, 5849.824505264827, 5850.912236316459, 5729.140628905677, 5741.712914354307, 5752.395998420189, 5777.1623114648355, 5777.277840269945, 4988.800447982113, 5119.180931051052, 5143.202803565416, 5144.794208231666, 5146.279520867081, 22537.0985160595, 23115.306540803802, 23431.297061088193, 23791.197257014843, 23893.88053059741, 2339.6607491913746, 2375.10933399975, 2464.7658472445087, 2636.156429942419, 2790.497710412125, 9541.90458095424, 14131.222782746945, 14865.331060102213, 15119.16844573548, 15176.089434633957, 1988.8508361872916, 2038.2152871144715, 2063.6388631989344, 2074.5228597422524, 2105.2736805801974, 53838.192427114016, 53885.0, 54951.0, 79901.20098798996, 85119.57440212759, 10699.518521666543, 11044.392558409203, 11177.49701263445, 11182.496787644575, 11307.434628268553, 14697.92651036738, 14744.262786860614, 15292.923535382251, 15381.384744610314, 15416.229188540752, 7746.651400686983, 8127.024757029076, 8168.714095006646, 8169.754907352789, 8292.875606865902, 7671.731489397956, 7672.232776722283, 7682.807929801688, 7690.307872291409, 7855.764327070083, 4790.760461976887, 4792.856214313576, 4872.220444728827, 4874.4150701916, 4897.2898929655, 2007.417848823854, 2056.979430205709, 2062.752469703645, 2070.927517536879, 2103.6844473329124, 926.7451450850936, 1022.0494939706144, 1033.3180101133366, 1048.638219814163, 1085.7122862441458, 18955.431337059912, 18963.0, 19218.0, 19301.80698193028, 19507.31724389668, 1028.681108856257, 1036.228010132441, 1048.5910494906839, 1081.9621313254, 1109.8180437833842, 10685.358878467317, 10962.725931851608, 11018.889811101786, 11118.722031949266, 11169.0, 406031.0, 406765.0, 407037.0, 439421.0, 469437.0, 85968.14031859726, 88891.11108888958, 91158.0, 92334.53832730794, 94608.0, 1078.681788872269, 1089.9237053406343, 1128.1595211567435, 1136.9602063927723, 1148.3856136966683, 17127.275996044926, 17261.827381726023, 17277.0, 17317.740233896755, 17465.38871139504, 39556.20887582174, 39796.40305395479, 40000.799995999834, 40335.19329613333, 40887.59112408838, 56165.0, 56871.71564142153, 57033.714831425576, 57137.42862571321, 57494.13758793705, 5436.103042998019, 7265.600391978492, 7749.0, 8720.345974051845, 8994.550272486218, 7675.961620192087, 11498.82751758741, 13656.317184140951, 13745.312734363442, 13860.792088118485, 12042.879571204176, 12072.517099315928, 12274.263544187377, 12321.199122057038, 12380.938095309466, 11783.587574434854, 11878.703032424259, 11969.281843089442, 12078.456469459072, 12347.876521234673, 9982.700518984442, 12268.0, 12307.20003199789, 12319.876801231872, 12337.136400452242, 8949.015608283215, 8997.955010225169, 9021.909780902108, 9121.179093881583, 9178.67874624385, 12048.51805927753, 12180.57367992116, 12209.267443953391, 12213.267203967791, 12296.938515307365], "value": 9250.082281167064, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1474.5944865162082, 1523.9161846098466, 1682.6129990102277, 1858.238122369827, 1892.290391103337, 7834.490758100719, 8908.599113039912, 8983.146601072896, 9598.712038638843, 9611.375260608065, 8880.1563851434, 9086.591103400346, 9129.68046118386, 9164.221041211506, 9166.770830729236, 2432.939176520588, 2479.652848601197, 2483.838550494212, 2486.577281862079, 2486.714027886789, 2385.3321070100315, 2398.5368924955765, 2418.5767490689145, 2454.7913427358694, 2460.8031357491445, 2423.503181847717, 2443.8900249488815, 2488.464980029293, 2488.464980029293, 2496.700395952488, 2351.953380745569, 2352.752960939102, 2378.726446458662, 2382.3567636738157, 2393.9521209575796, 2420.310211589706, 2428.562858685436, 2447.5227330670527, 2447.7185123710824, 2457.1891275878916, 9158.725238242863, 9190.0, 9217.815643687089, 9240.168384845329, 9264.39781414206, 5431.945680543223, 5581.358143813432, 5680.602357834953, 5710.057840456361, 5717.428257174291, 3370.1406141433777, 3388.491726241059, 3409.3181363727354, 3588.2644057968314, 3620.746547741659, 1088.6733979806027, 1129.232122156933, 1141.5890279499456, 1178.8054970929873, 1189.881011898812, 13096.476140954446, 13268.60194194166, 13283.136596121221, 13327.067105302633, 13334.0, 4914.655974081851, 4935.037667654845, 4963.6277279204205, 5056.797728090909, 5075.8984820303385, 11124.888751112385, 11155.163362747664, 11186.216964812385, 11217.775644487065, 11232.775344493064, 5510.256115424367, 5580.441955804387, 5581.832545023656, 5614.775408983676, 5730.1404789281105, 4449.644028477714, 5120.231965205175, 5129.79480820763, 5210.322658054429, 5242.7378631068295, 4198.0, 4234.428352172479, 4247.129338485664, 4254.723442976197, 4284.892877678083, 1270.314030423561, 1291.3607764156616, 1295.9049603085377, 1296.623979046085, 1303.7197002644286, 1002.0880998291666, 1011.4790882695418, 1021.4126877045728, 1029.696239609302, 1053.7260312318851, 6253.5622506425025, 6311.621302721851, 6371.872562548723, 6391.360863913572, 6529.216494020748, 491.1282473609372, 494.54995953681976, 494.71374426490837, 511.03924621710945, 511.1744532579857, 4160.084781348099, 4256.297710877732, 4279.251131052053, 4307.978460107679, 4320.308750599889, 11421.200515963968, 11643.76712465746, 11668.241564298294, 11772.234804737836, 11793.587224447103, 11559.537618495335, 11653.766924661459, 11663.76672466546, 11667.241629294069, 11669.59156429521, 8069.596520173968, 8339.24946754795, 8446.704365347183, 8462.576871156418, 8516.74449766508, 5965.582409231486, 6241.188645476059, 6353.8729225416155, 6451.2924933575405, 6486.9351306488215, 10379.377237365783, 10548.736281593021, 10594.152467802403, 10697.304675196086, 10874.184436167478, 10480.213983951082, 10858.45707714627, 10890.564377425131, 10908.672739817817, 10981.341119532854, 7975.202479752211, 8640.870386944076, 8727.301815854844, 8846.071162527842, 8882.467051976902, 8893.688720894737, 8984.146506081912, 8989.775255618662, 9039.819203616022, 9062.50156241413, 7984.161663025531, 8090.150534193825, 8167.469114507538, 8248.628811703367, 8334.0, 7990.560519171501, 8013.118556958613, 8026.277635012877, 8076.353891688534, 8111.675532978615, 7128.144622645108, 7277.490575659653, 7342.596157211191, 7365.153007404003, 7400.0, 5586.86032849182, 5660.490555849993, 5683.3748287687495, 5704.058830293121, 5761.625494342854, 5442.074847275893, 5650.463205995424, 5662.405447427961, 5712.828615141552, 5756.65460072397], "value": 4817.261694591306, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.8968309507148, 349.27002564639906, 349.66082899587406, 352.8002901906613, 355.34261616010383, 5550.222968784368, 5636.971815140919, 5667.8583035424135, 5683.204351390808, 5714.371419143891, 5585.664860108386, 5588.580856435763, 5590.987244591954, 5595.300587426572, 5614.9157762633595, 4165.104502531947, 4247.384129301249, 4343.478782546099, 4359.346098085281, 4367.148406060819, 4334.0, 4336.392904993288, 4355.695101342907, 4363.912721745563, 4364.519902810688, 4371.388005679208, 4371.956280437187, 4373.606375426211, 4388.100439409929, 4398.252297109483, 4254.319308910575, 4348.804303806336, 4351.891202719926, 4352.455943007124, 4353.717008394444, 3830.751001184914, 3838.9232215355537, 3857.691384689246, 3864.3623802072625, 3871.4386413970096, 5447.101228297326, 5451.809186678487, 5487.286652735119, 5491.395946445888, 5502.826383578504, 4957.058158949788, 4997.775100120503, 5017.623678224148, 5037.420696619863, 5043.62172837035, 5750.706091129462, 5808.738606762664, 5851.385604511507, 5879.4713374522935, 5907.995640741041, 4257.531671516131, 4267.487901451846, 4277.657787377002, 4283.935740963888, 4302.365101261532, 5974.761009559613, 6116.785912493041, 6160.722767475474, 6168.660723660197, 6208.472279856218, 4352.455943007124, 4354.869353919387, 4368.08270263242, 4379.1022840317655, 4381.539938306432, 4398.75806830621, 4407.779611019436, 4408.589251439573, 4416.4258646375765, 4423.049044455457, 4793.18515852306, 5004.374453193351, 5006.799728010911, 5007.47421520735, 5031.345925029796, 5877.266206469102, 5899.587028908021, 5924.792632257937, 5930.970345148333, 5935.2877654681715, 1500.1449173970732, 1515.8938874278695, 1537.2851623994673, 1541.922903854825, 1547.2727817925556, 987.5654711926729, 990.2721499697716, 994.8109859126743, 1030.3663247102977, 1059.258519036662, 5678.479342807485, 5692.37383887772, 5694.120940089843, 5710.057840456361, 5727.455891690282, 5996.460318571262, 6010.2186715726675, 6045.969770151121, 6059.091136329498, 6073.908891366633, 5532.5297349724915, 5661.830145095653, 5662.725886675465, 5674.233978412862, 5675.971620141873, 3164.5253212018383, 3200.5039218921106, 3210.4221240176525, 3221.4040402525607, 3243.626982896997, 5910.290765108214, 6174.598651087755, 6232.220972378453, 6237.532185086136, 6268.529860260499, 6022.0, 6031.974564323988, 6051.576389652682, 6110.816675499742, 6124.468882779305, 5994.250718660254, 6205.6586887721605, 6221.5333849961435, 6265.592736472115, 6282.780102696383, 5997.760089596542, 6003.429674180946, 6010.9699451502465, 6043.033114701627, 6051.729136881304, 5949.631584735448, 5956.434138756811, 5968.253968253968, 5985.65322802366, 5988.0, 5942.851428714317, 6176.7838125665385, 6202.976508875985, 6214.8135555933395, 6226.283977342664, 4350.32569951658, 4355.194289056535, 4355.346697995326, 4364.214441400578, 4366.279563871925, 5896.882062358814, 5899.0, 5970.223870896755, 6010.579259451796, 6020.1270815730595, 5789.334226563999, 5806.303243610793, 5819.883602327845, 5824.446677565625, 5833.857960847846, 5776.162456443876, 5800.361960184292, 5803.158542011469, 5822.505087067647, 5833.970830145822, 5196.740162991911, 5708.571857110816, 5779.739911704068, 5806.867660806102, 5816.447437493432, 5861.560382971379, 5896.823095307148, 5914.142449344907, 5924.674142922181, 5928.822135335947, 5573.7770489179975, 5774.538036956949, 5787.0, 5842.649441033552, 5856.3558008618165], "value": 4489.440350985488, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.9916400835991, 865.8311629232302, 879.3932186791113, 898.3711402018585, 902.156483687752, 15302.311395987179, 15438.69122617547, 15566.844331556695, 15609.531714048582, 15975.920120399382, 16043.197840107978, 16105.919470402632, 16166.0, 16224.918875405636, 16235.594110147253, 825.5088222507599, 855.9486430814155, 862.9223369896708, 864.2999170671776, 869.3002133282705, 859.1451505751786, 866.0559989611322, 866.4498043742237, 866.7659731872391, 867.5141920524495, 915.0757734687979, 916.0656130746635, 919.6321471411455, 919.6919032124247, 919.8666193401953, 906.4742449379344, 911.9407238529475, 912.5756523216703, 913.5340976102202, 915.5376534849925, 641.8972964325732, 649.1398896462207, 652.5236577298551, 658.1838520234922, 659.9835004124888, 14983.0, 15024.624384390369, 15029.849701502955, 15065.171415572138, 15077.924610376987, 13372.398242079129, 13523.729525409437, 13563.52527661537, 13748.106373085817, 13837.377318020612, 11805.64583062501, 11960.641180764504, 12004.69988250292, 12024.639260822189, 12276.631701048893, 3884.2037382336553, 3925.3130702127014, 3944.0, 3956.7823769692654, 4050.8177132029127, 60793.69603151956, 60799.392006080256, 61239.38760612426, 61490.0, 61622.0, 11186.272892261977, 11201.66395008151, 11202.0, 11344.602938897098, 11354.829677554842, 20609.690854637192, 20721.0, 20747.066382012847, 20808.167673292897, 20831.583368332853, 8374.916250837536, 8526.445781024213, 8611.827763444697, 8742.694005709769, 8744.956275218583, 4977.203647416396, 4995.275685025651, 5029.7736601853, 5034.471380505068, 5072.391313042459, 3612.096975756061, 3697.5193224880595, 3709.517762690833, 3709.9258014840093, 3710.8515659373325, 714.8891921752137, 717.6268340463034, 727.9781606551812, 730.4010711216857, 734.6400263870665, 609.9481544068803, 760.1600231743954, 787.649495974286, 797.9945268961151, 799.3605115907367, 8896.332775041898, 8963.50700711454, 9021.233195178484, 9098.0, 9118.58966346516, 617.6911544227886, 698.5913240754215, 774.632049776363, 788.4520258420457, 789.6683392974965, 4460.1971645104195, 4725.834595789131, 4770.76146192689, 4796.712197268175, 4839.637027222902, 78323.0, 79262.20737792664, 80536.59731701421, 81242.0, 81456.18543814486, 69892.65053674801, 71967.0, 72560.2743972564, 72738.0, 73286.0, 64690.67654661697, 64845.866954634956, 65163.999999999054, 65233.673831630535, 66013.33986660167, 8835.779105522413, 8980.955095224483, 9088.272938164799, 9144.908550914672, 9199.35604507678, 40255.0, 40855.59144408637, 41004.58995410127, 41337.379939301536, 41415.0, 52206.47793522016, 56864.0, 57737.0, 58221.417785823294, 58538.7073064632, 12012.819807703067, 12353.62939111828, 12364.62906112818, 12416.75166496683, 12704.682382940131, 13584.0, 13736.587902362946, 13821.516246931309, 14177.716445670823, 14694.63263418423, 12959.870401295866, 13041.934790325988, 13052.34738263064, 13241.933790330986, 13454.798178027533, 12562.434690439135, 12758.362081896053, 12799.104062715893, 12877.291748953898, 13313.86686133165, 12959.870401295866, 12996.8050479241, 13017.349132543524, 13038.348082596021, 13202.141860779018, 10820.13158679369, 11118.888811112109, 11292.838361780776, 11327.660170194908, 11369.204155709022, 10895.455227238448, 11118.555257789598, 11517.884821151682, 11590.478428470908, 11596.362200079077], "value": 7316.0058521108185, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 104.0, 108.0, 112.0, 112.0, 103.0, 110.0, 108.0, 108.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 151.0, 210.0, 127.0, 152.0, 156.0, 126.0, 180.0, 134.0], "value": 151.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 162.0, 161.0, 164.0, 177.0, 163.0, 163.0, 163.0, 164.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 162.0, 85.0, 76.0, 75.0, 75.0, 173.0, 75.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 92.0, 182.0, 91.0, 92.0, 93.0, 159.0, 92.0, 94.0, 141.0], "value": 113.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 56.0, 55.0, 59.0, 55.0, 56.0, 55.0, 59.0, 59.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 58.0, 58.0, 58.0, 58.0, 59.0, 58.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 78.0, 79.0, 82.0, 79.0, 79.0, 79.0, 140.0, 79.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 124.0, 127.0, 125.0, 118.0, 127.0, 124.0, 128.0, 137.0, 131.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 157.0, 162.0, 158.0, 158.0, 163.0, 157.0, 164.0, 158.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 63.0, 63.0, 64.0, 67.0, 63.0, 62.0, 66.0, 62.0], "value": 64.6, "unit": "score"}]}]} 16:31:50 INFO - Return code: 0 16:31:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:31:50 ERROR - # TBPL SUCCESS # 16:31:50 INFO - Running post-action listener: _resource_record_post_action 16:31:50 INFO - ##### 16:31:50 INFO - ##### Finished run-tests step (success) 16:31:50 INFO - ##### 16:31:50 INFO - Running post-run listener: _resource_record_post_run 16:31:50 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549658624; Read time: 28; Write time: 1368164 16:31:50 INFO - TinderboxPrint: CPU usage
13.5% 16:31:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 16:31:50 INFO - TinderboxPrint: I/O write bytes / time
549,658,624 / 1,368,164 16:31:50 INFO - TinderboxPrint: CPU idle
8,232.9 (86.5%) 16:31:50 INFO - TinderboxPrint: CPU user
1,216.1 (12.8%) 16:31:50 INFO - TinderboxPrint: Swap in / out
0 / 0 16:31:50 INFO - install - Wall time: 17s; CPU: 21.0%; Read bytes: 0; Write bytes: 265154560; Read time: 0; Write time: 917304 16:31:50 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284504064; Read time: 28; Write time: 450860 16:31:51 INFO - Running post-run listener: _upload_blobber_files 16:31:51 INFO - Blob upload gear active. 16:31:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:31:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:31:51 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:31:51 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:31:51 INFO - (blobuploader) - INFO - Open directory for files ... 16:31:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:31:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:31:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:54 INFO - (blobuploader) - INFO - Done attempting. 16:31:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:31:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:31:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:55 INFO - (blobuploader) - INFO - Done attempting. 16:31:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:31:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:31:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:56 INFO - (blobuploader) - INFO - Done attempting. 16:31:56 INFO - (blobuploader) - INFO - Iteration through files over. 16:31:56 INFO - Return code: 0 16:31:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:31:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:31:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585181a7b8bc6c36a464581bc1f8c9ecb8e52412db1073d5880e6f8cc17d7b7e2cee87a35bf35a323f2a6c62714f0bc94cfb600df47818afc908c9ce80e8539f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66a48f7c97d28f1f3e5a800eda537c37796fb31b6d9fbc326372dedc00d7dd24e88c0510a84c74bdfc536da3604abd74b04d3db596702471c65e058b8c16e728", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea8966023a9306df01b2471ecd62fe6629c94999a68c8f145d5cc086225fc3b133dd1e47edf2b09282d6dce51d009c5424c10afc90d98cd4faae216f9a79dbbc"} 16:31:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:31:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:31:56 INFO - Contents: 16:31:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585181a7b8bc6c36a464581bc1f8c9ecb8e52412db1073d5880e6f8cc17d7b7e2cee87a35bf35a323f2a6c62714f0bc94cfb600df47818afc908c9ce80e8539f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66a48f7c97d28f1f3e5a800eda537c37796fb31b6d9fbc326372dedc00d7dd24e88c0510a84c74bdfc536da3604abd74b04d3db596702471c65e058b8c16e728", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea8966023a9306df01b2471ecd62fe6629c94999a68c8f145d5cc086225fc3b133dd1e47edf2b09282d6dce51d009c5424c10afc90d98cd4faae216f9a79dbbc"} 16:31:56 INFO - Running post-run listener: copy_logs_to_upload_dir 16:31:56 INFO - Copying logs to upload dir... 16:31:56 INFO - mkdir: /builds/slave/test/build/upload/logs 16:31:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.177753 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-14 16:31:54.732786) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 16:31:54.735929) ========= 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=33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293 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/Firefox/sha512/585181a7b8bc6c36a464581bc1f8c9ecb8e52412db1073d5880e6f8cc17d7b7e2cee87a35bf35a323f2a6c62714f0bc94cfb600df47818afc908c9ce80e8539f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66a48f7c97d28f1f3e5a800eda537c37796fb31b6d9fbc326372dedc00d7dd24e88c0510a84c74bdfc536da3604abd74b04d3db596702471c65e058b8c16e728", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea8966023a9306df01b2471ecd62fe6629c94999a68c8f145d5cc086225fc3b133dd1e47edf2b09282d6dce51d009c5424c10afc90d98cd4faae216f9a79dbbc"} build_url:https://queue.taskcluster.net/v1/task/eHKmPmcwTUS6ka-D4vfz5A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/eHKmPmcwTUS6ka-D4vfz5A/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/Firefox/sha512/585181a7b8bc6c36a464581bc1f8c9ecb8e52412db1073d5880e6f8cc17d7b7e2cee87a35bf35a323f2a6c62714f0bc94cfb600df47818afc908c9ce80e8539f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66a48f7c97d28f1f3e5a800eda537c37796fb31b6d9fbc326372dedc00d7dd24e88c0510a84c74bdfc536da3604abd74b04d3db596702471c65e058b8c16e728", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea8966023a9306df01b2471ecd62fe6629c94999a68c8f145d5cc086225fc3b133dd1e47edf2b09282d6dce51d009c5424c10afc90d98cd4faae216f9a79dbbc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 16:31:54.760409) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 16:31:54.760710) ========= 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=33d5923976266a1c518c4bf7000001ab-1463266321.11640-1192106293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 16:31:54.845336) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 16:31:54.845666) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 16:31:54.845951) ========= ========= Total master_lag: 0.16 =========