builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1467800312.87 results: success (0) buildid: 20160706004036 builduid: b30cd026e1ef4956afe5168fe5983624 revision: ce7a035cd2d10e06d8a720736e44bf81dea725f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 03:18:32.868088) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 03:18:32.868613) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 03:18:32.869453) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 03:18:32.886973) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 03:18:32.887306) ========= 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=31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 03:18:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-07-06 03:18:33 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131298 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 03:18:33.036484) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 03:18:33.036777) ========= 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=31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022010 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 03:18:33.087918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 03:18:33.088247) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ce7a035cd2d10e06d8a720736e44bf81dea725f2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ce7a035cd2d10e06d8a720736e44bf81dea725f2 --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=31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 03:18:33,192 truncating revision to first 12 chars 2016-07-06 03:18:33,192 Setting DEBUG logging. 2016-07-06 03:18:33,192 attempt 1/10 2016-07-06 03:18:33,192 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ce7a035cd2d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 03:18:34,044 unpacking tar archive at: mozilla-aurora-ce7a035cd2d1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.196746 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 03:18:34.298672) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 03:18:34.298963) ========= script_repo_revision: ce7a035cd2d10e06d8a720736e44bf81dea725f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 03:18:34.299399) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 03:18:34.299668) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 03:18:34.309129) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-06 03:18:34.309499) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:18:34 INFO - MultiFileLogger online at 20160706 03:18:34 in /builds/slave/test 03:18:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:18:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:18:34 INFO - {'append_to_log': False, 03:18:34 INFO - 'base_work_dir': '/builds/slave/test', 03:18:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:18:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:18:34 INFO - 'branch': 'Mozilla-Aurora', 03:18:34 INFO - 'buildbot_json_path': 'buildprops.json', 03:18:34 INFO - 'config_files': ('talos/linux_config.py',), 03:18:34 INFO - 'default_actions': ('clobber', 03:18:34 INFO - 'read-buildbot-config', 03:18:34 INFO - 'download-and-extract', 03:18:34 INFO - 'populate-webroot', 03:18:34 INFO - 'create-virtualenv', 03:18:34 INFO - 'install', 03:18:34 INFO - 'run-tests'), 03:18:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:18:34 INFO - 'download_minidump_stackwalk': True, 03:18:34 INFO - 'download_symbols': 'ondemand', 03:18:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:18:34 INFO - 'tooltool.py': '/tools/tooltool.py', 03:18:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:18:34 INFO - '/tools/misc-python/virtualenv.py')}, 03:18:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:18:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:18:34 INFO - 'installer_path': 'installer.exe', 03:18:34 INFO - 'log_level': 'info', 03:18:34 INFO - 'log_name': 'talos', 03:18:34 INFO - 'log_to_console': True, 03:18:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:18:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:18:34 INFO - 'opt_config_files': (), 03:18:34 INFO - 'pip_index': False, 03:18:34 INFO - 'sps_profile': False, 03:18:34 INFO - 'sps_profile_interval': 0, 03:18:34 INFO - 'suite': 'dromaeojs', 03:18:34 INFO - 'system_bits': '32', 03:18:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:18:34 INFO - 'title': 'talos-linux64-ix-014', 03:18:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:18:34 INFO - 'use_talos_json': True, 03:18:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:18:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:18:34 INFO - 'work_dir': 'build'} 03:18:34 INFO - ##### 03:18:34 INFO - ##### Running clobber step. 03:18:34 INFO - ##### 03:18:34 INFO - Running pre-action listener: _resource_record_pre_action 03:18:34 INFO - Running main action method: clobber 03:18:34 INFO - rmtree: /builds/slave/test/build 03:18:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:18:35 INFO - Running post-action listener: _resource_record_post_action 03:18:35 INFO - ##### 03:18:35 INFO - ##### Finished clobber step (success) 03:18:35 INFO - ##### 03:18:35 INFO - ##### 03:18:35 INFO - ##### Running read-buildbot-config step. 03:18:35 INFO - ##### 03:18:35 INFO - Running pre-action listener: _resource_record_pre_action 03:18:35 INFO - Running main action method: read_buildbot_config 03:18:35 INFO - Using buildbot properties: 03:18:35 INFO - { 03:18:35 INFO - "project": "", 03:18:35 INFO - "product": "firefox", 03:18:35 INFO - "script_repo_revision": "production", 03:18:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:18:35 INFO - "repository": "", 03:18:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:18:35 INFO - "buildid": "20160706004036", 03:18:35 INFO - "stage_platform": "linux64-pgo", 03:18:35 INFO - "basedir": "/builds/slave/test", 03:18:35 INFO - "nightly_build": "True", 03:18:35 INFO - "buildnumber": 592, 03:18:35 INFO - "slavename": "talos-linux64-ix-014", 03:18:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:18:35 INFO - "platform": "ubuntu64_hw", 03:18:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:18:35 INFO - "branch": "mozilla-aurora", 03:18:35 INFO - "repo_path": "releases/mozilla-aurora", 03:18:35 INFO - "revision": "ce7a035cd2d10e06d8a720736e44bf81dea725f2", 03:18:35 INFO - "pgo_build": "True", 03:18:35 INFO - "builduid": "b30cd026e1ef4956afe5168fe5983624", 03:18:35 INFO - "slavebuilddir": "test" 03:18:35 INFO - } 03:18:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:18:35 INFO - Running post-action listener: _resource_record_post_action 03:18:35 INFO - ##### 03:18:35 INFO - ##### Finished read-buildbot-config step (success) 03:18:35 INFO - ##### 03:18:35 INFO - ##### 03:18:35 INFO - ##### Running download-and-extract step. 03:18:35 INFO - ##### 03:18:35 INFO - Running pre-action listener: _resource_record_pre_action 03:18:35 INFO - Running main action method: download_and_extract 03:18:35 INFO - mkdir: /builds/slave/test/build/tests 03:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:35 INFO - https://queue.taskcluster.net/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:18:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:18:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:18:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:18:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:18:39 INFO - Downloaded 1361 bytes. 03:18:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:18:39 INFO - Using the following test package requirements: 03:18:39 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:18:39 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:39 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:18:39 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:39 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:18:39 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:39 INFO - u'jsshell-linux-x86_64.zip'], 03:18:39 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:39 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:18:39 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:18:39 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:39 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:18:39 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:39 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:18:39 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:39 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:18:39 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:39 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:18:39 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:39 INFO - https://queue.taskcluster.net/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:18:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:18:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:18:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:18:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:18:44 INFO - Downloaded 24525624 bytes. 03:18:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:18:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:18:45 INFO - Return code: 0 03:18:45 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:18: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')]} 03:18:45 INFO - https://queue.taskcluster.net/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:18:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:18:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:18:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:18:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:18:46 INFO - Downloaded 24525624 bytes. 03:18:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:18:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:18:47 INFO - Return code: 0 03:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:47 INFO - https://queue.taskcluster.net/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:18:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:18:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:18:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:18:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:18:48 INFO - Downloaded 10833369 bytes. 03:18:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:18:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:18:49 INFO - Return code: 0 03:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:49 INFO - https://queue.taskcluster.net/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:18:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:18:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:18:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:18:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:18:50 INFO - Downloaded 63614098 bytes. 03:18:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:18:50 INFO - mkdir: /builds/slave/test/properties 03:18:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:18:50 INFO - Writing to file /builds/slave/test/properties/build_url 03:18:50 INFO - Contents: 03:18:50 INFO - build_url:https://queue.taskcluster.net/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:18:51 INFO - Running post-action listener: _resource_record_post_action 03:18:51 INFO - Running post-action listener: set_extra_try_arguments 03:18:51 INFO - ##### 03:18:51 INFO - ##### Finished download-and-extract step (success) 03:18:51 INFO - ##### 03:18:51 INFO - ##### 03:18:51 INFO - ##### Running populate-webroot step. 03:18:51 INFO - ##### 03:18:51 INFO - Running pre-action listener: _resource_record_pre_action 03:18:51 INFO - Running main action method: populate_webroot 03:18:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:18:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:18:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:18:51 INFO - '--tppagecycles', 03:18:51 INFO - '7'], 03:18:51 INFO - 'tests': ['tsvgm']}}, 03:18:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:18:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:18:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:18:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:18:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:18:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:18:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:51 INFO - 'talos_options': ['--disable-e10s'], 03:18:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:51 INFO - 'talos_options': ['--disable-e10s'], 03:18:51 INFO - 'tests': ['damp', 'tps']}, 03:18:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:51 INFO - 'tests': ['damp', 'tps']}, 03:18:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:18:51 INFO - 'tests': ['dromaeo_dom']}, 03:18:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:18:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:18:51 INFO - 'tests': ['a11yr', 03:18:51 INFO - 'ts_paint', 03:18:51 INFO - 'tpaint', 03:18:51 INFO - 'sessionrestore', 03:18:51 INFO - 'sessionrestore_no_auto_restore', 03:18:51 INFO - 'tabpaint']}, 03:18:51 INFO - 'other-e10s': {'tests': ['a11yr', 03:18:51 INFO - 'ts_paint', 03:18:51 INFO - 'tpaint', 03:18:51 INFO - 'sessionrestore', 03:18:51 INFO - 'sessionrestore_no_auto_restore', 03:18:51 INFO - 'tabpaint']}, 03:18:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:18:51 INFO - 'ts_paint', 03:18:51 INFO - 'tpaint', 03:18:51 INFO - 'sessionrestore', 03:18:51 INFO - 'sessionrestore_no_auto_restore', 03:18:51 INFO - 'tabpaint']}, 03:18:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:18:51 INFO - 'ts_paint', 03:18:51 INFO - 'tpaint', 03:18:51 INFO - 'sessionrestore', 03:18:51 INFO - 'sessionrestore_no_auto_restore', 03:18:51 INFO - 'tabpaint']}, 03:18:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:18:51 INFO - 'tests': ['a11yr', 03:18:51 INFO - 'ts_paint', 03:18:51 INFO - 'tpaint', 03:18:51 INFO - 'sessionrestore', 03:18:51 INFO - 'sessionrestore_no_auto_restore', 03:18:51 INFO - 'tabpaint']}, 03:18:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:18:51 INFO - 'tests': ['a11yr', 03:18:51 INFO - 'ts_paint', 03:18:51 INFO - 'tpaint', 03:18:51 INFO - 'sessionrestore', 03:18:51 INFO - 'sessionrestore_no_auto_restore', 03:18:51 INFO - 'tabpaint']}, 03:18:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:18:51 INFO - 'tests': ['tsvgx', 03:18:51 INFO - 'tsvgr_opacity', 03:18:51 INFO - 'tart', 03:18:51 INFO - 'tscrollx', 03:18:51 INFO - 'cart']}, 03:18:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:18:51 INFO - 'tsvgr_opacity', 03:18:51 INFO - 'tart', 03:18:51 INFO - 'tscrollx', 03:18:51 INFO - 'cart']}, 03:18:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:51 INFO - 'talos_options': ['--disable-e10s'], 03:18:51 INFO - 'tests': ['tp5o']}, 03:18:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:51 INFO - 'tests': ['tp5o']}, 03:18:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:51 INFO - 'talos_options': ['--disable-e10s', 03:18:51 INFO - '--xperf_path', 03:18:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:51 INFO - 'tests': ['tp5n']}, 03:18:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:51 INFO - 'talos_options': ['--xperf_path', 03:18:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:51 INFO - 'tests': ['tp5n']}}, 03:18:51 INFO - 'talos.zip': {'path': '', 03:18:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:18:51 INFO - Running post-action listener: _resource_record_post_action 03:18:51 INFO - ##### 03:18:51 INFO - ##### Finished populate-webroot step (success) 03:18:51 INFO - ##### 03:18:51 INFO - ##### 03:18:51 INFO - ##### Running create-virtualenv step. 03:18:51 INFO - ##### 03:18:51 INFO - Running pre-action listener: _resource_record_pre_action 03:18:51 INFO - Running main action method: create_virtualenv 03:18:51 INFO - Creating virtualenv /builds/slave/test/build/venv 03:18:51 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 03:18:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:18:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:18:51 INFO - Using real prefix '/usr' 03:18:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:18:51 INFO - Installing distribute.............................................................................................................................................................................................done. 03:18:53 INFO - Installing pip.................done. 03:18:53 INFO - Return code: 0 03:18:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:18:53 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')]} 03:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:53 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')]} 03:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:53 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 0x7fc67e933f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25562e0>, '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 0x24c2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c25d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', '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 03:18:53 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 03:18:53 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 03:18:53 INFO - Using env: {'DISPLAY': ':0', 03:18:53 INFO - 'HOME': '/home/cltbld', 03:18:53 INFO - 'LANG': 'en_US.UTF-8', 03:18:53 INFO - 'LANGUAGE': 'en_US:en', 03:18:53 INFO - 'LOGNAME': 'cltbld', 03:18:53 INFO - 'MAIL': '/var/mail/cltbld', 03:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:53 INFO - 'MOZ_NO_REMOTE': '1', 03:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:53 INFO - 'NO_EM_RESTART': '1', 03:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:53 INFO - 'PWD': '/builds/slave/test', 03:18:53 INFO - 'SHELL': '/bin/bash', 03:18:53 INFO - 'SHLVL': '1', 03:18:53 INFO - 'TERM': 'linux', 03:18:53 INFO - 'TMOUT': '86400', 03:18:53 INFO - 'USER': 'cltbld', 03:18:53 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', 03:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:53 INFO - '_': '/tools/buildbot/bin/python'} 03:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:53 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 03:18:53 INFO - Cleaning up... 03:18:53 INFO - Return code: 0 03:18:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:18:53 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')]} 03:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:53 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')]} 03:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:53 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 0x7fc67e933f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25562e0>, '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 0x24c2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c25d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', '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 03:18:53 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 03:18:53 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 03:18:53 INFO - Using env: {'DISPLAY': ':0', 03:18:53 INFO - 'HOME': '/home/cltbld', 03:18:53 INFO - 'LANG': 'en_US.UTF-8', 03:18:53 INFO - 'LANGUAGE': 'en_US:en', 03:18:53 INFO - 'LOGNAME': 'cltbld', 03:18:53 INFO - 'MAIL': '/var/mail/cltbld', 03:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:53 INFO - 'MOZ_NO_REMOTE': '1', 03:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:53 INFO - 'NO_EM_RESTART': '1', 03:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:53 INFO - 'PWD': '/builds/slave/test', 03:18:53 INFO - 'SHELL': '/bin/bash', 03:18:53 INFO - 'SHLVL': '1', 03:18:53 INFO - 'TERM': 'linux', 03:18:53 INFO - 'TMOUT': '86400', 03:18:53 INFO - 'USER': 'cltbld', 03:18:53 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', 03:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:53 INFO - '_': '/tools/buildbot/bin/python'} 03:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:54 INFO - Downloading/unpacking psutil>=3.1.1 03:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:18:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:56 INFO - Installing collected packages: psutil 03:18:56 INFO - Running setup.py install for psutil 03:18:56 INFO - building 'psutil._psutil_linux' extension 03:18:56 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 03:18:56 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 03:18:56 INFO - building 'psutil._psutil_posix' extension 03:18:56 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 03:18:56 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 03:18:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:56 INFO - Successfully installed psutil 03:18:56 INFO - Cleaning up... 03:18:56 INFO - Return code: 0 03:18:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc67e933f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25562e0>, '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 0x24c2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c25d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', '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 03:18:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:18:56 INFO - Using env: {'DISPLAY': ':0', 03:18:56 INFO - 'HOME': '/home/cltbld', 03:18:56 INFO - 'LANG': 'en_US.UTF-8', 03:18:56 INFO - 'LANGUAGE': 'en_US:en', 03:18:56 INFO - 'LOGNAME': 'cltbld', 03:18:56 INFO - 'MAIL': '/var/mail/cltbld', 03:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:56 INFO - 'MOZ_NO_REMOTE': '1', 03:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:56 INFO - 'NO_EM_RESTART': '1', 03:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:56 INFO - 'PWD': '/builds/slave/test', 03:18:56 INFO - 'SHELL': '/bin/bash', 03:18:56 INFO - 'SHLVL': '1', 03:18:56 INFO - 'TERM': 'linux', 03:18:56 INFO - 'TMOUT': '86400', 03:18:56 INFO - 'USER': 'cltbld', 03:18:56 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', 03:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:56 INFO - '_': '/tools/buildbot/bin/python'} 03:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:18:58 INFO - Installing collected packages: mozsystemmonitor 03:18:58 INFO - Running setup.py install for mozsystemmonitor 03:18:59 INFO - Successfully installed mozsystemmonitor 03:18:59 INFO - Cleaning up... 03:18:59 INFO - Return code: 0 03:18:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc67e933f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25562e0>, '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 0x24c2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c25d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', '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 03:18:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:18:59 INFO - Using env: {'DISPLAY': ':0', 03:18:59 INFO - 'HOME': '/home/cltbld', 03:18:59 INFO - 'LANG': 'en_US.UTF-8', 03:18:59 INFO - 'LANGUAGE': 'en_US:en', 03:18:59 INFO - 'LOGNAME': 'cltbld', 03:18:59 INFO - 'MAIL': '/var/mail/cltbld', 03:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:59 INFO - 'MOZ_NO_REMOTE': '1', 03:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:59 INFO - 'NO_EM_RESTART': '1', 03:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:59 INFO - 'PWD': '/builds/slave/test', 03:18:59 INFO - 'SHELL': '/bin/bash', 03:18:59 INFO - 'SHLVL': '1', 03:18:59 INFO - 'TERM': 'linux', 03:18:59 INFO - 'TMOUT': '86400', 03:18:59 INFO - 'USER': 'cltbld', 03:18:59 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', 03:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:59 INFO - '_': '/tools/buildbot/bin/python'} 03:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:59 INFO - Downloading/unpacking jsonschema==2.5.1 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:19:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:19:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:01 INFO - Downloading functools32-3.2.3-2.tar.gz 03:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:19:01 INFO - warning: no files found matching '*.txt' 03:19:01 INFO - no previously-included directories found matching 'build' 03:19:01 INFO - no previously-included directories found matching 'dist' 03:19:01 INFO - no previously-included directories found matching '.git*' 03:19:01 INFO - Installing collected packages: jsonschema, functools32 03:19:02 INFO - Running setup.py install for functools32 03:19:02 INFO - warning: no files found matching '*.txt' 03:19:02 INFO - no previously-included directories found matching 'build' 03:19:02 INFO - no previously-included directories found matching 'dist' 03:19:02 INFO - no previously-included directories found matching '.git*' 03:19:02 INFO - Successfully installed jsonschema functools32 03:19:02 INFO - Cleaning up... 03:19:02 INFO - Return code: 0 03:19:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:19:02 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')]} 03:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:02 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')]} 03:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:02 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 0x7fc67e933f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25562e0>, '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 0x24c2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c25d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', '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 03:19:02 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 03:19:02 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 03:19:02 INFO - Using env: {'DISPLAY': ':0', 03:19:02 INFO - 'HOME': '/home/cltbld', 03:19:02 INFO - 'LANG': 'en_US.UTF-8', 03:19:02 INFO - 'LANGUAGE': 'en_US:en', 03:19:02 INFO - 'LOGNAME': 'cltbld', 03:19:02 INFO - 'MAIL': '/var/mail/cltbld', 03:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:02 INFO - 'MOZ_NO_REMOTE': '1', 03:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:02 INFO - 'NO_EM_RESTART': '1', 03:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:02 INFO - 'PWD': '/builds/slave/test', 03:19:02 INFO - 'SHELL': '/bin/bash', 03:19:02 INFO - 'SHLVL': '1', 03:19:02 INFO - 'TERM': 'linux', 03:19:02 INFO - 'TMOUT': '86400', 03:19:02 INFO - 'USER': 'cltbld', 03:19:02 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', 03:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:02 INFO - '_': '/tools/buildbot/bin/python'} 03:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:02 INFO - Downloading/unpacking blobuploader==1.2.4 03:19:02 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 03:19:02 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 03:19:02 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 03:19:02 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 03:19:02 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 03:19:02 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 03:19:04 INFO - Downloading blobuploader-1.2.4.tar.gz 03:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:19:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:19:04 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 03:19:04 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 03:19:04 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 03:19:04 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 03:19:04 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 03:19:04 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 03:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:19:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:19:04 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 03:19:04 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 03:19:04 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 03:19:04 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 03:19:04 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 03:19:04 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 03:19:04 INFO - Downloading docopt-0.6.1.tar.gz 03:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:19:05 INFO - Installing collected packages: blobuploader, requests, docopt 03:19:05 INFO - Running setup.py install for blobuploader 03:19:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:19:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:19:05 INFO - Running setup.py install for requests 03:19:05 INFO - Running setup.py install for docopt 03:19:05 INFO - Successfully installed blobuploader requests docopt 03:19:05 INFO - Cleaning up... 03:19:05 INFO - Return code: 0 03:19:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19: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')]} 03:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19: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')]} 03:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:05 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 0x7fc67e933f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25562e0>, '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 0x24c2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c25d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', '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 03:19:05 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 03:19:05 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 03:19:05 INFO - Using env: {'DISPLAY': ':0', 03:19:05 INFO - 'HOME': '/home/cltbld', 03:19:05 INFO - 'LANG': 'en_US.UTF-8', 03:19:05 INFO - 'LANGUAGE': 'en_US:en', 03:19:05 INFO - 'LOGNAME': 'cltbld', 03:19:05 INFO - 'MAIL': '/var/mail/cltbld', 03:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:05 INFO - 'MOZ_NO_REMOTE': '1', 03:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:05 INFO - 'NO_EM_RESTART': '1', 03:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:05 INFO - 'PWD': '/builds/slave/test', 03:19:05 INFO - 'SHELL': '/bin/bash', 03:19:05 INFO - 'SHLVL': '1', 03:19:05 INFO - 'TERM': 'linux', 03:19:05 INFO - 'TMOUT': '86400', 03:19:05 INFO - 'USER': 'cltbld', 03:19:05 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', 03:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:05 INFO - '_': '/tools/buildbot/bin/python'} 03:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:19:05 INFO - Running setup.py (path:/tmp/pip-pVAOdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:19:05 INFO - Running setup.py (path:/tmp/pip-kiG5Hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:19:05 INFO - Running setup.py (path:/tmp/pip-A9UwNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:19:06 INFO - Running setup.py (path:/tmp/pip-qQWsZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:19:06 INFO - Running setup.py (path:/tmp/pip-axmZf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:19:06 INFO - Running setup.py (path:/tmp/pip-zhkCvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:19:06 INFO - Running setup.py (path:/tmp/pip-s49S5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:19:06 INFO - Running setup.py (path:/tmp/pip-FflwKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:19:06 INFO - Running setup.py (path:/tmp/pip-iEoF1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:19:06 INFO - Running setup.py (path:/tmp/pip-nk6vJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:19:06 INFO - Running setup.py (path:/tmp/pip-A8t28v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:19:06 INFO - Running setup.py (path:/tmp/pip-sfp8mG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:19:06 INFO - Running setup.py (path:/tmp/pip-c1drO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:19:06 INFO - Running setup.py (path:/tmp/pip-mjVcli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:06 INFO - Running setup.py (path:/tmp/pip-GW9TtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:19:06 INFO - Running setup.py (path:/tmp/pip-K4qY2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:19:06 INFO - Running setup.py (path:/tmp/pip-_UJtRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:19:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:19:07 INFO - Running setup.py install for manifestparser 03:19:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:19:07 INFO - Running setup.py install for mozcrash 03:19:07 INFO - Running setup.py install for mozdebug 03:19:07 INFO - Running setup.py install for mozdevice 03:19:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:19:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:19:07 INFO - Running setup.py install for mozfile 03:19:07 INFO - Running setup.py install for mozhttpd 03:19:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:19:07 INFO - Running setup.py install for mozinfo 03:19:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:19:07 INFO - Running setup.py install for mozInstall 03:19:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:19:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:19:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:19:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:19:07 INFO - Running setup.py install for mozleak 03:19:07 INFO - Running setup.py install for mozlog 03:19:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:19:08 INFO - Running setup.py install for moznetwork 03:19:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:19:08 INFO - Running setup.py install for mozprocess 03:19:08 INFO - Running setup.py install for mozprofile 03:19:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:19:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:19:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:19:08 INFO - Running setup.py install for mozrunner 03:19:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:19:08 INFO - Running setup.py install for mozscreenshot 03:19:08 INFO - Running setup.py install for moztest 03:19:08 INFO - Running setup.py install for mozversion 03:19:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:19:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:19:08 INFO - Cleaning up... 03:19:08 INFO - Return code: 0 03:19:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19: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')]} 03:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19: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')]} 03:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:08 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 0x7fc67e933f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25562e0>, '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 0x24c2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c25d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', '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 03:19:08 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 03:19:08 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 03:19:08 INFO - Using env: {'DISPLAY': ':0', 03:19:08 INFO - 'HOME': '/home/cltbld', 03:19:08 INFO - 'LANG': 'en_US.UTF-8', 03:19:08 INFO - 'LANGUAGE': 'en_US:en', 03:19:08 INFO - 'LOGNAME': 'cltbld', 03:19:08 INFO - 'MAIL': '/var/mail/cltbld', 03:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:08 INFO - 'MOZ_NO_REMOTE': '1', 03:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:08 INFO - 'NO_EM_RESTART': '1', 03:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:08 INFO - 'PWD': '/builds/slave/test', 03:19:08 INFO - 'SHELL': '/bin/bash', 03:19:08 INFO - 'SHLVL': '1', 03:19:08 INFO - 'TERM': 'linux', 03:19:08 INFO - 'TMOUT': '86400', 03:19:08 INFO - 'USER': 'cltbld', 03:19:08 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', 03:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:08 INFO - '_': '/tools/buildbot/bin/python'} 03:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:19:09 INFO - Running setup.py (path:/tmp/pip-bM7NY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:19:09 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)) 03:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:19:09 INFO - Running setup.py (path:/tmp/pip-_n9U5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:19:09 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)) 03:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:19:09 INFO - Running setup.py (path:/tmp/pip-Uejig0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:19:09 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)) 03:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:19:09 INFO - Running setup.py (path:/tmp/pip-ouiFCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:19:09 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)) 03:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:19:09 INFO - Running setup.py (path:/tmp/pip-3KY9DC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:19:09 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)) 03:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:19:09 INFO - Running setup.py (path:/tmp/pip-zFeFWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:19:09 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)) 03:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:19:09 INFO - Running setup.py (path:/tmp/pip-sg1DyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:19:09 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)) 03:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:19:09 INFO - Running setup.py (path:/tmp/pip-zzwng4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:19:09 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)) 03:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:19:09 INFO - Running setup.py (path:/tmp/pip-4Ko3aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:19:09 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)) 03:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:19:09 INFO - Running setup.py (path:/tmp/pip-7tR4Lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:19:09 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)) 03:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:19:09 INFO - Running setup.py (path:/tmp/pip-g8r9hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:19:09 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)) 03:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:19:09 INFO - Running setup.py (path:/tmp/pip-_ZV6qR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:19:09 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)) 03:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:19:09 INFO - Running setup.py (path:/tmp/pip-FzboTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:19:09 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)) 03:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:19:10 INFO - Running setup.py (path:/tmp/pip-6cXjjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:19:10 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)) 03:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:10 INFO - Running setup.py (path:/tmp/pip-eSTjSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:10 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)) 03:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:19:10 INFO - Running setup.py (path:/tmp/pip-H1_TR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:19:10 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)) 03:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:19:10 INFO - Running setup.py (path:/tmp/pip-UzOmSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:19:10 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)) 03:19:10 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)) 03:19:10 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)) 03:19:10 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)) 03:19:10 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)) 03:19:10 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)) 03:19:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:19:10 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 03:19:10 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 03:19:10 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 03:19:10 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 03:19:10 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 03:19:10 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 03:19:12 INFO - Downloading blessings-1.6.tar.gz 03:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:19:12 INFO - Installing collected packages: blessings 03:19:12 INFO - Running setup.py install for blessings 03:19:12 INFO - Successfully installed blessings 03:19:12 INFO - Cleaning up... 03:19:12 INFO - Return code: 0 03:19:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:19:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:12 INFO - Reading from file tmpfile_stdout 03:19:12 INFO - Current package versions: 03:19:12 INFO - argparse == 1.2.1 03:19:12 INFO - blessings == 1.6 03:19:12 INFO - blobuploader == 1.2.4 03:19:12 INFO - docopt == 0.6.1 03:19:12 INFO - functools32 == 3.2.3-2 03:19:12 INFO - jsonschema == 2.5.1 03:19:12 INFO - manifestparser == 1.1 03:19:12 INFO - mozInstall == 1.12 03:19:12 INFO - mozcrash == 0.17 03:19:12 INFO - mozdebug == 0.1 03:19:12 INFO - mozdevice == 0.48 03:19:12 INFO - mozfile == 1.2 03:19:12 INFO - mozhttpd == 0.7 03:19:12 INFO - mozinfo == 0.9 03:19:12 INFO - mozleak == 0.1 03:19:12 INFO - mozlog == 3.2 03:19:12 INFO - moznetwork == 0.27 03:19:12 INFO - mozprocess == 0.22 03:19:12 INFO - mozprofile == 0.28 03:19:12 INFO - mozrunner == 6.11 03:19:12 INFO - mozscreenshot == 0.1 03:19:12 INFO - mozsystemmonitor == 0.3 03:19:12 INFO - moztest == 0.7 03:19:12 INFO - mozversion == 1.4 03:19:12 INFO - psutil == 3.1.1 03:19:12 INFO - requests == 1.2.3 03:19:12 INFO - wsgiref == 0.1.2 03:19:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:12 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')]} 03:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:12 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')]} 03:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:12 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 0x7fc67e933f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25562e0>, '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 0x24c2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c25d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', '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 03:19:12 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 03:19:12 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 03:19:12 INFO - Using env: {'DISPLAY': ':0', 03:19:12 INFO - 'HOME': '/home/cltbld', 03:19:12 INFO - 'LANG': 'en_US.UTF-8', 03:19:12 INFO - 'LANGUAGE': 'en_US:en', 03:19:12 INFO - 'LOGNAME': 'cltbld', 03:19:12 INFO - 'MAIL': '/var/mail/cltbld', 03:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:12 INFO - 'MOZ_NO_REMOTE': '1', 03:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:12 INFO - 'NO_EM_RESTART': '1', 03:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:12 INFO - 'PWD': '/builds/slave/test', 03:19:12 INFO - 'SHELL': '/bin/bash', 03:19:12 INFO - 'SHLVL': '1', 03:19:12 INFO - 'TERM': 'linux', 03:19:12 INFO - 'TMOUT': '86400', 03:19:12 INFO - 'USER': 'cltbld', 03:19:12 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', 03:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:12 INFO - '_': '/tools/buildbot/bin/python'} 03:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:12 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)) 03:19:12 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)) 03:19:12 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)) 03:19:12 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)) 03:19:12 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)) 03:19:12 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)) 03:19:12 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)) 03:19:12 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)) 03:19:12 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)) 03:19:12 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)) 03:19:12 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)) 03:19:12 INFO - Cleaning up... 03:19:12 INFO - Return code: 0 03:19:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:19:12 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')]} 03:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:12 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')]} 03:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:12 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 0x7fc67e933f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25562e0>, '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 0x24c2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c25d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', '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 03:19:12 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 03:19:12 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 03:19:12 INFO - Using env: {'DISPLAY': ':0', 03:19:12 INFO - 'HOME': '/home/cltbld', 03:19:12 INFO - 'LANG': 'en_US.UTF-8', 03:19:12 INFO - 'LANGUAGE': 'en_US:en', 03:19:12 INFO - 'LOGNAME': 'cltbld', 03:19:12 INFO - 'MAIL': '/var/mail/cltbld', 03:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:12 INFO - 'MOZ_NO_REMOTE': '1', 03:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:12 INFO - 'NO_EM_RESTART': '1', 03:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:12 INFO - 'PWD': '/builds/slave/test', 03:19:12 INFO - 'SHELL': '/bin/bash', 03:19:12 INFO - 'SHLVL': '1', 03:19:12 INFO - 'TERM': 'linux', 03:19:12 INFO - 'TMOUT': '86400', 03:19:12 INFO - 'USER': 'cltbld', 03:19:12 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', 03:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:12 INFO - '_': '/tools/buildbot/bin/python'} 03:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:19:13 INFO - Cleaning up... 03:19:13 INFO - Return code: 0 03:19:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:19:13 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')]} 03:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:13 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')]} 03:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:13 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 0x7fc67e933f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25562e0>, '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 0x24c2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c25d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', '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 03:19:13 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 03:19:13 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 03:19:13 INFO - Using env: {'DISPLAY': ':0', 03:19:13 INFO - 'HOME': '/home/cltbld', 03:19:13 INFO - 'LANG': 'en_US.UTF-8', 03:19:13 INFO - 'LANGUAGE': 'en_US:en', 03:19:13 INFO - 'LOGNAME': 'cltbld', 03:19:13 INFO - 'MAIL': '/var/mail/cltbld', 03:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:13 INFO - 'MOZ_NO_REMOTE': '1', 03:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:13 INFO - 'NO_EM_RESTART': '1', 03:19:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:13 INFO - 'PWD': '/builds/slave/test', 03:19:13 INFO - 'SHELL': '/bin/bash', 03:19:13 INFO - 'SHLVL': '1', 03:19:13 INFO - 'TERM': 'linux', 03:19:13 INFO - 'TMOUT': '86400', 03:19:13 INFO - 'USER': 'cltbld', 03:19:13 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', 03:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:13 INFO - '_': '/tools/buildbot/bin/python'} 03:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:13 INFO - Downloading/unpacking flake8 03:19:13 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 03:19:13 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 03:19:13 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 03:19:13 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 03:19:13 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 03:19:13 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 03:19:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:19:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:19:15 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 03:19:15 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 03:19:15 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 03:19:15 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 03:19:15 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 03:19:15 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 03:19:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:19:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:19:15 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 03:19:15 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 03:19:15 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 03:19:15 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 03:19:15 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 03:19:15 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 03:19:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:19:15 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 03:19:15 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 03:19:15 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 03:19:15 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 03:19:15 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 03:19:15 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 03:19:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:19:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:19:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:19:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:19:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:19:15 INFO - no previously-included directories found matching 'docs/_build' 03:19:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:19:16 INFO - Running setup.py install for pep8 03:19:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:19:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:19:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:19:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:19:16 INFO - no previously-included directories found matching 'docs/_build' 03:19:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:19:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:19:16 INFO - Cleaning up... 03:19:16 INFO - Return code: 0 03:19:16 INFO - Running post-action listener: _resource_record_post_action 03:19:16 INFO - Running post-action listener: _start_resource_monitoring 03:19:16 INFO - Starting resource monitoring. 03:19:16 INFO - ##### 03:19:16 INFO - ##### Finished create-virtualenv step (success) 03:19:16 INFO - ##### 03:19:16 INFO - ##### 03:19:16 INFO - ##### Running install step. 03:19:16 INFO - ##### 03:19:16 INFO - Running pre-action listener: _resource_record_pre_action 03:19:16 INFO - Running main action method: install 03:19:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:16 INFO - Reading from file tmpfile_stdout 03:19:16 INFO - Detecting whether we're running mozinstall >=1.0... 03:19:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:19:16 INFO - Reading from file tmpfile_stdout 03:19:16 INFO - Output received: 03:19:16 INFO - Usage: mozinstall [options] installer 03:19:16 INFO - Options: 03:19:16 INFO - -h, --help show this help message and exit 03:19:16 INFO - -d DEST, --destination=DEST 03:19:16 INFO - Directory to install application into. [default: 03:19:16 INFO - "/builds/slave/test"] 03:19:16 INFO - --app=APP Application being installed. [default: firefox] 03:19:16 INFO - mkdir: /builds/slave/test/build/application 03:19:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:19:32 INFO - Reading from file tmpfile_stdout 03:19:32 INFO - Output received: 03:19:32 INFO - /builds/slave/test/build/application/firefox/firefox 03:19:32 INFO - Running post-action listener: _resource_record_post_action 03:19:32 INFO - ##### 03:19:32 INFO - ##### Finished install step (success) 03:19:32 INFO - ##### 03:19:32 INFO - ##### 03:19:32 INFO - ##### Running run-tests step. 03:19:32 INFO - ##### 03:19:32 INFO - Running pre-action listener: _resource_record_pre_action 03:19:32 INFO - Running main action method: run_tests 03:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:19:32 INFO - Python 2.7.3 03:19:32 INFO - Return code: 0 03:19:32 INFO - grabbing minidump binary from tooltool 03:19:32 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')]} 03:19:32 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 0x25562e0>, '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 0x24c2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c25d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:19:32 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 03:19:32 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 03:19:32 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 03:19:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:19:32 INFO - Return code: 0 03:19:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:19:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:19:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:19:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:19:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:19:33 INFO - Return code: 0 03:19:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:19:33 INFO - Using env: {'DISPLAY': ':0', 03:19:33 INFO - 'HOME': '/home/cltbld', 03:19:33 INFO - 'LANG': 'en_US.UTF-8', 03:19:33 INFO - 'LANGUAGE': 'en_US:en', 03:19:33 INFO - 'LOGNAME': 'cltbld', 03:19:33 INFO - 'MAIL': '/var/mail/cltbld', 03:19:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:19:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:33 INFO - 'MOZ_NO_REMOTE': '1', 03:19:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:19:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:33 INFO - 'NO_EM_RESTART': '1', 03:19:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:33 INFO - 'PWD': '/builds/slave/test', 03:19:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:19:33 INFO - 'SHELL': '/bin/bash', 03:19:33 INFO - 'SHLVL': '1', 03:19:33 INFO - 'TERM': 'linux', 03:19:33 INFO - 'TMOUT': '86400', 03:19:33 INFO - 'USER': 'cltbld', 03:19:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307', 03:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:33 INFO - '_': '/tools/buildbot/bin/python'} 03:19:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:19:33 INFO - mozversion application_buildid: 20160706004036 03:19:33 INFO - mozversion application_changeset: ce7a035cd2d10e06d8a720736e44bf81dea725f2 03:19:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:19:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:19:33 INFO - mozversion application_name: Firefox 03:19:33 INFO - mozversion application_remotingname: firefox-dev 03:19:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:19:33 INFO - mozversion application_vendor: Mozilla 03:19:33 INFO - mozversion application_version: 49.0a2 03:19:33 INFO - mozversion platform_buildid: 20160706004036 03:19:33 INFO - mozversion platform_changeset: ce7a035cd2d10e06d8a720736e44bf81dea725f2 03:19:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:19:33 INFO - mozversion platform_version: 49.0a2 03:19:33 INFO - using testdate: 1467800373 03:19:33 INFO - actual date: 1467800373 03:19:33 INFO - starting webserver on 'localhost:46561' 03:19:33 INFO - SUITE-START | Running 2 tests 03:19:33 INFO - TEST-START | dromaeo_css 03:19:33 INFO - operating with platform_type : linux_ 03:19:33 INFO - Initialising browser for dromaeo_css test... 03:19:33 INFO - TEST-INFO | started process 10826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkLEnbU/profile http://localhost:46561/getInfo.html) 03:19:38 INFO - PROCESS | 10826 | __metrics Screen width/height:1600/1200 03:19:38 INFO - PROCESS | 10826 | colorDepth:24 03:19:38 INFO - PROCESS | 10826 | Browser inner width/height: 1024/697 03:19:38 INFO - PROCESS | 10826 | __metrics 03:19:39 ERROR - PROCESS | 10826 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:19:40 INFO - TEST-INFO | 10826: exit 0 03:19:40 INFO - Browser initialized. 03:19:40 INFO - Running cycle 1/1 for dromaeo_css test... 03:19:40 INFO - TEST-INFO | started process 10915 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkLEnbU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:51 INFO - PROCESS | 10915 | RSS: Main: 149430272 03:19:51 INFO - PROCESS | 10915 | 03:20:43 INFO - PROCESS | 10915 | 1467800443033 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] 03:22:51 INFO - PROCESS | 10915 | Cycle 1(1): loaded http://localhost:46561/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46561/tests/dromaeo/cssquery-ext.html) 03:22:52 INFO - PROCESS | 10915 | RSS: Main: 259481600 03:22:52 INFO - PROCESS | 10915 | 03:25:54 INFO - PROCESS | 10915 | Cycle 1(1): loaded http://localhost:46561/tests/dromaeo/cssquery-ext.html (next: http://localhost:46561/tests/dromaeo/cssquery-jquery.html) 03:25:55 INFO - PROCESS | 10915 | RSS: Main: 230289408 03:25:55 INFO - PROCESS | 10915 | 03:28:57 INFO - PROCESS | 10915 | Cycle 1(1): loaded http://localhost:46561/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46561/tests/dromaeo/cssquery-mootools.html) 03:28:57 INFO - PROCESS | 10915 | RSS: Main: 226648064 03:28:57 INFO - PROCESS | 10915 | 03:31:59 INFO - PROCESS | 10915 | Cycle 1(1): loaded http://localhost:46561/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46561/tests/dromaeo/cssquery-prototype.html) 03:32:00 INFO - PROCESS | 10915 | RSS: Main: 220725248 03:32:00 INFO - PROCESS | 10915 | 03:35:02 INFO - PROCESS | 10915 | Cycle 1(1): loaded http://localhost:46561/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46561/tests/dromaeo/cssquery-yui.html) 03:35:03 INFO - PROCESS | 10915 | RSS: Main: 218042368 03:35:03 INFO - PROCESS | 10915 | 03:38:05 INFO - PROCESS | 10915 | Cycle 1(1): loaded http://localhost:46561/tests/dromaeo/cssquery-yui.html (next: http://localhost:46561/tests/dromaeo/cssquery-dojo.html) 03:38:05 INFO - PROCESS | 10915 | RSS: Main: 260837376 03:38:05 INFO - PROCESS | 10915 | 03:38:05 INFO - PROCESS | 10915 | __start_tp_report 03:38:05 INFO - PROCESS | 10915 | _x_x_mozilla_page_load 03:38:05 INFO - PROCESS | 10915 | _x_x_mozilla_page_load_details 03:38:05 INFO - PROCESS | 10915 | |i|pagename|runs| 03:38:05 INFO - PROCESS | 10915 | |0;dojo.html;3342.84957176927;3362.7814192077512;3365.8821941232045;3374.8312584370774;3414.453687410013;5540.418256083114;5585.52523035542;5597.3003374578175;5606.859828504289;5611.607187496877;5500.477454641803;5542.4457554244555;5545.556355491551;5553.500184983351;5593.636413633111;4963.677360971526;5006.148954677714;5023.422306434771;5062.443131255559;5089.211172268286;4933.136701077315;5075.061113693979;5107.821226257081;5122.974385128069;5123.487651234866;5010.649254552182;5051.065552872712;5055;5060.873478163038;5082.796688132489;5157.277981082651;5168.586513078963;5175.715335656538;5175.818846340398;5192.896142077157;4890.853274401774;4977.6764510307075;5019.949800501985;5060.468650791688;5084.44071152173;5379.058664733656;5403.162509810985;5403.918941215885;5447.509724124809;5456.372517160498;5978.372270911535;6000.789972350947;6008.309044459899;6009.459148676597;6010.909836352458;5798.10129429939;5868.970655146697;5872.001759700861;5926.496247818941;6061.909071363933;5522.2544956431175;5534.225208470817;5556.91664625031;5558.527525160366;5581.944180558224;5848.502877255396;6050.818475445743;6055.048614814198;6063.060225665029;6082.695865206722;5810.535157187415;5850.297964244232;5860.824175274749;5974.1934838796205;5975;6026.186464827192;6031.487323577458;6031.60794548353;6060.727267272983;6065.332813390523;5712.343080545707;5855.531557475391;5994.820155395345;6004.189434426296;6004.699765011732;5917.792877249276;5982.40175982407;5988.670623115683;5990;6013.729382177812;4599.701019433726;4606.332081848113;4607.331936869202;4610.492845786961;4626.606738427204;4007.7595344279434;4015.357542793139;4068.8575899843363;4114.259433301974;4146.489405073242;5667.036603777367;5678.602497825113;5684.459976302244;5693.715314234271;5694.829155125353;5976.820695379146;5989.520838332923;6006.789762358297;6007.699615019232;6040.697965101727;5421.728913554307;5605;5675.290588676416;5697.601167918206;5719.142128680648;5075.87310317245;5084.9745751271;5088;5090.821821236313;5098.515641014098;5981.581289309794;6225.8132256032395;6266.279377871603;6272.40412160844;6292.087647291209;5931.614445061057;5976.731047102978;5976.940230597812;6048.425399587032;6063.029915213545;6257.405546473078;6275.497960163268;6294.842628934313;6296.653684047238;6301.684915754102;5636.267285252891;5800.535957123504;5931.110333450017;5944.108383742473;5978.491828194478;5904.350521442552;5998.1002849572915;6003.849903752441;6008.03871380577;6023.6385816851125;5828.766849326149;5865.882682346414;5877.0302900021015;5879.323877754113;5881.147233651182;5651.265335506358;5804.100364443518;5805.042168042394;5834.474897259267;5867.471927526543;5849.239598852122;5850.765969361178;5853.122031695109;5853.1220316952795;5884.08796636522;5964.970175149097;5973.283206015306;6009.789657361971;6009.969950150221;6022.427869352405;5590.916136258041;5681.318241811009;5712.571557133315;5733.197352370755;5868.647881127146 03:38:05 INFO - PROCESS | 10915 | |1;ext.html;593.7120496559168;645.7158850105953;647.2491909385111;653.2846533046312;667.9365460281277;33778.66221337786;36168.81915590422;36215.63784362155;36222.45666315007;36244.637553624525;36769.44845827308;37575;47050.764746176304;48277;48375.75812120943;8933.062028487013;9098.954505227464;9102.544872756369;9107.453552786821;9108.271338292921;9000.819983600324;9004.099590041009;9008.54957252138;9028.32287578431;9103.317251206154;8396.370272229577;10932.453377331101;11128.833067503994;11167.553297868117;11178.105751539857;10656.680299591024;10749.892501074968;10753.677389678243;11062.557497700163;11070.335779853154;8256.83486330276;10552.47237638115;10774.084202842767;10845.783084338347;10873.456327183609;47494.287585686245;48058.27912581314;48117.27824082642;48138.51861481411;48167.51832481665;3740.869069582579;3748.3440397930253;3868.7485313454536;3902.356111241642;3930.1746633207063;27397.574958550536;27868.442631147263;34390;35873.282534349164;36130.63869361299;4766.928496072562;4769.976150119227;4832.516748325174;4863.124637565237;4926.334944782444;407254;410894;412220;412331;412620;71737.64131179311;72097;72211.63894180495;72282.27717722756;72457;75727;76079;76280;76606.23393765991;76722;18436.446906592824;19010.904945475184;19017.049147542566;19019.714704279446;19022.61954760897;14036.789448158286;14039.929800350932;14042.929785351007;14045;14092.506762263476;18840.76794673817;21411.46471338229;21926.342209733735;22207.66688499674;22396.104155833586;7704.460687751915;7711.614419279013;7828.238646304536;7850.56821874791;7912.723054693058;989.9059589339146;1072.8980746829038;1113.4877956140267;1185.9110566707532;1193.3376975778353;34382.48426273608;34511.654883451345;34740.30519389598;35129.64870351315;35183.4722479163;1166.6674997625805;1196.342011893455;1209.9334536600395;1229.5880879905153;1258.5595041735319;18233.544161396072;18237.361692340968;18240.908795455936;18293.359732409303;18322.450326490227;583856;587718;587965;588400;588775;66123.66938165374;66256.6687166561;66518.66740666266;66747.33252667412;66766.33233667698;1340.5040135149861;1419.5954153066532;1437.6334034821264;1446.6094154578204;1457.890658200639;33325.83337083299;35988;36529.26941461209;37120.25759484741;37336.43995340126;54771.45228547663;55359.446405535426;55913.72043139758;55996.72001640129;56082.439175607724;433294;434135;434678;438336;438774;40070.1985960285;46074.769626151654;46269.30596041129;47243.29135062908;47451.52548474609;52744.20883686671;52799.73600131975;53281.733591331795;53552.46447535475;53617;43639.56360436482;44240.55759442493;44430.11139777251;45023;45587;43955.66072985428;44497;44529.332060018474;44757.328640069776;45910.31134532918;44113.353198808174;45340.31989520226;45582.31626525539;45731.54268457273;45887.54112458966;38447.80776096102;39325.60674393219;39331;39879.601203987586;40118.799406002785;29555.704442955295;29788.55317170201;29793.553096703134;29851.402971940875;30050.549241760953 03:38:05 INFO - PROCESS | 10915 | |2;jquery.html;401.9216252830697;402.8449047116859;410.58735970349795;416.90411205422754;421.81018541656243;15402;18975;20741.481462963413;20850;22091.116355345806;20804.89597552014;20933.58132837346;21313.36059918201;21437.14251429945;21468.8926555367;5567.693776842282;5840.328362238333;5840.737166827503;5843.970780146094;5849.678267695275;4343.934840977372;5758.049921762904;5807.477327040566;5818.0981947797945;5827.854303642401;6084.087386891957;6383.904241436359;6397.968010159942;6510.251321098087;6520.576162549442;6399.808005759812;6425.1968503937005;6427.903581446282;6456.289808121103;6462.838429039311;5498.505134537871;5668.206451096849;5670.943290567083;5677.40387259336;5703.600747947646;22974.885125574267;24562.263132106065;24804.3798905027;25010.874945625157;25601.48797024049;2505.523950449409;2523.3313172009434;2569.79441644668;2604.4660844526825;2627.619398746476;9855.11303982645;14915.850841491554;15252.466163684328;15264;15381.077135371801;1966.852486063551;2062.9690554641693;2081.916723331065;2090.6654935210445;2105.505206276524;75811;78457.60771196165;79597.60201199015;85451;89412.5529372349;9311.115444032941;9872.111509964137;10000.449975251286;10250.794984100276;10265;13384;13422;13470.326483675974;13474.326283685776;13536.052476326562;8210.466319689202;8447.02859171203;8449.070602233749;8457.450265732708;8552.914470855336;8600.182982616641;8622.945111790843;8802.251808596213;8944.150305720947;8954.776130596656;4024.9798751006642;4034.8789536313957;4046.1705350403095;4120.237756015147;4250.978745106255;1833.6516061948187;1841.3555255660413;1843.2074208090382;1861.5997560524552;1930.1893204853995;448.7032476143947;462.5998511287779;462.69230961410284;946.8343039967978;1150.2753265442718;11951.163418560618;11965.820512692317;12199.329036903055;12218.877811221952;12335.198212116364;463.25416080110995;464.9093426781745;473.5879784587431;487.43944463866126;491.83523519621326;6473.482121430275;6481.027845823164;6530.2816690164045;6534.183227096613;6549.869002619921;546868;551795;554159;556468;557233;79957.60021199856;90323.54838225899;102004.48997754963;108082;111303;470.73403527007133;477.14829030181653;477.8638088144862;482.3801415181545;1080.222239987208;17648.73526897072;18708.532286692942;18758.249670013047;18812.435626931216;18825.717614236073;40164.79917600393;41517;43632.34551481667;44495.777521112184;45760.7711961438;52399.476005240984;61354;61718.382816171266;61766.69116654388;62928.370716294085;8547.95726021366;8781.385303028726;8965.775855603662;8984.101589840964;9057.230135438298;13223.471061157446;13652.795208071688;13713.794293085812;13893.096948698303;13951.930240348733;8058.677652893819;12314.938425307817;12442.37788110609;12579.93710031444;12775.744485110059;11589.710257243636;11791.469383877575;12476.750464990831;12677.492900284255;12735.55425560101;12883.806742898676;12971.416286266953;13080.869191307966;13112.344382780631;13148.342582870628;8993.910060899307;9014.729558113268;9043.819123617623;9177.77055573616;9256.213221876216;9082.36423450352;12491;12521;12573.811392829299;12606.306653134166 03:38:05 INFO - PROCESS | 10915 | |3;mootools.html;1391.9512817051404;1600.3038678174994;1611.105836260875;1840.5950690848008;1941.8931958742273;9049.14033166849;9331.626734930604;9362.204212641926;9694.12752852245;9748.805023899518;9425.57584908679;9645.180159686435;9649.22806175506;9659.227261819055;9682.419054856697;2398.796102331304;2414.8913298901502;2425.139075628153;2427.6844010278637;2429.878506074689;2415.1909110448023;2455.7667021632915;2488.1291547958162;2489.3776555861036;2501.062101711858;2446.131623273739;2449.0571130114854;2471.864047477388;2478.615814548739;2484.627305904111;2369.7393286738443;2370.644403339513;2378.2389635316704;2385.320183747632;2407.374082738483;2301.551197516485;2330.5105927755194;2334.0430423526273;2334.2997100869843;2340.976590234093;8365.205305495969;8573.52845593492;9455.52722363886;9536.2371010319;9555.522223888778;4799.760011999386;4917.114919314522;5272.261883336336;5414.269073675043;5419.187121931703;3573.6962358199585;3621.3662609043313;3631.8184090795353;3687.2441149564543;3695.113172838526;1144.9771004579945;1191.195942738648;1191.2137988927352;1191.9106067045007;1206.8129439936824;13812.309384530734;13875.306234688325;13912.58262252134;13936;13947.790783138262;4724.173269677793;4747;4824.614030877521;4840.394950631171;4845.75771211438;11514.078873690085;11514.76970460586;11520.423978801027;11540.24988375753;11556.364399958084;5416;5419;5419.701916394636;5421.918671219935;5422.078246698071;4873.561379475864;4898.90202195954;4967.826126085642;5122.948770512247;5125.743712814345;3982.880513584597;3991.221711766236;4057.5536690963972;4082.0611259410502;4129.359949207877;1212.5331747277185;1257.0634877016498;1263.3809433377762;1267.4930027988694;1279.5649479177125;853.7268074216191;1026.2918586175515;1068.636663534402;1081.2485322700647;1091.514276147107;6416.358364163546;6426.871462570816;6500;6574.211094668574;6653.733850646016;978.4276198424002;1031.63377001165;1065.3767545985531;1072.2708558180357;1116.8603924509437;4480.260756975128;4514.277715565494;4517.457905051415;4523.909521809545;4557.635389168859;12024.699382515508;12362.814557781641;12374.381280936097;12377.381130943417;12404.19372740769;11613.825792613117;12055.57805476804;12060.75878482443;12412;12428.316442595564;8730.825383492294;8998.325125615474;9011.053839346905;9011.549422528848;9024.278057755364;6569.967150164219;6731.225909020525;6744.156980377453;6854.074699915447;6900.171979362509;11192.104631629287;11301.491432885376;11443.828342574701;11448.141389395661;11482.081433485468;11416.31502109876;11562.364069975896;11625.302481851117;11637.650870473899;11641;8385.874211886705;8531.402801803813;8624.396292259482;8647.654093836176;8676.175763302475;9607.663731769355;9628.18160456341;9636.373635713657;9697.6120955161;9698.078682525149;8496.490210587384;8691.521966291915;8712.303015758598;8789.384743067923;8843.425177363451;8250.54621995796;8261.752147435587;8518.48889066658;8569.914300856912;8684.2184203422;7845.254700803414;7934.603269836601;7936.484128531627;7938.285554300141;7941.483803552751;5555.30558680165;5562.638428502134;5653.152027195789;5718.342390625131;5807.390224026416;5019.924701129559;5723.599348045597;5747.166660834072;5791.131330300489;5878.412158784087 03:38:05 INFO - PROCESS | 10915 | |4;prototype.html;334.5951398807442;338.1934087202022;342.9537012503311;344.2890431259449;347.272464187527;5522.889542209158;5547.140193270049;5579.274694289747;5590.776368945242;5629.3526244481845;5411.540019098381;5501.642393244436;5510.834674959758;5512.228288039678;5528.336599608053;4123.6494897933635;4156.251874662559;4269.551697071809;4290.5709429057;4320.848770293041;4193.412922190896;4272.743635381887;4281.159101586317;4301.0967696783555;4320.524742278347;4050.2709512287774;4226.894327641803;4245.129748401586;4246.3205887058075;4259.829606815739;3988.7806170660747;4131.0185786021675;4180.686448516343;4240.279152544075;4245.450410600109;3724.087598538348;3736.23407201523;3746.587875333711;3747.2318174774377;3754.49314342563;5218.347706536683;5345.732713364355;5351.866203344947;5353.464653534655;5359.231453620296;4709.116353458609;4791.233402655594;4794.544518270759;4810.39870016248;4847.951520484785;5697.230873832063;5707.71461426927;5718.828435146952;5720.313562372542;5757.366689664133;4111.820735010449;4121;4132.710710250284;4146.792660366969;4151.626353628188;5640.461792193489;5922.8815423691285;5971.7611295547695;5971.910421343683;5975.611585246988;4081.469408976814;4137.172565486914;4138.379243113497;4139.648129908931;4146.854860079943;4221.767802770877;4224.281872081692;4227.767472788964;4231.661467082626;4237.6821738369745;4671.5094915034115;4695.694779839299;4729.716217026989;4747.786349614275;4763.618910487153;5663.631863928831;5683.971580142155;5699.2590963174525;5706.229658995982;5726.3700992890745;1434.340203506378;1447.3486930881145;1447.6959838434047;1449.2101804516565;1457.8542145785336;897.1835629577054;906.3383729877227;915.6474757218385;927.8979312275644;949.5299826585884;5538.363088244903;5552.666839989613;5559.416261292587;5601;5621.18492818539;5810.680412577349;5831.387704290988;5868.119782032644;5879.5002424794375;5889.617174883619;5220.634555581073;5516.531094856902;5553.4724201200825;5578.2748242728185;5599.0761524348845;3101.1626860747924;3107.891223807201;3122.172624254574;3126.8436578171;3128.3586864692684;5853.502452291517;6016.217891674054;6050.42520960508;6060.666663333559;6073.878522429527;5884.617499862496;5899.026660600953;5902.8819423611285;5909.527237820964;5911.733971971272;6001.3098493672915;6022.789202377896;6080.270367555833;6107.236595425661;6122.755089796358;5703.971480142573;5821.476067153807;5826.76692932278;5836.153757705194;5844.503217226584;5698.145278208136;5700.515456186271;5756.129257991086;5768.884622307614;5770.884582308414;5793.594448388572;5978.880422391441;6037.124616930432;6042.308153716966;6141.969290153521;4138.779060177195;4142.9792851036755;4168;4168.145530166369;4168.645665118378;5867.530597552271;5883.3820699308035;5898.94101058984;5912.822615321547;5918.141869428822;5595.748191331481;5727.594410347748;5765.4811067004175;5774.855628609318;5805.419458054161;5654.6324488908085;5680.204771331934;5695.345035320991;5708.315002199596;5736.340320862987;5388.434214407431;5496.488465671972;5522.66863988162;5624.268845050117;5640.756564975074;5664.37691853904;5725.227094342211;5752.223449834386;5760.452756988079;5769.60561367028;5485.177223416519;5627.803026894039;5647.265855438766;5662.7734890603915;5664.546836253172 03:38:05 INFO - PROCESS | 10915 | |5;yui.html;807.3116521981801;813.4834380168593;830.9293710034647;867.3581549653254;868.9782755431113;15113.244337783122;15616.609584760372;15850.286737096814;15859;15930.920345398257;15377.615559611015;15621.375144994216;15875.126868022255;15930.920345398286;15983.84016159841;877.1272583779132;882.8940527136721;887.436477836572;889.3285569395098;889.6886089868559;748.1807420874161;859.8925134358205;873.6592728835759;875.5578432891381;879.7624641346864;938.5541867612898;941.7221919533754;942.1520631431732;942.7454587261435;942.9245660347156;773.3194788586064;936.0592604432536;936.9812603747955;937.8640097185904;938.1603464898911;667.159379182229;673.4545018534953;674.4570620650375;675.76010516267;678.2640834694363;14601.78097328541;14810.703785924328;14928;14934.62663433412;14937.477188298357;15027.624309392244;15506.45727399547;15560.61098472536;15621.453249136226;15817.683646327008;13313.467461301536;13752.449902003907;13826.23955682437;13865.237411942338;14118.858811411857;4707.223308154151;4786.952130478686;4807.95192048082;4820.975895120502;4913.901721965576;75702.24297757007;77557;77994.22005779983;78306.21693783047;79311;12251.816222756488;12431.875681243253;12471.93764031174;12510.937445312715;12692.873071269354;22320.10719571199;22337.32988010362;22382.88808555947;22440.990155443043;22484;8881.156290152425;8958.507282099417;9004.729858104267;9088.772780680536;9240.5841737122;4842.22524396102;4957.876053098701;5055.14751649446;5069.670471419346;5123.897522049613;3517.630648781841;3600.5499312585926;3614.7288953328607;3617.782933024027;3620.3664358737115;592.6740292839007;600.519584332541;604.3684349854412;618.9257289125244;623.5853157650203;640.7981485831948;715.6994062493765;723.1147720594894;763.091920614467;795.8169620987205;10103.826283338765;10137.171126602234;10143.746406339753;10164;10210.234232432596;699.6047233313263;724.4675163754636;735.1729304532402;771.5756334016269;787.1341524323199;4839.249916262985;5135.229715542624;5259.763310650953;5487.780488780484;5560.304961879765;84650.5767471171;128011.35994319968;130193;131683.34158329148;132803;107742.46128769463;109351;109918;110069.44965275122;110531.44734276277;98104;99595.50202249088;99744.50127749315;102070;102554.97445025454;10055.648052318134;10057.949710251401;10160.313146675546;10162.491875406053;10437.530311135864;51988.480115199876;52009;52816.73591632171;54396.18405723997;55931.72034139803;78321.21678783139;85301;87758.56120719356;88432;89196;11828.408579570814;13474.258915759336;13697.520586779416;13922.721545569235;14218.928905355408;14444.927775361057;14874.33065512033;15435.15106669099;15631.140287284308;16441.83558164403;14753.631159220677;15296.464623738117;15393;15905.363785448453;15922.363105475652;14262;14873.776893346825;15150.696986060437;15645.1395173262;15692.215389230721;15008;15310.540683779505;15367.538973830802;15475.226238687796;15809.13049782273;11754.88245117538;12010.068677098978;12656.810147847973;13022.544210952572;13107.641053518628;11804.940975295412;12325.383730813603;12439.751204976032;12482.126251162332;13019.283939383426 03:38:05 INFO - PROCESS | 10915 | __end_tp_report 03:38:05 INFO - PROCESS | 10915 | __start_cc_report 03:38:05 INFO - PROCESS | 10915 | _x_x_mozilla_cycle_collect,948 03:38:05 INFO - PROCESS | 10915 | __end_cc_report 03:38:05 INFO - PROCESS | 10915 | __startTimestamp1467801485983__endTimestamp 03:38:05 INFO - PROCESS | 10915 | 03:38:05 INFO - PROCESS | 10915 | ------- Summary: start ------- 03:38:05 INFO - PROCESS | 10915 | Number of tests: 6 03:38:05 INFO - PROCESS | 10915 | 03:38:05 INFO - PROCESS | 10915 | [#0] dojo.html Cycles:165 Average:5552.01 Median:5798.10 stddev:623.40 (10.8%) stddev-sans-first:600.74 03:38:05 INFO - PROCESS | 10915 | Values: 3342.8 3362.8 3365.9 3374.8 3414.5 5540.4 5585.5 5597.3 5606.9 5611.6 5500.5 5542.4 5545.6 5553.5 5593.6 4963.7 5006.1 5023.4 5062.4 5089.2 4933.1 5075.1 5107.8 5123.0 5123.5 5010.6 5051.1 5055.0 5060.9 5082.8 5157.3 5168.6 5175.7 5175.8 5192.9 4890.9 4977.7 5019.9 5060.5 5084.4 5379.1 5403.2 5403.9 5447.5 5456.4 5978.4 6000.8 6008.3 6009.5 6010.9 5798.1 5869.0 5872.0 5926.5 6061.9 5522.3 5534.2 5556.9 5558.5 5581.9 5848.5 6050.8 6055.0 6063.1 6082.7 5810.5 5850.3 5860.8 5974.2 5975.0 6026.2 6031.5 6031.6 6060.7 6065.3 5712.3 5855.5 5994.8 6004.2 6004.7 5917.8 5982.4 5988.7 5990.0 6013.7 4599.7 4606.3 4607.3 4610.5 4626.6 4007.8 4015.4 4068.9 4114.3 4146.5 5667.0 5678.6 5684.5 5693.7 5694.8 5976.8 5989.5 6006.8 6007.7 6040.7 5421.7 5605.0 5675.3 5697.6 5719.1 5075.9 5085.0 5088.0 5090.8 5098.5 5981.6 6225.8 6266.3 6272.4 6292.1 5931.6 5976.7 5976.9 6048.4 6063.0 6257.4 6275.5 6294.8 6296.7 6301.7 5636.3 5800.5 5931.1 5944.1 5978.5 5904.4 5998.1 6003.8 6008.0 6023.6 5828.8 5865.9 5877.0 5879.3 5881.1 5651.3 5804.1 5805.0 5834.5 5867.5 5849.2 5850.8 5853.1 5853.1 5884.1 5965.0 5973.3 6009.8 6010.0 6022.4 5590.9 5681.3 5712.6 5733.2 5868.6 03:38:05 INFO - PROCESS | 10915 | 03:38:05 INFO - PROCESS | 10915 | [#1] ext.html Cycles:180 Average:66139.29 Median:433714.50 stddev:128311.09 (29.6%) stddev-sans-first:128576.66 03:38:05 INFO - PROCESS | 10915 | Values: 593.7 645.7 647.2 653.3 667.9 33778.7 36168.8 36215.6 36222.5 36244.6 36769.4 37575.0 47050.8 48277.0 48375.8 8933.1 9099.0 9102.5 9107.5 9108.3 9000.8 9004.1 9008.5 9028.3 9103.3 8396.4 10932.5 11128.8 11167.6 11178.1 10656.7 10749.9 10753.7 11062.6 11070.3 8256.8 10552.5 10774.1 10845.8 10873.5 47494.3 48058.3 48117.3 48138.5 48167.5 3740.9 3748.3 3868.7 3902.4 3930.2 27397.6 27868.4 34390.0 35873.3 36130.6 4766.9 4770.0 4832.5 4863.1 4926.3 407254.0 410894.0 412220.0 412331.0 412620.0 71737.6 72097.0 72211.6 72282.3 72457.0 75727.0 76079.0 76280.0 76606.2 76722.0 18436.4 19010.9 19017.0 19019.7 19022.6 14036.8 14039.9 14042.9 14045.0 14092.5 18840.8 21411.5 21926.3 22207.7 22396.1 7704.5 7711.6 7828.2 7850.6 7912.7 989.9 1072.9 1113.5 1185.9 1193.3 34382.5 34511.7 34740.3 35129.6 35183.5 1166.7 1196.3 1209.9 1229.6 1258.6 18233.5 18237.4 18240.9 18293.4 18322.5 583856.0 587718.0 587965.0 588400.0 588775.0 66123.7 66256.7 66518.7 66747.3 66766.3 1340.5 1419.6 1437.6 1446.6 1457.9 33325.8 35988.0 36529.3 37120.3 37336.4 54771.5 55359.4 55913.7 55996.7 56082.4 433294.0 434135.0 434678.0 438336.0 438774.0 40070.2 46074.8 46269.3 47243.3 47451.5 52744.2 52799.7 53281.7 53552.5 53617.0 43639.6 44240.6 44430.1 45023.0 45587.0 43955.7 44497.0 44529.3 44757.3 45910.3 44113.4 45340.3 45582.3 45731.5 45887.5 38447.8 39325.6 39331.0 39879.6 40118.8 29555.7 29788.6 29793.6 29851.4 30050.5 03:38:05 INFO - PROCESS | 10915 | 03:38:05 INFO - PROCESS | 10915 | [#2] jquery.html Cycles:180 Average:31022.77 Median:2336.39 stddev:91125.71 (3900.3%) stddev-sans-first:91352.34 03:38:05 INFO - PROCESS | 10915 | Values: 401.9 402.8 410.6 416.9 421.8 15402.0 18975.0 20741.5 20850.0 22091.1 20804.9 20933.6 21313.4 21437.1 21468.9 5567.7 5840.3 5840.7 5844.0 5849.7 4343.9 5758.0 5807.5 5818.1 5827.9 6084.1 6383.9 6398.0 6510.3 6520.6 6399.8 6425.2 6427.9 6456.3 6462.8 5498.5 5668.2 5670.9 5677.4 5703.6 22974.9 24562.3 24804.4 25010.9 25601.5 2505.5 2523.3 2569.8 2604.5 2627.6 9855.1 14915.9 15252.5 15264.0 15381.1 1966.9 2063.0 2081.9 2090.7 2105.5 75811.0 78457.6 79597.6 85451.0 89412.6 9311.1 9872.1 10000.4 10250.8 10265.0 13384.0 13422.0 13470.3 13474.3 13536.1 8210.5 8447.0 8449.1 8457.5 8552.9 8600.2 8622.9 8802.3 8944.2 8954.8 4025.0 4034.9 4046.2 4120.2 4251.0 1833.7 1841.4 1843.2 1861.6 1930.2 448.7 462.6 462.7 946.8 1150.3 11951.2 11965.8 12199.3 12218.9 12335.2 463.3 464.9 473.6 487.4 491.8 6473.5 6481.0 6530.3 6534.2 6549.9 546868.0 551795.0 554159.0 556468.0 557233.0 79957.6 90323.5 102004.5 108082.0 111303.0 470.7 477.1 477.9 482.4 1080.2 17648.7 18708.5 18758.2 18812.4 18825.7 40164.8 41517.0 43632.3 44495.8 45760.8 52399.5 61354.0 61718.4 61766.7 62928.4 8548.0 8781.4 8965.8 8984.1 9057.2 13223.5 13652.8 13713.8 13893.1 13951.9 8058.7 12314.9 12442.4 12579.9 12775.7 11589.7 11791.5 12476.8 12677.5 12735.6 12883.8 12971.4 13080.9 13112.3 13148.3 8993.9 9014.7 9043.8 9177.8 9256.2 9082.4 12491.0 12521.0 12573.8 12606.3 03:38:05 INFO - PROCESS | 10915 | 03:38:05 INFO - PROCESS | 10915 | [#3] mootools.html Cycles:180 Average:6350.69 Median:4520.68 stddev:3740.02 (82.7%) stddev-sans-first:3731.95 03:38:05 INFO - PROCESS | 10915 | Values: 1392.0 1600.3 1611.1 1840.6 1941.9 9049.1 9331.6 9362.2 9694.1 9748.8 9425.6 9645.2 9649.2 9659.2 9682.4 2398.8 2414.9 2425.1 2427.7 2429.9 2415.2 2455.8 2488.1 2489.4 2501.1 2446.1 2449.1 2471.9 2478.6 2484.6 2369.7 2370.6 2378.2 2385.3 2407.4 2301.6 2330.5 2334.0 2334.3 2341.0 8365.2 8573.5 9455.5 9536.2 9555.5 4799.8 4917.1 5272.3 5414.3 5419.2 3573.7 3621.4 3631.8 3687.2 3695.1 1145.0 1191.2 1191.2 1191.9 1206.8 13812.3 13875.3 13912.6 13936.0 13947.8 4724.2 4747.0 4824.6 4840.4 4845.8 11514.1 11514.8 11520.4 11540.2 11556.4 5416.0 5419.0 5419.7 5421.9 5422.1 4873.6 4898.9 4967.8 5122.9 5125.7 3982.9 3991.2 4057.6 4082.1 4129.4 1212.5 1257.1 1263.4 1267.5 1279.6 853.7 1026.3 1068.6 1081.2 1091.5 6416.4 6426.9 6500.0 6574.2 6653.7 978.4 1031.6 1065.4 1072.3 1116.9 4480.3 4514.3 4517.5 4523.9 4557.6 12024.7 12362.8 12374.4 12377.4 12404.2 11613.8 12055.6 12060.8 12412.0 12428.3 8730.8 8998.3 9011.1 9011.5 9024.3 6570.0 6731.2 6744.2 6854.1 6900.2 11192.1 11301.5 11443.8 11448.1 11482.1 11416.3 11562.4 11625.3 11637.7 11641.0 8385.9 8531.4 8624.4 8647.7 8676.2 9607.7 9628.2 9636.4 9697.6 9698.1 8496.5 8691.5 8712.3 8789.4 8843.4 8250.5 8261.8 8518.5 8569.9 8684.2 7845.3 7934.6 7936.5 7938.3 7941.5 5555.3 5562.6 5653.2 5718.3 5807.4 5019.9 5723.6 5747.2 5791.1 5878.4 03:38:05 INFO - PROCESS | 10915 | 03:38:05 INFO - PROCESS | 10915 | [#4] prototype.html Cycles:180 Average:4804.44 Median:5556.44 stddev:1420.44 (25.6%) stddev-sans-first:1384.23 03:38:05 INFO - PROCESS | 10915 | Values: 334.6 338.2 343.0 344.3 347.3 5522.9 5547.1 5579.3 5590.8 5629.4 5411.5 5501.6 5510.8 5512.2 5528.3 4123.6 4156.3 4269.6 4290.6 4320.8 4193.4 4272.7 4281.2 4301.1 4320.5 4050.3 4226.9 4245.1 4246.3 4259.8 3988.8 4131.0 4180.7 4240.3 4245.5 3724.1 3736.2 3746.6 3747.2 3754.5 5218.3 5345.7 5351.9 5353.5 5359.2 4709.1 4791.2 4794.5 4810.4 4848.0 5697.2 5707.7 5718.8 5720.3 5757.4 4111.8 4121.0 4132.7 4146.8 4151.6 5640.5 5922.9 5971.8 5971.9 5975.6 4081.5 4137.2 4138.4 4139.6 4146.9 4221.8 4224.3 4227.8 4231.7 4237.7 4671.5 4695.7 4729.7 4747.8 4763.6 5663.6 5684.0 5699.3 5706.2 5726.4 1434.3 1447.3 1447.7 1449.2 1457.9 897.2 906.3 915.6 927.9 949.5 5538.4 5552.7 5559.4 5601.0 5621.2 5810.7 5831.4 5868.1 5879.5 5889.6 5220.6 5516.5 5553.5 5578.3 5599.1 3101.2 3107.9 3122.2 3126.8 3128.4 5853.5 6016.2 6050.4 6060.7 6073.9 5884.6 5899.0 5902.9 5909.5 5911.7 6001.3 6022.8 6080.3 6107.2 6122.8 5704.0 5821.5 5826.8 5836.2 5844.5 5698.1 5700.5 5756.1 5768.9 5770.9 5793.6 5978.9 6037.1 6042.3 6142.0 4138.8 4143.0 4168.0 4168.1 4168.6 5867.5 5883.4 5898.9 5912.8 5918.1 5595.7 5727.6 5765.5 5774.9 5805.4 5654.6 5680.2 5695.3 5708.3 5736.3 5388.4 5496.5 5522.7 5624.3 5640.8 5664.4 5725.2 5752.2 5760.5 5769.6 5485.2 5627.8 5647.3 5662.8 5664.5 03:38:06 INFO - PROCESS | 10915 | 03:38:06 INFO - PROCESS | 10915 | [#5] yui.html Cycles:180 Average:22603.34 Median:13000.82 stddev:32873.66 (252.9%) stddev-sans-first:32925.14 03:38:06 INFO - PROCESS | 10915 | Values: 807.3 813.5 830.9 867.4 869.0 15113.2 15616.6 15850.3 15859.0 15930.9 15377.6 15621.4 15875.1 15930.9 15983.8 877.1 882.9 887.4 889.3 889.7 748.2 859.9 873.7 875.6 879.8 938.6 941.7 942.2 942.7 942.9 773.3 936.1 937.0 937.9 938.2 667.2 673.5 674.5 675.8 678.3 14601.8 14810.7 14928.0 14934.6 14937.5 15027.6 15506.5 15560.6 15621.5 15817.7 13313.5 13752.4 13826.2 13865.2 14118.9 4707.2 4787.0 4808.0 4821.0 4913.9 75702.2 77557.0 77994.2 78306.2 79311.0 12251.8 12431.9 12471.9 12510.9 12692.9 22320.1 22337.3 22382.9 22441.0 22484.0 8881.2 8958.5 9004.7 9088.8 9240.6 4842.2 4957.9 5055.1 5069.7 5123.9 3517.6 3600.5 3614.7 3617.8 3620.4 592.7 600.5 604.4 618.9 623.6 640.8 715.7 723.1 763.1 795.8 10103.8 10137.2 10143.7 10164.0 10210.2 699.6 724.5 735.2 771.6 787.1 4839.2 5135.2 5259.8 5487.8 5560.3 84650.6 128011.4 130193.0 131683.3 132803.0 107742.5 109351.0 109918.0 110069.4 110531.4 98104.0 99595.5 99744.5 102070.0 102555.0 10055.6 10057.9 10160.3 10162.5 10437.5 51988.5 52009.0 52816.7 54396.2 55931.7 78321.2 85301.0 87758.6 88432.0 89196.0 11828.4 13474.3 13697.5 13922.7 14218.9 14444.9 14874.3 15435.2 15631.1 16441.8 14753.6 15296.5 15393.0 15905.4 15922.4 14262.0 14873.8 15150.7 15645.1 15692.2 15008.0 15310.5 15367.5 15475.2 15809.1 11754.9 12010.1 12656.8 13022.5 13107.6 11804.9 12325.4 12439.8 12482.1 13019.3 03:38:06 INFO - PROCESS | 10915 | -------- Summary: end -------- 03:38:06 INFO - PROCESS | 10915 | 03:38:06 INFO - TEST-INFO | 10915: exit 0 03:38:06 INFO - TEST-OK | dromaeo_css | took 1113117ms 03:38:06 INFO - TEST-START | kraken 03:38:06 INFO - operating with platform_type : linux_ 03:38:06 INFO - Initialising browser for kraken test... 03:38:06 INFO - TEST-INFO | started process 11105 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnlMUzI/profile http://localhost:46561/getInfo.html) 03:38:10 INFO - PROCESS | 11105 | __metrics Screen width/height:1600/1200 03:38:10 INFO - PROCESS | 11105 | colorDepth:24 03:38:10 INFO - PROCESS | 11105 | Browser inner width/height: 1024/697 03:38:10 INFO - PROCESS | 11105 | __metrics 03:38:11 ERROR - PROCESS | 11105 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:38:12 INFO - TEST-INFO | 11105: exit 0 03:38:12 INFO - Browser initialized. 03:38:12 INFO - Running cycle 1/1 for kraken test... 03:38:12 INFO - TEST-INFO | started process 11196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnlMUzI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:24 INFO - PROCESS | 11196 | RSS: Main: 145461248 03:38:24 INFO - PROCESS | 11196 | 03:38:26 INFO - PROCESS | 11196 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46561/tests/kraken/driver.html?testName=audio-beat-detection) 03:38:27 INFO - PROCESS | 11196 | RSS: Main: 194596864 03:38:27 INFO - PROCESS | 11196 | 03:38:30 INFO - PROCESS | 11196 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46561/tests/kraken/driver.html?testName=audio-dft) 03:38:30 INFO - PROCESS | 11196 | RSS: Main: 192217088 03:38:30 INFO - PROCESS | 11196 | 03:38:33 INFO - PROCESS | 11196 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46561/tests/kraken/driver.html?testName=audio-fft) 03:38:34 INFO - PROCESS | 11196 | RSS: Main: 279179264 03:38:34 INFO - PROCESS | 11196 | 03:38:36 INFO - PROCESS | 11196 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46561/tests/kraken/driver.html?testName=audio-oscillator) 03:38:36 INFO - PROCESS | 11196 | RSS: Main: 187453440 03:38:36 INFO - PROCESS | 11196 | 03:38:39 INFO - PROCESS | 11196 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46561/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:38:39 INFO - PROCESS | 11196 | RSS: Main: 187179008 03:38:39 INFO - PROCESS | 11196 | 03:38:42 INFO - PROCESS | 11196 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46561/tests/kraken/driver.html?testName=imaging-darkroom) 03:38:43 INFO - PROCESS | 11196 | RSS: Main: 222343168 03:38:43 INFO - PROCESS | 11196 | 03:38:46 INFO - PROCESS | 11196 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46561/tests/kraken/driver.html?testName=imaging-desaturate) 03:38:47 INFO - PROCESS | 11196 | RSS: Main: 221564928 03:38:47 INFO - PROCESS | 11196 | 03:38:49 INFO - PROCESS | 11196 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46561/tests/kraken/driver.html?testName=json-parse-financial) 03:38:50 INFO - PROCESS | 11196 | RSS: Main: 221995008 03:38:50 INFO - PROCESS | 11196 | 03:38:52 INFO - PROCESS | 11196 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46561/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:38:52 INFO - PROCESS | 11196 | RSS: Main: 201252864 03:38:52 INFO - PROCESS | 11196 | 03:38:54 INFO - PROCESS | 11196 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46561/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:38:55 INFO - PROCESS | 11196 | RSS: Main: 200372224 03:38:55 INFO - PROCESS | 11196 | 03:38:57 INFO - PROCESS | 11196 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46561/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:38:57 INFO - PROCESS | 11196 | RSS: Main: 211132416 03:38:57 INFO - PROCESS | 11196 | 03:39:00 INFO - PROCESS | 11196 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46561/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:39:00 INFO - PROCESS | 11196 | RSS: Main: 215691264 03:39:00 INFO - PROCESS | 11196 | 03:39:03 INFO - PROCESS | 11196 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46561/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:39:03 INFO - PROCESS | 11196 | RSS: Main: 216965120 03:39:03 INFO - PROCESS | 11196 | 03:39:05 INFO - PROCESS | 11196 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46561/tests/kraken/driver.html?testName=ai-astar) 03:39:05 INFO - PROCESS | 11196 | RSS: Main: 258981888 03:39:05 INFO - PROCESS | 11196 | 03:39:05 INFO - PROCESS | 11196 | __start_tp_report 03:39:05 INFO - PROCESS | 11196 | _x_x_mozilla_page_load 03:39:05 INFO - PROCESS | 11196 | _x_x_mozilla_page_load_details 03:39:05 INFO - PROCESS | 11196 | |i|pagename|runs| 03:39:05 INFO - PROCESS | 11196 | |0;ai-astar;111;104;110;111;112;111;110;110;111;110 03:39:05 INFO - PROCESS | 11196 | |1;audio-beat-detection;148;122;125;173;124;133;149;125;164;123 03:39:05 INFO - PROCESS | 11196 | |2;audio-dft;160;161;160;159;158;160;160;159;158;159 03:39:05 INFO - PROCESS | 11196 | |3;audio-fft;75;83;75;100;74;75;74;75;97;75 03:39:05 INFO - PROCESS | 11196 | |4;audio-oscillator;83;84;112;85;84;84;118;84;84;118 03:39:05 INFO - PROCESS | 11196 | |5;imaging-gaussian-blur;117;118;117;118;117;117;116;117;117;116 03:39:05 INFO - PROCESS | 11196 | |6;imaging-darkroom;147;145;145;145;146;146;147;146;146;146 03:39:05 INFO - PROCESS | 11196 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 03:39:05 INFO - PROCESS | 11196 | |8;json-parse-financial;51;50;50;50;51;53;52;52;52;50 03:39:05 INFO - PROCESS | 11196 | |9;json-stringify-tinderbox;60;60;60;60;61;60;60;59;60;60 03:39:05 INFO - PROCESS | 11196 | |10;stanford-crypto-aes;76;81;78;75;79;78;76;82;102;77 03:39:05 INFO - PROCESS | 11196 | |11;stanford-crypto-ccm;128;118;121;117;117;115;115;119;122;130 03:39:05 INFO - PROCESS | 11196 | |12;stanford-crypto-pbkdf2;155;157;156;159;156;153;155;156;154;155 03:39:05 INFO - PROCESS | 11196 | |13;stanford-crypto-sha256-iterative;66;61;63;61;61;62;62;61;60;60 03:39:05 INFO - PROCESS | 11196 | __end_tp_report 03:39:05 INFO - PROCESS | 11196 | __start_cc_report 03:39:05 INFO - PROCESS | 11196 | _x_x_mozilla_cycle_collect,1613 03:39:05 INFO - PROCESS | 11196 | __end_cc_report 03:39:05 INFO - PROCESS | 11196 | __startTimestamp1467801545860__endTimestamp 03:39:05 INFO - PROCESS | 11196 | 03:39:05 INFO - PROCESS | 11196 | ------- Summary: start ------- 03:39:05 INFO - PROCESS | 11196 | Number of tests: 14 03:39:05 INFO - PROCESS | 11196 | 03:39:05 INFO - PROCESS | 11196 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.21 (2.0%) stddev-sans-first:2.32 03:39:05 INFO - PROCESS | 11196 | Values: 111.0 104.0 110.0 111.0 112.0 111.0 110.0 110.0 111.0 110.0 03:39:05 INFO - PROCESS | 11196 | 03:39:05 INFO - PROCESS | 11196 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:140.50 stddev:18.73 (13.3%) stddev-sans-first:19.56 03:39:05 INFO - PROCESS | 11196 | Values: 148.0 122.0 125.0 173.0 124.0 133.0 149.0 125.0 164.0 123.0 03:39:05 INFO - PROCESS | 11196 | 03:39:05 INFO - PROCESS | 11196 | [#2] audio-dft Cycles:10 Average:159.40 Median:160.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 03:39:05 INFO - PROCESS | 11196 | Values: 160.0 161.0 160.0 159.0 158.0 160.0 160.0 159.0 158.0 159.0 03:39:05 INFO - PROCESS | 11196 | 03:39:05 INFO - PROCESS | 11196 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:9.97 (13.3%) stddev-sans-first:10.39 03:39:05 INFO - PROCESS | 11196 | Values: 75.0 83.0 75.0 100.0 74.0 75.0 74.0 75.0 97.0 75.0 03:39:05 INFO - PROCESS | 11196 | 03:39:05 INFO - PROCESS | 11196 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:84.00 stddev:15.55 (18.5%) stddev-sans-first:16.01 03:39:05 INFO - PROCESS | 11196 | Values: 83.0 84.0 112.0 85.0 84.0 84.0 118.0 84.0 84.0 118.0 03:39:05 INFO - PROCESS | 11196 | 03:39:05 INFO - PROCESS | 11196 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 03:39:05 INFO - PROCESS | 11196 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 116.0 117.0 117.0 116.0 03:39:05 INFO - PROCESS | 11196 | 03:39:05 INFO - PROCESS | 11196 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 03:39:05 INFO - PROCESS | 11196 | Values: 147.0 145.0 145.0 145.0 146.0 146.0 147.0 146.0 146.0 146.0 03:39:05 INFO - PROCESS | 11196 | 03:39:05 INFO - PROCESS | 11196 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:39:05 INFO - PROCESS | 11196 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 03:39:05 INFO - PROCESS | 11196 | 03:39:05 INFO - PROCESS | 11196 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.50 stddev:1.10 (2.1%) stddev-sans-first:1.17 03:39:05 INFO - PROCESS | 11196 | Values: 51.0 50.0 50.0 50.0 51.0 53.0 52.0 52.0 52.0 50.0 03:39:05 INFO - PROCESS | 11196 | 03:39:05 INFO - PROCESS | 11196 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 03:39:05 INFO - PROCESS | 11196 | Values: 60.0 60.0 60.0 60.0 61.0 60.0 60.0 59.0 60.0 60.0 03:39:05 INFO - PROCESS | 11196 | 03:39:05 INFO - PROCESS | 11196 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:78.00 stddev:7.90 (10.1%) stddev-sans-first:8.22 03:39:05 INFO - PROCESS | 11196 | Values: 76.0 81.0 78.0 75.0 79.0 78.0 76.0 82.0 102.0 77.0 03:39:05 INFO - PROCESS | 11196 | 03:39:05 INFO - PROCESS | 11196 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:120.00 stddev:5.18 (4.3%) stddev-sans-first:4.66 03:39:05 INFO - PROCESS | 11196 | Values: 128.0 118.0 121.0 117.0 117.0 115.0 115.0 119.0 122.0 130.0 03:39:05 INFO - PROCESS | 11196 | 03:39:05 INFO - PROCESS | 11196 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.60 Median:156.00 stddev:1.65 (1.1%) stddev-sans-first:1.73 03:39:05 INFO - PROCESS | 11196 | Values: 155.0 157.0 156.0 159.0 156.0 153.0 155.0 156.0 154.0 155.0 03:39:05 INFO - PROCESS | 11196 | 03:39:05 INFO - PROCESS | 11196 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:61.50 stddev:1.77 (2.9%) stddev-sans-first:0.97 03:39:05 INFO - PROCESS | 11196 | Values: 66.0 61.0 63.0 61.0 61.0 62.0 62.0 61.0 60.0 60.0 03:39:05 INFO - PROCESS | 11196 | -------- Summary: end -------- 03:39:05 INFO - PROCESS | 11196 | 03:39:06 INFO - TEST-INFO | 11196: exit 0 03:39:06 INFO - TEST-OK | kraken | took 60116ms 03:39:06 INFO - SUITE-END | took 1173s 03:39:07 INFO - Completed test suite (00:19:33) 03:39:07 INFO - javascript benchmark 03:39:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3342.84957176927, 3362.7814192077512, 3365.8821941232045, 3374.8312584370774, 3414.453687410013, 5540.418256083114, 5585.52523035542, 5597.3003374578175, 5606.859828504289, 5611.607187496877, 5500.477454641803, 5542.4457554244555, 5545.556355491551, 5553.500184983351, 5593.636413633111, 4963.677360971526, 5006.148954677714, 5023.422306434771, 5062.443131255559, 5089.211172268286, 4933.136701077315, 5075.061113693979, 5107.821226257081, 5122.974385128069, 5123.487651234866, 5010.649254552182, 5051.065552872712, 5055.0, 5060.873478163038, 5082.796688132489, 5157.277981082651, 5168.586513078963, 5175.715335656538, 5175.818846340398, 5192.896142077157, 4890.853274401774, 4977.6764510307075, 5019.949800501985, 5060.468650791688, 5084.44071152173, 5379.058664733656, 5403.162509810985, 5403.918941215885, 5447.509724124809, 5456.372517160498, 5978.372270911535, 6000.789972350947, 6008.309044459899, 6009.459148676597, 6010.909836352458, 5798.10129429939, 5868.970655146697, 5872.001759700861, 5926.496247818941, 6061.909071363933, 5522.2544956431175, 5534.225208470817, 5556.91664625031, 5558.527525160366, 5581.944180558224, 5848.502877255396, 6050.818475445743, 6055.048614814198, 6063.060225665029, 6082.695865206722, 5810.535157187415, 5850.297964244232, 5860.824175274749, 5974.1934838796205, 5975.0, 6026.186464827192, 6031.487323577458, 6031.60794548353, 6060.727267272983, 6065.332813390523, 5712.343080545707, 5855.531557475391, 5994.820155395345, 6004.189434426296, 6004.699765011732, 5917.792877249276, 5982.40175982407, 5988.670623115683, 5990.0, 6013.729382177812, 4599.701019433726, 4606.332081848113, 4607.331936869202, 4610.492845786961, 4626.606738427204, 4007.7595344279434, 4015.357542793139, 4068.8575899843363, 4114.259433301974, 4146.489405073242, 5667.036603777367, 5678.602497825113, 5684.459976302244, 5693.715314234271, 5694.829155125353, 5976.820695379146, 5989.520838332923, 6006.789762358297, 6007.699615019232, 6040.697965101727, 5421.728913554307, 5605.0, 5675.290588676416, 5697.601167918206, 5719.142128680648, 5075.87310317245, 5084.9745751271, 5088.0, 5090.821821236313, 5098.515641014098, 5981.581289309794, 6225.8132256032395, 6266.279377871603, 6272.40412160844, 6292.087647291209, 5931.614445061057, 5976.731047102978, 5976.940230597812, 6048.425399587032, 6063.029915213545, 6257.405546473078, 6275.497960163268, 6294.842628934313, 6296.653684047238, 6301.684915754102, 5636.267285252891, 5800.535957123504, 5931.110333450017, 5944.108383742473, 5978.491828194478, 5904.350521442552, 5998.1002849572915, 6003.849903752441, 6008.03871380577, 6023.6385816851125, 5828.766849326149, 5865.882682346414, 5877.0302900021015, 5879.323877754113, 5881.147233651182, 5651.265335506358, 5804.100364443518, 5805.042168042394, 5834.474897259267, 5867.471927526543, 5849.239598852122, 5850.765969361178, 5853.122031695109, 5853.1220316952795, 5884.08796636522, 5964.970175149097, 5973.283206015306, 6009.789657361971, 6009.969950150221, 6022.427869352405, 5590.916136258041, 5681.318241811009, 5712.571557133315, 5733.197352370755, 5868.647881127146], "value": 5511.436693862335, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.7120496559168, 645.7158850105953, 647.2491909385111, 653.2846533046312, 667.9365460281277, 33778.66221337786, 36168.81915590422, 36215.63784362155, 36222.45666315007, 36244.637553624525, 36769.44845827308, 37575.0, 47050.764746176304, 48277.0, 48375.75812120943, 8933.062028487013, 9098.954505227464, 9102.544872756369, 9107.453552786821, 9108.271338292921, 9000.819983600324, 9004.099590041009, 9008.54957252138, 9028.32287578431, 9103.317251206154, 8396.370272229577, 10932.453377331101, 11128.833067503994, 11167.553297868117, 11178.105751539857, 10656.680299591024, 10749.892501074968, 10753.677389678243, 11062.557497700163, 11070.335779853154, 8256.83486330276, 10552.47237638115, 10774.084202842767, 10845.783084338347, 10873.456327183609, 47494.287585686245, 48058.27912581314, 48117.27824082642, 48138.51861481411, 48167.51832481665, 3740.869069582579, 3748.3440397930253, 3868.7485313454536, 3902.356111241642, 3930.1746633207063, 27397.574958550536, 27868.442631147263, 34390.0, 35873.282534349164, 36130.63869361299, 4766.928496072562, 4769.976150119227, 4832.516748325174, 4863.124637565237, 4926.334944782444, 407254.0, 410894.0, 412220.0, 412331.0, 412620.0, 71737.64131179311, 72097.0, 72211.63894180495, 72282.27717722756, 72457.0, 75727.0, 76079.0, 76280.0, 76606.23393765991, 76722.0, 18436.446906592824, 19010.904945475184, 19017.049147542566, 19019.714704279446, 19022.61954760897, 14036.789448158286, 14039.929800350932, 14042.929785351007, 14045.0, 14092.506762263476, 18840.76794673817, 21411.46471338229, 21926.342209733735, 22207.66688499674, 22396.104155833586, 7704.460687751915, 7711.614419279013, 7828.238646304536, 7850.56821874791, 7912.723054693058, 989.9059589339146, 1072.8980746829038, 1113.4877956140267, 1185.9110566707532, 1193.3376975778353, 34382.48426273608, 34511.654883451345, 34740.30519389598, 35129.64870351315, 35183.4722479163, 1166.6674997625805, 1196.342011893455, 1209.9334536600395, 1229.5880879905153, 1258.5595041735319, 18233.544161396072, 18237.361692340968, 18240.908795455936, 18293.359732409303, 18322.450326490227, 583856.0, 587718.0, 587965.0, 588400.0, 588775.0, 66123.66938165374, 66256.6687166561, 66518.66740666266, 66747.33252667412, 66766.33233667698, 1340.5040135149861, 1419.5954153066532, 1437.6334034821264, 1446.6094154578204, 1457.890658200639, 33325.83337083299, 35988.0, 36529.26941461209, 37120.25759484741, 37336.43995340126, 54771.45228547663, 55359.446405535426, 55913.72043139758, 55996.72001640129, 56082.439175607724, 433294.0, 434135.0, 434678.0, 438336.0, 438774.0, 40070.1985960285, 46074.769626151654, 46269.30596041129, 47243.29135062908, 47451.52548474609, 52744.20883686671, 52799.73600131975, 53281.733591331795, 53552.46447535475, 53617.0, 43639.56360436482, 44240.55759442493, 44430.11139777251, 45023.0, 45587.0, 43955.66072985428, 44497.0, 44529.332060018474, 44757.328640069776, 45910.31134532918, 44113.353198808174, 45340.31989520226, 45582.31626525539, 45731.54268457273, 45887.54112458966, 38447.80776096102, 39325.60674393219, 39331.0, 39879.601203987586, 40118.799406002785, 29555.704442955295, 29788.55317170201, 29793.553096703134, 29851.402971940875, 30050.549241760953], "value": 22205.427970659915, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.9216252830697, 402.8449047116859, 410.58735970349795, 416.90411205422754, 421.81018541656243, 15402.0, 18975.0, 20741.481462963413, 20850.0, 22091.116355345806, 20804.89597552014, 20933.58132837346, 21313.36059918201, 21437.14251429945, 21468.8926555367, 5567.693776842282, 5840.328362238333, 5840.737166827503, 5843.970780146094, 5849.678267695275, 4343.934840977372, 5758.049921762904, 5807.477327040566, 5818.0981947797945, 5827.854303642401, 6084.087386891957, 6383.904241436359, 6397.968010159942, 6510.251321098087, 6520.576162549442, 6399.808005759812, 6425.1968503937005, 6427.903581446282, 6456.289808121103, 6462.838429039311, 5498.505134537871, 5668.206451096849, 5670.943290567083, 5677.40387259336, 5703.600747947646, 22974.885125574267, 24562.263132106065, 24804.3798905027, 25010.874945625157, 25601.48797024049, 2505.523950449409, 2523.3313172009434, 2569.79441644668, 2604.4660844526825, 2627.619398746476, 9855.11303982645, 14915.850841491554, 15252.466163684328, 15264.0, 15381.077135371801, 1966.852486063551, 2062.9690554641693, 2081.916723331065, 2090.6654935210445, 2105.505206276524, 75811.0, 78457.60771196165, 79597.60201199015, 85451.0, 89412.5529372349, 9311.115444032941, 9872.111509964137, 10000.449975251286, 10250.794984100276, 10265.0, 13384.0, 13422.0, 13470.326483675974, 13474.326283685776, 13536.052476326562, 8210.466319689202, 8447.02859171203, 8449.070602233749, 8457.450265732708, 8552.914470855336, 8600.182982616641, 8622.945111790843, 8802.251808596213, 8944.150305720947, 8954.776130596656, 4024.9798751006642, 4034.8789536313957, 4046.1705350403095, 4120.237756015147, 4250.978745106255, 1833.6516061948187, 1841.3555255660413, 1843.2074208090382, 1861.5997560524552, 1930.1893204853995, 448.7032476143947, 462.5998511287779, 462.69230961410284, 946.8343039967978, 1150.2753265442718, 11951.163418560618, 11965.820512692317, 12199.329036903055, 12218.877811221952, 12335.198212116364, 463.25416080110995, 464.9093426781745, 473.5879784587431, 487.43944463866126, 491.83523519621326, 6473.482121430275, 6481.027845823164, 6530.2816690164045, 6534.183227096613, 6549.869002619921, 546868.0, 551795.0, 554159.0, 556468.0, 557233.0, 79957.60021199856, 90323.54838225899, 102004.48997754963, 108082.0, 111303.0, 470.73403527007133, 477.14829030181653, 477.8638088144862, 482.3801415181545, 1080.222239987208, 17648.73526897072, 18708.532286692942, 18758.249670013047, 18812.435626931216, 18825.717614236073, 40164.79917600393, 41517.0, 43632.34551481667, 44495.777521112184, 45760.7711961438, 52399.476005240984, 61354.0, 61718.382816171266, 61766.69116654388, 62928.370716294085, 8547.95726021366, 8781.385303028726, 8965.775855603662, 8984.101589840964, 9057.230135438298, 13223.471061157446, 13652.795208071688, 13713.794293085812, 13893.096948698303, 13951.930240348733, 8058.677652893819, 12314.938425307817, 12442.37788110609, 12579.93710031444, 12775.744485110059, 11589.710257243636, 11791.469383877575, 12476.750464990831, 12677.492900284255, 12735.55425560101, 12883.806742898676, 12971.416286266953, 13080.869191307966, 13112.344382780631, 13148.342582870628, 8993.910060899307, 9014.729558113268, 9043.819123617623, 9177.77055573616, 9256.213221876216, 9082.36423450352, 12491.0, 12521.0, 12573.811392829299, 12606.306653134166], "value": 8887.443003989565, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.9512817051404, 1600.3038678174994, 1611.105836260875, 1840.5950690848008, 1941.8931958742273, 9049.14033166849, 9331.626734930604, 9362.204212641926, 9694.12752852245, 9748.805023899518, 9425.57584908679, 9645.180159686435, 9649.22806175506, 9659.227261819055, 9682.419054856697, 2398.796102331304, 2414.8913298901502, 2425.139075628153, 2427.6844010278637, 2429.878506074689, 2415.1909110448023, 2455.7667021632915, 2488.1291547958162, 2489.3776555861036, 2501.062101711858, 2446.131623273739, 2449.0571130114854, 2471.864047477388, 2478.615814548739, 2484.627305904111, 2369.7393286738443, 2370.644403339513, 2378.2389635316704, 2385.320183747632, 2407.374082738483, 2301.551197516485, 2330.5105927755194, 2334.0430423526273, 2334.2997100869843, 2340.976590234093, 8365.205305495969, 8573.52845593492, 9455.52722363886, 9536.2371010319, 9555.522223888778, 4799.760011999386, 4917.114919314522, 5272.261883336336, 5414.269073675043, 5419.187121931703, 3573.6962358199585, 3621.3662609043313, 3631.8184090795353, 3687.2441149564543, 3695.113172838526, 1144.9771004579945, 1191.195942738648, 1191.2137988927352, 1191.9106067045007, 1206.8129439936824, 13812.309384530734, 13875.306234688325, 13912.58262252134, 13936.0, 13947.790783138262, 4724.173269677793, 4747.0, 4824.614030877521, 4840.394950631171, 4845.75771211438, 11514.078873690085, 11514.76970460586, 11520.423978801027, 11540.24988375753, 11556.364399958084, 5416.0, 5419.0, 5419.701916394636, 5421.918671219935, 5422.078246698071, 4873.561379475864, 4898.90202195954, 4967.826126085642, 5122.948770512247, 5125.743712814345, 3982.880513584597, 3991.221711766236, 4057.5536690963972, 4082.0611259410502, 4129.359949207877, 1212.5331747277185, 1257.0634877016498, 1263.3809433377762, 1267.4930027988694, 1279.5649479177125, 853.7268074216191, 1026.2918586175515, 1068.636663534402, 1081.2485322700647, 1091.514276147107, 6416.358364163546, 6426.871462570816, 6500.0, 6574.211094668574, 6653.733850646016, 978.4276198424002, 1031.63377001165, 1065.3767545985531, 1072.2708558180357, 1116.8603924509437, 4480.260756975128, 4514.277715565494, 4517.457905051415, 4523.909521809545, 4557.635389168859, 12024.699382515508, 12362.814557781641, 12374.381280936097, 12377.381130943417, 12404.19372740769, 11613.825792613117, 12055.57805476804, 12060.75878482443, 12412.0, 12428.316442595564, 8730.825383492294, 8998.325125615474, 9011.053839346905, 9011.549422528848, 9024.278057755364, 6569.967150164219, 6731.225909020525, 6744.156980377453, 6854.074699915447, 6900.171979362509, 11192.104631629287, 11301.491432885376, 11443.828342574701, 11448.141389395661, 11482.081433485468, 11416.31502109876, 11562.364069975896, 11625.302481851117, 11637.650870473899, 11641.0, 8385.874211886705, 8531.402801803813, 8624.396292259482, 8647.654093836176, 8676.175763302475, 9607.663731769355, 9628.18160456341, 9636.373635713657, 9697.6120955161, 9698.078682525149, 8496.490210587384, 8691.521966291915, 8712.303015758598, 8789.384743067923, 8843.425177363451, 8250.54621995796, 8261.752147435587, 8518.48889066658, 8569.914300856912, 8684.2184203422, 7845.254700803414, 7934.603269836601, 7936.484128531627, 7938.285554300141, 7941.483803552751, 5555.30558680165, 5562.638428502134, 5653.152027195789, 5718.342390625131, 5807.390224026416, 5019.924701129559, 5723.599348045597, 5747.166660834072, 5791.131330300489, 5878.412158784087], "value": 5009.073479781575, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.5951398807442, 338.1934087202022, 342.9537012503311, 344.2890431259449, 347.272464187527, 5522.889542209158, 5547.140193270049, 5579.274694289747, 5590.776368945242, 5629.3526244481845, 5411.540019098381, 5501.642393244436, 5510.834674959758, 5512.228288039678, 5528.336599608053, 4123.6494897933635, 4156.251874662559, 4269.551697071809, 4290.5709429057, 4320.848770293041, 4193.412922190896, 4272.743635381887, 4281.159101586317, 4301.0967696783555, 4320.524742278347, 4050.2709512287774, 4226.894327641803, 4245.129748401586, 4246.3205887058075, 4259.829606815739, 3988.7806170660747, 4131.0185786021675, 4180.686448516343, 4240.279152544075, 4245.450410600109, 3724.087598538348, 3736.23407201523, 3746.587875333711, 3747.2318174774377, 3754.49314342563, 5218.347706536683, 5345.732713364355, 5351.866203344947, 5353.464653534655, 5359.231453620296, 4709.116353458609, 4791.233402655594, 4794.544518270759, 4810.39870016248, 4847.951520484785, 5697.230873832063, 5707.71461426927, 5718.828435146952, 5720.313562372542, 5757.366689664133, 4111.820735010449, 4121.0, 4132.710710250284, 4146.792660366969, 4151.626353628188, 5640.461792193489, 5922.8815423691285, 5971.7611295547695, 5971.910421343683, 5975.611585246988, 4081.469408976814, 4137.172565486914, 4138.379243113497, 4139.648129908931, 4146.854860079943, 4221.767802770877, 4224.281872081692, 4227.767472788964, 4231.661467082626, 4237.6821738369745, 4671.5094915034115, 4695.694779839299, 4729.716217026989, 4747.786349614275, 4763.618910487153, 5663.631863928831, 5683.971580142155, 5699.2590963174525, 5706.229658995982, 5726.3700992890745, 1434.340203506378, 1447.3486930881145, 1447.6959838434047, 1449.2101804516565, 1457.8542145785336, 897.1835629577054, 906.3383729877227, 915.6474757218385, 927.8979312275644, 949.5299826585884, 5538.363088244903, 5552.666839989613, 5559.416261292587, 5601.0, 5621.18492818539, 5810.680412577349, 5831.387704290988, 5868.119782032644, 5879.5002424794375, 5889.617174883619, 5220.634555581073, 5516.531094856902, 5553.4724201200825, 5578.2748242728185, 5599.0761524348845, 3101.1626860747924, 3107.891223807201, 3122.172624254574, 3126.8436578171, 3128.3586864692684, 5853.502452291517, 6016.217891674054, 6050.42520960508, 6060.666663333559, 6073.878522429527, 5884.617499862496, 5899.026660600953, 5902.8819423611285, 5909.527237820964, 5911.733971971272, 6001.3098493672915, 6022.789202377896, 6080.270367555833, 6107.236595425661, 6122.755089796358, 5703.971480142573, 5821.476067153807, 5826.76692932278, 5836.153757705194, 5844.503217226584, 5698.145278208136, 5700.515456186271, 5756.129257991086, 5768.884622307614, 5770.884582308414, 5793.594448388572, 5978.880422391441, 6037.124616930432, 6042.308153716966, 6141.969290153521, 4138.779060177195, 4142.9792851036755, 4168.0, 4168.145530166369, 4168.645665118378, 5867.530597552271, 5883.3820699308035, 5898.94101058984, 5912.822615321547, 5918.141869428822, 5595.748191331481, 5727.594410347748, 5765.4811067004175, 5774.855628609318, 5805.419458054161, 5654.6324488908085, 5680.204771331934, 5695.345035320991, 5708.315002199596, 5736.340320862987, 5388.434214407431, 5496.488465671972, 5522.66863988162, 5624.268845050117, 5640.756564975074, 5664.37691853904, 5725.227094342211, 5752.223449834386, 5760.452756988079, 5769.60561367028, 5485.177223416519, 5627.803026894039, 5647.265855438766, 5662.7734890603915, 5664.546836253172], "value": 4347.317484801799, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.3116521981801, 813.4834380168593, 830.9293710034647, 867.3581549653254, 868.9782755431113, 15113.244337783122, 15616.609584760372, 15850.286737096814, 15859.0, 15930.920345398257, 15377.615559611015, 15621.375144994216, 15875.126868022255, 15930.920345398286, 15983.84016159841, 877.1272583779132, 882.8940527136721, 887.436477836572, 889.3285569395098, 889.6886089868559, 748.1807420874161, 859.8925134358205, 873.6592728835759, 875.5578432891381, 879.7624641346864, 938.5541867612898, 941.7221919533754, 942.1520631431732, 942.7454587261435, 942.9245660347156, 773.3194788586064, 936.0592604432536, 936.9812603747955, 937.8640097185904, 938.1603464898911, 667.159379182229, 673.4545018534953, 674.4570620650375, 675.76010516267, 678.2640834694363, 14601.78097328541, 14810.703785924328, 14928.0, 14934.62663433412, 14937.477188298357, 15027.624309392244, 15506.45727399547, 15560.61098472536, 15621.453249136226, 15817.683646327008, 13313.467461301536, 13752.449902003907, 13826.23955682437, 13865.237411942338, 14118.858811411857, 4707.223308154151, 4786.952130478686, 4807.95192048082, 4820.975895120502, 4913.901721965576, 75702.24297757007, 77557.0, 77994.22005779983, 78306.21693783047, 79311.0, 12251.816222756488, 12431.875681243253, 12471.93764031174, 12510.937445312715, 12692.873071269354, 22320.10719571199, 22337.32988010362, 22382.88808555947, 22440.990155443043, 22484.0, 8881.156290152425, 8958.507282099417, 9004.729858104267, 9088.772780680536, 9240.5841737122, 4842.22524396102, 4957.876053098701, 5055.14751649446, 5069.670471419346, 5123.897522049613, 3517.630648781841, 3600.5499312585926, 3614.7288953328607, 3617.782933024027, 3620.3664358737115, 592.6740292839007, 600.519584332541, 604.3684349854412, 618.9257289125244, 623.5853157650203, 640.7981485831948, 715.6994062493765, 723.1147720594894, 763.091920614467, 795.8169620987205, 10103.826283338765, 10137.171126602234, 10143.746406339753, 10164.0, 10210.234232432596, 699.6047233313263, 724.4675163754636, 735.1729304532402, 771.5756334016269, 787.1341524323199, 4839.249916262985, 5135.229715542624, 5259.763310650953, 5487.780488780484, 5560.304961879765, 84650.5767471171, 128011.35994319968, 130193.0, 131683.34158329148, 132803.0, 107742.46128769463, 109351.0, 109918.0, 110069.44965275122, 110531.44734276277, 98104.0, 99595.50202249088, 99744.50127749315, 102070.0, 102554.97445025454, 10055.648052318134, 10057.949710251401, 10160.313146675546, 10162.491875406053, 10437.530311135864, 51988.480115199876, 52009.0, 52816.73591632171, 54396.18405723997, 55931.72034139803, 78321.21678783139, 85301.0, 87758.56120719356, 88432.0, 89196.0, 11828.408579570814, 13474.258915759336, 13697.520586779416, 13922.721545569235, 14218.928905355408, 14444.927775361057, 14874.33065512033, 15435.15106669099, 15631.140287284308, 16441.83558164403, 14753.631159220677, 15296.464623738117, 15393.0, 15905.363785448453, 15922.363105475652, 14262.0, 14873.776893346825, 15150.696986060437, 15645.1395173262, 15692.215389230721, 15008.0, 15310.540683779505, 15367.538973830802, 15475.226238687796, 15809.13049782273, 11754.88245117538, 12010.068677098978, 12656.810147847973, 13022.544210952572, 13107.641053518628, 11804.940975295412, 12325.383730813603, 12439.751204976032, 12482.126251162332, 13019.283939383426], "value": 8141.757330608357, "unit": "score"}], "name": "dromaeo_css", "value": 7601.051504066916, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 110.0, 111.0, 112.0, 111.0, 110.0, 110.0, 111.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 125.0, 173.0, 124.0, 133.0, 149.0, 125.0, 164.0, 123.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 159.0, 158.0, 160.0, 160.0, 159.0, 158.0, 159.0], "value": 159.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 75.0, 100.0, 74.0, 75.0, 74.0, 75.0, 97.0, 75.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 112.0, 85.0, 84.0, 84.0, 118.0, 84.0, 84.0, 118.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 145.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 50.0, 51.0, 53.0, 52.0, 52.0, 52.0, 50.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 59.0, 60.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 78.0, 75.0, 79.0, 78.0, 76.0, 82.0, 102.0, 77.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 118.0, 121.0, 117.0, 117.0, 115.0, 115.0, 119.0, 122.0, 130.0], "value": 120.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 157.0, 156.0, 159.0, 156.0, 153.0, 155.0, 156.0, 154.0, 155.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 61.0, 63.0, 61.0, 61.0, 62.0, 62.0, 61.0, 60.0, 60.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1468.8000000000002, "alertThreshold": 2.0}]} 03:39:07 INFO - Return code: 0 03:39:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:39:07 ERROR - # TBPL SUCCESS # 03:39:07 INFO - Running post-action listener: _resource_record_post_action 03:39:07 INFO - ##### 03:39:07 INFO - ##### Finished run-tests step (success) 03:39:07 INFO - ##### 03:39:07 INFO - Running post-run listener: _resource_record_post_run 03:39:07 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 327680; Write bytes: 256450560; Read time: 60; Write time: 137652 03:39:07 INFO - TinderboxPrint: CPU usage
13.0% 03:39:07 INFO - TinderboxPrint: I/O read bytes / time
327,680 / 60 03:39:07 INFO - TinderboxPrint: I/O write bytes / time
256,450,560 / 137,652 03:39:07 INFO - TinderboxPrint: CPU idle
8,260.4 (87.0%) 03:39:07 INFO - TinderboxPrint: CPU user
1,194.4 (12.6%) 03:39:07 INFO - TinderboxPrint: Swap in / out
0 / 0 03:39:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5390336; Read time: 0; Write time: 620 03:39:07 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 303104; Write bytes: 251060224; Read time: 44; Write time: 137032 03:39:07 INFO - Running post-run listener: _upload_blobber_files 03:39:07 INFO - Blob upload gear active. 03:39:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:39:07 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 03:39:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:39:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:39:08 INFO - (blobuploader) - INFO - Open directory for files ... 03:39:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:39:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:39:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:08 INFO - (blobuploader) - INFO - Done attempting. 03:39:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:39:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:39:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:12 INFO - (blobuploader) - INFO - Done attempting. 03:39:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:39:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:39:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:13 INFO - (blobuploader) - INFO - Done attempting. 03:39:13 INFO - (blobuploader) - INFO - Iteration through files over. 03:39:13 INFO - Return code: 0 03:39:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:39:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:39:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d77bb24a88871f5ad8ac93e334bc1a8463c571db393e45fa7136073669164dc6f0d78cfc837ff7794063dd329fab4e0cfb88c8b93c11404d3ade860e0e55f4f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0af079e53f96c8d1d3d6ecd4196e054ffbeef349f331a5aa1e3bece43dad72ca983a0618a6a736be868ae692d831e71a3502d0e0a74bc7033dfaa5b6a73b3a46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d119ca63dc675782505450790bc973ac8752e02e66a7fffff093886220dbe2109221deaeba05766bfdc65f0c4e90b1e09f3eb8207d8a3c5e55ae4b4dcd117340"} 03:39:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:39:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:39:13 INFO - Contents: 03:39:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d77bb24a88871f5ad8ac93e334bc1a8463c571db393e45fa7136073669164dc6f0d78cfc837ff7794063dd329fab4e0cfb88c8b93c11404d3ade860e0e55f4f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0af079e53f96c8d1d3d6ecd4196e054ffbeef349f331a5aa1e3bece43dad72ca983a0618a6a736be868ae692d831e71a3502d0e0a74bc7033dfaa5b6a73b3a46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d119ca63dc675782505450790bc973ac8752e02e66a7fffff093886220dbe2109221deaeba05766bfdc65f0c4e90b1e09f3eb8207d8a3c5e55ae4b4dcd117340"} 03:39:13 INFO - Running post-run listener: copy_logs_to_upload_dir 03:39:13 INFO - Copying logs to upload dir... 03:39:13 INFO - mkdir: /builds/slave/test/build/upload/logs 03:39:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.938288 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-06 03:39:13.264069) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 03:39:13.267420) ========= 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=31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d77bb24a88871f5ad8ac93e334bc1a8463c571db393e45fa7136073669164dc6f0d78cfc837ff7794063dd329fab4e0cfb88c8b93c11404d3ade860e0e55f4f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0af079e53f96c8d1d3d6ecd4196e054ffbeef349f331a5aa1e3bece43dad72ca983a0618a6a736be868ae692d831e71a3502d0e0a74bc7033dfaa5b6a73b3a46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d119ca63dc675782505450790bc973ac8752e02e66a7fffff093886220dbe2109221deaeba05766bfdc65f0c4e90b1e09f3eb8207d8a3c5e55ae4b4dcd117340"} build_url:https://queue.taskcluster.net/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://queue.taskcluster.net/v1/task/e1siYfStRrGqL1FNKiVI7w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d77bb24a88871f5ad8ac93e334bc1a8463c571db393e45fa7136073669164dc6f0d78cfc837ff7794063dd329fab4e0cfb88c8b93c11404d3ade860e0e55f4f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0af079e53f96c8d1d3d6ecd4196e054ffbeef349f331a5aa1e3bece43dad72ca983a0618a6a736be868ae692d831e71a3502d0e0a74bc7033dfaa5b6a73b3a46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d119ca63dc675782505450790bc973ac8752e02e66a7fffff093886220dbe2109221deaeba05766bfdc65f0c4e90b1e09f3eb8207d8a3c5e55ae4b4dcd117340"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 03:39:13.292589) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 03:39:13.292890) ========= 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=31acecf42b6a79ec49471d4a000001bb-1467798528.98898-1455292307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 03:39:13.377159) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 03:39:13.377506) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 03:39:13.377811) ========= ========= Total master_lag: 0.17 =========