builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1466680818.31 results: success (0) buildid: 20160623013034 builduid: f3f0508f62824bc683344d19d3eba38b revision: 0a73cc32722952781b61bad3b69ba5a2fc591621 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 04:20:18.305676) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 04:20:18.306421) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 04:20:18.306735) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 04:20:18.326476) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:20:18.326770) ========= 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=41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 04:20:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-06-23 04:20:18 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093041 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:20:18.436583) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:20:18.436879) ========= 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=41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019067 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:20:18.506796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:20:18.507129) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0a73cc32722952781b61bad3b69ba5a2fc591621 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0a73cc32722952781b61bad3b69ba5a2fc591621 --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=41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 04:20:19,007 truncating revision to first 12 chars 2016-06-23 04:20:19,007 Setting DEBUG logging. 2016-06-23 04:20:19,007 attempt 1/10 2016-06-23 04:20:19,007 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0a73cc327229?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 04:20:19,348 unpacking tar archive at: mozilla-inbound-0a73cc327229/testing/mozharness/ program finished with exit code 0 elapsedTime=0.688924 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:20:19.216027) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 04:20:19.216404) ========= script_repo_revision: 0a73cc32722952781b61bad3b69ba5a2fc591621 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 04:20:19.216863) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 04:20:19.217223) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 04:20:19.230813) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-23 04:20:19.231129) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:20:19 INFO - MultiFileLogger online at 20160623 04:20:19 in /builds/slave/test 04:20:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:20:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:20:19 INFO - {'append_to_log': False, 04:20:19 INFO - 'base_work_dir': '/builds/slave/test', 04:20:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:20:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:20:19 INFO - 'branch': 'Mozilla-Inbound', 04:20:19 INFO - 'buildbot_json_path': 'buildprops.json', 04:20:19 INFO - 'config_files': ('talos/linux_config.py',), 04:20:19 INFO - 'default_actions': ('clobber', 04:20:19 INFO - 'read-buildbot-config', 04:20:19 INFO - 'download-and-extract', 04:20:19 INFO - 'populate-webroot', 04:20:19 INFO - 'create-virtualenv', 04:20:19 INFO - 'install', 04:20:19 INFO - 'run-tests'), 04:20:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:20:19 INFO - 'download_minidump_stackwalk': True, 04:20:19 INFO - 'download_symbols': 'ondemand', 04:20:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:20:19 INFO - 'tooltool.py': '/tools/tooltool.py', 04:20:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:20:19 INFO - '/tools/misc-python/virtualenv.py')}, 04:20:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:20:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:20:19 INFO - 'installer_path': 'installer.exe', 04:20:19 INFO - 'log_level': 'info', 04:20:19 INFO - 'log_name': 'talos', 04:20:19 INFO - 'log_to_console': True, 04:20:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:20:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:20:19 INFO - 'opt_config_files': (), 04:20:19 INFO - 'pip_index': False, 04:20:19 INFO - 'sps_profile': False, 04:20:19 INFO - 'sps_profile_interval': 0, 04:20:19 INFO - 'suite': 'dromaeojs-e10s', 04:20:19 INFO - 'system_bits': '32', 04:20:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:20:19 INFO - 'title': 'talos-linux64-ix-024', 04:20:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:20:19 INFO - 'use_talos_json': True, 04:20:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:20:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:20:19 INFO - 'work_dir': 'build'} 04:20:19 INFO - ##### 04:20:19 INFO - ##### Running clobber step. 04:20:19 INFO - ##### 04:20:19 INFO - Running pre-action listener: _resource_record_pre_action 04:20:19 INFO - Running main action method: clobber 04:20:19 INFO - rmtree: /builds/slave/test/build 04:20:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:20:20 INFO - Running post-action listener: _resource_record_post_action 04:20:20 INFO - ##### 04:20:20 INFO - ##### Finished clobber step (success) 04:20:20 INFO - ##### 04:20:20 INFO - ##### 04:20:20 INFO - ##### Running read-buildbot-config step. 04:20:20 INFO - ##### 04:20:20 INFO - Running pre-action listener: _resource_record_pre_action 04:20:20 INFO - Running main action method: read_buildbot_config 04:20:20 INFO - Using buildbot properties: 04:20:20 INFO - { 04:20:20 INFO - "project": "", 04:20:20 INFO - "product": "firefox", 04:20:20 INFO - "script_repo_revision": "production", 04:20:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:20:20 INFO - "repository": "", 04:20:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:20:20 INFO - "buildid": "20160623013034", 04:20:20 INFO - "pgo_build": "True", 04:20:20 INFO - "basedir": "/builds/slave/test", 04:20:20 INFO - "buildnumber": 900, 04:20:20 INFO - "slavename": "talos-linux64-ix-024", 04:20:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:20:20 INFO - "platform": "ubuntu64_hw", 04:20:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:20:20 INFO - "branch": "mozilla-inbound", 04:20:20 INFO - "repo_path": "integration/mozilla-inbound", 04:20:20 INFO - "revision": "0a73cc32722952781b61bad3b69ba5a2fc591621", 04:20:20 INFO - "stage_platform": "linux64-pgo", 04:20:20 INFO - "builduid": "f3f0508f62824bc683344d19d3eba38b", 04:20:20 INFO - "slavebuilddir": "test" 04:20:20 INFO - } 04:20:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:20:20 INFO - Running post-action listener: _resource_record_post_action 04:20:20 INFO - ##### 04:20:20 INFO - ##### Finished read-buildbot-config step (success) 04:20:20 INFO - ##### 04:20:20 INFO - ##### 04:20:20 INFO - ##### Running download-and-extract step. 04:20:20 INFO - ##### 04:20:20 INFO - Running pre-action listener: _resource_record_pre_action 04:20:20 INFO - Running main action method: download_and_extract 04:20:20 INFO - mkdir: /builds/slave/test/build/tests 04:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:20 INFO - https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:20:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:20:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:20:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/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 04:20:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/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 04:20:21 INFO - Downloaded 1361 bytes. 04:20:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:20:21 INFO - Using the following test package requirements: 04:20:21 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:20:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:20:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:20:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:21 INFO - u'jsshell-linux-x86_64.zip'], 04:20:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:20:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:20:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:20:21 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:20:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:20:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:20:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:21 INFO - https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:20:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:20:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:20:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/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 04:20:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/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 04:20:22 INFO - Downloaded 24270138 bytes. 04:20:22 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'] 04:20:22 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 04:20:24 INFO - Return code: 0 04:20:24 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 04:20:24 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')]} 04:20:24 INFO - https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:20:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:20:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:20:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/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 04:20:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/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 04:20:40 INFO - Downloaded 24270138 bytes. 04:20:40 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'] 04:20:40 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 04:20:41 INFO - Return code: 0 04:20:41 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')]} 04:20:41 INFO - https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:20:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:20:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:20:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/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 04:20:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/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 04:20:43 INFO - Downloaded 14405384 bytes. 04:20:43 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'] 04:20:43 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 04:20:43 INFO - Return code: 0 04:20:43 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')]} 04:20:43 INFO - https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:20:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:20:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:20:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/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 04:20:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/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 04:20:44 INFO - Downloaded 60145882 bytes. 04:20:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:20:44 INFO - mkdir: /builds/slave/test/properties 04:20:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:20:44 INFO - Writing to file /builds/slave/test/properties/build_url 04:20:44 INFO - Contents: 04:20:44 INFO - build_url:https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:20:45 INFO - Running post-action listener: _resource_record_post_action 04:20:45 INFO - Running post-action listener: set_extra_try_arguments 04:20:45 INFO - ##### 04:20:45 INFO - ##### Finished download-and-extract step (success) 04:20:45 INFO - ##### 04:20:45 INFO - ##### 04:20:45 INFO - ##### Running populate-webroot step. 04:20:45 INFO - ##### 04:20:45 INFO - Running pre-action listener: _resource_record_pre_action 04:20:45 INFO - Running main action method: populate_webroot 04:20:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:20:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:20:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:20:45 INFO - '--tppagecycles', 04:20:45 INFO - '7'], 04:20:45 INFO - 'tests': ['tsvgm']}}, 04:20:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:20:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:20:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:20:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:20:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:20:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:20:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:45 INFO - 'talos_options': ['--disable-e10s'], 04:20:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:20:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:20:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:45 INFO - 'talos_options': ['--disable-e10s'], 04:20:45 INFO - 'tests': ['damp', 'tps']}, 04:20:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:45 INFO - 'tests': ['damp', 'tps']}, 04:20:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:20:45 INFO - 'tests': ['dromaeo_dom']}, 04:20:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:20:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:20:45 INFO - 'tests': ['basic_compositor_video']}, 04:20:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:20:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:20:45 INFO - 'tests': ['a11yr', 04:20:45 INFO - 'ts_paint', 04:20:45 INFO - 'tpaint', 04:20:45 INFO - 'sessionrestore', 04:20:45 INFO - 'sessionrestore_no_auto_restore', 04:20:45 INFO - 'tabpaint']}, 04:20:45 INFO - 'other-e10s': {'tests': ['a11yr', 04:20:45 INFO - 'ts_paint', 04:20:45 INFO - 'tpaint', 04:20:45 INFO - 'sessionrestore', 04:20:45 INFO - 'sessionrestore_no_auto_restore', 04:20:45 INFO - 'tabpaint']}, 04:20:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:20:45 INFO - 'ts_paint', 04:20:45 INFO - 'tpaint', 04:20:45 INFO - 'sessionrestore', 04:20:45 INFO - 'sessionrestore_no_auto_restore', 04:20:45 INFO - 'tabpaint']}, 04:20:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:20:45 INFO - 'ts_paint', 04:20:45 INFO - 'tpaint', 04:20:45 INFO - 'sessionrestore', 04:20:45 INFO - 'sessionrestore_no_auto_restore', 04:20:45 INFO - 'tabpaint']}, 04:20:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:20:45 INFO - 'tests': ['a11yr', 04:20:45 INFO - 'ts_paint', 04:20:45 INFO - 'tpaint', 04:20:45 INFO - 'sessionrestore', 04:20:45 INFO - 'sessionrestore_no_auto_restore', 04:20:45 INFO - 'tabpaint']}, 04:20:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:20:45 INFO - 'tests': ['a11yr', 04:20:45 INFO - 'ts_paint', 04:20:45 INFO - 'tpaint', 04:20:45 INFO - 'sessionrestore', 04:20:45 INFO - 'sessionrestore_no_auto_restore', 04:20:45 INFO - 'tabpaint']}, 04:20:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:20:45 INFO - 'tests': ['tsvgx', 04:20:45 INFO - 'tsvgr_opacity', 04:20:45 INFO - 'tart', 04:20:45 INFO - 'tscrollx', 04:20:45 INFO - 'cart']}, 04:20:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:20:45 INFO - 'tsvgr_opacity', 04:20:45 INFO - 'tart', 04:20:45 INFO - 'tscrollx', 04:20:45 INFO - 'cart']}, 04:20:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:45 INFO - 'talos_options': ['--disable-e10s'], 04:20:45 INFO - 'tests': ['tp5o']}, 04:20:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:45 INFO - 'tests': ['tp5o']}, 04:20:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:45 INFO - 'talos_options': ['--disable-e10s', 04:20:45 INFO - '--xperf_path', 04:20:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:20:45 INFO - 'tests': ['tp5n']}, 04:20:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:45 INFO - 'talos_options': ['--xperf_path', 04:20:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:20:45 INFO - 'tests': ['tp5n']}}, 04:20:45 INFO - 'talos.zip': {'path': '', 04:20:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:20:45 INFO - Running post-action listener: _resource_record_post_action 04:20:45 INFO - ##### 04:20:45 INFO - ##### Finished populate-webroot step (success) 04:20:45 INFO - ##### 04:20:45 INFO - ##### 04:20:45 INFO - ##### Running create-virtualenv step. 04:20:45 INFO - ##### 04:20:45 INFO - Running pre-action listener: _resource_record_pre_action 04:20:45 INFO - Running main action method: create_virtualenv 04:20:45 INFO - Creating virtualenv /builds/slave/test/build/venv 04:20:45 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 04:20:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:20:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:20:45 INFO - Using real prefix '/usr' 04:20:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:20:46 INFO - Installing distribute.............................................................................................................................................................................................done. 04:20:48 INFO - Installing pip.................done. 04:20:48 INFO - Return code: 0 04:20:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4a9a7dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', '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 04:20:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:20:48 INFO - Using env: {'DISPLAY': ':0', 04:20:48 INFO - 'HOME': '/home/cltbld', 04:20:48 INFO - 'LANG': 'en_US.UTF-8', 04:20:48 INFO - 'LANGUAGE': 'en_US:en', 04:20:48 INFO - 'LOGNAME': 'cltbld', 04:20:48 INFO - 'MAIL': '/var/mail/cltbld', 04:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:48 INFO - 'MOZ_NO_REMOTE': '1', 04:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:48 INFO - 'NO_EM_RESTART': '1', 04:20:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:48 INFO - 'PWD': '/builds/slave/test', 04:20:48 INFO - 'SHELL': '/bin/bash', 04:20:48 INFO - 'SHLVL': '1', 04:20:48 INFO - 'TERM': 'linux', 04:20:48 INFO - 'TMOUT': '86400', 04:20:48 INFO - 'USER': 'cltbld', 04:20:48 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', 04:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:48 INFO - '_': '/tools/buildbot/bin/python'} 04:20:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:48 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 04:20:48 INFO - Cleaning up... 04:20:48 INFO - Return code: 0 04:20:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4a9a7dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', '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 04:20:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:20:48 INFO - Using env: {'DISPLAY': ':0', 04:20:48 INFO - 'HOME': '/home/cltbld', 04:20:48 INFO - 'LANG': 'en_US.UTF-8', 04:20:48 INFO - 'LANGUAGE': 'en_US:en', 04:20:48 INFO - 'LOGNAME': 'cltbld', 04:20:48 INFO - 'MAIL': '/var/mail/cltbld', 04:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:48 INFO - 'MOZ_NO_REMOTE': '1', 04:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:48 INFO - 'NO_EM_RESTART': '1', 04:20:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:48 INFO - 'PWD': '/builds/slave/test', 04:20:48 INFO - 'SHELL': '/bin/bash', 04:20:48 INFO - 'SHLVL': '1', 04:20:48 INFO - 'TERM': 'linux', 04:20:48 INFO - 'TMOUT': '86400', 04:20:48 INFO - 'USER': 'cltbld', 04:20:48 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', 04:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:48 INFO - '_': '/tools/buildbot/bin/python'} 04:20:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:48 INFO - Downloading/unpacking psutil>=3.1.1 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:20:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:50 INFO - Installing collected packages: psutil 04:20:50 INFO - Running setup.py install for psutil 04:20:50 INFO - building 'psutil._psutil_linux' extension 04:20:50 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 04:20:50 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 04:20:50 INFO - building 'psutil._psutil_posix' extension 04:20:50 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 04:20:50 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 04:20:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:51 INFO - Successfully installed psutil 04:20:51 INFO - Cleaning up... 04:20:51 INFO - Return code: 0 04:20:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4a9a7dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', '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 04:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:20:51 INFO - Using env: {'DISPLAY': ':0', 04:20:51 INFO - 'HOME': '/home/cltbld', 04:20:51 INFO - 'LANG': 'en_US.UTF-8', 04:20:51 INFO - 'LANGUAGE': 'en_US:en', 04:20:51 INFO - 'LOGNAME': 'cltbld', 04:20:51 INFO - 'MAIL': '/var/mail/cltbld', 04:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:51 INFO - 'MOZ_NO_REMOTE': '1', 04:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:51 INFO - 'NO_EM_RESTART': '1', 04:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:51 INFO - 'PWD': '/builds/slave/test', 04:20:51 INFO - 'SHELL': '/bin/bash', 04:20:51 INFO - 'SHLVL': '1', 04:20:51 INFO - 'TERM': 'linux', 04:20:51 INFO - 'TMOUT': '86400', 04:20:51 INFO - 'USER': 'cltbld', 04:20:51 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', 04:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:51 INFO - '_': '/tools/buildbot/bin/python'} 04:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:20:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:20:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:20:53 INFO - Installing collected packages: mozsystemmonitor 04:20:53 INFO - Running setup.py install for mozsystemmonitor 04:20:53 INFO - Successfully installed mozsystemmonitor 04:20:53 INFO - Cleaning up... 04:20:53 INFO - Return code: 0 04:20:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4a9a7dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', '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 04:20:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:20:53 INFO - Using env: {'DISPLAY': ':0', 04:20:53 INFO - 'HOME': '/home/cltbld', 04:20:53 INFO - 'LANG': 'en_US.UTF-8', 04:20:53 INFO - 'LANGUAGE': 'en_US:en', 04:20:53 INFO - 'LOGNAME': 'cltbld', 04:20:53 INFO - 'MAIL': '/var/mail/cltbld', 04:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:53 INFO - 'MOZ_NO_REMOTE': '1', 04:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:53 INFO - 'NO_EM_RESTART': '1', 04:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:53 INFO - 'PWD': '/builds/slave/test', 04:20:53 INFO - 'SHELL': '/bin/bash', 04:20:53 INFO - 'SHLVL': '1', 04:20:53 INFO - 'TERM': 'linux', 04:20:53 INFO - 'TMOUT': '86400', 04:20:53 INFO - 'USER': 'cltbld', 04:20:53 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', 04:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:53 INFO - '_': '/tools/buildbot/bin/python'} 04:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:53 INFO - Downloading/unpacking jsonschema==2.5.1 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:20:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:55 INFO - Downloading functools32-3.2.3-2.tar.gz 04:20:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:20:55 INFO - warning: no files found matching '*.txt' 04:20:55 INFO - no previously-included directories found matching 'build' 04:20:55 INFO - no previously-included directories found matching 'dist' 04:20:55 INFO - no previously-included directories found matching '.git*' 04:20:55 INFO - Installing collected packages: jsonschema, functools32 04:20:55 INFO - Running setup.py install for functools32 04:20:55 INFO - warning: no files found matching '*.txt' 04:20:55 INFO - no previously-included directories found matching 'build' 04:20:55 INFO - no previously-included directories found matching 'dist' 04:20:55 INFO - no previously-included directories found matching '.git*' 04:20:55 INFO - Successfully installed jsonschema functools32 04:20:55 INFO - Cleaning up... 04:20:55 INFO - Return code: 0 04:20:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:20:55 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')]} 04:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:55 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')]} 04:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:55 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 0x7f4a9a7dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', '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 04:20:55 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 04:20:55 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 04:20:55 INFO - Using env: {'DISPLAY': ':0', 04:20:55 INFO - 'HOME': '/home/cltbld', 04:20:55 INFO - 'LANG': 'en_US.UTF-8', 04:20:55 INFO - 'LANGUAGE': 'en_US:en', 04:20:55 INFO - 'LOGNAME': 'cltbld', 04:20:55 INFO - 'MAIL': '/var/mail/cltbld', 04:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:55 INFO - 'MOZ_NO_REMOTE': '1', 04:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:55 INFO - 'NO_EM_RESTART': '1', 04:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:55 INFO - 'PWD': '/builds/slave/test', 04:20:55 INFO - 'SHELL': '/bin/bash', 04:20:55 INFO - 'SHLVL': '1', 04:20:55 INFO - 'TERM': 'linux', 04:20:55 INFO - 'TMOUT': '86400', 04:20:55 INFO - 'USER': 'cltbld', 04:20:55 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', 04:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:55 INFO - '_': '/tools/buildbot/bin/python'} 04:20:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:56 INFO - Downloading/unpacking blobuploader==1.2.4 04:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:58 INFO - Downloading blobuploader-1.2.4.tar.gz 04:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:20:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:20:58 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 04:20:58 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 04:20:58 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 04:20:58 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 04:20:58 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 04:20:58 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 04:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:20:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:20:58 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 04:20:58 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 04:20:58 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 04:20:58 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 04:20:58 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 04:20:58 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 04:20:58 INFO - Downloading docopt-0.6.1.tar.gz 04:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:20:58 INFO - Installing collected packages: blobuploader, requests, docopt 04:20:58 INFO - Running setup.py install for blobuploader 04:20:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:20:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:20:58 INFO - Running setup.py install for requests 04:20:59 INFO - Running setup.py install for docopt 04:20:59 INFO - Successfully installed blobuploader requests docopt 04:20:59 INFO - Cleaning up... 04:20:59 INFO - Return code: 0 04:20:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20: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')]} 04:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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')]} 04:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:59 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 0x7f4a9a7dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', '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 04:20:59 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 04:20:59 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 04:20:59 INFO - Using env: {'DISPLAY': ':0', 04:20:59 INFO - 'HOME': '/home/cltbld', 04:20:59 INFO - 'LANG': 'en_US.UTF-8', 04:20:59 INFO - 'LANGUAGE': 'en_US:en', 04:20:59 INFO - 'LOGNAME': 'cltbld', 04:20:59 INFO - 'MAIL': '/var/mail/cltbld', 04:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:59 INFO - 'MOZ_NO_REMOTE': '1', 04:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:59 INFO - 'NO_EM_RESTART': '1', 04:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:59 INFO - 'PWD': '/builds/slave/test', 04:20:59 INFO - 'SHELL': '/bin/bash', 04:20:59 INFO - 'SHLVL': '1', 04:20:59 INFO - 'TERM': 'linux', 04:20:59 INFO - 'TMOUT': '86400', 04:20:59 INFO - 'USER': 'cltbld', 04:20:59 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', 04:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:59 INFO - '_': '/tools/buildbot/bin/python'} 04:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:59 INFO - Running setup.py (path:/tmp/pip-QdRLZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:59 INFO - Running setup.py (path:/tmp/pip-FnKdqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:59 INFO - Running setup.py (path:/tmp/pip-V6oooo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:59 INFO - Running setup.py (path:/tmp/pip-k9HfR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:59 INFO - Running setup.py (path:/tmp/pip-IvfNsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:00 INFO - Running setup.py (path:/tmp/pip-E9MTdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:00 INFO - Running setup.py (path:/tmp/pip-O_tU67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:00 INFO - Running setup.py (path:/tmp/pip-CDDQJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:00 INFO - Running setup.py (path:/tmp/pip-fn4jTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:00 INFO - Running setup.py (path:/tmp/pip-EqBffr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:00 INFO - Running setup.py (path:/tmp/pip-DlnAhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:00 INFO - Running setup.py (path:/tmp/pip-zM5peg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:00 INFO - Running setup.py (path:/tmp/pip-Y4ivzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:00 INFO - Running setup.py (path:/tmp/pip-6nQ0Hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:00 INFO - Running setup.py (path:/tmp/pip-u3MglD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:00 INFO - Running setup.py (path:/tmp/pip-qRnf0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:00 INFO - Running setup.py (path:/tmp/pip-tc6gMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:21:00 INFO - Running setup.py install for manifestparser 04:21:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:21:01 INFO - Running setup.py install for mozcrash 04:21:01 INFO - Running setup.py install for mozdebug 04:21:01 INFO - Running setup.py install for mozdevice 04:21:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:21:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:21:01 INFO - Running setup.py install for mozfile 04:21:01 INFO - Running setup.py install for mozhttpd 04:21:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:21:01 INFO - Running setup.py install for mozinfo 04:21:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:21:01 INFO - Running setup.py install for mozInstall 04:21:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:21:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:21:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:21:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:21:01 INFO - Running setup.py install for mozleak 04:21:01 INFO - Running setup.py install for mozlog 04:21:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:21:01 INFO - Running setup.py install for moznetwork 04:21:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:21:02 INFO - Running setup.py install for mozprocess 04:21:02 INFO - Running setup.py install for mozprofile 04:21:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:21:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:21:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:21:02 INFO - Running setup.py install for mozrunner 04:21:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:21:02 INFO - Running setup.py install for mozscreenshot 04:21:02 INFO - Running setup.py install for moztest 04:21:02 INFO - Running setup.py install for mozversion 04:21:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:21:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:21:02 INFO - Cleaning up... 04:21:02 INFO - Return code: 0 04:21:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:02 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 0x7f4a9a7dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', '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 04:21:02 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 04:21:02 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 04:21:02 INFO - Using env: {'DISPLAY': ':0', 04:21:02 INFO - 'HOME': '/home/cltbld', 04:21:02 INFO - 'LANG': 'en_US.UTF-8', 04:21:02 INFO - 'LANGUAGE': 'en_US:en', 04:21:02 INFO - 'LOGNAME': 'cltbld', 04:21:02 INFO - 'MAIL': '/var/mail/cltbld', 04:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:02 INFO - 'MOZ_NO_REMOTE': '1', 04:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:02 INFO - 'NO_EM_RESTART': '1', 04:21:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:02 INFO - 'PWD': '/builds/slave/test', 04:21:02 INFO - 'SHELL': '/bin/bash', 04:21:02 INFO - 'SHLVL': '1', 04:21:02 INFO - 'TERM': 'linux', 04:21:02 INFO - 'TMOUT': '86400', 04:21:02 INFO - 'USER': 'cltbld', 04:21:02 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', 04:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:02 INFO - '_': '/tools/buildbot/bin/python'} 04:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:02 INFO - Running setup.py (path:/tmp/pip-8QlNZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:03 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)) 04:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:03 INFO - Running setup.py (path:/tmp/pip-TbgMMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:03 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)) 04:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:03 INFO - Running setup.py (path:/tmp/pip-ZxY1OS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:03 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)) 04:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:03 INFO - Running setup.py (path:/tmp/pip-6Qj3HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:03 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)) 04:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:03 INFO - Running setup.py (path:/tmp/pip-SIq1gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:03 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)) 04:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:03 INFO - Running setup.py (path:/tmp/pip-5bFE1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:03 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)) 04:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:03 INFO - Running setup.py (path:/tmp/pip-DYdl8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:03 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)) 04:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:03 INFO - Running setup.py (path:/tmp/pip-Q5mQJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:03 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)) 04:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:03 INFO - Running setup.py (path:/tmp/pip-Nn9InJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:03 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)) 04:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:03 INFO - Running setup.py (path:/tmp/pip-P6m9Cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:03 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)) 04:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:03 INFO - Running setup.py (path:/tmp/pip-T0QLvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:03 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)) 04:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:03 INFO - Running setup.py (path:/tmp/pip-WjVbEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:03 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)) 04:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:03 INFO - Running setup.py (path:/tmp/pip-bZ31qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:03 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)) 04:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:03 INFO - Running setup.py (path:/tmp/pip-fM1EXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:03 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)) 04:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:03 INFO - Running setup.py (path:/tmp/pip-ful8zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:04 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)) 04:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:04 INFO - Running setup.py (path:/tmp/pip-M3ijLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:04 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)) 04:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:04 INFO - Running setup.py (path:/tmp/pip-Vp8b5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:04 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)) 04:21:04 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)) 04:21:04 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)) 04:21:04 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)) 04:21:04 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)) 04:21:04 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)) 04:21:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21:06 INFO - Downloading blessings-1.6.tar.gz 04:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:21:06 INFO - Installing collected packages: blessings 04:21:06 INFO - Running setup.py install for blessings 04:21:06 INFO - Successfully installed blessings 04:21:06 INFO - Cleaning up... 04:21:06 INFO - Return code: 0 04:21:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:21:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:06 INFO - Reading from file tmpfile_stdout 04:21:06 INFO - Current package versions: 04:21:06 INFO - argparse == 1.2.1 04:21:06 INFO - blessings == 1.6 04:21:06 INFO - blobuploader == 1.2.4 04:21:06 INFO - docopt == 0.6.1 04:21:06 INFO - functools32 == 3.2.3-2 04:21:06 INFO - jsonschema == 2.5.1 04:21:06 INFO - manifestparser == 1.1 04:21:06 INFO - mozInstall == 1.12 04:21:06 INFO - mozcrash == 0.17 04:21:06 INFO - mozdebug == 0.1 04:21:06 INFO - mozdevice == 0.48 04:21:06 INFO - mozfile == 1.2 04:21:06 INFO - mozhttpd == 0.7 04:21:06 INFO - mozinfo == 0.9 04:21:06 INFO - mozleak == 0.1 04:21:06 INFO - mozlog == 3.2 04:21:06 INFO - moznetwork == 0.27 04:21:06 INFO - mozprocess == 0.22 04:21:06 INFO - mozprofile == 0.28 04:21:06 INFO - mozrunner == 6.11 04:21:06 INFO - mozscreenshot == 0.1 04:21:06 INFO - mozsystemmonitor == 0.3 04:21:06 INFO - moztest == 0.7 04:21:06 INFO - mozversion == 1.4 04:21:06 INFO - psutil == 3.1.1 04:21:06 INFO - requests == 1.2.3 04:21:06 INFO - wsgiref == 0.1.2 04:21:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:06 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')]} 04:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:06 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')]} 04:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:06 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 0x7f4a9a7dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', '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 04:21:06 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 04:21:06 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 04:21:06 INFO - Using env: {'DISPLAY': ':0', 04:21:06 INFO - 'HOME': '/home/cltbld', 04:21:06 INFO - 'LANG': 'en_US.UTF-8', 04:21:06 INFO - 'LANGUAGE': 'en_US:en', 04:21:06 INFO - 'LOGNAME': 'cltbld', 04:21:06 INFO - 'MAIL': '/var/mail/cltbld', 04:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:06 INFO - 'MOZ_NO_REMOTE': '1', 04:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:06 INFO - 'NO_EM_RESTART': '1', 04:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:06 INFO - 'PWD': '/builds/slave/test', 04:21:06 INFO - 'SHELL': '/bin/bash', 04:21:06 INFO - 'SHLVL': '1', 04:21:06 INFO - 'TERM': 'linux', 04:21:06 INFO - 'TMOUT': '86400', 04:21:06 INFO - 'USER': 'cltbld', 04:21:06 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', 04:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:06 INFO - '_': '/tools/buildbot/bin/python'} 04:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:06 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)) 04:21:06 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)) 04:21:06 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)) 04:21:06 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)) 04:21:06 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)) 04:21:06 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)) 04:21:06 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)) 04:21:06 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)) 04:21:06 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)) 04:21:06 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)) 04:21:06 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)) 04:21:06 INFO - Cleaning up... 04:21:06 INFO - Return code: 0 04:21:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:21:06 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')]} 04:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:06 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')]} 04:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:06 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 0x7f4a9a7dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', '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 04:21:06 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 04:21:06 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 04:21:06 INFO - Using env: {'DISPLAY': ':0', 04:21:06 INFO - 'HOME': '/home/cltbld', 04:21:06 INFO - 'LANG': 'en_US.UTF-8', 04:21:06 INFO - 'LANGUAGE': 'en_US:en', 04:21:06 INFO - 'LOGNAME': 'cltbld', 04:21:06 INFO - 'MAIL': '/var/mail/cltbld', 04:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:06 INFO - 'MOZ_NO_REMOTE': '1', 04:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:06 INFO - 'NO_EM_RESTART': '1', 04:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:06 INFO - 'PWD': '/builds/slave/test', 04:21:06 INFO - 'SHELL': '/bin/bash', 04:21:06 INFO - 'SHLVL': '1', 04:21:06 INFO - 'TERM': 'linux', 04:21:06 INFO - 'TMOUT': '86400', 04:21:06 INFO - 'USER': 'cltbld', 04:21:06 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', 04:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:06 INFO - '_': '/tools/buildbot/bin/python'} 04:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:21:06 INFO - Cleaning up... 04:21:06 INFO - Return code: 0 04:21:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:21:06 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')]} 04:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:06 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')]} 04:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:06 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 0x7f4a9a7dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, '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': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', '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 04:21:06 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 04:21:06 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 04:21:06 INFO - Using env: {'DISPLAY': ':0', 04:21:06 INFO - 'HOME': '/home/cltbld', 04:21:06 INFO - 'LANG': 'en_US.UTF-8', 04:21:06 INFO - 'LANGUAGE': 'en_US:en', 04:21:06 INFO - 'LOGNAME': 'cltbld', 04:21:06 INFO - 'MAIL': '/var/mail/cltbld', 04:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:06 INFO - 'MOZ_NO_REMOTE': '1', 04:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:06 INFO - 'NO_EM_RESTART': '1', 04:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:06 INFO - 'PWD': '/builds/slave/test', 04:21:06 INFO - 'SHELL': '/bin/bash', 04:21:06 INFO - 'SHLVL': '1', 04:21:06 INFO - 'TERM': 'linux', 04:21:06 INFO - 'TMOUT': '86400', 04:21:06 INFO - 'USER': 'cltbld', 04:21:06 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', 04:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:06 INFO - '_': '/tools/buildbot/bin/python'} 04:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:07 INFO - Downloading/unpacking flake8 04:21:07 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 04:21:07 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 04:21:07 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 04:21:07 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 04:21:07 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 04:21:07 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 04:21:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:21:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:21:09 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 04:21:09 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 04:21:09 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 04:21:09 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 04:21:09 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 04:21:09 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 04:21:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:21:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:21:09 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 04:21:09 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 04:21:09 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 04:21:09 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 04:21:09 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 04:21:09 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 04:21:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:21:09 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 04:21:09 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 04:21:09 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 04:21:09 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 04:21:09 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 04:21:09 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 04:21:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:21:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:21:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:21:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:21:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:21:09 INFO - no previously-included directories found matching 'docs/_build' 04:21:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:21:09 INFO - Running setup.py install for pep8 04:21:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:21:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:21:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:21:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:21:09 INFO - no previously-included directories found matching 'docs/_build' 04:21:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:21:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:21:09 INFO - Cleaning up... 04:21:10 INFO - Return code: 0 04:21:10 INFO - Running post-action listener: _resource_record_post_action 04:21:10 INFO - Running post-action listener: _start_resource_monitoring 04:21:10 INFO - Starting resource monitoring. 04:21:10 INFO - ##### 04:21:10 INFO - ##### Finished create-virtualenv step (success) 04:21:10 INFO - ##### 04:21:10 INFO - ##### 04:21:10 INFO - ##### Running install step. 04:21:10 INFO - ##### 04:21:10 INFO - Running pre-action listener: _resource_record_pre_action 04:21:10 INFO - Running main action method: install 04:21:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:10 INFO - Reading from file tmpfile_stdout 04:21:10 INFO - Detecting whether we're running mozinstall >=1.0... 04:21:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:21:10 INFO - Reading from file tmpfile_stdout 04:21:10 INFO - Output received: 04:21:10 INFO - Usage: mozinstall [options] installer 04:21:10 INFO - Options: 04:21:10 INFO - -h, --help show this help message and exit 04:21:10 INFO - -d DEST, --destination=DEST 04:21:10 INFO - Directory to install application into. [default: 04:21:10 INFO - "/builds/slave/test"] 04:21:10 INFO - --app=APP Application being installed. [default: firefox] 04:21:10 INFO - mkdir: /builds/slave/test/build/application 04:21:10 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'] 04:21:10 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 04:21:27 INFO - Reading from file tmpfile_stdout 04:21:27 INFO - Output received: 04:21:27 INFO - /builds/slave/test/build/application/firefox/firefox 04:21:27 INFO - Running post-action listener: _resource_record_post_action 04:21:27 INFO - ##### 04:21:27 INFO - ##### Finished install step (success) 04:21:27 INFO - ##### 04:21:27 INFO - ##### 04:21:27 INFO - ##### Running run-tests step. 04:21:27 INFO - ##### 04:21:27 INFO - Running pre-action listener: _resource_record_pre_action 04:21:27 INFO - Running main action method: run_tests 04:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:21:27 INFO - Python 2.7.3 04:21:27 INFO - Return code: 0 04:21:27 INFO - grabbing minidump binary from tooltool 04:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:27 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 0x1e5e2e0>, '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 0x1dca140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:21:27 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 04:21:27 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 04:21:27 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 04:21:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:21:27 INFO - Return code: 0 04:21:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:21:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:21:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:21:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:21:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:21:28 INFO - Return code: 0 04:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 04:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 04:21:28 INFO - Using env: {'DISPLAY': ':0', 04:21:28 INFO - 'HOME': '/home/cltbld', 04:21:28 INFO - 'LANG': 'en_US.UTF-8', 04:21:28 INFO - 'LANGUAGE': 'en_US:en', 04:21:28 INFO - 'LOGNAME': 'cltbld', 04:21:28 INFO - 'MAIL': '/var/mail/cltbld', 04:21:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:21:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:28 INFO - 'MOZ_NO_REMOTE': '1', 04:21:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:28 INFO - 'NO_EM_RESTART': '1', 04:21:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:28 INFO - 'PWD': '/builds/slave/test', 04:21:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:21:28 INFO - 'SHELL': '/bin/bash', 04:21:28 INFO - 'SHLVL': '1', 04:21:28 INFO - 'TERM': 'linux', 04:21:28 INFO - 'TMOUT': '86400', 04:21:28 INFO - 'USER': 'cltbld', 04:21:28 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613', 04:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:28 INFO - '_': '/tools/buildbot/bin/python'} 04:21:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 04:21:28 INFO - mozversion application_buildid: 20160623013034 04:21:28 INFO - mozversion application_changeset: 0a73cc32722952781b61bad3b69ba5a2fc591621 04:21:28 INFO - mozversion application_display_name: Nightly 04:21:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:21:28 INFO - mozversion application_name: Firefox 04:21:28 INFO - mozversion application_remotingname: firefox 04:21:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:21:28 INFO - mozversion application_vendor: Mozilla 04:21:28 INFO - mozversion application_version: 50.0a1 04:21:28 INFO - mozversion platform_buildid: 20160623013034 04:21:28 INFO - mozversion platform_changeset: 0a73cc32722952781b61bad3b69ba5a2fc591621 04:21:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:21:28 INFO - mozversion platform_version: 50.0a1 04:21:28 INFO - using testdate: 1466680888 04:21:28 INFO - actual date: 1466680888 04:21:28 INFO - starting webserver on 'localhost:44915' 04:21:28 INFO - SUITE-START | Running 2 tests 04:21:28 INFO - TEST-START | dromaeo_css 04:21:28 INFO - operating with platform_type : linux_ 04:21:28 INFO - Initialising browser for dromaeo_css test... 04:21:28 INFO - TEST-INFO | started process 28226 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiM7UtR/profile http://localhost:44915/getInfo.html) 04:21:33 INFO - PROCESS | 28226 | __metrics Screen width/height:1600/1200 04:21:33 INFO - PROCESS | 28226 | colorDepth:24 04:21:33 INFO - PROCESS | 28226 | Browser inner width/height: 1024/697 04:21:33 INFO - PROCESS | 28226 | __metrics 04:21:34 ERROR - PROCESS | 28226 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:21:35 INFO - TEST-INFO | 28226: exit 0 04:21:35 INFO - Browser initialized. 04:21:35 INFO - Running cycle 1/1 for dromaeo_css test... 04:21:35 INFO - TEST-INFO | started process 28347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiM7UtR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:47 INFO - PROCESS | 28347 | RSS: Main: 184889344 04:21:47 INFO - PROCESS | 28347 | 04:22:36 INFO - PROCESS | 28347 | 1466680956893 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] 04:24:44 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:44915/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44915/tests/dromaeo/cssquery-ext.html) 04:24:45 INFO - PROCESS | 28347 | RSS: Main: 188428288 04:24:45 INFO - PROCESS | 28347 | 04:27:47 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:44915/tests/dromaeo/cssquery-ext.html (next: http://localhost:44915/tests/dromaeo/cssquery-jquery.html) 04:27:48 INFO - PROCESS | 28347 | RSS: Main: 187842560 04:27:48 INFO - PROCESS | 28347 | 04:30:50 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:44915/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44915/tests/dromaeo/cssquery-mootools.html) 04:30:51 INFO - PROCESS | 28347 | RSS: Main: 189067264 04:30:51 INFO - PROCESS | 28347 | 04:33:52 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:44915/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44915/tests/dromaeo/cssquery-prototype.html) 04:33:53 INFO - PROCESS | 28347 | RSS: Main: 187260928 04:33:53 INFO - PROCESS | 28347 | 04:36:55 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:44915/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44915/tests/dromaeo/cssquery-yui.html) 04:36:56 INFO - PROCESS | 28347 | RSS: Main: 188461056 04:36:56 INFO - PROCESS | 28347 | 04:39:59 INFO - PROCESS | 28347 | Cycle 1(1): loaded http://localhost:44915/tests/dromaeo/cssquery-yui.html (next: http://localhost:44915/tests/dromaeo/cssquery-dojo.html) 04:39:59 INFO - PROCESS | 28347 | RSS: Main: 190025728 04:39:59 INFO - PROCESS | 28347 | 04:39:59 INFO - PROCESS | 28347 | __start_tp_report 04:39:59 INFO - PROCESS | 28347 | _x_x_mozilla_page_load 04:39:59 INFO - PROCESS | 28347 | _x_x_mozilla_page_load_details 04:39:59 INFO - PROCESS | 28347 | |i|pagename|runs| 04:39:59 INFO - PROCESS | 28347 | |0;dojo.html;3080.922976925577;3108.766842486814;3131.1389367923825;3142.7485801135913;3155.4162479941197;5290.127129023716;5374.247605335251;5382.0312343778105;5427.348718153827;5455.672659640414;5321.4412486688925;5326.467353264671;5337.786488540453;5379.300690910186;5416.295881535405;4810.230363141906;4870.829520966767;4972.403311602613;5015.648904576681;5069.112905241568;776.4580946259397;4937.23472861707;4993.6005119590345;5021.548060674539;5039.067772462106;4931.284963680264;4931.605471562284;4941.728204948727;4969.975150124263;4991.425986011583;4880.780364883553;4975.577075948549;4993.375828021497;5022.221555658843;5056.165732654108;4853.466118726938;4868.829590964299;4871.732054736988;4875.58557522611;4898.730569818658;5313.38896026958;5420.268263784378;5480.479354461319;5519.806806761784;5569.081101618228;5792.68140252286;5836.358000619928;5919.792807251725;5937.495312898409;5943.257092863392;5916.408359164092;5944.910826337566;5955.464008239279;5967.373425790316;6009.278886533644;5518.2826232589905;5525.364583072957;5529.198266251411;5529.281193444826;5541.113421852484;5763.510101641407;5858.970705146447;5900.76396944126;5912.940870591325;6002.789902353396;5744.310682718101;5745.569082318842;5748.19525266463;5750.166225897222;5769.07694768835;5827.038538641162;5828.271466066742;5831.533477321804;5833.591648584643;5841.591088623841;5665.3768085510565;5740.0815869460685;5765.365809760923;5809.564282678732;5841.474267315962;5583.274174357389;5618.6628802272;5668.149777533321;5672.971635141798;5853.502452291603;4348.543402942709;4354.085642015149;4369.038811461473;4387.188370151533;4398.56014398564;3936.9606303937167;3966.781826999543;3976.224636195914;4010.8796736097966;4013.478247827764;5567.24842146305;5608.803691870765;5618.6628802272;5629.577781666391;5674.432556744293;5739.368669446358;5865.73604187804;5938.495227905676;5945.048792193228;5945.910811337833;5554.611177217636;5581.916271255935;5614.803481878196;5619.634723742944;5622.859428514238;5078.822241221539;5093.898122037538;5105.15764898795;5107.565856902131;5156.432792392834;5863.2670916135485;5991.7902873399225;6113.083037544315;6115.143879856823;6130.080487926846;5806.506446952057;5870.882582348415;5890.145928840208;5916.26046744157;5940.851478713067;6052.425019623129;6091.969540152271;6095.847603809941;6100.908486372619;6117.357677443804;5640.633358831663;5648.4633959773755;5666.291713535808;5793.594448388572;5801.332846722681;5823.213866128188;5836.095405212199;5845.240118784701;5850.444207800252;5888.793892213752;5669.7165141741925;5674.148877668383;5698.20225168485;5699.743511542073;5708.429157084258;5564.276644036249;5612.522935550524;5619.690916999441;5625.606207565431;5676.148577713376;5480.698561579152;5490.862728431821;5533.861653458534;5548.0845660467185;5586.525145362527;5616.606837521498;5682.77268909239;5700.857478563069;5719.971400142973;5731.684757338387;5457.372402173642;5524.364698059774;5560.499555040065;5617.915731263953;5634.971825140848 04:39:59 INFO - PROCESS | 28347 | |1;ext.html;573.2748073686787;605.9030555111177;615.7598536570738;626.9686515674215;635.8982562789953;43011.56988430115;43900.12199756003;43936.340954885665;44148;47826;45260.32109518351;45501.31748023782;45611.315830262574;45870.770646146724;46018.53981460184;8898.199162075429;9013.684521041765;9047.683331083414;9072.954635226815;9085.818283634324;8970.730878073635;9052.094790520929;9060.909390906105;9092.363534552584;9128.58921348541;8829.072947340534;8862.645494180257;8873.822523549525;8885.155910188521;8895.599698013573;9068.455892646429;9114.58984345706;9115.316351273681;9125.543722813833;9141.49721765306;8975.775605609846;9039.54802259891;9057.139571740674;9060.048694887008;9067.7279681609;42551.148977020595;42597.36103958443;42960.14079718419;43099.569004310186;43142.13715725699;3524.788512689221;3610.530631017977;3659.871904483357;3711.6288371162937;4091.652209562191;31815;32186.356272874644;32543.349133017444;32650.836745816356;32689.019329420156;3938.3048817011195;3974.145558704892;3977.164795392942;3981;4034.757914525138;351185;366483;366935;368003;369890;54614.45385546173;58499.41500585025;59357;59450;59613.403865961656;62005.37994619996;62314.68842655848;62481.375186248464;62539.37460625426;62586.374136258055;15182.696346073017;15501.302441390164;15578.454754083552;15584.766228506582;15589.454369097028;11711.414429278502;11838.704032399259;11946.880531194576;12015.699607509881;12040.157188996685;19020.809791902182;19098.33155839567;19120.713189302172;19165.233390664496;19340;6973.965130174418;7049.753258635923;7092.751753688596;7216.530925489827;7306.488545801849;992.8411454167299;1036.9896301036893;1088.6842815583393;1140.5323817234894;1148.4315263944402;30897.845510772302;31590.842045789625;31814.2571233211;31983.52024719631;32305.838470807495;1108.6729414822646;1215.3376409856648;1217.2939694976892;1218.8171774233936;1253.9686507837378;16684.58288542796;16809.243584038748;17020.744688829676;17116.14419279031;17344;422382;423304;428325;428336;429537;57560.71219643875;57840.42159578435;58165.70917145472;58204.4179558199;58285.417145827996;1329.2755448280516;1346.7845144776788;1372.1561239837429;1379.6068120585585;1383.3290853935832;30071.398572028873;30823;30848.228794280323;31313.373732524768;31605;44185.33721994108;44420.777896111606;44486.555134448245;44580.554194458935;44600;372313;376551;377204.2537660455;378133;378709;26973.460530789667;28118;28122.2969425766;28123.156305310873;28172.43655126927;47250;47729;48012.759936201495;48292.7585362071;48320.2751958728;40440;40905.181896362505;41002.58997410107;41781.79109104435;41916;39858;39899.60100399075;40569.59430405658;41219.1756164881;41728.16543669049;38398.42402363911;39819.40270895997;40515.55617772522;41763.1647367057;44710.3293450605;35424.82287588545;37336.81331593324;37777.62222377741;37880.43179352257;37938.62061379351;28081.859590701915;28324;28336.291592710346;28394.85802570974;28789.42421151607 04:39:59 INFO - PROCESS | 28347 | |2;jquery.html;387.5156054931336;390.30330859415915;393.6929195227722;395.4977178982692;417.15526059729046;18393.080345982697;20357.287494937682;20399.592008159845;20403.38789836307;20986.790132098675;18126.637467250646;18145.4556363309;18847;18873.62252754944;19551.217951281968;5026.874328141798;5190.299309593213;5494.478024587658;5694.060480020791;5750.7699692012475;5676.489115979561;5740.1102829061565;5756.654600723949;5768.221290125843;5822.505087067604;5427.83716488504;5712.371639119693;5730.942690573103;5732.885342293152;5804.535637149039;5666.57500687448;5694.288213973254;5706.400827913092;5709.343425506078;5880.647161170344;5839.240898683186;5848.2689663792025;5850.3564607893095;5880;5888.941110588882;13673.453061877513;13782.793258101137;21420.892895535577;22872.428189295235;22899;2328;2397.4725560376687;2497;2519.508695804319;2643.1013455425054;9775.120239178437;10299.897001029969;10323.432211228379;11218;13910.234937078456;1860.8604354673453;1898.221729091066;1924.788273289937;1945.396926952635;1946.912388942501;68744;78934.60532697357;82732.58633706853;83043.99999999939;84775.57612211962;9910.900890990997;10277.486125693686;11102;11110.777784444266;11278.774424511465;15422.845771542365;15429.537113886601;15443;15493.302801373966;15541;7625.466217364842;7826.686932522749;7826.960865195638;7887.763367098996;7895.565743884026;7360.889586656204;7382.409407247407;7561.584112873735;7570.9242907570215;7612.048493938258;4659.743714095757;4677.953220467752;4726.550977657117;4784.4497882743235;4869.269609558594;1831.285798538571;1885.5191926059042;1923.980760192408;1941.213808407597;1961.3429501117284;946.6260826973307;965.8744363232876;972.1785091597588;987.6049580167846;1028.2596530498029;18573.721394179098;18824.811751882306;19558.413247602595;19827.60344793096;20301.796982030286;942.4533770413144;999.3753903810118;1001.6744558018673;1004.8643433136433;1017.3743147963949;10705;10734.516946737416;11131.220814543067;11515.366654833897;11716.297022178696;487816;490158;490333;500785;502791;90178;94042;94839.52580237055;94905.5254723722;95582.52208738912;1018.8166130096506;1030.6753372687579;1041.7135287795766;1049.6536143072767;1056.1920131099869;17980.91009544944;18011.189496472427;18329;18420.539486512946;18486.537836553656;41536.169276614906;43924;44198.116037678425;44834.55165448434;44901;54055;57061;58424.415755841896;59215.11177332429;59323.70338148282;7273.490855640054;8664.523451210243;8773.166549177819;8823.867641985247;8849.159329863653;9449.811003780023;11453.370064646524;13526.93236533811;13956;13973.580792576238;11100.333979960906;11447.599334023269;11570.942145289557;11603.767924641628;11628.18602697803;11700.94149529281;11773.823392648947;11854.407279636156;11922.642320730392;12034;10339.327943683636;11294.265872718248;11302.83045754298;11363.147763917905;11601.071914247008;7512.9624351880075;7548.622568871425;8592.183742544448;8715.259202967818;8785.604647790993;10369.377837329785;10419.374837509773;10786.622468213574;11006.724831879266;11059.336439813636 04:39:59 INFO - PROCESS | 28347 | |3;mootools.html;1456.8178977627797;1474.8230212374515;1589.944351947682;1707.5560354307877;1720.079757329828;7645.388368930486;8161.632726527306;8191.426600137993;8868.334874884376;8889.511076890769;8403.243708066273;8428.452150610206;8485.78785530362;8486.575671216446;8552.67433547801;2319.5708793873146;2353.705786776653;2357.5638506876285;2359.1860808021206;2363.6927199464044;2310.260716570698;2332.976670233293;2348.365941195876;2351.8941647625898;2359.2214569192124;2328.3946173994714;2334.6498025296173;2349.18952961229;2359.7050368703913;2371.27676058802;2288.6795848581214;2293.1859189987563;2304.585174668559;2314.93055208344;2332.7317358503733;2294.724633044029;2325.2210509479346;2327.7439481657;2330.778576035274;2341.438054866837;8707.738767836974;8760.737177884674;8774.341924355698;8794.384393092487;8796.780080497974;4819.349387832633;4913.656044076916;4919.77860996256;4922.556969872693;4935;3166.2717574957887;3231.111444352798;3324.2852786650988;3344.4481660525985;3371.123507887942;1072.8122578548723;1079.1043433949803;1099.3294090604725;1099.9560017599285;1100.9009189173014;11858.703532411673;11864.58473953416;11876.465559049864;11891.881081189164;11896.345700986529;4351.108022855307;4433.6009759121835;4531.728096314232;4531.909361812745;4535.16099521583;10204.897951020543;10210.285280030475;10233.692989210336;10234.385936843813;10237.641682541076;4829.6860704054125;4845.248986407112;4853.296272040534;4859.173940430135;4861.659683822169;3982.661473774762;4358.346248062752;4383.495897971774;4487.708298960557;4490.977545112253;3949.407588861636;3976.0855003349393;4084.8774536763945;4102.610252026053;4110.815013324348;1232.4638782129803;1245.5266998540496;1249.975000500003;1258.6916205529521;1261;818.7011740714596;852.3394369363792;877.9868301975475;893.2898345815092;1013.8935411781804;6079.179310792986;6133.233345831771;6138.355472675394;6198.907016394758;6372.7132279047555;959.4818797849083;993.7565296502403;998.9250806189565;1002.9598816047277;1004.8794144702537;4078.8164532596106;4122.3404255319;4177.268977928911;4242.53332133465;4267.743935363826;10065.798684026278;10215.438150901771;10231.334963227366;10302.433366164933;10318.17454603645;10238.53926573306;10265.692029239135;10267.024632660035;10290.588376464857;10292.228082893664;7819.139894611588;8104.635291411901;8146.185381461925;8163;8334.916650833535;6110.7250173741395;6159.876802463836;6308.621482710869;6335.628416392674;6375.298717141203;9246.537673116452;9954;10134.847977280198;10203.897961020295;10270.691879243635;9639.421634701941;9640.951795240979;9725.4650994196;9848.60605575769;10152.238582106223;7100.644967751695;7579.583122928292;7743.303102720783;7876.763697089096;7969.203079691984;8173.67305307781;8208.46644968075;8222;8283.544405057779;8294.046184688837;7676.309132178131;7853.410994175346;7880.408969327438;7890.644920978455;8013.278804907586;7517.173110957681;7589.6584653689615;7638;7682.769516914502;7754.495957762728;7019.403350715246;7072.08062951813;7091.397231235403;7101.183363913216;7117.1459424869345;5041.546260836542;5143.3570803649545;5174.844754657366;5292.655977361459;5294.100002999422;5222.42553319127;5270.420253772006;5288.574382125736;5340.759665815125;5490.780368785364 04:39:59 INFO - PROCESS | 28347 | |4;prototype.html;305.3374178033668;321.79083595662803;333.26515034349256;336.87987441756167;337.50892451483077;5504.036793561121;5600.1599760035915;5646.209530665705;5660.773569057238;5733.5699822513325;5586.748596313166;5589.329280486337;5625.634333768302;5637.267155269819;5657;4330.956690433087;4331.870043898688;4346.739195648263;4394.868488782938;4395.384646149541;4163.625273725364;4377.802998865042;4380.868573942771;4438.755868427235;4448.733076015434;4273.444452221207;4280.828766849338;4302.569743025688;4309.784510774464;4310.8145260053425;4289.4209281747035;4301.182775272704;4336.6530677545725;4367.27939889921;4377.409049778271;3724.0875985383755;3735.3649879520276;3809.980950095232;3818.5608655004753;3822.140018495844;5441.211024401479;5454.7272636368025;5459.262999495057;5473.370562385337;5473.698946557938;4934.80260789568;4940.777665005084;4952.182889823211;4988.02733466974;4998.425181104147;5511.779528818843;5879.2944846618675;5885.8822823543715;5907.645541267495;5970.850728731773;4153.1486045360625;4170.311898536738;4172.77049762263;4184.3932629768815;4195.160967806451;6145.938540614581;6155.199824022893;6187.350328215518;6242.375762423767;6249.187605611241;4129.696243005584;4277.786110694453;4282.143571285756;4322.113966636832;4324.870253892388;4324.870253892388;4329.328954012133;4333.1766964276685;4333.220020396359;4351.97824010878;4938.333325001151;4966.683828785374;4976.3578019253555;5004.3994720633755;5012;5860.677662728505;5941.435563621449;5958.702064896738;5969.671668058211;6011.218541589566;1467.8091848059685;1481.1927499512792;1488.9032212906127;1496.2892626002779;1497.1241823533355;909.7193018073459;939.3424602778083;939.7509659939984;942.4109931292942;950.8621249918862;5045.344105266366;5064.974675126675;5086.77109530072;5133;5137.434882163034;5277.920831187535;5285.63000589955;5350.839474815762;5374.623776335619;5424.267723857308;4875.5124487551675;4928.28539861718;4998.825041123616;5079.6698214615935;5156.8195113171605;2833.9878686133075;2834.3622684896145;2865.7564107051135;2872.5547540131315;2900.6374203224595;5515.669059856422;5517.531009864207;5520.66875987434;5559.833205003856;5578.832635020955;5509.531689806331;5745.626534275259;6281.59169653971;6328.525360597973;6358.809235722843;6344.777932772331;6376.936230637727;6406;6412.102305677209;6421;6027.78902738402;6139.1098290746695;6143.324234334309;6161;6171.105189747551;6030.758769649165;6045.21412216409;6077.848053798691;6082.783443311444;6166.907496387468;5668.574856885668;6368.713407896563;6378.744850206125;6379.776707815204;6384.680765961591;4241.87274381769;4250.596193361625;4252.723572967747;4268.2743933530755;4271.93592096125;6103.938960610337;6111.419415155553;6159.661218632839;6208.3791620839365;6227.719752611053;5789.089600431932;6005.819825405245;6011.819645410645;6012.669303188367;6050.42520960508;5887.4406931341455;5924.289085309618;5925.614835035709;5939.643621382731;5958.493528049991;5823.242978412949;5824.15549745293;5845.678487683218;5858.355580886014;5893.44012318829;5620.634658747168;5908.231929849092;5949.286085669747;6007.48936340416;6059.454649081604;5800.651960882361;5841.707914604338;5845.240118784531;5869.53043756507;5899.528037756883 04:39:59 INFO - PROCESS | 28347 | |5;yui.html;696.5994553131944;701.0395757811799;723.7647764476546;784.941129415294;804.9154838741932;13448.66378340542;14245.572632821018;14522.782158267608;14903.478378256763;14986.925065374659;14844.554663360117;14964.476243331486;15059.472918447857;15126.243687815593;15141.621459463491;634.0837489827202;770.3606007014165;796.1560745609657;801.3348920396087;813.3899575318511;804.2399932064202;812.5571563497908;815.0586073085595;815.9061707903578;816.0533780814256;843.8481073406784;845.344857735254;848.5333066813259;848.9872651910226;852.3947996922193;840.9075001749833;841.9452735572199;843.9493630382196;844.0462277626243;847.2882778466118;616;620.2618883528587;620.4694985787132;621.1304174156172;622.7913648927615;13805.654858628513;13921.930390348085;13945.302734863217;13977.440902363893;14019.859801402059;15152.696946061127;15242.314095865713;15431.459898903484;15493.690126197525;15654.139022353766;12138.039278015656;12218.877811221862;12297.139200255986;12308.446119924625;12724.363781810873;3962.920741585152;3979.5025621797276;4045.939310910339;4082.8162732676806;4185.560516145792;81297;81499.18500814975;82354.58822705848;82450.17549824485;85968.14031859663;12224.572139975058;12247.387630618612;12269.754604907852;12494.437750301258;12544;23310;23461.88269058678;23611.40971475727;23668.881655591955;23695;7902.881456778153;8381.41330106899;8465.915340846635;8468.618912148968;9172.44965302084;4833.202521583969;4935.358403407534;4978.701277923336;4996.775145118479;5029.497050294941;3515.5605549306338;3643.908902277464;3654.9766065501703;3655.83548740302;3664.358737220976;614.6834380294152;634.9555531112778;637.8182218067828;638.3520726462644;659.8878190707495;695.7078027228577;756.837279984806;757.9886301705479;762.9542227466259;779.5128044971892;9111.544422778967;9730.855018587361;9809.754756131011;9883.50582470888;10572.15422766177;548.9780408783683;659.1694464974167;663.4062514049898;716.8279612892973;754.2043144482514;4648.883777905579;4659.860204193879;4713.905721885543;4779.498152693986;4876.4392094909535;114612;118255;118592;119330;121356;94347.52826235825;94925;95057;95195.78200354776;95326;90280.5485972566;90702.54648726847;92851.60722589167;94148;94202;9052.818943621223;9072.773180670536;9111.225545828678;9469.526523673927;9511.286653500876;52144.73927630338;52315.47684523258;52987;53069;53754.193687093946;68069.31930680828;68456.6577167111;76830;77417.41951934149;80570.59714701389;11741.530338786353;12002.779485795156;12089.939550302544;12100.213486123374;12631.494740210288;11845.407729613657;11850.466728997388;11992.580259690869;12111.455108359132;12141.696457588278;12870.613881583567;13125.212487250796;13453.125546839425;13583.52457663977;13759;12170.756584868075;12310.938445307716;12367.814482782585;12834.55079072228;12845.165064270792;12089.39553022363;12574.811377829523;14170.858291417366;14257.358418871383;14402.783958240425;11089.372436463995;11224.494897729784;11234.213605047567;11264.267822591506;11578;11168.720781980515;11420.086393088699;11803.881961180277;11846.703832404259;11900.821487677518 04:39:59 INFO - PROCESS | 28347 | __end_tp_report 04:39:59 INFO - PROCESS | 28347 | __start_cc_report 04:39:59 INFO - PROCESS | 28347 | _x_x_mozilla_cycle_collect,339 04:39:59 INFO - PROCESS | 28347 | __end_cc_report 04:39:59 INFO - PROCESS | 28347 | __startTimestamp1466681999412__endTimestamp 04:39:59 INFO - PROCESS | 28347 | 04:39:59 INFO - PROCESS | 28347 | ------- Summary: start ------- 04:39:59 INFO - PROCESS | 28347 | Number of tests: 6 04:39:59 INFO - PROCESS | 28347 | 04:39:59 INFO - PROCESS | 28347 | [#0] dojo.html Cycles:165 Average:5386.67 Median:5618.66 stddev:720.25 (12.8%) stddev-sans-first:699.37 04:39:59 INFO - PROCESS | 28347 | Values: 3080.9 3108.8 3131.1 3142.7 3155.4 5290.1 5374.2 5382.0 5427.3 5455.7 5321.4 5326.5 5337.8 5379.3 5416.3 4810.2 4870.8 4972.4 5015.6 5069.1 776.5 4937.2 4993.6 5021.5 5039.1 4931.3 4931.6 4941.7 4970.0 4991.4 4880.8 4975.6 4993.4 5022.2 5056.2 4853.5 4868.8 4871.7 4875.6 4898.7 5313.4 5420.3 5480.5 5519.8 5569.1 5792.7 5836.4 5919.8 5937.5 5943.3 5916.4 5944.9 5955.5 5967.4 6009.3 5518.3 5525.4 5529.2 5529.3 5541.1 5763.5 5859.0 5900.8 5912.9 6002.8 5744.3 5745.6 5748.2 5750.2 5769.1 5827.0 5828.3 5831.5 5833.6 5841.6 5665.4 5740.1 5765.4 5809.6 5841.5 5583.3 5618.7 5668.1 5673.0 5853.5 4348.5 4354.1 4369.0 4387.2 4398.6 3937.0 3966.8 3976.2 4010.9 4013.5 5567.2 5608.8 5618.7 5629.6 5674.4 5739.4 5865.7 5938.5 5945.0 5945.9 5554.6 5581.9 5614.8 5619.6 5622.9 5078.8 5093.9 5105.2 5107.6 5156.4 5863.3 5991.8 6113.1 6115.1 6130.1 5806.5 5870.9 5890.1 5916.3 5940.9 6052.4 6092.0 6095.8 6100.9 6117.4 5640.6 5648.5 5666.3 5793.6 5801.3 5823.2 5836.1 5845.2 5850.4 5888.8 5669.7 5674.1 5698.2 5699.7 5708.4 5564.3 5612.5 5619.7 5625.6 5676.1 5480.7 5490.9 5533.9 5548.1 5586.5 5616.6 5682.8 5700.9 5720.0 5731.7 5457.4 5524.4 5560.5 5617.9 5635.0 04:39:59 INFO - PROCESS | 28347 | 04:39:59 INFO - PROCESS | 28347 | [#1] ext.html Cycles:180 Average:55856.99 Median:22498.42 stddev:102702.50 (456.5%) stddev-sans-first:102906.73 04:39:59 INFO - PROCESS | 28347 | Values: 573.3 605.9 615.8 627.0 635.9 43011.6 43900.1 43936.3 44148.0 47826.0 45260.3 45501.3 45611.3 45870.8 46018.5 8898.2 9013.7 9047.7 9073.0 9085.8 8970.7 9052.1 9060.9 9092.4 9128.6 8829.1 8862.6 8873.8 8885.2 8895.6 9068.5 9114.6 9115.3 9125.5 9141.5 8975.8 9039.5 9057.1 9060.0 9067.7 42551.1 42597.4 42960.1 43099.6 43142.1 3524.8 3610.5 3659.9 3711.6 4091.7 31815.0 32186.4 32543.3 32650.8 32689.0 3938.3 3974.1 3977.2 3981.0 4034.8 351185.0 366483.0 366935.0 368003.0 369890.0 54614.5 58499.4 59357.0 59450.0 59613.4 62005.4 62314.7 62481.4 62539.4 62586.4 15182.7 15501.3 15578.5 15584.8 15589.5 11711.4 11838.7 11946.9 12015.7 12040.2 19020.8 19098.3 19120.7 19165.2 19340.0 6974.0 7049.8 7092.8 7216.5 7306.5 992.8 1037.0 1088.7 1140.5 1148.4 30897.8 31590.8 31814.3 31983.5 32305.8 1108.7 1215.3 1217.3 1218.8 1254.0 16684.6 16809.2 17020.7 17116.1 17344.0 422382.0 423304.0 428325.0 428336.0 429537.0 57560.7 57840.4 58165.7 58204.4 58285.4 1329.3 1346.8 1372.2 1379.6 1383.3 30071.4 30823.0 30848.2 31313.4 31605.0 44185.3 44420.8 44486.6 44580.6 44600.0 372313.0 376551.0 377204.3 378133.0 378709.0 26973.5 28118.0 28122.3 28123.2 28172.4 47250.0 47729.0 48012.8 48292.8 48320.3 40440.0 40905.2 41002.6 41781.8 41916.0 39858.0 39899.6 40569.6 41219.2 41728.2 38398.4 39819.4 40515.6 41763.2 44710.3 35424.8 37336.8 37777.6 37880.4 37938.6 28081.9 28324.0 28336.3 28394.9 28789.4 04:39:59 INFO - PROCESS | 28347 | 04:39:59 INFO - PROCESS | 28347 | [#2] jquery.html Cycles:180 Average:29053.95 Median:1515.31 stddev:81550.06 (5381.7%) stddev-sans-first:81750.42 04:39:59 INFO - PROCESS | 28347 | Values: 387.5 390.3 393.7 395.5 417.2 18393.1 20357.3 20399.6 20403.4 20986.8 18126.6 18145.5 18847.0 18873.6 19551.2 5026.9 5190.3 5494.5 5694.1 5750.8 5676.5 5740.1 5756.7 5768.2 5822.5 5427.8 5712.4 5730.9 5732.9 5804.5 5666.6 5694.3 5706.4 5709.3 5880.6 5839.2 5848.3 5850.4 5880.0 5888.9 13673.5 13782.8 21420.9 22872.4 22899.0 2328.0 2397.5 2497.0 2519.5 2643.1 9775.1 10299.9 10323.4 11218.0 13910.2 1860.9 1898.2 1924.8 1945.4 1946.9 68744.0 78934.6 82732.6 83044.0 84775.6 9910.9 10277.5 11102.0 11110.8 11278.8 15422.8 15429.5 15443.0 15493.3 15541.0 7625.5 7826.7 7827.0 7887.8 7895.6 7360.9 7382.4 7561.6 7570.9 7612.0 4659.7 4678.0 4726.6 4784.4 4869.3 1831.3 1885.5 1924.0 1941.2 1961.3 946.6 965.9 972.2 987.6 1028.3 18573.7 18824.8 19558.4 19827.6 20301.8 942.5 999.4 1001.7 1004.9 1017.4 10705.0 10734.5 11131.2 11515.4 11716.3 487816.0 490158.0 490333.0 500785.0 502791.0 90178.0 94042.0 94839.5 94905.5 95582.5 1018.8 1030.7 1041.7 1049.7 1056.2 17980.9 18011.2 18329.0 18420.5 18486.5 41536.2 43924.0 44198.1 44834.6 44901.0 54055.0 57061.0 58424.4 59215.1 59323.7 7273.5 8664.5 8773.2 8823.9 8849.2 9449.8 11453.4 13526.9 13956.0 13973.6 11100.3 11447.6 11570.9 11603.8 11628.2 11700.9 11773.8 11854.4 11922.6 12034.0 10339.3 11294.3 11302.8 11363.1 11601.1 7513.0 7548.6 8592.2 8715.3 8785.6 10369.4 10419.4 10786.6 11006.7 11059.3 04:39:59 INFO - PROCESS | 28347 | 04:39:59 INFO - PROCESS | 28347 | [#3] mootools.html Cycles:180 Average:5695.91 Median:4533.54 stddev:3182.56 (70.2%) stddev-sans-first:3175.54 04:39:59 INFO - PROCESS | 28347 | Values: 1456.8 1474.8 1589.9 1707.6 1720.1 7645.4 8161.6 8191.4 8868.3 8889.5 8403.2 8428.5 8485.8 8486.6 8552.7 2319.6 2353.7 2357.6 2359.2 2363.7 2310.3 2333.0 2348.4 2351.9 2359.2 2328.4 2334.6 2349.2 2359.7 2371.3 2288.7 2293.2 2304.6 2314.9 2332.7 2294.7 2325.2 2327.7 2330.8 2341.4 8707.7 8760.7 8774.3 8794.4 8796.8 4819.3 4913.7 4919.8 4922.6 4935.0 3166.3 3231.1 3324.3 3344.4 3371.1 1072.8 1079.1 1099.3 1100.0 1100.9 11858.7 11864.6 11876.5 11891.9 11896.3 4351.1 4433.6 4531.7 4531.9 4535.2 10204.9 10210.3 10233.7 10234.4 10237.6 4829.7 4845.2 4853.3 4859.2 4861.7 3982.7 4358.3 4383.5 4487.7 4491.0 3949.4 3976.1 4084.9 4102.6 4110.8 1232.5 1245.5 1250.0 1258.7 1261.0 818.7 852.3 878.0 893.3 1013.9 6079.2 6133.2 6138.4 6198.9 6372.7 959.5 993.8 998.9 1003.0 1004.9 4078.8 4122.3 4177.3 4242.5 4267.7 10065.8 10215.4 10231.3 10302.4 10318.2 10238.5 10265.7 10267.0 10290.6 10292.2 7819.1 8104.6 8146.2 8163.0 8334.9 6110.7 6159.9 6308.6 6335.6 6375.3 9246.5 9954.0 10134.8 10203.9 10270.7 9639.4 9641.0 9725.5 9848.6 10152.2 7100.6 7579.6 7743.3 7876.8 7969.2 8173.7 8208.5 8222.0 8283.5 8294.0 7676.3 7853.4 7880.4 7890.6 8013.3 7517.2 7589.7 7638.0 7682.8 7754.5 7019.4 7072.1 7091.4 7101.2 7117.1 5041.5 5143.4 5174.8 5292.7 5294.1 5222.4 5270.4 5288.6 5340.8 5490.8 04:39:59 INFO - PROCESS | 28347 | 04:39:59 INFO - PROCESS | 28347 | [#4] prototype.html Cycles:180 Average:4887.30 Median:5506.78 stddev:1470.80 (26.7%) stddev-sans-first:1434.15 04:39:59 INFO - PROCESS | 28347 | Values: 305.3 321.8 333.3 336.9 337.5 5504.0 5600.2 5646.2 5660.8 5733.6 5586.7 5589.3 5625.6 5637.3 5657.0 4331.0 4331.9 4346.7 4394.9 4395.4 4163.6 4377.8 4380.9 4438.8 4448.7 4273.4 4280.8 4302.6 4309.8 4310.8 4289.4 4301.2 4336.7 4367.3 4377.4 3724.1 3735.4 3810.0 3818.6 3822.1 5441.2 5454.7 5459.3 5473.4 5473.7 4934.8 4940.8 4952.2 4988.0 4998.4 5511.8 5879.3 5885.9 5907.6 5970.9 4153.1 4170.3 4172.8 4184.4 4195.2 6145.9 6155.2 6187.4 6242.4 6249.2 4129.7 4277.8 4282.1 4322.1 4324.9 4324.9 4329.3 4333.2 4333.2 4352.0 4938.3 4966.7 4976.4 5004.4 5012.0 5860.7 5941.4 5958.7 5969.7 6011.2 1467.8 1481.2 1488.9 1496.3 1497.1 909.7 939.3 939.8 942.4 950.9 5045.3 5065.0 5086.8 5133.0 5137.4 5277.9 5285.6 5350.8 5374.6 5424.3 4875.5 4928.3 4998.8 5079.7 5156.8 2834.0 2834.4 2865.8 2872.6 2900.6 5515.7 5517.5 5520.7 5559.8 5578.8 5509.5 5745.6 6281.6 6328.5 6358.8 6344.8 6376.9 6406.0 6412.1 6421.0 6027.8 6139.1 6143.3 6161.0 6171.1 6030.8 6045.2 6077.8 6082.8 6166.9 5668.6 6368.7 6378.7 6379.8 6384.7 4241.9 4250.6 4252.7 4268.3 4271.9 6103.9 6111.4 6159.7 6208.4 6227.7 5789.1 6005.8 6011.8 6012.7 6050.4 5887.4 5924.3 5925.6 5939.6 5958.5 5823.2 5824.2 5845.7 5858.4 5893.4 5620.6 5908.2 5949.3 6007.5 6059.5 5800.7 5841.7 5845.2 5869.5 5899.5 04:39:59 INFO - PROCESS | 28347 | 04:39:59 INFO - PROCESS | 28347 | [#5] yui.html Cycles:180 Average:21129.50 Median:4854.82 stddev:30743.31 (633.3%) stddev-sans-first:30791.27 04:39:59 INFO - PROCESS | 28347 | Values: 696.6 701.0 723.8 784.9 804.9 13448.7 14245.6 14522.8 14903.5 14986.9 14844.6 14964.5 15059.5 15126.2 15141.6 634.1 770.4 796.2 801.3 813.4 804.2 812.6 815.1 815.9 816.1 843.8 845.3 848.5 849.0 852.4 840.9 841.9 843.9 844.0 847.3 616.0 620.3 620.5 621.1 622.8 13805.7 13921.9 13945.3 13977.4 14019.9 15152.7 15242.3 15431.5 15493.7 15654.1 12138.0 12218.9 12297.1 12308.4 12724.4 3962.9 3979.5 4045.9 4082.8 4185.6 81297.0 81499.2 82354.6 82450.2 85968.1 12224.6 12247.4 12269.8 12494.4 12544.0 23310.0 23461.9 23611.4 23668.9 23695.0 7902.9 8381.4 8465.9 8468.6 9172.4 4833.2 4935.4 4978.7 4996.8 5029.5 3515.6 3643.9 3655.0 3655.8 3664.4 614.7 635.0 637.8 638.4 659.9 695.7 756.8 758.0 763.0 779.5 9111.5 9730.9 9809.8 9883.5 10572.2 549.0 659.2 663.4 716.8 754.2 4648.9 4659.9 4713.9 4779.5 4876.4 114612.0 118255.0 118592.0 119330.0 121356.0 94347.5 94925.0 95057.0 95195.8 95326.0 90280.5 90702.5 92851.6 94148.0 94202.0 9052.8 9072.8 9111.2 9469.5 9511.3 52144.7 52315.5 52987.0 53069.0 53754.2 68069.3 68456.7 76830.0 77417.4 80570.6 11741.5 12002.8 12089.9 12100.2 12631.5 11845.4 11850.5 11992.6 12111.5 12141.7 12870.6 13125.2 13453.1 13583.5 13759.0 12170.8 12310.9 12367.8 12834.6 12845.2 12089.4 12574.8 14170.9 14257.4 14402.8 11089.4 11224.5 11234.2 11264.3 11578.0 11168.7 11420.1 11803.9 11846.7 11900.8 04:39:59 INFO - PROCESS | 28347 | -------- Summary: end -------- 04:39:59 INFO - PROCESS | 28347 | 04:40:00 INFO - TEST-INFO | 28347: exit 0 04:40:00 INFO - TEST-OK | dromaeo_css | took 1111606ms 04:40:00 INFO - TEST-START | kraken 04:40:00 INFO - operating with platform_type : linux_ 04:40:00 INFO - Initialising browser for kraken test... 04:40:00 INFO - TEST-INFO | started process 28582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8a89XB/profile http://localhost:44915/getInfo.html) 04:40:04 INFO - PROCESS | 28582 | __metrics Screen width/height:1600/1200 04:40:04 INFO - PROCESS | 28582 | colorDepth:24 04:40:04 INFO - PROCESS | 28582 | Browser inner width/height: 1024/697 04:40:04 INFO - PROCESS | 28582 | __metrics 04:40:05 ERROR - PROCESS | 28582 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:40:06 INFO - TEST-INFO | 28582: exit 0 04:40:06 INFO - Browser initialized. 04:40:06 INFO - Running cycle 1/1 for kraken test... 04:40:06 INFO - TEST-INFO | started process 28703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8a89XB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:18 INFO - PROCESS | 28703 | RSS: Main: 184737792 04:40:18 INFO - PROCESS | 28703 | 04:40:20 INFO - PROCESS | 28703 | Cycle 1(1): loaded http://localhost:44915/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44915/tests/kraken/driver.html?testName=audio-beat-detection) 04:40:21 INFO - PROCESS | 28703 | RSS: Main: 190308352 04:40:21 INFO - PROCESS | 28703 | 04:40:24 INFO - PROCESS | 28703 | Cycle 1(1): loaded http://localhost:44915/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44915/tests/kraken/driver.html?testName=audio-dft) 04:40:25 INFO - PROCESS | 28703 | RSS: Main: 189972480 04:40:25 INFO - PROCESS | 28703 | 04:40:28 INFO - PROCESS | 28703 | Cycle 1(1): loaded http://localhost:44915/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44915/tests/kraken/driver.html?testName=audio-fft) 04:40:28 INFO - PROCESS | 28703 | RSS: Main: 185090048 04:40:28 INFO - PROCESS | 28703 | 04:40:31 INFO - PROCESS | 28703 | Cycle 1(1): loaded http://localhost:44915/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44915/tests/kraken/driver.html?testName=audio-oscillator) 04:40:31 INFO - PROCESS | 28703 | RSS: Main: 185933824 04:40:31 INFO - PROCESS | 28703 | 04:40:33 INFO - PROCESS | 28703 | Cycle 1(1): loaded http://localhost:44915/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44915/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:40:34 INFO - PROCESS | 28703 | RSS: Main: 185991168 04:40:34 INFO - PROCESS | 28703 | 04:40:37 INFO - PROCESS | 28703 | Cycle 1(1): loaded http://localhost:44915/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44915/tests/kraken/driver.html?testName=imaging-darkroom) 04:40:38 INFO - PROCESS | 28703 | RSS: Main: 186466304 04:40:38 INFO - PROCESS | 28703 | 04:40:41 INFO - PROCESS | 28703 | Cycle 1(1): loaded http://localhost:44915/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44915/tests/kraken/driver.html?testName=imaging-desaturate) 04:40:42 INFO - PROCESS | 28703 | RSS: Main: 183631872 04:40:42 INFO - PROCESS | 28703 | 04:40:45 INFO - PROCESS | 28703 | Cycle 1(1): loaded http://localhost:44915/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44915/tests/kraken/driver.html?testName=json-parse-financial) 04:40:45 INFO - PROCESS | 28703 | RSS: Main: 185032704 04:40:45 INFO - PROCESS | 28703 | 04:40:47 INFO - PROCESS | 28703 | Cycle 1(1): loaded http://localhost:44915/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44915/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:40:47 INFO - PROCESS | 28703 | RSS: Main: 185421824 04:40:47 INFO - PROCESS | 28703 | 04:40:49 INFO - PROCESS | 28703 | Cycle 1(1): loaded http://localhost:44915/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44915/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:40:50 INFO - PROCESS | 28703 | RSS: Main: 185790464 04:40:50 INFO - PROCESS | 28703 | 04:40:52 INFO - PROCESS | 28703 | Cycle 1(1): loaded http://localhost:44915/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44915/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:40:53 INFO - PROCESS | 28703 | RSS: Main: 185851904 04:40:53 INFO - PROCESS | 28703 | 04:40:55 INFO - PROCESS | 28703 | Cycle 1(1): loaded http://localhost:44915/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44915/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:40:56 INFO - PROCESS | 28703 | RSS: Main: 186294272 04:40:56 INFO - PROCESS | 28703 | 04:40:59 INFO - PROCESS | 28703 | Cycle 1(1): loaded http://localhost:44915/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44915/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:40:59 INFO - PROCESS | 28703 | RSS: Main: 186220544 04:40:59 INFO - PROCESS | 28703 | 04:41:01 INFO - PROCESS | 28703 | Cycle 1(1): loaded http://localhost:44915/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44915/tests/kraken/driver.html?testName=ai-astar) 04:41:01 INFO - PROCESS | 28703 | RSS: Main: 187006976 04:41:01 INFO - PROCESS | 28703 | 04:41:01 INFO - PROCESS | 28703 | __start_tp_report 04:41:01 INFO - PROCESS | 28703 | _x_x_mozilla_page_load 04:41:01 INFO - PROCESS | 28703 | _x_x_mozilla_page_load_details 04:41:01 INFO - PROCESS | 28703 | |i|pagename|runs| 04:41:01 INFO - PROCESS | 28703 | |0;ai-astar;104;112;105;113;113;112;111;112;113;111 04:41:01 INFO - PROCESS | 28703 | |1;audio-beat-detection;159;135;156;178;132;154;155;138;194;135 04:41:01 INFO - PROCESS | 28703 | |2;audio-dft;163;164;161;166;166;170;163;163;161;163 04:41:01 INFO - PROCESS | 28703 | |3;audio-fft;78;76;75;175;76;75;74;76;168;76 04:41:01 INFO - PROCESS | 28703 | |4;audio-oscillator;85;85;149;85;87;86;148;85;85;141 04:41:01 INFO - PROCESS | 28703 | |5;imaging-gaussian-blur;117;118;118;118;119;118;119;118;118;117 04:41:01 INFO - PROCESS | 28703 | |6;imaging-darkroom;147;147;147;148;150;148;149;148;148;148 04:41:01 INFO - PROCESS | 28703 | |7;imaging-desaturate;96;95;96;95;95;95;96;96;95;96 04:41:01 INFO - PROCESS | 28703 | |8;json-parse-financial;58;60;55;56;58;56;55;56;55;68 04:41:01 INFO - PROCESS | 28703 | |9;json-stringify-tinderbox;63;63;63;62;64;63;62;62;63;62 04:41:01 INFO - PROCESS | 28703 | |10;stanford-crypto-aes;88;84;80;78;81;86;81;81;166;86 04:41:01 INFO - PROCESS | 28703 | |11;stanford-crypto-ccm;134;125;122;120;124;129;124;129;128;123 04:41:01 INFO - PROCESS | 28703 | |12;stanford-crypto-pbkdf2;161;162;165;163;164;169;168;168;162;168 04:41:01 INFO - PROCESS | 28703 | |13;stanford-crypto-sha256-iterative;66;64;65;62;65;64;65;64;66;64 04:41:01 INFO - PROCESS | 28703 | __end_tp_report 04:41:01 INFO - PROCESS | 28703 | __start_cc_report 04:41:01 INFO - PROCESS | 28703 | _x_x_mozilla_cycle_collect,935 04:41:01 INFO - PROCESS | 28703 | __end_cc_report 04:41:01 INFO - PROCESS | 28703 | __startTimestamp1466682061687__endTimestamp 04:41:01 INFO - PROCESS | 28703 | 04:41:01 INFO - PROCESS | 28703 | ------- Summary: start ------- 04:41:01 INFO - PROCESS | 28703 | Number of tests: 14 04:41:01 INFO - PROCESS | 28703 | 04:41:01 INFO - PROCESS | 28703 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.31 (3.0%) stddev-sans-first:2.50 04:41:01 INFO - PROCESS | 28703 | Values: 104.0 112.0 105.0 113.0 113.0 112.0 111.0 112.0 113.0 111.0 04:41:01 INFO - PROCESS | 28703 | 04:41:01 INFO - PROCESS | 28703 | [#1] audio-beat-detection Cycles:10 Average:153.60 Median:155.50 stddev:20.18 (13.0%) stddev-sans-first:21.31 04:41:01 INFO - PROCESS | 28703 | Values: 159.0 135.0 156.0 178.0 132.0 154.0 155.0 138.0 194.0 135.0 04:41:01 INFO - PROCESS | 28703 | 04:41:01 INFO - PROCESS | 28703 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:2.71 (1.7%) stddev-sans-first:2.85 04:41:01 INFO - PROCESS | 28703 | Values: 163.0 164.0 161.0 166.0 166.0 170.0 163.0 163.0 161.0 163.0 04:41:01 INFO - PROCESS | 28703 | 04:41:01 INFO - PROCESS | 28703 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.00 stddev:40.42 (53.2%) stddev-sans-first:42.41 04:41:01 INFO - PROCESS | 28703 | Values: 78.0 76.0 75.0 175.0 76.0 75.0 74.0 76.0 168.0 76.0 04:41:01 INFO - PROCESS | 28703 | 04:41:01 INFO - PROCESS | 28703 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:85.00 stddev:29.34 (34.5%) stddev-sans-first:30.34 04:41:01 INFO - PROCESS | 28703 | Values: 85.0 85.0 149.0 85.0 87.0 86.0 148.0 85.0 85.0 141.0 04:41:01 INFO - PROCESS | 28703 | 04:41:01 INFO - PROCESS | 28703 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 04:41:01 INFO - PROCESS | 28703 | Values: 117.0 118.0 118.0 118.0 119.0 118.0 119.0 118.0 118.0 117.0 04:41:01 INFO - PROCESS | 28703 | 04:41:01 INFO - PROCESS | 28703 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 04:41:01 INFO - PROCESS | 28703 | Values: 147.0 147.0 147.0 148.0 150.0 148.0 149.0 148.0 148.0 148.0 04:41:01 INFO - PROCESS | 28703 | 04:41:01 INFO - PROCESS | 28703 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:41:01 INFO - PROCESS | 28703 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 04:41:01 INFO - PROCESS | 28703 | 04:41:01 INFO - PROCESS | 28703 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:3.97 (7.0%) stddev-sans-first:4.21 04:41:01 INFO - PROCESS | 28703 | Values: 58.0 60.0 55.0 56.0 58.0 56.0 55.0 56.0 55.0 68.0 04:41:01 INFO - PROCESS | 28703 | 04:41:01 INFO - PROCESS | 28703 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 04:41:01 INFO - PROCESS | 28703 | Values: 63.0 63.0 63.0 62.0 64.0 63.0 62.0 62.0 63.0 62.0 04:41:01 INFO - PROCESS | 28703 | 04:41:01 INFO - PROCESS | 28703 | [#10] stanford-crypto-aes Cycles:10 Average:91.10 Median:82.50 stddev:26.51 (32.1%) stddev-sans-first:28.09 04:41:01 INFO - PROCESS | 28703 | Values: 88.0 84.0 80.0 78.0 81.0 86.0 81.0 81.0 166.0 86.0 04:41:01 INFO - PROCESS | 28703 | 04:41:01 INFO - PROCESS | 28703 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:126.50 stddev:4.16 (3.3%) stddev-sans-first:3.18 04:41:01 INFO - PROCESS | 28703 | Values: 134.0 125.0 122.0 120.0 124.0 129.0 124.0 129.0 128.0 123.0 04:41:01 INFO - PROCESS | 28703 | 04:41:01 INFO - PROCESS | 28703 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:166.50 stddev:3.02 (1.8%) stddev-sans-first:2.83 04:41:01 INFO - PROCESS | 28703 | Values: 161.0 162.0 165.0 163.0 164.0 169.0 168.0 168.0 162.0 168.0 04:41:01 INFO - PROCESS | 28703 | 04:41:01 INFO - PROCESS | 28703 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:1.18 (1.8%) stddev-sans-first:1.12 04:41:01 INFO - PROCESS | 28703 | Values: 66.0 64.0 65.0 62.0 65.0 64.0 65.0 64.0 66.0 64.0 04:41:01 INFO - PROCESS | 28703 | -------- Summary: end -------- 04:41:01 INFO - PROCESS | 28703 | 04:41:02 INFO - TEST-INFO | 28703: exit 0 04:41:02 INFO - TEST-OK | kraken | took 62481ms 04:41:02 INFO - SUITE-END | took 1174s 04:41:02 INFO - Completed test suite (00:19:34) 04:41:02 INFO - javascript benchmark 04:41:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7279.103488492409, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3080.922976925577, 3108.766842486814, 3131.1389367923825, 3142.7485801135913, 3155.4162479941197, 5290.127129023716, 5374.247605335251, 5382.0312343778105, 5427.348718153827, 5455.672659640414, 5321.4412486688925, 5326.467353264671, 5337.786488540453, 5379.300690910186, 5416.295881535405, 4810.230363141906, 4870.829520966767, 4972.403311602613, 5015.648904576681, 5069.112905241568, 776.4580946259397, 4937.23472861707, 4993.6005119590345, 5021.548060674539, 5039.067772462106, 4931.284963680264, 4931.605471562284, 4941.728204948727, 4969.975150124263, 4991.425986011583, 4880.780364883553, 4975.577075948549, 4993.375828021497, 5022.221555658843, 5056.165732654108, 4853.466118726938, 4868.829590964299, 4871.732054736988, 4875.58557522611, 4898.730569818658, 5313.38896026958, 5420.268263784378, 5480.479354461319, 5519.806806761784, 5569.081101618228, 5792.68140252286, 5836.358000619928, 5919.792807251725, 5937.495312898409, 5943.257092863392, 5916.408359164092, 5944.910826337566, 5955.464008239279, 5967.373425790316, 6009.278886533644, 5518.2826232589905, 5525.364583072957, 5529.198266251411, 5529.281193444826, 5541.113421852484, 5763.510101641407, 5858.970705146447, 5900.76396944126, 5912.940870591325, 6002.789902353396, 5744.310682718101, 5745.569082318842, 5748.19525266463, 5750.166225897222, 5769.07694768835, 5827.038538641162, 5828.271466066742, 5831.533477321804, 5833.591648584643, 5841.591088623841, 5665.3768085510565, 5740.0815869460685, 5765.365809760923, 5809.564282678732, 5841.474267315962, 5583.274174357389, 5618.6628802272, 5668.149777533321, 5672.971635141798, 5853.502452291603, 4348.543402942709, 4354.085642015149, 4369.038811461473, 4387.188370151533, 4398.56014398564, 3936.9606303937167, 3966.781826999543, 3976.224636195914, 4010.8796736097966, 4013.478247827764, 5567.24842146305, 5608.803691870765, 5618.6628802272, 5629.577781666391, 5674.432556744293, 5739.368669446358, 5865.73604187804, 5938.495227905676, 5945.048792193228, 5945.910811337833, 5554.611177217636, 5581.916271255935, 5614.803481878196, 5619.634723742944, 5622.859428514238, 5078.822241221539, 5093.898122037538, 5105.15764898795, 5107.565856902131, 5156.432792392834, 5863.2670916135485, 5991.7902873399225, 6113.083037544315, 6115.143879856823, 6130.080487926846, 5806.506446952057, 5870.882582348415, 5890.145928840208, 5916.26046744157, 5940.851478713067, 6052.425019623129, 6091.969540152271, 6095.847603809941, 6100.908486372619, 6117.357677443804, 5640.633358831663, 5648.4633959773755, 5666.291713535808, 5793.594448388572, 5801.332846722681, 5823.213866128188, 5836.095405212199, 5845.240118784701, 5850.444207800252, 5888.793892213752, 5669.7165141741925, 5674.148877668383, 5698.20225168485, 5699.743511542073, 5708.429157084258, 5564.276644036249, 5612.522935550524, 5619.690916999441, 5625.606207565431, 5676.148577713376, 5480.698561579152, 5490.862728431821, 5533.861653458534, 5548.0845660467185, 5586.525145362527, 5616.606837521498, 5682.77268909239, 5700.857478563069, 5719.971400142973, 5731.684757338387, 5457.372402173642, 5524.364698059774, 5560.499555040065, 5617.915731263953, 5634.971825140848], "value": 5339.342652925749, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.2748073686787, 605.9030555111177, 615.7598536570738, 626.9686515674215, 635.8982562789953, 43011.56988430115, 43900.12199756003, 43936.340954885665, 44148.0, 47826.0, 45260.32109518351, 45501.31748023782, 45611.315830262574, 45870.770646146724, 46018.53981460184, 8898.199162075429, 9013.684521041765, 9047.683331083414, 9072.954635226815, 9085.818283634324, 8970.730878073635, 9052.094790520929, 9060.909390906105, 9092.363534552584, 9128.58921348541, 8829.072947340534, 8862.645494180257, 8873.822523549525, 8885.155910188521, 8895.599698013573, 9068.455892646429, 9114.58984345706, 9115.316351273681, 9125.543722813833, 9141.49721765306, 8975.775605609846, 9039.54802259891, 9057.139571740674, 9060.048694887008, 9067.7279681609, 42551.148977020595, 42597.36103958443, 42960.14079718419, 43099.569004310186, 43142.13715725699, 3524.788512689221, 3610.530631017977, 3659.871904483357, 3711.6288371162937, 4091.652209562191, 31815.0, 32186.356272874644, 32543.349133017444, 32650.836745816356, 32689.019329420156, 3938.3048817011195, 3974.145558704892, 3977.164795392942, 3981.0, 4034.757914525138, 351185.0, 366483.0, 366935.0, 368003.0, 369890.0, 54614.45385546173, 58499.41500585025, 59357.0, 59450.0, 59613.403865961656, 62005.37994619996, 62314.68842655848, 62481.375186248464, 62539.37460625426, 62586.374136258055, 15182.696346073017, 15501.302441390164, 15578.454754083552, 15584.766228506582, 15589.454369097028, 11711.414429278502, 11838.704032399259, 11946.880531194576, 12015.699607509881, 12040.157188996685, 19020.809791902182, 19098.33155839567, 19120.713189302172, 19165.233390664496, 19340.0, 6973.965130174418, 7049.753258635923, 7092.751753688596, 7216.530925489827, 7306.488545801849, 992.8411454167299, 1036.9896301036893, 1088.6842815583393, 1140.5323817234894, 1148.4315263944402, 30897.845510772302, 31590.842045789625, 31814.2571233211, 31983.52024719631, 32305.838470807495, 1108.6729414822646, 1215.3376409856648, 1217.2939694976892, 1218.8171774233936, 1253.9686507837378, 16684.58288542796, 16809.243584038748, 17020.744688829676, 17116.14419279031, 17344.0, 422382.0, 423304.0, 428325.0, 428336.0, 429537.0, 57560.71219643875, 57840.42159578435, 58165.70917145472, 58204.4179558199, 58285.417145827996, 1329.2755448280516, 1346.7845144776788, 1372.1561239837429, 1379.6068120585585, 1383.3290853935832, 30071.398572028873, 30823.0, 30848.228794280323, 31313.373732524768, 31605.0, 44185.33721994108, 44420.777896111606, 44486.555134448245, 44580.554194458935, 44600.0, 372313.0, 376551.0, 377204.2537660455, 378133.0, 378709.0, 26973.460530789667, 28118.0, 28122.2969425766, 28123.156305310873, 28172.43655126927, 47250.0, 47729.0, 48012.759936201495, 48292.7585362071, 48320.2751958728, 40440.0, 40905.181896362505, 41002.58997410107, 41781.79109104435, 41916.0, 39858.0, 39899.60100399075, 40569.59430405658, 41219.1756164881, 41728.16543669049, 38398.42402363911, 39819.40270895997, 40515.55617772522, 41763.1647367057, 44710.3293450605, 35424.82287588545, 37336.81331593324, 37777.62222377741, 37880.43179352257, 37938.62061379351, 28081.859590701915, 28324.0, 28336.291592710346, 28394.85802570974, 28789.42421151607], "value": 19933.465277591004, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.5156054931336, 390.30330859415915, 393.6929195227722, 395.4977178982692, 417.15526059729046, 18393.080345982697, 20357.287494937682, 20399.592008159845, 20403.38789836307, 20986.790132098675, 18126.637467250646, 18145.4556363309, 18847.0, 18873.62252754944, 19551.217951281968, 5026.874328141798, 5190.299309593213, 5494.478024587658, 5694.060480020791, 5750.7699692012475, 5676.489115979561, 5740.1102829061565, 5756.654600723949, 5768.221290125843, 5822.505087067604, 5427.83716488504, 5712.371639119693, 5730.942690573103, 5732.885342293152, 5804.535637149039, 5666.57500687448, 5694.288213973254, 5706.400827913092, 5709.343425506078, 5880.647161170344, 5839.240898683186, 5848.2689663792025, 5850.3564607893095, 5880.0, 5888.941110588882, 13673.453061877513, 13782.793258101137, 21420.892895535577, 22872.428189295235, 22899.0, 2328.0, 2397.4725560376687, 2497.0, 2519.508695804319, 2643.1013455425054, 9775.120239178437, 10299.897001029969, 10323.432211228379, 11218.0, 13910.234937078456, 1860.8604354673453, 1898.221729091066, 1924.788273289937, 1945.396926952635, 1946.912388942501, 68744.0, 78934.60532697357, 82732.58633706853, 83043.99999999939, 84775.57612211962, 9910.900890990997, 10277.486125693686, 11102.0, 11110.777784444266, 11278.774424511465, 15422.845771542365, 15429.537113886601, 15443.0, 15493.302801373966, 15541.0, 7625.466217364842, 7826.686932522749, 7826.960865195638, 7887.763367098996, 7895.565743884026, 7360.889586656204, 7382.409407247407, 7561.584112873735, 7570.9242907570215, 7612.048493938258, 4659.743714095757, 4677.953220467752, 4726.550977657117, 4784.4497882743235, 4869.269609558594, 1831.285798538571, 1885.5191926059042, 1923.980760192408, 1941.213808407597, 1961.3429501117284, 946.6260826973307, 965.8744363232876, 972.1785091597588, 987.6049580167846, 1028.2596530498029, 18573.721394179098, 18824.811751882306, 19558.413247602595, 19827.60344793096, 20301.796982030286, 942.4533770413144, 999.3753903810118, 1001.6744558018673, 1004.8643433136433, 1017.3743147963949, 10705.0, 10734.516946737416, 11131.220814543067, 11515.366654833897, 11716.297022178696, 487816.0, 490158.0, 490333.0, 500785.0, 502791.0, 90178.0, 94042.0, 94839.52580237055, 94905.5254723722, 95582.52208738912, 1018.8166130096506, 1030.6753372687579, 1041.7135287795766, 1049.6536143072767, 1056.1920131099869, 17980.91009544944, 18011.189496472427, 18329.0, 18420.539486512946, 18486.537836553656, 41536.169276614906, 43924.0, 44198.116037678425, 44834.55165448434, 44901.0, 54055.0, 57061.0, 58424.415755841896, 59215.11177332429, 59323.70338148282, 7273.490855640054, 8664.523451210243, 8773.166549177819, 8823.867641985247, 8849.159329863653, 9449.811003780023, 11453.370064646524, 13526.93236533811, 13956.0, 13973.580792576238, 11100.333979960906, 11447.599334023269, 11570.942145289557, 11603.767924641628, 11628.18602697803, 11700.94149529281, 11773.823392648947, 11854.407279636156, 11922.642320730392, 12034.0, 10339.327943683636, 11294.265872718248, 11302.83045754298, 11363.147763917905, 11601.071914247008, 7512.9624351880075, 7548.622568871425, 8592.183742544448, 8715.259202967818, 8785.604647790993, 10369.377837329785, 10419.374837509773, 10786.622468213574, 11006.724831879266, 11059.336439813636], "value": 9155.52686195552, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.8178977627797, 1474.8230212374515, 1589.944351947682, 1707.5560354307877, 1720.079757329828, 7645.388368930486, 8161.632726527306, 8191.426600137993, 8868.334874884376, 8889.511076890769, 8403.243708066273, 8428.452150610206, 8485.78785530362, 8486.575671216446, 8552.67433547801, 2319.5708793873146, 2353.705786776653, 2357.5638506876285, 2359.1860808021206, 2363.6927199464044, 2310.260716570698, 2332.976670233293, 2348.365941195876, 2351.8941647625898, 2359.2214569192124, 2328.3946173994714, 2334.6498025296173, 2349.18952961229, 2359.7050368703913, 2371.27676058802, 2288.6795848581214, 2293.1859189987563, 2304.585174668559, 2314.93055208344, 2332.7317358503733, 2294.724633044029, 2325.2210509479346, 2327.7439481657, 2330.778576035274, 2341.438054866837, 8707.738767836974, 8760.737177884674, 8774.341924355698, 8794.384393092487, 8796.780080497974, 4819.349387832633, 4913.656044076916, 4919.77860996256, 4922.556969872693, 4935.0, 3166.2717574957887, 3231.111444352798, 3324.2852786650988, 3344.4481660525985, 3371.123507887942, 1072.8122578548723, 1079.1043433949803, 1099.3294090604725, 1099.9560017599285, 1100.9009189173014, 11858.703532411673, 11864.58473953416, 11876.465559049864, 11891.881081189164, 11896.345700986529, 4351.108022855307, 4433.6009759121835, 4531.728096314232, 4531.909361812745, 4535.16099521583, 10204.897951020543, 10210.285280030475, 10233.692989210336, 10234.385936843813, 10237.641682541076, 4829.6860704054125, 4845.248986407112, 4853.296272040534, 4859.173940430135, 4861.659683822169, 3982.661473774762, 4358.346248062752, 4383.495897971774, 4487.708298960557, 4490.977545112253, 3949.407588861636, 3976.0855003349393, 4084.8774536763945, 4102.610252026053, 4110.815013324348, 1232.4638782129803, 1245.5266998540496, 1249.975000500003, 1258.6916205529521, 1261.0, 818.7011740714596, 852.3394369363792, 877.9868301975475, 893.2898345815092, 1013.8935411781804, 6079.179310792986, 6133.233345831771, 6138.355472675394, 6198.907016394758, 6372.7132279047555, 959.4818797849083, 993.7565296502403, 998.9250806189565, 1002.9598816047277, 1004.8794144702537, 4078.8164532596106, 4122.3404255319, 4177.268977928911, 4242.53332133465, 4267.743935363826, 10065.798684026278, 10215.438150901771, 10231.334963227366, 10302.433366164933, 10318.17454603645, 10238.53926573306, 10265.692029239135, 10267.024632660035, 10290.588376464857, 10292.228082893664, 7819.139894611588, 8104.635291411901, 8146.185381461925, 8163.0, 8334.916650833535, 6110.7250173741395, 6159.876802463836, 6308.621482710869, 6335.628416392674, 6375.298717141203, 9246.537673116452, 9954.0, 10134.847977280198, 10203.897961020295, 10270.691879243635, 9639.421634701941, 9640.951795240979, 9725.4650994196, 9848.60605575769, 10152.238582106223, 7100.644967751695, 7579.583122928292, 7743.303102720783, 7876.763697089096, 7969.203079691984, 8173.67305307781, 8208.46644968075, 8222.0, 8283.544405057779, 8294.046184688837, 7676.309132178131, 7853.410994175346, 7880.408969327438, 7890.644920978455, 8013.278804907586, 7517.173110957681, 7589.6584653689615, 7638.0, 7682.769516914502, 7754.495957762728, 7019.403350715246, 7072.08062951813, 7091.397231235403, 7101.183363913216, 7117.1459424869345, 5041.546260836542, 5143.3570803649545, 5174.844754657366, 5292.655977361459, 5294.100002999422, 5222.42553319127, 5270.420253772006, 5288.574382125736, 5340.759665815125, 5490.780368785364], "value": 4578.932230316985, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.3374178033668, 321.79083595662803, 333.26515034349256, 336.87987441756167, 337.50892451483077, 5504.036793561121, 5600.1599760035915, 5646.209530665705, 5660.773569057238, 5733.5699822513325, 5586.748596313166, 5589.329280486337, 5625.634333768302, 5637.267155269819, 5657.0, 4330.956690433087, 4331.870043898688, 4346.739195648263, 4394.868488782938, 4395.384646149541, 4163.625273725364, 4377.802998865042, 4380.868573942771, 4438.755868427235, 4448.733076015434, 4273.444452221207, 4280.828766849338, 4302.569743025688, 4309.784510774464, 4310.8145260053425, 4289.4209281747035, 4301.182775272704, 4336.6530677545725, 4367.27939889921, 4377.409049778271, 3724.0875985383755, 3735.3649879520276, 3809.980950095232, 3818.5608655004753, 3822.140018495844, 5441.211024401479, 5454.7272636368025, 5459.262999495057, 5473.370562385337, 5473.698946557938, 4934.80260789568, 4940.777665005084, 4952.182889823211, 4988.02733466974, 4998.425181104147, 5511.779528818843, 5879.2944846618675, 5885.8822823543715, 5907.645541267495, 5970.850728731773, 4153.1486045360625, 4170.311898536738, 4172.77049762263, 4184.3932629768815, 4195.160967806451, 6145.938540614581, 6155.199824022893, 6187.350328215518, 6242.375762423767, 6249.187605611241, 4129.696243005584, 4277.786110694453, 4282.143571285756, 4322.113966636832, 4324.870253892388, 4324.870253892388, 4329.328954012133, 4333.1766964276685, 4333.220020396359, 4351.97824010878, 4938.333325001151, 4966.683828785374, 4976.3578019253555, 5004.3994720633755, 5012.0, 5860.677662728505, 5941.435563621449, 5958.702064896738, 5969.671668058211, 6011.218541589566, 1467.8091848059685, 1481.1927499512792, 1488.9032212906127, 1496.2892626002779, 1497.1241823533355, 909.7193018073459, 939.3424602778083, 939.7509659939984, 942.4109931292942, 950.8621249918862, 5045.344105266366, 5064.974675126675, 5086.77109530072, 5133.0, 5137.434882163034, 5277.920831187535, 5285.63000589955, 5350.839474815762, 5374.623776335619, 5424.267723857308, 4875.5124487551675, 4928.28539861718, 4998.825041123616, 5079.6698214615935, 5156.8195113171605, 2833.9878686133075, 2834.3622684896145, 2865.7564107051135, 2872.5547540131315, 2900.6374203224595, 5515.669059856422, 5517.531009864207, 5520.66875987434, 5559.833205003856, 5578.832635020955, 5509.531689806331, 5745.626534275259, 6281.59169653971, 6328.525360597973, 6358.809235722843, 6344.777932772331, 6376.936230637727, 6406.0, 6412.102305677209, 6421.0, 6027.78902738402, 6139.1098290746695, 6143.324234334309, 6161.0, 6171.105189747551, 6030.758769649165, 6045.21412216409, 6077.848053798691, 6082.783443311444, 6166.907496387468, 5668.574856885668, 6368.713407896563, 6378.744850206125, 6379.776707815204, 6384.680765961591, 4241.87274381769, 4250.596193361625, 4252.723572967747, 4268.2743933530755, 4271.93592096125, 6103.938960610337, 6111.419415155553, 6159.661218632839, 6208.3791620839365, 6227.719752611053, 5789.089600431932, 6005.819825405245, 6011.819645410645, 6012.669303188367, 6050.42520960508, 5887.4406931341455, 5924.289085309618, 5925.614835035709, 5939.643621382731, 5958.493528049991, 5823.242978412949, 5824.15549745293, 5845.678487683218, 5858.355580886014, 5893.44012318829, 5620.634658747168, 5908.231929849092, 5949.286085669747, 6007.48936340416, 6059.454649081604, 5800.651960882361, 5841.707914604338, 5845.240118784531, 5869.53043756507, 5899.528037756883], "value": 4409.489271505659, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.5994553131944, 701.0395757811799, 723.7647764476546, 784.941129415294, 804.9154838741932, 13448.66378340542, 14245.572632821018, 14522.782158267608, 14903.478378256763, 14986.925065374659, 14844.554663360117, 14964.476243331486, 15059.472918447857, 15126.243687815593, 15141.621459463491, 634.0837489827202, 770.3606007014165, 796.1560745609657, 801.3348920396087, 813.3899575318511, 804.2399932064202, 812.5571563497908, 815.0586073085595, 815.9061707903578, 816.0533780814256, 843.8481073406784, 845.344857735254, 848.5333066813259, 848.9872651910226, 852.3947996922193, 840.9075001749833, 841.9452735572199, 843.9493630382196, 844.0462277626243, 847.2882778466118, 616.0, 620.2618883528587, 620.4694985787132, 621.1304174156172, 622.7913648927615, 13805.654858628513, 13921.930390348085, 13945.302734863217, 13977.440902363893, 14019.859801402059, 15152.696946061127, 15242.314095865713, 15431.459898903484, 15493.690126197525, 15654.139022353766, 12138.039278015656, 12218.877811221862, 12297.139200255986, 12308.446119924625, 12724.363781810873, 3962.920741585152, 3979.5025621797276, 4045.939310910339, 4082.8162732676806, 4185.560516145792, 81297.0, 81499.18500814975, 82354.58822705848, 82450.17549824485, 85968.14031859663, 12224.572139975058, 12247.387630618612, 12269.754604907852, 12494.437750301258, 12544.0, 23310.0, 23461.88269058678, 23611.40971475727, 23668.881655591955, 23695.0, 7902.881456778153, 8381.41330106899, 8465.915340846635, 8468.618912148968, 9172.44965302084, 4833.202521583969, 4935.358403407534, 4978.701277923336, 4996.775145118479, 5029.497050294941, 3515.5605549306338, 3643.908902277464, 3654.9766065501703, 3655.83548740302, 3664.358737220976, 614.6834380294152, 634.9555531112778, 637.8182218067828, 638.3520726462644, 659.8878190707495, 695.7078027228577, 756.837279984806, 757.9886301705479, 762.9542227466259, 779.5128044971892, 9111.544422778967, 9730.855018587361, 9809.754756131011, 9883.50582470888, 10572.15422766177, 548.9780408783683, 659.1694464974167, 663.4062514049898, 716.8279612892973, 754.2043144482514, 4648.883777905579, 4659.860204193879, 4713.905721885543, 4779.498152693986, 4876.4392094909535, 114612.0, 118255.0, 118592.0, 119330.0, 121356.0, 94347.52826235825, 94925.0, 95057.0, 95195.78200354776, 95326.0, 90280.5485972566, 90702.54648726847, 92851.60722589167, 94148.0, 94202.0, 9052.818943621223, 9072.773180670536, 9111.225545828678, 9469.526523673927, 9511.286653500876, 52144.73927630338, 52315.47684523258, 52987.0, 53069.0, 53754.193687093946, 68069.31930680828, 68456.6577167111, 76830.0, 77417.41951934149, 80570.59714701389, 11741.530338786353, 12002.779485795156, 12089.939550302544, 12100.213486123374, 12631.494740210288, 11845.407729613657, 11850.466728997388, 11992.580259690869, 12111.455108359132, 12141.696457588278, 12870.613881583567, 13125.212487250796, 13453.125546839425, 13583.52457663977, 13759.0, 12170.756584868075, 12310.938445307716, 12367.814482782585, 12834.55079072228, 12845.165064270792, 12089.39553022363, 12574.811377829523, 14170.858291417366, 14257.358418871383, 14402.783958240425, 11089.372436463995, 11224.494897729784, 11234.213605047567, 11264.267822591506, 11578.0, 11168.720781980515, 11420.086393088699, 11803.881961180277, 11846.703832404259, 11900.821487677518], "value": 7559.926355212484, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 105.0, 113.0, 113.0, 112.0, 111.0, 112.0, 113.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 135.0, 156.0, 178.0, 132.0, 154.0, 155.0, 138.0, 194.0, 135.0], "value": 153.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 161.0, 166.0, 166.0, 170.0, 163.0, 163.0, 161.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 75.0, 175.0, 76.0, 75.0, 74.0, 76.0, 168.0, 76.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 149.0, 85.0, 87.0, 86.0, 148.0, 85.0, 85.0, 141.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 119.0, 118.0, 119.0, 118.0, 118.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 150.0, 148.0, 149.0, 148.0, 148.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 55.0, 56.0, 58.0, 56.0, 55.0, 56.0, 55.0, 68.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 64.0, 63.0, 62.0, 62.0, 63.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 80.0, 78.0, 81.0, 86.0, 81.0, 81.0, 166.0, 86.0], "value": 91.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 125.0, 122.0, 120.0, 124.0, 129.0, 124.0, 129.0, 128.0, 123.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 165.0, 163.0, 164.0, 169.0, 168.0, 168.0, 162.0, 168.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 62.0, 65.0, 64.0, 65.0, 64.0, 66.0, 64.0], "value": 64.5, "unit": "score"}]}]} 04:41:02 INFO - Return code: 0 04:41:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:41:02 ERROR - # TBPL SUCCESS # 04:41:02 INFO - Running post-action listener: _resource_record_post_action 04:41:02 INFO - ##### 04:41:02 INFO - ##### Finished run-tests step (success) 04:41:02 INFO - ##### 04:41:02 INFO - Running post-run listener: _resource_record_post_run 04:41:03 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 551424000; Read time: 0; Write time: 389324 04:41:03 INFO - TinderboxPrint: CPU usage
13.5% 04:41:03 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:41:03 INFO - TinderboxPrint: I/O write bytes / time
551,424,000 / 389,324 04:41:03 INFO - TinderboxPrint: CPU idle
8,225.1 (86.5%) 04:41:03 INFO - TinderboxPrint: CPU user
1,226.0 (12.9%) 04:41:03 INFO - TinderboxPrint: Swap in / out
0 / 0 04:41:03 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256417792; Read time: 0; Write time: 221884 04:41:03 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 295006208; Read time: 0; Write time: 167440 04:41:03 INFO - Running post-run listener: _upload_blobber_files 04:41:03 INFO - Blob upload gear active. 04:41:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:41:03 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 04:41:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:41:04 INFO - (blobuploader) - INFO - Open directory for files ... 04:41:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:41:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:41:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:04 INFO - (blobuploader) - INFO - Done attempting. 04:41:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:41:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:41:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:08 INFO - (blobuploader) - INFO - Done attempting. 04:41:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:41:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:41:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:09 INFO - (blobuploader) - INFO - Done attempting. 04:41:09 INFO - (blobuploader) - INFO - Iteration through files over. 04:41:09 INFO - Return code: 0 04:41:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:41:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:41:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5db0e1ca8ca7fda4ddb94f8eb7fff3776aa9569305d33d3af57e2a020d991b9d66dc121e02e7359327ebc0244b1a7fec8995fa6b7bee5b9ee3275ddef3aac9d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cd0ced754cb5851fc744ed5496b6ca88d0afb9ca7d17bb1dcf155d47efc14b20b4225f42383f68e9b7e7d03d58cbfdfbc91d8e77f1b2d775e415ec6b93510d1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f85d623f783ae371ca2f61879dc6925f9fe5add0e0989e1fdf1d5e2cea88e2a1257d459fbc4efa6a3dbe5739884ea5afb20a1aaa198f5e095656cfca6831ac1a"} 04:41:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:41:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:41:09 INFO - Contents: 04:41:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5db0e1ca8ca7fda4ddb94f8eb7fff3776aa9569305d33d3af57e2a020d991b9d66dc121e02e7359327ebc0244b1a7fec8995fa6b7bee5b9ee3275ddef3aac9d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cd0ced754cb5851fc744ed5496b6ca88d0afb9ca7d17bb1dcf155d47efc14b20b4225f42383f68e9b7e7d03d58cbfdfbc91d8e77f1b2d775e415ec6b93510d1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f85d623f783ae371ca2f61879dc6925f9fe5add0e0989e1fdf1d5e2cea88e2a1257d459fbc4efa6a3dbe5739884ea5afb20a1aaa198f5e095656cfca6831ac1a"} 04:41:09 INFO - Running post-run listener: copy_logs_to_upload_dir 04:41:09 INFO - Copying logs to upload dir... 04:41:09 INFO - mkdir: /builds/slave/test/build/upload/logs 04:41:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.167511 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-23 04:41:09.431689) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 04:41:09.436048) ========= 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=41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5db0e1ca8ca7fda4ddb94f8eb7fff3776aa9569305d33d3af57e2a020d991b9d66dc121e02e7359327ebc0244b1a7fec8995fa6b7bee5b9ee3275ddef3aac9d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cd0ced754cb5851fc744ed5496b6ca88d0afb9ca7d17bb1dcf155d47efc14b20b4225f42383f68e9b7e7d03d58cbfdfbc91d8e77f1b2d775e415ec6b93510d1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f85d623f783ae371ca2f61879dc6925f9fe5add0e0989e1fdf1d5e2cea88e2a1257d459fbc4efa6a3dbe5739884ea5afb20a1aaa198f5e095656cfca6831ac1a"} build_url:https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/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/Mozilla-Inbound/sha512/5db0e1ca8ca7fda4ddb94f8eb7fff3776aa9569305d33d3af57e2a020d991b9d66dc121e02e7359327ebc0244b1a7fec8995fa6b7bee5b9ee3275ddef3aac9d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cd0ced754cb5851fc744ed5496b6ca88d0afb9ca7d17bb1dcf155d47efc14b20b4225f42383f68e9b7e7d03d58cbfdfbc91d8e77f1b2d775e415ec6b93510d1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f85d623f783ae371ca2f61879dc6925f9fe5add0e0989e1fdf1d5e2cea88e2a1257d459fbc4efa6a3dbe5739884ea5afb20a1aaa198f5e095656cfca6831ac1a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 04:41:09.462867) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:41:09.463228) ========= 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=41a7e32711b8e08598a63237000001d6-1466678393.397281-1158362613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004678 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:41:09.546907) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 04:41:09.547280) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 04:41:09.547606) ========= ========= Total master_lag: 0.22 =========