builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1466345185.73 results: success (0) buildid: 20160619043043 builduid: 9bf0bf807bf741feb3a98db45f48c5e6 revision: 284a185682c00610573eb93ae01e24c610f4daaa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-19 07:06:25.728891) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-19 07:06:25.729330) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-19 07:06:25.729618) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-19 07:06:25.790070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-19 07:06:25.790337) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-19 07:06:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-19 07:06:26 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130711 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-19 07:06:25.939481) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-19 07:06:25.939778) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019957 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-19 07:06:25.994247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-19 07:06:25.994599) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 284a185682c00610573eb93ae01e24c610f4daaa --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 284a185682c00610573eb93ae01e24c610f4daaa --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-19 07:06:26,193 truncating revision to first 12 chars 2016-06-19 07:06:26,193 Setting DEBUG logging. 2016-06-19 07:06:26,193 attempt 1/10 2016-06-19 07:06:26,193 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/284a185682c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-19 07:06:26,497 unpacking tar archive at: mozilla-inbound-284a185682c0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632563 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-19 07:06:26.640006) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-19 07:06:26.640287) ========= script_repo_revision: 284a185682c00610573eb93ae01e24c610f4daaa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-19 07:06:26.640700) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-19 07:06:26.640987) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-19 07:06:26.660047) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-06-19 07:06:26.660339) ========= /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=33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:06:26 INFO - MultiFileLogger online at 20160619 07:06:26 in /builds/slave/test 07:06:26 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 07:06:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:06:26 INFO - {'append_to_log': False, 07:06:26 INFO - 'base_work_dir': '/builds/slave/test', 07:06:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:06:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:06:26 INFO - 'branch': 'Mozilla-Inbound', 07:06:26 INFO - 'buildbot_json_path': 'buildprops.json', 07:06:26 INFO - 'config_files': ('talos/linux_config.py',), 07:06:26 INFO - 'default_actions': ('clobber', 07:06:26 INFO - 'read-buildbot-config', 07:06:26 INFO - 'download-and-extract', 07:06:26 INFO - 'populate-webroot', 07:06:26 INFO - 'create-virtualenv', 07:06:26 INFO - 'install', 07:06:26 INFO - 'run-tests'), 07:06:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:06:26 INFO - 'download_minidump_stackwalk': True, 07:06:26 INFO - 'download_symbols': 'ondemand', 07:06:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:06:26 INFO - 'tooltool.py': '/tools/tooltool.py', 07:06:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:06:26 INFO - '/tools/misc-python/virtualenv.py')}, 07:06:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:06:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:06:26 INFO - 'installer_path': 'installer.exe', 07:06:26 INFO - 'log_level': 'info', 07:06:26 INFO - 'log_name': 'talos', 07:06:26 INFO - 'log_to_console': True, 07:06:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:06:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:06:26 INFO - 'opt_config_files': (), 07:06:26 INFO - 'pip_index': False, 07:06:26 INFO - 'sps_profile': False, 07:06:26 INFO - 'sps_profile_interval': 0, 07:06:26 INFO - 'suite': 'dromaeojs-e10s', 07:06:26 INFO - 'system_bits': '32', 07:06:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:06:26 INFO - 'title': 'talos-linux64-ix-063', 07:06:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:06:26 INFO - 'use_talos_json': True, 07:06:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:06:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:06:26 INFO - 'work_dir': 'build'} 07:06:26 INFO - ##### 07:06:26 INFO - ##### Running clobber step. 07:06:26 INFO - ##### 07:06:26 INFO - Running pre-action listener: _resource_record_pre_action 07:06:26 INFO - Running main action method: clobber 07:06:26 INFO - rmtree: /builds/slave/test/build 07:06:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:06:27 INFO - Running post-action listener: _resource_record_post_action 07:06:27 INFO - ##### 07:06:27 INFO - ##### Finished clobber step (success) 07:06:27 INFO - ##### 07:06:27 INFO - ##### 07:06:27 INFO - ##### Running read-buildbot-config step. 07:06:27 INFO - ##### 07:06:27 INFO - Running pre-action listener: _resource_record_pre_action 07:06:27 INFO - Running main action method: read_buildbot_config 07:06:27 INFO - Using buildbot properties: 07:06:27 INFO - { 07:06:27 INFO - "project": "", 07:06:27 INFO - "product": "firefox", 07:06:27 INFO - "script_repo_revision": "production", 07:06:27 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:06:27 INFO - "repository": "", 07:06:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:06:27 INFO - "buildid": "20160619043043", 07:06:27 INFO - "pgo_build": "True", 07:06:27 INFO - "basedir": "/builds/slave/test", 07:06:27 INFO - "buildnumber": 734, 07:06:27 INFO - "slavename": "talos-linux64-ix-063", 07:06:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:06:27 INFO - "platform": "ubuntu64_hw", 07:06:27 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:06:27 INFO - "branch": "mozilla-inbound", 07:06:27 INFO - "repo_path": "integration/mozilla-inbound", 07:06:27 INFO - "revision": "284a185682c00610573eb93ae01e24c610f4daaa", 07:06:27 INFO - "stage_platform": "linux64-pgo", 07:06:27 INFO - "builduid": "9bf0bf807bf741feb3a98db45f48c5e6", 07:06:27 INFO - "slavebuilddir": "test" 07:06:27 INFO - } 07:06:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:06:27 INFO - Running post-action listener: _resource_record_post_action 07:06:27 INFO - ##### 07:06:27 INFO - ##### Finished read-buildbot-config step (success) 07:06:27 INFO - ##### 07:06:27 INFO - ##### 07:06:27 INFO - ##### Running download-and-extract step. 07:06:27 INFO - ##### 07:06:27 INFO - Running pre-action listener: _resource_record_pre_action 07:06:27 INFO - Running main action method: download_and_extract 07:06:27 INFO - mkdir: /builds/slave/test/build/tests 07:06: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')]} 07:06:27 INFO - https://queue.taskcluster.net/v1/task/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:06:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:06:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:06:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/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 07:06:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/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 07:06:33 INFO - Downloaded 1361 bytes. 07:06:33 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:06:33 INFO - Using the following test package requirements: 07:06:33 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:33 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:06:33 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:06:33 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:33 INFO - u'jsshell-linux-x86_64.zip'], 07:06:33 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:06:33 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:33 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:06:33 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:06:33 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:06:33 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:06:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:06:33 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')]} 07:06:33 INFO - https://queue.taskcluster.net/v1/task/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:06:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:06:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:06:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/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 07:06:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/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 07:06:34 INFO - Downloaded 24221007 bytes. 07:06:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:06:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:06:35 INFO - Return code: 0 07:06:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:35 INFO - https://queue.taskcluster.net/v1/task/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:06:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:06:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:06:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/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 07:06:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/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 07:06:40 INFO - Downloaded 24221007 bytes. 07:06: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'] 07:06: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 07:06:41 INFO - Return code: 0 07:06: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')]} 07:06:41 INFO - https://queue.taskcluster.net/v1/task/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:06:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:06:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:06:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/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 07:06:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/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 07:06:43 INFO - Downloaded 14405384 bytes. 07:06: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'] 07:06: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 07:06:43 INFO - Return code: 0 07:06: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')]} 07:06:43 INFO - https://queue.taskcluster.net/v1/task/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:06:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:06:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:06:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/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 07:06:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBsJz5igSJKFeszoxyZYzQ/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 07:06:45 INFO - Downloaded 60121688 bytes. 07:06:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:06:45 INFO - mkdir: /builds/slave/test/properties 07:06:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:06:45 INFO - Writing to file /builds/slave/test/properties/build_url 07:06:45 INFO - Contents: 07:06:45 INFO - build_url:https://queue.taskcluster.net/v1/task/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:06:46 INFO - Running post-action listener: _resource_record_post_action 07:06:46 INFO - Running post-action listener: set_extra_try_arguments 07:06:46 INFO - ##### 07:06:46 INFO - ##### Finished download-and-extract step (success) 07:06:46 INFO - ##### 07:06:46 INFO - ##### 07:06:46 INFO - ##### Running populate-webroot step. 07:06:46 INFO - ##### 07:06:46 INFO - Running pre-action listener: _resource_record_pre_action 07:06:46 INFO - Running main action method: populate_webroot 07:06:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:06:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:06:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:06:46 INFO - '--tppagecycles', 07:06:46 INFO - '7'], 07:06:46 INFO - 'tests': ['tsvgm']}}, 07:06:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:06:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:06:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:06:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:06:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:06:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:06:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:46 INFO - 'talos_options': ['--disable-e10s'], 07:06:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:46 INFO - 'talos_options': ['--disable-e10s'], 07:06:46 INFO - 'tests': ['damp', 'tps']}, 07:06:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:46 INFO - 'tests': ['damp', 'tps']}, 07:06:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:06:46 INFO - 'tests': ['dromaeo_dom']}, 07:06:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:06:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:06:46 INFO - 'tests': ['basic_compositor_video']}, 07:06:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:06:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:06:46 INFO - 'tests': ['a11yr', 07:06:46 INFO - 'ts_paint', 07:06:46 INFO - 'tpaint', 07:06:46 INFO - 'sessionrestore', 07:06:46 INFO - 'sessionrestore_no_auto_restore', 07:06:46 INFO - 'tabpaint']}, 07:06:46 INFO - 'other-e10s': {'tests': ['a11yr', 07:06:46 INFO - 'ts_paint', 07:06:46 INFO - 'tpaint', 07:06:46 INFO - 'sessionrestore', 07:06:46 INFO - 'sessionrestore_no_auto_restore', 07:06:46 INFO - 'tabpaint']}, 07:06:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:06:46 INFO - 'ts_paint', 07:06:46 INFO - 'tpaint', 07:06:46 INFO - 'sessionrestore', 07:06:46 INFO - 'sessionrestore_no_auto_restore', 07:06:46 INFO - 'tabpaint']}, 07:06:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:06:46 INFO - 'ts_paint', 07:06:46 INFO - 'tpaint', 07:06:46 INFO - 'sessionrestore', 07:06:46 INFO - 'sessionrestore_no_auto_restore', 07:06:46 INFO - 'tabpaint']}, 07:06:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:06:46 INFO - 'tests': ['a11yr', 07:06:46 INFO - 'ts_paint', 07:06:46 INFO - 'tpaint', 07:06:46 INFO - 'sessionrestore', 07:06:46 INFO - 'sessionrestore_no_auto_restore', 07:06:46 INFO - 'tabpaint']}, 07:06:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:06:46 INFO - 'tests': ['a11yr', 07:06:46 INFO - 'ts_paint', 07:06:46 INFO - 'tpaint', 07:06:46 INFO - 'sessionrestore', 07:06:46 INFO - 'sessionrestore_no_auto_restore', 07:06:46 INFO - 'tabpaint']}, 07:06:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:06:46 INFO - 'tests': ['tsvgx', 07:06:46 INFO - 'tsvgr_opacity', 07:06:46 INFO - 'tart', 07:06:46 INFO - 'tscrollx', 07:06:46 INFO - 'cart']}, 07:06:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:06:46 INFO - 'tsvgr_opacity', 07:06:46 INFO - 'tart', 07:06:46 INFO - 'tscrollx', 07:06:46 INFO - 'cart']}, 07:06:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:46 INFO - 'talos_options': ['--disable-e10s'], 07:06:46 INFO - 'tests': ['tp5o']}, 07:06:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:46 INFO - 'tests': ['tp5o']}, 07:06:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:46 INFO - 'talos_options': ['--disable-e10s', 07:06:46 INFO - '--xperf_path', 07:06:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:46 INFO - 'tests': ['tp5n']}, 07:06:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:46 INFO - 'talos_options': ['--xperf_path', 07:06:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:46 INFO - 'tests': ['tp5n']}}, 07:06:46 INFO - 'talos.zip': {'path': '', 07:06:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:06:46 INFO - Running post-action listener: _resource_record_post_action 07:06:46 INFO - ##### 07:06:46 INFO - ##### Finished populate-webroot step (success) 07:06:46 INFO - ##### 07:06:46 INFO - ##### 07:06:46 INFO - ##### Running create-virtualenv step. 07:06:46 INFO - ##### 07:06:46 INFO - Running pre-action listener: _resource_record_pre_action 07:06:46 INFO - Running main action method: create_virtualenv 07:06:46 INFO - Creating virtualenv /builds/slave/test/build/venv 07:06:46 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 07:06:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:06:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:06:46 INFO - Using real prefix '/usr' 07:06:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:06:46 INFO - Installing distribute.............................................................................................................................................................................................done. 07:06:48 INFO - Installing pip.................done. 07:06:48 INFO - Return code: 0 07:06:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:06: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')]} 07:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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 0x7f033f80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6990>, '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 0x1342470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1342900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', '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 07:06: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 07:06: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 07:06:48 INFO - Using env: {'DISPLAY': ':0', 07:06:48 INFO - 'HOME': '/home/cltbld', 07:06:48 INFO - 'LANG': 'en_US.UTF-8', 07:06:48 INFO - 'LANGUAGE': 'en_US:en', 07:06:48 INFO - 'LOGNAME': 'cltbld', 07:06:48 INFO - 'MAIL': '/var/mail/cltbld', 07:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:48 INFO - 'MOZ_NO_REMOTE': '1', 07:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:48 INFO - 'NO_EM_RESTART': '1', 07:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:48 INFO - 'PWD': '/builds/slave/test', 07:06:48 INFO - 'SHELL': '/bin/bash', 07:06:48 INFO - 'SHLVL': '1', 07:06:48 INFO - 'TERM': 'linux', 07:06:48 INFO - 'TMOUT': '86400', 07:06:48 INFO - 'USER': 'cltbld', 07:06:48 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', 07:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:48 INFO - '_': '/tools/buildbot/bin/python'} 07:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06: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 07:06:48 INFO - Cleaning up... 07:06:48 INFO - Return code: 0 07:06:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:06: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')]} 07:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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 0x7f033f80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6990>, '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 0x1342470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1342900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', '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 07:06: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 07:06: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 07:06:48 INFO - Using env: {'DISPLAY': ':0', 07:06:48 INFO - 'HOME': '/home/cltbld', 07:06:48 INFO - 'LANG': 'en_US.UTF-8', 07:06:48 INFO - 'LANGUAGE': 'en_US:en', 07:06:48 INFO - 'LOGNAME': 'cltbld', 07:06:48 INFO - 'MAIL': '/var/mail/cltbld', 07:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:48 INFO - 'MOZ_NO_REMOTE': '1', 07:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:48 INFO - 'NO_EM_RESTART': '1', 07:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:48 INFO - 'PWD': '/builds/slave/test', 07:06:48 INFO - 'SHELL': '/bin/bash', 07:06:48 INFO - 'SHLVL': '1', 07:06:48 INFO - 'TERM': 'linux', 07:06:48 INFO - 'TMOUT': '86400', 07:06:48 INFO - 'USER': 'cltbld', 07:06:48 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', 07:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:48 INFO - '_': '/tools/buildbot/bin/python'} 07:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:49 INFO - Downloading/unpacking psutil>=3.1.1 07:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:06:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:51 INFO - Installing collected packages: psutil 07:06:51 INFO - Running setup.py install for psutil 07:06:51 INFO - building 'psutil._psutil_linux' extension 07:06:51 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 07:06:51 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 07:06:51 INFO - building 'psutil._psutil_posix' extension 07:06:51 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 07:06:51 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 07:06:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:51 INFO - Successfully installed psutil 07:06:51 INFO - Cleaning up... 07:06:55 INFO - Return code: 0 07:06:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:06: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')]} 07:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f033f80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6990>, '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 0x1342470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1342900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', '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 07:06: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:06: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 mozsystemmonitor==0.3 07:06:55 INFO - Using env: {'DISPLAY': ':0', 07:06:55 INFO - 'HOME': '/home/cltbld', 07:06:55 INFO - 'LANG': 'en_US.UTF-8', 07:06:55 INFO - 'LANGUAGE': 'en_US:en', 07:06:55 INFO - 'LOGNAME': 'cltbld', 07:06:55 INFO - 'MAIL': '/var/mail/cltbld', 07:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:55 INFO - 'MOZ_NO_REMOTE': '1', 07:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:55 INFO - 'NO_EM_RESTART': '1', 07:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:55 INFO - 'PWD': '/builds/slave/test', 07:06:55 INFO - 'SHELL': '/bin/bash', 07:06:55 INFO - 'SHLVL': '1', 07:06:55 INFO - 'TERM': 'linux', 07:06:55 INFO - 'TMOUT': '86400', 07:06:55 INFO - 'USER': 'cltbld', 07:06:55 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', 07:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:55 INFO - '_': '/tools/buildbot/bin/python'} 07:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:06:58 INFO - Installing collected packages: mozsystemmonitor 07:06:58 INFO - Running setup.py install for mozsystemmonitor 07:06:59 INFO - Successfully installed mozsystemmonitor 07:06:59 INFO - Cleaning up... 07:07:06 INFO - Return code: 0 07:07:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:07: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')]} 07:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07: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')]} 07:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f033f80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6990>, '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 0x1342470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1342900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', '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 07:07: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==2.5.1'] in /builds/slave/test/build 07:07: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==2.5.1 07:07:06 INFO - Using env: {'DISPLAY': ':0', 07:07:06 INFO - 'HOME': '/home/cltbld', 07:07:06 INFO - 'LANG': 'en_US.UTF-8', 07:07:06 INFO - 'LANGUAGE': 'en_US:en', 07:07:06 INFO - 'LOGNAME': 'cltbld', 07:07:06 INFO - 'MAIL': '/var/mail/cltbld', 07:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:06 INFO - 'MOZ_NO_REMOTE': '1', 07:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:06 INFO - 'NO_EM_RESTART': '1', 07:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:06 INFO - 'PWD': '/builds/slave/test', 07:07:06 INFO - 'SHELL': '/bin/bash', 07:07:06 INFO - 'SHLVL': '1', 07:07:06 INFO - 'TERM': 'linux', 07:07:06 INFO - 'TMOUT': '86400', 07:07:06 INFO - 'USER': 'cltbld', 07:07:06 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', 07:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:06 INFO - '_': '/tools/buildbot/bin/python'} 07:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:06 INFO - Downloading/unpacking jsonschema==2.5.1 07:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:07:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:08 INFO - Downloading functools32-3.2.3-2.tar.gz 07:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:07:08 INFO - warning: no files found matching '*.txt' 07:07:08 INFO - no previously-included directories found matching 'build' 07:07:08 INFO - no previously-included directories found matching 'dist' 07:07:08 INFO - no previously-included directories found matching '.git*' 07:07:08 INFO - Installing collected packages: jsonschema, functools32 07:07:08 INFO - Running setup.py install for functools32 07:07:13 INFO - warning: no files found matching '*.txt' 07:07:13 INFO - no previously-included directories found matching 'build' 07:07:13 INFO - no previously-included directories found matching 'dist' 07:07:13 INFO - no previously-included directories found matching '.git*' 07:07:15 INFO - Successfully installed jsonschema functools32 07:07:15 INFO - Cleaning up... 07:07:16 INFO - Return code: 0 07:07:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:07:16 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')]} 07:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:16 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')]} 07:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:16 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 0x7f033f80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6990>, '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 0x1342470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1342900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', '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 07:07:16 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 07:07:16 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 07:07:16 INFO - Using env: {'DISPLAY': ':0', 07:07:16 INFO - 'HOME': '/home/cltbld', 07:07:16 INFO - 'LANG': 'en_US.UTF-8', 07:07:16 INFO - 'LANGUAGE': 'en_US:en', 07:07:16 INFO - 'LOGNAME': 'cltbld', 07:07:16 INFO - 'MAIL': '/var/mail/cltbld', 07:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:16 INFO - 'MOZ_NO_REMOTE': '1', 07:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:16 INFO - 'NO_EM_RESTART': '1', 07:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:16 INFO - 'PWD': '/builds/slave/test', 07:07:16 INFO - 'SHELL': '/bin/bash', 07:07:16 INFO - 'SHLVL': '1', 07:07:16 INFO - 'TERM': 'linux', 07:07:16 INFO - 'TMOUT': '86400', 07:07:16 INFO - 'USER': 'cltbld', 07:07:16 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', 07:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:16 INFO - '_': '/tools/buildbot/bin/python'} 07:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:16 INFO - Downloading/unpacking blobuploader==1.2.4 07:07:16 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 07:07:16 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 07:07:16 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 07:07:16 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 07:07:16 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 07:07:16 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 07:07:18 INFO - Downloading blobuploader-1.2.4.tar.gz 07:07:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:07:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:07:18 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 07:07:18 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 07:07:18 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 07:07:18 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 07:07:18 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 07:07:18 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 07:07:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:07:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:07:18 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 07:07:18 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 07:07:18 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 07:07:18 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 07:07:18 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 07:07:18 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 07:07:18 INFO - Downloading docopt-0.6.1.tar.gz 07:07:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:07:19 INFO - Installing collected packages: blobuploader, requests, docopt 07:07:19 INFO - Running setup.py install for blobuploader 07:07:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:07:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:07:19 INFO - Running setup.py install for requests 07:07:19 INFO - Running setup.py install for docopt 07:07:19 INFO - Successfully installed blobuploader requests docopt 07:07:19 INFO - Cleaning up... 07:07:19 INFO - Return code: 0 07:07:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:07:19 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')]} 07:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:19 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')]} 07:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:19 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 0x7f033f80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6990>, '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 0x1342470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1342900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', '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 07:07:19 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 07:07:19 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 07:07:19 INFO - Using env: {'DISPLAY': ':0', 07:07:19 INFO - 'HOME': '/home/cltbld', 07:07:19 INFO - 'LANG': 'en_US.UTF-8', 07:07:19 INFO - 'LANGUAGE': 'en_US:en', 07:07:19 INFO - 'LOGNAME': 'cltbld', 07:07:19 INFO - 'MAIL': '/var/mail/cltbld', 07:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:19 INFO - 'MOZ_NO_REMOTE': '1', 07:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:19 INFO - 'NO_EM_RESTART': '1', 07:07:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:19 INFO - 'PWD': '/builds/slave/test', 07:07:19 INFO - 'SHELL': '/bin/bash', 07:07:19 INFO - 'SHLVL': '1', 07:07:19 INFO - 'TERM': 'linux', 07:07:19 INFO - 'TMOUT': '86400', 07:07:19 INFO - 'USER': 'cltbld', 07:07:19 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', 07:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:19 INFO - '_': '/tools/buildbot/bin/python'} 07:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:07:19 INFO - Running setup.py (path:/tmp/pip-6Jj49y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:07:19 INFO - Running setup.py (path:/tmp/pip-Vz5n9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:07:20 INFO - Running setup.py (path:/tmp/pip-VS97ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:07:20 INFO - Running setup.py (path:/tmp/pip-UJIYDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:07:20 INFO - Running setup.py (path:/tmp/pip-6FCnb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:07:20 INFO - Running setup.py (path:/tmp/pip-ejvoBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:07:20 INFO - Running setup.py (path:/tmp/pip-gKw3sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:07:20 INFO - Running setup.py (path:/tmp/pip-6gSkub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:07:20 INFO - Running setup.py (path:/tmp/pip-TYcgS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:07:20 INFO - Running setup.py (path:/tmp/pip-mtM9EY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:07:20 INFO - Running setup.py (path:/tmp/pip-TzyJJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:07:20 INFO - Running setup.py (path:/tmp/pip-n6zMU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:07:20 INFO - Running setup.py (path:/tmp/pip-A7ZH2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:07:20 INFO - Running setup.py (path:/tmp/pip-9UccZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:07:20 INFO - Running setup.py (path:/tmp/pip-qo7aSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:07:20 INFO - Running setup.py (path:/tmp/pip-tAAPXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:07:21 INFO - Running setup.py (path:/tmp/pip-SSGqLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:07:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:07:21 INFO - Running setup.py install for manifestparser 07:07:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:07:21 INFO - Running setup.py install for mozcrash 07:07:21 INFO - Running setup.py install for mozdebug 07:07:21 INFO - Running setup.py install for mozdevice 07:07:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:07:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:07:21 INFO - Running setup.py install for mozfile 07:07:21 INFO - Running setup.py install for mozhttpd 07:07:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:07:21 INFO - Running setup.py install for mozinfo 07:07:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:07:21 INFO - Running setup.py install for mozInstall 07:07:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:07:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:07:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:07:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:07:21 INFO - Running setup.py install for mozleak 07:07:21 INFO - Running setup.py install for mozlog 07:07:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:07:22 INFO - Running setup.py install for moznetwork 07:07:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:07:22 INFO - Running setup.py install for mozprocess 07:07:22 INFO - Running setup.py install for mozprofile 07:07:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:07:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:07:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:07:22 INFO - Running setup.py install for mozrunner 07:07:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:07:22 INFO - Running setup.py install for mozscreenshot 07:07:22 INFO - Running setup.py install for moztest 07:07:22 INFO - Running setup.py install for mozversion 07:07:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:07:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:07:22 INFO - Cleaning up... 07:07:22 INFO - Return code: 0 07:07:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:07:22 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')]} 07:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:22 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')]} 07:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:22 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 0x7f033f80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6990>, '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 0x1342470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1342900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', '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 07:07:22 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 07:07:22 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 07:07:22 INFO - Using env: {'DISPLAY': ':0', 07:07:22 INFO - 'HOME': '/home/cltbld', 07:07:22 INFO - 'LANG': 'en_US.UTF-8', 07:07:22 INFO - 'LANGUAGE': 'en_US:en', 07:07:22 INFO - 'LOGNAME': 'cltbld', 07:07:22 INFO - 'MAIL': '/var/mail/cltbld', 07:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:22 INFO - 'MOZ_NO_REMOTE': '1', 07:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:22 INFO - 'NO_EM_RESTART': '1', 07:07:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:22 INFO - 'PWD': '/builds/slave/test', 07:07:22 INFO - 'SHELL': '/bin/bash', 07:07:22 INFO - 'SHLVL': '1', 07:07:22 INFO - 'TERM': 'linux', 07:07:22 INFO - 'TMOUT': '86400', 07:07:22 INFO - 'USER': 'cltbld', 07:07:22 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', 07:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:22 INFO - '_': '/tools/buildbot/bin/python'} 07:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:07:23 INFO - Running setup.py (path:/tmp/pip-R889Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:07:23 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)) 07:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:07:23 INFO - Running setup.py (path:/tmp/pip-v2HHxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:07:23 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)) 07:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:07:23 INFO - Running setup.py (path:/tmp/pip-FtINsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:07:23 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)) 07:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:07:23 INFO - Running setup.py (path:/tmp/pip-Vflya6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:07:23 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)) 07:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:07:23 INFO - Running setup.py (path:/tmp/pip-Hmm3Ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:07:23 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)) 07:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:07:23 INFO - Running setup.py (path:/tmp/pip-wZ_mZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:07:23 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)) 07:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:07:23 INFO - Running setup.py (path:/tmp/pip-Zzk1t7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:07:23 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)) 07:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:07:23 INFO - Running setup.py (path:/tmp/pip-HiEyQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:07:23 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)) 07:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:07:23 INFO - Running setup.py (path:/tmp/pip-PIh5Xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:07:23 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)) 07:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:07:23 INFO - Running setup.py (path:/tmp/pip-myNbKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:07:23 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)) 07:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:07:23 INFO - Running setup.py (path:/tmp/pip-xuPu9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:07:23 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)) 07:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:07:23 INFO - Running setup.py (path:/tmp/pip-dxxNrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:07:23 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)) 07:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:07:23 INFO - Running setup.py (path:/tmp/pip-fQdSq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:07:24 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)) 07:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:07:24 INFO - Running setup.py (path:/tmp/pip-1pA5Ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:07:24 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)) 07:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:07:24 INFO - Running setup.py (path:/tmp/pip-EpFDdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:07:24 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)) 07:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:07:24 INFO - Running setup.py (path:/tmp/pip-Itp2Pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:07:24 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)) 07:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:07:24 INFO - Running setup.py (path:/tmp/pip-VMfYzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:07:24 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)) 07:07:24 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)) 07:07:24 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)) 07:07:24 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)) 07:07:24 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)) 07:07:24 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)) 07:07:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:07:24 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 07:07:24 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 07:07:24 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 07:07:24 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 07:07:24 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 07:07:24 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 07:07:26 INFO - Downloading blessings-1.6.tar.gz 07:07:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:07:26 INFO - Installing collected packages: blessings 07:07:26 INFO - Running setup.py install for blessings 07:07:26 INFO - Successfully installed blessings 07:07:26 INFO - Cleaning up... 07:07:26 INFO - Return code: 0 07:07:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:07:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:07:26 INFO - Reading from file tmpfile_stdout 07:07:26 INFO - Current package versions: 07:07:26 INFO - argparse == 1.2.1 07:07:26 INFO - blessings == 1.6 07:07:26 INFO - blobuploader == 1.2.4 07:07:26 INFO - docopt == 0.6.1 07:07:26 INFO - functools32 == 3.2.3-2 07:07:26 INFO - jsonschema == 2.5.1 07:07:26 INFO - manifestparser == 1.1 07:07:26 INFO - mozInstall == 1.12 07:07:26 INFO - mozcrash == 0.17 07:07:26 INFO - mozdebug == 0.1 07:07:26 INFO - mozdevice == 0.48 07:07:26 INFO - mozfile == 1.2 07:07:26 INFO - mozhttpd == 0.7 07:07:26 INFO - mozinfo == 0.9 07:07:26 INFO - mozleak == 0.1 07:07:26 INFO - mozlog == 3.2 07:07:26 INFO - moznetwork == 0.27 07:07:26 INFO - mozprocess == 0.22 07:07:26 INFO - mozprofile == 0.28 07:07:26 INFO - mozrunner == 6.11 07:07:26 INFO - mozscreenshot == 0.1 07:07:26 INFO - mozsystemmonitor == 0.3 07:07:26 INFO - moztest == 0.7 07:07:26 INFO - mozversion == 1.4 07:07:26 INFO - psutil == 3.1.1 07:07:26 INFO - requests == 1.2.3 07:07:26 INFO - wsgiref == 0.1.2 07:07:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:26 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 0x7f033f80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6990>, '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 0x1342470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1342900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', '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 07:07:26 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 07:07:26 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 07:07:26 INFO - Using env: {'DISPLAY': ':0', 07:07:26 INFO - 'HOME': '/home/cltbld', 07:07:26 INFO - 'LANG': 'en_US.UTF-8', 07:07:26 INFO - 'LANGUAGE': 'en_US:en', 07:07:26 INFO - 'LOGNAME': 'cltbld', 07:07:26 INFO - 'MAIL': '/var/mail/cltbld', 07:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:26 INFO - 'MOZ_NO_REMOTE': '1', 07:07:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:26 INFO - 'NO_EM_RESTART': '1', 07:07:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:26 INFO - 'PWD': '/builds/slave/test', 07:07:26 INFO - 'SHELL': '/bin/bash', 07:07:26 INFO - 'SHLVL': '1', 07:07:26 INFO - 'TERM': 'linux', 07:07:26 INFO - 'TMOUT': '86400', 07:07:26 INFO - 'USER': 'cltbld', 07:07:26 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', 07:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:26 INFO - '_': '/tools/buildbot/bin/python'} 07:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:26 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)) 07:07:26 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)) 07:07:26 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)) 07:07:26 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)) 07:07:26 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)) 07:07:26 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)) 07:07:26 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)) 07:07:26 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)) 07:07:26 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)) 07:07:26 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)) 07:07:26 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)) 07:07:26 INFO - Cleaning up... 07:07:26 INFO - Return code: 0 07:07:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:26 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 0x7f033f80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6990>, '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 0x1342470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1342900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', '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 07:07:26 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 07:07:26 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 07:07:26 INFO - Using env: {'DISPLAY': ':0', 07:07:26 INFO - 'HOME': '/home/cltbld', 07:07:26 INFO - 'LANG': 'en_US.UTF-8', 07:07:26 INFO - 'LANGUAGE': 'en_US:en', 07:07:26 INFO - 'LOGNAME': 'cltbld', 07:07:26 INFO - 'MAIL': '/var/mail/cltbld', 07:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:26 INFO - 'MOZ_NO_REMOTE': '1', 07:07:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:26 INFO - 'NO_EM_RESTART': '1', 07:07:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:26 INFO - 'PWD': '/builds/slave/test', 07:07:26 INFO - 'SHELL': '/bin/bash', 07:07:26 INFO - 'SHLVL': '1', 07:07:26 INFO - 'TERM': 'linux', 07:07:26 INFO - 'TMOUT': '86400', 07:07:26 INFO - 'USER': 'cltbld', 07:07:26 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', 07:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:26 INFO - '_': '/tools/buildbot/bin/python'} 07:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:07:27 INFO - Cleaning up... 07:07:27 INFO - Return code: 0 07:07:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:07: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')]} 07:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07: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')]} 07:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:27 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 0x7f033f80ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13443b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d6990>, '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 0x1342470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1342900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', '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 07:07:27 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 07:07:27 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 07:07:27 INFO - Using env: {'DISPLAY': ':0', 07:07:27 INFO - 'HOME': '/home/cltbld', 07:07:27 INFO - 'LANG': 'en_US.UTF-8', 07:07:27 INFO - 'LANGUAGE': 'en_US:en', 07:07:27 INFO - 'LOGNAME': 'cltbld', 07:07:27 INFO - 'MAIL': '/var/mail/cltbld', 07:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:27 INFO - 'MOZ_NO_REMOTE': '1', 07:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:27 INFO - 'NO_EM_RESTART': '1', 07:07:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:27 INFO - 'PWD': '/builds/slave/test', 07:07:27 INFO - 'SHELL': '/bin/bash', 07:07:27 INFO - 'SHLVL': '1', 07:07:27 INFO - 'TERM': 'linux', 07:07:27 INFO - 'TMOUT': '86400', 07:07:27 INFO - 'USER': 'cltbld', 07:07:27 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', 07:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:27 INFO - '_': '/tools/buildbot/bin/python'} 07:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:27 INFO - Downloading/unpacking flake8 07:07:27 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 07:07:27 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 07:07:27 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 07:07:27 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 07:07:27 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 07:07:27 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 07:07:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:07:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:07:29 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 07:07:29 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 07:07:29 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 07:07:29 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 07:07:29 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 07:07:29 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 07:07:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:07:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:07:29 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 07:07:29 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 07:07:29 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 07:07:29 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 07:07:29 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 07:07:29 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 07:07:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:07:29 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 07:07:29 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 07:07:29 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 07:07:29 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 07:07:29 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 07:07:29 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 07:07:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:07:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:07:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:07:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:07:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:07:29 INFO - no previously-included directories found matching 'docs/_build' 07:07:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:07:30 INFO - Running setup.py install for pep8 07:07:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:07:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:07:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:07:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:07:30 INFO - no previously-included directories found matching 'docs/_build' 07:07:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:07:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:07:30 INFO - Cleaning up... 07:07:30 INFO - Return code: 0 07:07:30 INFO - Running post-action listener: _resource_record_post_action 07:07:30 INFO - Running post-action listener: _start_resource_monitoring 07:07:30 INFO - Starting resource monitoring. 07:07:30 INFO - ##### 07:07:30 INFO - ##### Finished create-virtualenv step (success) 07:07:30 INFO - ##### 07:07:30 INFO - ##### 07:07:30 INFO - ##### Running install step. 07:07:30 INFO - ##### 07:07:30 INFO - Running pre-action listener: _resource_record_pre_action 07:07:30 INFO - Running main action method: install 07:07:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:07:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:07:30 INFO - Reading from file tmpfile_stdout 07:07:30 INFO - Detecting whether we're running mozinstall >=1.0... 07:07:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:07:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:07:30 INFO - Reading from file tmpfile_stdout 07:07:30 INFO - Output received: 07:07:30 INFO - Usage: mozinstall [options] installer 07:07:30 INFO - Options: 07:07:30 INFO - -h, --help show this help message and exit 07:07:30 INFO - -d DEST, --destination=DEST 07:07:30 INFO - Directory to install application into. [default: 07:07:30 INFO - "/builds/slave/test"] 07:07:30 INFO - --app=APP Application being installed. [default: firefox] 07:07:30 INFO - mkdir: /builds/slave/test/build/application 07:07:30 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'] 07:07:30 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 07:07:47 INFO - Reading from file tmpfile_stdout 07:07:47 INFO - Output received: 07:07:47 INFO - /builds/slave/test/build/application/firefox/firefox 07:07:47 INFO - Running post-action listener: _resource_record_post_action 07:07:47 INFO - ##### 07:07:47 INFO - ##### Finished install step (success) 07:07:47 INFO - ##### 07:07:47 INFO - ##### 07:07:47 INFO - ##### Running run-tests step. 07:07:47 INFO - ##### 07:07:47 INFO - Running pre-action listener: _resource_record_pre_action 07:07:47 INFO - Running main action method: run_tests 07:07:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:07:47 INFO - Python 2.7.3 07:07:47 INFO - Return code: 0 07:07:47 INFO - grabbing minidump binary from tooltool 07:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:47 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 0x13d6990>, '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 0x1342470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1342900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:07:47 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 07:07:47 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 07:07:47 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 07:07:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:07:47 INFO - Return code: 0 07:07:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:07:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:07:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:07:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:07:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:07:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:07:48 INFO - Return code: 0 07:07:48 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/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:07:48 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/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:07:48 INFO - Using env: {'DISPLAY': ':0', 07:07:48 INFO - 'HOME': '/home/cltbld', 07:07:48 INFO - 'LANG': 'en_US.UTF-8', 07:07:48 INFO - 'LANGUAGE': 'en_US:en', 07:07:48 INFO - 'LOGNAME': 'cltbld', 07:07:48 INFO - 'MAIL': '/var/mail/cltbld', 07:07:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:07:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:48 INFO - 'MOZ_NO_REMOTE': '1', 07:07:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:48 INFO - 'NO_EM_RESTART': '1', 07:07:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:48 INFO - 'PWD': '/builds/slave/test', 07:07:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:07:48 INFO - 'SHELL': '/bin/bash', 07:07:48 INFO - 'SHLVL': '1', 07:07:48 INFO - 'TERM': 'linux', 07:07:48 INFO - 'TMOUT': '86400', 07:07:48 INFO - 'USER': 'cltbld', 07:07:48 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471', 07:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:48 INFO - '_': '/tools/buildbot/bin/python'} 07:07:48 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/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:07:48 INFO - mozversion application_buildid: 20160619043043 07:07:48 INFO - mozversion application_changeset: 284a185682c00610573eb93ae01e24c610f4daaa 07:07:48 INFO - mozversion application_display_name: Nightly 07:07:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:07:48 INFO - mozversion application_name: Firefox 07:07:48 INFO - mozversion application_remotingname: firefox 07:07:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:07:48 INFO - mozversion application_vendor: Mozilla 07:07:48 INFO - mozversion application_version: 50.0a1 07:07:48 INFO - mozversion platform_buildid: 20160619043043 07:07:48 INFO - mozversion platform_changeset: 284a185682c00610573eb93ae01e24c610f4daaa 07:07:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:07:48 INFO - mozversion platform_version: 50.0a1 07:07:48 INFO - using testdate: 1466345268 07:07:48 INFO - actual date: 1466345268 07:07:48 INFO - starting webserver on 'localhost:57614' 07:07:48 INFO - SUITE-START | Running 2 tests 07:07:48 INFO - TEST-START | dromaeo_css 07:07:48 INFO - operating with platform_type : linux_ 07:07:48 INFO - Initialising browser for dromaeo_css test... 07:07:48 INFO - TEST-INFO | started process 10947 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpevlp8d/profile http://localhost:57614/getInfo.html) 07:07:56 INFO - PROCESS | 10947 | __metrics Screen width/height:1600/1200 07:07:56 INFO - PROCESS | 10947 | colorDepth:24 07:07:56 INFO - PROCESS | 10947 | Browser inner width/height: 1024/697 07:07:56 INFO - PROCESS | 10947 | __metrics 07:07:58 ERROR - PROCESS | 10947 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 07:07:59 INFO - TEST-INFO | 10947: exit 0 07:07:59 INFO - Browser initialized. 07:07:59 INFO - Running cycle 1/1 for dromaeo_css test... 07:07:59 INFO - TEST-INFO | started process 11069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpevlp8d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:08:11 INFO - PROCESS | 11069 | RSS: Main: 184582144 07:08:11 INFO - PROCESS | 11069 | 07:09:00 INFO - PROCESS | 11069 | 1466345340944 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] 07:11:11 INFO - PROCESS | 11069 | Cycle 1(1): loaded http://localhost:57614/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57614/tests/dromaeo/cssquery-ext.html) 07:11:12 INFO - PROCESS | 11069 | RSS: Main: 189222912 07:11:12 INFO - PROCESS | 11069 | 07:14:14 INFO - PROCESS | 11069 | Cycle 1(1): loaded http://localhost:57614/tests/dromaeo/cssquery-ext.html (next: http://localhost:57614/tests/dromaeo/cssquery-jquery.html) 07:14:15 INFO - PROCESS | 11069 | RSS: Main: 187789312 07:14:15 INFO - PROCESS | 11069 | 07:17:17 INFO - PROCESS | 11069 | Cycle 1(1): loaded http://localhost:57614/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57614/tests/dromaeo/cssquery-mootools.html) 07:17:17 INFO - PROCESS | 11069 | RSS: Main: 189067264 07:17:17 INFO - PROCESS | 11069 | 07:20:19 INFO - PROCESS | 11069 | Cycle 1(1): loaded http://localhost:57614/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57614/tests/dromaeo/cssquery-prototype.html) 07:20:20 INFO - PROCESS | 11069 | RSS: Main: 186351616 07:20:20 INFO - PROCESS | 11069 | 07:23:22 INFO - PROCESS | 11069 | Cycle 1(1): loaded http://localhost:57614/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57614/tests/dromaeo/cssquery-yui.html) 07:23:23 INFO - PROCESS | 11069 | RSS: Main: 188571648 07:23:23 INFO - PROCESS | 11069 | 07:26:25 INFO - PROCESS | 11069 | Cycle 1(1): loaded http://localhost:57614/tests/dromaeo/cssquery-yui.html (next: http://localhost:57614/tests/dromaeo/cssquery-dojo.html) 07:26:25 INFO - PROCESS | 11069 | RSS: Main: 189960192 07:26:25 INFO - PROCESS | 11069 | 07:26:25 INFO - PROCESS | 11069 | __start_tp_report 07:26:25 INFO - PROCESS | 11069 | _x_x_mozilla_page_load 07:26:25 INFO - PROCESS | 11069 | _x_x_mozilla_page_load_details 07:26:25 INFO - PROCESS | 11069 | |i|pagename|runs| 07:26:25 INFO - PROCESS | 11069 | |0;dojo.html;3045.0864740577827;3048.5579590959296;3048.817070975743;3080.245339891726;3099.7055279748415;5173.172292433212;5189.844304670856;5194.298769666103;5330.253764472977;5358.812441564546;5131.3842338919385;5284.418713941473;5306.177542480912;5321.813736519222;5506.559475241971;4939;4943.332650092228;4953.133201689708;4973.5523802857915;5022.673526220802;4717.103750287434;4764.66647334685;4803.327534145223;4850.927236091461;4920.040592084527;4787.13831510328;4803;4804.807807687688;4862.36789217403;4921.089598424303;4850.514948505156;4868.561829435368;4870.537298956629;4882.292067650171;4902.950970490285;4794.976025119887;4833.057553777015;4863.8540843774745;4871.171900776876;4879.780409881529;5370.838874833722;5373.865653358658;5384.730763461811;5393.056215162331;5396.082665946759;5508.91736623951;5629.831105066854;5721.39925307845;5725.656460612377;5729.341125770548;5730.828075157752;5741.741621627037;5792.275965504312;5808.59339846211;5850.210221620112;5398.460153984609;5408.783648654088;5411.83764487066;5417.45825417459;5420.07858664028;5665.49010589049;5763.884722305615;5777.566682498829;5882.323532793698;5883.911741323884;5628.380878103405;5628.690422026828;5635.042042852725;5636.746346414421;5642.943570564242;5488.067028605146;5587.161925711094;5625.493705566519;5660.264165658438;5670.8015219467125;5518.779248830002;5639.125935480007;5659.688717120598;5667.12159615252;5685.715714214272;5664.518515926193;5734.369219385864;5737.3115226172295;5751.8562035949435;5798.072308430631;4415.205263052681;4417;4418;4425.933610995838;4426.026274219666;3893.4549163117185;3917.6865850731874;3930.9606903931167;3973.2848087343978;3989.3218152914073;5449;5468.125099983983;5469.726513674301;5475.260839786658;5511.366192887789;5777.88444231113;5782.277215348082;5793.073108302736;5797.507211886952;5798.333191682926;5277.340332458442;5390.353157621111;5407.297051383295;5425.131978883439;5444.727763611882;4968.527989840959;4968.527989841032;4972;4987.102321582078;5025.246213068069;5879.617824841372;5939.198208241918;5948.613340132878;5951.256092988377;5953.523718102628;5550.944490555043;5648.830535083954;5675.971620141873;5708.115242137475;5772.509336706427;5815.447532484407;5845.240118784531;5884.146798714248;5892.322382926019;5914.290285165807;5423.647462914898;5583.106702927512;5589.776408943597;5603.0474819281635;5618.410066942912;5556.72216389187;5628.577856660685;5646.265985421869;5748.310202775694;5758.539316854725;5538.501534861882;5569.972150139223;5570.2480165177185;5610.326760788732;5623.3533143689;5591.804286849941;5599.692016939108;5602.971985140048;5609.74756135983;5614.719264036864;5303.098473259478;5475.6440831345835;5518;5518.255035570147;5519.889602207853;5565.888682226414;5629.268195134607;5646.774129034792;5647.068233741386;5658.349289831557;5283.731904342853;5468.589855760754;5511.145772405283;5526.17107433872;5583.944160558342 07:26:25 INFO - PROCESS | 11069 | |1;ext.html;539.4605394605395;574.5461085742264;598.4912824099516;600.3876046432639;613.2793967088671;43962;45303.32045019327;45423.77288113559;45482;48437;42742.35886461698;43354.13291734163;47275.763621181846;47398.28902566464;47419.28871066937;8949.821003579924;8973.775655608613;9059.139381758756;9090.818183636324;9096.499692516909;8979.416337938046;9055.411398259124;9055.864162037575;9084;9105.226055785233;9145.542722863831;9164.083591640849;9184.08159184083;9206.631734730636;9229.723108306762;9112.407693499901;9140.6800761973;9151.267898568098;9177.816443671123;9193.264538836911;8980.14688604588;9049.185573298435;9065.728028159167;9116.361854670176;9146.54267286633;43193.56806431927;43506.347404788954;43609.34585981213;43850.561494384965;43905.78047109776;3328.6005679318396;3441.9483707744403;3446.104012956624;3491.9301613967577;4166.520850102247;33068.83465582681;33326.50010249848;33520.83239583787;33591.49612755811;33654.83172584146;4369.410129632491;4399.73601583906;4579.839705610321;4617.122746678154;4638.141943740419;358204;360751;362527;362544;363951.9999999974;54031.18953215705;59960;60758;61393.07910381348;67647.66176169187;66721;66727.66636166789;67283;67328.6633566829;67776;14885.33016014282;15077.773833392508;15252.237388130548;15326.846731532542;15377.923110384376;12992.935035324952;13035.413406396736;13044.934775326063;13060.151090179108;13082.542111026069;18792.938169036544;19114.426567203005;19116.80883191178;19122.52193695169;19137.60779902512;7330.157031941289;7338.889916651147;7385.81535461607;7394.334509894135;7399.408047356199;1004.4626125023077;1068.3109394440698;1128.3117298448103;1136.7499150186945;1181.6514128332162;30899.69100308968;31653.8417307912;32046.83976580102;32348.35303293921;32814.85148019856;1067.765091679829;1117.636768050387;1155.260633194756;1209.7701436726993;1213.308414203913;15408.22958852053;15667.529974100795;15752.212389380486;16023.19884005795;16292;542822;546402;547512;550809;553286;54157.72921135369;54579;54740.726296368266;54791.178132328045;54840;1367.5282027700428;1385.8336999560117;1391.5199256256778;1399.860013998592;1411.788231765223;29513.409731805674;29744.256393590334;29832.85083574568;29865.850670746506;30525.389492210477;47908.28137577869;48169.759151204016;48262.27606585974;48324.27513587369;48549.75725121493;458439;458895;458948;460870;461679;27676;27907.86046069838;28052.71947280501;28069.298267543476;28586.14241572756;45104.75963401202;45235.321470178635;45560.54439455563;45611;45643.543564565254;39112.80443597764;39211;39460.802695986335;40484.1903161941;40681;38294.42558361571;39519.604803951595;39920;40857.79571102125;41194;39708.40437393384;39997.80001099976;40370.394444082776;40505.59494405018;43380.78309608432;35019.29961400809;36309.27381452409;36700;37173.628263717015;37212.88361349164;27545.724542754317;27546.44907101887;29748.851255743582;29895.850520747255;30194.396112078073 07:26:25 INFO - PROCESS | 11069 | |2;jquery.html;379.01645230626525;382.7741632436862;389.22349911925704;394.81443721450927;398.700974269298;17357.39249126281;19888.70166947497;20280.695789563168;20351.084201210942;20378.286759963405;18231.635367292645;18341.7248741269;19112.61774764504;19209.23163073479;19273.325433609825;5562.16567514873;5601.215829783833;5612.158176273571;5714.799982000631;5724.169995350671;5606.383297837235;5664.348599911001;5718.199452076713;5720.1133824257095;5751.022326204535;5565.109582466806;5647.068233741427;5678.091505359143;5681.602287839853;5696.829095127153;5628.296462942132;5628.802991895305;5634.915476267859;5645.096784514458;5656.349519805213;4995.450500444948;5005.1491246488185;5079.822206222764;5106.591472682177;5109.105906466353;22009.779902200935;22443.775562244497;22567.097316107334;22848.885755571115;22851.54296914069;2303.447172678545;2461.4461746107163;2835.5746638004257;2889.7688184945364;3075.138961090898;14530.346134423977;15376.615584610474;15502.379904803794;15521.456749013843;15803.130827804465;2040.9591808163755;2095.72668231185;2101.7477902651626;2128.0849234829016;2166.230987999269;70466;71812;73443;85389.14610853937;93581.5320923391;16753.91623041877;17640.470785876445;17766.378176763752;18015.63968720618;18044.2782288707;31491.055268341985;32023.359532809678;32323.676763232535;32499.675003249664;32507.34985300281;9815.901840981642;10452.216083793746;10468.52891619879;10486.265961382782;10523.473826308655;8217.424780265444;8259.917400825914;8441.957790211132;8493.193146651058;8752.212300892823;8589.226969572768;9057.275417966546;9151.588178531982;9211.40125891815;9254.768630784285;3261.429249881309;3282.7045565898707;3392.9491057634154;3510.982445087758;3517.1734642359024;878.4773060029272;909.7270818754347;965.6909788867636;976.1117383181271;977.1010670183448;18786.53033674169;19149.521261968563;19221.80778192228;19294;19533.92563409026;953.9332246742662;955.3424807958187;991.8016396720541;999.6701088640731;1022.4427686910651;10534.789304213873;10850.403227822546;10897.019268265736;10929.890701093047;11004.779904401867;427198.50408227846;451748;466849;467522;467686;86339;88906.55546722225;89004.554977226;89024;89685.10314896767;989.1048601016092;990.6780296403554;995.6415690351613;1008.6469735592484;1014.051861509491;16989.235484402983;17197.74203386925;17355.913220433817;17396.652066958337;17487.475375738748;28244.15267541977;29667.85166074156;38990.41514377343;40168.79915600403;40911;53712;54165.18752218641;54964;55246.723766380914;56434.43565564292;8635.611397487253;8690.739277821676;8748;9087.273018158663;11372.829407559058;13001.544945926848;13404.664883377993;14034.789478157632;14055.437782488585;14149.08030977983;11772.882271177179;11984.64046078619;12053.819192712292;12150.817737734118;12523.499060037497;8503.702370417006;8587.914120858712;12215.633530994084;12241.265524068584;12799.656036116447;8271.296939760188;8678.739637810875;8706.303495720455;8773.736787896374;8962.551872406484;12596.748065038464;12660.177088489587;12758.87241127614;12966.67583310387;13305.667358315732;11927.522899083939;12285.262884226975;12300.630981070582;12595.748085038065;12620.684482888002 07:26:25 INFO - PROCESS | 11069 | |3;mootools.html;1444.891633127515;1445.6602698365884;1555.3778488604557;1670.649163675628;1727.1019070083564;7173.641317934109;7822.452428330019;7856.528608283493;8340.624671889773;8345.791355216123;7908.762737117896;8131.59342032899;8184.672613095484;8199;8248.7937801555;2207.701960235364;2224.3327001899447;2232.9218477353297;2241.8206543476563;2245.146844199202;2153.849230553862;2172.3157205480225;2258.8192944564476;2282.863028218304;2283.691701620285;2170.3597438755605;2183.4868805830615;2183.945401364963;2190.8466407351493;2207.558488302338;2184.923527676524;2192.9890350548226;2193.6928829963817;2196.0117946923947;2198.296545105567;2157.7087093242526;2173.630482817909;2176.4667656424117;2180.3894909425385;2185.508260641359;8072.959635201786;8165.183481651847;8208.794780130485;8214.178582141738;8217.671293148267;4667.6732628716;4799.856004319876;4810.254410566367;4812.085703716282;4815.470298267188;3038.498647723123;3107.90676279712;3164.256399746058;3166.9683303166903;3188.4101441233447;984.990150098497;985.2659768472533;991.6578780320777;1005.9597616095348;1009.5103874620803;10880.727981800519;10898.945505272502;10948.671539853738;10950.561977520889;10998.615048473264;4189.622933935961;4219.831206751695;4337.371081193272;4338.783060846945;4343.305071188594;9372;9392.530373481299;9396.48319342429;9430;9431;4758.452777930513;4807.302941073524;4821.325014497973;4836.298736683161;4836.5888899443235;3998.7000974926996;4403.185410698967;4462;4488.214562451558;4552.544745525487;3742.6070262622034;3771.41543060826;3792;3816.503854498953;3896.941545876814;1171.1743221029324;1172.865120511152;1188.1504724122294;1204.9698757530957;1212.2302338015425;915.5056269614333;932.9253659707207;975.1077763846143;978.3200675530438;999.9256745038801;5705.486506214461;5794.420557944172;5810.099434587646;5865.589408741347;5923.674197919156;439.70979153758367;452.81137015334747;458.3560098062228;460.8501788038864;938.4556956964944;3977.4033894915992;4155.4182414462;4173.353130264813;4210.073783767566;4223.366495025771;9672.903270967201;9848.21214302854;9934.354266972623;9960.252981026308;10021.348612340174;9119.772005699911;9802.068803463659;9913.851292230622;9929.702108936743;9939.453330066772;7353.963230183815;7577.280158384945;7644.847103057908;7670.386369090459;7715.228477152352;5526.336839579276;5571.637843540157;5745.224394706661;5781.768729250783;5825.155352473783;8980.685676001309;9091.045440228945;9146.268298535968;9236.168744813;9279.072092790937;9064.63741450361;9189.586468609063;9201.631934722536;9401.529923503935;9434.198093162158;7746.186650401627;7858.44990850635;7880.17258187882;7976.880346794919;8023.959880200561;7829.412794040583;7849.3328067114935;7913.44605877583;7933.563653999086;7965.800854978672;6711.932880671131;6994.160700715946;7076.575405475688;7102.715891364288;7155.749548765768;6601.603903765789;6774.119364482585;6799.354061364163;7023.613701246481;7142.5714457132735;6650.20197576294;6772.25505194438;6784.932150678627;6795.660216989032;6816.386525212754;4846.29728689331;5058.468860769566;5072.4673909239;5074.949250507448;5104.948950510596;4846.491118432514;4951.900961980668;5046.646734728681;5064.949350506595;5138.588912887035 07:26:25 INFO - PROCESS | 11069 | |4;prototype.html;308.82705684816506;310.20432590405613;313.34510872276945;318.6001568032119;319;5321.680699158053;5491.788629187604;5679.636887147086;5784.2769653793275;5793.971030144854;5609.747561359738;5667.5749318801045;5671.546276297897;5680.147977803332;5691.601587888849;4306.8277268909205;4370.847020354288;4381.978090109545;4388.385626012345;4405.788408187758;4103.9070074262045;4396.384506169139;4400.867973960786;4411.933820992687;4440.711353761995;4249.25638013348;4267.591694740744;4274.487061552618;4291.141771645668;4293.334533147352;4242.490901091889;4256.5099416841185;4267.4025636410925;4269.146170765859;4300.462442194726;3714.5542534895717;3717.9070523237137;3733.4586484959527;3745.606711295329;3773.5660399054186;5218.452062533417;5461.262729531502;5463.153211252262;5479.260369815092;5606.859828504279;4854.660173787836;4869.70781753096;4870.7564621769125;4879.585235255007;4891.608671306322;5739.225204597367;5840.561957853178;5867.911981320283;5868;5878.912401205791;4022.3966405039187;4028.1742242840146;4036.9394459083137;4048;4062.431259623655;5903.881922361572;5942.405759424067;5944.821655350346;6093.573449858512;6137.6010559313945;4127.4634297541725;4135.29699951009;4144.33690609501;4146.253674338588;4163;4174.91650166995;4183.97908010458;4195.328747400462;4195.853145139967;4208.621224089847;4691.554302341272;4801.927971080437;4900.583450406755;4901;4906.092372911023;5795.420457954255;5814.430103872015;5846.94153058464;5911.467967882912;5918.348981612019;1428.678547326864;1441.5819412370295;1469.0744830756555;1470.4412323317285;1472.374240947593;880.8240998267257;916.2029034739819;927.3230541704594;927.9907200927904;930.3208657679796;4946.455889852114;4953.2168419369;5036.118679231193;5085.160948443466;5091.592672586185;5310.362756469249;5338.46615338463;5344.198370244494;5347.075537179285;5387.380451248078;5071.340725705634;5080.872978175576;5140.511651393112;5317.9202311965355;5692.402297758758;3184.2835362043356;3225.822579758136;3228.2736384313343;3232.337370838972;3247.253131779704;6150.831342044997;6267.62394256346;6296.8425789354715;6304.306526282106;6317.684115794284;6157.96921015401;6160.229971253593;6190.1952746142715;6220.25356957159;6263.71813268404;6188.504919606511;6214.974529202631;6241.18864547615;6242.5353928570075;6242.625442473466;5833.504152146946;6031.155638210566;6094.8171554853425;6145.600535965148;6166.290876549254;5942.494887934574;6005.549583781321;6013.9699301503215;6054.848628784315;6061.727222275096;5918.905002574537;5947.821565353046;6198.163247961467;6222.471089957405;6287.245530536365;4217.388478670514;4235.576442355863;4245.3631955206965;4247.108107297502;4247.97876010618;5855.268091488564;6084.908726369196;6170.290416601969;6178.351273116258;6185.876282474415;5889.440503152194;5912.196779982147;5929.584929054925;5933.465988060922;6000.549958753199;5920.851978700567;5933.2880054393745;5939.426052096112;5962.493188079062;5970.402959704169;5595.860103497283;5723.914141287967;5742.454466825645;5745.482906538432;5749.396313387034;5887.587868849139;5897.348742352148;5900.790337980618;5921.733521991435;5940.287165540163;5622.522085622768;5741.45456181662;5786.855328616818;5802;5863.885861686266 07:26:25 INFO - PROCESS | 11069 | |5;yui.html;730.408369220931;763.3473380259877;812.9146439623839;846.7205822078714;869.7869022089587;15638.765418518731;16218.837811621881;16268.34926602936;16276.43032493863;16614.335426582937;12583.245005299688;12671.61985140445;12692.238465692066;12714.23714577126;12783;590.7784580782196;787.5353541410567;809.3929552835374;818.304441224957;819.7745619954501;807.6446363600027;814.5112932240638;816.2939057715093;817.7832874288318;819.2012787532168;849.3290300662469;850.0352100366098;854.3080105114877;854.6666799948025;861.7113267055513;851.6635928808117;859.4370687199894;859.4499520306978;860.4708104515709;862.9784255393665;621.8414304352361;626.589583822597;626.8558231606756;626.9341719119518;627.137685682187;14793.40826366944;14932.701345973128;15063.322150503254;15090.773638395432;15096.773548396783;12184.573539926148;12408.81386779199;12502.874971250261;15517.922410387875;15974.920125399414;11994.880051199463;12166.939165304206;12218;12304.81542776859;12558.623241302776;4352.695311328208;4388.802503887333;4427.158839820424;4454.2873140297725;4558.817647294104;76150.61924690341;77548;78717.21282787214;78919.68642508585;79861;11078.169137314733;11348.829767553494;11370.545178192946;11402.315861048197;11514.53941842317;19767.60464790725;19895.502612434804;19969.20123195056;20012.299569515;20041.198352066047;7932.484388514728;7965.084015338194;7995.040595128622;8132.634031468599;8217.630206640715;4500.212462818994;4541.2733962565835;4547.317902314613;4617.930731039037;4754.286856971482;3438.8108654023767;3500.317438099546;3524.6827785498917;3525.8765943191866;3565.2691198304806;605.2102006881063;608.0939400293619;608.2913405882098;610.7129649065021;634.7524465458475;683.6752542542353;685.2975699907635;689.6413864790281;706.4983861458422;725.1081170160732;9369.859452108223;9565.61737530491;9674.937583449551;9734.420692369402;10118.645847395454;616.8334549671564;692.984777301246;741.1106671993629;757.5379018798528;792.6472719639705;5011.198208286657;5107.642465027412;5111.744412779346;5256.421793602701;5282.2340760589495;114608;117902;118293;119270.8072919277;119960;96230.51884740671;98872;100031.49984250033;100949;101290.49354753179;91817;92251.07748922559;92343.5382823095;92610.53694731483;95549;9568.035312151935;9652.131308182297;9656.95171524138;9677.177439917687;9704.6118155273;49063;50490;50733.492665072874;51754.74122629363;53157;71138.64430677814;78146;78717.21282787099;78917.60541197257;79823;12180.878191217975;12289;12754;12799.744005119659;13141.737165256833;14328.283585820458;14336.49822256216;14432.206228657524;14528.636784080483;14651.12093274407;13539.458421663023;13585.728285434434;13842.65393365174;13903.652408689459;14028.368723407675;13025.283609401575;13190;13648.727025459237;13737.381817818023;14124.78812817788;12218;12219.327936963553;12652.17760845542;13421;13647.181169129884;11124.61063862761;11152.21934464612;11155.888441115485;11251.662450126181;11398.259113157617;11025.61410350634;11101.666949991513;11190.776184476103;11233.831492527783;11321.660350189508 07:26:25 INFO - PROCESS | 11069 | __end_tp_report 07:26:25 INFO - PROCESS | 11069 | __start_cc_report 07:26:25 INFO - PROCESS | 11069 | _x_x_mozilla_cycle_collect,365 07:26:25 INFO - PROCESS | 11069 | __end_cc_report 07:26:25 INFO - PROCESS | 11069 | __startTimestamp1466346385758__endTimestamp 07:26:25 INFO - PROCESS | 11069 | 07:26:25 INFO - PROCESS | 11069 | ------- Summary: start ------- 07:26:25 INFO - PROCESS | 11069 | Number of tests: 6 07:26:25 INFO - PROCESS | 11069 | 07:26:25 INFO - PROCESS | 11069 | [#0] dojo.html Cycles:165 Average:5305.27 Median:5511.37 stddev:594.61 (10.8%) stddev-sans-first:569.38 07:26:25 INFO - PROCESS | 11069 | Values: 3045.1 3048.6 3048.8 3080.2 3099.7 5173.2 5189.8 5194.3 5330.3 5358.8 5131.4 5284.4 5306.2 5321.8 5506.6 4939.0 4943.3 4953.1 4973.6 5022.7 4717.1 4764.7 4803.3 4850.9 4920.0 4787.1 4803.0 4804.8 4862.4 4921.1 4850.5 4868.6 4870.5 4882.3 4903.0 4795.0 4833.1 4863.9 4871.2 4879.8 5370.8 5373.9 5384.7 5393.1 5396.1 5508.9 5629.8 5721.4 5725.7 5729.3 5730.8 5741.7 5792.3 5808.6 5850.2 5398.5 5408.8 5411.8 5417.5 5420.1 5665.5 5763.9 5777.6 5882.3 5883.9 5628.4 5628.7 5635.0 5636.7 5642.9 5488.1 5587.2 5625.5 5660.3 5670.8 5518.8 5639.1 5659.7 5667.1 5685.7 5664.5 5734.4 5737.3 5751.9 5798.1 4415.2 4417.0 4418.0 4425.9 4426.0 3893.5 3917.7 3931.0 3973.3 3989.3 5449.0 5468.1 5469.7 5475.3 5511.4 5777.9 5782.3 5793.1 5797.5 5798.3 5277.3 5390.4 5407.3 5425.1 5444.7 4968.5 4968.5 4972.0 4987.1 5025.2 5879.6 5939.2 5948.6 5951.3 5953.5 5550.9 5648.8 5676.0 5708.1 5772.5 5815.4 5845.2 5884.1 5892.3 5914.3 5423.6 5583.1 5589.8 5603.0 5618.4 5556.7 5628.6 5646.3 5748.3 5758.5 5538.5 5570.0 5570.2 5610.3 5623.4 5591.8 5599.7 5603.0 5609.7 5614.7 5303.1 5475.6 5518.0 5518.3 5519.9 5565.9 5629.3 5646.8 5647.1 5658.3 5283.7 5468.6 5511.1 5526.2 5583.9 07:26:25 INFO - PROCESS | 11069 | 07:26:25 INFO - PROCESS | 11069 | [#1] ext.html Cycles:180 Average:61621.80 Median:43273.85 stddev:122813.98 (283.8%) stddev-sans-first:123072.88 07:26:25 INFO - PROCESS | 11069 | Values: 539.5 574.5 598.5 600.4 613.3 43962.0 45303.3 45423.8 45482.0 48437.0 42742.4 43354.1 47275.8 47398.3 47419.3 8949.8 8973.8 9059.1 9090.8 9096.5 8979.4 9055.4 9055.9 9084.0 9105.2 9145.5 9164.1 9184.1 9206.6 9229.7 9112.4 9140.7 9151.3 9177.8 9193.3 8980.1 9049.2 9065.7 9116.4 9146.5 43193.6 43506.3 43609.3 43850.6 43905.8 3328.6 3441.9 3446.1 3491.9 4166.5 33068.8 33326.5 33520.8 33591.5 33654.8 4369.4 4399.7 4579.8 4617.1 4638.1 358204.0 360751.0 362527.0 362544.0 363952.0 54031.2 59960.0 60758.0 61393.1 67647.7 66721.0 66727.7 67283.0 67328.7 67776.0 14885.3 15077.8 15252.2 15326.8 15377.9 12992.9 13035.4 13044.9 13060.2 13082.5 18792.9 19114.4 19116.8 19122.5 19137.6 7330.2 7338.9 7385.8 7394.3 7399.4 1004.5 1068.3 1128.3 1136.7 1181.7 30899.7 31653.8 32046.8 32348.4 32814.9 1067.8 1117.6 1155.3 1209.8 1213.3 15408.2 15667.5 15752.2 16023.2 16292.0 542822.0 546402.0 547512.0 550809.0 553286.0 54157.7 54579.0 54740.7 54791.2 54840.0 1367.5 1385.8 1391.5 1399.9 1411.8 29513.4 29744.3 29832.9 29865.9 30525.4 47908.3 48169.8 48262.3 48324.3 48549.8 458439.0 458895.0 458948.0 460870.0 461679.0 27676.0 27907.9 28052.7 28069.3 28586.1 45104.8 45235.3 45560.5 45611.0 45643.5 39112.8 39211.0 39460.8 40484.2 40681.0 38294.4 39519.6 39920.0 40857.8 41194.0 39708.4 39997.8 40370.4 40505.6 43380.8 35019.3 36309.3 36700.0 37173.6 37212.9 27545.7 27546.4 29748.9 29895.9 30194.4 07:26:25 INFO - PROCESS | 11069 | 07:26:25 INFO - PROCESS | 11069 | [#2] jquery.html Cycles:180 Average:28741.13 Median:3451.97 stddev:75134.82 (2176.6%) stddev-sans-first:75315.42 07:26:25 INFO - PROCESS | 11069 | Values: 379.0 382.8 389.2 394.8 398.7 17357.4 19888.7 20280.7 20351.1 20378.3 18231.6 18341.7 19112.6 19209.2 19273.3 5562.2 5601.2 5612.2 5714.8 5724.2 5606.4 5664.3 5718.2 5720.1 5751.0 5565.1 5647.1 5678.1 5681.6 5696.8 5628.3 5628.8 5634.9 5645.1 5656.3 4995.5 5005.1 5079.8 5106.6 5109.1 22009.8 22443.8 22567.1 22848.9 22851.5 2303.4 2461.4 2835.6 2889.8 3075.1 14530.3 15376.6 15502.4 15521.5 15803.1 2041.0 2095.7 2101.7 2128.1 2166.2 70466.0 71812.0 73443.0 85389.1 93581.5 16753.9 17640.5 17766.4 18015.6 18044.3 31491.1 32023.4 32323.7 32499.7 32507.3 9815.9 10452.2 10468.5 10486.3 10523.5 8217.4 8259.9 8442.0 8493.2 8752.2 8589.2 9057.3 9151.6 9211.4 9254.8 3261.4 3282.7 3392.9 3511.0 3517.2 878.5 909.7 965.7 976.1 977.1 18786.5 19149.5 19221.8 19294.0 19533.9 953.9 955.3 991.8 999.7 1022.4 10534.8 10850.4 10897.0 10929.9 11004.8 427198.5 451748.0 466849.0 467522.0 467686.0 86339.0 88906.6 89004.6 89024.0 89685.1 989.1 990.7 995.6 1008.6 1014.1 16989.2 17197.7 17355.9 17396.7 17487.5 28244.2 29667.9 38990.4 40168.8 40911.0 53712.0 54165.2 54964.0 55246.7 56434.4 8635.6 8690.7 8748.0 9087.3 11372.8 13001.5 13404.7 14034.8 14055.4 14149.1 11772.9 11984.6 12053.8 12150.8 12523.5 8503.7 8587.9 12215.6 12241.3 12799.7 8271.3 8678.7 8706.3 8773.7 8962.6 12596.7 12660.2 12758.9 12966.7 13305.7 11927.5 12285.3 12300.6 12595.7 12620.7 07:26:25 INFO - PROCESS | 11069 | 07:26:25 INFO - PROCESS | 11069 | [#3] mootools.html Cycles:180 Average:5383.21 Median:5121.77 stddev:2987.29 (58.3%) stddev-sans-first:2981.01 07:26:25 INFO - PROCESS | 11069 | Values: 1444.9 1445.7 1555.4 1670.6 1727.1 7173.6 7822.5 7856.5 8340.6 8345.8 7908.8 8131.6 8184.7 8199.0 8248.8 2207.7 2224.3 2232.9 2241.8 2245.1 2153.8 2172.3 2258.8 2282.9 2283.7 2170.4 2183.5 2183.9 2190.8 2207.6 2184.9 2193.0 2193.7 2196.0 2198.3 2157.7 2173.6 2176.5 2180.4 2185.5 8073.0 8165.2 8208.8 8214.2 8217.7 4667.7 4799.9 4810.3 4812.1 4815.5 3038.5 3107.9 3164.3 3167.0 3188.4 985.0 985.3 991.7 1006.0 1009.5 10880.7 10898.9 10948.7 10950.6 10998.6 4189.6 4219.8 4337.4 4338.8 4343.3 9372.0 9392.5 9396.5 9430.0 9431.0 4758.5 4807.3 4821.3 4836.3 4836.6 3998.7 4403.2 4462.0 4488.2 4552.5 3742.6 3771.4 3792.0 3816.5 3896.9 1171.2 1172.9 1188.2 1205.0 1212.2 915.5 932.9 975.1 978.3 999.9 5705.5 5794.4 5810.1 5865.6 5923.7 439.7 452.8 458.4 460.9 938.5 3977.4 4155.4 4173.4 4210.1 4223.4 9672.9 9848.2 9934.4 9960.3 10021.3 9119.8 9802.1 9913.9 9929.7 9939.5 7354.0 7577.3 7644.8 7670.4 7715.2 5526.3 5571.6 5745.2 5781.8 5825.2 8980.7 9091.0 9146.3 9236.2 9279.1 9064.6 9189.6 9201.6 9401.5 9434.2 7746.2 7858.4 7880.2 7976.9 8024.0 7829.4 7849.3 7913.4 7933.6 7965.8 6711.9 6994.2 7076.6 7102.7 7155.7 6601.6 6774.1 6799.4 7023.6 7142.6 6650.2 6772.3 6784.9 6795.7 6816.4 4846.3 5058.5 5072.5 5074.9 5104.9 4846.5 4951.9 5046.6 5064.9 5138.6 07:26:25 INFO - PROCESS | 11069 | 07:26:25 INFO - PROCESS | 11069 | [#4] prototype.html Cycles:180 Average:4875.73 Median:5601.36 stddev:1465.44 (26.2%) stddev-sans-first:1428.90 07:26:25 INFO - PROCESS | 11069 | Values: 308.8 310.2 313.3 318.6 319.0 5321.7 5491.8 5679.6 5784.3 5794.0 5609.7 5667.6 5671.5 5680.1 5691.6 4306.8 4370.8 4382.0 4388.4 4405.8 4103.9 4396.4 4400.9 4411.9 4440.7 4249.3 4267.6 4274.5 4291.1 4293.3 4242.5 4256.5 4267.4 4269.1 4300.5 3714.6 3717.9 3733.5 3745.6 3773.6 5218.5 5461.3 5463.2 5479.3 5606.9 4854.7 4869.7 4870.8 4879.6 4891.6 5739.2 5840.6 5867.9 5868.0 5878.9 4022.4 4028.2 4036.9 4048.0 4062.4 5903.9 5942.4 5944.8 6093.6 6137.6 4127.5 4135.3 4144.3 4146.3 4163.0 4174.9 4184.0 4195.3 4195.9 4208.6 4691.6 4801.9 4900.6 4901.0 4906.1 5795.4 5814.4 5846.9 5911.5 5918.3 1428.7 1441.6 1469.1 1470.4 1472.4 880.8 916.2 927.3 928.0 930.3 4946.5 4953.2 5036.1 5085.2 5091.6 5310.4 5338.5 5344.2 5347.1 5387.4 5071.3 5080.9 5140.5 5317.9 5692.4 3184.3 3225.8 3228.3 3232.3 3247.3 6150.8 6267.6 6296.8 6304.3 6317.7 6158.0 6160.2 6190.2 6220.3 6263.7 6188.5 6215.0 6241.2 6242.5 6242.6 5833.5 6031.2 6094.8 6145.6 6166.3 5942.5 6005.5 6014.0 6054.8 6061.7 5918.9 5947.8 6198.2 6222.5 6287.2 4217.4 4235.6 4245.4 4247.1 4248.0 5855.3 6084.9 6170.3 6178.4 6185.9 5889.4 5912.2 5929.6 5933.5 6000.5 5920.9 5933.3 5939.4 5962.5 5970.4 5595.9 5723.9 5742.5 5745.5 5749.4 5887.6 5897.3 5900.8 5921.7 5940.3 5622.5 5741.5 5786.9 5802.0 5863.9 07:26:25 INFO - PROCESS | 11069 | 07:26:25 INFO - PROCESS | 11069 | [#5] yui.html Cycles:180 Average:21100.98 Median:4553.07 stddev:30892.90 (678.5%) stddev-sans-first:30941.70 07:26:25 INFO - PROCESS | 11069 | Values: 730.4 763.3 812.9 846.7 869.8 15638.8 16218.8 16268.3 16276.4 16614.3 12583.2 12671.6 12692.2 12714.2 12783.0 590.8 787.5 809.4 818.3 819.8 807.6 814.5 816.3 817.8 819.2 849.3 850.0 854.3 854.7 861.7 851.7 859.4 859.4 860.5 863.0 621.8 626.6 626.9 626.9 627.1 14793.4 14932.7 15063.3 15090.8 15096.8 12184.6 12408.8 12502.9 15517.9 15974.9 11994.9 12166.9 12218.0 12304.8 12558.6 4352.7 4388.8 4427.2 4454.3 4558.8 76150.6 77548.0 78717.2 78919.7 79861.0 11078.2 11348.8 11370.5 11402.3 11514.5 19767.6 19895.5 19969.2 20012.3 20041.2 7932.5 7965.1 7995.0 8132.6 8217.6 4500.2 4541.3 4547.3 4617.9 4754.3 3438.8 3500.3 3524.7 3525.9 3565.3 605.2 608.1 608.3 610.7 634.8 683.7 685.3 689.6 706.5 725.1 9369.9 9565.6 9674.9 9734.4 10118.6 616.8 693.0 741.1 757.5 792.6 5011.2 5107.6 5111.7 5256.4 5282.2 114608.0 117902.0 118293.0 119270.8 119960.0 96230.5 98872.0 100031.5 100949.0 101290.5 91817.0 92251.1 92343.5 92610.5 95549.0 9568.0 9652.1 9657.0 9677.2 9704.6 49063.0 50490.0 50733.5 51754.7 53157.0 71138.6 78146.0 78717.2 78917.6 79823.0 12180.9 12289.0 12754.0 12799.7 13141.7 14328.3 14336.5 14432.2 14528.6 14651.1 13539.5 13585.7 13842.7 13903.7 14028.4 13025.3 13190.0 13648.7 13737.4 14124.8 12218.0 12219.3 12652.2 13421.0 13647.2 11124.6 11152.2 11155.9 11251.7 11398.3 11025.6 11101.7 11190.8 11233.8 11321.7 07:26:25 INFO - PROCESS | 11069 | -------- Summary: end -------- 07:26:25 INFO - PROCESS | 11069 | 07:26:26 INFO - TEST-INFO | 11069: exit 0 07:26:26 INFO - TEST-OK | dromaeo_css | took 1117866ms 07:26:26 INFO - TEST-START | kraken 07:26:26 INFO - operating with platform_type : linux_ 07:26:26 INFO - Initialising browser for kraken test... 07:26:26 INFO - TEST-INFO | started process 11311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLsFkD8/profile http://localhost:57614/getInfo.html) 07:26:34 INFO - PROCESS | 11311 | __metrics Screen width/height:1600/1200 07:26:34 INFO - PROCESS | 11311 | colorDepth:24 07:26:34 INFO - PROCESS | 11311 | Browser inner width/height: 1024/697 07:26:34 INFO - PROCESS | 11311 | __metrics 07:26:35 ERROR - PROCESS | 11311 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 07:26:36 INFO - TEST-INFO | 11311: exit 0 07:26:36 INFO - Browser initialized. 07:26:36 INFO - Running cycle 1/1 for kraken test... 07:26:36 INFO - TEST-INFO | started process 11433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLsFkD8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:48 INFO - PROCESS | 11433 | RSS: Main: 184889344 07:26:48 INFO - PROCESS | 11433 | 07:26:51 INFO - PROCESS | 11433 | Cycle 1(1): loaded http://localhost:57614/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57614/tests/kraken/driver.html?testName=audio-beat-detection) 07:26:52 INFO - PROCESS | 11433 | RSS: Main: 190398464 07:26:52 INFO - PROCESS | 11433 | 07:26:54 INFO - PROCESS | 11433 | Cycle 1(1): loaded http://localhost:57614/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57614/tests/kraken/driver.html?testName=audio-dft) 07:26:55 INFO - PROCESS | 11433 | RSS: Main: 188866560 07:26:55 INFO - PROCESS | 11433 | 07:26:58 INFO - PROCESS | 11433 | Cycle 1(1): loaded http://localhost:57614/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57614/tests/kraken/driver.html?testName=audio-fft) 07:26:58 INFO - PROCESS | 11433 | RSS: Main: 185339904 07:26:58 INFO - PROCESS | 11433 | 07:27:01 INFO - PROCESS | 11433 | Cycle 1(1): loaded http://localhost:57614/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57614/tests/kraken/driver.html?testName=audio-oscillator) 07:27:01 INFO - PROCESS | 11433 | RSS: Main: 185610240 07:27:01 INFO - PROCESS | 11433 | 07:27:04 INFO - PROCESS | 11433 | Cycle 1(1): loaded http://localhost:57614/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57614/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:27:04 INFO - PROCESS | 11433 | RSS: Main: 186314752 07:27:04 INFO - PROCESS | 11433 | 07:27:07 INFO - PROCESS | 11433 | Cycle 1(1): loaded http://localhost:57614/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57614/tests/kraken/driver.html?testName=imaging-darkroom) 07:27:08 INFO - PROCESS | 11433 | RSS: Main: 185806848 07:27:08 INFO - PROCESS | 11433 | 07:27:11 INFO - PROCESS | 11433 | Cycle 1(1): loaded http://localhost:57614/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57614/tests/kraken/driver.html?testName=imaging-desaturate) 07:27:12 INFO - PROCESS | 11433 | RSS: Main: 182857728 07:27:12 INFO - PROCESS | 11433 | 07:27:15 INFO - PROCESS | 11433 | Cycle 1(1): loaded http://localhost:57614/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57614/tests/kraken/driver.html?testName=json-parse-financial) 07:27:15 INFO - PROCESS | 11433 | RSS: Main: 185098240 07:27:15 INFO - PROCESS | 11433 | 07:27:17 INFO - PROCESS | 11433 | Cycle 1(1): loaded http://localhost:57614/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57614/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:27:18 INFO - PROCESS | 11433 | RSS: Main: 185909248 07:27:18 INFO - PROCESS | 11433 | 07:27:19 INFO - PROCESS | 11433 | Cycle 1(1): loaded http://localhost:57614/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57614/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:27:20 INFO - PROCESS | 11433 | RSS: Main: 185507840 07:27:20 INFO - PROCESS | 11433 | 07:27:22 INFO - PROCESS | 11433 | Cycle 1(1): loaded http://localhost:57614/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57614/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:27:23 INFO - PROCESS | 11433 | RSS: Main: 186044416 07:27:23 INFO - PROCESS | 11433 | 07:27:25 INFO - PROCESS | 11433 | Cycle 1(1): loaded http://localhost:57614/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57614/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:27:26 INFO - PROCESS | 11433 | RSS: Main: 185339904 07:27:26 INFO - PROCESS | 11433 | 07:27:29 INFO - PROCESS | 11433 | Cycle 1(1): loaded http://localhost:57614/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57614/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:27:29 INFO - PROCESS | 11433 | RSS: Main: 186228736 07:27:29 INFO - PROCESS | 11433 | 07:27:31 INFO - PROCESS | 11433 | Cycle 1(1): loaded http://localhost:57614/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57614/tests/kraken/driver.html?testName=ai-astar) 07:27:31 INFO - PROCESS | 11433 | RSS: Main: 187023360 07:27:31 INFO - PROCESS | 11433 | 07:27:31 INFO - PROCESS | 11433 | __start_tp_report 07:27:31 INFO - PROCESS | 11433 | _x_x_mozilla_page_load 07:27:31 INFO - PROCESS | 11433 | _x_x_mozilla_page_load_details 07:27:31 INFO - PROCESS | 11433 | |i|pagename|runs| 07:27:31 INFO - PROCESS | 11433 | |0;ai-astar;112;108;113;112;113;113;113;112;112;113 07:27:31 INFO - PROCESS | 11433 | |1;audio-beat-detection;153;129;152;185;130;157;161;129;181;126 07:27:31 INFO - PROCESS | 11433 | |2;audio-dft;162;165;162;164;164;169;165;164;161;161 07:27:31 INFO - PROCESS | 11433 | |3;audio-fft;76;75;76;161;76;76;76;75;162;76 07:27:31 INFO - PROCESS | 11433 | |4;audio-oscillator;86;87;143;86;85;85;141;84;84;145 07:27:31 INFO - PROCESS | 11433 | |5;imaging-gaussian-blur;117;117;116;117;117;117;118;117;117;117 07:27:31 INFO - PROCESS | 11433 | |6;imaging-darkroom;146;146;148;150;147;147;149;147;146;148 07:27:31 INFO - PROCESS | 11433 | |7;imaging-desaturate;96;96;95;95;95;96;95;95;96;96 07:27:31 INFO - PROCESS | 11433 | |8;json-parse-financial;58;55;57;55;56;56;57;59;56;55 07:27:31 INFO - PROCESS | 11433 | |9;json-stringify-tinderbox;63;63;62;64;63;62;63;63;63;63 07:27:31 INFO - PROCESS | 11433 | |10;stanford-crypto-aes;85;79;81;82;82;89;83;86;106;88 07:27:31 INFO - PROCESS | 11433 | |11;stanford-crypto-ccm;122;126;133;124;126;126;137;128;129;130 07:27:31 INFO - PROCESS | 11433 | |12;stanford-crypto-pbkdf2;166;162;164;163;163;163;163;163;166;162 07:27:31 INFO - PROCESS | 11433 | |13;stanford-crypto-sha256-iterative;67;66;65;63;69;62;67;64;64;62 07:27:31 INFO - PROCESS | 11433 | __end_tp_report 07:27:31 INFO - PROCESS | 11433 | __start_cc_report 07:27:31 INFO - PROCESS | 11433 | _x_x_mozilla_cycle_collect,881 07:27:31 INFO - PROCESS | 11433 | __end_cc_report 07:27:31 INFO - PROCESS | 11433 | __startTimestamp1466346451884__endTimestamp 07:27:31 INFO - PROCESS | 11433 | 07:27:31 INFO - PROCESS | 11433 | ------- Summary: start ------- 07:27:31 INFO - PROCESS | 11433 | Number of tests: 14 07:27:31 INFO - PROCESS | 11433 | 07:27:31 INFO - PROCESS | 11433 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:1.52 (1.3%) stddev-sans-first:1.62 07:27:31 INFO - PROCESS | 11433 | Values: 112.0 108.0 113.0 112.0 113.0 113.0 113.0 112.0 112.0 113.0 07:27:31 INFO - PROCESS | 11433 | 07:27:31 INFO - PROCESS | 11433 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:155.00 stddev:21.67 (14.0%) stddev-sans-first:22.96 07:27:31 INFO - PROCESS | 11433 | Values: 153.0 129.0 152.0 185.0 130.0 157.0 161.0 129.0 181.0 126.0 07:27:31 INFO - PROCESS | 11433 | 07:27:31 INFO - PROCESS | 11433 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:2.41 (1.5%) stddev-sans-first:2.47 07:27:31 INFO - PROCESS | 11433 | Values: 162.0 165.0 162.0 164.0 164.0 169.0 165.0 164.0 161.0 161.0 07:27:31 INFO - PROCESS | 11433 | 07:27:31 INFO - PROCESS | 11433 | [#3] audio-fft Cycles:10 Average:92.90 Median:76.00 stddev:36.16 (47.6%) stddev-sans-first:37.83 07:27:31 INFO - PROCESS | 11433 | Values: 76.0 75.0 76.0 161.0 76.0 76.0 76.0 75.0 162.0 76.0 07:27:31 INFO - PROCESS | 11433 | 07:27:31 INFO - PROCESS | 11433 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:85.00 stddev:27.91 (32.8%) stddev-sans-first:28.95 07:27:31 INFO - PROCESS | 11433 | Values: 86.0 87.0 143.0 86.0 85.0 85.0 141.0 84.0 84.0 145.0 07:27:31 INFO - PROCESS | 11433 | 07:27:31 INFO - PROCESS | 11433 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 07:27:31 INFO - PROCESS | 11433 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 07:27:31 INFO - PROCESS | 11433 | 07:27:31 INFO - PROCESS | 11433 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:1.35 (0.9%) stddev-sans-first:1.33 07:27:31 INFO - PROCESS | 11433 | Values: 146.0 146.0 148.0 150.0 147.0 147.0 149.0 147.0 146.0 148.0 07:27:31 INFO - PROCESS | 11433 | 07:27:31 INFO - PROCESS | 11433 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:27:31 INFO - PROCESS | 11433 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 07:27:31 INFO - PROCESS | 11433 | 07:27:31 INFO - PROCESS | 11433 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:1.35 (2.4%) stddev-sans-first:1.30 07:27:31 INFO - PROCESS | 11433 | Values: 58.0 55.0 57.0 55.0 56.0 56.0 57.0 59.0 56.0 55.0 07:27:31 INFO - PROCESS | 11433 | 07:27:31 INFO - PROCESS | 11433 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 07:27:31 INFO - PROCESS | 11433 | Values: 63.0 63.0 62.0 64.0 63.0 62.0 63.0 63.0 63.0 63.0 07:27:31 INFO - PROCESS | 11433 | 07:27:31 INFO - PROCESS | 11433 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:84.00 stddev:7.67 (9.1%) stddev-sans-first:8.12 07:27:31 INFO - PROCESS | 11433 | Values: 85.0 79.0 81.0 82.0 82.0 89.0 83.0 86.0 106.0 88.0 07:27:31 INFO - PROCESS | 11433 | 07:27:31 INFO - PROCESS | 11433 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:128.50 stddev:4.41 (3.4%) stddev-sans-first:4.09 07:27:31 INFO - PROCESS | 11433 | Values: 122.0 126.0 133.0 124.0 126.0 126.0 137.0 128.0 129.0 130.0 07:27:31 INFO - PROCESS | 11433 | 07:27:31 INFO - PROCESS | 11433 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.50 Median:163.00 stddev:1.43 (0.9%) stddev-sans-first:1.20 07:27:31 INFO - PROCESS | 11433 | Values: 166.0 162.0 164.0 163.0 163.0 163.0 163.0 163.0 166.0 162.0 07:27:31 INFO - PROCESS | 11433 | 07:27:31 INFO - PROCESS | 11433 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.50 stddev:2.33 (3.6%) stddev-sans-first:2.35 07:27:31 INFO - PROCESS | 11433 | Values: 67.0 66.0 65.0 63.0 69.0 62.0 67.0 64.0 64.0 62.0 07:27:31 INFO - PROCESS | 11433 | -------- Summary: end -------- 07:27:31 INFO - PROCESS | 11433 | 07:27:33 INFO - TEST-INFO | 11433: exit 0 07:27:33 INFO - TEST-OK | kraken | took 66474ms 07:27:33 INFO - SUITE-END | took 1184s 07:27:33 INFO - Completed test suite (00:19:44) 07:27:33 INFO - javascript benchmark 07:27:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7312.714786508494, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3045.0864740577827, 3048.5579590959296, 3048.817070975743, 3080.245339891726, 3099.7055279748415, 5173.172292433212, 5189.844304670856, 5194.298769666103, 5330.253764472977, 5358.812441564546, 5131.3842338919385, 5284.418713941473, 5306.177542480912, 5321.813736519222, 5506.559475241971, 4939.0, 4943.332650092228, 4953.133201689708, 4973.5523802857915, 5022.673526220802, 4717.103750287434, 4764.66647334685, 4803.327534145223, 4850.927236091461, 4920.040592084527, 4787.13831510328, 4803.0, 4804.807807687688, 4862.36789217403, 4921.089598424303, 4850.514948505156, 4868.561829435368, 4870.537298956629, 4882.292067650171, 4902.950970490285, 4794.976025119887, 4833.057553777015, 4863.8540843774745, 4871.171900776876, 4879.780409881529, 5370.838874833722, 5373.865653358658, 5384.730763461811, 5393.056215162331, 5396.082665946759, 5508.91736623951, 5629.831105066854, 5721.39925307845, 5725.656460612377, 5729.341125770548, 5730.828075157752, 5741.741621627037, 5792.275965504312, 5808.59339846211, 5850.210221620112, 5398.460153984609, 5408.783648654088, 5411.83764487066, 5417.45825417459, 5420.07858664028, 5665.49010589049, 5763.884722305615, 5777.566682498829, 5882.323532793698, 5883.911741323884, 5628.380878103405, 5628.690422026828, 5635.042042852725, 5636.746346414421, 5642.943570564242, 5488.067028605146, 5587.161925711094, 5625.493705566519, 5660.264165658438, 5670.8015219467125, 5518.779248830002, 5639.125935480007, 5659.688717120598, 5667.12159615252, 5685.715714214272, 5664.518515926193, 5734.369219385864, 5737.3115226172295, 5751.8562035949435, 5798.072308430631, 4415.205263052681, 4417.0, 4418.0, 4425.933610995838, 4426.026274219666, 3893.4549163117185, 3917.6865850731874, 3930.9606903931167, 3973.2848087343978, 3989.3218152914073, 5449.0, 5468.125099983983, 5469.726513674301, 5475.260839786658, 5511.366192887789, 5777.88444231113, 5782.277215348082, 5793.073108302736, 5797.507211886952, 5798.333191682926, 5277.340332458442, 5390.353157621111, 5407.297051383295, 5425.131978883439, 5444.727763611882, 4968.527989840959, 4968.527989841032, 4972.0, 4987.102321582078, 5025.246213068069, 5879.617824841372, 5939.198208241918, 5948.613340132878, 5951.256092988377, 5953.523718102628, 5550.944490555043, 5648.830535083954, 5675.971620141873, 5708.115242137475, 5772.509336706427, 5815.447532484407, 5845.240118784531, 5884.146798714248, 5892.322382926019, 5914.290285165807, 5423.647462914898, 5583.106702927512, 5589.776408943597, 5603.0474819281635, 5618.410066942912, 5556.72216389187, 5628.577856660685, 5646.265985421869, 5748.310202775694, 5758.539316854725, 5538.501534861882, 5569.972150139223, 5570.2480165177185, 5610.326760788732, 5623.3533143689, 5591.804286849941, 5599.692016939108, 5602.971985140048, 5609.74756135983, 5614.719264036864, 5303.098473259478, 5475.6440831345835, 5518.0, 5518.255035570147, 5519.889602207853, 5565.888682226414, 5629.268195134607, 5646.774129034792, 5647.068233741386, 5658.349289831557, 5283.731904342853, 5468.589855760754, 5511.145772405283, 5526.17107433872, 5583.944160558342], "value": 5265.4147630116495, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.4605394605395, 574.5461085742264, 598.4912824099516, 600.3876046432639, 613.2793967088671, 43962.0, 45303.32045019327, 45423.77288113559, 45482.0, 48437.0, 42742.35886461698, 43354.13291734163, 47275.763621181846, 47398.28902566464, 47419.28871066937, 8949.821003579924, 8973.775655608613, 9059.139381758756, 9090.818183636324, 9096.499692516909, 8979.416337938046, 9055.411398259124, 9055.864162037575, 9084.0, 9105.226055785233, 9145.542722863831, 9164.083591640849, 9184.08159184083, 9206.631734730636, 9229.723108306762, 9112.407693499901, 9140.6800761973, 9151.267898568098, 9177.816443671123, 9193.264538836911, 8980.14688604588, 9049.185573298435, 9065.728028159167, 9116.361854670176, 9146.54267286633, 43193.56806431927, 43506.347404788954, 43609.34585981213, 43850.561494384965, 43905.78047109776, 3328.6005679318396, 3441.9483707744403, 3446.104012956624, 3491.9301613967577, 4166.520850102247, 33068.83465582681, 33326.50010249848, 33520.83239583787, 33591.49612755811, 33654.83172584146, 4369.410129632491, 4399.73601583906, 4579.839705610321, 4617.122746678154, 4638.141943740419, 358204.0, 360751.0, 362527.0, 362544.0, 363951.9999999974, 54031.18953215705, 59960.0, 60758.0, 61393.07910381348, 67647.66176169187, 66721.0, 66727.66636166789, 67283.0, 67328.6633566829, 67776.0, 14885.33016014282, 15077.773833392508, 15252.237388130548, 15326.846731532542, 15377.923110384376, 12992.935035324952, 13035.413406396736, 13044.934775326063, 13060.151090179108, 13082.542111026069, 18792.938169036544, 19114.426567203005, 19116.80883191178, 19122.52193695169, 19137.60779902512, 7330.157031941289, 7338.889916651147, 7385.81535461607, 7394.334509894135, 7399.408047356199, 1004.4626125023077, 1068.3109394440698, 1128.3117298448103, 1136.7499150186945, 1181.6514128332162, 30899.69100308968, 31653.8417307912, 32046.83976580102, 32348.35303293921, 32814.85148019856, 1067.765091679829, 1117.636768050387, 1155.260633194756, 1209.7701436726993, 1213.308414203913, 15408.22958852053, 15667.529974100795, 15752.212389380486, 16023.19884005795, 16292.0, 542822.0, 546402.0, 547512.0, 550809.0, 553286.0, 54157.72921135369, 54579.0, 54740.726296368266, 54791.178132328045, 54840.0, 1367.5282027700428, 1385.8336999560117, 1391.5199256256778, 1399.860013998592, 1411.788231765223, 29513.409731805674, 29744.256393590334, 29832.85083574568, 29865.850670746506, 30525.389492210477, 47908.28137577869, 48169.759151204016, 48262.27606585974, 48324.27513587369, 48549.75725121493, 458439.0, 458895.0, 458948.0, 460870.0, 461679.0, 27676.0, 27907.86046069838, 28052.71947280501, 28069.298267543476, 28586.14241572756, 45104.75963401202, 45235.321470178635, 45560.54439455563, 45611.0, 45643.543564565254, 39112.80443597764, 39211.0, 39460.802695986335, 40484.1903161941, 40681.0, 38294.42558361571, 39519.604803951595, 39920.0, 40857.79571102125, 41194.0, 39708.40437393384, 39997.80001099976, 40370.394444082776, 40505.59494405018, 43380.78309608432, 35019.29961400809, 36309.27381452409, 36700.0, 37173.628263717015, 37212.88361349164, 27545.724542754317, 27546.44907101887, 29748.851255743582, 29895.850520747255, 30194.396112078073], "value": 20288.53775491866, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.01645230626525, 382.7741632436862, 389.22349911925704, 394.81443721450927, 398.700974269298, 17357.39249126281, 19888.70166947497, 20280.695789563168, 20351.084201210942, 20378.286759963405, 18231.635367292645, 18341.7248741269, 19112.61774764504, 19209.23163073479, 19273.325433609825, 5562.16567514873, 5601.215829783833, 5612.158176273571, 5714.799982000631, 5724.169995350671, 5606.383297837235, 5664.348599911001, 5718.199452076713, 5720.1133824257095, 5751.022326204535, 5565.109582466806, 5647.068233741427, 5678.091505359143, 5681.602287839853, 5696.829095127153, 5628.296462942132, 5628.802991895305, 5634.915476267859, 5645.096784514458, 5656.349519805213, 4995.450500444948, 5005.1491246488185, 5079.822206222764, 5106.591472682177, 5109.105906466353, 22009.779902200935, 22443.775562244497, 22567.097316107334, 22848.885755571115, 22851.54296914069, 2303.447172678545, 2461.4461746107163, 2835.5746638004257, 2889.7688184945364, 3075.138961090898, 14530.346134423977, 15376.615584610474, 15502.379904803794, 15521.456749013843, 15803.130827804465, 2040.9591808163755, 2095.72668231185, 2101.7477902651626, 2128.0849234829016, 2166.230987999269, 70466.0, 71812.0, 73443.0, 85389.14610853937, 93581.5320923391, 16753.91623041877, 17640.470785876445, 17766.378176763752, 18015.63968720618, 18044.2782288707, 31491.055268341985, 32023.359532809678, 32323.676763232535, 32499.675003249664, 32507.34985300281, 9815.901840981642, 10452.216083793746, 10468.52891619879, 10486.265961382782, 10523.473826308655, 8217.424780265444, 8259.917400825914, 8441.957790211132, 8493.193146651058, 8752.212300892823, 8589.226969572768, 9057.275417966546, 9151.588178531982, 9211.40125891815, 9254.768630784285, 3261.429249881309, 3282.7045565898707, 3392.9491057634154, 3510.982445087758, 3517.1734642359024, 878.4773060029272, 909.7270818754347, 965.6909788867636, 976.1117383181271, 977.1010670183448, 18786.53033674169, 19149.521261968563, 19221.80778192228, 19294.0, 19533.92563409026, 953.9332246742662, 955.3424807958187, 991.8016396720541, 999.6701088640731, 1022.4427686910651, 10534.789304213873, 10850.403227822546, 10897.019268265736, 10929.890701093047, 11004.779904401867, 427198.50408227846, 451748.0, 466849.0, 467522.0, 467686.0, 86339.0, 88906.55546722225, 89004.554977226, 89024.0, 89685.10314896767, 989.1048601016092, 990.6780296403554, 995.6415690351613, 1008.6469735592484, 1014.051861509491, 16989.235484402983, 17197.74203386925, 17355.913220433817, 17396.652066958337, 17487.475375738748, 28244.15267541977, 29667.85166074156, 38990.41514377343, 40168.79915600403, 40911.0, 53712.0, 54165.18752218641, 54964.0, 55246.723766380914, 56434.43565564292, 8635.611397487253, 8690.739277821676, 8748.0, 9087.273018158663, 11372.829407559058, 13001.544945926848, 13404.664883377993, 14034.789478157632, 14055.437782488585, 14149.08030977983, 11772.882271177179, 11984.64046078619, 12053.819192712292, 12150.817737734118, 12523.499060037497, 8503.702370417006, 8587.914120858712, 12215.633530994084, 12241.265524068584, 12799.656036116447, 8271.296939760188, 8678.739637810875, 8706.303495720455, 8773.736787896374, 8962.551872406484, 12596.748065038464, 12660.177088489587, 12758.87241127614, 12966.67583310387, 13305.667358315732, 11927.522899083939, 12285.262884226975, 12300.630981070582, 12595.748085038065, 12620.684482888002], "value": 10022.844530259545, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1444.891633127515, 1445.6602698365884, 1555.3778488604557, 1670.649163675628, 1727.1019070083564, 7173.641317934109, 7822.452428330019, 7856.528608283493, 8340.624671889773, 8345.791355216123, 7908.762737117896, 8131.59342032899, 8184.672613095484, 8199.0, 8248.7937801555, 2207.701960235364, 2224.3327001899447, 2232.9218477353297, 2241.8206543476563, 2245.146844199202, 2153.849230553862, 2172.3157205480225, 2258.8192944564476, 2282.863028218304, 2283.691701620285, 2170.3597438755605, 2183.4868805830615, 2183.945401364963, 2190.8466407351493, 2207.558488302338, 2184.923527676524, 2192.9890350548226, 2193.6928829963817, 2196.0117946923947, 2198.296545105567, 2157.7087093242526, 2173.630482817909, 2176.4667656424117, 2180.3894909425385, 2185.508260641359, 8072.959635201786, 8165.183481651847, 8208.794780130485, 8214.178582141738, 8217.671293148267, 4667.6732628716, 4799.856004319876, 4810.254410566367, 4812.085703716282, 4815.470298267188, 3038.498647723123, 3107.90676279712, 3164.256399746058, 3166.9683303166903, 3188.4101441233447, 984.990150098497, 985.2659768472533, 991.6578780320777, 1005.9597616095348, 1009.5103874620803, 10880.727981800519, 10898.945505272502, 10948.671539853738, 10950.561977520889, 10998.615048473264, 4189.622933935961, 4219.831206751695, 4337.371081193272, 4338.783060846945, 4343.305071188594, 9372.0, 9392.530373481299, 9396.48319342429, 9430.0, 9431.0, 4758.452777930513, 4807.302941073524, 4821.325014497973, 4836.298736683161, 4836.5888899443235, 3998.7000974926996, 4403.185410698967, 4462.0, 4488.214562451558, 4552.544745525487, 3742.6070262622034, 3771.41543060826, 3792.0, 3816.503854498953, 3896.941545876814, 1171.1743221029324, 1172.865120511152, 1188.1504724122294, 1204.9698757530957, 1212.2302338015425, 915.5056269614333, 932.9253659707207, 975.1077763846143, 978.3200675530438, 999.9256745038801, 5705.486506214461, 5794.420557944172, 5810.099434587646, 5865.589408741347, 5923.674197919156, 439.70979153758367, 452.81137015334747, 458.3560098062228, 460.8501788038864, 938.4556956964944, 3977.4033894915992, 4155.4182414462, 4173.353130264813, 4210.073783767566, 4223.366495025771, 9672.903270967201, 9848.21214302854, 9934.354266972623, 9960.252981026308, 10021.348612340174, 9119.772005699911, 9802.068803463659, 9913.851292230622, 9929.702108936743, 9939.453330066772, 7353.963230183815, 7577.280158384945, 7644.847103057908, 7670.386369090459, 7715.228477152352, 5526.336839579276, 5571.637843540157, 5745.224394706661, 5781.768729250783, 5825.155352473783, 8980.685676001309, 9091.045440228945, 9146.268298535968, 9236.168744813, 9279.072092790937, 9064.63741450361, 9189.586468609063, 9201.631934722536, 9401.529923503935, 9434.198093162158, 7746.186650401627, 7858.44990850635, 7880.17258187882, 7976.880346794919, 8023.959880200561, 7829.412794040583, 7849.3328067114935, 7913.44605877583, 7933.563653999086, 7965.800854978672, 6711.932880671131, 6994.160700715946, 7076.575405475688, 7102.715891364288, 7155.749548765768, 6601.603903765789, 6774.119364482585, 6799.354061364163, 7023.613701246481, 7142.5714457132735, 6650.20197576294, 6772.25505194438, 6784.932150678627, 6795.660216989032, 6816.386525212754, 4846.29728689331, 5058.468860769566, 5072.4673909239, 5074.949250507448, 5104.948950510596, 4846.491118432514, 4951.900961980668, 5046.646734728681, 5064.949350506595, 5138.588912887035], "value": 4296.5096514018705, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.82705684816506, 310.20432590405613, 313.34510872276945, 318.6001568032119, 319.0, 5321.680699158053, 5491.788629187604, 5679.636887147086, 5784.2769653793275, 5793.971030144854, 5609.747561359738, 5667.5749318801045, 5671.546276297897, 5680.147977803332, 5691.601587888849, 4306.8277268909205, 4370.847020354288, 4381.978090109545, 4388.385626012345, 4405.788408187758, 4103.9070074262045, 4396.384506169139, 4400.867973960786, 4411.933820992687, 4440.711353761995, 4249.25638013348, 4267.591694740744, 4274.487061552618, 4291.141771645668, 4293.334533147352, 4242.490901091889, 4256.5099416841185, 4267.4025636410925, 4269.146170765859, 4300.462442194726, 3714.5542534895717, 3717.9070523237137, 3733.4586484959527, 3745.606711295329, 3773.5660399054186, 5218.452062533417, 5461.262729531502, 5463.153211252262, 5479.260369815092, 5606.859828504279, 4854.660173787836, 4869.70781753096, 4870.7564621769125, 4879.585235255007, 4891.608671306322, 5739.225204597367, 5840.561957853178, 5867.911981320283, 5868.0, 5878.912401205791, 4022.3966405039187, 4028.1742242840146, 4036.9394459083137, 4048.0, 4062.431259623655, 5903.881922361572, 5942.405759424067, 5944.821655350346, 6093.573449858512, 6137.6010559313945, 4127.4634297541725, 4135.29699951009, 4144.33690609501, 4146.253674338588, 4163.0, 4174.91650166995, 4183.97908010458, 4195.328747400462, 4195.853145139967, 4208.621224089847, 4691.554302341272, 4801.927971080437, 4900.583450406755, 4901.0, 4906.092372911023, 5795.420457954255, 5814.430103872015, 5846.94153058464, 5911.467967882912, 5918.348981612019, 1428.678547326864, 1441.5819412370295, 1469.0744830756555, 1470.4412323317285, 1472.374240947593, 880.8240998267257, 916.2029034739819, 927.3230541704594, 927.9907200927904, 930.3208657679796, 4946.455889852114, 4953.2168419369, 5036.118679231193, 5085.160948443466, 5091.592672586185, 5310.362756469249, 5338.46615338463, 5344.198370244494, 5347.075537179285, 5387.380451248078, 5071.340725705634, 5080.872978175576, 5140.511651393112, 5317.9202311965355, 5692.402297758758, 3184.2835362043356, 3225.822579758136, 3228.2736384313343, 3232.337370838972, 3247.253131779704, 6150.831342044997, 6267.62394256346, 6296.8425789354715, 6304.306526282106, 6317.684115794284, 6157.96921015401, 6160.229971253593, 6190.1952746142715, 6220.25356957159, 6263.71813268404, 6188.504919606511, 6214.974529202631, 6241.18864547615, 6242.5353928570075, 6242.625442473466, 5833.504152146946, 6031.155638210566, 6094.8171554853425, 6145.600535965148, 6166.290876549254, 5942.494887934574, 6005.549583781321, 6013.9699301503215, 6054.848628784315, 6061.727222275096, 5918.905002574537, 5947.821565353046, 6198.163247961467, 6222.471089957405, 6287.245530536365, 4217.388478670514, 4235.576442355863, 4245.3631955206965, 4247.108107297502, 4247.97876010618, 5855.268091488564, 6084.908726369196, 6170.290416601969, 6178.351273116258, 6185.876282474415, 5889.440503152194, 5912.196779982147, 5929.584929054925, 5933.465988060922, 6000.549958753199, 5920.851978700567, 5933.2880054393745, 5939.426052096112, 5962.493188079062, 5970.402959704169, 5595.860103497283, 5723.914141287967, 5742.454466825645, 5745.482906538432, 5749.396313387034, 5887.587868849139, 5897.348742352148, 5900.790337980618, 5921.733521991435, 5940.287165540163, 5622.522085622768, 5741.45456181662, 5786.855328616818, 5802.0, 5863.885861686266], "value": 4394.434587965916, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.408369220931, 763.3473380259877, 812.9146439623839, 846.7205822078714, 869.7869022089587, 15638.765418518731, 16218.837811621881, 16268.34926602936, 16276.43032493863, 16614.335426582937, 12583.245005299688, 12671.61985140445, 12692.238465692066, 12714.23714577126, 12783.0, 590.7784580782196, 787.5353541410567, 809.3929552835374, 818.304441224957, 819.7745619954501, 807.6446363600027, 814.5112932240638, 816.2939057715093, 817.7832874288318, 819.2012787532168, 849.3290300662469, 850.0352100366098, 854.3080105114877, 854.6666799948025, 861.7113267055513, 851.6635928808117, 859.4370687199894, 859.4499520306978, 860.4708104515709, 862.9784255393665, 621.8414304352361, 626.589583822597, 626.8558231606756, 626.9341719119518, 627.137685682187, 14793.40826366944, 14932.701345973128, 15063.322150503254, 15090.773638395432, 15096.773548396783, 12184.573539926148, 12408.81386779199, 12502.874971250261, 15517.922410387875, 15974.920125399414, 11994.880051199463, 12166.939165304206, 12218.0, 12304.81542776859, 12558.623241302776, 4352.695311328208, 4388.802503887333, 4427.158839820424, 4454.2873140297725, 4558.817647294104, 76150.61924690341, 77548.0, 78717.21282787214, 78919.68642508585, 79861.0, 11078.169137314733, 11348.829767553494, 11370.545178192946, 11402.315861048197, 11514.53941842317, 19767.60464790725, 19895.502612434804, 19969.20123195056, 20012.299569515, 20041.198352066047, 7932.484388514728, 7965.084015338194, 7995.040595128622, 8132.634031468599, 8217.630206640715, 4500.212462818994, 4541.2733962565835, 4547.317902314613, 4617.930731039037, 4754.286856971482, 3438.8108654023767, 3500.317438099546, 3524.6827785498917, 3525.8765943191866, 3565.2691198304806, 605.2102006881063, 608.0939400293619, 608.2913405882098, 610.7129649065021, 634.7524465458475, 683.6752542542353, 685.2975699907635, 689.6413864790281, 706.4983861458422, 725.1081170160732, 9369.859452108223, 9565.61737530491, 9674.937583449551, 9734.420692369402, 10118.645847395454, 616.8334549671564, 692.984777301246, 741.1106671993629, 757.5379018798528, 792.6472719639705, 5011.198208286657, 5107.642465027412, 5111.744412779346, 5256.421793602701, 5282.2340760589495, 114608.0, 117902.0, 118293.0, 119270.8072919277, 119960.0, 96230.51884740671, 98872.0, 100031.49984250033, 100949.0, 101290.49354753179, 91817.0, 92251.07748922559, 92343.5382823095, 92610.53694731483, 95549.0, 9568.035312151935, 9652.131308182297, 9656.95171524138, 9677.177439917687, 9704.6118155273, 49063.0, 50490.0, 50733.492665072874, 51754.74122629363, 53157.0, 71138.64430677814, 78146.0, 78717.21282787099, 78917.60541197257, 79823.0, 12180.878191217975, 12289.0, 12754.0, 12799.744005119659, 13141.737165256833, 14328.283585820458, 14336.49822256216, 14432.206228657524, 14528.636784080483, 14651.12093274407, 13539.458421663023, 13585.728285434434, 13842.65393365174, 13903.652408689459, 14028.368723407675, 13025.283609401575, 13190.0, 13648.727025459237, 13737.381817818023, 14124.78812817788, 12218.0, 12219.327936963553, 12652.17760845542, 13421.0, 13647.181169129884, 11124.61063862761, 11152.21934464612, 11155.888441115485, 11251.662450126181, 11398.259113157617, 11025.61410350634, 11101.666949991513, 11190.776184476103, 11233.831492527783, 11321.660350189508], "value": 7563.633717119044, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 113.0, 112.0, 113.0, 113.0, 113.0, 112.0, 112.0, 113.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 129.0, 152.0, 185.0, 130.0, 157.0, 161.0, 129.0, 181.0, 126.0], "value": 150.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 162.0, 164.0, 164.0, 169.0, 165.0, 164.0, 161.0, 161.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 161.0, 76.0, 76.0, 76.0, 75.0, 162.0, 76.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 143.0, 86.0, 85.0, 85.0, 141.0, 84.0, 84.0, 145.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 148.0, 150.0, 147.0, 147.0, 149.0, 147.0, 146.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 57.0, 55.0, 56.0, 56.0, 57.0, 59.0, 56.0, 55.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 64.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 81.0, 82.0, 82.0, 89.0, 83.0, 86.0, 106.0, 88.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 126.0, 133.0, 124.0, 126.0, 126.0, 137.0, 128.0, 129.0, 130.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 164.0, 163.0, 163.0, 163.0, 163.0, 163.0, 166.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 63.0, 69.0, 62.0, 67.0, 64.0, 64.0, 62.0], "value": 64.9, "unit": "score"}]}]} 07:27:33 INFO - Return code: 0 07:27:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:27:33 ERROR - # TBPL SUCCESS # 07:27:33 INFO - Running post-action listener: _resource_record_post_action 07:27:33 INFO - ##### 07:27:33 INFO - ##### Finished run-tests step (success) 07:27:33 INFO - ##### 07:27:33 INFO - Running post-run listener: _resource_record_post_run 07:27:33 INFO - Total resource usage - Wall time: 1203s; CPU: 14.0%; Read bytes: 4096; Write bytes: 294010880; Read time: 24; Write time: 1943528 07:27:33 INFO - TinderboxPrint: CPU usage
13.8% 07:27:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 07:27:33 INFO - TinderboxPrint: I/O write bytes / time
294,010,880 / 1,943,528 07:27:33 INFO - TinderboxPrint: CPU idle
8,273.6 (86.2%) 07:27:33 INFO - TinderboxPrint: CPU user
1,219.1 (12.7%) 07:27:33 INFO - TinderboxPrint: Swap in / out
0 / 0 07:27:33 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1191936; Read time: 0; Write time: 2340 07:27:33 INFO - run-tests - Wall time: 1186s; CPU: 14.0%; Read bytes: 4096; Write bytes: 292818944; Read time: 24; Write time: 1941188 07:27:34 INFO - Running post-run listener: _upload_blobber_files 07:27:34 INFO - Blob upload gear active. 07:27:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:27:34 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 07:27:34 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'] 07:27:34 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 07:27:34 INFO - (blobuploader) - INFO - Open directory for files ... 07:27:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:27:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:27:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:27:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:38 INFO - (blobuploader) - INFO - Done attempting. 07:27:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:27:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:27:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:27:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:38 INFO - (blobuploader) - INFO - Done attempting. 07:27:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:27:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:27:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:27:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:39 INFO - (blobuploader) - INFO - Done attempting. 07:27:39 INFO - (blobuploader) - INFO - Iteration through files over. 07:27:39 INFO - Return code: 0 07:27:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:27:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:27:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9db4e94f6e997595ad856cc834d13199c361e12f0f8621197e2e844f06fb8af7c30d102aa845c004fd7d724cb3ab29a65cacb0468e64786648836ed394d2f9ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/da2780f53bd439c7b0164496e9e466cd903c6e229078e186106005f3ca2ee37b205d712ad9e718c5cdaf0bd7a2840f37e18470f82828aea931a05935553e61c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8212aea754a9a5b252d8cba2f3cd13adc394be2e0f278159bbb9657bed440f50ab845b28620f1c3d430e548faa3369c832262848924910f0cfaf0b3f89da34fe"} 07:27:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:27:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:27:39 INFO - Contents: 07:27:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9db4e94f6e997595ad856cc834d13199c361e12f0f8621197e2e844f06fb8af7c30d102aa845c004fd7d724cb3ab29a65cacb0468e64786648836ed394d2f9ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/da2780f53bd439c7b0164496e9e466cd903c6e229078e186106005f3ca2ee37b205d712ad9e718c5cdaf0bd7a2840f37e18470f82828aea931a05935553e61c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8212aea754a9a5b252d8cba2f3cd13adc394be2e0f278159bbb9657bed440f50ab845b28620f1c3d430e548faa3369c832262848924910f0cfaf0b3f89da34fe"} 07:27:39 INFO - Running post-run listener: copy_logs_to_upload_dir 07:27:39 INFO - Copying logs to upload dir... 07:27:39 INFO - mkdir: /builds/slave/test/build/upload/logs 07:27:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.838388 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-06-19 07:27:39.509010) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-19 07:27:39.512866) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471 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/9db4e94f6e997595ad856cc834d13199c361e12f0f8621197e2e844f06fb8af7c30d102aa845c004fd7d724cb3ab29a65cacb0468e64786648836ed394d2f9ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/da2780f53bd439c7b0164496e9e466cd903c6e229078e186106005f3ca2ee37b205d712ad9e718c5cdaf0bd7a2840f37e18470f82828aea931a05935553e61c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8212aea754a9a5b252d8cba2f3cd13adc394be2e0f278159bbb9657bed440f50ab845b28620f1c3d430e548faa3369c832262848924910f0cfaf0b3f89da34fe"} build_url:https://queue.taskcluster.net/v1/task/EBsJz5igSJKFeszoxyZYzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/EBsJz5igSJKFeszoxyZYzQ/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/9db4e94f6e997595ad856cc834d13199c361e12f0f8621197e2e844f06fb8af7c30d102aa845c004fd7d724cb3ab29a65cacb0468e64786648836ed394d2f9ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/da2780f53bd439c7b0164496e9e466cd903c6e229078e186106005f3ca2ee37b205d712ad9e718c5cdaf0bd7a2840f37e18470f82828aea931a05935553e61c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8212aea754a9a5b252d8cba2f3cd13adc394be2e0f278159bbb9657bed440f50ab845b28620f1c3d430e548faa3369c832262848924910f0cfaf0b3f89da34fe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-19 07:27:39.539744) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-19 07:27:39.540402) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1466342472.9875-1318591471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-19 07:27:39.622960) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-19 07:27:39.623703) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-19 07:27:39.624227) ========= ========= Total master_lag: 0.17 =========