builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-056 starttime: 1467058406.01 results: success (0) buildid: 20160627115019 builduid: 8c9c4afbac6748da811d399b884ff610 revision: 1d84194ace3538ad91d6cffb6fa3ec6a3a5037be ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 13:13:26.010337) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 13:13:26.010935) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 13:13:26.011302) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 13:13:26.031215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:13:26.031552) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 13:13:26-- 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% 221M=0s 2016-06-27 13:13:26 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075342 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:13:26.122364) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:13:26.122836) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013698 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:13:26.172667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:13:26.173081) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1d84194ace3538ad91d6cffb6fa3ec6a3a5037be --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1d84194ace3538ad91d6cffb6fa3ec6a3a5037be --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 13:13:26,741 truncating revision to first 12 chars 2016-06-27 13:13:26,741 Setting DEBUG logging. 2016-06-27 13:13:26,741 attempt 1/10 2016-06-27 13:13:26,741 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1d84194ace35?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 13:13:27,036 unpacking tar archive at: mozilla-central-1d84194ace35/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679765 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:13:26.867213) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 13:13:26.867611) ========= script_repo_revision: 1d84194ace3538ad91d6cffb6fa3ec6a3a5037be ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 13:13:26.868130) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 13:13:26.868462) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 13:13:26.879746) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-27 13:13:26.880132) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:13:27 INFO - MultiFileLogger online at 20160627 13:13:27 in /builds/slave/test 13:13:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 13:13:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:13:27 INFO - {'append_to_log': False, 13:13:27 INFO - 'base_work_dir': '/builds/slave/test', 13:13:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:13:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:13:27 INFO - 'branch': 'Firefox-Non-PGO', 13:13:27 INFO - 'buildbot_json_path': 'buildprops.json', 13:13:27 INFO - 'config_files': ('talos/linux_config.py',), 13:13:27 INFO - 'default_actions': ('clobber', 13:13:27 INFO - 'read-buildbot-config', 13:13:27 INFO - 'download-and-extract', 13:13:27 INFO - 'populate-webroot', 13:13:27 INFO - 'create-virtualenv', 13:13:27 INFO - 'install', 13:13:27 INFO - 'run-tests'), 13:13:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:13:27 INFO - 'download_minidump_stackwalk': True, 13:13:27 INFO - 'download_symbols': 'ondemand', 13:13:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:13:27 INFO - 'tooltool.py': '/tools/tooltool.py', 13:13:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:13:27 INFO - '/tools/misc-python/virtualenv.py')}, 13:13:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:13:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:13:27 INFO - 'installer_path': 'installer.exe', 13:13:27 INFO - 'log_level': 'info', 13:13:27 INFO - 'log_name': 'talos', 13:13:27 INFO - 'log_to_console': True, 13:13:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:13:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:13:27 INFO - 'opt_config_files': (), 13:13:27 INFO - 'pip_index': False, 13:13:27 INFO - 'sps_profile': False, 13:13:27 INFO - 'sps_profile_interval': 0, 13:13:27 INFO - 'suite': 'dromaeojs-e10s', 13:13:27 INFO - 'system_bits': '32', 13:13:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:13:27 INFO - 'title': 'talos-linux64-ix-056', 13:13:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:13:27 INFO - 'use_talos_json': True, 13:13:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:13:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:13:27 INFO - 'work_dir': 'build'} 13:13:27 INFO - ##### 13:13:27 INFO - ##### Running clobber step. 13:13:27 INFO - ##### 13:13:27 INFO - Running pre-action listener: _resource_record_pre_action 13:13:27 INFO - Running main action method: clobber 13:13:27 INFO - rmtree: /builds/slave/test/build 13:13:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:13:28 INFO - Running post-action listener: _resource_record_post_action 13:13:28 INFO - ##### 13:13:28 INFO - ##### Finished clobber step (success) 13:13:28 INFO - ##### 13:13:28 INFO - ##### 13:13:28 INFO - ##### Running read-buildbot-config step. 13:13:28 INFO - ##### 13:13:28 INFO - Running pre-action listener: _resource_record_pre_action 13:13:28 INFO - Running main action method: read_buildbot_config 13:13:28 INFO - Using buildbot properties: 13:13:28 INFO - { 13:13:28 INFO - "project": "", 13:13:28 INFO - "product": "firefox", 13:13:28 INFO - "script_repo_revision": "production", 13:13:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:13:28 INFO - "repository": "", 13:13:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 13:13:28 INFO - "buildid": "20160627115019", 13:13:28 INFO - "pgo_build": "False", 13:13:28 INFO - "basedir": "/builds/slave/test", 13:13:28 INFO - "buildnumber": 365, 13:13:28 INFO - "slavename": "talos-linux64-ix-056", 13:13:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:13:28 INFO - "platform": "ubuntu64_hw", 13:13:28 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 13:13:28 INFO - "branch": "mozilla-central", 13:13:28 INFO - "repo_path": "mozilla-central", 13:13:28 INFO - "revision": "1d84194ace3538ad91d6cffb6fa3ec6a3a5037be", 13:13:28 INFO - "stage_platform": "linux64", 13:13:28 INFO - "builduid": "8c9c4afbac6748da811d399b884ff610", 13:13:28 INFO - "slavebuilddir": "test" 13:13:28 INFO - } 13:13:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:13:28 INFO - Running post-action listener: _resource_record_post_action 13:13:28 INFO - ##### 13:13:28 INFO - ##### Finished read-buildbot-config step (success) 13:13:28 INFO - ##### 13:13:28 INFO - ##### 13:13:28 INFO - ##### Running download-and-extract step. 13:13:28 INFO - ##### 13:13:28 INFO - Running pre-action listener: _resource_record_pre_action 13:13:28 INFO - Running main action method: download_and_extract 13:13:28 INFO - mkdir: /builds/slave/test/build/tests 13:13:28 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')]} 13:13:28 INFO - https://queue.taskcluster.net/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:13:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:13:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:13:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:13:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:13:28 INFO - Downloaded 1361 bytes. 13:13:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:13:28 INFO - Using the following test package requirements: 13:13:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:13:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:13:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:13:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:13:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:13:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:13:28 INFO - u'jsshell-linux-x86_64.zip'], 13:13:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:13:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:13:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:13:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:13:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:13:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:13:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:13:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:13:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:13:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:13:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:13:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:13:28 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')]} 13:13:28 INFO - https://queue.taskcluster.net/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:13:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:13:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:13:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:13:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:13:34 INFO - Downloaded 22713160 bytes. 13:13:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:13:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:13:35 INFO - Return code: 0 13:13:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:13: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')]} 13:13:35 INFO - https://queue.taskcluster.net/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:13:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:13:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:13:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:13:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:13:37 INFO - Downloaded 22713160 bytes. 13:13:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:13:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:13:38 INFO - Return code: 0 13:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:38 INFO - https://queue.taskcluster.net/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:13:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:13:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:13:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:13:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:13:39 INFO - Downloaded 14405240 bytes. 13:13:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:13:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:13:40 INFO - Return code: 0 13:13:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:40 INFO - https://queue.taskcluster.net/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:13:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:13:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:13:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:13:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:13:41 INFO - Downloaded 56291778 bytes. 13:13:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:13:41 INFO - mkdir: /builds/slave/test/properties 13:13:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:13:41 INFO - Writing to file /builds/slave/test/properties/build_url 13:13:41 INFO - Contents: 13:13:41 INFO - build_url:https://queue.taskcluster.net/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:13:42 INFO - Running post-action listener: _resource_record_post_action 13:13:42 INFO - Running post-action listener: set_extra_try_arguments 13:13:42 INFO - ##### 13:13:42 INFO - ##### Finished download-and-extract step (success) 13:13:42 INFO - ##### 13:13:42 INFO - ##### 13:13:42 INFO - ##### Running populate-webroot step. 13:13:42 INFO - ##### 13:13:42 INFO - Running pre-action listener: _resource_record_pre_action 13:13:42 INFO - Running main action method: populate_webroot 13:13:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:13:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:13:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:13:42 INFO - '--tppagecycles', 13:13:42 INFO - '7'], 13:13:42 INFO - 'tests': ['tsvgm']}}, 13:13:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:13:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:13:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:13:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:13:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:13:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:13:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:42 INFO - 'talos_options': ['--disable-e10s'], 13:13:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:13:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:13:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:42 INFO - 'talos_options': ['--disable-e10s'], 13:13:42 INFO - 'tests': ['damp', 'tps']}, 13:13:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:42 INFO - 'tests': ['damp', 'tps']}, 13:13:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:13:42 INFO - 'tests': ['dromaeo_dom']}, 13:13:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:13:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:13:42 INFO - 'tests': ['basic_compositor_video']}, 13:13:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:13:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:13:42 INFO - 'tests': ['a11yr', 13:13:42 INFO - 'ts_paint', 13:13:42 INFO - 'tpaint', 13:13:42 INFO - 'sessionrestore', 13:13:42 INFO - 'sessionrestore_no_auto_restore', 13:13:42 INFO - 'tabpaint']}, 13:13:42 INFO - 'other-e10s': {'tests': ['a11yr', 13:13:42 INFO - 'ts_paint', 13:13:42 INFO - 'tpaint', 13:13:42 INFO - 'sessionrestore', 13:13:42 INFO - 'sessionrestore_no_auto_restore', 13:13:42 INFO - 'tabpaint']}, 13:13:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:13:42 INFO - 'ts_paint', 13:13:42 INFO - 'tpaint', 13:13:42 INFO - 'sessionrestore', 13:13:42 INFO - 'sessionrestore_no_auto_restore', 13:13:42 INFO - 'tabpaint']}, 13:13:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:13:42 INFO - 'ts_paint', 13:13:42 INFO - 'tpaint', 13:13:42 INFO - 'sessionrestore', 13:13:42 INFO - 'sessionrestore_no_auto_restore', 13:13:42 INFO - 'tabpaint']}, 13:13:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:13:42 INFO - 'tests': ['a11yr', 13:13:42 INFO - 'ts_paint', 13:13:42 INFO - 'tpaint', 13:13:42 INFO - 'sessionrestore', 13:13:42 INFO - 'sessionrestore_no_auto_restore', 13:13:42 INFO - 'tabpaint']}, 13:13:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:13:42 INFO - 'tests': ['a11yr', 13:13:42 INFO - 'ts_paint', 13:13:42 INFO - 'tpaint', 13:13:42 INFO - 'sessionrestore', 13:13:42 INFO - 'sessionrestore_no_auto_restore', 13:13:42 INFO - 'tabpaint']}, 13:13:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:13:42 INFO - 'tests': ['tsvgx', 13:13:42 INFO - 'tsvgr_opacity', 13:13:42 INFO - 'tart', 13:13:42 INFO - 'tscrollx', 13:13:42 INFO - 'cart']}, 13:13:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:13:42 INFO - 'tsvgr_opacity', 13:13:42 INFO - 'tart', 13:13:42 INFO - 'tscrollx', 13:13:42 INFO - 'cart']}, 13:13:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:42 INFO - 'talos_options': ['--disable-e10s'], 13:13:42 INFO - 'tests': ['tp5o']}, 13:13:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:42 INFO - 'tests': ['tp5o']}, 13:13:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:42 INFO - 'talos_options': ['--disable-e10s', 13:13:42 INFO - '--xperf_path', 13:13:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:13:42 INFO - 'tests': ['tp5n']}, 13:13:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:42 INFO - 'talos_options': ['--xperf_path', 13:13:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:13:42 INFO - 'tests': ['tp5n']}}, 13:13:42 INFO - 'talos.zip': {'path': '', 13:13:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:13:42 INFO - Running post-action listener: _resource_record_post_action 13:13:42 INFO - ##### 13:13:42 INFO - ##### Finished populate-webroot step (success) 13:13:42 INFO - ##### 13:13:42 INFO - ##### 13:13:42 INFO - ##### Running create-virtualenv step. 13:13:42 INFO - ##### 13:13:42 INFO - Running pre-action listener: _resource_record_pre_action 13:13:42 INFO - Running main action method: create_virtualenv 13:13:42 INFO - Creating virtualenv /builds/slave/test/build/venv 13:13:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:13:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:13:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:13:42 INFO - Using real prefix '/usr' 13:13:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:13:42 INFO - Installing distribute.............................................................................................................................................................................................done. 13:13:44 INFO - Installing pip.................done. 13:13:44 INFO - Return code: 0 13:13:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:44 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 0x7fd812596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25876f0>, '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 0x25885f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2588aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', '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 13:13:44 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 13:13:44 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 13:13:44 INFO - Using env: {'DISPLAY': ':0', 13:13:44 INFO - 'HOME': '/home/cltbld', 13:13:44 INFO - 'LANG': 'en_US.UTF-8', 13:13:44 INFO - 'LANGUAGE': 'en_US:en', 13:13:44 INFO - 'LOGNAME': 'cltbld', 13:13:44 INFO - 'MAIL': '/var/mail/cltbld', 13:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:44 INFO - 'MOZ_NO_REMOTE': '1', 13:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:44 INFO - 'NO_EM_RESTART': '1', 13:13:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:44 INFO - 'PWD': '/builds/slave/test', 13:13:44 INFO - 'SHELL': '/bin/bash', 13:13:44 INFO - 'SHLVL': '1', 13:13:44 INFO - 'TERM': 'linux', 13:13:44 INFO - 'TMOUT': '86400', 13:13:44 INFO - 'USER': 'cltbld', 13:13:44 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', 13:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:44 INFO - '_': '/tools/buildbot/bin/python'} 13:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:45 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 13:13:45 INFO - Cleaning up... 13:13:45 INFO - Return code: 0 13:13:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:13: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')]} 13:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13: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')]} 13:13:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd812596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25876f0>, '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 0x25885f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2588aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', '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 13:13:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:13:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:13:45 INFO - Using env: {'DISPLAY': ':0', 13:13:45 INFO - 'HOME': '/home/cltbld', 13:13:45 INFO - 'LANG': 'en_US.UTF-8', 13:13:45 INFO - 'LANGUAGE': 'en_US:en', 13:13:45 INFO - 'LOGNAME': 'cltbld', 13:13:45 INFO - 'MAIL': '/var/mail/cltbld', 13:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:45 INFO - 'MOZ_NO_REMOTE': '1', 13:13:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:45 INFO - 'NO_EM_RESTART': '1', 13:13:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:45 INFO - 'PWD': '/builds/slave/test', 13:13:45 INFO - 'SHELL': '/bin/bash', 13:13:45 INFO - 'SHLVL': '1', 13:13:45 INFO - 'TERM': 'linux', 13:13:45 INFO - 'TMOUT': '86400', 13:13:45 INFO - 'USER': 'cltbld', 13:13:45 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', 13:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:45 INFO - '_': '/tools/buildbot/bin/python'} 13:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:45 INFO - Downloading/unpacking psutil>=3.1.1 13:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:13:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:13:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:13:47 INFO - Installing collected packages: psutil 13:13:47 INFO - Running setup.py install for psutil 13:13:47 INFO - building 'psutil._psutil_linux' extension 13:13:47 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 13:13:47 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 13:13:47 INFO - building 'psutil._psutil_posix' extension 13:13:47 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 13:13:47 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 13:13:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:13:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:13:47 INFO - Successfully installed psutil 13:13:47 INFO - Cleaning up... 13:13:47 INFO - Return code: 0 13:13:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:13: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')]} 13:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13: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')]} 13:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd812596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25876f0>, '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 0x25885f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2588aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', '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 13:13:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:13:47 INFO - Using env: {'DISPLAY': ':0', 13:13:47 INFO - 'HOME': '/home/cltbld', 13:13:47 INFO - 'LANG': 'en_US.UTF-8', 13:13:47 INFO - 'LANGUAGE': 'en_US:en', 13:13:47 INFO - 'LOGNAME': 'cltbld', 13:13:47 INFO - 'MAIL': '/var/mail/cltbld', 13:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:47 INFO - 'MOZ_NO_REMOTE': '1', 13:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:47 INFO - 'NO_EM_RESTART': '1', 13:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:47 INFO - 'PWD': '/builds/slave/test', 13:13:47 INFO - 'SHELL': '/bin/bash', 13:13:47 INFO - 'SHLVL': '1', 13:13:47 INFO - 'TERM': 'linux', 13:13:47 INFO - 'TMOUT': '86400', 13:13:47 INFO - 'USER': 'cltbld', 13:13:47 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', 13:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:47 INFO - '_': '/tools/buildbot/bin/python'} 13:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:13:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:13:50 INFO - Installing collected packages: mozsystemmonitor 13:13:50 INFO - Running setup.py install for mozsystemmonitor 13:13:50 INFO - Successfully installed mozsystemmonitor 13:13:50 INFO - Cleaning up... 13:13:50 INFO - Return code: 0 13:13:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd812596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25876f0>, '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 0x25885f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2588aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', '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 13:13:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:13:50 INFO - Using env: {'DISPLAY': ':0', 13:13:50 INFO - 'HOME': '/home/cltbld', 13:13:50 INFO - 'LANG': 'en_US.UTF-8', 13:13:50 INFO - 'LANGUAGE': 'en_US:en', 13:13:50 INFO - 'LOGNAME': 'cltbld', 13:13:50 INFO - 'MAIL': '/var/mail/cltbld', 13:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:50 INFO - 'MOZ_NO_REMOTE': '1', 13:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:50 INFO - 'NO_EM_RESTART': '1', 13:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:50 INFO - 'PWD': '/builds/slave/test', 13:13:50 INFO - 'SHELL': '/bin/bash', 13:13:50 INFO - 'SHLVL': '1', 13:13:50 INFO - 'TERM': 'linux', 13:13:50 INFO - 'TMOUT': '86400', 13:13:50 INFO - 'USER': 'cltbld', 13:13:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', 13:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:50 INFO - '_': '/tools/buildbot/bin/python'} 13:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:50 INFO - Downloading/unpacking jsonschema==2.5.1 13:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:13:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:52 INFO - Downloading functools32-3.2.3-2.tar.gz 13:13:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:13:52 INFO - warning: no files found matching '*.txt' 13:13:52 INFO - no previously-included directories found matching 'build' 13:13:52 INFO - no previously-included directories found matching 'dist' 13:13:52 INFO - no previously-included directories found matching '.git*' 13:13:52 INFO - Installing collected packages: jsonschema, functools32 13:13:52 INFO - Running setup.py install for functools32 13:13:52 INFO - warning: no files found matching '*.txt' 13:13:52 INFO - no previously-included directories found matching 'build' 13:13:52 INFO - no previously-included directories found matching 'dist' 13:13:52 INFO - no previously-included directories found matching '.git*' 13:13:52 INFO - Successfully installed jsonschema functools32 13:13:52 INFO - Cleaning up... 13:13:52 INFO - Return code: 0 13:13:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd812596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25876f0>, '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 0x25885f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2588aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', '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 13:13:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:13:52 INFO - Using env: {'DISPLAY': ':0', 13:13:52 INFO - 'HOME': '/home/cltbld', 13:13:52 INFO - 'LANG': 'en_US.UTF-8', 13:13:52 INFO - 'LANGUAGE': 'en_US:en', 13:13:52 INFO - 'LOGNAME': 'cltbld', 13:13:52 INFO - 'MAIL': '/var/mail/cltbld', 13:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:52 INFO - 'MOZ_NO_REMOTE': '1', 13:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:52 INFO - 'NO_EM_RESTART': '1', 13:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:52 INFO - 'PWD': '/builds/slave/test', 13:13:52 INFO - 'SHELL': '/bin/bash', 13:13:52 INFO - 'SHLVL': '1', 13:13:52 INFO - 'TERM': 'linux', 13:13:52 INFO - 'TMOUT': '86400', 13:13:52 INFO - 'USER': 'cltbld', 13:13:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', 13:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:52 INFO - '_': '/tools/buildbot/bin/python'} 13:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:53 INFO - Downloading/unpacking blobuploader==1.2.4 13:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:55 INFO - Downloading blobuploader-1.2.4.tar.gz 13:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:13:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:13:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:55 INFO - Downloading docopt-0.6.1.tar.gz 13:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:13:55 INFO - Installing collected packages: blobuploader, requests, docopt 13:13:55 INFO - Running setup.py install for blobuploader 13:13:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:13:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:13:55 INFO - Running setup.py install for requests 13:13:56 INFO - Running setup.py install for docopt 13:13:56 INFO - Successfully installed blobuploader requests docopt 13:13:56 INFO - Cleaning up... 13:13:56 INFO - Return code: 0 13:13:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:13: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')]} 13:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13: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')]} 13:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd812596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25876f0>, '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 0x25885f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2588aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', '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 13:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:13:56 INFO - Using env: {'DISPLAY': ':0', 13:13:56 INFO - 'HOME': '/home/cltbld', 13:13:56 INFO - 'LANG': 'en_US.UTF-8', 13:13:56 INFO - 'LANGUAGE': 'en_US:en', 13:13:56 INFO - 'LOGNAME': 'cltbld', 13:13:56 INFO - 'MAIL': '/var/mail/cltbld', 13:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:56 INFO - 'MOZ_NO_REMOTE': '1', 13:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:56 INFO - 'NO_EM_RESTART': '1', 13:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:56 INFO - 'PWD': '/builds/slave/test', 13:13:56 INFO - 'SHELL': '/bin/bash', 13:13:56 INFO - 'SHLVL': '1', 13:13:56 INFO - 'TERM': 'linux', 13:13:56 INFO - 'TMOUT': '86400', 13:13:56 INFO - 'USER': 'cltbld', 13:13:56 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', 13:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:56 INFO - '_': '/tools/buildbot/bin/python'} 13:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:13:56 INFO - Running setup.py (path:/tmp/pip-klD9kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:13:56 INFO - Running setup.py (path:/tmp/pip-Piuoo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:13:56 INFO - Running setup.py (path:/tmp/pip-caneOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:13:56 INFO - Running setup.py (path:/tmp/pip-0VAEmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:13:57 INFO - Running setup.py (path:/tmp/pip-MxwIiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:13:57 INFO - Running setup.py (path:/tmp/pip-_N2zxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:13:57 INFO - Running setup.py (path:/tmp/pip-PS0sEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:13:57 INFO - Running setup.py (path:/tmp/pip-idFTxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:13:57 INFO - Running setup.py (path:/tmp/pip-vBF094-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:13:57 INFO - Running setup.py (path:/tmp/pip-kMvX88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:13:57 INFO - Running setup.py (path:/tmp/pip-PWKMNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:13:57 INFO - Running setup.py (path:/tmp/pip-sOvsue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:13:57 INFO - Running setup.py (path:/tmp/pip-rr6DMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:13:57 INFO - Running setup.py (path:/tmp/pip-jYrq6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:13:57 INFO - Running setup.py (path:/tmp/pip-XU31TC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:13:57 INFO - Running setup.py (path:/tmp/pip-fKg0Ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:13:57 INFO - Running setup.py (path:/tmp/pip-1xMswp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:13:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:13:57 INFO - Running setup.py install for manifestparser 13:13:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:13:58 INFO - Running setup.py install for mozcrash 13:13:58 INFO - Running setup.py install for mozdebug 13:13:58 INFO - Running setup.py install for mozdevice 13:13:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:13:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:13:58 INFO - Running setup.py install for mozfile 13:13:58 INFO - Running setup.py install for mozhttpd 13:13:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:13:58 INFO - Running setup.py install for mozinfo 13:13:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:13:58 INFO - Running setup.py install for mozInstall 13:13:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:13:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:13:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:13:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:13:58 INFO - Running setup.py install for mozleak 13:13:58 INFO - Running setup.py install for mozlog 13:13:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:13:59 INFO - Running setup.py install for moznetwork 13:13:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:13:59 INFO - Running setup.py install for mozprocess 13:13:59 INFO - Running setup.py install for mozprofile 13:13:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:13:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:13:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:13:59 INFO - Running setup.py install for mozrunner 13:13:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:13:59 INFO - Running setup.py install for mozscreenshot 13:13:59 INFO - Running setup.py install for moztest 13:13:59 INFO - Running setup.py install for mozversion 13:13:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:13:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:13:59 INFO - Cleaning up... 13:13:59 INFO - Return code: 0 13:13:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:13: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')]} 13:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13: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')]} 13:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd812596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25876f0>, '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 0x25885f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2588aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', '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 13:13:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:13:59 INFO - Using env: {'DISPLAY': ':0', 13:13:59 INFO - 'HOME': '/home/cltbld', 13:13:59 INFO - 'LANG': 'en_US.UTF-8', 13:13:59 INFO - 'LANGUAGE': 'en_US:en', 13:13:59 INFO - 'LOGNAME': 'cltbld', 13:13:59 INFO - 'MAIL': '/var/mail/cltbld', 13:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:59 INFO - 'MOZ_NO_REMOTE': '1', 13:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:59 INFO - 'NO_EM_RESTART': '1', 13:13:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:59 INFO - 'PWD': '/builds/slave/test', 13:13:59 INFO - 'SHELL': '/bin/bash', 13:13:59 INFO - 'SHLVL': '1', 13:13:59 INFO - 'TERM': 'linux', 13:13:59 INFO - 'TMOUT': '86400', 13:13:59 INFO - 'USER': 'cltbld', 13:13:59 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', 13:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:59 INFO - '_': '/tools/buildbot/bin/python'} 13:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:13:59 INFO - Running setup.py (path:/tmp/pip-7yfjeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:14:00 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)) 13:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:14:00 INFO - Running setup.py (path:/tmp/pip-f4lo4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:14:00 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)) 13:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:14:00 INFO - Running setup.py (path:/tmp/pip-FXLQ8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:14:00 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)) 13:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:14:00 INFO - Running setup.py (path:/tmp/pip-bUxjrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:14:00 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)) 13:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:14:00 INFO - Running setup.py (path:/tmp/pip-9YQq_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:14:00 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)) 13:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:14:00 INFO - Running setup.py (path:/tmp/pip-AXWGqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:14:00 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)) 13:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:14:00 INFO - Running setup.py (path:/tmp/pip-orB8Xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:14:00 INFO - Running setup.py (path:/tmp/pip-CRA7gS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:14:00 INFO - Running setup.py (path:/tmp/pip-L6W4iE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:14:00 INFO - Running setup.py (path:/tmp/pip-aDWkqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:14:00 INFO - Running setup.py (path:/tmp/pip-nwp6V7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:14:00 INFO - Running setup.py (path:/tmp/pip-88gR4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:14:00 INFO - Running setup.py (path:/tmp/pip-Vwi94v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:14:00 INFO - Running setup.py (path:/tmp/pip-gGKAoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:14:01 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)) 13:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:14:01 INFO - Running setup.py (path:/tmp/pip-TJYyzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:14:01 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)) 13:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:14:01 INFO - Running setup.py (path:/tmp/pip-Pmh8Oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:14:01 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)) 13:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:14:01 INFO - Running setup.py (path:/tmp/pip-k2a85L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:14:01 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)) 13:14:01 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)) 13:14:01 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)) 13:14:01 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)) 13:14:01 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)) 13:14:01 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)) 13:14:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:14: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 13:14: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 13:14: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 13:14: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 13:14: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 13:14: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 13:14:03 INFO - Downloading blessings-1.6.tar.gz 13:14:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:14:03 INFO - Installing collected packages: blessings 13:14:03 INFO - Running setup.py install for blessings 13:14:03 INFO - Successfully installed blessings 13:14:03 INFO - Cleaning up... 13:14:03 INFO - Return code: 0 13:14:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:14:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:14:03 INFO - Reading from file tmpfile_stdout 13:14:03 INFO - Current package versions: 13:14:03 INFO - argparse == 1.2.1 13:14:03 INFO - blessings == 1.6 13:14:03 INFO - blobuploader == 1.2.4 13:14:03 INFO - docopt == 0.6.1 13:14:03 INFO - functools32 == 3.2.3-2 13:14:03 INFO - jsonschema == 2.5.1 13:14:03 INFO - manifestparser == 1.1 13:14:03 INFO - mozInstall == 1.12 13:14:03 INFO - mozcrash == 0.17 13:14:03 INFO - mozdebug == 0.1 13:14:03 INFO - mozdevice == 0.48 13:14:03 INFO - mozfile == 1.2 13:14:03 INFO - mozhttpd == 0.7 13:14:03 INFO - mozinfo == 0.9 13:14:03 INFO - mozleak == 0.1 13:14:03 INFO - mozlog == 3.2 13:14:03 INFO - moznetwork == 0.27 13:14:03 INFO - mozprocess == 0.22 13:14:03 INFO - mozprofile == 0.28 13:14:03 INFO - mozrunner == 6.11 13:14:03 INFO - mozscreenshot == 0.1 13:14:03 INFO - mozsystemmonitor == 0.3 13:14:03 INFO - moztest == 0.7 13:14:03 INFO - mozversion == 1.4 13:14:03 INFO - psutil == 3.1.1 13:14:03 INFO - requests == 1.2.3 13:14:03 INFO - wsgiref == 0.1.2 13:14:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd812596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25876f0>, '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 0x25885f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2588aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', '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 13:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:14:03 INFO - Using env: {'DISPLAY': ':0', 13:14:03 INFO - 'HOME': '/home/cltbld', 13:14:03 INFO - 'LANG': 'en_US.UTF-8', 13:14:03 INFO - 'LANGUAGE': 'en_US:en', 13:14:03 INFO - 'LOGNAME': 'cltbld', 13:14:03 INFO - 'MAIL': '/var/mail/cltbld', 13:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:03 INFO - 'MOZ_NO_REMOTE': '1', 13:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:03 INFO - 'NO_EM_RESTART': '1', 13:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:03 INFO - 'PWD': '/builds/slave/test', 13:14:03 INFO - 'SHELL': '/bin/bash', 13:14:03 INFO - 'SHLVL': '1', 13:14:03 INFO - 'TERM': 'linux', 13:14:03 INFO - 'TMOUT': '86400', 13:14:03 INFO - 'USER': 'cltbld', 13:14:03 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', 13:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:03 INFO - '_': '/tools/buildbot/bin/python'} 13:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:14:03 INFO - Cleaning up... 13:14:03 INFO - Return code: 0 13:14:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd812596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25876f0>, '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 0x25885f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2588aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', '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 13:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:14:03 INFO - Using env: {'DISPLAY': ':0', 13:14:03 INFO - 'HOME': '/home/cltbld', 13:14:03 INFO - 'LANG': 'en_US.UTF-8', 13:14:03 INFO - 'LANGUAGE': 'en_US:en', 13:14:03 INFO - 'LOGNAME': 'cltbld', 13:14:03 INFO - 'MAIL': '/var/mail/cltbld', 13:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:03 INFO - 'MOZ_NO_REMOTE': '1', 13:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:03 INFO - 'NO_EM_RESTART': '1', 13:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:03 INFO - 'PWD': '/builds/slave/test', 13:14:03 INFO - 'SHELL': '/bin/bash', 13:14:03 INFO - 'SHLVL': '1', 13:14:03 INFO - 'TERM': 'linux', 13:14:03 INFO - 'TMOUT': '86400', 13:14:03 INFO - 'USER': 'cltbld', 13:14:03 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', 13:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:03 INFO - '_': '/tools/buildbot/bin/python'} 13:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:14:04 INFO - Cleaning up... 13:14:04 INFO - Return code: 0 13:14:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:14:04 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')]} 13:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:04 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')]} 13:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:04 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 0x7fd812596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25876f0>, '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 0x25885f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2588aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', '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 13:14:04 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 13:14:04 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 13:14:04 INFO - Using env: {'DISPLAY': ':0', 13:14:04 INFO - 'HOME': '/home/cltbld', 13:14:04 INFO - 'LANG': 'en_US.UTF-8', 13:14:04 INFO - 'LANGUAGE': 'en_US:en', 13:14:04 INFO - 'LOGNAME': 'cltbld', 13:14:04 INFO - 'MAIL': '/var/mail/cltbld', 13:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:04 INFO - 'MOZ_NO_REMOTE': '1', 13:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:04 INFO - 'NO_EM_RESTART': '1', 13:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:04 INFO - 'PWD': '/builds/slave/test', 13:14:04 INFO - 'SHELL': '/bin/bash', 13:14:04 INFO - 'SHLVL': '1', 13:14:04 INFO - 'TERM': 'linux', 13:14:04 INFO - 'TMOUT': '86400', 13:14:04 INFO - 'USER': 'cltbld', 13:14:04 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', 13:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:04 INFO - '_': '/tools/buildbot/bin/python'} 13:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:04 INFO - Downloading/unpacking flake8 13:14: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 13:14: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 13:14: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 13:14: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 13:14: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 13:14: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 13:14:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:14:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:14:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:14:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:14:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:14:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:14:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:14:06 INFO - no previously-included directories found matching 'docs/_build' 13:14:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:14:07 INFO - Running setup.py install for pep8 13:14:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:14:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:14:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:14:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:14:07 INFO - no previously-included directories found matching 'docs/_build' 13:14:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:14:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:14:07 INFO - Cleaning up... 13:14:07 INFO - Return code: 0 13:14:07 INFO - Running post-action listener: _resource_record_post_action 13:14:07 INFO - Running post-action listener: _start_resource_monitoring 13:14:07 INFO - Starting resource monitoring. 13:14:07 INFO - ##### 13:14:07 INFO - ##### Finished create-virtualenv step (success) 13:14:07 INFO - ##### 13:14:07 INFO - ##### 13:14:07 INFO - ##### Running install step. 13:14:07 INFO - ##### 13:14:07 INFO - Running pre-action listener: _resource_record_pre_action 13:14:07 INFO - Running main action method: install 13:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:14:07 INFO - Reading from file tmpfile_stdout 13:14:07 INFO - Detecting whether we're running mozinstall >=1.0... 13:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:14:07 INFO - Reading from file tmpfile_stdout 13:14:07 INFO - Output received: 13:14:07 INFO - Usage: mozinstall [options] installer 13:14:07 INFO - Options: 13:14:07 INFO - -h, --help show this help message and exit 13:14:07 INFO - -d DEST, --destination=DEST 13:14:07 INFO - Directory to install application into. [default: 13:14:07 INFO - "/builds/slave/test"] 13:14:07 INFO - --app=APP Application being installed. [default: firefox] 13:14:07 INFO - mkdir: /builds/slave/test/build/application 13:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:14:23 INFO - Reading from file tmpfile_stdout 13:14:23 INFO - Output received: 13:14:23 INFO - /builds/slave/test/build/application/firefox/firefox 13:14:23 INFO - Running post-action listener: _resource_record_post_action 13:14:23 INFO - ##### 13:14:23 INFO - ##### Finished install step (success) 13:14:23 INFO - ##### 13:14:23 INFO - ##### 13:14:23 INFO - ##### Running run-tests step. 13:14:23 INFO - ##### 13:14:23 INFO - Running pre-action listener: _resource_record_pre_action 13:14:23 INFO - Running main action method: run_tests 13:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:14:23 INFO - Python 2.7.3 13:14:23 INFO - Return code: 0 13:14:23 INFO - grabbing minidump binary from tooltool 13:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:23 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 0x25876f0>, '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 0x25885f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2588aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:14:23 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 13:14:23 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 13:14:23 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 13:14:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:14:23 INFO - Return code: 0 13:14:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:14:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:14:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:14:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:14:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:14:24 INFO - Return code: 0 13:14:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:14:24 INFO - Using env: {'DISPLAY': ':0', 13:14:24 INFO - 'HOME': '/home/cltbld', 13:14:24 INFO - 'LANG': 'en_US.UTF-8', 13:14:24 INFO - 'LANGUAGE': 'en_US:en', 13:14:24 INFO - 'LOGNAME': 'cltbld', 13:14:24 INFO - 'MAIL': '/var/mail/cltbld', 13:14:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:14:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:24 INFO - 'MOZ_NO_REMOTE': '1', 13:14:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:14:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:24 INFO - 'NO_EM_RESTART': '1', 13:14:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:24 INFO - 'PWD': '/builds/slave/test', 13:14:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:14:24 INFO - 'SHELL': '/bin/bash', 13:14:24 INFO - 'SHLVL': '1', 13:14:24 INFO - 'TERM': 'linux', 13:14:24 INFO - 'TMOUT': '86400', 13:14:24 INFO - 'USER': 'cltbld', 13:14:24 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012', 13:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:24 INFO - '_': '/tools/buildbot/bin/python'} 13:14:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:14:24 INFO - mozversion application_buildid: 20160627115019 13:14:24 INFO - mozversion application_changeset: 1d84194ace3538ad91d6cffb6fa3ec6a3a5037be 13:14:24 INFO - mozversion application_display_name: Nightly 13:14:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:14:24 INFO - mozversion application_name: Firefox 13:14:24 INFO - mozversion application_remotingname: firefox 13:14:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:14:24 INFO - mozversion application_vendor: Mozilla 13:14:24 INFO - mozversion application_version: 50.0a1 13:14:24 INFO - mozversion platform_buildid: 20160627115019 13:14:24 INFO - mozversion platform_changeset: 1d84194ace3538ad91d6cffb6fa3ec6a3a5037be 13:14:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:14:24 INFO - mozversion platform_version: 50.0a1 13:14:24 INFO - using testdate: 1467058464 13:14:24 INFO - actual date: 1467058464 13:14:24 INFO - starting webserver on 'localhost:45859' 13:14:24 INFO - SUITE-START | Running 2 tests 13:14:24 INFO - TEST-START | dromaeo_css 13:14:24 INFO - operating with platform_type : linux_ 13:14:24 INFO - Initialising browser for dromaeo_css test... 13:14:24 INFO - TEST-INFO | started process 4213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPNw8Ht/profile http://localhost:45859/getInfo.html) 13:14:30 INFO - PROCESS | 4213 | __metrics Screen width/height:1600/1200 13:14:30 INFO - PROCESS | 4213 | colorDepth:24 13:14:30 INFO - PROCESS | 4213 | Browser inner width/height: 1024/697 13:14:30 INFO - PROCESS | 4213 | __metrics 13:14:30 ERROR - PROCESS | 4213 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 13:14:31 INFO - TEST-INFO | 4213: exit 0 13:14:31 INFO - Browser initialized. 13:14:31 INFO - Running cycle 1/1 for dromaeo_css test... 13:14:31 INFO - TEST-INFO | started process 4330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPNw8Ht/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:14:44 INFO - PROCESS | 4330 | RSS: Main: 185982976 13:14:44 INFO - PROCESS | 4330 | 13:15:33 INFO - PROCESS | 4330 | 1467058533621 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] 13:17:45 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:45859/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45859/tests/dromaeo/cssquery-ext.html) 13:17:46 INFO - PROCESS | 4330 | RSS: Main: 189026304 13:17:46 INFO - PROCESS | 4330 | 13:20:48 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:45859/tests/dromaeo/cssquery-ext.html (next: http://localhost:45859/tests/dromaeo/cssquery-jquery.html) 13:20:49 INFO - PROCESS | 4330 | RSS: Main: 188399616 13:20:49 INFO - PROCESS | 4330 | 13:23:51 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:45859/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45859/tests/dromaeo/cssquery-mootools.html) 13:23:51 INFO - PROCESS | 4330 | RSS: Main: 188809216 13:23:51 INFO - PROCESS | 4330 | 13:26:53 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:45859/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45859/tests/dromaeo/cssquery-prototype.html) 13:26:54 INFO - PROCESS | 4330 | RSS: Main: 186507264 13:26:54 INFO - PROCESS | 4330 | 13:29:57 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:45859/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45859/tests/dromaeo/cssquery-yui.html) 13:29:57 INFO - PROCESS | 4330 | RSS: Main: 188395520 13:29:57 INFO - PROCESS | 4330 | 13:33:00 INFO - PROCESS | 4330 | Cycle 1(1): loaded http://localhost:45859/tests/dromaeo/cssquery-yui.html (next: http://localhost:45859/tests/dromaeo/cssquery-dojo.html) 13:33:00 INFO - PROCESS | 4330 | RSS: Main: 189812736 13:33:00 INFO - PROCESS | 4330 | 13:33:00 INFO - PROCESS | 4330 | __start_tp_report 13:33:00 INFO - PROCESS | 4330 | _x_x_mozilla_page_load 13:33:00 INFO - PROCESS | 4330 | _x_x_mozilla_page_load_details 13:33:00 INFO - PROCESS | 4330 | |i|pagename|runs| 13:33:00 INFO - PROCESS | 4330 | |0;dojo.html;2619.8166128371017;2651.6155157502158;2662.3077999720067;2685.1810197889636;2693.501702185096;4784.473707892129;4809.711417314964;4902.166631672615;4903.705777653343;4921.852344429664;4789.497102804207;4801.351817504645;4852.199387101133;4906;4909.729964851932;4414.867553973378;4439.977800111011;4551.2717965125585;4570.680052396334;4586.885327866797;492.0691161964206;4243.745375277494;4405.31717583775;4410.64714822815;4555.430571178603;4508.887277818048;4552.613027892633;4558.954410455886;4570.10882877839;4595.058013107305;4556.977215113936;4569.794359253841;4573.6569757268335;4573.725576465389;4625.213713668651;4418.403515525395;4494.07871386365;4520.028193938286;4558.544145585448;4562.680612357136;4882.511748825124;4942.579880710144;4969.503049695001;4970.304157417928;5041.546260836506;5014.724190169539;5286.471352864722;5312.389075256357;5326.813561525328;5359.222912677679;5167.715775632339;5239.47605239473;5252.684838909678;5264.2893209416625;5274.815381461631;4897.363342765453;4900.534449227318;4909.828156014522;4954.331165292711;4957;5212.139996900469;5280.683159010472;5440.292761941001;5471.699056551848;5480.7533660985355;5139.820106296336;5168.870778230575;5174;5205.713685747321;5219.060569097599;5268.762905669254;5296.682199068068;5300.893982120413;5310.309659744208;5347.171188465794;5035.496450354935;5111.463296353903;5231.450697676765;5233.633645644768;5235.764390602432;5166.45752196014;5177.430482646906;5228.2680424740565;5244.816431424882;5279.9208011879855;4439.1121775645;4472.8210871565425;4475.776211189427;4479.350494178326;4521.819127234874;3829.215010922754;3867.5165604299464;3893.182431689377;3917;3935.35066713989;4527.954720452819;4531.546845315442;4553.954460455353;4588.885277868013;4608.470025947059;5286.577073834084;5298.311219541435;5306.893862122736;5308.389535203424;5312.123499622519;4419.867403977886;4458.331250312479;4499.032707967803;4532.501424843264;4537.319402089713;4657.953420465819;4747.406574178228;4776.928346074812;4778.522147785263;4813.638977076664;4897.877553061202;4908.852734417973;4936.580390666833;4966.404031516241;4991.625628077836;5113.463086376026;5194.7922083116255;5195.298634684269;5311.044012077708;5317.867053323543;4914.631402644744;4931.7040977541465;4936.7284799336385;4948.579370753526;4983.626228032985;5225.503577160163;5229.843104706865;5236.345456817898;5238.738063096906;5240.34495688039;5160.380754309507;5169.586433085269;5173.1205695031185;5220.556252718561;5270.262163297065;5053.166227572409;5075.670081444694;5082.085224659449;5100.489951005018;5108.974455127701;4923.310736496822;5071.822486212965;5073.974630126973;5078.339815823919;5079.898402031865;4900.926486102782;4933.679310844784;4989.700617962933;5006.974965125297;5020.246962955586;5080.415752188545;5083.87290317745;5084.949150508448;5141.7686204120155;5147.6911385317;5008.724520151427;5014.974925125351;5043.067032598981;5058.974705126451;5079.5428411443145 13:33:00 INFO - PROCESS | 4330 | |1;ext.html;562.4853259267769;585.787420040516;586.0505980311892;590.2444870565674;596.8090211132434;35203.64796352039;35999.640003599954;36028.27943441133;36188.63811361886;36230;40357;40959;40988.38517422241;41021.384679229835;41088.58911410885;7682.731104411333;7793.259640334188;7829.608519574027;7836.451448398614;7888.881666775003;7640.235976402371;7688.769336919873;7691.461597688164;7718.498297610638;7735.381169506454;7649.082110146763;7697.230276972314;7725.150233474314;7743.419243556727;7753.263439973193;7672.808179795494;7719.536827790323;7720.845583088307;7726.150123486412;7727.49771264866;7644.388448924073;7723.575203363813;7746.109197442253;7757.069151701776;7768.7669369918995;37502.81248593739;37568.43647345292;37580.62419375826;37630.43554346687;37767.62232377668;2549.61755736641;2907.1278616414993;2921.795474316799;3020.9728692244744;3090.8300043497597;26011.479770404487;27191.184264472096;27862.164135075982;28331.85834070837;28561.85719071412;3172.159377764894;3190.96809031909;3211.935761284785;3282.9658657522805;3329.900102996914;226483;231556;234351;235030.8248458764;235196;29175;29678.258043549085;29920.102396928127;31869.84065079706;31965;32150.35699286001;32254.35491290208;32260.516092258636;32334.35331293361;32507.34985300281;13175.209487430784;13355.46578136883;13385.330733463483;13431.126976746677;13444.663883402993;10505.159587233004;10542.947285263524;10603.681889543326;10671.786564268672;10678.09236214915;7719.768406947801;7796.142424333319;7810.258025487569;7834.529928204326;7866.881996770053;3081.443870845209;3126.45287074761;3139.968600314013;3142.5600415941785;3150.480170771797;870.303756994402;884.3014018924977;903.3721563513426;903.810199858024;986.8569057486624;28272.71727282742;28511.857440712665;29262.853685731436;29263.561046584317;29267.121986340444;962.9951850240705;994.7165057958592;1026.2200727447193;1042.5829668132808;1087.1194332590626;15132.697346053237;15502.612434688997;15571.143587102819;15610.843891561166;15720.29258683362;394413;395485;395543;395558;396745;51288.74355628198;51527.484725153015;52007.73996129995;52036;52095.73952130291;1154.1747650429816;1180.409795102466;1192.1118766518998;1196.4376742930808;1198.0714945916984;27592;28156.577651335658;28368.886511456138;29037.274068148465;29217.85391073031;44436.77781611071;44576.55423445854;44706;45022;45064.774676126406;316198.77105529845;317420;317811;318347;320069;25448.491030179663;25456.23631291064;27995.58006629943;28168.29579260535;28247.15258542247;43660.126797463236;43708;43929.34105988477;44192.89627528801;45376;37068;37210.25579488449;37476.62523374731;37559.81220093882;38307.2338553233;37211.25577488489;37264.06839829026;37887.86336409802;38071.238575227784;38301.808490957366;32103;36229;36894;37123.62876371202;37232.627673724;32076.839615802706;34161.658383415845;34288.82855585806;34594;34851.65148348585;25196.622050669623;25839.483210336064;25873.870630646725;26073.869630651727;26384.60423093617 13:33:00 INFO - PROCESS | 4330 | |2;jquery.html;366.8165917041479;370.56273597155354;376.6346643755556;382.6345839723065;392.46428624926983;15877.841221587794;16571.254293556787;17578.560535986606;17588.736168957475;17596.384126555575;15945.362185512595;16533.25600347984;16859.325626974907;17045.06252156134;17071.658566828657;4819.493953134915;4969.055879382906;4985.052839960396;5019.799208031693;5042.672226305297;3686.2811751708427;5004.524570165829;5490.450954904518;5898.999999999978;5900.498457631106;5867.061270196769;5939.346671866091;5942.286925568917;5960.761569537213;5982.910256346158;5838.649681019131;5937.524998000171;5955.910661340084;6103.450689437972;6268.467180289681;5399.919001214985;5421.756020979065;5441.29263195782;5450.945490545084;5520.751566179491;20903.8954805225;21159.5768084639;21238.51330406872;21360.679589806165;21612.567748645095;2076.968845467319;2468.0744720729726;2489.9751002489925;2494.0273293415585;2495.301315631626;12177.269363838199;12235.877641223562;13151.802722959163;13590.932045339809;13600.727985440335;1694.4831826292975;1745.432734361325;1802.5716954508348;1847.0856925821804;1878.4646375782836;64178.679106604635;66613.3338666612;66811.66594166998;67137.66431167813;67708.6614566924;9822.361546499455;9922;9931.453770042572;10170.542325595366;10221.182305415548;13551.051426400254;13643.680574302392;13703.246321452416;13771.586852394445;13773.724525509433;7342.229065948105;7466.887996680054;7507.8498430031095;7647.426443016796;7656.770296891103;7070.858582828418;7157.642117894085;7202.71189152428;7218.855622887513;7337.486375953738;6239.844003899848;6348.714307856158;6364.395382438661;6401.996460458557;6458.257300410419;1667.7748503951811;1684.3094331324098;1722.7329763886617;1853.4347024157762;1863.3850829226324;876.5660997806;915.7802127489355;922.8062106957614;929.6281487405092;952.2477242978108;17689.734653980202;17835.910820445813;17992.280308787504;18271.634567308578;18308.80294364658;878.7407714724171;918.4581097152712;924.8612708093705;969.9175570076482;997.5909876950416;10171;10182.389056656624;10213.642522511676;10282.126019288444;10358.274920755475;358697;360642;361264;376669;395276;68908.6554567224;69950.30049699539;70154.64922675354;70622;76149;872.7512658892313;886.9290456763443;923.4044041593135;926.749777560055;929.6095639831287;15118;15341.769873452131;15477.690446190787;15721.135337556545;16026.038437693776;33624;33804.492932606525;35097.47353789644;37093;38302.42546361862;44686.77656611696;47316.52683473259;49215.507844922526;51411.742941285054;52659.73670131625;7653.464257501922;7701.845963080819;7795.947547081071;7819;7855.2930236276725;8325.167483251626;10995.965746336953;11012.50443730018;11540.480678369326;11955.880441195477;9521.761955951157;10024.448655324028;10049.748756280858;10240.078392944373;10327.48362581853;10613.469326533797;10665.786684266426;10708.143348532254;10861.837072444077;11123.221374503708;10040.899591003996;10210.693679189637;10241.487925603838;10392.37645741258;10612.097971672185;7954.5624990626075;7982.920170798217;7984.880226796487;8100.959495202486;8147.063087744985;8731.825363492822;9888.208943284664;9945.104940555384;10204.897951020692;10218.131458826083 13:33:00 INFO - PROCESS | 4330 | |3;mootools.html;1361.366964361572;1407.6621610813404;1467.3983666696656;1666.0919798709701;1686.9746953795695;6644.269130395653;7136.215016348197;7333.449991250657;7687.154413014571;7744.92255077449;7215.81960450989;7412.629368531579;7415.110186777581;7443.106827180746;7525.774226773206;2147.6241657709916;2161.6757486377014;2164.3831508020216;2184.5958497677902;2189.1899997001133;2115.2808045264605;2126.7873212678765;2138.6043581937392;2159.9352019439443;2183.268605017321;2158;2171.229213629155;2190.11300423328;2193.6819161221615;2198.7251593550805;2130.968035479469;2138.0699395762817;2138.550904310097;2138.8823614701187;2145.2169957965384;2116.333354993172;2119.7138386317956;2147.108949785837;2149;2162.535054963175;7416.406687465043;7473.364763995012;7499.287567681062;7524.661390237453;7532.246775322424;4368.650507959387;4450;4486.7980940857415;4495.168393847149;4512.796924138422;2728.208819442379;2736.7263273672675;2822.0969289827262;2834.093090211133;2844.1183233197776;863.5984267315665;870.4168207301124;875.0855356152836;887;928.6796055360958;10343.069123778821;10376.533056012497;10389.168866490663;10462.529186186564;10476.266661333633;4121.814518346681;4145;4216.47294088239;4231.830726770956;4277.144571085795;8846.982597001299;8875;8877.245434138042;8913.5097569633;8925.062868398725;4593.678442508993;4614.861554153381;4631.143238500888;4640.512746161672;4655.930161047587;3571.4464258040043;3813.161104556993;3952.8616498422416;4026.053877338823;4121.9381709274385;3603.9639603603628;3605.441156620728;3641.9271614568092;3642.745007849478;3699.5375578052744;1156.1733360647177;1175.6061719323952;1175.9529618815152;1182.343799191457;1183;698.5284932670427;808.18373442822;811.8295158016882;839.5004972041626;841.6128580852876;5015.774290156952;5296.25852380667;5304.098303288451;5306.495882891119;5316.096263635114;408.98773036808944;413.2685147289281;422.11356152080384;428.39596169400994;429.47174974781194;3350.1289664687356;3545.982270088633;3555.7866528008403;3584.193556449778;3666.1018050577777;9084.772880678036;9420.152186303265;9424.481653509123;9456.90543094574;9477.668281610111;9375.765605859908;9376.62493500266;9411.858822117674;9421;9509.381890177116;7093.964530177419;7184.137903451619;7296.963515182496;7307.01355317036;7347.191808901017;5278.287431196739;5351.625386222927;5421.891562168814;5425.647332923348;5548.916766248591;7983.401244906771;8257.83484330322;8309.584520773817;8379;8434.198751118634;8376.246137847624;8376.623051962799;8528.275096616857;8536.146385361415;8577.356698247531;6021.608595441282;6509.772157974448;6597.406233439014;6680.064790929371;6722.831929201809;7372.336489715952;7430.071241094864;7527.736529221451;7552.320291173821;7567.205443428361;6426.678666066771;6768.4585233182215;6811.114555107804;6848.2124555674745;6954.513184077066;6625.569337993015;6654.101696270942;6655.134832471747;6656.800295991128;6766.391024807791;6138.355472675484;6232.065190221322;6243.469305109116;6249.625022498664;6290.779822706183;4560.498345181961;4581.7709114544805;4700.6474514410875;4705.529447055267;4715.339852420732;4502.810515868131;4599.425071866017;4680.063987202505;4709.4584122824945;4747.83382581608 13:33:00 INFO - PROCESS | 4330 | |4;prototype.html;296.23423450380767;296.5699735383693;297.47941103069627;310.20277885833417;310.76537214403135;4905.718840739056;4935.210366341386;5097.260897169908;5105.974470127644;5151.793928242871;5004.7497625118685;5033.219850923104;5044.218146187338;5060.735825392629;5077.923831142536;3999.9600003999954;4003.239384516947;4003.319435695939;4004.8598299059395;4015.5382131054866;3928.7249892507393;4024.356103023517;4031.3549832026883;4031.4355990161403;4036.2331157080207;3950.1309711863346;3978.18447218321;4004.3993400989793;4024.235395274903;4025.866290865831;3982.5420076691116;4008.779517126557;4022.7760851106223;4023.839046438139;4026.8993275168064;3262.7879187852714;3373.881914133018;3406.318736252759;3420.8973730788116;3550.5797680927576;4923.113839508887;4928.876778080541;4955.851324460236;4964.255361695738;4988.850334489971;4454.910901781978;4473.977630111861;4475.59719625232;4480.507144214133;4520.4575450946095;5026.567428282922;5235.267062611238;5249.947500524984;5274.861457432821;5290.629655924087;3645.8359373827975;3666.24841907411;3671.7429779915415;3677.2829298286847;3686.963130368689;5514;5560.36055853578;5561.916571251394;5569.721513924328;5574;3650.1175453158485;3772.0569857535615;3787.6401741835034;3794.1083845296334;3829.119302560371;3819.694424446038;3824.388097904322;3829.8659546915724;3832.9233415331537;3859.459675645412;4352.912941741148;4412;4464.933026004613;4464.977675111603;4481.865544033684;5284.973575132177;5293.550048245866;5316.893662126736;5332.68003919766;5337.439568845293;1283.3390803736083;1321.6035189443128;1326.1181314425799;1328.4287756264705;1330.5164741313365;818.6193420059582;834.8145633200749;844.8268105038452;850.6087199887997;857.1557016338901;4137.8689974663075;4155.4182414462;4155.625993660585;4222.451081359403;4234.407182994383;4821.349117869043;4834.404646466657;4842.789302674331;4843.878903027453;4864.610831133572;4133.937990930139;4134.937975930364;4167.395727619539;4171.228322760238;4206.48566516054;2472.8887200076038;2581.690197176351;2594.779443747265;2618.6726659167603;2629.526685196645;4492.4725593298435;4541.205289074399;4544.295634176708;4559.977200113978;4581.473130589959;4852.811061290006;4922.572453988375;4932.753362331869;4933.407991041098;4940.382452193476;4384.8903777405185;4508.024703695611;4517.661175411858;4537.3647689323525;4572.931406028979;4771.976140119277;4811.302361157543;4819.566239038503;4838.540338667821;4844.370231869834;4703.882402939954;4732.384789977281;4736.313234581035;4740.5733483986605;4803.423589169322;4536.72779633223;4776.59398951093;5163.328767260232;5163.3545806774155;5168.58651307887;3584.0860580552835;3694.649008344203;3790.128270497856;3801.6198380161763;3870;5457.017736807413;5547.140193270049;5548.250986116984;5557;5560.36055853582;5274.233131900856;5308.601854860824;5333.7866485340155;5336.919946200733;5370.865728356823;5141.717205553581;5180.507851754077;5230.843074707765;5288.805145864423;5300.337457817773;5168.198929165986;5177.223416487557;5187.703074231442;5201.843944681666;5205.943652257413;5137.332146821039;5288.127458969381;5289.18017707256;5303.257543943774;5323.1216849219445;5137.409197942135;5150.253213284128;5189.558887494454;5213.139831927841;5214.21786731978 13:33:00 INFO - PROCESS | 4330 | |5;yui.html;672.5325898500543;682.2836022176716;730.565313638385;758.2909979169477;770.8458308338334;11867.109966752485;14173.362198701057;14631.41474341025;14758.70482590349;15205.315760790763;13516.729665406687;13603.795943060863;13647.044706870523;13710.45158193671;13716;620.7889317632004;802.9317508011811;803.3693550562809;804.2600807257309;804.5574933786423;775.5191781095729;794.4716763352363;802.0495712580581;805.1746959366637;805.3275514944999;835.5780330932901;846.8687353460224;847.1443841719877;851.7189327521903;858;832.4797001873828;832.5046597274612;834.0991728932738;836.6444261188971;840.1136800675285;623.6164758673383;625.7622103600648;625.7747211004034;626.2047200055949;627.3193584960324;13327.466901323935;13334.133281336779;13347.733045339135;13366.933165334209;13412.597622071353;12935.935320323339;13002.804957925639;13345.332733363293;13381.66545836352;13393.866061339359;10602.204834637356;10663.146948244123;10696.51865666047;10800.351978881292;10853;3325.81708006062;3374.6625337466303;3383.4924761285756;3400.7109395701395;3406.6593340665736;61123.69438152825;61538.38461615416;61562.384376156115;61713.691431543004;62852.37147628557;10546.947265263778;10577.259591828652;10624;10627.096696780705;10717.517711702993;18688;19005.239790408505;19043.90478047601;19132.139053742616;19137.23451061942;7083.964580177066;7097.680604372816;7161.4628902831455;7193.460490463236;7301.671424785897;3794.165283637595;4002.0995276062654;4002.8198731057173;4039;4063.7358571692744;3068.8925887593828;3134.5454909038517;3164.7784655073924;3189.7926634768664;3199.776015678927;513.2762804445714;527.3671594087111;531.6517680919004;533.2827347217985;538.6875612144946;457.4807593381469;462.4612326639427;604.2024527623582;617.1699064757894;629.7323637454064;7189.761156913341;7962.6416811243635;8060.596970151586;8203.466774659628;8309.584520773937;505.9443461219263;514.6140394703972;545.9071957767189;560.6243816642859;574.1387918122816;3687.8524859005875;3761.736678432538;3856.3636999895266;3895.590962948906;3906.187941853961;74083;76007.81956992419;76672.23327766762;88321.55839220891;88680.55659721789;76447;76871.61564192144;77299.61350193214;77853.61073194598;80271;42560.361594576105;68618.65690671514;71192.64403678052;71992.64003680053;72396.99999999895;7912.32745216663;8340.207680270365;8652.351073669373;8789.296856251613;8842.204201621886;44543.777281113384;44851;44854.55145448634;44919.32621010622;45022.54977450184;55685;55908;59779;63560;63610.363896360446;11024.118070554498;11276.9436152822;11422.200445969034;11485.19603627738;11834.704132396759;12955.805662915252;12982.935085324512;13082.542111026069;13457.663558411117;13751.243681597609;10008.249381296286;10267.486625668836;11593.130515211562;11939.403029848647;12078;10999.450027498433;11203.663890083311;11435.59975400857;11590.594329198437;11787.292762433939;10754.946225268823;10976;11071.225014248925;11093.223474356717;11193.776124477628;9495.38280011797;9525.57134928916;9703.07820757027;9900.752481188028;9961.551730172305;9165.17513423795;9353.532323383939;9380.577873995822;9397.154256116983;9441.669541566012 13:33:00 INFO - PROCESS | 4330 | __end_tp_report 13:33:00 INFO - PROCESS | 4330 | __start_cc_report 13:33:00 INFO - PROCESS | 4330 | _x_x_mozilla_cycle_collect,389 13:33:00 INFO - PROCESS | 4330 | __end_cc_report 13:33:00 INFO - PROCESS | 4330 | __startTimestamp1467059580691__endTimestamp 13:33:00 INFO - PROCESS | 4330 | 13:33:00 INFO - PROCESS | 4330 | ------- Summary: start ------- 13:33:00 INFO - PROCESS | 4330 | Number of tests: 6 13:33:00 INFO - PROCESS | 4330 | 13:33:00 INFO - PROCESS | 4330 | [#0] dojo.html Cycles:165 Average:4820.13 Median:4966.40 stddev:617.16 (12.4%) stddev-sans-first:594.42 13:33:00 INFO - PROCESS | 4330 | Values: 2619.8 2651.6 2662.3 2685.2 2693.5 4784.5 4809.7 4902.2 4903.7 4921.9 4789.5 4801.4 4852.2 4906.0 4909.7 4414.9 4440.0 4551.3 4570.7 4586.9 492.1 4243.7 4405.3 4410.6 4555.4 4508.9 4552.6 4559.0 4570.1 4595.1 4557.0 4569.8 4573.7 4573.7 4625.2 4418.4 4494.1 4520.0 4558.5 4562.7 4882.5 4942.6 4969.5 4970.3 5041.5 5014.7 5286.5 5312.4 5326.8 5359.2 5167.7 5239.5 5252.7 5264.3 5274.8 4897.4 4900.5 4909.8 4954.3 4957.0 5212.1 5280.7 5440.3 5471.7 5480.8 5139.8 5168.9 5174.0 5205.7 5219.1 5268.8 5296.7 5300.9 5310.3 5347.2 5035.5 5111.5 5231.5 5233.6 5235.8 5166.5 5177.4 5228.3 5244.8 5279.9 4439.1 4472.8 4475.8 4479.4 4521.8 3829.2 3867.5 3893.2 3917.0 3935.4 4528.0 4531.5 4554.0 4588.9 4608.5 5286.6 5298.3 5306.9 5308.4 5312.1 4419.9 4458.3 4499.0 4532.5 4537.3 4658.0 4747.4 4776.9 4778.5 4813.6 4897.9 4908.9 4936.6 4966.4 4991.6 5113.5 5194.8 5195.3 5311.0 5317.9 4914.6 4931.7 4936.7 4948.6 4983.6 5225.5 5229.8 5236.3 5238.7 5240.3 5160.4 5169.6 5173.1 5220.6 5270.3 5053.2 5075.7 5082.1 5100.5 5109.0 4923.3 5071.8 5074.0 5078.3 5079.9 4900.9 4933.7 4989.7 5007.0 5020.2 5080.4 5083.9 5084.9 5141.8 5147.7 5008.7 5015.0 5043.1 5059.0 5079.5 13:33:00 INFO - PROCESS | 4330 | 13:33:00 INFO - PROCESS | 4330 | [#1] ext.html Cycles:180 Average:45722.41 Median:36013.96 stddev:85121.60 (236.4%) stddev-sans-first:85292.86 13:33:00 INFO - PROCESS | 4330 | Values: 562.5 585.8 586.1 590.2 596.8 35203.6 35999.6 36028.3 36188.6 36230.0 40357.0 40959.0 40988.4 41021.4 41088.6 7682.7 7793.3 7829.6 7836.5 7888.9 7640.2 7688.8 7691.5 7718.5 7735.4 7649.1 7697.2 7725.2 7743.4 7753.3 7672.8 7719.5 7720.8 7726.2 7727.5 7644.4 7723.6 7746.1 7757.1 7768.8 37502.8 37568.4 37580.6 37630.4 37767.6 2549.6 2907.1 2921.8 3021.0 3090.8 26011.5 27191.2 27862.2 28331.9 28561.9 3172.2 3191.0 3211.9 3283.0 3329.9 226483.0 231556.0 234351.0 235030.8 235196.0 29175.0 29678.3 29920.1 31869.8 31965.0 32150.4 32254.4 32260.5 32334.4 32507.3 13175.2 13355.5 13385.3 13431.1 13444.7 10505.2 10542.9 10603.7 10671.8 10678.1 7719.8 7796.1 7810.3 7834.5 7866.9 3081.4 3126.5 3140.0 3142.6 3150.5 870.3 884.3 903.4 903.8 986.9 28272.7 28511.9 29262.9 29263.6 29267.1 963.0 994.7 1026.2 1042.6 1087.1 15132.7 15502.6 15571.1 15610.8 15720.3 394413.0 395485.0 395543.0 395558.0 396745.0 51288.7 51527.5 52007.7 52036.0 52095.7 1154.2 1180.4 1192.1 1196.4 1198.1 27592.0 28156.6 28368.9 29037.3 29217.9 44436.8 44576.6 44706.0 45022.0 45064.8 316198.8 317420.0 317811.0 318347.0 320069.0 25448.5 25456.2 27995.6 28168.3 28247.2 43660.1 43708.0 43929.3 44192.9 45376.0 37068.0 37210.3 37476.6 37559.8 38307.2 37211.3 37264.1 37887.9 38071.2 38301.8 32103.0 36229.0 36894.0 37123.6 37232.6 32076.8 34161.7 34288.8 34594.0 34851.7 25196.6 25839.5 25873.9 26073.9 26384.6 13:33:00 INFO - PROCESS | 4330 | 13:33:00 INFO - PROCESS | 4330 | [#2] jquery.html Cycles:180 Average:23707.84 Median:19347.44 stddev:61075.67 (315.7%) stddev-sans-first:61221.86 13:33:00 INFO - PROCESS | 4330 | Values: 366.8 370.6 376.6 382.6 392.5 15877.8 16571.3 17578.6 17588.7 17596.4 15945.4 16533.3 16859.3 17045.1 17071.7 4819.5 4969.1 4985.1 5019.8 5042.7 3686.3 5004.5 5490.5 5899.0 5900.5 5867.1 5939.3 5942.3 5960.8 5982.9 5838.6 5937.5 5955.9 6103.5 6268.5 5399.9 5421.8 5441.3 5450.9 5520.8 20903.9 21159.6 21238.5 21360.7 21612.6 2077.0 2468.1 2490.0 2494.0 2495.3 12177.3 12235.9 13151.8 13590.9 13600.7 1694.5 1745.4 1802.6 1847.1 1878.5 64178.7 66613.3 66811.7 67137.7 67708.7 9822.4 9922.0 9931.5 10170.5 10221.2 13551.1 13643.7 13703.2 13771.6 13773.7 7342.2 7466.9 7507.8 7647.4 7656.8 7070.9 7157.6 7202.7 7218.9 7337.5 6239.8 6348.7 6364.4 6402.0 6458.3 1667.8 1684.3 1722.7 1853.4 1863.4 876.6 915.8 922.8 929.6 952.2 17689.7 17835.9 17992.3 18271.6 18308.8 878.7 918.5 924.9 969.9 997.6 10171.0 10182.4 10213.6 10282.1 10358.3 358697.0 360642.0 361264.0 376669.0 395276.0 68908.7 69950.3 70154.6 70622.0 76149.0 872.8 886.9 923.4 926.7 929.6 15118.0 15341.8 15477.7 15721.1 16026.0 33624.0 33804.5 35097.5 37093.0 38302.4 44686.8 47316.5 49215.5 51411.7 52659.7 7653.5 7701.8 7795.9 7819.0 7855.3 8325.2 10996.0 11012.5 11540.5 11955.9 9521.8 10024.4 10049.7 10240.1 10327.5 10613.5 10665.8 10708.1 10861.8 11123.2 10040.9 10210.7 10241.5 10392.4 10612.1 7954.6 7982.9 7984.9 8101.0 8147.1 8731.8 9888.2 9945.1 10204.9 10218.1 13:33:00 INFO - PROCESS | 4330 | 13:33:00 INFO - PROCESS | 4330 | [#3] mootools.html Cycles:180 Average:5017.52 Median:5147.03 stddev:2791.19 (54.2%) stddev-sans-first:2785.50 13:33:00 INFO - PROCESS | 4330 | Values: 1361.4 1407.7 1467.4 1666.1 1687.0 6644.3 7136.2 7333.4 7687.2 7744.9 7215.8 7412.6 7415.1 7443.1 7525.8 2147.6 2161.7 2164.4 2184.6 2189.2 2115.3 2126.8 2138.6 2159.9 2183.3 2158.0 2171.2 2190.1 2193.7 2198.7 2131.0 2138.1 2138.6 2138.9 2145.2 2116.3 2119.7 2147.1 2149.0 2162.5 7416.4 7473.4 7499.3 7524.7 7532.2 4368.7 4450.0 4486.8 4495.2 4512.8 2728.2 2736.7 2822.1 2834.1 2844.1 863.6 870.4 875.1 887.0 928.7 10343.1 10376.5 10389.2 10462.5 10476.3 4121.8 4145.0 4216.5 4231.8 4277.1 8847.0 8875.0 8877.2 8913.5 8925.1 4593.7 4614.9 4631.1 4640.5 4655.9 3571.4 3813.2 3952.9 4026.1 4121.9 3604.0 3605.4 3641.9 3642.7 3699.5 1156.2 1175.6 1176.0 1182.3 1183.0 698.5 808.2 811.8 839.5 841.6 5015.8 5296.3 5304.1 5306.5 5316.1 409.0 413.3 422.1 428.4 429.5 3350.1 3546.0 3555.8 3584.2 3666.1 9084.8 9420.2 9424.5 9456.9 9477.7 9375.8 9376.6 9411.9 9421.0 9509.4 7094.0 7184.1 7297.0 7307.0 7347.2 5278.3 5351.6 5421.9 5425.6 5548.9 7983.4 8257.8 8309.6 8379.0 8434.2 8376.2 8376.6 8528.3 8536.1 8577.4 6021.6 6509.8 6597.4 6680.1 6722.8 7372.3 7430.1 7527.7 7552.3 7567.2 6426.7 6768.5 6811.1 6848.2 6954.5 6625.6 6654.1 6655.1 6656.8 6766.4 6138.4 6232.1 6243.5 6249.6 6290.8 4560.5 4581.8 4700.6 4705.5 4715.3 4502.8 4599.4 4680.1 4709.5 4747.8 13:33:00 INFO - PROCESS | 4330 | 13:33:00 INFO - PROCESS | 4330 | [#4] prototype.html Cycles:180 Average:4247.77 Median:4642.68 stddev:1237.92 (26.7%) stddev-sans-first:1205.34 13:33:00 INFO - PROCESS | 4330 | Values: 296.2 296.6 297.5 310.2 310.8 4905.7 4935.2 5097.3 5106.0 5151.8 5004.7 5033.2 5044.2 5060.7 5077.9 4000.0 4003.2 4003.3 4004.9 4015.5 3928.7 4024.4 4031.4 4031.4 4036.2 3950.1 3978.2 4004.4 4024.2 4025.9 3982.5 4008.8 4022.8 4023.8 4026.9 3262.8 3373.9 3406.3 3420.9 3550.6 4923.1 4928.9 4955.9 4964.3 4988.9 4454.9 4474.0 4475.6 4480.5 4520.5 5026.6 5235.3 5249.9 5274.9 5290.6 3645.8 3666.2 3671.7 3677.3 3687.0 5514.0 5560.4 5561.9 5569.7 5574.0 3650.1 3772.1 3787.6 3794.1 3829.1 3819.7 3824.4 3829.9 3832.9 3859.5 4352.9 4412.0 4464.9 4465.0 4481.9 5285.0 5293.6 5316.9 5332.7 5337.4 1283.3 1321.6 1326.1 1328.4 1330.5 818.6 834.8 844.8 850.6 857.2 4137.9 4155.4 4155.6 4222.5 4234.4 4821.3 4834.4 4842.8 4843.9 4864.6 4133.9 4134.9 4167.4 4171.2 4206.5 2472.9 2581.7 2594.8 2618.7 2629.5 4492.5 4541.2 4544.3 4560.0 4581.5 4852.8 4922.6 4932.8 4933.4 4940.4 4384.9 4508.0 4517.7 4537.4 4572.9 4772.0 4811.3 4819.6 4838.5 4844.4 4703.9 4732.4 4736.3 4740.6 4803.4 4536.7 4776.6 5163.3 5163.4 5168.6 3584.1 3694.6 3790.1 3801.6 3870.0 5457.0 5547.1 5548.3 5557.0 5560.4 5274.2 5308.6 5333.8 5336.9 5370.9 5141.7 5180.5 5230.8 5288.8 5300.3 5168.2 5177.2 5187.7 5201.8 5205.9 5137.3 5288.1 5289.2 5303.3 5323.1 5137.4 5150.3 5189.6 5213.1 5214.2 13:33:00 INFO - PROCESS | 4330 | 13:33:00 INFO - PROCESS | 4330 | [#5] yui.html Cycles:180 Average:16842.38 Median:520.99 stddev:22817.12 (4379.6%) stddev-sans-first:22848.82 13:33:00 INFO - PROCESS | 4330 | Values: 672.5 682.3 730.6 758.3 770.8 11867.1 14173.4 14631.4 14758.7 15205.3 13516.7 13603.8 13647.0 13710.5 13716.0 620.8 802.9 803.4 804.3 804.6 775.5 794.5 802.0 805.2 805.3 835.6 846.9 847.1 851.7 858.0 832.5 832.5 834.1 836.6 840.1 623.6 625.8 625.8 626.2 627.3 13327.5 13334.1 13347.7 13366.9 13412.6 12935.9 13002.8 13345.3 13381.7 13393.9 10602.2 10663.1 10696.5 10800.4 10853.0 3325.8 3374.7 3383.5 3400.7 3406.7 61123.7 61538.4 61562.4 61713.7 62852.4 10546.9 10577.3 10624.0 10627.1 10717.5 18688.0 19005.2 19043.9 19132.1 19137.2 7084.0 7097.7 7161.5 7193.5 7301.7 3794.2 4002.1 4002.8 4039.0 4063.7 3068.9 3134.5 3164.8 3189.8 3199.8 513.3 527.4 531.7 533.3 538.7 457.5 462.5 604.2 617.2 629.7 7189.8 7962.6 8060.6 8203.5 8309.6 505.9 514.6 545.9 560.6 574.1 3687.9 3761.7 3856.4 3895.6 3906.2 74083.0 76007.8 76672.2 88321.6 88680.6 76447.0 76871.6 77299.6 77853.6 80271.0 42560.4 68618.7 71192.6 71992.6 72397.0 7912.3 8340.2 8652.4 8789.3 8842.2 44543.8 44851.0 44854.6 44919.3 45022.5 55685.0 55908.0 59779.0 63560.0 63610.4 11024.1 11276.9 11422.2 11485.2 11834.7 12955.8 12982.9 13082.5 13457.7 13751.2 10008.2 10267.5 11593.1 11939.4 12078.0 10999.5 11203.7 11435.6 11590.6 11787.3 10754.9 10976.0 11071.2 11093.2 11193.8 9495.4 9525.6 9703.1 9900.8 9961.6 9165.2 9353.5 9380.6 9397.2 9441.7 13:33:00 INFO - PROCESS | 4330 | -------- Summary: end -------- 13:33:00 INFO - PROCESS | 4330 | 13:33:01 INFO - TEST-INFO | 4330: exit 0 13:33:01 INFO - TEST-OK | dromaeo_css | took 1116579ms 13:33:01 INFO - TEST-START | kraken 13:33:01 INFO - operating with platform_type : linux_ 13:33:01 INFO - Initialising browser for kraken test... 13:33:01 INFO - TEST-INFO | started process 4569 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprNZU_Z/profile http://localhost:45859/getInfo.html) 13:33:06 INFO - PROCESS | 4569 | __metrics Screen width/height:1600/1200 13:33:06 INFO - PROCESS | 4569 | colorDepth:24 13:33:06 INFO - PROCESS | 4569 | Browser inner width/height: 1024/697 13:33:06 INFO - PROCESS | 4569 | __metrics 13:33:07 ERROR - PROCESS | 4569 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 13:33:08 INFO - TEST-INFO | 4569: exit 0 13:33:08 INFO - Browser initialized. 13:33:08 INFO - Running cycle 1/1 for kraken test... 13:33:08 INFO - TEST-INFO | started process 4688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprNZU_Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:33:20 INFO - PROCESS | 4688 | RSS: Main: 186630144 13:33:20 INFO - PROCESS | 4688 | 13:33:23 INFO - PROCESS | 4688 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45859/tests/kraken/driver.html?testName=audio-beat-detection) 13:33:24 INFO - PROCESS | 4688 | RSS: Main: 190910464 13:33:24 INFO - PROCESS | 4688 | 13:33:27 INFO - PROCESS | 4688 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45859/tests/kraken/driver.html?testName=audio-dft) 13:33:27 INFO - PROCESS | 4688 | RSS: Main: 190574592 13:33:27 INFO - PROCESS | 4688 | 13:33:30 INFO - PROCESS | 4688 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45859/tests/kraken/driver.html?testName=audio-fft) 13:33:31 INFO - PROCESS | 4688 | RSS: Main: 186466304 13:33:31 INFO - PROCESS | 4688 | 13:33:33 INFO - PROCESS | 4688 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45859/tests/kraken/driver.html?testName=audio-oscillator) 13:33:34 INFO - PROCESS | 4688 | RSS: Main: 187256832 13:33:34 INFO - PROCESS | 4688 | 13:33:36 INFO - PROCESS | 4688 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45859/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:33:37 INFO - PROCESS | 4688 | RSS: Main: 187445248 13:33:37 INFO - PROCESS | 4688 | 13:33:40 INFO - PROCESS | 4688 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45859/tests/kraken/driver.html?testName=imaging-darkroom) 13:33:41 INFO - PROCESS | 4688 | RSS: Main: 187813888 13:33:41 INFO - PROCESS | 4688 | 13:33:44 INFO - PROCESS | 4688 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45859/tests/kraken/driver.html?testName=imaging-desaturate) 13:33:45 INFO - PROCESS | 4688 | RSS: Main: 185401344 13:33:45 INFO - PROCESS | 4688 | 13:33:48 INFO - PROCESS | 4688 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45859/tests/kraken/driver.html?testName=json-parse-financial) 13:33:48 INFO - PROCESS | 4688 | RSS: Main: 186540032 13:33:48 INFO - PROCESS | 4688 | 13:33:50 INFO - PROCESS | 4688 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45859/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:33:51 INFO - PROCESS | 4688 | RSS: Main: 186769408 13:33:51 INFO - PROCESS | 4688 | 13:33:53 INFO - PROCESS | 4688 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45859/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:33:53 INFO - PROCESS | 4688 | RSS: Main: 187441152 13:33:53 INFO - PROCESS | 4688 | 13:33:55 INFO - PROCESS | 4688 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45859/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:33:56 INFO - PROCESS | 4688 | RSS: Main: 187666432 13:33:56 INFO - PROCESS | 4688 | 13:33:59 INFO - PROCESS | 4688 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:34:00 INFO - PROCESS | 4688 | RSS: Main: 187748352 13:34:00 INFO - PROCESS | 4688 | 13:34:03 INFO - PROCESS | 4688 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:34:03 INFO - PROCESS | 4688 | RSS: Main: 187265024 13:34:03 INFO - PROCESS | 4688 | 13:34:05 INFO - PROCESS | 4688 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45859/tests/kraken/driver.html?testName=ai-astar) 13:34:05 INFO - PROCESS | 4688 | RSS: Main: 188334080 13:34:05 INFO - PROCESS | 4688 | 13:34:05 INFO - PROCESS | 4688 | __start_tp_report 13:34:05 INFO - PROCESS | 4688 | _x_x_mozilla_page_load 13:34:05 INFO - PROCESS | 4688 | _x_x_mozilla_page_load_details 13:34:05 INFO - PROCESS | 4688 | |i|pagename|runs| 13:34:05 INFO - PROCESS | 4688 | |0;ai-astar;106;114;107;114;115;116;115;115;115;114 13:34:05 INFO - PROCESS | 4688 | |1;audio-beat-detection;163;133;160;180;132;163;154;140;193;132 13:34:05 INFO - PROCESS | 4688 | |2;audio-dft;166;168;171;163;163;164;163;166;165;164 13:34:05 INFO - PROCESS | 4688 | |3;audio-fft;76;76;77;157;78;79;77;76;169;76 13:34:05 INFO - PROCESS | 4688 | |4;audio-oscillator;87;88;147;88;89;88;138;87;88;144 13:34:05 INFO - PROCESS | 4688 | |5;imaging-gaussian-blur;120;118;118;119;118;118;119;120;117;118 13:34:05 INFO - PROCESS | 4688 | |6;imaging-darkroom;150;149;148;148;152;147;148;150;149;147 13:34:05 INFO - PROCESS | 4688 | |7;imaging-desaturate;97;96;96;95;96;97;97;97;97;96 13:34:05 INFO - PROCESS | 4688 | |8;json-parse-financial;65;66;65;64;65;64;64;64;63;65 13:34:05 INFO - PROCESS | 4688 | |9;json-stringify-tinderbox;65;66;64;66;66;66;65;66;66;66 13:34:05 INFO - PROCESS | 4688 | |10;stanford-crypto-aes;83;83;86;84;83;88;85;84;97;84 13:34:05 INFO - PROCESS | 4688 | |11;stanford-crypto-ccm;144;133;134;132;131;135;132;137;140;144 13:34:05 INFO - PROCESS | 4688 | |12;stanford-crypto-pbkdf2;168;178;175;170;171;171;171;185;170;173 13:34:05 INFO - PROCESS | 4688 | |13;stanford-crypto-sha256-iterative;69;69;69;69;73;68;67;69;70;73 13:34:05 INFO - PROCESS | 4688 | __end_tp_report 13:34:05 INFO - PROCESS | 4688 | __start_cc_report 13:34:05 INFO - PROCESS | 4688 | _x_x_mozilla_cycle_collect,958 13:34:05 INFO - PROCESS | 4688 | __end_cc_report 13:34:05 INFO - PROCESS | 4688 | __startTimestamp1467059645735__endTimestamp 13:34:05 INFO - PROCESS | 4688 | 13:34:05 INFO - PROCESS | 4688 | ------- Summary: start ------- 13:34:05 INFO - PROCESS | 4688 | Number of tests: 14 13:34:05 INFO - PROCESS | 4688 | 13:34:05 INFO - PROCESS | 4688 | [#0] ai-astar Cycles:10 Average:113.10 Median:115.00 stddev:3.54 (3.1%) stddev-sans-first:2.67 13:34:05 INFO - PROCESS | 4688 | Values: 106.0 114.0 107.0 114.0 115.0 116.0 115.0 115.0 115.0 114.0 13:34:05 INFO - PROCESS | 4688 | 13:34:05 INFO - PROCESS | 4688 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:161.50 stddev:21.06 (13.0%) stddev-sans-first:22.13 13:34:05 INFO - PROCESS | 4688 | Values: 163.0 133.0 160.0 180.0 132.0 163.0 154.0 140.0 193.0 132.0 13:34:05 INFO - PROCESS | 4688 | 13:34:05 INFO - PROCESS | 4688 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.50 stddev:2.58 (1.6%) stddev-sans-first:2.73 13:34:05 INFO - PROCESS | 4688 | Values: 166.0 168.0 171.0 163.0 163.0 164.0 163.0 166.0 165.0 164.0 13:34:05 INFO - PROCESS | 4688 | 13:34:05 INFO - PROCESS | 4688 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.50 stddev:36.44 (47.6%) stddev-sans-first:38.05 13:34:05 INFO - PROCESS | 4688 | Values: 76.0 76.0 77.0 157.0 78.0 79.0 77.0 76.0 169.0 76.0 13:34:05 INFO - PROCESS | 4688 | 13:34:05 INFO - PROCESS | 4688 | [#4] audio-oscillator Cycles:10 Average:104.40 Median:88.00 stddev:26.73 (30.4%) stddev-sans-first:27.60 13:34:05 INFO - PROCESS | 4688 | Values: 87.0 88.0 147.0 88.0 89.0 88.0 138.0 87.0 88.0 144.0 13:34:05 INFO - PROCESS | 4688 | 13:34:05 INFO - PROCESS | 4688 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.50 stddev:0.97 (0.8%) stddev-sans-first:0.87 13:34:05 INFO - PROCESS | 4688 | Values: 120.0 118.0 118.0 119.0 118.0 118.0 119.0 120.0 117.0 118.0 13:34:05 INFO - PROCESS | 4688 | 13:34:05 INFO - PROCESS | 4688 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:1.55 (1.0%) stddev-sans-first:1.58 13:34:05 INFO - PROCESS | 4688 | Values: 150.0 149.0 148.0 148.0 152.0 147.0 148.0 150.0 149.0 147.0 13:34:05 INFO - PROCESS | 4688 | 13:34:05 INFO - PROCESS | 4688 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 13:34:05 INFO - PROCESS | 4688 | Values: 97.0 96.0 96.0 95.0 96.0 97.0 97.0 97.0 97.0 96.0 13:34:05 INFO - PROCESS | 4688 | 13:34:05 INFO - PROCESS | 4688 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 13:34:05 INFO - PROCESS | 4688 | Values: 65.0 66.0 65.0 64.0 65.0 64.0 64.0 64.0 63.0 65.0 13:34:05 INFO - PROCESS | 4688 | 13:34:05 INFO - PROCESS | 4688 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 13:34:05 INFO - PROCESS | 4688 | Values: 65.0 66.0 64.0 66.0 66.0 66.0 65.0 66.0 66.0 66.0 13:34:05 INFO - PROCESS | 4688 | 13:34:05 INFO - PROCESS | 4688 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:84.50 stddev:4.27 (5.1%) stddev-sans-first:4.42 13:34:05 INFO - PROCESS | 4688 | Values: 83.0 83.0 86.0 84.0 83.0 88.0 85.0 84.0 97.0 84.0 13:34:05 INFO - PROCESS | 4688 | 13:34:05 INFO - PROCESS | 4688 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:136.00 stddev:4.89 (3.6%) stddev-sans-first:4.30 13:34:05 INFO - PROCESS | 4688 | Values: 144.0 133.0 134.0 132.0 131.0 135.0 132.0 137.0 140.0 144.0 13:34:05 INFO - PROCESS | 4688 | 13:34:05 INFO - PROCESS | 4688 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:172.00 stddev:5.03 (2.9%) stddev-sans-first:4.97 13:34:05 INFO - PROCESS | 4688 | Values: 168.0 178.0 175.0 170.0 171.0 171.0 171.0 185.0 170.0 173.0 13:34:05 INFO - PROCESS | 4688 | 13:34:05 INFO - PROCESS | 4688 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.00 stddev:1.96 (2.8%) stddev-sans-first:2.06 13:34:05 INFO - PROCESS | 4688 | Values: 69.0 69.0 69.0 69.0 73.0 68.0 67.0 69.0 70.0 73.0 13:34:05 INFO - PROCESS | 4688 | -------- Summary: end -------- 13:34:05 INFO - PROCESS | 4688 | 13:34:06 INFO - TEST-INFO | 4688: exit 0 13:34:06 INFO - TEST-OK | kraken | took 65370ms 13:34:06 INFO - SUITE-END | took 1181s 13:34:07 INFO - Completed test suite (00:19:42) 13:34:07 INFO - javascript benchmark 13:34:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6363.039663966899, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2619.8166128371017, 2651.6155157502158, 2662.3077999720067, 2685.1810197889636, 2693.501702185096, 4784.473707892129, 4809.711417314964, 4902.166631672615, 4903.705777653343, 4921.852344429664, 4789.497102804207, 4801.351817504645, 4852.199387101133, 4906.0, 4909.729964851932, 4414.867553973378, 4439.977800111011, 4551.2717965125585, 4570.680052396334, 4586.885327866797, 492.0691161964206, 4243.745375277494, 4405.31717583775, 4410.64714822815, 4555.430571178603, 4508.887277818048, 4552.613027892633, 4558.954410455886, 4570.10882877839, 4595.058013107305, 4556.977215113936, 4569.794359253841, 4573.6569757268335, 4573.725576465389, 4625.213713668651, 4418.403515525395, 4494.07871386365, 4520.028193938286, 4558.544145585448, 4562.680612357136, 4882.511748825124, 4942.579880710144, 4969.503049695001, 4970.304157417928, 5041.546260836506, 5014.724190169539, 5286.471352864722, 5312.389075256357, 5326.813561525328, 5359.222912677679, 5167.715775632339, 5239.47605239473, 5252.684838909678, 5264.2893209416625, 5274.815381461631, 4897.363342765453, 4900.534449227318, 4909.828156014522, 4954.331165292711, 4957.0, 5212.139996900469, 5280.683159010472, 5440.292761941001, 5471.699056551848, 5480.7533660985355, 5139.820106296336, 5168.870778230575, 5174.0, 5205.713685747321, 5219.060569097599, 5268.762905669254, 5296.682199068068, 5300.893982120413, 5310.309659744208, 5347.171188465794, 5035.496450354935, 5111.463296353903, 5231.450697676765, 5233.633645644768, 5235.764390602432, 5166.45752196014, 5177.430482646906, 5228.2680424740565, 5244.816431424882, 5279.9208011879855, 4439.1121775645, 4472.8210871565425, 4475.776211189427, 4479.350494178326, 4521.819127234874, 3829.215010922754, 3867.5165604299464, 3893.182431689377, 3917.0, 3935.35066713989, 4527.954720452819, 4531.546845315442, 4553.954460455353, 4588.885277868013, 4608.470025947059, 5286.577073834084, 5298.311219541435, 5306.893862122736, 5308.389535203424, 5312.123499622519, 4419.867403977886, 4458.331250312479, 4499.032707967803, 4532.501424843264, 4537.319402089713, 4657.953420465819, 4747.406574178228, 4776.928346074812, 4778.522147785263, 4813.638977076664, 4897.877553061202, 4908.852734417973, 4936.580390666833, 4966.404031516241, 4991.625628077836, 5113.463086376026, 5194.7922083116255, 5195.298634684269, 5311.044012077708, 5317.867053323543, 4914.631402644744, 4931.7040977541465, 4936.7284799336385, 4948.579370753526, 4983.626228032985, 5225.503577160163, 5229.843104706865, 5236.345456817898, 5238.738063096906, 5240.34495688039, 5160.380754309507, 5169.586433085269, 5173.1205695031185, 5220.556252718561, 5270.262163297065, 5053.166227572409, 5075.670081444694, 5082.085224659449, 5100.489951005018, 5108.974455127701, 4923.310736496822, 5071.822486212965, 5073.974630126973, 5078.339815823919, 5079.898402031865, 4900.926486102782, 4933.679310844784, 4989.700617962933, 5006.974965125297, 5020.246962955586, 5080.415752188545, 5083.87290317745, 5084.949150508448, 5141.7686204120155, 5147.6911385317, 5008.724520151427, 5014.974925125351, 5043.067032598981, 5058.974705126451, 5079.5428411443145], "value": 4781.314156860214, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.4853259267769, 585.787420040516, 586.0505980311892, 590.2444870565674, 596.8090211132434, 35203.64796352039, 35999.640003599954, 36028.27943441133, 36188.63811361886, 36230.0, 40357.0, 40959.0, 40988.38517422241, 41021.384679229835, 41088.58911410885, 7682.731104411333, 7793.259640334188, 7829.608519574027, 7836.451448398614, 7888.881666775003, 7640.235976402371, 7688.769336919873, 7691.461597688164, 7718.498297610638, 7735.381169506454, 7649.082110146763, 7697.230276972314, 7725.150233474314, 7743.419243556727, 7753.263439973193, 7672.808179795494, 7719.536827790323, 7720.845583088307, 7726.150123486412, 7727.49771264866, 7644.388448924073, 7723.575203363813, 7746.109197442253, 7757.069151701776, 7768.7669369918995, 37502.81248593739, 37568.43647345292, 37580.62419375826, 37630.43554346687, 37767.62232377668, 2549.61755736641, 2907.1278616414993, 2921.795474316799, 3020.9728692244744, 3090.8300043497597, 26011.479770404487, 27191.184264472096, 27862.164135075982, 28331.85834070837, 28561.85719071412, 3172.159377764894, 3190.96809031909, 3211.935761284785, 3282.9658657522805, 3329.900102996914, 226483.0, 231556.0, 234351.0, 235030.8248458764, 235196.0, 29175.0, 29678.258043549085, 29920.102396928127, 31869.84065079706, 31965.0, 32150.35699286001, 32254.35491290208, 32260.516092258636, 32334.35331293361, 32507.34985300281, 13175.209487430784, 13355.46578136883, 13385.330733463483, 13431.126976746677, 13444.663883402993, 10505.159587233004, 10542.947285263524, 10603.681889543326, 10671.786564268672, 10678.09236214915, 7719.768406947801, 7796.142424333319, 7810.258025487569, 7834.529928204326, 7866.881996770053, 3081.443870845209, 3126.45287074761, 3139.968600314013, 3142.5600415941785, 3150.480170771797, 870.303756994402, 884.3014018924977, 903.3721563513426, 903.810199858024, 986.8569057486624, 28272.71727282742, 28511.857440712665, 29262.853685731436, 29263.561046584317, 29267.121986340444, 962.9951850240705, 994.7165057958592, 1026.2200727447193, 1042.5829668132808, 1087.1194332590626, 15132.697346053237, 15502.612434688997, 15571.143587102819, 15610.843891561166, 15720.29258683362, 394413.0, 395485.0, 395543.0, 395558.0, 396745.0, 51288.74355628198, 51527.484725153015, 52007.73996129995, 52036.0, 52095.73952130291, 1154.1747650429816, 1180.409795102466, 1192.1118766518998, 1196.4376742930808, 1198.0714945916984, 27592.0, 28156.577651335658, 28368.886511456138, 29037.274068148465, 29217.85391073031, 44436.77781611071, 44576.55423445854, 44706.0, 45022.0, 45064.774676126406, 316198.77105529845, 317420.0, 317811.0, 318347.0, 320069.0, 25448.491030179663, 25456.23631291064, 27995.58006629943, 28168.29579260535, 28247.15258542247, 43660.126797463236, 43708.0, 43929.34105988477, 44192.89627528801, 45376.0, 37068.0, 37210.25579488449, 37476.62523374731, 37559.81220093882, 38307.2338553233, 37211.25577488489, 37264.06839829026, 37887.86336409802, 38071.238575227784, 38301.808490957366, 32103.0, 36229.0, 36894.0, 37123.62876371202, 37232.627673724, 32076.839615802706, 34161.658383415845, 34288.82855585806, 34594.0, 34851.65148348585, 25196.622050669623, 25839.483210336064, 25873.870630646725, 26073.869630651727, 26384.60423093617], "value": 16265.591047733078, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.8165917041479, 370.56273597155354, 376.6346643755556, 382.6345839723065, 392.46428624926983, 15877.841221587794, 16571.254293556787, 17578.560535986606, 17588.736168957475, 17596.384126555575, 15945.362185512595, 16533.25600347984, 16859.325626974907, 17045.06252156134, 17071.658566828657, 4819.493953134915, 4969.055879382906, 4985.052839960396, 5019.799208031693, 5042.672226305297, 3686.2811751708427, 5004.524570165829, 5490.450954904518, 5898.999999999978, 5900.498457631106, 5867.061270196769, 5939.346671866091, 5942.286925568917, 5960.761569537213, 5982.910256346158, 5838.649681019131, 5937.524998000171, 5955.910661340084, 6103.450689437972, 6268.467180289681, 5399.919001214985, 5421.756020979065, 5441.29263195782, 5450.945490545084, 5520.751566179491, 20903.8954805225, 21159.5768084639, 21238.51330406872, 21360.679589806165, 21612.567748645095, 2076.968845467319, 2468.0744720729726, 2489.9751002489925, 2494.0273293415585, 2495.301315631626, 12177.269363838199, 12235.877641223562, 13151.802722959163, 13590.932045339809, 13600.727985440335, 1694.4831826292975, 1745.432734361325, 1802.5716954508348, 1847.0856925821804, 1878.4646375782836, 64178.679106604635, 66613.3338666612, 66811.66594166998, 67137.66431167813, 67708.6614566924, 9822.361546499455, 9922.0, 9931.453770042572, 10170.542325595366, 10221.182305415548, 13551.051426400254, 13643.680574302392, 13703.246321452416, 13771.586852394445, 13773.724525509433, 7342.229065948105, 7466.887996680054, 7507.8498430031095, 7647.426443016796, 7656.770296891103, 7070.858582828418, 7157.642117894085, 7202.71189152428, 7218.855622887513, 7337.486375953738, 6239.844003899848, 6348.714307856158, 6364.395382438661, 6401.996460458557, 6458.257300410419, 1667.7748503951811, 1684.3094331324098, 1722.7329763886617, 1853.4347024157762, 1863.3850829226324, 876.5660997806, 915.7802127489355, 922.8062106957614, 929.6281487405092, 952.2477242978108, 17689.734653980202, 17835.910820445813, 17992.280308787504, 18271.634567308578, 18308.80294364658, 878.7407714724171, 918.4581097152712, 924.8612708093705, 969.9175570076482, 997.5909876950416, 10171.0, 10182.389056656624, 10213.642522511676, 10282.126019288444, 10358.274920755475, 358697.0, 360642.0, 361264.0, 376669.0, 395276.0, 68908.6554567224, 69950.30049699539, 70154.64922675354, 70622.0, 76149.0, 872.7512658892313, 886.9290456763443, 923.4044041593135, 926.749777560055, 929.6095639831287, 15118.0, 15341.769873452131, 15477.690446190787, 15721.135337556545, 16026.038437693776, 33624.0, 33804.492932606525, 35097.47353789644, 37093.0, 38302.42546361862, 44686.77656611696, 47316.52683473259, 49215.507844922526, 51411.742941285054, 52659.73670131625, 7653.464257501922, 7701.845963080819, 7795.947547081071, 7819.0, 7855.2930236276725, 8325.167483251626, 10995.965746336953, 11012.50443730018, 11540.480678369326, 11955.880441195477, 9521.761955951157, 10024.448655324028, 10049.748756280858, 10240.078392944373, 10327.48362581853, 10613.469326533797, 10665.786684266426, 10708.143348532254, 10861.837072444077, 11123.221374503708, 10040.899591003996, 10210.693679189637, 10241.487925603838, 10392.37645741258, 10612.097971672185, 7954.5624990626075, 7982.920170798217, 7984.880226796487, 8100.959495202486, 8147.063087744985, 8731.825363492822, 9888.208943284664, 9945.104940555384, 10204.897951020692, 10218.131458826083], "value": 8485.136878116211, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.366964361572, 1407.6621610813404, 1467.3983666696656, 1666.0919798709701, 1686.9746953795695, 6644.269130395653, 7136.215016348197, 7333.449991250657, 7687.154413014571, 7744.92255077449, 7215.81960450989, 7412.629368531579, 7415.110186777581, 7443.106827180746, 7525.774226773206, 2147.6241657709916, 2161.6757486377014, 2164.3831508020216, 2184.5958497677902, 2189.1899997001133, 2115.2808045264605, 2126.7873212678765, 2138.6043581937392, 2159.9352019439443, 2183.268605017321, 2158.0, 2171.229213629155, 2190.11300423328, 2193.6819161221615, 2198.7251593550805, 2130.968035479469, 2138.0699395762817, 2138.550904310097, 2138.8823614701187, 2145.2169957965384, 2116.333354993172, 2119.7138386317956, 2147.108949785837, 2149.0, 2162.535054963175, 7416.406687465043, 7473.364763995012, 7499.287567681062, 7524.661390237453, 7532.246775322424, 4368.650507959387, 4450.0, 4486.7980940857415, 4495.168393847149, 4512.796924138422, 2728.208819442379, 2736.7263273672675, 2822.0969289827262, 2834.093090211133, 2844.1183233197776, 863.5984267315665, 870.4168207301124, 875.0855356152836, 887.0, 928.6796055360958, 10343.069123778821, 10376.533056012497, 10389.168866490663, 10462.529186186564, 10476.266661333633, 4121.814518346681, 4145.0, 4216.47294088239, 4231.830726770956, 4277.144571085795, 8846.982597001299, 8875.0, 8877.245434138042, 8913.5097569633, 8925.062868398725, 4593.678442508993, 4614.861554153381, 4631.143238500888, 4640.512746161672, 4655.930161047587, 3571.4464258040043, 3813.161104556993, 3952.8616498422416, 4026.053877338823, 4121.9381709274385, 3603.9639603603628, 3605.441156620728, 3641.9271614568092, 3642.745007849478, 3699.5375578052744, 1156.1733360647177, 1175.6061719323952, 1175.9529618815152, 1182.343799191457, 1183.0, 698.5284932670427, 808.18373442822, 811.8295158016882, 839.5004972041626, 841.6128580852876, 5015.774290156952, 5296.25852380667, 5304.098303288451, 5306.495882891119, 5316.096263635114, 408.98773036808944, 413.2685147289281, 422.11356152080384, 428.39596169400994, 429.47174974781194, 3350.1289664687356, 3545.982270088633, 3555.7866528008403, 3584.193556449778, 3666.1018050577777, 9084.772880678036, 9420.152186303265, 9424.481653509123, 9456.90543094574, 9477.668281610111, 9375.765605859908, 9376.62493500266, 9411.858822117674, 9421.0, 9509.381890177116, 7093.964530177419, 7184.137903451619, 7296.963515182496, 7307.01355317036, 7347.191808901017, 5278.287431196739, 5351.625386222927, 5421.891562168814, 5425.647332923348, 5548.916766248591, 7983.401244906771, 8257.83484330322, 8309.584520773817, 8379.0, 8434.198751118634, 8376.246137847624, 8376.623051962799, 8528.275096616857, 8536.146385361415, 8577.356698247531, 6021.608595441282, 6509.772157974448, 6597.406233439014, 6680.064790929371, 6722.831929201809, 7372.336489715952, 7430.071241094864, 7527.736529221451, 7552.320291173821, 7567.205443428361, 6426.678666066771, 6768.4585233182215, 6811.114555107804, 6848.2124555674745, 6954.513184077066, 6625.569337993015, 6654.101696270942, 6655.134832471747, 6656.800295991128, 6766.391024807791, 6138.355472675484, 6232.065190221322, 6243.469305109116, 6249.625022498664, 6290.779822706183, 4560.498345181961, 4581.7709114544805, 4700.6474514410875, 4705.529447055267, 4715.339852420732, 4502.810515868131, 4599.425071866017, 4680.063987202505, 4709.4584122824945, 4747.83382581608], "value": 3988.377752377306, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.23423450380767, 296.5699735383693, 297.47941103069627, 310.20277885833417, 310.76537214403135, 4905.718840739056, 4935.210366341386, 5097.260897169908, 5105.974470127644, 5151.793928242871, 5004.7497625118685, 5033.219850923104, 5044.218146187338, 5060.735825392629, 5077.923831142536, 3999.9600003999954, 4003.239384516947, 4003.319435695939, 4004.8598299059395, 4015.5382131054866, 3928.7249892507393, 4024.356103023517, 4031.3549832026883, 4031.4355990161403, 4036.2331157080207, 3950.1309711863346, 3978.18447218321, 4004.3993400989793, 4024.235395274903, 4025.866290865831, 3982.5420076691116, 4008.779517126557, 4022.7760851106223, 4023.839046438139, 4026.8993275168064, 3262.7879187852714, 3373.881914133018, 3406.318736252759, 3420.8973730788116, 3550.5797680927576, 4923.113839508887, 4928.876778080541, 4955.851324460236, 4964.255361695738, 4988.850334489971, 4454.910901781978, 4473.977630111861, 4475.59719625232, 4480.507144214133, 4520.4575450946095, 5026.567428282922, 5235.267062611238, 5249.947500524984, 5274.861457432821, 5290.629655924087, 3645.8359373827975, 3666.24841907411, 3671.7429779915415, 3677.2829298286847, 3686.963130368689, 5514.0, 5560.36055853578, 5561.916571251394, 5569.721513924328, 5574.0, 3650.1175453158485, 3772.0569857535615, 3787.6401741835034, 3794.1083845296334, 3829.119302560371, 3819.694424446038, 3824.388097904322, 3829.8659546915724, 3832.9233415331537, 3859.459675645412, 4352.912941741148, 4412.0, 4464.933026004613, 4464.977675111603, 4481.865544033684, 5284.973575132177, 5293.550048245866, 5316.893662126736, 5332.68003919766, 5337.439568845293, 1283.3390803736083, 1321.6035189443128, 1326.1181314425799, 1328.4287756264705, 1330.5164741313365, 818.6193420059582, 834.8145633200749, 844.8268105038452, 850.6087199887997, 857.1557016338901, 4137.8689974663075, 4155.4182414462, 4155.625993660585, 4222.451081359403, 4234.407182994383, 4821.349117869043, 4834.404646466657, 4842.789302674331, 4843.878903027453, 4864.610831133572, 4133.937990930139, 4134.937975930364, 4167.395727619539, 4171.228322760238, 4206.48566516054, 2472.8887200076038, 2581.690197176351, 2594.779443747265, 2618.6726659167603, 2629.526685196645, 4492.4725593298435, 4541.205289074399, 4544.295634176708, 4559.977200113978, 4581.473130589959, 4852.811061290006, 4922.572453988375, 4932.753362331869, 4933.407991041098, 4940.382452193476, 4384.8903777405185, 4508.024703695611, 4517.661175411858, 4537.3647689323525, 4572.931406028979, 4771.976140119277, 4811.302361157543, 4819.566239038503, 4838.540338667821, 4844.370231869834, 4703.882402939954, 4732.384789977281, 4736.313234581035, 4740.5733483986605, 4803.423589169322, 4536.72779633223, 4776.59398951093, 5163.328767260232, 5163.3545806774155, 5168.58651307887, 3584.0860580552835, 3694.649008344203, 3790.128270497856, 3801.6198380161763, 3870.0, 5457.017736807413, 5547.140193270049, 5548.250986116984, 5557.0, 5560.36055853582, 5274.233131900856, 5308.601854860824, 5333.7866485340155, 5336.919946200733, 5370.865728356823, 5141.717205553581, 5180.507851754077, 5230.843074707765, 5288.805145864423, 5300.337457817773, 5168.198929165986, 5177.223416487557, 5187.703074231442, 5201.843944681666, 5205.943652257413, 5137.332146821039, 5288.127458969381, 5289.18017707256, 5303.257543943774, 5323.1216849219445, 5137.409197942135, 5150.253213284128, 5189.558887494454, 5213.139831927841, 5214.21786731978], "value": 3852.3851023055454, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.5325898500543, 682.2836022176716, 730.565313638385, 758.2909979169477, 770.8458308338334, 11867.109966752485, 14173.362198701057, 14631.41474341025, 14758.70482590349, 15205.315760790763, 13516.729665406687, 13603.795943060863, 13647.044706870523, 13710.45158193671, 13716.0, 620.7889317632004, 802.9317508011811, 803.3693550562809, 804.2600807257309, 804.5574933786423, 775.5191781095729, 794.4716763352363, 802.0495712580581, 805.1746959366637, 805.3275514944999, 835.5780330932901, 846.8687353460224, 847.1443841719877, 851.7189327521903, 858.0, 832.4797001873828, 832.5046597274612, 834.0991728932738, 836.6444261188971, 840.1136800675285, 623.6164758673383, 625.7622103600648, 625.7747211004034, 626.2047200055949, 627.3193584960324, 13327.466901323935, 13334.133281336779, 13347.733045339135, 13366.933165334209, 13412.597622071353, 12935.935320323339, 13002.804957925639, 13345.332733363293, 13381.66545836352, 13393.866061339359, 10602.204834637356, 10663.146948244123, 10696.51865666047, 10800.351978881292, 10853.0, 3325.81708006062, 3374.6625337466303, 3383.4924761285756, 3400.7109395701395, 3406.6593340665736, 61123.69438152825, 61538.38461615416, 61562.384376156115, 61713.691431543004, 62852.37147628557, 10546.947265263778, 10577.259591828652, 10624.0, 10627.096696780705, 10717.517711702993, 18688.0, 19005.239790408505, 19043.90478047601, 19132.139053742616, 19137.23451061942, 7083.964580177066, 7097.680604372816, 7161.4628902831455, 7193.460490463236, 7301.671424785897, 3794.165283637595, 4002.0995276062654, 4002.8198731057173, 4039.0, 4063.7358571692744, 3068.8925887593828, 3134.5454909038517, 3164.7784655073924, 3189.7926634768664, 3199.776015678927, 513.2762804445714, 527.3671594087111, 531.6517680919004, 533.2827347217985, 538.6875612144946, 457.4807593381469, 462.4612326639427, 604.2024527623582, 617.1699064757894, 629.7323637454064, 7189.761156913341, 7962.6416811243635, 8060.596970151586, 8203.466774659628, 8309.584520773937, 505.9443461219263, 514.6140394703972, 545.9071957767189, 560.6243816642859, 574.1387918122816, 3687.8524859005875, 3761.736678432538, 3856.3636999895266, 3895.590962948906, 3906.187941853961, 74083.0, 76007.81956992419, 76672.23327766762, 88321.55839220891, 88680.55659721789, 76447.0, 76871.61564192144, 77299.61350193214, 77853.61073194598, 80271.0, 42560.361594576105, 68618.65690671514, 71192.64403678052, 71992.64003680053, 72396.99999999895, 7912.32745216663, 8340.207680270365, 8652.351073669373, 8789.296856251613, 8842.204201621886, 44543.777281113384, 44851.0, 44854.55145448634, 44919.32621010622, 45022.54977450184, 55685.0, 55908.0, 59779.0, 63560.0, 63610.363896360446, 11024.118070554498, 11276.9436152822, 11422.200445969034, 11485.19603627738, 11834.704132396759, 12955.805662915252, 12982.935085324512, 13082.542111026069, 13457.663558411117, 13751.243681597609, 10008.249381296286, 10267.486625668836, 11593.130515211562, 11939.403029848647, 12078.0, 10999.450027498433, 11203.663890083311, 11435.59975400857, 11590.594329198437, 11787.292762433939, 10754.946225268823, 10976.0, 11071.225014248925, 11093.223474356717, 11193.776124477628, 9495.38280011797, 9525.57134928916, 9703.07820757027, 9900.752481188028, 9961.551730172305, 9165.17513423795, 9353.532323383939, 9380.577873995822, 9397.154256116983, 9441.669541566012], "value": 6545.4372291237305, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 107.0, 114.0, 115.0, 116.0, 115.0, 115.0, 115.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 133.0, 160.0, 180.0, 132.0, 163.0, 154.0, 140.0, 193.0, 132.0], "value": 155.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 171.0, 163.0, 163.0, 164.0, 163.0, 166.0, 165.0, 164.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 157.0, 78.0, 79.0, 77.0, 76.0, 169.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 147.0, 88.0, 89.0, 88.0, 138.0, 87.0, 88.0, 144.0], "value": 104.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 118.0, 119.0, 118.0, 118.0, 119.0, 120.0, 117.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 148.0, 148.0, 152.0, 147.0, 148.0, 150.0, 149.0, 147.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 95.0, 96.0, 97.0, 97.0, 97.0, 97.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 64.0, 65.0, 64.0, 64.0, 64.0, 63.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 86.0, 84.0, 83.0, 88.0, 85.0, 84.0, 97.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 133.0, 134.0, 132.0, 131.0, 135.0, 132.0, 137.0, 140.0, 144.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 178.0, 175.0, 170.0, 171.0, 171.0, 171.0, 185.0, 170.0, 173.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 69.0, 73.0, 68.0, 67.0, 69.0, 70.0, 73.0], "value": 69.6, "unit": "score"}]}]} 13:34:07 INFO - Return code: 0 13:34:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:34:07 ERROR - # TBPL SUCCESS # 13:34:07 INFO - Running post-action listener: _resource_record_post_action 13:34:07 INFO - ##### 13:34:07 INFO - ##### Finished run-tests step (success) 13:34:07 INFO - ##### 13:34:07 INFO - Running post-run listener: _resource_record_post_run 13:34:07 INFO - Total resource usage - Wall time: 1200s; CPU: 14.0%; Read bytes: 0; Write bytes: 543506432; Read time: 0; Write time: 649552 13:34:07 INFO - TinderboxPrint: CPU usage
13.6% 13:34:07 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:34:07 INFO - TinderboxPrint: I/O write bytes / time
543,506,432 / 649,552 13:34:07 INFO - TinderboxPrint: CPU idle
8,272.8 (86.4%) 13:34:07 INFO - TinderboxPrint: CPU user
1,236.6 (12.9%) 13:34:07 INFO - TinderboxPrint: Swap in / out
0 / 0 13:34:07 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 245981184; Read time: 0; Write time: 395584 13:34:07 INFO - run-tests - Wall time: 1184s; CPU: 14.0%; Read bytes: 0; Write bytes: 296939520; Read time: 0; Write time: 253956 13:34:08 INFO - Running post-run listener: _upload_blobber_files 13:34:08 INFO - Blob upload gear active. 13:34:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:34:08 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 13:34:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:34:08 INFO - (blobuploader) - INFO - Open directory for files ... 13:34:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:34:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:34:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:34:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:34:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:34:09 INFO - (blobuploader) - INFO - Done attempting. 13:34:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:34:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:34:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:34:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:34:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:34:12 INFO - (blobuploader) - INFO - Done attempting. 13:34:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:34:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:34:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:34:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:34:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:34:13 INFO - (blobuploader) - INFO - Done attempting. 13:34:13 INFO - (blobuploader) - INFO - Iteration through files over. 13:34:13 INFO - Return code: 0 13:34:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:34:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:34:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e03aed8b16276ed9cce567608f47a083f957ed0b9102a0a93449cd961d91e34759fccae7dc85d5c7f71d2a4400fc5448bf2f8ee02d51f3b48d6138a3a357d1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e56ef53ea3a0d2fdd6537cc4ab74545c821982be247168f3ca85900bf545179638303d234647cf1d96d22a649eb33a948cb4291c4585a2c86a99384e234397e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb17b9b889de520fe2e4d5c5cae9dfa3e335cea4951fb7a2c9f3ebd1cb9a663cd91b0dbbd4c807a91fa38bde77da5bb8c51407591beb4145cb7c36634c0bad5d"} 13:34:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:34:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:34:13 INFO - Contents: 13:34:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e03aed8b16276ed9cce567608f47a083f957ed0b9102a0a93449cd961d91e34759fccae7dc85d5c7f71d2a4400fc5448bf2f8ee02d51f3b48d6138a3a357d1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e56ef53ea3a0d2fdd6537cc4ab74545c821982be247168f3ca85900bf545179638303d234647cf1d96d22a649eb33a948cb4291c4585a2c86a99384e234397e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb17b9b889de520fe2e4d5c5cae9dfa3e335cea4951fb7a2c9f3ebd1cb9a663cd91b0dbbd4c807a91fa38bde77da5bb8c51407591beb4145cb7c36634c0bad5d"} 13:34:13 INFO - Running post-run listener: copy_logs_to_upload_dir 13:34:13 INFO - Copying logs to upload dir... 13:34:13 INFO - mkdir: /builds/slave/test/build/upload/logs 13:34:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.015860 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-27 13:34:12.891531) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 13:34:12.895038) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e03aed8b16276ed9cce567608f47a083f957ed0b9102a0a93449cd961d91e34759fccae7dc85d5c7f71d2a4400fc5448bf2f8ee02d51f3b48d6138a3a357d1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e56ef53ea3a0d2fdd6537cc4ab74545c821982be247168f3ca85900bf545179638303d234647cf1d96d22a649eb33a948cb4291c4585a2c86a99384e234397e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb17b9b889de520fe2e4d5c5cae9dfa3e335cea4951fb7a2c9f3ebd1cb9a663cd91b0dbbd4c807a91fa38bde77da5bb8c51407591beb4145cb7c36634c0bad5d"} build_url:https://queue.taskcluster.net/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://queue.taskcluster.net/v1/task/ZlwJm5UDReqSNbwU4W6Yfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e03aed8b16276ed9cce567608f47a083f957ed0b9102a0a93449cd961d91e34759fccae7dc85d5c7f71d2a4400fc5448bf2f8ee02d51f3b48d6138a3a357d1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e56ef53ea3a0d2fdd6537cc4ab74545c821982be247168f3ca85900bf545179638303d234647cf1d96d22a649eb33a948cb4291c4585a2c86a99384e234397e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb17b9b889de520fe2e4d5c5cae9dfa3e335cea4951fb7a2c9f3ebd1cb9a663cd91b0dbbd4c807a91fa38bde77da5bb8c51407591beb4145cb7c36634c0bad5d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 13:34:12.920780) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:34:12.921124) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1467057397.64860-1509201012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:34:13.004671) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 13:34:13.005023) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 13:34:13.005377) ========= ========= Total master_lag: 0.16 =========