builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1463784468.9 results: success (0) buildid: 20160520141432 builduid: 3128e432882a403988c6fb73adef99c7 revision: 44fa05b72b6fb2ef0edfe73e4767154ab99381bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 15:47:48.900482) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 15:47:48.901168) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 15:47:48.901454) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 15:47:48.933974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 15:47:48.934310) ========= 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=af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 15:47:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 58.9M=0s 2016-05-20 15:47:49 (58.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.379449 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 15:47:49.327948) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 15:47:49.328267) ========= 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=af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017582 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 15:47:49.377644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 15:47:49.378020) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 44fa05b72b6fb2ef0edfe73e4767154ab99381bc --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 44fa05b72b6fb2ef0edfe73e4767154ab99381bc --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=af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 15:47:49,910 truncating revision to first 12 chars 2016-05-20 15:47:49,910 Setting DEBUG logging. 2016-05-20 15:47:49,910 attempt 1/10 2016-05-20 15:47:49,910 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/44fa05b72b6f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 15:47:50,201 unpacking tar archive at: mozilla-central-44fa05b72b6f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.568423 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 15:47:49.959925) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 15:47:49.960243) ========= script_repo_revision: 44fa05b72b6fb2ef0edfe73e4767154ab99381bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 15:47:49.960630) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 15:47:49.960909) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 15:47:49.969465) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-05-20 15:47:49.969847) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:47:50 INFO - MultiFileLogger online at 20160520 15:47:50 in /builds/slave/test 15:47:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:47:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:47:50 INFO - {'append_to_log': False, 15:47:50 INFO - 'base_work_dir': '/builds/slave/test', 15:47:50 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:47:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:47:50 INFO - 'branch': 'Firefox-Non-PGO', 15:47:50 INFO - 'buildbot_json_path': 'buildprops.json', 15:47:50 INFO - 'config_files': ('talos/linux_config.py',), 15:47:50 INFO - 'default_actions': ('clobber', 15:47:50 INFO - 'read-buildbot-config', 15:47:50 INFO - 'download-and-extract', 15:47:50 INFO - 'populate-webroot', 15:47:50 INFO - 'create-virtualenv', 15:47:50 INFO - 'install', 15:47:50 INFO - 'run-tests'), 15:47:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:47:50 INFO - 'download_minidump_stackwalk': True, 15:47:50 INFO - 'download_symbols': 'ondemand', 15:47:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:47:50 INFO - 'tooltool.py': '/tools/tooltool.py', 15:47:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:47:50 INFO - '/tools/misc-python/virtualenv.py')}, 15:47:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:47:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:47:50 INFO - 'installer_path': 'installer.exe', 15:47:50 INFO - 'log_level': 'info', 15:47:50 INFO - 'log_name': 'talos', 15:47:50 INFO - 'log_to_console': True, 15:47:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:47:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:47:50 INFO - 'opt_config_files': (), 15:47:50 INFO - 'pip_index': False, 15:47:50 INFO - 'sps_profile': False, 15:47:50 INFO - 'sps_profile_interval': 0, 15:47:50 INFO - 'suite': 'dromaeojs-e10s', 15:47:50 INFO - 'system_bits': '32', 15:47:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:47:50 INFO - 'title': 'talos-linux64-ix-020', 15:47:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:47:50 INFO - 'use_talos_json': True, 15:47:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:47:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:47:50 INFO - 'work_dir': 'build'} 15:47:50 INFO - ##### 15:47:50 INFO - ##### Running clobber step. 15:47:50 INFO - ##### 15:47:50 INFO - Running pre-action listener: _resource_record_pre_action 15:47:50 INFO - Running main action method: clobber 15:47:50 INFO - rmtree: /builds/slave/test/build 15:47:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:47:51 INFO - Running post-action listener: _resource_record_post_action 15:47:51 INFO - ##### 15:47:51 INFO - ##### Finished clobber step (success) 15:47:51 INFO - ##### 15:47:51 INFO - ##### 15:47:51 INFO - ##### Running read-buildbot-config step. 15:47:51 INFO - ##### 15:47:51 INFO - Running pre-action listener: _resource_record_pre_action 15:47:51 INFO - Running main action method: read_buildbot_config 15:47:51 INFO - Using buildbot properties: 15:47:51 INFO - { 15:47:51 INFO - "project": "", 15:47:51 INFO - "product": "firefox", 15:47:51 INFO - "script_repo_revision": "production", 15:47:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:47:51 INFO - "repository": "", 15:47:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:47:51 INFO - "buildid": "20160520141432", 15:47:51 INFO - "pgo_build": "False", 15:47:51 INFO - "basedir": "/builds/slave/test", 15:47:51 INFO - "buildnumber": 356, 15:47:51 INFO - "slavename": "talos-linux64-ix-020", 15:47:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:47:51 INFO - "platform": "ubuntu64_hw", 15:47:51 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:47:51 INFO - "branch": "mozilla-central", 15:47:51 INFO - "repo_path": "mozilla-central", 15:47:51 INFO - "revision": "44fa05b72b6fb2ef0edfe73e4767154ab99381bc", 15:47:51 INFO - "stage_platform": "linux64", 15:47:51 INFO - "builduid": "3128e432882a403988c6fb73adef99c7", 15:47:51 INFO - "slavebuilddir": "test" 15:47:51 INFO - } 15:47:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:47:51 INFO - Running post-action listener: _resource_record_post_action 15:47:51 INFO - ##### 15:47:51 INFO - ##### Finished read-buildbot-config step (success) 15:47:51 INFO - ##### 15:47:51 INFO - ##### 15:47:51 INFO - ##### Running download-and-extract step. 15:47:51 INFO - ##### 15:47:51 INFO - Running pre-action listener: _resource_record_pre_action 15:47:51 INFO - Running main action method: download_and_extract 15:47:51 INFO - mkdir: /builds/slave/test/build/tests 15:47: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')]} 15:47:51 INFO - https://queue.taskcluster.net/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:47:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:47:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:47:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/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 15:47:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/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 15:47:52 INFO - Downloaded 1361 bytes. 15:47:52 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:47:52 INFO - Using the following test package requirements: 15:47:52 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:52 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:47:52 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:47:52 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:52 INFO - u'jsshell-linux-x86_64.zip'], 15:47:52 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:47:52 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:52 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:47:52 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:47:52 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:47:52 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:47:52 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:52 INFO - https://queue.taskcluster.net/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:47:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:47:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:47:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/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 15:47:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/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 15:48:07 INFO - Downloaded 22814329 bytes. 15:48:07 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'] 15:48:07 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 15:48:08 INFO - Return code: 0 15:48:08 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 15:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:08 INFO - https://queue.taskcluster.net/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:48:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:48:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:48:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/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 15:48:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/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 15:48:09 INFO - Downloaded 22814329 bytes. 15:48:09 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'] 15:48:09 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 15:48:11 INFO - Return code: 0 15:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:11 INFO - https://queue.taskcluster.net/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:48:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:48:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:48:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/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 15:48:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/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 15:48:25 INFO - Downloaded 10840359 bytes. 15:48:25 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'] 15:48:25 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 15:48:26 INFO - Return code: 0 15:48: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')]} 15:48:26 INFO - https://queue.taskcluster.net/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:48:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:48:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:48:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/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 15:48:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnSvswvqQJ-hGOFrzfXMlA/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 15:48:40 INFO - Downloaded 54820955 bytes. 15:48:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:48:40 INFO - mkdir: /builds/slave/test/properties 15:48:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:48:40 INFO - Writing to file /builds/slave/test/properties/build_url 15:48:40 INFO - Contents: 15:48:40 INFO - build_url:https://queue.taskcluster.net/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:48:42 INFO - Running post-action listener: _resource_record_post_action 15:48:42 INFO - Running post-action listener: set_extra_try_arguments 15:48:42 INFO - ##### 15:48:42 INFO - ##### Finished download-and-extract step (success) 15:48:42 INFO - ##### 15:48:42 INFO - ##### 15:48:42 INFO - ##### Running populate-webroot step. 15:48:42 INFO - ##### 15:48:42 INFO - Running pre-action listener: _resource_record_pre_action 15:48:42 INFO - Running main action method: populate_webroot 15:48:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:48:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:48:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:48:42 INFO - '--tppagecycles', 15:48:42 INFO - '7'], 15:48:42 INFO - 'tests': ['tsvgm']}}, 15:48:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:48:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:48:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:48:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:48:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:48:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:48:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:42 INFO - 'talos_options': ['--disable-e10s'], 15:48:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:42 INFO - 'talos_options': ['--disable-e10s'], 15:48:42 INFO - 'tests': ['damp', 'tps']}, 15:48:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:42 INFO - 'tests': ['damp', 'tps']}, 15:48:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:48:42 INFO - 'tests': ['dromaeo_dom']}, 15:48:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:48:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:48:42 INFO - 'tests': ['a11yr', 15:48:42 INFO - 'ts_paint', 15:48:42 INFO - 'tpaint', 15:48:42 INFO - 'sessionrestore', 15:48:42 INFO - 'sessionrestore_no_auto_restore', 15:48:42 INFO - 'tabpaint']}, 15:48:42 INFO - 'other-e10s': {'tests': ['a11yr', 15:48:42 INFO - 'ts_paint', 15:48:42 INFO - 'tpaint', 15:48:42 INFO - 'sessionrestore', 15:48:42 INFO - 'sessionrestore_no_auto_restore', 15:48:42 INFO - 'tabpaint']}, 15:48:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:48:42 INFO - 'ts_paint', 15:48:42 INFO - 'tpaint', 15:48:42 INFO - 'sessionrestore', 15:48:42 INFO - 'sessionrestore_no_auto_restore', 15:48:42 INFO - 'tabpaint']}, 15:48:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:48:42 INFO - 'ts_paint', 15:48:42 INFO - 'tpaint', 15:48:42 INFO - 'sessionrestore', 15:48:42 INFO - 'sessionrestore_no_auto_restore', 15:48:42 INFO - 'tabpaint']}, 15:48:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:48:42 INFO - 'tests': ['a11yr', 15:48:42 INFO - 'ts_paint', 15:48:42 INFO - 'tpaint', 15:48:42 INFO - 'sessionrestore', 15:48:42 INFO - 'sessionrestore_no_auto_restore', 15:48:42 INFO - 'tabpaint']}, 15:48:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:48:42 INFO - 'tests': ['a11yr', 15:48:42 INFO - 'ts_paint', 15:48:42 INFO - 'tpaint', 15:48:42 INFO - 'sessionrestore', 15:48:42 INFO - 'sessionrestore_no_auto_restore', 15:48:42 INFO - 'tabpaint']}, 15:48:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:48:42 INFO - 'tests': ['tsvgx', 15:48:42 INFO - 'tsvgr_opacity', 15:48:42 INFO - 'tart', 15:48:42 INFO - 'tscrollx', 15:48:42 INFO - 'cart']}, 15:48:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:48:42 INFO - 'tsvgr_opacity', 15:48:42 INFO - 'tart', 15:48:42 INFO - 'tscrollx', 15:48:42 INFO - 'cart']}, 15:48:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:42 INFO - 'talos_options': ['--disable-e10s'], 15:48:42 INFO - 'tests': ['tp5o']}, 15:48:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:42 INFO - 'tests': ['tp5o']}, 15:48:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:42 INFO - 'talos_options': ['--disable-e10s', 15:48:42 INFO - '--xperf_path', 15:48:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:42 INFO - 'tests': ['tp5n']}, 15:48:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:42 INFO - 'talos_options': ['--xperf_path', 15:48:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:42 INFO - 'tests': ['tp5n']}}, 15:48:42 INFO - 'talos.zip': {'path': '', 15:48:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:48:42 INFO - Running post-action listener: _resource_record_post_action 15:48:42 INFO - ##### 15:48:42 INFO - ##### Finished populate-webroot step (success) 15:48:42 INFO - ##### 15:48:42 INFO - ##### 15:48:42 INFO - ##### Running create-virtualenv step. 15:48:42 INFO - ##### 15:48:42 INFO - Running pre-action listener: _resource_record_pre_action 15:48:42 INFO - Running main action method: create_virtualenv 15:48:42 INFO - Creating virtualenv /builds/slave/test/build/venv 15:48:42 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 15:48:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:48:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:48:42 INFO - Using real prefix '/usr' 15:48:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:48:42 INFO - Installing distribute.............................................................................................................................................................................................done. 15:48:45 INFO - Installing pip.................done. 15:48:45 INFO - Return code: 0 15:48:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f14f5761f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160a9c0>, '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 0x160b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160bd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640', '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 15:48:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:48:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:48:45 INFO - Using env: {'DISPLAY': ':0', 15:48:45 INFO - 'HOME': '/home/cltbld', 15:48:45 INFO - 'LANG': 'en_US.UTF-8', 15:48:45 INFO - 'LANGUAGE': 'en_US:en', 15:48:45 INFO - 'LOGNAME': 'cltbld', 15:48:45 INFO - 'MAIL': '/var/mail/cltbld', 15:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:45 INFO - 'MOZ_NO_REMOTE': '1', 15:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:45 INFO - 'NO_EM_RESTART': '1', 15:48:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:45 INFO - 'PWD': '/builds/slave/test', 15:48:45 INFO - 'SHELL': '/bin/bash', 15:48:45 INFO - 'SHLVL': '1', 15:48:45 INFO - 'TERM': 'linux', 15:48:45 INFO - 'TMOUT': '86400', 15:48:45 INFO - 'USER': 'cltbld', 15:48:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640', 15:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:45 INFO - '_': '/tools/buildbot/bin/python'} 15:48:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:46 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 15:48:46 INFO - Cleaning up... 15:48:46 INFO - Return code: 0 15:48:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:48:46 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')]} 15:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:46 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')]} 15:48:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:46 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 0x7f14f5761f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160a9c0>, '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 0x160b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160bd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640', '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 15:48:46 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 15:48:46 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 15:48:46 INFO - Using env: {'DISPLAY': ':0', 15:48:46 INFO - 'HOME': '/home/cltbld', 15:48:46 INFO - 'LANG': 'en_US.UTF-8', 15:48:46 INFO - 'LANGUAGE': 'en_US:en', 15:48:46 INFO - 'LOGNAME': 'cltbld', 15:48:46 INFO - 'MAIL': '/var/mail/cltbld', 15:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:46 INFO - 'MOZ_NO_REMOTE': '1', 15:48:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:46 INFO - 'NO_EM_RESTART': '1', 15:48:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:46 INFO - 'PWD': '/builds/slave/test', 15:48:46 INFO - 'SHELL': '/bin/bash', 15:48:46 INFO - 'SHLVL': '1', 15:48:46 INFO - 'TERM': 'linux', 15:48:46 INFO - 'TMOUT': '86400', 15:48:46 INFO - 'USER': 'cltbld', 15:48:46 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640', 15:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:46 INFO - '_': '/tools/buildbot/bin/python'} 15:48:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:46 INFO - Downloading/unpacking psutil>=3.1.1 15:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:48:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:48 INFO - Installing collected packages: psutil 15:48:48 INFO - Running setup.py install for psutil 15:48:48 INFO - building 'psutil._psutil_linux' extension 15:48:48 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 15:48:48 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 15:48:48 INFO - building 'psutil._psutil_posix' extension 15:48:48 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 15:48:48 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 15:48:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:48 INFO - Successfully installed psutil 15:48:48 INFO - Cleaning up... 15:48:48 INFO - Return code: 0 15:48:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:48:48 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')]} 15:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:48 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')]} 15:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:48 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 0x7f14f5761f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160a9c0>, '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 0x160b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160bd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640', '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 15:48:48 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 15:48:48 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 15:48:48 INFO - Using env: {'DISPLAY': ':0', 15:48:48 INFO - 'HOME': '/home/cltbld', 15:48:48 INFO - 'LANG': 'en_US.UTF-8', 15:48:48 INFO - 'LANGUAGE': 'en_US:en', 15:48:48 INFO - 'LOGNAME': 'cltbld', 15:48:48 INFO - 'MAIL': '/var/mail/cltbld', 15:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:48 INFO - 'MOZ_NO_REMOTE': '1', 15:48:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:48 INFO - 'NO_EM_RESTART': '1', 15:48:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:48 INFO - 'PWD': '/builds/slave/test', 15:48:48 INFO - 'SHELL': '/bin/bash', 15:48:48 INFO - 'SHLVL': '1', 15:48:48 INFO - 'TERM': 'linux', 15:48:48 INFO - 'TMOUT': '86400', 15:48:48 INFO - 'USER': 'cltbld', 15:48:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640', 15:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:48 INFO - '_': '/tools/buildbot/bin/python'} 15:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:48:49 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 15:48:49 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 15:48:49 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 15:48:49 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 15:48:49 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 15:48:49 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 15:48:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:48:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:48:50 INFO - Installing collected packages: mozsystemmonitor 15:48:50 INFO - Running setup.py install for mozsystemmonitor 15:48:51 INFO - Successfully installed mozsystemmonitor 15:48:51 INFO - Cleaning up... 15:48:51 INFO - Return code: 0 15:48:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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')]} 15:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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', '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 0x7f14f5761f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160a9c0>, '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 0x160b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160bd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640', '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 15:48: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:48: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 blobuploader==1.2.4 15:48:51 INFO - Using env: {'DISPLAY': ':0', 15:48:51 INFO - 'HOME': '/home/cltbld', 15:48:51 INFO - 'LANG': 'en_US.UTF-8', 15:48:51 INFO - 'LANGUAGE': 'en_US:en', 15:48:51 INFO - 'LOGNAME': 'cltbld', 15:48:51 INFO - 'MAIL': '/var/mail/cltbld', 15:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:51 INFO - 'MOZ_NO_REMOTE': '1', 15:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:51 INFO - 'NO_EM_RESTART': '1', 15:48:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:51 INFO - 'PWD': '/builds/slave/test', 15:48:51 INFO - 'SHELL': '/bin/bash', 15:48:51 INFO - 'SHLVL': '1', 15:48:51 INFO - 'TERM': 'linux', 15:48:51 INFO - 'TMOUT': '86400', 15:48:51 INFO - 'USER': 'cltbld', 15:48:51 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640', 15:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:51 INFO - '_': '/tools/buildbot/bin/python'} 15:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:51 INFO - Downloading/unpacking blobuploader==1.2.4 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48:53 INFO - Downloading blobuploader-1.2.4.tar.gz 15:48:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:48:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:48:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48:53 INFO - Downloading docopt-0.6.1.tar.gz 15:48:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:48:53 INFO - Installing collected packages: blobuploader, requests, docopt 15:48:53 INFO - Running setup.py install for blobuploader 15:48:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:48:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:48:54 INFO - Running setup.py install for requests 15:48:54 INFO - Running setup.py install for docopt 15:48:54 INFO - Successfully installed blobuploader requests docopt 15:48:54 INFO - Cleaning up... 15:48:54 INFO - Return code: 0 15:48:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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')]} 15:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:54 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 0x7f14f5761f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160a9c0>, '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 0x160b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160bd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640', '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 15:48:54 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 15:48:54 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 15:48:54 INFO - Using env: {'DISPLAY': ':0', 15:48:54 INFO - 'HOME': '/home/cltbld', 15:48:54 INFO - 'LANG': 'en_US.UTF-8', 15:48:54 INFO - 'LANGUAGE': 'en_US:en', 15:48:54 INFO - 'LOGNAME': 'cltbld', 15:48:54 INFO - 'MAIL': '/var/mail/cltbld', 15:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:54 INFO - 'MOZ_NO_REMOTE': '1', 15:48:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:54 INFO - 'NO_EM_RESTART': '1', 15:48:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:54 INFO - 'PWD': '/builds/slave/test', 15:48:54 INFO - 'SHELL': '/bin/bash', 15:48:54 INFO - 'SHLVL': '1', 15:48:54 INFO - 'TERM': 'linux', 15:48:54 INFO - 'TMOUT': '86400', 15:48:54 INFO - 'USER': 'cltbld', 15:48:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640', 15:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:54 INFO - '_': '/tools/buildbot/bin/python'} 15:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:54 INFO - Running setup.py (path:/tmp/pip-bzGDWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:54 INFO - Running setup.py (path:/tmp/pip-cdbUmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:54 INFO - Running setup.py (path:/tmp/pip-d9XrjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:54 INFO - Running setup.py (path:/tmp/pip-lzVamL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:55 INFO - Running setup.py (path:/tmp/pip-XiWN47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:55 INFO - Running setup.py (path:/tmp/pip-ksSOys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:55 INFO - Running setup.py (path:/tmp/pip-fYbxPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:55 INFO - Running setup.py (path:/tmp/pip-CT4KsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:55 INFO - Running setup.py (path:/tmp/pip-Fia5rN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:55 INFO - Running setup.py (path:/tmp/pip-t_EvYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:55 INFO - Running setup.py (path:/tmp/pip-RWBQfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:55 INFO - Running setup.py (path:/tmp/pip-hf2ilX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:55 INFO - Running setup.py (path:/tmp/pip-21JKkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:55 INFO - Running setup.py (path:/tmp/pip-uhELUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:55 INFO - Running setup.py (path:/tmp/pip-qDfHUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:55 INFO - Running setup.py (path:/tmp/pip-JoR8AA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:55 INFO - Running setup.py (path:/tmp/pip-5_hCVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:48:56 INFO - Running setup.py install for manifestparser 15:48:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:48:56 INFO - Running setup.py install for mozcrash 15:48:56 INFO - Running setup.py install for mozdebug 15:48:56 INFO - Running setup.py install for mozdevice 15:48:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:48:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:48:56 INFO - Running setup.py install for mozfile 15:48:56 INFO - Running setup.py install for mozhttpd 15:48:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:48:56 INFO - Running setup.py install for mozinfo 15:48:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:48:56 INFO - Running setup.py install for mozInstall 15:48:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:48:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:48:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:48:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:48:56 INFO - Running setup.py install for mozleak 15:48:56 INFO - Running setup.py install for mozlog 15:48:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:48:57 INFO - Running setup.py install for moznetwork 15:48:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:48:57 INFO - Running setup.py install for mozprocess 15:48:57 INFO - Running setup.py install for mozprofile 15:48:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:48:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:48:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:48:57 INFO - Running setup.py install for mozrunner 15:48:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:48:57 INFO - Running setup.py install for mozscreenshot 15:48:57 INFO - Running setup.py install for moztest 15:48:57 INFO - Running setup.py install for mozversion 15:48:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:48:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:48:57 INFO - Cleaning up... 15:48:57 INFO - Return code: 0 15:48:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:57 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')]} 15:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:57 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')]} 15:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:57 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 0x7f14f5761f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160a9c0>, '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 0x160b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160bd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640', '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 15:48:57 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 15:48:57 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 15:48:57 INFO - Using env: {'DISPLAY': ':0', 15:48:57 INFO - 'HOME': '/home/cltbld', 15:48:57 INFO - 'LANG': 'en_US.UTF-8', 15:48:57 INFO - 'LANGUAGE': 'en_US:en', 15:48:57 INFO - 'LOGNAME': 'cltbld', 15:48:57 INFO - 'MAIL': '/var/mail/cltbld', 15:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:57 INFO - 'MOZ_NO_REMOTE': '1', 15:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:57 INFO - 'NO_EM_RESTART': '1', 15:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:57 INFO - 'PWD': '/builds/slave/test', 15:48:57 INFO - 'SHELL': '/bin/bash', 15:48:57 INFO - 'SHLVL': '1', 15:48:57 INFO - 'TERM': 'linux', 15:48:57 INFO - 'TMOUT': '86400', 15:48:57 INFO - 'USER': 'cltbld', 15:48:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640', 15:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:57 INFO - '_': '/tools/buildbot/bin/python'} 15:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:58 INFO - Running setup.py (path:/tmp/pip-oCOpDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:58 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)) 15:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:58 INFO - Running setup.py (path:/tmp/pip-lK588Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:58 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)) 15:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:58 INFO - Running setup.py (path:/tmp/pip-1xJyDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:58 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)) 15:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:58 INFO - Running setup.py (path:/tmp/pip-yUTtSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:58 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)) 15:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:58 INFO - Running setup.py (path:/tmp/pip-a_Z6j7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:58 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)) 15:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:58 INFO - Running setup.py (path:/tmp/pip-60YSDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:58 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)) 15:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:58 INFO - Running setup.py (path:/tmp/pip-WdM7iY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:58 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)) 15:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:58 INFO - Running setup.py (path:/tmp/pip-zwybYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:58 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)) 15:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:58 INFO - Running setup.py (path:/tmp/pip-L0liou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:58 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)) 15:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:58 INFO - Running setup.py (path:/tmp/pip-IWOc_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:58 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)) 15:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:58 INFO - Running setup.py (path:/tmp/pip-rASVM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:58 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)) 15:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:58 INFO - Running setup.py (path:/tmp/pip-XEHQCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:58 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)) 15:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:58 INFO - Running setup.py (path:/tmp/pip-EVzYKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:58 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)) 15:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:58 INFO - Running setup.py (path:/tmp/pip-qzIPpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:59 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)) 15:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:59 INFO - Running setup.py (path:/tmp/pip-7pBelm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:59 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)) 15:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:59 INFO - Running setup.py (path:/tmp/pip-i7y8UD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:59 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)) 15:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:59 INFO - Running setup.py (path:/tmp/pip-Z4_Dae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:59 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)) 15:48:59 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)) 15:48:59 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)) 15:48:59 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)) 15:48:59 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)) 15:48:59 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)) 15:48:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:02 INFO - Downloading blessings-1.6.tar.gz 15:49:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:49:02 INFO - Installing collected packages: blessings 15:49:02 INFO - Running setup.py install for blessings 15:49:02 INFO - Successfully installed blessings 15:49:02 INFO - Cleaning up... 15:49:02 INFO - Return code: 0 15:49:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:49:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:03 INFO - Reading from file tmpfile_stdout 15:49:03 INFO - Current package versions: 15:49:03 INFO - argparse == 1.2.1 15:49:03 INFO - blessings == 1.6 15:49:03 INFO - blobuploader == 1.2.4 15:49:03 INFO - docopt == 0.6.1 15:49:03 INFO - manifestparser == 1.1 15:49:03 INFO - mozInstall == 1.12 15:49:03 INFO - mozcrash == 0.17 15:49:03 INFO - mozdebug == 0.1 15:49:03 INFO - mozdevice == 0.48 15:49:03 INFO - mozfile == 1.2 15:49:03 INFO - mozhttpd == 0.7 15:49:03 INFO - mozinfo == 0.9 15:49:03 INFO - mozleak == 0.1 15:49:03 INFO - mozlog == 3.2 15:49:03 INFO - moznetwork == 0.27 15:49:03 INFO - mozprocess == 0.22 15:49:03 INFO - mozprofile == 0.28 15:49:03 INFO - mozrunner == 6.11 15:49:03 INFO - mozscreenshot == 0.1 15:49:03 INFO - mozsystemmonitor == 0.3 15:49:03 INFO - moztest == 0.7 15:49:03 INFO - mozversion == 1.4 15:49:03 INFO - psutil == 3.1.1 15:49:03 INFO - requests == 1.2.3 15:49:03 INFO - wsgiref == 0.1.2 15:49:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f14f5761f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160a9c0>, '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 0x160b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160bd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640', '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 15:49:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:49:03 INFO - Using env: {'DISPLAY': ':0', 15:49:03 INFO - 'HOME': '/home/cltbld', 15:49:03 INFO - 'LANG': 'en_US.UTF-8', 15:49:03 INFO - 'LANGUAGE': 'en_US:en', 15:49:03 INFO - 'LOGNAME': 'cltbld', 15:49:03 INFO - 'MAIL': '/var/mail/cltbld', 15:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:03 INFO - 'MOZ_NO_REMOTE': '1', 15:49:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:03 INFO - 'NO_EM_RESTART': '1', 15:49:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:03 INFO - 'PWD': '/builds/slave/test', 15:49:03 INFO - 'SHELL': '/bin/bash', 15:49:03 INFO - 'SHLVL': '1', 15:49:03 INFO - 'TERM': 'linux', 15:49:03 INFO - 'TMOUT': '86400', 15:49:03 INFO - 'USER': 'cltbld', 15:49:03 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640', 15:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:03 INFO - '_': '/tools/buildbot/bin/python'} 15:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:49:03 INFO - Cleaning up... 15:49:03 INFO - Return code: 0 15:49:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f14f5761f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160a9c0>, '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 0x160b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160bd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640', '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 15:49:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:49:03 INFO - Using env: {'DISPLAY': ':0', 15:49:03 INFO - 'HOME': '/home/cltbld', 15:49:03 INFO - 'LANG': 'en_US.UTF-8', 15:49:03 INFO - 'LANGUAGE': 'en_US:en', 15:49:03 INFO - 'LOGNAME': 'cltbld', 15:49:03 INFO - 'MAIL': '/var/mail/cltbld', 15:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:03 INFO - 'MOZ_NO_REMOTE': '1', 15:49:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:03 INFO - 'NO_EM_RESTART': '1', 15:49:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:03 INFO - 'PWD': '/builds/slave/test', 15:49:03 INFO - 'SHELL': '/bin/bash', 15:49:03 INFO - 'SHLVL': '1', 15:49:03 INFO - 'TERM': 'linux', 15:49:03 INFO - 'TMOUT': '86400', 15:49:03 INFO - 'USER': 'cltbld', 15:49:03 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640', 15:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:03 INFO - '_': '/tools/buildbot/bin/python'} 15:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:03 INFO - Downloading/unpacking jsonschema 15:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:49:05 INFO - Downloading/unpacking functools32 (from jsonschema) 15:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:05 INFO - Downloading functools32-3.2.3-2.tar.gz 15:49:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:49:05 INFO - warning: no files found matching '*.txt' 15:49:05 INFO - no previously-included directories found matching 'build' 15:49:05 INFO - no previously-included directories found matching 'dist' 15:49:05 INFO - no previously-included directories found matching '.git*' 15:49:05 INFO - Installing collected packages: jsonschema, functools32 15:49:05 INFO - Running setup.py install for functools32 15:49:05 INFO - warning: no files found matching '*.txt' 15:49:05 INFO - no previously-included directories found matching 'build' 15:49:05 INFO - no previously-included directories found matching 'dist' 15:49:05 INFO - no previously-included directories found matching '.git*' 15:49:05 INFO - Successfully installed jsonschema functools32 15:49:05 INFO - Cleaning up... 15:49:05 INFO - Return code: 0 15:49:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f14f5761f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160a9c0>, '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 0x160b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160bd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640', '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 15:49:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:49:05 INFO - Using env: {'DISPLAY': ':0', 15:49:05 INFO - 'HOME': '/home/cltbld', 15:49:05 INFO - 'LANG': 'en_US.UTF-8', 15:49:05 INFO - 'LANGUAGE': 'en_US:en', 15:49:05 INFO - 'LOGNAME': 'cltbld', 15:49:05 INFO - 'MAIL': '/var/mail/cltbld', 15:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:05 INFO - 'MOZ_NO_REMOTE': '1', 15:49:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:05 INFO - 'NO_EM_RESTART': '1', 15:49:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:05 INFO - 'PWD': '/builds/slave/test', 15:49:05 INFO - 'SHELL': '/bin/bash', 15:49:05 INFO - 'SHLVL': '1', 15:49:05 INFO - 'TERM': 'linux', 15:49:05 INFO - 'TMOUT': '86400', 15:49:05 INFO - 'USER': 'cltbld', 15:49:05 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640', 15:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:05 INFO - '_': '/tools/buildbot/bin/python'} 15:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:06 INFO - Downloading/unpacking flake8 15:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:49:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:49:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:49:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:49:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:49:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:49:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:49:08 INFO - no previously-included directories found matching 'docs/_build' 15:49:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:49:08 INFO - Running setup.py install for pep8 15:49:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:49:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:49:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:49:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:49:08 INFO - no previously-included directories found matching 'docs/_build' 15:49:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:49:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:49:08 INFO - Cleaning up... 15:49:09 INFO - Return code: 0 15:49:09 INFO - Running post-action listener: _resource_record_post_action 15:49:09 INFO - Running post-action listener: _start_resource_monitoring 15:49:09 INFO - Starting resource monitoring. 15:49:09 INFO - ##### 15:49:09 INFO - ##### Finished create-virtualenv step (success) 15:49:09 INFO - ##### 15:49:09 INFO - ##### 15:49:09 INFO - ##### Running install step. 15:49:09 INFO - ##### 15:49:09 INFO - Running pre-action listener: _resource_record_pre_action 15:49:09 INFO - Running main action method: install 15:49:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:09 INFO - Reading from file tmpfile_stdout 15:49:09 INFO - Detecting whether we're running mozinstall >=1.0... 15:49:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:49:09 INFO - Reading from file tmpfile_stdout 15:49:09 INFO - Output received: 15:49:09 INFO - Usage: mozinstall [options] installer 15:49:09 INFO - Options: 15:49:09 INFO - -h, --help show this help message and exit 15:49:09 INFO - -d DEST, --destination=DEST 15:49:09 INFO - Directory to install application into. [default: 15:49:09 INFO - "/builds/slave/test"] 15:49:09 INFO - --app=APP Application being installed. [default: firefox] 15:49:09 INFO - mkdir: /builds/slave/test/build/application 15:49:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:49:25 INFO - Reading from file tmpfile_stdout 15:49:25 INFO - Output received: 15:49:25 INFO - /builds/slave/test/build/application/firefox/firefox 15:49:25 INFO - Running post-action listener: _resource_record_post_action 15:49:25 INFO - ##### 15:49:25 INFO - ##### Finished install step (success) 15:49:25 INFO - ##### 15:49:25 INFO - ##### 15:49:25 INFO - ##### Running run-tests step. 15:49:25 INFO - ##### 15:49:25 INFO - Running pre-action listener: _resource_record_pre_action 15:49:25 INFO - Running main action method: run_tests 15:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:49:25 INFO - Python 2.7.3 15:49:25 INFO - Return code: 0 15:49:25 INFO - grabbing minidump binary from tooltool 15:49:25 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')]} 15:49:25 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 0x160a9c0>, '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 0x160b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160bd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:49:25 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 15:49:25 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 15:49:25 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 15:49:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:49:25 INFO - Return code: 0 15:49:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:49:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:49:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:49:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:49:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:49:26 INFO - Return code: 0 15:49:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 15:49:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 15:49:26 INFO - Using env: {'DISPLAY': ':0', 15:49:26 INFO - 'HOME': '/home/cltbld', 15:49:26 INFO - 'LANG': 'en_US.UTF-8', 15:49:26 INFO - 'LANGUAGE': 'en_US:en', 15:49:26 INFO - 'LOGNAME': 'cltbld', 15:49:26 INFO - 'MAIL': '/var/mail/cltbld', 15:49:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:49:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:26 INFO - 'MOZ_NO_REMOTE': '1', 15:49:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:26 INFO - 'NO_EM_RESTART': '1', 15:49:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:26 INFO - 'PWD': '/builds/slave/test', 15:49:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:49:26 INFO - 'SHELL': '/bin/bash', 15:49:26 INFO - 'SHLVL': '1', 15:49:26 INFO - 'TERM': 'linux', 15:49:26 INFO - 'TMOUT': '86400', 15:49:26 INFO - 'USER': 'cltbld', 15:49:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640', 15:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:26 INFO - '_': '/tools/buildbot/bin/python'} 15:49:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 15:49:26 INFO - mozversion application_buildid: 20160520141432 15:49:26 INFO - mozversion application_changeset: 44fa05b72b6fb2ef0edfe73e4767154ab99381bc 15:49:26 INFO - mozversion application_display_name: Nightly 15:49:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:49:26 INFO - mozversion application_name: Firefox 15:49:26 INFO - mozversion application_remotingname: firefox 15:49:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:49:26 INFO - mozversion application_vendor: Mozilla 15:49:26 INFO - mozversion application_version: 49.0a1 15:49:26 INFO - mozversion platform_buildid: 20160520141432 15:49:26 INFO - mozversion platform_changeset: 44fa05b72b6fb2ef0edfe73e4767154ab99381bc 15:49:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:49:26 INFO - mozversion platform_version: 49.0a1 15:49:26 INFO - using testdate: 1463784566 15:49:26 INFO - actual date: 1463784566 15:49:26 INFO - starting webserver on 'localhost:48565' 15:49:26 INFO - SUITE-START | Running 2 tests 15:49:26 INFO - TEST-START | dromaeo_css 15:49:26 INFO - operating with platform_type : linux_ 15:49:26 INFO - Initialising browser for dromaeo_css test... 15:49:26 INFO - TEST-INFO | started process 10193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiXX98q/profile http://localhost:48565/getInfo.html) 15:49:30 INFO - PROCESS | 10193 | 15:49:30 INFO - PROCESS | 10193 | (process:10261): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:49:31 INFO - PROCESS | 10193 | __metrics Screen width/height:1600/1200 15:49:31 INFO - PROCESS | 10193 | colorDepth:24 15:49:31 INFO - PROCESS | 10193 | Browser inner width/height: 1024/697 15:49:31 INFO - PROCESS | 10193 | __metrics 15:49:32 ERROR - PROCESS | 10193 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 15:49:33 INFO - TEST-INFO | 10193: exit 0 15:49:33 INFO - Browser initialized. 15:49:33 INFO - Running cycle 1/1 for dromaeo_css test... 15:49:33 INFO - TEST-INFO | started process 10312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiXX98q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:49:35 INFO - PROCESS | 10312 | 15:49:35 INFO - PROCESS | 10312 | (process:10372): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:49:45 INFO - PROCESS | 10312 | RSS: Main: 165453824 15:49:45 INFO - PROCESS | 10312 | 15:50:35 INFO - PROCESS | 10312 | 1463784635193 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] 15:52:46 INFO - PROCESS | 10312 | Cycle 1(1): loaded http://localhost:48565/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48565/tests/dromaeo/cssquery-ext.html) 15:52:48 INFO - PROCESS | 10312 | RSS: Main: 167346176 15:52:48 INFO - PROCESS | 10312 | 15:55:50 INFO - PROCESS | 10312 | Cycle 1(1): loaded http://localhost:48565/tests/dromaeo/cssquery-ext.html (next: http://localhost:48565/tests/dromaeo/cssquery-jquery.html) 15:55:50 INFO - PROCESS | 10312 | RSS: Main: 166805504 15:55:50 INFO - PROCESS | 10312 | 15:58:52 INFO - PROCESS | 10312 | Cycle 1(1): loaded http://localhost:48565/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48565/tests/dromaeo/cssquery-mootools.html) 15:58:53 INFO - PROCESS | 10312 | RSS: Main: 168054784 15:58:53 INFO - PROCESS | 10312 | 16:01:55 INFO - PROCESS | 10312 | Cycle 1(1): loaded http://localhost:48565/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48565/tests/dromaeo/cssquery-prototype.html) 16:01:56 INFO - PROCESS | 10312 | RSS: Main: 165638144 16:01:56 INFO - PROCESS | 10312 | 16:04:58 INFO - PROCESS | 10312 | Cycle 1(1): loaded http://localhost:48565/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48565/tests/dromaeo/cssquery-yui.html) 16:04:59 INFO - PROCESS | 10312 | RSS: Main: 166531072 16:04:59 INFO - PROCESS | 10312 | 16:08:01 INFO - PROCESS | 10312 | Cycle 1(1): loaded http://localhost:48565/tests/dromaeo/cssquery-yui.html (next: http://localhost:48565/tests/dromaeo/cssquery-dojo.html) 16:08:02 INFO - PROCESS | 10312 | RSS: Main: 169074688 16:08:02 INFO - PROCESS | 10312 | 16:08:02 INFO - PROCESS | 10312 | __start_tp_report 16:08:02 INFO - PROCESS | 10312 | _x_x_mozilla_page_load 16:08:02 INFO - PROCESS | 10312 | _x_x_mozilla_page_load_details 16:08:02 INFO - PROCESS | 10312 | |i|pagename|runs| 16:08:02 INFO - PROCESS | 10312 | |0;dojo.html;2664.5736682130855;2669.94660106798;2677.8661066946647;2710.200490855199;2712.9321766955823;4673.5092815254375;4677.391939047923;4685.320628508873;4703.694259873106;4742.97628511857;4575.794089265983;4708.128996135717;4755.072760811643;4789.18583840747;4826.179549476588;4347.5652434756585;4423.77881105945;4487.932681009787;4489.124620698965;4511.255642818931;574.9095578521071;4016.6704951924644;4295.248331541983;4297.570242975708;4395.824167033315;4398.472183338004;4404.383386325917;4419.160359531678;4427.2695005324085;4454.57681520255;4400.09797991411;4422;4425.734455932622;4443.577860103317;4450.376947227391;4270.039241170743;4350;4367.803448844809;4389.934150987738;4394.472663280427;4622.9075418491775;4641.11818754439;4652.790624421909;4672.789724462407;4700.2949557566635;4907.2393778964315;5060.873478163038;5107.4892510749;5108.616853735947;5126.71803050832;5132.538071573539;5154.690718556899;5157.510036546522;5172.61205409592;5227.581793456515;4748.097861406356;4816.807327706852;4819.770958405584;4831.782569784298;4848.369711937461;5023.070731914608;5179.922301165486;5185.377754669388;5253.054450199001;5267;5007.324011258506;5028.497150285016;5062.519060689228;5064.518870707277;5094.847154585294;5072.82245121419;5135.35808023997;5136.845894623168;5146.6911985281;5160.664556803796;4918.606511479073;5044.697318160922;5087.033463641897;5096;5110.642255042111;4996.7501624918605;5032.823851165192;5038.874028149326;5047.495250474996;5123.948760512421;4345.130973805251;4398.494173170063;4398.978005110018;4404.823807047746;4446.444194475691;3693.7045036397026;3700.685441737429;3780.1872597391143;3804.524434445694;3808.409696497047;4340.956590434118;4349.608535231781;4361.258586040381;4387.956120438818;4446.911061778811;5176.689398636018;5180.430152683201;5181.4559471255725;5187.455317191716;5197.58419326453;4266.807993640294;4319.287317592562;4319.503257125408;4369.257226271541;4441.71128876622;4499.955000450019;4567.223571992769;4574.428196475441;4575.519570445122;4650.046740418206;4809.519048095162;4820.590249828733;4851.054044461296;4854.17479028559;4900.558949694545;5201.817936372209;5202.271681964452;5206.349206349207;5216.321878155815;5217.50433708797;4618.884527886829;4696.107739529479;4698.177818881751;4752.643551733565;4756.857294281177;4979.975100124476;4981.953789704203;5034.942662041012;5111.539961403491;5159.942211846487;5161.277421160966;5164.0962831505085;5171.379434467737;5172.043172013189;5173.611979101507;5024.07054694868;5027.296178535081;5035.420926593342;5041.1430056889685;5068.746562671926;4818.10864989978;4921.557059864629;4973.676711013773;5006.674566153189;5007.524285192901;4874.6344024197615;4916.950830491793;4920.040592084509;4931.728754918514;4933.161362568444;4864.294677271705;5051.090803655377;5052.924206136838;5055.216441451581;5063.0380227756605;4871.464138944642;4881.389826271716;4911.557959783637;4925.729084900365;4928.457869634266 16:08:02 INFO - PROCESS | 10312 | |1;ext.html;541.3084112149533;591.8313280714997;602.653474252305;609.247579239639;624.5128799536358;38824.41763373548;39887.2022559549;39942;40065;40177.39733903994;40917.795411022904;40946.795266023626;41513.58486415135;41869;41871.58128418715;7623.542587444771;7797.33722633574;7799.5710235937;7819.139894611617;7853.2539408756365;7586.7344642937505;7607.429442791785;7680.385569154482;7706.267904549059;7711.884321735179;7705.537667739925;7709.575973321493;7715.074191097076;7719.8070048248965;7751.7674469766;7656.5406075635365;7699.461037727361;7699.538027718327;7702.845943081107;7710.807229819271;7342;7763.844723105506;7770.689172433096;7798.844023119563;7810.062792464883;37278.62721372806;37903.62096379029;37994.62005379939;38118;38189.23621527554;3031.1512776422637;3162.739780558813;3277.5083737439336;3404.370191514553;3949.624785645359;30186;30198.24504387386;30398.088057358094;30521.847390763127;30752;3515.0860776198115;3624.818759062063;3680.9447858282147;3716.0524066363173;3722.9069273268383;265900;266369;266459;266513;267362;32338.676613233565;33360.332793343994;54602.45397546053;54869.45130548723;55033.1745023825;34371;34546.65453345434;34686.65313346885;34721.826390867885;34903;11878.762424751629;11897.286162830258;11945.761084778429;12083.57707480234;12151.270923744603;9317.72046838596;9435.90564094364;9446.291528135418;9453.054694530629;9466.432014079177;8002.439829211899;8053.919460805317;8070.717524886601;8074.596270186467;8127.106018337978;3153.5585018097486;3167.160702413862;3169.065125787898;3197.6802319767835;3201.279712064767;870.2907130688469;912.6760000199966;918.7197904639015;971.8882328532168;1073.1736266344835;29136.271593209916;29144.755879741013;29330.853345733136;29415.705842941297;29693;908.2098574240453;993.4486360070086;1040.9479526023667;1051.6844946516014;1123.685368096934;14818.25908704582;14983.175925324213;14988.775168372484;15033.624159395884;15051.698966020836;380873;386296;386581;388710;391039;50427.24359134616;50883.236751448756;50958.235626465634;51006.234906476435;51046.234306485436;1185.1881461199107;1203.9699007524707;1206.589759481763;1217.3061355027726;1227.9324637144864;26161.345966350993;27721.168364949084;27886.44227115487;27972.58041129344;28013.439731204853;42059;42212;42252.15495690131;42541.574584255;42592.14815703606;319834;321264;321616;321880;322597;25064.498710026062;25212.74787252104;25795.484090317714;25823.48353032891;25850.48299033971;38782.6121738779;42198.57801421946;42885.5711442894;42900;43007.354889677306;36775;36848.44727329039;36953.260934780614;37346.626533734314;38068.42897356486;36815.07962300964;36828.81585592055;37080.62919370772;37388.439173411876;37618.811905940296;30680.50057974484;35806.82096589501;36166.27667446584;36373.09067273339;37021.62978370182;33603.159921002174;34429.311413772084;34533;34857;35033.474497883064;25804;26332.473350533266;26431.354207611694;26463.206103816916;26464 16:08:02 INFO - PROCESS | 10312 | |2;jquery.html;366.2893985667803;367.4616686554198;367.86021311901476;377.8828563145423;381.11961369237065;15611.921940390297;15897.92051039746;16952.83047169528;16992.235349409275;17000.149992500374;16246.350145994176;17029.744553831704;17611.73582396262;17612.64774704505;17640.823591764078;5039.748012599373;5149.768260428271;5213.2701421800975;5240.423553409122;5246.658967167122;5078.8476345709505;5174.275601415805;5237.7381130943495;5278.155495120782;5287.259783630276;5087.949120508803;5132.4610915853855;5162.483751624826;5172.612054095939;5180;4959.553640172366;5109.821156259513;5111.744412779365;5172.19830926207;5241.580673546107;4613.953860461386;4655.464621568495;4657.6273898088075;4663;4671.743054132022;20304.39086827383;20560.691589626167;20803.063862126088;21195.152193912225;21278.042488088075;2000.2599038355756;2020.2626041494896;2063.8442472215606;2077.989610051955;2249.7750224977535;11944.283342999448;13385.732285354336;13657.112287701268;13697.657558561115;14010.159390436504;1732.9566760830953;1774.4410510689092;1797.9910100449545;1820.6449742300256;1869.1867546245044;69345.65327173383;72046.63976680135;72536;72785;73961.26038739597;10184.388936663823;10316.381017138845;10347.379157250589;10348.586056557653;10509.474526273656;14216.64458388528;14273.92863035699;14357.64105897361;14371.353289102015;14431.422743090368;6604.834879127964;6749.0551322814845;6783.830404239835;6798.76204332846;6820.488463365267;6132.7546898124465;6184.474319682788;6215.9378406215355;6267.874642507124;6321.146645202839;4378.8029538670835;4433.733975961452;4474.955250447454;4512.887177820581;4547.181507328646;1851.8703690741518;1856.7838066066747;1876.9436916892514;1893.195391958412;1897.2695512227615;795.6777505110324;856.9828603427896;894.5080205886736;938.6714649872627;957.899420560845;16554;16914.577135571708;17179.484615461555;17292;17595.384161554284;869.7043005378201;894.8568229083315;903.4037535226719;930.5021813329836;966.8694726212012;9572.329936904489;9666.880491698164;9747.805043899083;9947.154491868272;9972;406278;410507;412419;415164;420249;78125;78513.60743196361;79939.60030199811;80211;81424.18575814166;868.405142477405;882.4749274181852;887.4896934262824;888.4846788862444;890.7550423633683;15138.848611513744;15283.541493754761;15307.46423875159;15349.923250383677;15578.610534736723;35655.821720892265;35803.462948055276;36204.63795362013;37052.25895482129;37404.81297593495;49813.750931245115;52197.7390113047;52256;52258;52894.47105528895;7580.62096895142;7613.467057305936;7647.579383133981;7770.650320735467;7812.3750099993;10612.840807387742;11391.943040285078;11720.70698232517;11737.119716021503;11947.522099115939;9755.365901216399;10036.598536058767;10144.239182061227;10249.538770755185;10488.528016239441;9629.422234665943;10109.797804044025;10336.139494890991;10504.26470147113;10911.508982095984;10066.748331291776;10497.370157790558;10517.21120915919;10752.247342686249;10844.945775271388;7764.855233630388;7815.218478152139;7832.099308579358;7863.292303692695;7923.881141782763;7816.960915195387;9426.434413935185;10057.446840423847;10101.98980101984;10260.897391025994 16:08:02 INFO - PROCESS | 10312 | |3;mootools.html;1429.056822497152;1467.919264440456;1561.601791543157;1747.7028905086142;1749.6413235286768;6758.763443279487;7340.155882073564;7567.545947243162;8085.110637829841;8103.756887293383;7438.888416673754;7650.770476885702;7711.190325015863;7752.728654497094;7765.301122898938;2153.074178103415;2191.923282685106;2193.8135258502966;2200.3948914048683;2201.042546492273;2126.2345555599973;2175.967360489594;2198.461376962646;2208.194009186643;2219.0901730290584;2158.5251244726137;2161.167950339123;2175.1516908405733;2193.1337121836864;2240.2943072931976;2096.0986775686447;2107.104480595741;2109.8312135029237;2119.6078725435846;2124.0972586650687;2090.7491101067817;2126.755423126345;2127.755308139568;2133.487962888911;2133.95732085359;7595.734149304803;7613.390928725744;7667.846643067108;7685.538867667958;7706.884396734054;4364.476262848447;4513.187626227278;4519.299508576176;4519.661025423106;4533.297338912474;2727.440874620698;2809.7752179825566;2902.506573882445;2905.186547766629;2912.941741165186;836.0970152235572;848.1857416879802;853.0318088969003;857.0486759696731;886.246690313235;10765.730856728565;10770.946145269223;10827.458627068694;10860.565577376896;10860.782784344268;4182.623563879265;4301.548337424525;4360.389545463638;4364.236258654722;4371.344298355209;9243.39917905334;9294.117058879396;9297.67458138962;9301.116393942564;9307.53462326881;4435.578620031092;4534.886627834265;4545.340925565841;4545.863624091283;4548.385967894292;3499.8600055997986;3892.649661530419;4076.8369265229653;4095.610916962884;4097.836086556564;3601.099725068733;3739.7382183247455;3758.4926034985474;3832.7317087803585;3852.6917846572205;1192.898603618702;1207.5833837326109;1212.0788200967152;1213.6237766292477;1220.3044264768996;706.3007622453733;830.3730683334044;836.7949852286229;843.8649816029406;845.9873101903477;5423.349198096174;5440.183972404171;5448.863778405572;5511.834644960577;5521.751521181556;883.739296907401;884.1777147252988;888.6623083228332;907.1925985872579;911.6171208092485;3560.4659301105044;3597.7481576289933;3672.5042119313553;3686.8340924658455;3748.793816340073;9284.164425201629;9598.95200523993;9613.855792163124;9669.613215471303;9734.756631084138;9528.19010384125;9576.47329396876;9614.230861531061;9660.227181825438;9676.516174191262;7023.719051237893;7202.099737532809;7321.450891183183;7323.853522929511;7362.77911662651;5407.5944304176555;5458.344998600193;5525.508112809439;5589.357223919302;5594.1608758686525;8720;8775.297976162019;8798.032216456313;8845;8933.910660893567;8658.567071646266;8995.460272383678;9008.32437567172;9042.593083311136;9049.185573298435;6121.418465245794;6392.169018027626;6591.044298576776;6633.767818126343;6827.078344423439;7761.0298712660915;7804.2585954334245;7805.297523222937;7843.098043724816;7854.371650268079;6594.208694956636;6746.9325306746305;6833.453323734188;6860.245373009065;6981.895271571032;6907.03301537775;6929.965350173217;6933.064036355027;7029.789106326818;7034.788956331318;6177.722002509808;6185.195924529782;6282.811515654537;6299;6421.518386121153;4844.079624871263;4901.681390709735;4920.507949205051;4938.629313058042;5049.141645920276;4997.200447928314;5079.6698214615935;5111.105556527667;5147.871303217449;5169.172932330809 16:08:02 INFO - PROCESS | 10312 | |4;prototype.html;293.95149800282957;296.7507293873147;297.61161684002377;300.12214273250765;302.9336734693877;5039.496050394959;5069.467705890879;5074.720890351029;5110.667806592578;5119.718415487151;4984.828565287155;5012.72430016349;5024.346834911456;5027.748612569375;5031.371078615173;3764.929288891106;3860.86486972956;3979.98010009951;3996.3605823068315;4000.2599519089063;3982.6459003938653;3993.5207775067033;3995.180987897474;3999.460072890152;4003.819828107742;3966.305896468121;3970.364741641338;3970.8014599270064;3973.582773808752;3982.2632812929555;3636.3636363636524;3831.8467261309515;3847.4228865670093;3946.4474973503734;3946.9605303947023;3384.9492257616157;3398.218409765768;3401.149712571857;3406.403879321134;3413.8293085345636;4810.542998415145;4810.95189048112;4816.699491137409;4822.9758851205515;4826.321391627645;4295.818649871279;4442.2004039272915;4446.133004064209;4446.7554284514335;4448.866534003985;5253.737313134367;5253.789848406059;5255.5795536357;5260.289860868772;5274.894502109936;3535.469679548088;3550.5206797082324;3561.4123669594487;3582.946255806139;3586.8385922633283;5329.893402131975;5449.373322067973;5460.34475862899;5469.206964990054;5482.80810171642;3807.8667246646232;3820.9617903821163;3821.8280177392085;3826.674732647756;3840.116773142193;3830.578636349999;3841.1741475582885;3843.077661361309;3843.8846834595006;3851.826667799956;4408.699433667076;4435.3125265583885;4439.178751930903;4440.4902333206865;4452;5046.697198168122;5249.291345668362;5252.894942101213;5263.26314315996;5288.937314447368;1317.0451422718645;1324.1723922548408;1329.5147271245926;1333.5265980576755;1336.7167519181694;839.5088873009236;849.9830003400021;854.6154230596132;855.9657613695507;880.423322723617;4489.483709373464;4556.7721613919175;4576.885577860514;4593.356930029799;4609.562091601292;5367.275417818622;5429.945700542944;5446.972765136149;5454;5456.427075157051;4410.669199810027;4468.262736648481;4517.412736344254;4573.787946194261;4575.405197324327;2922.40728802803;2931.5749216363506;2939.955900661492;2960.3191266008507;2961.555766635022;5113.593761715483;5146.4853514648985;5179.736765837573;5180.119379705384;5182.53357197854;5400.055979847252;5622.943770562324;5643.266375371176;5686.289213848269;5700.7719691212715;5054.292399064134;5088.287639730441;5120.257562653394;5126.923096153635;5136.280920671109;5417.972910135424;5432.130859062531;5472.671639701631;5477.849651573214;5494.36814766307;5103.132467480612;5341.786328546815;5364.892702146013;5383.757730902197;5423.132298832325;5103.362079740033;5139.383274007143;5142;5149.506643073467;5153.561947234377;3844.4041173618134;3856.9035774105873;3861.343571592892;3875.767453952772;3891.494105766232;5244.475552444877;5536.806211782568;5539.8892022160135;5540.722963851872;5547.223388725501;5332.413434522122;5347.545458636059;5368.114261146867;5369.550221440268;5374.274472946102;5115.240298380613;5320.547753441001;5322.201669749568;5342.78628854857;5355.518003379714;5210.0983141153965;5216.217567364925;5229.294045303835;5232.110541207928;5240.7641656126325;5113.795448182031;5187.832737634002;5319.734013299397;5350.6254562180275;5362.624616276979;5207.3490813648295;5248.160294352885;5256.6320357574605;5258.158694608845;5269.841904742864 16:08:02 INFO - PROCESS | 10312 | |5;yui.html;656.9375909288618;731.4952682648968;765.5024234247738;765.5100735529259;773.0491495460583;11807.114466415022;12009.699757506067;12060.57787977421;12092.939535302323;12119.575814846483;12188.51245950161;12276;12451.439685214165;12703.301318427482;12712.491500339998;620.9099680546341;775.391317815515;783.4202690009381;796.5300472721093;798.0981490915258;778.0468925566192;778.3617433704364;779.555653277632;780.6916268074108;789.6091434739811;811.407672399149;815.8572249856281;816.4121832280748;816.779469543223;821.4003777242586;804.1757198871175;807.6930766308794;808.2160304504621;808.9231523005305;811.6712731343815;586.7711592478937;592.6414519215856;593;593.4065934065934;593.7387549478216;12739.808902866464;12858.099933004694;12865.292408917507;12868;12907.419166137546;12114.273143611412;12272.815907761391;12316.81524777129;12446.875531244663;12482.251064936043;10420.218483613759;10439.94780026095;10471.790564188674;10615.363078215254;10690.144788416987;3281.5405843181975;3317.336532693471;3365.6297807241185;3384.966150338514;3452.7928324300624;47829.521704782856;48039.75980120112;48218.27672584914;49094.263586046596;49375;10023.799524009479;10170.186385089175;10243.231757618209;10277.17782577392;10501.632442864464;16215.756763648555;18471;18473.630527389647;18551;18639.627207455775;6789.422899053537;6936.098307220029;6938.895916561256;6988.79033628992;7001.159860816734;3672.926541469156;3751.2309976454762;3753.9061523461587;3763.849446022183;3766.8681596144;2703.6620422447195;2747.079728291005;2842.545192769147;2843.1470558832266;2844.7155284471387;535.7508758427272;557.027986164138;557.6236040672529;558.5419955636339;558.8546977785805;478.7701903086468;540.394757871179;560.9046462101453;585.0376131264131;629.7071861584385;8351.916480835236;8416.410851240476;8530.914690853137;8551.828963420698;8751.299896008304;506.6200349737697;539.9568034557226;598.4494265275956;623.1307326279814;638.4126603524768;3940.9605903941165;4046.716729828943;4091.324931386288;4177.6866734995;4191.64371028466;59495.40504594899;59678.40321596815;59978.10032849511;60294.39705602975;60711.69644151839;52630.47369526256;53245;53958.190627140626;54375.45624543704;55145.44854551483;49978.250326245136;50387.24419133716;50434.74782626063;50649.24026139611;51232.74383628058;7311.817204569716;7386.519876208029;7547.811304717426;7562.659680314509;7578.204288549623;33131.337373252885;33705;33797.155071123416;33831.154221144665;34724.30551389009;36969.44545831868;38587;41215.381769272884;41363.379549306184;41727.374089388075;11124.666260012213;11155;11236.438178090899;11400.258983166068;11469.885301147215;12083;12308.692282692646;12381.938090309492;12474.126811123135;12932.288724120264;11613.419329033346;11631.88368116308;11750;11984.161108722306;12033.759324813629;10847.945760271465;11266.155038371991;11466.31202127875;11574.942125289319;11794.469248883992;10326.535305911402;11142.442877856236;11272.492737826982;11332.093432525544;11615.186936914335;9835.16401105914;10037.19702423819;10046.346987445793;10087.596496140366;10228.64199753005;9345.626174952926;9816.214702823614;9839.803203936024;9866.506674666382;9915.702528924145 16:08:02 INFO - PROCESS | 10312 | __end_tp_report 16:08:02 INFO - PROCESS | 10312 | __start_cc_report 16:08:02 INFO - PROCESS | 10312 | _x_x_mozilla_cycle_collect,363 16:08:02 INFO - PROCESS | 10312 | __end_cc_report 16:08:02 INFO - PROCESS | 10312 | __startTimestamp1463785682160__endTimestamp 16:08:02 INFO - PROCESS | 10312 | 16:08:02 INFO - PROCESS | 10312 | ------- Summary: start ------- 16:08:02 INFO - PROCESS | 10312 | Number of tests: 6 16:08:02 INFO - PROCESS | 10312 | 16:08:02 INFO - PROCESS | 10312 | [#0] dojo.html Cycles:165 Average:4693.65 Median:4851.05 stddev:595.66 (12.3%) stddev-sans-first:575.83 16:08:02 INFO - PROCESS | 10312 | Values: 2664.6 2669.9 2677.9 2710.2 2712.9 4673.5 4677.4 4685.3 4703.7 4743.0 4575.8 4708.1 4755.1 4789.2 4826.2 4347.6 4423.8 4487.9 4489.1 4511.3 574.9 4016.7 4295.2 4297.6 4395.8 4398.5 4404.4 4419.2 4427.3 4454.6 4400.1 4422.0 4425.7 4443.6 4450.4 4270.0 4350.0 4367.8 4389.9 4394.5 4622.9 4641.1 4652.8 4672.8 4700.3 4907.2 5060.9 5107.5 5108.6 5126.7 5132.5 5154.7 5157.5 5172.6 5227.6 4748.1 4816.8 4819.8 4831.8 4848.4 5023.1 5179.9 5185.4 5253.1 5267.0 5007.3 5028.5 5062.5 5064.5 5094.8 5072.8 5135.4 5136.8 5146.7 5160.7 4918.6 5044.7 5087.0 5096.0 5110.6 4996.8 5032.8 5038.9 5047.5 5123.9 4345.1 4398.5 4399.0 4404.8 4446.4 3693.7 3700.7 3780.2 3804.5 3808.4 4341.0 4349.6 4361.3 4388.0 4446.9 5176.7 5180.4 5181.5 5187.5 5197.6 4266.8 4319.3 4319.5 4369.3 4441.7 4500.0 4567.2 4574.4 4575.5 4650.0 4809.5 4820.6 4851.1 4854.2 4900.6 5201.8 5202.3 5206.3 5216.3 5217.5 4618.9 4696.1 4698.2 4752.6 4756.9 4980.0 4982.0 5034.9 5111.5 5159.9 5161.3 5164.1 5171.4 5172.0 5173.6 5024.1 5027.3 5035.4 5041.1 5068.7 4818.1 4921.6 4973.7 5006.7 5007.5 4874.6 4917.0 4920.0 4931.7 4933.2 4864.3 5051.1 5052.9 5055.2 5063.0 4871.5 4881.4 4911.6 4925.7 4928.5 16:08:02 INFO - PROCESS | 10312 | 16:08:02 INFO - PROCESS | 10312 | [#1] ext.html Cycles:180 Average:46938.06 Median:20500.77 stddev:86659.04 (422.7%) stddev-sans-first:86832.12 16:08:02 INFO - PROCESS | 10312 | Values: 541.3 591.8 602.7 609.2 624.5 38824.4 39887.2 39942.0 40065.0 40177.4 40917.8 40946.8 41513.6 41869.0 41871.6 7623.5 7797.3 7799.6 7819.1 7853.3 7586.7 7607.4 7680.4 7706.3 7711.9 7705.5 7709.6 7715.1 7719.8 7751.8 7656.5 7699.5 7699.5 7702.8 7710.8 7342.0 7763.8 7770.7 7798.8 7810.1 37278.6 37903.6 37994.6 38118.0 38189.2 3031.2 3162.7 3277.5 3404.4 3949.6 30186.0 30198.2 30398.1 30521.8 30752.0 3515.1 3624.8 3680.9 3716.1 3722.9 265900.0 266369.0 266459.0 266513.0 267362.0 32338.7 33360.3 54602.5 54869.5 55033.2 34371.0 34546.7 34686.7 34721.8 34903.0 11878.8 11897.3 11945.8 12083.6 12151.3 9317.7 9435.9 9446.3 9453.1 9466.4 8002.4 8053.9 8070.7 8074.6 8127.1 3153.6 3167.2 3169.1 3197.7 3201.3 870.3 912.7 918.7 971.9 1073.2 29136.3 29144.8 29330.9 29415.7 29693.0 908.2 993.4 1040.9 1051.7 1123.7 14818.3 14983.2 14988.8 15033.6 15051.7 380873.0 386296.0 386581.0 388710.0 391039.0 50427.2 50883.2 50958.2 51006.2 51046.2 1185.2 1204.0 1206.6 1217.3 1227.9 26161.3 27721.2 27886.4 27972.6 28013.4 42059.0 42212.0 42252.2 42541.6 42592.1 319834.0 321264.0 321616.0 321880.0 322597.0 25064.5 25212.7 25795.5 25823.5 25850.5 38782.6 42198.6 42885.6 42900.0 43007.4 36775.0 36848.4 36953.3 37346.6 38068.4 36815.1 36828.8 37080.6 37388.4 37618.8 30680.5 35806.8 36166.3 36373.1 37021.6 33603.2 34429.3 34533.0 34857.0 35033.5 25804.0 26332.5 26431.4 26463.2 26464.0 16:08:02 INFO - PROCESS | 10312 | 16:08:02 INFO - PROCESS | 10312 | [#2] jquery.html Cycles:180 Average:25190.63 Median:212313.90 stddev:68152.37 (32.1%) stddev-sans-first:68318.07 16:08:02 INFO - PROCESS | 10312 | Values: 366.3 367.5 367.9 377.9 381.1 15611.9 15897.9 16952.8 16992.2 17000.1 16246.4 17029.7 17611.7 17612.6 17640.8 5039.7 5149.8 5213.3 5240.4 5246.7 5078.8 5174.3 5237.7 5278.2 5287.3 5087.9 5132.5 5162.5 5172.6 5180.0 4959.6 5109.8 5111.7 5172.2 5241.6 4614.0 4655.5 4657.6 4663.0 4671.7 20304.4 20560.7 20803.1 21195.2 21278.0 2000.3 2020.3 2063.8 2078.0 2249.8 11944.3 13385.7 13657.1 13697.7 14010.2 1733.0 1774.4 1798.0 1820.6 1869.2 69345.7 72046.6 72536.0 72785.0 73961.3 10184.4 10316.4 10347.4 10348.6 10509.5 14216.6 14273.9 14357.6 14371.4 14431.4 6604.8 6749.1 6783.8 6798.8 6820.5 6132.8 6184.5 6215.9 6267.9 6321.1 4378.8 4433.7 4475.0 4512.9 4547.2 1851.9 1856.8 1876.9 1893.2 1897.3 795.7 857.0 894.5 938.7 957.9 16554.0 16914.6 17179.5 17292.0 17595.4 869.7 894.9 903.4 930.5 966.9 9572.3 9666.9 9747.8 9947.2 9972.0 406278.0 410507.0 412419.0 415164.0 420249.0 78125.0 78513.6 79939.6 80211.0 81424.2 868.4 882.5 887.5 888.5 890.8 15138.8 15283.5 15307.5 15349.9 15578.6 35655.8 35803.5 36204.6 37052.3 37404.8 49813.8 52197.7 52256.0 52258.0 52894.5 7580.6 7613.5 7647.6 7770.7 7812.4 10612.8 11391.9 11720.7 11737.1 11947.5 9755.4 10036.6 10144.2 10249.5 10488.5 9629.4 10109.8 10336.1 10504.3 10911.5 10066.7 10497.4 10517.2 10752.2 10844.9 7764.9 7815.2 7832.1 7863.3 7923.9 7817.0 9426.4 10057.4 10102.0 10260.9 16:08:02 INFO - PROCESS | 10312 | 16:08:02 INFO - PROCESS | 10312 | [#3] mootools.html Cycles:180 Average:5174.00 Median:5516.79 stddev:2881.86 (52.2%) stddev-sans-first:2876.20 16:08:02 INFO - PROCESS | 10312 | Values: 1429.1 1467.9 1561.6 1747.7 1749.6 6758.8 7340.2 7567.5 8085.1 8103.8 7438.9 7650.8 7711.2 7752.7 7765.3 2153.1 2191.9 2193.8 2200.4 2201.0 2126.2 2176.0 2198.5 2208.2 2219.1 2158.5 2161.2 2175.2 2193.1 2240.3 2096.1 2107.1 2109.8 2119.6 2124.1 2090.7 2126.8 2127.8 2133.5 2134.0 7595.7 7613.4 7667.8 7685.5 7706.9 4364.5 4513.2 4519.3 4519.7 4533.3 2727.4 2809.8 2902.5 2905.2 2912.9 836.1 848.2 853.0 857.0 886.2 10765.7 10770.9 10827.5 10860.6 10860.8 4182.6 4301.5 4360.4 4364.2 4371.3 9243.4 9294.1 9297.7 9301.1 9307.5 4435.6 4534.9 4545.3 4545.9 4548.4 3499.9 3892.6 4076.8 4095.6 4097.8 3601.1 3739.7 3758.5 3832.7 3852.7 1192.9 1207.6 1212.1 1213.6 1220.3 706.3 830.4 836.8 843.9 846.0 5423.3 5440.2 5448.9 5511.8 5521.8 883.7 884.2 888.7 907.2 911.6 3560.5 3597.7 3672.5 3686.8 3748.8 9284.2 9599.0 9613.9 9669.6 9734.8 9528.2 9576.5 9614.2 9660.2 9676.5 7023.7 7202.1 7321.5 7323.9 7362.8 5407.6 5458.3 5525.5 5589.4 5594.2 8720.0 8775.3 8798.0 8845.0 8933.9 8658.6 8995.5 9008.3 9042.6 9049.2 6121.4 6392.2 6591.0 6633.8 6827.1 7761.0 7804.3 7805.3 7843.1 7854.4 6594.2 6746.9 6833.5 6860.2 6981.9 6907.0 6930.0 6933.1 7029.8 7034.8 6177.7 6185.2 6282.8 6299.0 6421.5 4844.1 4901.7 4920.5 4938.6 5049.1 4997.2 5079.7 5111.1 5147.9 5169.2 16:08:02 INFO - PROCESS | 10312 | 16:08:02 INFO - PROCESS | 10312 | [#4] prototype.html Cycles:180 Average:4375.30 Median:5043.10 stddev:1286.47 (25.5%) stddev-sans-first:1253.08 16:08:02 INFO - PROCESS | 10312 | Values: 294.0 296.8 297.6 300.1 302.9 5039.5 5069.5 5074.7 5110.7 5119.7 4984.8 5012.7 5024.3 5027.7 5031.4 3764.9 3860.9 3980.0 3996.4 4000.3 3982.6 3993.5 3995.2 3999.5 4003.8 3966.3 3970.4 3970.8 3973.6 3982.3 3636.4 3831.8 3847.4 3946.4 3947.0 3384.9 3398.2 3401.1 3406.4 3413.8 4810.5 4811.0 4816.7 4823.0 4826.3 4295.8 4442.2 4446.1 4446.8 4448.9 5253.7 5253.8 5255.6 5260.3 5274.9 3535.5 3550.5 3561.4 3582.9 3586.8 5329.9 5449.4 5460.3 5469.2 5482.8 3807.9 3821.0 3821.8 3826.7 3840.1 3830.6 3841.2 3843.1 3843.9 3851.8 4408.7 4435.3 4439.2 4440.5 4452.0 5046.7 5249.3 5252.9 5263.3 5288.9 1317.0 1324.2 1329.5 1333.5 1336.7 839.5 850.0 854.6 856.0 880.4 4489.5 4556.8 4576.9 4593.4 4609.6 5367.3 5429.9 5447.0 5454.0 5456.4 4410.7 4468.3 4517.4 4573.8 4575.4 2922.4 2931.6 2940.0 2960.3 2961.6 5113.6 5146.5 5179.7 5180.1 5182.5 5400.1 5622.9 5643.3 5686.3 5700.8 5054.3 5088.3 5120.3 5126.9 5136.3 5418.0 5432.1 5472.7 5477.8 5494.4 5103.1 5341.8 5364.9 5383.8 5423.1 5103.4 5139.4 5142.0 5149.5 5153.6 3844.4 3856.9 3861.3 3875.8 3891.5 5244.5 5536.8 5539.9 5540.7 5547.2 5332.4 5347.5 5368.1 5369.6 5374.3 5115.2 5320.5 5322.2 5342.8 5355.5 5210.1 5216.2 5229.3 5232.1 5240.8 5113.8 5187.8 5319.7 5350.6 5362.6 5207.3 5248.2 5256.6 5258.2 5269.8 16:08:02 INFO - PROCESS | 10312 | 16:08:02 INFO - PROCESS | 10312 | [#5] yui.html Cycles:180 Average:13783.59 Median:41545.38 stddev:16361.92 (39.4%) stddev-sans-first:16378.12 16:08:02 INFO - PROCESS | 10312 | Values: 656.9 731.5 765.5 765.5 773.0 11807.1 12009.7 12060.6 12092.9 12119.6 12188.5 12276.0 12451.4 12703.3 12712.5 620.9 775.4 783.4 796.5 798.1 778.0 778.4 779.6 780.7 789.6 811.4 815.9 816.4 816.8 821.4 804.2 807.7 808.2 808.9 811.7 586.8 592.6 593.0 593.4 593.7 12739.8 12858.1 12865.3 12868.0 12907.4 12114.3 12272.8 12316.8 12446.9 12482.3 10420.2 10439.9 10471.8 10615.4 10690.1 3281.5 3317.3 3365.6 3385.0 3452.8 47829.5 48039.8 48218.3 49094.3 49375.0 10023.8 10170.2 10243.2 10277.2 10501.6 16215.8 18471.0 18473.6 18551.0 18639.6 6789.4 6936.1 6938.9 6988.8 7001.2 3672.9 3751.2 3753.9 3763.8 3766.9 2703.7 2747.1 2842.5 2843.1 2844.7 535.8 557.0 557.6 558.5 558.9 478.8 540.4 560.9 585.0 629.7 8351.9 8416.4 8530.9 8551.8 8751.3 506.6 540.0 598.4 623.1 638.4 3941.0 4046.7 4091.3 4177.7 4191.6 59495.4 59678.4 59978.1 60294.4 60711.7 52630.5 53245.0 53958.2 54375.5 55145.4 49978.3 50387.2 50434.7 50649.2 51232.7 7311.8 7386.5 7547.8 7562.7 7578.2 33131.3 33705.0 33797.2 33831.2 34724.3 36969.4 38587.0 41215.4 41363.4 41727.4 11124.7 11155.0 11236.4 11400.3 11469.9 12083.0 12308.7 12381.9 12474.1 12932.3 11613.4 11631.9 11750.0 11984.2 12033.8 10847.9 11266.2 11466.3 11574.9 11794.5 10326.5 11142.4 11272.5 11332.1 11615.2 9835.2 10037.2 10046.3 10087.6 10228.6 9345.6 9816.2 9839.8 9866.5 9915.7 16:08:02 INFO - PROCESS | 10312 | -------- Summary: end -------- 16:08:02 INFO - PROCESS | 10312 | 16:08:02 INFO - TEST-INFO | 10312: exit 0 16:08:02 INFO - TEST-OK | dromaeo_css | took 1116673ms 16:08:02 INFO - TEST-START | kraken 16:08:02 INFO - operating with platform_type : linux_ 16:08:02 INFO - Initialising browser for kraken test... 16:08:02 INFO - TEST-INFO | started process 10556 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp70i921/profile http://localhost:48565/getInfo.html) 16:08:07 INFO - PROCESS | 10556 | 16:08:07 INFO - PROCESS | 10556 | (process:10626): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:08:08 INFO - PROCESS | 10556 | __metrics Screen width/height:1600/1200 16:08:08 INFO - PROCESS | 10556 | colorDepth:24 16:08:08 INFO - PROCESS | 10556 | Browser inner width/height: 1024/697 16:08:08 INFO - PROCESS | 10556 | __metrics 16:08:08 ERROR - PROCESS | 10556 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 16:08:09 INFO - TEST-INFO | 10556: exit 0 16:08:09 INFO - Browser initialized. 16:08:09 INFO - Running cycle 1/1 for kraken test... 16:08:09 INFO - TEST-INFO | started process 10677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp70i921/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:11 INFO - PROCESS | 10677 | 16:08:11 INFO - PROCESS | 10677 | (process:10738): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:08:21 INFO - PROCESS | 10677 | RSS: Main: 164986880 16:08:21 INFO - PROCESS | 10677 | 16:08:24 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:48565/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48565/tests/kraken/driver.html?testName=audio-beat-detection) 16:08:25 INFO - PROCESS | 10677 | RSS: Main: 168828928 16:08:25 INFO - PROCESS | 10677 | 16:08:28 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:48565/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48565/tests/kraken/driver.html?testName=audio-dft) 16:08:29 INFO - PROCESS | 10677 | RSS: Main: 168783872 16:08:29 INFO - PROCESS | 10677 | 16:08:32 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:48565/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48565/tests/kraken/driver.html?testName=audio-fft) 16:08:32 INFO - PROCESS | 10677 | RSS: Main: 164655104 16:08:32 INFO - PROCESS | 10677 | 16:08:34 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:48565/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48565/tests/kraken/driver.html?testName=audio-oscillator) 16:08:35 INFO - PROCESS | 10677 | RSS: Main: 164560896 16:08:35 INFO - PROCESS | 10677 | 16:08:37 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:48565/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48565/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:08:38 INFO - PROCESS | 10677 | RSS: Main: 165048320 16:08:38 INFO - PROCESS | 10677 | 16:08:41 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:48565/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48565/tests/kraken/driver.html?testName=imaging-darkroom) 16:08:42 INFO - PROCESS | 10677 | RSS: Main: 165007360 16:08:42 INFO - PROCESS | 10677 | 16:08:46 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:48565/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48565/tests/kraken/driver.html?testName=imaging-desaturate) 16:08:46 INFO - PROCESS | 10677 | RSS: Main: 163291136 16:08:46 INFO - PROCESS | 10677 | 16:08:49 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:48565/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48565/tests/kraken/driver.html?testName=json-parse-financial) 16:08:50 INFO - PROCESS | 10677 | RSS: Main: 164380672 16:08:50 INFO - PROCESS | 10677 | 16:08:52 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:48565/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48565/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:08:52 INFO - PROCESS | 10677 | RSS: Main: 164724736 16:08:52 INFO - PROCESS | 10677 | 16:08:54 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:48565/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48565/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:08:55 INFO - PROCESS | 10677 | RSS: Main: 165003264 16:08:55 INFO - PROCESS | 10677 | 16:08:57 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:48565/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48565/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:08:58 INFO - PROCESS | 10677 | RSS: Main: 165294080 16:08:58 INFO - PROCESS | 10677 | 16:09:01 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:48565/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:09:01 INFO - PROCESS | 10677 | RSS: Main: 165597184 16:09:01 INFO - PROCESS | 10677 | 16:09:04 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:48565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:09:05 INFO - PROCESS | 10677 | RSS: Main: 164958208 16:09:05 INFO - PROCESS | 10677 | 16:09:07 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:48565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48565/tests/kraken/driver.html?testName=ai-astar) 16:09:07 INFO - PROCESS | 10677 | RSS: Main: 167501824 16:09:07 INFO - PROCESS | 10677 | 16:09:07 INFO - PROCESS | 10677 | __start_tp_report 16:09:07 INFO - PROCESS | 10677 | _x_x_mozilla_page_load 16:09:07 INFO - PROCESS | 10677 | _x_x_mozilla_page_load_details 16:09:07 INFO - PROCESS | 10677 | |i|pagename|runs| 16:09:07 INFO - PROCESS | 10677 | |0;ai-astar;115;113;114;117;116;115;115;114;115;115 16:09:07 INFO - PROCESS | 10677 | |1;audio-beat-detection;163;135;161;224;132;159;151;132;190;130 16:09:07 INFO - PROCESS | 10677 | |2;audio-dft;162;166;175;161;164;163;161;162;162;163 16:09:07 INFO - PROCESS | 10677 | |3;audio-fft;75;76;76;162;76;76;77;76;160;75 16:09:07 INFO - PROCESS | 10677 | |4;audio-oscillator;94;93;178;97;96;94;147;94;95;140 16:09:07 INFO - PROCESS | 10677 | |5;imaging-gaussian-blur;118;118;118;118;118;118;118;117;117;118 16:09:07 INFO - PROCESS | 10677 | |6;imaging-darkroom;149;148;148;148;148;147;147;148;147;148 16:09:07 INFO - PROCESS | 10677 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 16:09:07 INFO - PROCESS | 10677 | |8;json-parse-financial;66;65;65;65;64;66;66;68;64;66 16:09:07 INFO - PROCESS | 10677 | |9;json-stringify-tinderbox;65;65;64;64;65;65;65;65;65;65 16:09:07 INFO - PROCESS | 10677 | |10;stanford-crypto-aes;83;83;88;82;83;84;84;83;139;83 16:09:07 INFO - PROCESS | 10677 | |11;stanford-crypto-ccm;128;131;133;134;131;130;128;132;153;136 16:09:07 INFO - PROCESS | 10677 | |12;stanford-crypto-pbkdf2;170;174;174;173;170;172;171;174;173;170 16:09:07 INFO - PROCESS | 10677 | |13;stanford-crypto-sha256-iterative;70;71;66;67;75;65;66;71;70;64 16:09:07 INFO - PROCESS | 10677 | __end_tp_report 16:09:07 INFO - PROCESS | 10677 | __start_cc_report 16:09:07 INFO - PROCESS | 10677 | _x_x_mozilla_cycle_collect,990 16:09:07 INFO - PROCESS | 10677 | __end_cc_report 16:09:07 INFO - PROCESS | 10677 | __startTimestamp1463785747445__endTimestamp 16:09:07 INFO - PROCESS | 10677 | 16:09:07 INFO - PROCESS | 10677 | ------- Summary: start ------- 16:09:07 INFO - PROCESS | 10677 | Number of tests: 14 16:09:07 INFO - PROCESS | 10677 | 16:09:07 INFO - PROCESS | 10677 | [#0] ai-astar Cycles:10 Average:114.90 Median:115.00 stddev:1.10 (1.0%) stddev-sans-first:1.17 16:09:07 INFO - PROCESS | 10677 | Values: 115.0 113.0 114.0 117.0 116.0 115.0 115.0 114.0 115.0 115.0 16:09:07 INFO - PROCESS | 10677 | 16:09:07 INFO - PROCESS | 10677 | [#1] audio-beat-detection Cycles:10 Average:157.70 Median:160.00 stddev:30.05 (18.8%) stddev-sans-first:31.81 16:09:07 INFO - PROCESS | 10677 | Values: 163.0 135.0 161.0 224.0 132.0 159.0 151.0 132.0 190.0 130.0 16:09:07 INFO - PROCESS | 10677 | 16:09:07 INFO - PROCESS | 10677 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:4.18 (2.6%) stddev-sans-first:4.37 16:09:07 INFO - PROCESS | 10677 | Values: 162.0 166.0 175.0 161.0 164.0 163.0 161.0 162.0 162.0 163.0 16:09:07 INFO - PROCESS | 10677 | 16:09:07 INFO - PROCESS | 10677 | [#3] audio-fft Cycles:10 Average:92.90 Median:76.00 stddev:35.90 (47.2%) stddev-sans-first:37.49 16:09:07 INFO - PROCESS | 10677 | Values: 75.0 76.0 76.0 162.0 76.0 76.0 77.0 76.0 160.0 75.0 16:09:07 INFO - PROCESS | 10677 | 16:09:07 INFO - PROCESS | 10677 | [#4] audio-oscillator Cycles:10 Average:112.80 Median:94.00 stddev:30.66 (32.6%) stddev-sans-first:31.76 16:09:07 INFO - PROCESS | 10677 | Values: 94.0 93.0 178.0 97.0 96.0 94.0 147.0 94.0 95.0 140.0 16:09:07 INFO - PROCESS | 10677 | 16:09:07 INFO - PROCESS | 10677 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:09:07 INFO - PROCESS | 10677 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 117.0 118.0 16:09:07 INFO - PROCESS | 10677 | 16:09:07 INFO - PROCESS | 10677 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 16:09:07 INFO - PROCESS | 10677 | Values: 149.0 148.0 148.0 148.0 148.0 147.0 147.0 148.0 147.0 148.0 16:09:07 INFO - PROCESS | 10677 | 16:09:07 INFO - PROCESS | 10677 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 16:09:07 INFO - PROCESS | 10677 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:09:07 INFO - PROCESS | 10677 | 16:09:07 INFO - PROCESS | 10677 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:66.00 stddev:1.18 (1.8%) stddev-sans-first:1.24 16:09:07 INFO - PROCESS | 10677 | Values: 66.0 65.0 65.0 65.0 64.0 66.0 66.0 68.0 64.0 66.0 16:09:07 INFO - PROCESS | 10677 | 16:09:07 INFO - PROCESS | 10677 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 16:09:07 INFO - PROCESS | 10677 | Values: 65.0 65.0 64.0 64.0 65.0 65.0 65.0 65.0 65.0 65.0 16:09:07 INFO - PROCESS | 10677 | 16:09:07 INFO - PROCESS | 10677 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:83.00 stddev:17.57 (21.2%) stddev-sans-first:18.50 16:09:07 INFO - PROCESS | 10677 | Values: 83.0 83.0 88.0 82.0 83.0 84.0 84.0 83.0 139.0 83.0 16:09:07 INFO - PROCESS | 10677 | 16:09:07 INFO - PROCESS | 10677 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:132.50 stddev:7.26 (5.5%) stddev-sans-first:7.41 16:09:07 INFO - PROCESS | 10677 | Values: 128.0 131.0 133.0 134.0 131.0 130.0 128.0 132.0 153.0 136.0 16:09:07 INFO - PROCESS | 10677 | 16:09:07 INFO - PROCESS | 10677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:173.00 stddev:1.73 (1.0%) stddev-sans-first:1.66 16:09:07 INFO - PROCESS | 10677 | Values: 170.0 174.0 174.0 173.0 170.0 172.0 171.0 174.0 173.0 170.0 16:09:07 INFO - PROCESS | 10677 | 16:09:07 INFO - PROCESS | 10677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:70.00 stddev:3.44 (4.9%) stddev-sans-first:3.61 16:09:07 INFO - PROCESS | 10677 | Values: 70.0 71.0 66.0 67.0 75.0 65.0 66.0 71.0 70.0 64.0 16:09:07 INFO - PROCESS | 10677 | -------- Summary: end -------- 16:09:07 INFO - PROCESS | 10677 | 16:09:08 INFO - TEST-INFO | 10677: exit 0 16:09:08 INFO - TEST-OK | kraken | took 65544ms 16:09:08 INFO - SUITE-END | took 1182s 16:09:08 INFO - Completed test suite (00:19:42) 16:09:08 INFO - javascript benchmark 16:09:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6334.146088045017, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2664.5736682130855, 2669.94660106798, 2677.8661066946647, 2710.200490855199, 2712.9321766955823, 4673.5092815254375, 4677.391939047923, 4685.320628508873, 4703.694259873106, 4742.97628511857, 4575.794089265983, 4708.128996135717, 4755.072760811643, 4789.18583840747, 4826.179549476588, 4347.5652434756585, 4423.77881105945, 4487.932681009787, 4489.124620698965, 4511.255642818931, 574.9095578521071, 4016.6704951924644, 4295.248331541983, 4297.570242975708, 4395.824167033315, 4398.472183338004, 4404.383386325917, 4419.160359531678, 4427.2695005324085, 4454.57681520255, 4400.09797991411, 4422.0, 4425.734455932622, 4443.577860103317, 4450.376947227391, 4270.039241170743, 4350.0, 4367.803448844809, 4389.934150987738, 4394.472663280427, 4622.9075418491775, 4641.11818754439, 4652.790624421909, 4672.789724462407, 4700.2949557566635, 4907.2393778964315, 5060.873478163038, 5107.4892510749, 5108.616853735947, 5126.71803050832, 5132.538071573539, 5154.690718556899, 5157.510036546522, 5172.61205409592, 5227.581793456515, 4748.097861406356, 4816.807327706852, 4819.770958405584, 4831.782569784298, 4848.369711937461, 5023.070731914608, 5179.922301165486, 5185.377754669388, 5253.054450199001, 5267.0, 5007.324011258506, 5028.497150285016, 5062.519060689228, 5064.518870707277, 5094.847154585294, 5072.82245121419, 5135.35808023997, 5136.845894623168, 5146.6911985281, 5160.664556803796, 4918.606511479073, 5044.697318160922, 5087.033463641897, 5096.0, 5110.642255042111, 4996.7501624918605, 5032.823851165192, 5038.874028149326, 5047.495250474996, 5123.948760512421, 4345.130973805251, 4398.494173170063, 4398.978005110018, 4404.823807047746, 4446.444194475691, 3693.7045036397026, 3700.685441737429, 3780.1872597391143, 3804.524434445694, 3808.409696497047, 4340.956590434118, 4349.608535231781, 4361.258586040381, 4387.956120438818, 4446.911061778811, 5176.689398636018, 5180.430152683201, 5181.4559471255725, 5187.455317191716, 5197.58419326453, 4266.807993640294, 4319.287317592562, 4319.503257125408, 4369.257226271541, 4441.71128876622, 4499.955000450019, 4567.223571992769, 4574.428196475441, 4575.519570445122, 4650.046740418206, 4809.519048095162, 4820.590249828733, 4851.054044461296, 4854.17479028559, 4900.558949694545, 5201.817936372209, 5202.271681964452, 5206.349206349207, 5216.321878155815, 5217.50433708797, 4618.884527886829, 4696.107739529479, 4698.177818881751, 4752.643551733565, 4756.857294281177, 4979.975100124476, 4981.953789704203, 5034.942662041012, 5111.539961403491, 5159.942211846487, 5161.277421160966, 5164.0962831505085, 5171.379434467737, 5172.043172013189, 5173.611979101507, 5024.07054694868, 5027.296178535081, 5035.420926593342, 5041.1430056889685, 5068.746562671926, 4818.10864989978, 4921.557059864629, 4973.676711013773, 5006.674566153189, 5007.524285192901, 4874.6344024197615, 4916.950830491793, 4920.040592084509, 4931.728754918514, 4933.161362568444, 4864.294677271705, 5051.090803655377, 5052.924206136838, 5055.216441451581, 5063.0380227756605, 4871.464138944642, 4881.389826271716, 4911.557959783637, 4925.729084900365, 4928.457869634266], "value": 4656.942614507704, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.3084112149533, 591.8313280714997, 602.653474252305, 609.247579239639, 624.5128799536358, 38824.41763373548, 39887.2022559549, 39942.0, 40065.0, 40177.39733903994, 40917.795411022904, 40946.795266023626, 41513.58486415135, 41869.0, 41871.58128418715, 7623.542587444771, 7797.33722633574, 7799.5710235937, 7819.139894611617, 7853.2539408756365, 7586.7344642937505, 7607.429442791785, 7680.385569154482, 7706.267904549059, 7711.884321735179, 7705.537667739925, 7709.575973321493, 7715.074191097076, 7719.8070048248965, 7751.7674469766, 7656.5406075635365, 7699.461037727361, 7699.538027718327, 7702.845943081107, 7710.807229819271, 7342.0, 7763.844723105506, 7770.689172433096, 7798.844023119563, 7810.062792464883, 37278.62721372806, 37903.62096379029, 37994.62005379939, 38118.0, 38189.23621527554, 3031.1512776422637, 3162.739780558813, 3277.5083737439336, 3404.370191514553, 3949.624785645359, 30186.0, 30198.24504387386, 30398.088057358094, 30521.847390763127, 30752.0, 3515.0860776198115, 3624.818759062063, 3680.9447858282147, 3716.0524066363173, 3722.9069273268383, 265900.0, 266369.0, 266459.0, 266513.0, 267362.0, 32338.676613233565, 33360.332793343994, 54602.45397546053, 54869.45130548723, 55033.1745023825, 34371.0, 34546.65453345434, 34686.65313346885, 34721.826390867885, 34903.0, 11878.762424751629, 11897.286162830258, 11945.761084778429, 12083.57707480234, 12151.270923744603, 9317.72046838596, 9435.90564094364, 9446.291528135418, 9453.054694530629, 9466.432014079177, 8002.439829211899, 8053.919460805317, 8070.717524886601, 8074.596270186467, 8127.106018337978, 3153.5585018097486, 3167.160702413862, 3169.065125787898, 3197.6802319767835, 3201.279712064767, 870.2907130688469, 912.6760000199966, 918.7197904639015, 971.8882328532168, 1073.1736266344835, 29136.271593209916, 29144.755879741013, 29330.853345733136, 29415.705842941297, 29693.0, 908.2098574240453, 993.4486360070086, 1040.9479526023667, 1051.6844946516014, 1123.685368096934, 14818.25908704582, 14983.175925324213, 14988.775168372484, 15033.624159395884, 15051.698966020836, 380873.0, 386296.0, 386581.0, 388710.0, 391039.0, 50427.24359134616, 50883.236751448756, 50958.235626465634, 51006.234906476435, 51046.234306485436, 1185.1881461199107, 1203.9699007524707, 1206.589759481763, 1217.3061355027726, 1227.9324637144864, 26161.345966350993, 27721.168364949084, 27886.44227115487, 27972.58041129344, 28013.439731204853, 42059.0, 42212.0, 42252.15495690131, 42541.574584255, 42592.14815703606, 319834.0, 321264.0, 321616.0, 321880.0, 322597.0, 25064.498710026062, 25212.74787252104, 25795.484090317714, 25823.48353032891, 25850.48299033971, 38782.6121738779, 42198.57801421946, 42885.5711442894, 42900.0, 43007.354889677306, 36775.0, 36848.44727329039, 36953.260934780614, 37346.626533734314, 38068.42897356486, 36815.07962300964, 36828.81585592055, 37080.62919370772, 37388.439173411876, 37618.811905940296, 30680.50057974484, 35806.82096589501, 36166.27667446584, 36373.09067273339, 37021.62978370182, 33603.159921002174, 34429.311413772084, 34533.0, 34857.0, 35033.474497883064, 25804.0, 26332.473350533266, 26431.354207611694, 26463.206103816916, 26464.0], "value": 16600.728564211782, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.2893985667803, 367.4616686554198, 367.86021311901476, 377.8828563145423, 381.11961369237065, 15611.921940390297, 15897.92051039746, 16952.83047169528, 16992.235349409275, 17000.149992500374, 16246.350145994176, 17029.744553831704, 17611.73582396262, 17612.64774704505, 17640.823591764078, 5039.748012599373, 5149.768260428271, 5213.2701421800975, 5240.423553409122, 5246.658967167122, 5078.8476345709505, 5174.275601415805, 5237.7381130943495, 5278.155495120782, 5287.259783630276, 5087.949120508803, 5132.4610915853855, 5162.483751624826, 5172.612054095939, 5180.0, 4959.553640172366, 5109.821156259513, 5111.744412779365, 5172.19830926207, 5241.580673546107, 4613.953860461386, 4655.464621568495, 4657.6273898088075, 4663.0, 4671.743054132022, 20304.39086827383, 20560.691589626167, 20803.063862126088, 21195.152193912225, 21278.042488088075, 2000.2599038355756, 2020.2626041494896, 2063.8442472215606, 2077.989610051955, 2249.7750224977535, 11944.283342999448, 13385.732285354336, 13657.112287701268, 13697.657558561115, 14010.159390436504, 1732.9566760830953, 1774.4410510689092, 1797.9910100449545, 1820.6449742300256, 1869.1867546245044, 69345.65327173383, 72046.63976680135, 72536.0, 72785.0, 73961.26038739597, 10184.388936663823, 10316.381017138845, 10347.379157250589, 10348.586056557653, 10509.474526273656, 14216.64458388528, 14273.92863035699, 14357.64105897361, 14371.353289102015, 14431.422743090368, 6604.834879127964, 6749.0551322814845, 6783.830404239835, 6798.76204332846, 6820.488463365267, 6132.7546898124465, 6184.474319682788, 6215.9378406215355, 6267.874642507124, 6321.146645202839, 4378.8029538670835, 4433.733975961452, 4474.955250447454, 4512.887177820581, 4547.181507328646, 1851.8703690741518, 1856.7838066066747, 1876.9436916892514, 1893.195391958412, 1897.2695512227615, 795.6777505110324, 856.9828603427896, 894.5080205886736, 938.6714649872627, 957.899420560845, 16554.0, 16914.577135571708, 17179.484615461555, 17292.0, 17595.384161554284, 869.7043005378201, 894.8568229083315, 903.4037535226719, 930.5021813329836, 966.8694726212012, 9572.329936904489, 9666.880491698164, 9747.805043899083, 9947.154491868272, 9972.0, 406278.0, 410507.0, 412419.0, 415164.0, 420249.0, 78125.0, 78513.60743196361, 79939.60030199811, 80211.0, 81424.18575814166, 868.405142477405, 882.4749274181852, 887.4896934262824, 888.4846788862444, 890.7550423633683, 15138.848611513744, 15283.541493754761, 15307.46423875159, 15349.923250383677, 15578.610534736723, 35655.821720892265, 35803.462948055276, 36204.63795362013, 37052.25895482129, 37404.81297593495, 49813.750931245115, 52197.7390113047, 52256.0, 52258.0, 52894.47105528895, 7580.62096895142, 7613.467057305936, 7647.579383133981, 7770.650320735467, 7812.3750099993, 10612.840807387742, 11391.943040285078, 11720.70698232517, 11737.119716021503, 11947.522099115939, 9755.365901216399, 10036.598536058767, 10144.239182061227, 10249.538770755185, 10488.528016239441, 9629.422234665943, 10109.797804044025, 10336.139494890991, 10504.26470147113, 10911.508982095984, 10066.748331291776, 10497.370157790558, 10517.21120915919, 10752.247342686249, 10844.945775271388, 7764.855233630388, 7815.218478152139, 7832.099308579358, 7863.292303692695, 7923.881141782763, 7816.960915195387, 9426.434413935185, 10057.446840423847, 10101.98980101984, 10260.897391025994], "value": 8284.766729598738, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1429.056822497152, 1467.919264440456, 1561.601791543157, 1747.7028905086142, 1749.6413235286768, 6758.763443279487, 7340.155882073564, 7567.545947243162, 8085.110637829841, 8103.756887293383, 7438.888416673754, 7650.770476885702, 7711.190325015863, 7752.728654497094, 7765.301122898938, 2153.074178103415, 2191.923282685106, 2193.8135258502966, 2200.3948914048683, 2201.042546492273, 2126.2345555599973, 2175.967360489594, 2198.461376962646, 2208.194009186643, 2219.0901730290584, 2158.5251244726137, 2161.167950339123, 2175.1516908405733, 2193.1337121836864, 2240.2943072931976, 2096.0986775686447, 2107.104480595741, 2109.8312135029237, 2119.6078725435846, 2124.0972586650687, 2090.7491101067817, 2126.755423126345, 2127.755308139568, 2133.487962888911, 2133.95732085359, 7595.734149304803, 7613.390928725744, 7667.846643067108, 7685.538867667958, 7706.884396734054, 4364.476262848447, 4513.187626227278, 4519.299508576176, 4519.661025423106, 4533.297338912474, 2727.440874620698, 2809.7752179825566, 2902.506573882445, 2905.186547766629, 2912.941741165186, 836.0970152235572, 848.1857416879802, 853.0318088969003, 857.0486759696731, 886.246690313235, 10765.730856728565, 10770.946145269223, 10827.458627068694, 10860.565577376896, 10860.782784344268, 4182.623563879265, 4301.548337424525, 4360.389545463638, 4364.236258654722, 4371.344298355209, 9243.39917905334, 9294.117058879396, 9297.67458138962, 9301.116393942564, 9307.53462326881, 4435.578620031092, 4534.886627834265, 4545.340925565841, 4545.863624091283, 4548.385967894292, 3499.8600055997986, 3892.649661530419, 4076.8369265229653, 4095.610916962884, 4097.836086556564, 3601.099725068733, 3739.7382183247455, 3758.4926034985474, 3832.7317087803585, 3852.6917846572205, 1192.898603618702, 1207.5833837326109, 1212.0788200967152, 1213.6237766292477, 1220.3044264768996, 706.3007622453733, 830.3730683334044, 836.7949852286229, 843.8649816029406, 845.9873101903477, 5423.349198096174, 5440.183972404171, 5448.863778405572, 5511.834644960577, 5521.751521181556, 883.739296907401, 884.1777147252988, 888.6623083228332, 907.1925985872579, 911.6171208092485, 3560.4659301105044, 3597.7481576289933, 3672.5042119313553, 3686.8340924658455, 3748.793816340073, 9284.164425201629, 9598.95200523993, 9613.855792163124, 9669.613215471303, 9734.756631084138, 9528.19010384125, 9576.47329396876, 9614.230861531061, 9660.227181825438, 9676.516174191262, 7023.719051237893, 7202.099737532809, 7321.450891183183, 7323.853522929511, 7362.77911662651, 5407.5944304176555, 5458.344998600193, 5525.508112809439, 5589.357223919302, 5594.1608758686525, 8720.0, 8775.297976162019, 8798.032216456313, 8845.0, 8933.910660893567, 8658.567071646266, 8995.460272383678, 9008.32437567172, 9042.593083311136, 9049.185573298435, 6121.418465245794, 6392.169018027626, 6591.044298576776, 6633.767818126343, 6827.078344423439, 7761.0298712660915, 7804.2585954334245, 7805.297523222937, 7843.098043724816, 7854.371650268079, 6594.208694956636, 6746.9325306746305, 6833.453323734188, 6860.245373009065, 6981.895271571032, 6907.03301537775, 6929.965350173217, 6933.064036355027, 7029.789106326818, 7034.788956331318, 6177.722002509808, 6185.195924529782, 6282.811515654537, 6299.0, 6421.518386121153, 4844.079624871263, 4901.681390709735, 4920.507949205051, 4938.629313058042, 5049.141645920276, 4997.200447928314, 5079.6698214615935, 5111.105556527667, 5147.871303217449, 5169.172932330809], "value": 4166.380777452085, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.95149800282957, 296.7507293873147, 297.61161684002377, 300.12214273250765, 302.9336734693877, 5039.496050394959, 5069.467705890879, 5074.720890351029, 5110.667806592578, 5119.718415487151, 4984.828565287155, 5012.72430016349, 5024.346834911456, 5027.748612569375, 5031.371078615173, 3764.929288891106, 3860.86486972956, 3979.98010009951, 3996.3605823068315, 4000.2599519089063, 3982.6459003938653, 3993.5207775067033, 3995.180987897474, 3999.460072890152, 4003.819828107742, 3966.305896468121, 3970.364741641338, 3970.8014599270064, 3973.582773808752, 3982.2632812929555, 3636.3636363636524, 3831.8467261309515, 3847.4228865670093, 3946.4474973503734, 3946.9605303947023, 3384.9492257616157, 3398.218409765768, 3401.149712571857, 3406.403879321134, 3413.8293085345636, 4810.542998415145, 4810.95189048112, 4816.699491137409, 4822.9758851205515, 4826.321391627645, 4295.818649871279, 4442.2004039272915, 4446.133004064209, 4446.7554284514335, 4448.866534003985, 5253.737313134367, 5253.789848406059, 5255.5795536357, 5260.289860868772, 5274.894502109936, 3535.469679548088, 3550.5206797082324, 3561.4123669594487, 3582.946255806139, 3586.8385922633283, 5329.893402131975, 5449.373322067973, 5460.34475862899, 5469.206964990054, 5482.80810171642, 3807.8667246646232, 3820.9617903821163, 3821.8280177392085, 3826.674732647756, 3840.116773142193, 3830.578636349999, 3841.1741475582885, 3843.077661361309, 3843.8846834595006, 3851.826667799956, 4408.699433667076, 4435.3125265583885, 4439.178751930903, 4440.4902333206865, 4452.0, 5046.697198168122, 5249.291345668362, 5252.894942101213, 5263.26314315996, 5288.937314447368, 1317.0451422718645, 1324.1723922548408, 1329.5147271245926, 1333.5265980576755, 1336.7167519181694, 839.5088873009236, 849.9830003400021, 854.6154230596132, 855.9657613695507, 880.423322723617, 4489.483709373464, 4556.7721613919175, 4576.885577860514, 4593.356930029799, 4609.562091601292, 5367.275417818622, 5429.945700542944, 5446.972765136149, 5454.0, 5456.427075157051, 4410.669199810027, 4468.262736648481, 4517.412736344254, 4573.787946194261, 4575.405197324327, 2922.40728802803, 2931.5749216363506, 2939.955900661492, 2960.3191266008507, 2961.555766635022, 5113.593761715483, 5146.4853514648985, 5179.736765837573, 5180.119379705384, 5182.53357197854, 5400.055979847252, 5622.943770562324, 5643.266375371176, 5686.289213848269, 5700.7719691212715, 5054.292399064134, 5088.287639730441, 5120.257562653394, 5126.923096153635, 5136.280920671109, 5417.972910135424, 5432.130859062531, 5472.671639701631, 5477.849651573214, 5494.36814766307, 5103.132467480612, 5341.786328546815, 5364.892702146013, 5383.757730902197, 5423.132298832325, 5103.362079740033, 5139.383274007143, 5142.0, 5149.506643073467, 5153.561947234377, 3844.4041173618134, 3856.9035774105873, 3861.343571592892, 3875.767453952772, 3891.494105766232, 5244.475552444877, 5536.806211782568, 5539.8892022160135, 5540.722963851872, 5547.223388725501, 5332.413434522122, 5347.545458636059, 5368.114261146867, 5369.550221440268, 5374.274472946102, 5115.240298380613, 5320.547753441001, 5322.201669749568, 5342.78628854857, 5355.518003379714, 5210.0983141153965, 5216.217567364925, 5229.294045303835, 5232.110541207928, 5240.7641656126325, 5113.795448182031, 5187.832737634002, 5319.734013299397, 5350.6254562180275, 5362.624616276979, 5207.3490813648295, 5248.160294352885, 5256.6320357574605, 5258.158694608845, 5269.841904742864], "value": 3959.6557518952627, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.9375909288618, 731.4952682648968, 765.5024234247738, 765.5100735529259, 773.0491495460583, 11807.114466415022, 12009.699757506067, 12060.57787977421, 12092.939535302323, 12119.575814846483, 12188.51245950161, 12276.0, 12451.439685214165, 12703.301318427482, 12712.491500339998, 620.9099680546341, 775.391317815515, 783.4202690009381, 796.5300472721093, 798.0981490915258, 778.0468925566192, 778.3617433704364, 779.555653277632, 780.6916268074108, 789.6091434739811, 811.407672399149, 815.8572249856281, 816.4121832280748, 816.779469543223, 821.4003777242586, 804.1757198871175, 807.6930766308794, 808.2160304504621, 808.9231523005305, 811.6712731343815, 586.7711592478937, 592.6414519215856, 593.0, 593.4065934065934, 593.7387549478216, 12739.808902866464, 12858.099933004694, 12865.292408917507, 12868.0, 12907.419166137546, 12114.273143611412, 12272.815907761391, 12316.81524777129, 12446.875531244663, 12482.251064936043, 10420.218483613759, 10439.94780026095, 10471.790564188674, 10615.363078215254, 10690.144788416987, 3281.5405843181975, 3317.336532693471, 3365.6297807241185, 3384.966150338514, 3452.7928324300624, 47829.521704782856, 48039.75980120112, 48218.27672584914, 49094.263586046596, 49375.0, 10023.799524009479, 10170.186385089175, 10243.231757618209, 10277.17782577392, 10501.632442864464, 16215.756763648555, 18471.0, 18473.630527389647, 18551.0, 18639.627207455775, 6789.422899053537, 6936.098307220029, 6938.895916561256, 6988.79033628992, 7001.159860816734, 3672.926541469156, 3751.2309976454762, 3753.9061523461587, 3763.849446022183, 3766.8681596144, 2703.6620422447195, 2747.079728291005, 2842.545192769147, 2843.1470558832266, 2844.7155284471387, 535.7508758427272, 557.027986164138, 557.6236040672529, 558.5419955636339, 558.8546977785805, 478.7701903086468, 540.394757871179, 560.9046462101453, 585.0376131264131, 629.7071861584385, 8351.916480835236, 8416.410851240476, 8530.914690853137, 8551.828963420698, 8751.299896008304, 506.6200349737697, 539.9568034557226, 598.4494265275956, 623.1307326279814, 638.4126603524768, 3940.9605903941165, 4046.716729828943, 4091.324931386288, 4177.6866734995, 4191.64371028466, 59495.40504594899, 59678.40321596815, 59978.10032849511, 60294.39705602975, 60711.69644151839, 52630.47369526256, 53245.0, 53958.190627140626, 54375.45624543704, 55145.44854551483, 49978.250326245136, 50387.24419133716, 50434.74782626063, 50649.24026139611, 51232.74383628058, 7311.817204569716, 7386.519876208029, 7547.811304717426, 7562.659680314509, 7578.204288549623, 33131.337373252885, 33705.0, 33797.155071123416, 33831.154221144665, 34724.30551389009, 36969.44545831868, 38587.0, 41215.381769272884, 41363.379549306184, 41727.374089388075, 11124.666260012213, 11155.0, 11236.438178090899, 11400.258983166068, 11469.885301147215, 12083.0, 12308.692282692646, 12381.938090309492, 12474.126811123135, 12932.288724120264, 11613.419329033346, 11631.88368116308, 11750.0, 11984.161108722306, 12033.759324813629, 10847.945760271465, 11266.155038371991, 11466.31202127875, 11574.942125289319, 11794.469248883992, 10326.535305911402, 11142.442877856236, 11272.492737826982, 11332.093432525544, 11615.186936914335, 9835.16401105914, 10037.19702423819, 10046.346987445793, 10087.596496140366, 10228.64199753005, 9345.626174952926, 9816.214702823614, 9839.803203936024, 9866.506674666382, 9915.702528924145], "value": 6111.647882609872, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1596.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 114.0, 117.0, 116.0, 115.0, 115.0, 114.0, 115.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 135.0, 161.0, 224.0, 132.0, 159.0, 151.0, 132.0, 190.0, 130.0], "value": 157.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 175.0, 161.0, 164.0, 163.0, 161.0, 162.0, 162.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 162.0, 76.0, 76.0, 77.0, 76.0, 160.0, 75.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 178.0, 97.0, 96.0, 94.0, 147.0, 94.0, 95.0, 140.0], "value": 112.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 64.0, 66.0, 66.0, 68.0, 64.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 88.0, 82.0, 83.0, 84.0, 84.0, 83.0, 139.0, 83.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 131.0, 133.0, 134.0, 131.0, 130.0, 128.0, 132.0, 153.0, 136.0], "value": 133.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 174.0, 174.0, 173.0, 170.0, 172.0, 171.0, 174.0, 173.0, 170.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 66.0, 67.0, 75.0, 65.0, 66.0, 71.0, 70.0, 64.0], "value": 68.5, "unit": "score"}]}]} 16:09:08 INFO - Return code: 0 16:09:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:09:08 ERROR - # TBPL SUCCESS # 16:09:08 INFO - Running post-action listener: _resource_record_post_action 16:09:08 INFO - ##### 16:09:08 INFO - ##### Finished run-tests step (success) 16:09:08 INFO - ##### 16:09:08 INFO - Running post-run listener: _resource_record_post_run 16:09:08 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 302977024; Read time: 20; Write time: 337896 16:09:08 INFO - TinderboxPrint: CPU usage
13.3% 16:09:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 16:09:08 INFO - TinderboxPrint: I/O write bytes / time
302,977,024 / 337,896 16:09:08 INFO - TinderboxPrint: CPU idle
8,293.0 (86.7%) 16:09:08 INFO - TinderboxPrint: CPU user
1,222.7 (12.8%) 16:09:08 INFO - TinderboxPrint: Swap in / out
0 / 0 16:09:08 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13885440; Read time: 0; Write time: 2344 16:09:08 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289091584; Read time: 20; Write time: 335552 16:09:09 INFO - Running post-run listener: _upload_blobber_files 16:09:09 INFO - Blob upload gear active. 16:09:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:09:09 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:09:09 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:09:09 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:09:09 INFO - (blobuploader) - INFO - Open directory for files ... 16:09:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:09:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:09:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:13 INFO - (blobuploader) - INFO - Done attempting. 16:09:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:09:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:09:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:14 INFO - (blobuploader) - INFO - Done attempting. 16:09:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:09:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:09:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:15 INFO - (blobuploader) - INFO - Done attempting. 16:09:15 INFO - (blobuploader) - INFO - Iteration through files over. 16:09:15 INFO - Return code: 0 16:09:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:09:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:09:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a95f35bb32944dfa5aeb1e259e310839eec85864804277dc48dda8ea5d9d03e3f4285bfa82eb74a4cf125e37729440d693f934800f8b11542144f0ad9cc10ab6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f31e51d34ed1da80b45f41b0f23bdb35d38c6cd722a0399aed58f36134bbf279fa96a9b50b779309454ffb1e784d5e27cdcbba5d8657b7545d9326a9592f215", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00b49a6d948076e6859381f8d1e2d4d570f30d32a9b35787ddf7e4f86a4c135b6d5c8977eb879dc1d8a6e1d7bba6b1a1de5be0938e50642c779d691e7115ae39"} 16:09:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:09:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:09:15 INFO - Contents: 16:09:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a95f35bb32944dfa5aeb1e259e310839eec85864804277dc48dda8ea5d9d03e3f4285bfa82eb74a4cf125e37729440d693f934800f8b11542144f0ad9cc10ab6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f31e51d34ed1da80b45f41b0f23bdb35d38c6cd722a0399aed58f36134bbf279fa96a9b50b779309454ffb1e784d5e27cdcbba5d8657b7545d9326a9592f215", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00b49a6d948076e6859381f8d1e2d4d570f30d32a9b35787ddf7e4f86a4c135b6d5c8977eb879dc1d8a6e1d7bba6b1a1de5be0938e50642c779d691e7115ae39"} 16:09:15 INFO - Running post-run listener: copy_logs_to_upload_dir 16:09:15 INFO - Copying logs to upload dir... 16:09:15 INFO - mkdir: /builds/slave/test/build/upload/logs 16:09:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.294627 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-05-20 16:09:15.285578) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 16:09:15.289125) ========= 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=af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640 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-Non-PGO/sha512/a95f35bb32944dfa5aeb1e259e310839eec85864804277dc48dda8ea5d9d03e3f4285bfa82eb74a4cf125e37729440d693f934800f8b11542144f0ad9cc10ab6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f31e51d34ed1da80b45f41b0f23bdb35d38c6cd722a0399aed58f36134bbf279fa96a9b50b779309454ffb1e784d5e27cdcbba5d8657b7545d9326a9592f215", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00b49a6d948076e6859381f8d1e2d4d570f30d32a9b35787ddf7e4f86a4c135b6d5c8977eb879dc1d8a6e1d7bba6b1a1de5be0938e50642c779d691e7115ae39"} build_url:https://queue.taskcluster.net/v1/task/fnSvswvqQJ-hGOFrzfXMlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011426 build_url: 'https://queue.taskcluster.net/v1/task/fnSvswvqQJ-hGOFrzfXMlA/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-Non-PGO/sha512/a95f35bb32944dfa5aeb1e259e310839eec85864804277dc48dda8ea5d9d03e3f4285bfa82eb74a4cf125e37729440d693f934800f8b11542144f0ad9cc10ab6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f31e51d34ed1da80b45f41b0f23bdb35d38c6cd722a0399aed58f36134bbf279fa96a9b50b779309454ffb1e784d5e27cdcbba5d8657b7545d9326a9592f215", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00b49a6d948076e6859381f8d1e2d4d570f30d32a9b35787ddf7e4f86a4c135b6d5c8977eb879dc1d8a6e1d7bba6b1a1de5be0938e50642c779d691e7115ae39"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 16:09:15.317399) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:09:15.318196) ========= 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=af724c981e2a0f424dbabf99000001e7-1463772407.276657-1517535640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:09:15.400513) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 16:09:15.401295) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 16:09:15.401815) ========= ========= Total master_lag: 0.18 =========