builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1468458016.27 results: success (0) buildid: 20160713152443 builduid: fb5f9fc9a81843ef95c1b9ce84958adb revision: 709652b674013b136627e45fd90b4e9063906a19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:16.273295) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:16.273702) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:16.273977) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:16.289233) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:16.289572) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 18:00:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 97.7M=0s 2016-07-13 18:00:16 (97.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108347 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:16.411901) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:16.412186) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016946 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:16.463145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:16.463724) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 709652b674013b136627e45fd90b4e9063906a19 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 709652b674013b136627e45fd90b4e9063906a19 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 18:00:16,616 truncating revision to first 12 chars 2016-07-13 18:00:16,616 Setting DEBUG logging. 2016-07-13 18:00:16,616 attempt 1/10 2016-07-13 18:00:16,616 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/709652b67401?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 18:00:16,928 unpacking tar archive at: mozilla-aurora-709652b67401/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656943 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:17.133925) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:17.134232) ========= script_repo_revision: 709652b674013b136627e45fd90b4e9063906a19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:17.134789) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:17.135059) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:17.145910) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-13 18:00:17.146299) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:00:17 INFO - MultiFileLogger online at 20160713 18:00:17 in /builds/slave/test 18:00:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:00:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:00:17 INFO - {'append_to_log': False, 18:00:17 INFO - 'base_work_dir': '/builds/slave/test', 18:00:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:00:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:00:17 INFO - 'branch': 'Mozilla-Aurora', 18:00:17 INFO - 'buildbot_json_path': 'buildprops.json', 18:00:17 INFO - 'config_files': ('talos/linux_config.py',), 18:00:17 INFO - 'default_actions': ('clobber', 18:00:17 INFO - 'read-buildbot-config', 18:00:17 INFO - 'download-and-extract', 18:00:17 INFO - 'populate-webroot', 18:00:17 INFO - 'create-virtualenv', 18:00:17 INFO - 'install', 18:00:17 INFO - 'run-tests'), 18:00:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:00:17 INFO - 'download_minidump_stackwalk': True, 18:00:17 INFO - 'download_symbols': 'ondemand', 18:00:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:00:17 INFO - 'tooltool.py': '/tools/tooltool.py', 18:00:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:00:17 INFO - '/tools/misc-python/virtualenv.py')}, 18:00:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:00:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:00:17 INFO - 'installer_path': 'installer.exe', 18:00:17 INFO - 'log_level': 'info', 18:00:17 INFO - 'log_name': 'talos', 18:00:17 INFO - 'log_to_console': True, 18:00:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:00:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:00:17 INFO - 'opt_config_files': (), 18:00:17 INFO - 'pip_index': False, 18:00:17 INFO - 'sps_profile': False, 18:00:17 INFO - 'sps_profile_interval': 0, 18:00:17 INFO - 'suite': 'dromaeojs-e10s', 18:00:17 INFO - 'system_bits': '32', 18:00:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:00:17 INFO - 'title': 'talos-linux64-ix-024', 18:00:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:00:17 INFO - 'use_talos_json': True, 18:00:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:00:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:00:17 INFO - 'work_dir': 'build'} 18:00:17 INFO - ##### 18:00:17 INFO - ##### Running clobber step. 18:00:17 INFO - ##### 18:00:17 INFO - Running pre-action listener: _resource_record_pre_action 18:00:17 INFO - Running main action method: clobber 18:00:17 INFO - rmtree: /builds/slave/test/build 18:00:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:00:17 INFO - Running post-action listener: _resource_record_post_action 18:00:17 INFO - ##### 18:00:17 INFO - ##### Finished clobber step (success) 18:00:17 INFO - ##### 18:00:17 INFO - ##### 18:00:17 INFO - ##### Running read-buildbot-config step. 18:00:17 INFO - ##### 18:00:17 INFO - Running pre-action listener: _resource_record_pre_action 18:00:17 INFO - Running main action method: read_buildbot_config 18:00:17 INFO - Using buildbot properties: 18:00:17 INFO - { 18:00:17 INFO - "project": "", 18:00:17 INFO - "product": "firefox", 18:00:17 INFO - "script_repo_revision": "production", 18:00:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 18:00:17 INFO - "repository": "", 18:00:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 18:00:17 INFO - "buildid": "20160713152443", 18:00:17 INFO - "pgo_build": "True", 18:00:17 INFO - "basedir": "/builds/slave/test", 18:00:17 INFO - "buildnumber": 396, 18:00:17 INFO - "slavename": "talos-linux64-ix-024", 18:00:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:00:17 INFO - "platform": "ubuntu64_hw", 18:00:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:00:17 INFO - "branch": "mozilla-aurora", 18:00:17 INFO - "repo_path": "releases/mozilla-aurora", 18:00:17 INFO - "revision": "709652b674013b136627e45fd90b4e9063906a19", 18:00:17 INFO - "stage_platform": "linux64-pgo", 18:00:17 INFO - "builduid": "fb5f9fc9a81843ef95c1b9ce84958adb", 18:00:17 INFO - "slavebuilddir": "test" 18:00:17 INFO - } 18:00:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 18:00:17 INFO - Running post-action listener: _resource_record_post_action 18:00:17 INFO - ##### 18:00:17 INFO - ##### Finished read-buildbot-config step (success) 18:00:17 INFO - ##### 18:00:17 INFO - ##### 18:00:17 INFO - ##### Running download-and-extract step. 18:00:17 INFO - ##### 18:00:17 INFO - Running pre-action listener: _resource_record_pre_action 18:00:17 INFO - Running main action method: download_and_extract 18:00:17 INFO - mkdir: /builds/slave/test/build/tests 18:00:17 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')]} 18:00:17 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:00:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:00:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:00:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:00:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:00:28 INFO - Downloaded 1361 bytes. 18:00:28 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:00:28 INFO - Using the following test package requirements: 18:00:28 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 18:00:28 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:00:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:00:28 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:00:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:00:28 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:00:28 INFO - u'jsshell-linux-x86_64.zip'], 18:00:28 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:00:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:00:28 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 18:00:28 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:00:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:00:28 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:00:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:00:28 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:00:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:00:28 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:00:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:00:28 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:28 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:00:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:00:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:00:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:00:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:00:34 INFO - Downloaded 24491003 bytes. 18:00:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:00:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:00:35 INFO - Return code: 0 18:00:35 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:00: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')]} 18:00:35 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:00:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:00:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:00:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:00:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:00:37 INFO - Downloaded 24491003 bytes. 18:00:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:00:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:00:38 INFO - Return code: 0 18:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:38 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:00:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:00:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:00:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:00:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:00:39 INFO - Downloaded 10833369 bytes. 18:00:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:00:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:00:39 INFO - Return code: 0 18:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:39 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:00:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:00:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:00:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:00:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:00:41 INFO - Downloaded 63642548 bytes. 18:00:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:00:41 INFO - mkdir: /builds/slave/test/properties 18:00:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:00:41 INFO - Writing to file /builds/slave/test/properties/build_url 18:00:41 INFO - Contents: 18:00:41 INFO - build_url:https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:00:41 INFO - Running post-action listener: _resource_record_post_action 18:00:41 INFO - Running post-action listener: set_extra_try_arguments 18:00:41 INFO - ##### 18:00:41 INFO - ##### Finished download-and-extract step (success) 18:00:41 INFO - ##### 18:00:41 INFO - ##### 18:00:41 INFO - ##### Running populate-webroot step. 18:00:41 INFO - ##### 18:00:41 INFO - Running pre-action listener: _resource_record_pre_action 18:00:41 INFO - Running main action method: populate_webroot 18:00:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:00:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:00:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:00:41 INFO - '--tppagecycles', 18:00:41 INFO - '7'], 18:00:41 INFO - 'tests': ['tsvgm']}}, 18:00:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:00:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:00:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:00:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:00:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:00:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:00:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:41 INFO - 'talos_options': ['--disable-e10s'], 18:00:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:00:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:00:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:41 INFO - 'talos_options': ['--disable-e10s'], 18:00:41 INFO - 'tests': ['damp', 'tps']}, 18:00:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:41 INFO - 'tests': ['damp', 'tps']}, 18:00:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:00:41 INFO - 'tests': ['dromaeo_dom']}, 18:00:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:00:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:00:41 INFO - 'tests': ['a11yr', 18:00:41 INFO - 'ts_paint', 18:00:41 INFO - 'tpaint', 18:00:41 INFO - 'sessionrestore', 18:00:41 INFO - 'sessionrestore_no_auto_restore', 18:00:41 INFO - 'tabpaint']}, 18:00:41 INFO - 'other-e10s': {'tests': ['a11yr', 18:00:41 INFO - 'ts_paint', 18:00:41 INFO - 'tpaint', 18:00:41 INFO - 'sessionrestore', 18:00:41 INFO - 'sessionrestore_no_auto_restore', 18:00:41 INFO - 'tabpaint']}, 18:00:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:00:41 INFO - 'ts_paint', 18:00:41 INFO - 'tpaint', 18:00:41 INFO - 'sessionrestore', 18:00:41 INFO - 'sessionrestore_no_auto_restore', 18:00:41 INFO - 'tabpaint']}, 18:00:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:00:41 INFO - 'ts_paint', 18:00:41 INFO - 'tpaint', 18:00:41 INFO - 'sessionrestore', 18:00:41 INFO - 'sessionrestore_no_auto_restore', 18:00:41 INFO - 'tabpaint']}, 18:00:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:00:41 INFO - 'tests': ['a11yr', 18:00:41 INFO - 'ts_paint', 18:00:41 INFO - 'tpaint', 18:00:41 INFO - 'sessionrestore', 18:00:41 INFO - 'sessionrestore_no_auto_restore', 18:00:41 INFO - 'tabpaint']}, 18:00:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:00:41 INFO - 'tests': ['a11yr', 18:00:41 INFO - 'ts_paint', 18:00:41 INFO - 'tpaint', 18:00:41 INFO - 'sessionrestore', 18:00:41 INFO - 'sessionrestore_no_auto_restore', 18:00:41 INFO - 'tabpaint']}, 18:00:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:00:41 INFO - 'tests': ['tsvgx', 18:00:41 INFO - 'tsvgr_opacity', 18:00:41 INFO - 'tart', 18:00:41 INFO - 'tscrollx', 18:00:41 INFO - 'cart']}, 18:00:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:00:41 INFO - 'tsvgr_opacity', 18:00:41 INFO - 'tart', 18:00:41 INFO - 'tscrollx', 18:00:41 INFO - 'cart']}, 18:00:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:41 INFO - 'talos_options': ['--disable-e10s'], 18:00:41 INFO - 'tests': ['tp5o']}, 18:00:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:41 INFO - 'tests': ['tp5o']}, 18:00:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:41 INFO - 'talos_options': ['--disable-e10s', 18:00:41 INFO - '--xperf_path', 18:00:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:00:41 INFO - 'tests': ['tp5n']}, 18:00:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:41 INFO - 'talos_options': ['--xperf_path', 18:00:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:00:41 INFO - 'tests': ['tp5n']}}, 18:00:41 INFO - 'talos.zip': {'path': '', 18:00:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:00:41 INFO - Running post-action listener: _resource_record_post_action 18:00:41 INFO - ##### 18:00:41 INFO - ##### Finished populate-webroot step (success) 18:00:41 INFO - ##### 18:00:41 INFO - ##### 18:00:41 INFO - ##### Running create-virtualenv step. 18:00:41 INFO - ##### 18:00:41 INFO - Running pre-action listener: _resource_record_pre_action 18:00:41 INFO - Running main action method: create_virtualenv 18:00:41 INFO - Creating virtualenv /builds/slave/test/build/venv 18:00:41 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 18:00:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:00:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:00:42 INFO - Using real prefix '/usr' 18:00:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:00:42 INFO - Installing distribute.............................................................................................................................................................................................done. 18:00:44 INFO - Installing pip.................done. 18:00:44 INFO - Return code: 0 18:00:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f231c9c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331c0>, '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 0x10340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', '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 18:00:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:00:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:00:44 INFO - Using env: {'DISPLAY': ':0', 18:00:44 INFO - 'HOME': '/home/cltbld', 18:00:44 INFO - 'LANG': 'en_US.UTF-8', 18:00:44 INFO - 'LANGUAGE': 'en_US:en', 18:00:44 INFO - 'LOGNAME': 'cltbld', 18:00:44 INFO - 'MAIL': '/var/mail/cltbld', 18:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:44 INFO - 'MOZ_NO_REMOTE': '1', 18:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:44 INFO - 'NO_EM_RESTART': '1', 18:00:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:44 INFO - 'PWD': '/builds/slave/test', 18:00:44 INFO - 'SHELL': '/bin/bash', 18:00:44 INFO - 'SHLVL': '1', 18:00:44 INFO - 'TERM': 'linux', 18:00:44 INFO - 'TMOUT': '86400', 18:00:44 INFO - 'USER': 'cltbld', 18:00:44 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', 18:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:44 INFO - '_': '/tools/buildbot/bin/python'} 18:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:44 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 18:00:44 INFO - Cleaning up... 18:00:44 INFO - Return code: 0 18:00:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f231c9c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331c0>, '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 0x10340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', '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 18:00:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:00:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:00:44 INFO - Using env: {'DISPLAY': ':0', 18:00:44 INFO - 'HOME': '/home/cltbld', 18:00:44 INFO - 'LANG': 'en_US.UTF-8', 18:00:44 INFO - 'LANGUAGE': 'en_US:en', 18:00:44 INFO - 'LOGNAME': 'cltbld', 18:00:44 INFO - 'MAIL': '/var/mail/cltbld', 18:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:44 INFO - 'MOZ_NO_REMOTE': '1', 18:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:44 INFO - 'NO_EM_RESTART': '1', 18:00:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:44 INFO - 'PWD': '/builds/slave/test', 18:00:44 INFO - 'SHELL': '/bin/bash', 18:00:44 INFO - 'SHLVL': '1', 18:00:44 INFO - 'TERM': 'linux', 18:00:44 INFO - 'TMOUT': '86400', 18:00:44 INFO - 'USER': 'cltbld', 18:00:44 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', 18:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:44 INFO - '_': '/tools/buildbot/bin/python'} 18:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:44 INFO - Downloading/unpacking psutil>=3.1.1 18:00:44 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 18:00:44 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 18:00:44 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 18:00:44 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 18:00:44 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 18:00:44 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 18:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:00:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:47 INFO - Installing collected packages: psutil 18:00:47 INFO - Running setup.py install for psutil 18:00:47 INFO - building 'psutil._psutil_linux' extension 18:00:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:00:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:00:47 INFO - building 'psutil._psutil_posix' extension 18:00:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:00:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:00:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:47 INFO - Successfully installed psutil 18:00:47 INFO - Cleaning up... 18:00:47 INFO - Return code: 0 18:00:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:00: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')]} 18:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00: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')]} 18:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f231c9c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331c0>, '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 0x10340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', '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 18:00:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:00:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:00:47 INFO - Using env: {'DISPLAY': ':0', 18:00:47 INFO - 'HOME': '/home/cltbld', 18:00:47 INFO - 'LANG': 'en_US.UTF-8', 18:00:47 INFO - 'LANGUAGE': 'en_US:en', 18:00:47 INFO - 'LOGNAME': 'cltbld', 18:00:47 INFO - 'MAIL': '/var/mail/cltbld', 18:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:47 INFO - 'MOZ_NO_REMOTE': '1', 18:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:47 INFO - 'NO_EM_RESTART': '1', 18:00:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:47 INFO - 'PWD': '/builds/slave/test', 18:00:47 INFO - 'SHELL': '/bin/bash', 18:00:47 INFO - 'SHLVL': '1', 18:00:47 INFO - 'TERM': 'linux', 18:00:47 INFO - 'TMOUT': '86400', 18:00:47 INFO - 'USER': 'cltbld', 18:00:47 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', 18:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:47 INFO - '_': '/tools/buildbot/bin/python'} 18:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:00:47 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 18:00:47 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 18:00:47 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 18:00:47 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 18:00:47 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 18:00:47 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 18:00:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:00:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:00:49 INFO - Installing collected packages: mozsystemmonitor 18:00:49 INFO - Running setup.py install for mozsystemmonitor 18:00:49 INFO - Successfully installed mozsystemmonitor 18:00:49 INFO - Cleaning up... 18:00:49 INFO - Return code: 0 18:00:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:49 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 0x7f231c9c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331c0>, '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 0x10340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', '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 18:00:49 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 18:00:49 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 18:00:49 INFO - Using env: {'DISPLAY': ':0', 18:00:49 INFO - 'HOME': '/home/cltbld', 18:00:49 INFO - 'LANG': 'en_US.UTF-8', 18:00:49 INFO - 'LANGUAGE': 'en_US:en', 18:00:49 INFO - 'LOGNAME': 'cltbld', 18:00:49 INFO - 'MAIL': '/var/mail/cltbld', 18:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:49 INFO - 'MOZ_NO_REMOTE': '1', 18:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:49 INFO - 'NO_EM_RESTART': '1', 18:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:49 INFO - 'PWD': '/builds/slave/test', 18:00:49 INFO - 'SHELL': '/bin/bash', 18:00:49 INFO - 'SHLVL': '1', 18:00:49 INFO - 'TERM': 'linux', 18:00:49 INFO - 'TMOUT': '86400', 18:00:49 INFO - 'USER': 'cltbld', 18:00:49 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', 18:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:49 INFO - '_': '/tools/buildbot/bin/python'} 18:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:50 INFO - Downloading/unpacking jsonschema==2.5.1 18:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:00:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:52 INFO - Downloading functools32-3.2.3-2.tar.gz 18:00:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:00:52 INFO - warning: no files found matching '*.txt' 18:00:52 INFO - no previously-included directories found matching 'build' 18:00:52 INFO - no previously-included directories found matching 'dist' 18:00:52 INFO - no previously-included directories found matching '.git*' 18:00:52 INFO - Installing collected packages: jsonschema, functools32 18:00:52 INFO - Running setup.py install for functools32 18:00:52 INFO - warning: no files found matching '*.txt' 18:00:52 INFO - no previously-included directories found matching 'build' 18:00:52 INFO - no previously-included directories found matching 'dist' 18:00:52 INFO - no previously-included directories found matching '.git*' 18:00:52 INFO - Successfully installed jsonschema functools32 18:00:52 INFO - Cleaning up... 18:00:52 INFO - Return code: 0 18:00:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f231c9c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331c0>, '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 0x10340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', '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 18:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:00:52 INFO - Using env: {'DISPLAY': ':0', 18:00:52 INFO - 'HOME': '/home/cltbld', 18:00:52 INFO - 'LANG': 'en_US.UTF-8', 18:00:52 INFO - 'LANGUAGE': 'en_US:en', 18:00:52 INFO - 'LOGNAME': 'cltbld', 18:00:52 INFO - 'MAIL': '/var/mail/cltbld', 18:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:52 INFO - 'MOZ_NO_REMOTE': '1', 18:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:52 INFO - 'NO_EM_RESTART': '1', 18:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:52 INFO - 'PWD': '/builds/slave/test', 18:00:52 INFO - 'SHELL': '/bin/bash', 18:00:52 INFO - 'SHLVL': '1', 18:00:52 INFO - 'TERM': 'linux', 18:00:52 INFO - 'TMOUT': '86400', 18:00:52 INFO - 'USER': 'cltbld', 18:00:52 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', 18:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:52 INFO - '_': '/tools/buildbot/bin/python'} 18:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:52 INFO - Downloading/unpacking blobuploader==1.2.4 18:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:54 INFO - Downloading blobuploader-1.2.4.tar.gz 18:00:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:00:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:00:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:55 INFO - Downloading docopt-0.6.1.tar.gz 18:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:00:55 INFO - Installing collected packages: blobuploader, requests, docopt 18:00:55 INFO - Running setup.py install for blobuploader 18:00:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:00:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:00:55 INFO - Running setup.py install for requests 18:00:55 INFO - Running setup.py install for docopt 18:00:55 INFO - Successfully installed blobuploader requests docopt 18:00:55 INFO - Cleaning up... 18:00:56 INFO - Return code: 0 18:00:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f231c9c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331c0>, '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 0x10340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', '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 18:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:00:56 INFO - Using env: {'DISPLAY': ':0', 18:00:56 INFO - 'HOME': '/home/cltbld', 18:00:56 INFO - 'LANG': 'en_US.UTF-8', 18:00:56 INFO - 'LANGUAGE': 'en_US:en', 18:00:56 INFO - 'LOGNAME': 'cltbld', 18:00:56 INFO - 'MAIL': '/var/mail/cltbld', 18:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:56 INFO - 'MOZ_NO_REMOTE': '1', 18:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:56 INFO - 'NO_EM_RESTART': '1', 18:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:56 INFO - 'PWD': '/builds/slave/test', 18:00:56 INFO - 'SHELL': '/bin/bash', 18:00:56 INFO - 'SHLVL': '1', 18:00:56 INFO - 'TERM': 'linux', 18:00:56 INFO - 'TMOUT': '86400', 18:00:56 INFO - 'USER': 'cltbld', 18:00:56 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', 18:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:56 INFO - '_': '/tools/buildbot/bin/python'} 18:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:00:56 INFO - Running setup.py (path:/tmp/pip-aR148y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:00:56 INFO - Running setup.py (path:/tmp/pip-ye3ECL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:00:56 INFO - Running setup.py (path:/tmp/pip-kOS2NC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:00:56 INFO - Running setup.py (path:/tmp/pip-6RM2ZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:00:56 INFO - Running setup.py (path:/tmp/pip-a1GliT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:00:56 INFO - Running setup.py (path:/tmp/pip-RthFU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:00:56 INFO - Running setup.py (path:/tmp/pip-pDXPW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:00:56 INFO - Running setup.py (path:/tmp/pip-tvMWGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:00:56 INFO - Running setup.py (path:/tmp/pip-if81ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:00:56 INFO - Running setup.py (path:/tmp/pip-MSqp4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:00:56 INFO - Running setup.py (path:/tmp/pip-hHGcYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:00:57 INFO - Running setup.py (path:/tmp/pip-wycNDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:00:57 INFO - Running setup.py (path:/tmp/pip-jmLqt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:00:57 INFO - Running setup.py (path:/tmp/pip-1fYe_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:57 INFO - Running setup.py (path:/tmp/pip-3EkRkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:00:57 INFO - Running setup.py (path:/tmp/pip-gbG2q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:00:57 INFO - Running setup.py (path:/tmp/pip-CAzJJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:00:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:00:57 INFO - Running setup.py install for manifestparser 18:00:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:00:57 INFO - Running setup.py install for mozcrash 18:00:57 INFO - Running setup.py install for mozdebug 18:00:57 INFO - Running setup.py install for mozdevice 18:00:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:00:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:00:57 INFO - Running setup.py install for mozfile 18:00:57 INFO - Running setup.py install for mozhttpd 18:00:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:00:58 INFO - Running setup.py install for mozinfo 18:00:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:00:58 INFO - Running setup.py install for mozInstall 18:00:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:00:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:00:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:00:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:00:58 INFO - Running setup.py install for mozleak 18:00:58 INFO - Running setup.py install for mozlog 18:00:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:00:58 INFO - Running setup.py install for moznetwork 18:00:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:00:58 INFO - Running setup.py install for mozprocess 18:00:58 INFO - Running setup.py install for mozprofile 18:00:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:00:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:00:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:00:58 INFO - Running setup.py install for mozrunner 18:00:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:00:58 INFO - Running setup.py install for mozscreenshot 18:00:59 INFO - Running setup.py install for moztest 18:00:59 INFO - Running setup.py install for mozversion 18:00:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:00:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:00:59 INFO - Cleaning up... 18:00:59 INFO - Return code: 0 18:00:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f231c9c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331c0>, '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 0x10340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', '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 18:00:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:00:59 INFO - Using env: {'DISPLAY': ':0', 18:00:59 INFO - 'HOME': '/home/cltbld', 18:00:59 INFO - 'LANG': 'en_US.UTF-8', 18:00:59 INFO - 'LANGUAGE': 'en_US:en', 18:00:59 INFO - 'LOGNAME': 'cltbld', 18:00:59 INFO - 'MAIL': '/var/mail/cltbld', 18:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:59 INFO - 'MOZ_NO_REMOTE': '1', 18:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:59 INFO - 'NO_EM_RESTART': '1', 18:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:59 INFO - 'PWD': '/builds/slave/test', 18:00:59 INFO - 'SHELL': '/bin/bash', 18:00:59 INFO - 'SHLVL': '1', 18:00:59 INFO - 'TERM': 'linux', 18:00:59 INFO - 'TMOUT': '86400', 18:00:59 INFO - 'USER': 'cltbld', 18:00:59 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', 18:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:59 INFO - '_': '/tools/buildbot/bin/python'} 18:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:00:59 INFO - Running setup.py (path:/tmp/pip-sb6dYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:00:59 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)) 18:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:00:59 INFO - Running setup.py (path:/tmp/pip-sSKsgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:00:59 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)) 18:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:00:59 INFO - Running setup.py (path:/tmp/pip-hXY090-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:00:59 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)) 18:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:00:59 INFO - Running setup.py (path:/tmp/pip-IUk_G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:00:59 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)) 18:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:00:59 INFO - Running setup.py (path:/tmp/pip-3qdNh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:00:59 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)) 18:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:00:59 INFO - Running setup.py (path:/tmp/pip-vpJLew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:00:59 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)) 18:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:00:59 INFO - Running setup.py (path:/tmp/pip-xuTjpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:00:59 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)) 18:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:00:59 INFO - Running setup.py (path:/tmp/pip-7JYxe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:01:00 INFO - Running setup.py (path:/tmp/pip-7PnsM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:01:00 INFO - Running setup.py (path:/tmp/pip-sCH4zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:01:00 INFO - Running setup.py (path:/tmp/pip-fq3qdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:01:00 INFO - Running setup.py (path:/tmp/pip-ZYYpEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 18:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:01:00 INFO - Running setup.py (path:/tmp/pip-FeEMX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:01:00 INFO - Running setup.py (path:/tmp/pip-nqtdRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 18:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:00 INFO - Running setup.py (path:/tmp/pip-Cz_boo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:00 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)) 18:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:01:00 INFO - Running setup.py (path:/tmp/pip-JfKZ6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:01:00 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)) 18:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:01:00 INFO - Running setup.py (path:/tmp/pip-xTRG_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:01:00 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)) 18:01:00 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)) 18:01:00 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)) 18:01:00 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)) 18:01:00 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)) 18:01:00 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)) 18:01:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:01:00 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 18:01:00 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 18:01:00 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 18:01:00 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 18:01:00 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 18:01:00 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 18:01:02 INFO - Downloading blessings-1.6.tar.gz 18:01:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:01:02 INFO - Installing collected packages: blessings 18:01:02 INFO - Running setup.py install for blessings 18:01:02 INFO - Successfully installed blessings 18:01:02 INFO - Cleaning up... 18:01:02 INFO - Return code: 0 18:01:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:01:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:01:03 INFO - Reading from file tmpfile_stdout 18:01:03 INFO - Current package versions: 18:01:03 INFO - argparse == 1.2.1 18:01:03 INFO - blessings == 1.6 18:01:03 INFO - blobuploader == 1.2.4 18:01:03 INFO - docopt == 0.6.1 18:01:03 INFO - functools32 == 3.2.3-2 18:01:03 INFO - jsonschema == 2.5.1 18:01:03 INFO - manifestparser == 1.1 18:01:03 INFO - mozInstall == 1.12 18:01:03 INFO - mozcrash == 0.17 18:01:03 INFO - mozdebug == 0.1 18:01:03 INFO - mozdevice == 0.48 18:01:03 INFO - mozfile == 1.2 18:01:03 INFO - mozhttpd == 0.7 18:01:03 INFO - mozinfo == 0.9 18:01:03 INFO - mozleak == 0.1 18:01:03 INFO - mozlog == 3.2 18:01:03 INFO - moznetwork == 0.27 18:01:03 INFO - mozprocess == 0.23 18:01:03 INFO - mozprofile == 0.28 18:01:03 INFO - mozrunner == 6.12 18:01:03 INFO - mozscreenshot == 0.1 18:01:03 INFO - mozsystemmonitor == 0.3 18:01:03 INFO - moztest == 0.7 18:01:03 INFO - mozversion == 1.4 18:01:03 INFO - psutil == 3.1.1 18:01:03 INFO - requests == 1.2.3 18:01:03 INFO - wsgiref == 0.1.2 18:01:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f231c9c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331c0>, '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 0x10340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', '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 18:01:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:01:03 INFO - Using env: {'DISPLAY': ':0', 18:01:03 INFO - 'HOME': '/home/cltbld', 18:01:03 INFO - 'LANG': 'en_US.UTF-8', 18:01:03 INFO - 'LANGUAGE': 'en_US:en', 18:01:03 INFO - 'LOGNAME': 'cltbld', 18:01:03 INFO - 'MAIL': '/var/mail/cltbld', 18:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:03 INFO - 'MOZ_NO_REMOTE': '1', 18:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:03 INFO - 'NO_EM_RESTART': '1', 18:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:03 INFO - 'PWD': '/builds/slave/test', 18:01:03 INFO - 'SHELL': '/bin/bash', 18:01:03 INFO - 'SHLVL': '1', 18:01:03 INFO - 'TERM': 'linux', 18:01:03 INFO - 'TMOUT': '86400', 18:01:03 INFO - 'USER': 'cltbld', 18:01:03 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', 18:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:03 INFO - '_': '/tools/buildbot/bin/python'} 18:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:01:03 INFO - Cleaning up... 18:01:03 INFO - Return code: 0 18:01:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f231c9c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331c0>, '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 0x10340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', '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 18:01:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:01:03 INFO - Using env: {'DISPLAY': ':0', 18:01:03 INFO - 'HOME': '/home/cltbld', 18:01:03 INFO - 'LANG': 'en_US.UTF-8', 18:01:03 INFO - 'LANGUAGE': 'en_US:en', 18:01:03 INFO - 'LOGNAME': 'cltbld', 18:01:03 INFO - 'MAIL': '/var/mail/cltbld', 18:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:03 INFO - 'MOZ_NO_REMOTE': '1', 18:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:03 INFO - 'NO_EM_RESTART': '1', 18:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:03 INFO - 'PWD': '/builds/slave/test', 18:01:03 INFO - 'SHELL': '/bin/bash', 18:01:03 INFO - 'SHLVL': '1', 18:01:03 INFO - 'TERM': 'linux', 18:01:03 INFO - 'TMOUT': '86400', 18:01:03 INFO - 'USER': 'cltbld', 18:01:03 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', 18:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:03 INFO - '_': '/tools/buildbot/bin/python'} 18:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:01:03 INFO - Cleaning up... 18:01:03 INFO - Return code: 0 18:01:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f231c9c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331c0>, '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 0x10340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', '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 18:01:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:01:03 INFO - Using env: {'DISPLAY': ':0', 18:01:03 INFO - 'HOME': '/home/cltbld', 18:01:03 INFO - 'LANG': 'en_US.UTF-8', 18:01:03 INFO - 'LANGUAGE': 'en_US:en', 18:01:03 INFO - 'LOGNAME': 'cltbld', 18:01:03 INFO - 'MAIL': '/var/mail/cltbld', 18:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:03 INFO - 'MOZ_NO_REMOTE': '1', 18:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:03 INFO - 'NO_EM_RESTART': '1', 18:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:03 INFO - 'PWD': '/builds/slave/test', 18:01:03 INFO - 'SHELL': '/bin/bash', 18:01:03 INFO - 'SHLVL': '1', 18:01:03 INFO - 'TERM': 'linux', 18:01:03 INFO - 'TMOUT': '86400', 18:01:03 INFO - 'USER': 'cltbld', 18:01:03 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', 18:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:03 INFO - '_': '/tools/buildbot/bin/python'} 18:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:03 INFO - Downloading/unpacking flake8 18:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:01:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:01:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:01: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 18:01: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 18:01: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 18:01: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 18:01: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 18:01: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 18:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:01:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:01:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:01:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:01:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:01:06 INFO - no previously-included directories found matching 'docs/_build' 18:01:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:01:06 INFO - Running setup.py install for pep8 18:01:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:01:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:01:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:01:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:01:06 INFO - no previously-included directories found matching 'docs/_build' 18:01:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:01:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:01:06 INFO - Cleaning up... 18:01:06 INFO - Return code: 0 18:01:06 INFO - Running post-action listener: _resource_record_post_action 18:01:06 INFO - Running post-action listener: _start_resource_monitoring 18:01:06 INFO - Starting resource monitoring. 18:01:06 INFO - ##### 18:01:06 INFO - ##### Finished create-virtualenv step (success) 18:01:06 INFO - ##### 18:01:06 INFO - ##### 18:01:06 INFO - ##### Running install step. 18:01:06 INFO - ##### 18:01:06 INFO - Running pre-action listener: _resource_record_pre_action 18:01:06 INFO - Running main action method: install 18:01:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:01:06 INFO - Reading from file tmpfile_stdout 18:01:06 INFO - Detecting whether we're running mozinstall >=1.0... 18:01:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:01:06 INFO - Reading from file tmpfile_stdout 18:01:06 INFO - Output received: 18:01:06 INFO - Usage: mozinstall [options] installer 18:01:06 INFO - Options: 18:01:06 INFO - -h, --help show this help message and exit 18:01:06 INFO - -d DEST, --destination=DEST 18:01:06 INFO - Directory to install application into. [default: 18:01:06 INFO - "/builds/slave/test"] 18:01:06 INFO - --app=APP Application being installed. [default: firefox] 18:01:06 INFO - mkdir: /builds/slave/test/build/application 18:01:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:01:22 INFO - Reading from file tmpfile_stdout 18:01:22 INFO - Output received: 18:01:22 INFO - /builds/slave/test/build/application/firefox/firefox 18:01:22 INFO - Running post-action listener: _resource_record_post_action 18:01:22 INFO - ##### 18:01:22 INFO - ##### Finished install step (success) 18:01:22 INFO - ##### 18:01:22 INFO - ##### 18:01:22 INFO - ##### Running run-tests step. 18:01:22 INFO - ##### 18:01:22 INFO - Running pre-action listener: _resource_record_pre_action 18:01:22 INFO - Running main action method: run_tests 18:01:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:01:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:01:22 INFO - Python 2.7.3 18:01:22 INFO - Return code: 0 18:01:22 INFO - grabbing minidump binary from tooltool 18:01: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')]} 18:01:22 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 0x10331c0>, '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 0x10340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:01:22 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 18:01:22 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 18:01:22 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 18:01:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:01:22 INFO - Return code: 0 18:01:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:01:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:01:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:01:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:01:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:01:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:01:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:01:23 INFO - Return code: 0 18:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:01:23 INFO - Using env: {'DISPLAY': ':0', 18:01:23 INFO - 'HOME': '/home/cltbld', 18:01:23 INFO - 'LANG': 'en_US.UTF-8', 18:01:23 INFO - 'LANGUAGE': 'en_US:en', 18:01:23 INFO - 'LOGNAME': 'cltbld', 18:01:23 INFO - 'MAIL': '/var/mail/cltbld', 18:01:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:01:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:23 INFO - 'MOZ_NO_REMOTE': '1', 18:01:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:23 INFO - 'NO_EM_RESTART': '1', 18:01:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:23 INFO - 'PWD': '/builds/slave/test', 18:01:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:01:23 INFO - 'SHELL': '/bin/bash', 18:01:23 INFO - 'SHLVL': '1', 18:01:23 INFO - 'TERM': 'linux', 18:01:23 INFO - 'TMOUT': '86400', 18:01:23 INFO - 'USER': 'cltbld', 18:01:23 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163', 18:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:23 INFO - '_': '/tools/buildbot/bin/python'} 18:01:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:01:24 INFO - mozversion application_buildid: 20160713152443 18:01:24 INFO - mozversion application_changeset: 709652b674013b136627e45fd90b4e9063906a19 18:01:24 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:01:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:01:24 INFO - mozversion application_name: Firefox 18:01:24 INFO - mozversion application_remotingname: firefox-dev 18:01:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:01:24 INFO - mozversion application_vendor: Mozilla 18:01:24 INFO - mozversion application_version: 49.0a2 18:01:24 INFO - mozversion platform_buildid: 20160713152443 18:01:24 INFO - mozversion platform_changeset: 709652b674013b136627e45fd90b4e9063906a19 18:01:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:01:24 INFO - mozversion platform_version: 49.0a2 18:01:24 INFO - using testdate: 1468458084 18:01:24 INFO - actual date: 1468458084 18:01:24 INFO - starting webserver on 'localhost:59576' 18:01:24 INFO - SUITE-START | Running 2 tests 18:01:24 INFO - TEST-START | dromaeo_css 18:01:24 INFO - operating with platform_type : linux_ 18:01:24 INFO - Initialising browser for dromaeo_css test... 18:01:24 INFO - TEST-INFO | started process 13942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJJbzia/profile http://localhost:59576/getInfo.html) 18:01:28 INFO - PROCESS | 13942 | __metrics Screen width/height:1600/1200 18:01:28 INFO - PROCESS | 13942 | colorDepth:24 18:01:28 INFO - PROCESS | 13942 | Browser inner width/height: 1024/697 18:01:28 INFO - PROCESS | 13942 | __metrics 18:01:29 ERROR - PROCESS | 13942 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 18:01:30 INFO - TEST-INFO | 13942: exit 0 18:01:30 INFO - Browser initialized. 18:01:30 INFO - Running cycle 1/1 for dromaeo_css test... 18:01:30 INFO - TEST-INFO | started process 14071 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJJbzia/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:01:42 INFO - PROCESS | 14071 | RSS: Main: 155746304 18:01:42 INFO - PROCESS | 14071 | 18:02:31 INFO - PROCESS | 14071 | 1468458151788 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] 18:04:39 INFO - PROCESS | 14071 | Cycle 1(1): loaded http://localhost:59576/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59576/tests/dromaeo/cssquery-ext.html) 18:04:40 INFO - PROCESS | 14071 | RSS: Main: 159547392 18:04:40 INFO - PROCESS | 14071 | 18:07:43 INFO - PROCESS | 14071 | Cycle 1(1): loaded http://localhost:59576/tests/dromaeo/cssquery-ext.html (next: http://localhost:59576/tests/dromaeo/cssquery-jquery.html) 18:07:43 INFO - PROCESS | 14071 | RSS: Main: 157212672 18:07:43 INFO - PROCESS | 14071 | 18:10:45 INFO - PROCESS | 14071 | Cycle 1(1): loaded http://localhost:59576/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59576/tests/dromaeo/cssquery-mootools.html) 18:10:45 INFO - PROCESS | 14071 | RSS: Main: 156884992 18:10:45 INFO - PROCESS | 14071 | 18:13:47 INFO - PROCESS | 14071 | Cycle 1(1): loaded http://localhost:59576/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59576/tests/dromaeo/cssquery-prototype.html) 18:13:48 INFO - PROCESS | 14071 | RSS: Main: 156385280 18:13:48 INFO - PROCESS | 14071 | 18:16:50 INFO - PROCESS | 14071 | Cycle 1(1): loaded http://localhost:59576/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59576/tests/dromaeo/cssquery-yui.html) 18:16:51 INFO - PROCESS | 14071 | RSS: Main: 158683136 18:16:51 INFO - PROCESS | 14071 | 18:19:53 INFO - PROCESS | 14071 | Cycle 1(1): loaded http://localhost:59576/tests/dromaeo/cssquery-yui.html (next: http://localhost:59576/tests/dromaeo/cssquery-dojo.html) 18:19:53 INFO - PROCESS | 14071 | RSS: Main: 158937088 18:19:53 INFO - PROCESS | 14071 | 18:19:53 INFO - PROCESS | 14071 | __start_tp_report 18:19:53 INFO - PROCESS | 14071 | _x_x_mozilla_page_load 18:19:53 INFO - PROCESS | 14071 | _x_x_mozilla_page_load_details 18:19:53 INFO - PROCESS | 14071 | |i|pagename|runs| 18:19:53 INFO - PROCESS | 14071 | |0;dojo.html;3348.229907121362;3350.112220261631;3373.9493907591377;3381.830908454578;3394.932101357973;5560.36055853577;5571.052921003429;5604.607677462579;5613.129964855444;5651.039323315036;5570.693611851357;5571.220029195916;5587.357453892803;5594.608377413582;5625.943740562593;4999.650024498295;5020.523050310233;5140.331756871601;5146.461246977286;5174;5064.037832811754;5067.721275329855;5104.872378190556;5111.335526381566;5148.459411761767;5082.440931497532;5122.257272695457;5124.154514505102;5140.974295128538;5176.327077479922;5141.485851414847;5160.716160611165;5190.2733617293425;5196.2465442511;5196.636235463519;4989.65072444929;5036.622253331015;5084.491550844923;5107.770150343244;5110.386753589593;5518.172274158868;5535.363433205152;5541.141123125922;5547.916781248285;5550.750216240279;5966.164736936832;6036.124761909498;6037.245344331958;6054.394560543955;6054.757809687607;5860.326062502824;5960.850978725566;5984.521238300969;6019.879602407927;6050.485708714765;5668.43315668434;5669.574781891333;5680.0627896397455;5682.971585142089;5688.089905615082;5995.190649262381;6117.816465506042;6197.349278325801;6218.968905155445;6228.252609686867;5827.35899051104;5846.444587764156;5865;5903;5904.114382842608;5983.970080149658;5994.7602095916545;6013.819585412444;6027.819165425044;6029.698515074228;5841.328247251536;5903.409659034062;5970.194023806731;5972.283326000907;5981.551383646244;5895.734691938873;6002.849928751816;6033.818985430444;6050;6062.42406971337;4594.218982772936;4603.654725895572;4604.240300350471;4604.930926036112;4631.62946964242;4078.286299897506;4078.6533144683035;4109.239790638741;4120.21715873983;4123.525794533607;5671.064274394761;5716.714164291769;5745.023346031185;5828.912566311508;5843.444872737083;6055;6075.574709770273;6081.604695694854;6082.57421980466;6086.969565152146;5608.130739735266;5684.943150568524;5719.170720245625;5741.569382296345;5841.620294680833;5089.440161582223;5101.234814777738;5118.667286626357;5122.078025955364;5122.641415100908;6221.346758590374;6223.813285601439;6224.968875155686;6228.34602366754;6229.190205273286;5826.038703613941;5842.328132264844;5844.766209351748;5887.20522729426;5958.19564358806;6196.504279657706;6208.286047104641;6211.65835879031;6224.408681175281;6253.468455181361;5803.216565763568;5848.327442344185;5858.5898987070495;5862.237909071793;5865.501432378295;5892.616979896293;5920.259967504062;5942.197803296673;5998;6000.459958603572;5855.063189889597;5863.677497737665;5873.207117039145;5879.7060146993335;5891.11633254998;5669.943300567106;5770.913436298375;5862.325832529144;5863.501602363847;5872.060470324727;5723.599348045764;5787.56593255516;5791.53667706574;5819.941800582109;5830.329512105993;5902.763889444546;5903.350631430625;5910.674912879661;5925.7925972592475;5926.259217597801;5584.86037849057;5720.427957204246;5721.628094173865;5788.768449262151;5801.1878337033695 18:19:53 INFO - PROCESS | 14071 | |1;ext.html;593.9109133629955;635.3487675132989;641.5188608543592;656.3764423797393;680.9455243580514;41568;45697.08605827886;45987.540124598745;45997.310040349425;46089.76955115228;45576.544234557645;45886.541134588726;46344.53655463444;46347.53652463474;46529;8810.955945220281;8937.106289371044;8946.105389461067;8963.417377870417;8971.372003959725;8900.37697361185;8992.100789921022;8997.235235005033;9006.954965225164;9007.909920900805;9011.053839346872;9024.458532488039;9039.548022598843;9060.728178154666;9061;8880.955595222047;8958.910410895873;8986.68546600866;8994.055624159468;8998.325125615605;8883.37816352849;8924.643014279422;8944.64221431142;8946.194842464209;8952.686655967074;42982.14035719299;43144.13711725748;43309;43329.566704332865;43457;3711.851525938986;3749.3626083565587;3818.427235914607;3825.158465137693;4402;34969.65030349689;35324.82337588296;35649.287014259826;35650.28699425997;36718;4713.717176969393;4733.928991065137;4771.212749896297;4821.68659037165;4825.9758701206265;375762;376439;377878;378390;379360;38292.80853595714;66955.33044669588;67061.66469167623;67251;67275;38768.80615596904;40709;40879.38680919789;41143.38284925729;41221.79389103036;15356.769648455282;15447;15498.767518487231;15499.612509687347;15573;12650.620481385573;12676.556320528738;12724.681882953;12759.362031898554;12793.232406055666;9298.674546390845;9300.348975571645;9374.484403357881;9437.480938548446;9469.431834089977;3468.098294443412;3491.9825400872833;3509.78941263525;3522.43641017436;3593.083763640255;1007.4559737741538;1055.4353420919772;1196.1148749924994;1241.391718058163;1242.689327668083;33552.32895342128;33836.32327353489;34124.48813267803;34131.82934085314;34290.48564271538;1197.5628895453096;1214.1197631716934;1226.8589112252027;1243.5833995611572;1277.9424925878359;17837.197326120357;17875.910620446815;17896.46310610684;17941.64116717658;18043.278268869362;567103;773663;797061;887575;906858;59453.702731486934;60457.69771151116;60480;60560.78878422407;60577;1456.6431224350101;1482.05148704829;1482.1847983608973;1484.7030593881268;1489.6052546075298;31736.841315793274;32015.35969280555;32233.51649725209;32523;32793.18017049593;53005;53358.4664153369;53448.4655153459;53552.73223633857;53816;419473;422989;423170;423638;423675;30202.395952080395;30444.695553044185;30524.236894077825;30608.540871887384;31019.224519386295;49286.753566233376;52902;53201.46798531965;53471.19793203027;54605.726971364886;44372.33441498445;44549;44604.55395446004;45087.54912450833;45925.54074459346;43347;43376.349354760336;43589.346159808265;44103.33844992392;44457.77771111124;43737.78131109451;44440.777796110815;44671;44738.10523789571;44998.325025123995;38082.809585951894;38333.42499862448;38394.23211535698;38781.224375512895;38906.221875561765;29969.70030299669;30134.698653014068;30175;30440.238994025327;30487.39025219439 18:19:53 INFO - PROCESS | 14071 | |2;jquery.html;421.30274395874835;426.62030792594595;431.43912913212824;432.105541529035;439.8086832227981;18807.247710091597;19926.302579409705;20959.05684244209;21035;21081;17523.561910952234;17528.824711752877;18085.367012154577;18215.27138914445;18231.908840455813;5333.839984800462;5732.770689172428;5735.139729040657;5746.798862039829;5760.510356619692;5438.864028399282;5585.58108141889;5636.323641163066;5642.4357564243655;5679.971600141994;5639.915401268984;5640.0693885508845;5656.886862262752;5672.858178545549;5677.716114194273;5500.312460942382;5646.632968857011;5648.717564121798;5651.802186923458;5738.942610573882;5138.97430512845;5143.948560514385;5162.819301324474;5174.301469301634;5177;23550.882245588833;23904.521909561885;23944.640830387558;24400.755992440027;24980;2513.7360577139502;2557.6163575463643;2627.093652689819;3074.5849310343265;3214.533892585562;15193.207416392372;15264.771028434583;15382;15490.30293636789;15613;2022.706707527415;2096.716943212662;2120.151939224307;2143.228437762404;2175.8368122390725;75532.62233688851;78805.60597197035;79206.20793792047;79345.60327198327;80140.59929700372;9669.806603867883;10293.794124117625;10526.105281051043;10746.408947507805;10983.066439352584;14687.192204428859;14756.63108422298;14769.852301477062;14798.408063677547;14812.259387030605;7859.6463159157975;7985.961824962834;8205.056418511827;8223.835523289501;8227.300679442315;7894.842103157905;7950;7955.641996110189;8066.717664881701;8091.231333023354;4463.642908567372;4475.48531918827;4511.639068874482;4530.07133537624;4574.542545745466;2064.246550009266;2105.3578658508995;2141.271967531047;2150.817180539672;2207.6798864164607;1002.293383164867;1050.9224210065051;1081.389015206406;1164.057113737875;1183.946722397494;19738.60522789536;19820;20099.799002010084;20182.697259541117;20336.186552538027;1066.7333166708322;1076.6339444588878;1087.7661302819774;1088.4992903264429;1115.6485707002269;11274.492647830868;11340.886591134147;11460.08916727341;11550.711232219262;11651.359175245443;497848;497854;503820;505561;531190;97289.5135524332;97679;98043;100436;100726;1040.7346126737784;1048.0829274384914;1060.0565496707936;1065.3714308557987;1077.0952399983894;17792.91103544474;17927.64144717072;18063.367782127563;18141.092945352942;18289.359872404402;42932;43340.78329608332;43546;45480.31779523243;45738.54261457343;55465.722671386386;56249;59987;61028;61452.385476144664;9074.954625226832;9240.815183696423;9473.526323683926;9492.145706886413;9660.75848103803;12773.2336059833;13363.866361336652;13821.654458638212;13989.790153147507;14149;6080.452759251689;10267.537960791931;11593.768124637292;12748.298843563693;12756.87243127594;11905.940470297593;12136.089793265364;12183.208091474025;12209;12365.814512782496;6325.430711236011;10338.948305258426;12681.112322137362;12710.745785084431;13006;9380.474597866043;9578.521073946415;9578.856317155109;9644.373115747454;9719.65981190655;11155.330680159217;12661.113722039738;12793.872061279268;12892.613221603367;12995.480180792661 18:19:53 INFO - PROCESS | 14071 | |3;mootools.html;1607.9276432560534;1612.282534272249;1843.4746097362254;1909.656261872864;1932.9323473678423;8533.87199192011;9151.084891510855;9246.214071803905;9894.109530142287;9912.702618921427;9355.204807591346;9696.17582505488;9753.975832537588;9772.951135244313;9779.559919803609;2523.091686992686;2547.961780573293;2550.7066687331007;2552.47674226784;2557.0794513975047;2476.8885400157037;2523.911663091792;2554.3231043773417;2557.6802899637546;2559.1810620601414;2506.7994560435122;2513.9748602514014;2521.7856482199036;2525.734797846227;2527.545041892459;2413.9155129570468;2453.5706251406023;2464.112919349051;2468.4075821802817;2470.703515578133;2446.388402899275;2450.8652024138664;2456.349067497115;2456.459578892641;2483.341914392687;9684.61261549537;9721.562529686182;9761.902380976171;9773.120419162238;9791;5447.12845944647;5498.642588231752;5523.475269849358;5531.668099914018;5570.86072848178;3668.6881615062753;3731.6081811409954;3817.541894972621;3896.883093507199;3901.49280593521;1262.7727009138353;1264.1593340428603;1270.2695949828885;1274.5921305182346;1282.4870051979283;13952.790708139386;13976.790348144787;14003.719925601532;14034.438622455089;14068.437262509487;5037.194048952223;5142.100132476801;5163.896722065538;5191.714455704897;5221.738913054332;11755.412229388496;11775.23460975034;11788.29270243788;11790.410479475991;11803;5554.2779438672715;5639.2668953035845;5672.801451949244;5675.2054712340305;5677.858053548612;4563.178627847019;4863.221884498464;5032.496750324938;5050.090983622983;5101.107306221396;4415.602595766396;4419.292913133883;4421.093675796518;4424.358468022183;4497.730136191839;1372.4304413668217;1410.1468611489902;1413.279227593914;1417.2842714429148;1431.2199851080977;879.3317079019863;988.9208863290919;1100.2958106811486;1100.7303210713267;1112.5438570186348;6607.504437167232;6712.899306510406;6746.819306621322;6834.282400347892;6861.931380686129;1059.9205059620406;1070.272214893864;1078.1805827570945;1087.9782404351868;1100.664297389304;4625.606823419979;4669.673122881366;4675.462321833033;4681.6722829401615;4779.498152693986;12216.938915305367;12272.38638068093;12369.196002259825;12504.937475312565;12573.245605263714;11276.1542884284;11589.24669896454;11696.47365868538;11944.940275298743;12430.254184748763;8845.911540884637;8860.911390886138;8886.333524985781;8922.821543569093;8947.3736838422;6727;6932.896006560007;6935.167779866247;6962.512624116263;7035.859282814417;11138.053265472201;11382.829257560978;11422.714432138931;11495.712607184887;11554.94222528882;11424.543018279175;11495.597654082067;11603.419829008684;11626.302421854716;11656.941715291368;8408;8614.052454229904;8620.396572239883;8669.653213871374;8750.824983500166;9652.131308182297;9664.855027174457;9669.9033009669;9743.756406089904;9839.754006149904;8352.7911802203;8556.74329770108;8563.357748168788;8649.3512986525;8677.956610216908;8368.079511253878;8400.159984001551;8499.447535910145;8526;8541.359398045295;7997.7600671979935;8003.4797738146835;8024.3179329755285;8044.597770111588;8100.837983240184;5656.095024796177;5699.943000569941;5864.179014937998;5887.322957859901;5975.970120149372;5727.599068065196;5775.075987841925;5780.190773291826;5819.098039803668;5904.439078287556 18:19:53 INFO - PROCESS | 14071 | |4;prototype.html;343.272262802858;349.4862552048488;349.6101846441218;355.42953559536926;359.8039068707554;5624.521915637176;5727.599068065237;5823.33031701354;5829.242198514187;5857.326407463143;5727.484526392624;5729.369769325382;5749.856253593663;5753.5684823638185;5755.30936287645;4448.710833795809;4468.039371535119;4470.888227794315;4472.44094488189;4484.97757511212;4394.077243778795;4417.469903611571;4446.688731788776;4454.732716037032;4517.25465298227;4375.7374557526655;4381.2037064803435;4404.69167158299;4412.911741765162;4417.094495628405;4441.356003379508;4446.110777844412;4451.643868490513;4454.349661951134;4466.017476155241;3677.5219221501034;3874.786886721229;3973.145773658677;3979.761214327121;3987.900302492461;5505.614606977513;5520.227168196456;5530.889382212374;5549;5549.1676248562635;5035.446100928895;5050.7222102784335;5053.891856508258;5061.392632884041;5072.644914855961;5610.4670056344585;5873.706314684248;5928.081147422156;5953.58324917256;5961.8807623847715;4194.6853985951175;4195.139996300751;4219.725717828332;4229.323308270693;4235.661147108224;6231.6572588507615;6242.469390101847;6289.748410063592;6348.492120630339;6361.964171465133;4264.530901600821;4279.828806847691;4348.717333373384;4362.520122786491;4387.978060109743;4397.384366188736;4400.185965596375;4408.53710360414;4413.536578659195;4414.4702635683925;5016.498350164954;5040.924386134211;5074.619403544749;5080.898382032338;5109.897802043938;5811.384876805454;5895.145203945404;6020.4280593343565;6040.184575082308;6102.115193296947;1528.6942611477748;1533.9463118790788;1537.8923475356842;1543.4135028689027;1553.906765594068;953.7472569769017;958.7075941837807;964.99035009649;985.2708995343394;989.7627965043696;5252.579793616502;5263.657862239019;5278.838655495785;5279.973600131974;5303.257543943851;5471.50756431923;5529.944700553024;5577.693226872561;5605.831825045255;5646.520045796071;4921.926171107436;5210.76551555181;5245.527902488794;5319.8138065168305;5324.908393779266;2956.2705817096808;2972.2420782700274;2985.328301132228;2985.7611391088662;2997.970020299813;5658.434156584309;5704.686242256716;5731.885362292731;5742.248614172718;5841.591088623755;5806.332271788714;6331.873362532723;6347.52393570484;6353.14232578596;6361.586496877688;6433.292337842833;6495.545311828127;6498.870022599616;6501.739930402731;6546.967265163644;6024.789132380346;6202;6238.251409830849;6245.344238855037;6272.18461599989;6036.547258955508;6055.031195008777;6086.330503644507;6141.754329826936;6184.6598437086395;6087.9391206087375;6443.96778016107;6494.707738151889;6496.837579060561;6505.2844187138435;4415.602595766396;4424.867253982386;4426.623736982393;4430.3575981483145;4445;5997.220361352996;6127.20346354971;6279.932411489966;6290.308066112632;6298.149749783721;5981.312149102909;5997.5306050018025;6027.517798576191;6072.240969878765;6075.179850720273;6065.636061836304;6079.817605471843;6089.269287685506;6112.877742445037;6137.938620613915;5812.418758124154;5936.762529498945;5952.851178720567;5982.4316689914385;6061.424164704346;6090.817275481742;6093.415711914846;6118.755249789959;6127.540434467522;6153.876922461436;5676.489115979582;5955.493783028491;5982.252218472691;5993.041113421831;5999.5500337473995 18:19:53 INFO - PROCESS | 14071 | |5;yui.html;757.6401209425527;763.9847203055936;808.474491580473;888.3736965439364;914.931380146489;15574.221288935565;15815;16505.17474126295;17691;17754;14157.575272741835;14169.858301416984;14235.359408826602;14240.572782816533;14287.857121428782;829.1087081387517;841.2638940926689;868.0581568997645;875.2866413872705;876.0626130040858;863.1368631368631;865.091653763549;866.5493943149559;866.6273502393968;869.9652013919467;903.3811838890348;910.5037754423822;910.7996240827041;913.219197586061;914.0311270053732;900.9414388064788;901.0853983207018;902.0573500691793;903.1961554216753;904.6426661468684;660.1978596005828;662.6487961380476;663.9900401493982;666.4967949198373;667.1493845347172;16354;16411;16515.752263716055;16521.6695666086;16535.338586456528;15212.923935380362;15495.612609684735;15497.225138743017;15535.223238838013;15694.372225110981;12750.29873356965;12816.935915320457;12912.418941147671;13089.869101308961;13145;4070.633642972147;4113.609207125318;4152.958470415288;4172.833086676529;4285.485741710983;79970.6001469989;80076.19923800803;80471.19528804696;80550;80632;12448.875511244953;12466.75066498665;12475.31385773773;12531.18547294423;12798.488060477663;21124.683129753066;23305.53388932212;23316.300510984696;23330;23391.298261052194;9475.573599188054;9503.762405939908;9546.856797148048;9556.76108097303;9595.23238140947;4941.629377796679;4984.576311013604;5002.974985125124;5085.0338435697095;5098.566621837112;3745.831437585315;3858.575556688762;3882.2041481496226;3903.965449155976;3914.0801911551334;693.1093544794915;693.8785712500393;696.8710788504143;701.3302296307014;702.378395120312;618.088319728397;624.537841996919;679.1442782094498;779.9298063174228;803.2489622203259;10267.435291059064;10688.266347505147;10703.732406689895;10772.461376931278;10847.67456976292;683.6581709145428;705.3052743048094;788.4008153803151;791.3748138970149;798.2935102434387;4973.154563724175;5183.559397451183;5233.738313084331;5237.764300606482;5240.816571419982;80383.59808200922;113789;114203;118167.40916295536;118187.40906295413;63219;80327.59836200782;93296.53351733333;97815.51092244635;99014;92731.5363423192;93156.53421732847;93426.53286733523;93512.99999999863;93810;9687.2734544908;9980.051895069957;10162.288639795439;10229.897701023192;10339.172866170538;46878;48312.758436207594;55229.723851380484;55530.72234638801;55537.722311388185;78476.60761696156;78482.6075869617;79134.20865791268;79765;80858.59570702109;13205.603831885059;13398.866011340151;14236.857631423552;14427.35076921562;14657.706845863237;15553.751201749521;15939.681206376039;16029.35882564731;16369.09969951664;16508;14738.63153421173;14783.556493304788;14795.630109247355;15004.624884377978;15397.84602153964;14938.701225975637;15135.394584216949;15182.544523664308;15329.925581441681;15603.921980390025;14562.745380273995;14588.270586470422;14979.775303370676;15196.544103676908;15235.704965078092;12198.085143614087;12362.3818809061;12529.248245105322;12562.497500099893;12604.558840440908;12285;12346.567870124503;12465.688357790765;12470.563530276397;12620.242785432903 18:19:53 INFO - PROCESS | 14071 | __end_tp_report 18:19:53 INFO - PROCESS | 14071 | __start_cc_report 18:19:53 INFO - PROCESS | 14071 | _x_x_mozilla_cycle_collect,340 18:19:53 INFO - PROCESS | 14071 | __end_cc_report 18:19:53 INFO - PROCESS | 14071 | __startTimestamp1468459193934__endTimestamp 18:19:53 INFO - PROCESS | 14071 | 18:19:53 INFO - PROCESS | 14071 | ------- Summary: start ------- 18:19:53 INFO - PROCESS | 14071 | Number of tests: 6 18:19:53 INFO - PROCESS | 14071 | 18:19:53 INFO - PROCESS | 14071 | [#0] dojo.html Cycles:165 Average:5573.38 Median:5803.22 stddev:614.77 (10.6%) stddev-sans-first:591.35 18:19:53 INFO - PROCESS | 14071 | Values: 3348.2 3350.1 3373.9 3381.8 3394.9 5560.4 5571.1 5604.6 5613.1 5651.0 5570.7 5571.2 5587.4 5594.6 5625.9 4999.7 5020.5 5140.3 5146.5 5174.0 5064.0 5067.7 5104.9 5111.3 5148.5 5082.4 5122.3 5124.2 5141.0 5176.3 5141.5 5160.7 5190.3 5196.2 5196.6 4989.7 5036.6 5084.5 5107.8 5110.4 5518.2 5535.4 5541.1 5547.9 5550.8 5966.2 6036.1 6037.2 6054.4 6054.8 5860.3 5960.9 5984.5 6019.9 6050.5 5668.4 5669.6 5680.1 5683.0 5688.1 5995.2 6117.8 6197.3 6219.0 6228.3 5827.4 5846.4 5865.0 5903.0 5904.1 5984.0 5994.8 6013.8 6027.8 6029.7 5841.3 5903.4 5970.2 5972.3 5981.6 5895.7 6002.8 6033.8 6050.0 6062.4 4594.2 4603.7 4604.2 4604.9 4631.6 4078.3 4078.7 4109.2 4120.2 4123.5 5671.1 5716.7 5745.0 5828.9 5843.4 6055.0 6075.6 6081.6 6082.6 6087.0 5608.1 5684.9 5719.2 5741.6 5841.6 5089.4 5101.2 5118.7 5122.1 5122.6 6221.3 6223.8 6225.0 6228.3 6229.2 5826.0 5842.3 5844.8 5887.2 5958.2 6196.5 6208.3 6211.7 6224.4 6253.5 5803.2 5848.3 5858.6 5862.2 5865.5 5892.6 5920.3 5942.2 5998.0 6000.5 5855.1 5863.7 5873.2 5879.7 5891.1 5669.9 5770.9 5862.3 5863.5 5872.1 5723.6 5787.6 5791.5 5819.9 5830.3 5902.8 5903.4 5910.7 5925.8 5926.3 5584.9 5720.4 5721.6 5788.8 5801.2 18:19:53 INFO - PROCESS | 14071 | 18:19:53 INFO - PROCESS | 14071 | [#1] ext.html Cycles:180 Average:67801.04 Median:43361.67 stddev:151677.00 (349.8%) stddev-sans-first:152018.55 18:19:53 INFO - PROCESS | 14071 | Values: 593.9 635.3 641.5 656.4 680.9 41568.0 45697.1 45987.5 45997.3 46089.8 45576.5 45886.5 46344.5 46347.5 46529.0 8811.0 8937.1 8946.1 8963.4 8971.4 8900.4 8992.1 8997.2 9007.0 9007.9 9011.1 9024.5 9039.5 9060.7 9061.0 8881.0 8958.9 8986.7 8994.1 8998.3 8883.4 8924.6 8944.6 8946.2 8952.7 42982.1 43144.1 43309.0 43329.6 43457.0 3711.9 3749.4 3818.4 3825.2 4402.0 34969.7 35324.8 35649.3 35650.3 36718.0 4713.7 4733.9 4771.2 4821.7 4826.0 375762.0 376439.0 377878.0 378390.0 379360.0 38292.8 66955.3 67061.7 67251.0 67275.0 38768.8 40709.0 40879.4 41143.4 41221.8 15356.8 15447.0 15498.8 15499.6 15573.0 12650.6 12676.6 12724.7 12759.4 12793.2 9298.7 9300.3 9374.5 9437.5 9469.4 3468.1 3492.0 3509.8 3522.4 3593.1 1007.5 1055.4 1196.1 1241.4 1242.7 33552.3 33836.3 34124.5 34131.8 34290.5 1197.6 1214.1 1226.9 1243.6 1277.9 17837.2 17875.9 17896.5 17941.6 18043.3 567103.0 773663.0 797061.0 887575.0 906858.0 59453.7 60457.7 60480.0 60560.8 60577.0 1456.6 1482.1 1482.2 1484.7 1489.6 31736.8 32015.4 32233.5 32523.0 32793.2 53005.0 53358.5 53448.5 53552.7 53816.0 419473.0 422989.0 423170.0 423638.0 423675.0 30202.4 30444.7 30524.2 30608.5 31019.2 49286.8 52902.0 53201.5 53471.2 54605.7 44372.3 44549.0 44604.6 45087.5 45925.5 43347.0 43376.3 43589.3 44103.3 44457.8 43737.8 44440.8 44671.0 44738.1 44998.3 38082.8 38333.4 38394.2 38781.2 38906.2 29969.7 30134.7 30175.0 30440.2 30487.4 18:19:53 INFO - PROCESS | 14071 | 18:19:53 INFO - PROCESS | 14071 | [#2] jquery.html Cycles:180 Average:29952.40 Median:23924.58 stddev:83653.27 (349.7%) stddev-sans-first:83858.55 18:19:53 INFO - PROCESS | 14071 | Values: 421.3 426.6 431.4 432.1 439.8 18807.2 19926.3 20959.1 21035.0 21081.0 17523.6 17528.8 18085.4 18215.3 18231.9 5333.8 5732.8 5735.1 5746.8 5760.5 5438.9 5585.6 5636.3 5642.4 5680.0 5639.9 5640.1 5656.9 5672.9 5677.7 5500.3 5646.6 5648.7 5651.8 5738.9 5139.0 5143.9 5162.8 5174.3 5177.0 23550.9 23904.5 23944.6 24400.8 24980.0 2513.7 2557.6 2627.1 3074.6 3214.5 15193.2 15264.8 15382.0 15490.3 15613.0 2022.7 2096.7 2120.2 2143.2 2175.8 75532.6 78805.6 79206.2 79345.6 80140.6 9669.8 10293.8 10526.1 10746.4 10983.1 14687.2 14756.6 14769.9 14798.4 14812.3 7859.6 7986.0 8205.1 8223.8 8227.3 7894.8 7950.0 7955.6 8066.7 8091.2 4463.6 4475.5 4511.6 4530.1 4574.5 2064.2 2105.4 2141.3 2150.8 2207.7 1002.3 1050.9 1081.4 1164.1 1183.9 19738.6 19820.0 20099.8 20182.7 20336.2 1066.7 1076.6 1087.8 1088.5 1115.6 11274.5 11340.9 11460.1 11550.7 11651.4 497848.0 497854.0 503820.0 505561.0 531190.0 97289.5 97679.0 98043.0 100436.0 100726.0 1040.7 1048.1 1060.1 1065.4 1077.1 17792.9 17927.6 18063.4 18141.1 18289.4 42932.0 43340.8 43546.0 45480.3 45738.5 55465.7 56249.0 59987.0 61028.0 61452.4 9075.0 9240.8 9473.5 9492.1 9660.8 12773.2 13363.9 13821.7 13989.8 14149.0 6080.5 10267.5 11593.8 12748.3 12756.9 11905.9 12136.1 12183.2 12209.0 12365.8 6325.4 10338.9 12681.1 12710.7 13006.0 9380.5 9578.5 9578.9 9644.4 9719.7 11155.3 12661.1 12793.9 12892.6 12995.5 18:19:53 INFO - PROCESS | 14071 | 18:19:53 INFO - PROCESS | 14071 | [#3] mootools.html Cycles:180 Average:6458.51 Median:4672.57 stddev:3712.74 (79.5%) stddev-sans-first:3705.26 18:19:53 INFO - PROCESS | 14071 | Values: 1607.9 1612.3 1843.5 1909.7 1932.9 8533.9 9151.1 9246.2 9894.1 9912.7 9355.2 9696.2 9754.0 9773.0 9779.6 2523.1 2548.0 2550.7 2552.5 2557.1 2476.9 2523.9 2554.3 2557.7 2559.2 2506.8 2514.0 2521.8 2525.7 2527.5 2413.9 2453.6 2464.1 2468.4 2470.7 2446.4 2450.9 2456.3 2456.5 2483.3 9684.6 9721.6 9761.9 9773.1 9791.0 5447.1 5498.6 5523.5 5531.7 5570.9 3668.7 3731.6 3817.5 3896.9 3901.5 1262.8 1264.2 1270.3 1274.6 1282.5 13952.8 13976.8 14003.7 14034.4 14068.4 5037.2 5142.1 5163.9 5191.7 5221.7 11755.4 11775.2 11788.3 11790.4 11803.0 5554.3 5639.3 5672.8 5675.2 5677.9 4563.2 4863.2 5032.5 5050.1 5101.1 4415.6 4419.3 4421.1 4424.4 4497.7 1372.4 1410.1 1413.3 1417.3 1431.2 879.3 988.9 1100.3 1100.7 1112.5 6607.5 6712.9 6746.8 6834.3 6861.9 1059.9 1070.3 1078.2 1088.0 1100.7 4625.6 4669.7 4675.5 4681.7 4779.5 12216.9 12272.4 12369.2 12504.9 12573.2 11276.2 11589.2 11696.5 11944.9 12430.3 8845.9 8860.9 8886.3 8922.8 8947.4 6727.0 6932.9 6935.2 6962.5 7035.9 11138.1 11382.8 11422.7 11495.7 11554.9 11424.5 11495.6 11603.4 11626.3 11656.9 8408.0 8614.1 8620.4 8669.7 8750.8 9652.1 9664.9 9669.9 9743.8 9839.8 8352.8 8556.7 8563.4 8649.4 8678.0 8368.1 8400.2 8499.4 8526.0 8541.4 7997.8 8003.5 8024.3 8044.6 8100.8 5656.1 5699.9 5864.2 5887.3 5976.0 5727.6 5775.1 5780.2 5819.1 5904.4 18:19:53 INFO - PROCESS | 14071 | 18:19:53 INFO - PROCESS | 14071 | [#4] prototype.html Cycles:180 Average:4992.19 Median:5635.52 stddev:1487.45 (26.4%) stddev-sans-first:1450.12 18:19:53 INFO - PROCESS | 14071 | Values: 343.3 349.5 349.6 355.4 359.8 5624.5 5727.6 5823.3 5829.2 5857.3 5727.5 5729.4 5749.9 5753.6 5755.3 4448.7 4468.0 4470.9 4472.4 4485.0 4394.1 4417.5 4446.7 4454.7 4517.3 4375.7 4381.2 4404.7 4412.9 4417.1 4441.4 4446.1 4451.6 4454.3 4466.0 3677.5 3874.8 3973.1 3979.8 3987.9 5505.6 5520.2 5530.9 5549.0 5549.2 5035.4 5050.7 5053.9 5061.4 5072.6 5610.5 5873.7 5928.1 5953.6 5961.9 4194.7 4195.1 4219.7 4229.3 4235.7 6231.7 6242.5 6289.7 6348.5 6362.0 4264.5 4279.8 4348.7 4362.5 4388.0 4397.4 4400.2 4408.5 4413.5 4414.5 5016.5 5040.9 5074.6 5080.9 5109.9 5811.4 5895.1 6020.4 6040.2 6102.1 1528.7 1533.9 1537.9 1543.4 1553.9 953.7 958.7 965.0 985.3 989.8 5252.6 5263.7 5278.8 5280.0 5303.3 5471.5 5529.9 5577.7 5605.8 5646.5 4921.9 5210.8 5245.5 5319.8 5324.9 2956.3 2972.2 2985.3 2985.8 2998.0 5658.4 5704.7 5731.9 5742.2 5841.6 5806.3 6331.9 6347.5 6353.1 6361.6 6433.3 6495.5 6498.9 6501.7 6547.0 6024.8 6202.0 6238.3 6245.3 6272.2 6036.5 6055.0 6086.3 6141.8 6184.7 6087.9 6444.0 6494.7 6496.8 6505.3 4415.6 4424.9 4426.6 4430.4 4445.0 5997.2 6127.2 6279.9 6290.3 6298.1 5981.3 5997.5 6027.5 6072.2 6075.2 6065.6 6079.8 6089.3 6112.9 6137.9 5812.4 5936.8 5952.9 5982.4 6061.4 6090.8 6093.4 6118.8 6127.5 6153.9 5676.5 5955.5 5982.3 5993.0 5999.6 18:19:53 INFO - PROCESS | 14071 | 18:19:53 INFO - PROCESS | 14071 | [#5] yui.html Cycles:180 Average:21331.31 Median:4229.16 stddev:29564.88 (699.1%) stddev-sans-first:29607.46 18:19:53 INFO - PROCESS | 14071 | Values: 757.6 764.0 808.5 888.4 914.9 15574.2 15815.0 16505.2 17691.0 17754.0 14157.6 14169.9 14235.4 14240.6 14287.9 829.1 841.3 868.1 875.3 876.1 863.1 865.1 866.5 866.6 870.0 903.4 910.5 910.8 913.2 914.0 900.9 901.1 902.1 903.2 904.6 660.2 662.6 664.0 666.5 667.1 16354.0 16411.0 16515.8 16521.7 16535.3 15212.9 15495.6 15497.2 15535.2 15694.4 12750.3 12816.9 12912.4 13089.9 13145.0 4070.6 4113.6 4153.0 4172.8 4285.5 79970.6 80076.2 80471.2 80550.0 80632.0 12448.9 12466.8 12475.3 12531.2 12798.5 21124.7 23305.5 23316.3 23330.0 23391.3 9475.6 9503.8 9546.9 9556.8 9595.2 4941.6 4984.6 5003.0 5085.0 5098.6 3745.8 3858.6 3882.2 3904.0 3914.1 693.1 693.9 696.9 701.3 702.4 618.1 624.5 679.1 779.9 803.2 10267.4 10688.3 10703.7 10772.5 10847.7 683.7 705.3 788.4 791.4 798.3 4973.2 5183.6 5233.7 5237.8 5240.8 80383.6 113789.0 114203.0 118167.4 118187.4 63219.0 80327.6 93296.5 97815.5 99014.0 92731.5 93156.5 93426.5 93513.0 93810.0 9687.3 9980.1 10162.3 10229.9 10339.2 46878.0 48312.8 55229.7 55530.7 55537.7 78476.6 78482.6 79134.2 79765.0 80858.6 13205.6 13398.9 14236.9 14427.4 14657.7 15553.8 15939.7 16029.4 16369.1 16508.0 14738.6 14783.6 14795.6 15004.6 15397.8 14938.7 15135.4 15182.5 15329.9 15603.9 14562.7 14588.3 14979.8 15196.5 15235.7 12198.1 12362.4 12529.2 12562.5 12604.6 12285.0 12346.6 12465.7 12470.6 12620.2 18:19:53 INFO - PROCESS | 14071 | -------- Summary: end -------- 18:19:53 INFO - PROCESS | 14071 | 18:19:54 INFO - TEST-INFO | 14071: exit 0 18:19:54 INFO - TEST-OK | dromaeo_css | took 1110643ms 18:19:54 INFO - TEST-START | kraken 18:19:54 INFO - operating with platform_type : linux_ 18:19:54 INFO - Initialising browser for kraken test... 18:19:54 INFO - TEST-INFO | started process 14318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7YyUxK/profile http://localhost:59576/getInfo.html) 18:19:59 INFO - PROCESS | 14318 | __metrics Screen width/height:1600/1200 18:19:59 INFO - PROCESS | 14318 | colorDepth:24 18:19:59 INFO - PROCESS | 14318 | Browser inner width/height: 1024/697 18:19:59 INFO - PROCESS | 14318 | __metrics 18:20:00 ERROR - PROCESS | 14318 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 18:20:00 INFO - TEST-INFO | 14318: exit 0 18:20:00 INFO - Browser initialized. 18:20:00 INFO - Running cycle 1/1 for kraken test... 18:20:00 INFO - TEST-INFO | started process 14448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7YyUxK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:20:12 INFO - PROCESS | 14448 | RSS: Main: 155774976 18:20:12 INFO - PROCESS | 14448 | 18:20:15 INFO - PROCESS | 14448 | Cycle 1(1): loaded http://localhost:59576/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59576/tests/kraken/driver.html?testName=audio-beat-detection) 18:20:16 INFO - PROCESS | 14448 | RSS: Main: 161615872 18:20:16 INFO - PROCESS | 14448 | 18:20:18 INFO - PROCESS | 14448 | Cycle 1(1): loaded http://localhost:59576/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59576/tests/kraken/driver.html?testName=audio-dft) 18:20:19 INFO - PROCESS | 14448 | RSS: Main: 160841728 18:20:19 INFO - PROCESS | 14448 | 18:20:22 INFO - PROCESS | 14448 | Cycle 1(1): loaded http://localhost:59576/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59576/tests/kraken/driver.html?testName=audio-fft) 18:20:22 INFO - PROCESS | 14448 | RSS: Main: 161492992 18:20:22 INFO - PROCESS | 14448 | 18:20:24 INFO - PROCESS | 14448 | Cycle 1(1): loaded http://localhost:59576/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59576/tests/kraken/driver.html?testName=audio-oscillator) 18:20:25 INFO - PROCESS | 14448 | RSS: Main: 160686080 18:20:25 INFO - PROCESS | 14448 | 18:20:27 INFO - PROCESS | 14448 | Cycle 1(1): loaded http://localhost:59576/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59576/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:20:28 INFO - PROCESS | 14448 | RSS: Main: 160677888 18:20:28 INFO - PROCESS | 14448 | 18:20:31 INFO - PROCESS | 14448 | Cycle 1(1): loaded http://localhost:59576/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59576/tests/kraken/driver.html?testName=imaging-darkroom) 18:20:32 INFO - PROCESS | 14448 | RSS: Main: 159707136 18:20:32 INFO - PROCESS | 14448 | 18:20:35 INFO - PROCESS | 14448 | Cycle 1(1): loaded http://localhost:59576/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59576/tests/kraken/driver.html?testName=imaging-desaturate) 18:20:36 INFO - PROCESS | 14448 | RSS: Main: 161026048 18:20:36 INFO - PROCESS | 14448 | 18:20:38 INFO - PROCESS | 14448 | Cycle 1(1): loaded http://localhost:59576/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59576/tests/kraken/driver.html?testName=json-parse-financial) 18:20:39 INFO - PROCESS | 14448 | RSS: Main: 161566720 18:20:39 INFO - PROCESS | 14448 | 18:20:41 INFO - PROCESS | 14448 | Cycle 1(1): loaded http://localhost:59576/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59576/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:20:41 INFO - PROCESS | 14448 | RSS: Main: 161103872 18:20:41 INFO - PROCESS | 14448 | 18:20:43 INFO - PROCESS | 14448 | Cycle 1(1): loaded http://localhost:59576/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59576/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:20:44 INFO - PROCESS | 14448 | RSS: Main: 160944128 18:20:44 INFO - PROCESS | 14448 | 18:20:46 INFO - PROCESS | 14448 | Cycle 1(1): loaded http://localhost:59576/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59576/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:20:46 INFO - PROCESS | 14448 | RSS: Main: 161320960 18:20:46 INFO - PROCESS | 14448 | 18:20:49 INFO - PROCESS | 14448 | Cycle 1(1): loaded http://localhost:59576/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59576/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:20:49 INFO - PROCESS | 14448 | RSS: Main: 161517568 18:20:49 INFO - PROCESS | 14448 | 18:20:52 INFO - PROCESS | 14448 | Cycle 1(1): loaded http://localhost:59576/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59576/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:20:53 INFO - PROCESS | 14448 | RSS: Main: 161136640 18:20:53 INFO - PROCESS | 14448 | 18:20:54 INFO - PROCESS | 14448 | Cycle 1(1): loaded http://localhost:59576/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59576/tests/kraken/driver.html?testName=ai-astar) 18:20:55 INFO - PROCESS | 14448 | RSS: Main: 161902592 18:20:55 INFO - PROCESS | 14448 | 18:20:55 INFO - PROCESS | 14448 | __start_tp_report 18:20:55 INFO - PROCESS | 14448 | _x_x_mozilla_page_load 18:20:55 INFO - PROCESS | 14448 | _x_x_mozilla_page_load_details 18:20:55 INFO - PROCESS | 14448 | |i|pagename|runs| 18:20:55 INFO - PROCESS | 14448 | |0;ai-astar;110;107;112;109;111;111;110;109;112;110 18:20:55 INFO - PROCESS | 14448 | |1;audio-beat-detection;155;126;151;172;133;156;155;126;187;126 18:20:55 INFO - PROCESS | 14448 | |2;audio-dft;165;163;163;162;165;162;162;165;161;161 18:20:55 INFO - PROCESS | 14448 | |3;audio-fft;77;75;75;176;76;76;75;74;162;76 18:20:55 INFO - PROCESS | 14448 | |4;audio-oscillator;86;84;160;85;83;85;141;85;89;132 18:20:55 INFO - PROCESS | 14448 | |5;imaging-gaussian-blur;117;117;117;117;117;118;119;117;117;122 18:20:55 INFO - PROCESS | 14448 | |6;imaging-darkroom;153;148;147;146;147;147;147;147;146;148 18:20:55 INFO - PROCESS | 14448 | |7;imaging-desaturate;96;95;97;95;95;95;97;96;96;95 18:20:55 INFO - PROCESS | 14448 | |8;json-parse-financial;53;54;54;54;60;54;53;54;54;52 18:20:55 INFO - PROCESS | 14448 | |9;json-stringify-tinderbox;58;58;58;59;60;59;59;59;59;59 18:20:55 INFO - PROCESS | 14448 | |10;stanford-crypto-aes;84;75;76;76;76;82;78;78;111;78 18:20:55 INFO - PROCESS | 14448 | |11;stanford-crypto-ccm;126;116;126;118;117;120;120;128;122;127 18:20:55 INFO - PROCESS | 14448 | |12;stanford-crypto-pbkdf2;151;159;156;157;160;151;156;160;154;151 18:20:55 INFO - PROCESS | 14448 | |13;stanford-crypto-sha256-iterative;68;62;60;63;62;61;60;59;61;60 18:20:55 INFO - PROCESS | 14448 | __end_tp_report 18:20:55 INFO - PROCESS | 14448 | __start_cc_report 18:20:55 INFO - PROCESS | 14448 | _x_x_mozilla_cycle_collect,894 18:20:55 INFO - PROCESS | 14448 | __end_cc_report 18:20:55 INFO - PROCESS | 14448 | __startTimestamp1468459255150__endTimestamp 18:20:55 INFO - PROCESS | 14448 | 18:20:55 INFO - PROCESS | 14448 | ------- Summary: start ------- 18:20:55 INFO - PROCESS | 14448 | Number of tests: 14 18:20:55 INFO - PROCESS | 14448 | 18:20:55 INFO - PROCESS | 14448 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:1.52 (1.4%) stddev-sans-first:1.62 18:20:55 INFO - PROCESS | 14448 | Values: 110.0 107.0 112.0 109.0 111.0 111.0 110.0 109.0 112.0 110.0 18:20:55 INFO - PROCESS | 14448 | 18:20:55 INFO - PROCESS | 14448 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:155.00 stddev:20.92 (13.5%) stddev-sans-first:22.07 18:20:55 INFO - PROCESS | 14448 | Values: 155.0 126.0 151.0 172.0 133.0 156.0 155.0 126.0 187.0 126.0 18:20:55 INFO - PROCESS | 14448 | 18:20:55 INFO - PROCESS | 14448 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.60 (1.0%) stddev-sans-first:1.50 18:20:55 INFO - PROCESS | 14448 | Values: 165.0 163.0 163.0 162.0 165.0 162.0 162.0 165.0 161.0 161.0 18:20:55 INFO - PROCESS | 14448 | 18:20:55 INFO - PROCESS | 14448 | [#3] audio-fft Cycles:10 Average:94.20 Median:75.50 stddev:39.57 (52.4%) stddev-sans-first:41.48 18:20:55 INFO - PROCESS | 14448 | Values: 77.0 75.0 75.0 176.0 76.0 76.0 75.0 74.0 162.0 76.0 18:20:55 INFO - PROCESS | 14448 | 18:20:55 INFO - PROCESS | 14448 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:85.00 stddev:29.35 (34.5%) stddev-sans-first:30.48 18:20:55 INFO - PROCESS | 14448 | Values: 86.0 84.0 160.0 85.0 83.0 85.0 141.0 85.0 89.0 132.0 18:20:55 INFO - PROCESS | 14448 | 18:20:55 INFO - PROCESS | 14448 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:117.00 stddev:1.62 (1.4%) stddev-sans-first:1.69 18:20:55 INFO - PROCESS | 14448 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 119.0 117.0 117.0 122.0 18:20:55 INFO - PROCESS | 14448 | 18:20:55 INFO - PROCESS | 14448 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.00 stddev:2.01 (1.4%) stddev-sans-first:0.71 18:20:55 INFO - PROCESS | 14448 | Values: 153.0 148.0 147.0 146.0 147.0 147.0 147.0 147.0 146.0 148.0 18:20:55 INFO - PROCESS | 14448 | 18:20:55 INFO - PROCESS | 14448 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 18:20:55 INFO - PROCESS | 14448 | Values: 96.0 95.0 97.0 95.0 95.0 95.0 97.0 96.0 96.0 95.0 18:20:55 INFO - PROCESS | 14448 | 18:20:55 INFO - PROCESS | 14448 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:2.15 (4.0%) stddev-sans-first:2.24 18:20:55 INFO - PROCESS | 14448 | Values: 53.0 54.0 54.0 54.0 60.0 54.0 53.0 54.0 54.0 52.0 18:20:55 INFO - PROCESS | 14448 | 18:20:55 INFO - PROCESS | 14448 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 18:20:55 INFO - PROCESS | 14448 | Values: 58.0 58.0 58.0 59.0 60.0 59.0 59.0 59.0 59.0 59.0 18:20:55 INFO - PROCESS | 14448 | 18:20:55 INFO - PROCESS | 14448 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:78.00 stddev:10.78 (13.8%) stddev-sans-first:11.40 18:20:55 INFO - PROCESS | 14448 | Values: 84.0 75.0 76.0 76.0 76.0 82.0 78.0 78.0 111.0 78.0 18:20:55 INFO - PROCESS | 14448 | 18:20:55 INFO - PROCESS | 14448 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:124.00 stddev:4.45 (3.6%) stddev-sans-first:4.48 18:20:55 INFO - PROCESS | 14448 | Values: 126.0 116.0 126.0 118.0 117.0 120.0 120.0 128.0 122.0 127.0 18:20:55 INFO - PROCESS | 14448 | 18:20:55 INFO - PROCESS | 14448 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.50 Median:156.50 stddev:3.63 (2.3%) stddev-sans-first:3.46 18:20:55 INFO - PROCESS | 14448 | Values: 151.0 159.0 156.0 157.0 160.0 151.0 156.0 160.0 154.0 151.0 18:20:55 INFO - PROCESS | 14448 | 18:20:55 INFO - PROCESS | 14448 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.60 Median:61.50 stddev:2.55 (4.1%) stddev-sans-first:1.27 18:20:55 INFO - PROCESS | 14448 | Values: 68.0 62.0 60.0 63.0 62.0 61.0 60.0 59.0 61.0 60.0 18:20:55 INFO - PROCESS | 14448 | -------- Summary: end -------- 18:20:55 INFO - PROCESS | 14448 | 18:20:56 INFO - TEST-INFO | 14448: exit 0 18:20:56 INFO - TEST-OK | kraken | took 61434ms 18:20:56 INFO - SUITE-END | took 1172s 18:20:56 INFO - Completed test suite (00:19:32) 18:20:56 INFO - javascript benchmark 18:20:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7649.2311994087595, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3348.229907121362, 3350.112220261631, 3373.9493907591377, 3381.830908454578, 3394.932101357973, 5560.36055853577, 5571.052921003429, 5604.607677462579, 5613.129964855444, 5651.039323315036, 5570.693611851357, 5571.220029195916, 5587.357453892803, 5594.608377413582, 5625.943740562593, 4999.650024498295, 5020.523050310233, 5140.331756871601, 5146.461246977286, 5174.0, 5064.037832811754, 5067.721275329855, 5104.872378190556, 5111.335526381566, 5148.459411761767, 5082.440931497532, 5122.257272695457, 5124.154514505102, 5140.974295128538, 5176.327077479922, 5141.485851414847, 5160.716160611165, 5190.2733617293425, 5196.2465442511, 5196.636235463519, 4989.65072444929, 5036.622253331015, 5084.491550844923, 5107.770150343244, 5110.386753589593, 5518.172274158868, 5535.363433205152, 5541.141123125922, 5547.916781248285, 5550.750216240279, 5966.164736936832, 6036.124761909498, 6037.245344331958, 6054.394560543955, 6054.757809687607, 5860.326062502824, 5960.850978725566, 5984.521238300969, 6019.879602407927, 6050.485708714765, 5668.43315668434, 5669.574781891333, 5680.0627896397455, 5682.971585142089, 5688.089905615082, 5995.190649262381, 6117.816465506042, 6197.349278325801, 6218.968905155445, 6228.252609686867, 5827.35899051104, 5846.444587764156, 5865.0, 5903.0, 5904.114382842608, 5983.970080149658, 5994.7602095916545, 6013.819585412444, 6027.819165425044, 6029.698515074228, 5841.328247251536, 5903.409659034062, 5970.194023806731, 5972.283326000907, 5981.551383646244, 5895.734691938873, 6002.849928751816, 6033.818985430444, 6050.0, 6062.42406971337, 4594.218982772936, 4603.654725895572, 4604.240300350471, 4604.930926036112, 4631.62946964242, 4078.286299897506, 4078.6533144683035, 4109.239790638741, 4120.21715873983, 4123.525794533607, 5671.064274394761, 5716.714164291769, 5745.023346031185, 5828.912566311508, 5843.444872737083, 6055.0, 6075.574709770273, 6081.604695694854, 6082.57421980466, 6086.969565152146, 5608.130739735266, 5684.943150568524, 5719.170720245625, 5741.569382296345, 5841.620294680833, 5089.440161582223, 5101.234814777738, 5118.667286626357, 5122.078025955364, 5122.641415100908, 6221.346758590374, 6223.813285601439, 6224.968875155686, 6228.34602366754, 6229.190205273286, 5826.038703613941, 5842.328132264844, 5844.766209351748, 5887.20522729426, 5958.19564358806, 6196.504279657706, 6208.286047104641, 6211.65835879031, 6224.408681175281, 6253.468455181361, 5803.216565763568, 5848.327442344185, 5858.5898987070495, 5862.237909071793, 5865.501432378295, 5892.616979896293, 5920.259967504062, 5942.197803296673, 5998.0, 6000.459958603572, 5855.063189889597, 5863.677497737665, 5873.207117039145, 5879.7060146993335, 5891.11633254998, 5669.943300567106, 5770.913436298375, 5862.325832529144, 5863.501602363847, 5872.060470324727, 5723.599348045764, 5787.56593255516, 5791.53667706574, 5819.941800582109, 5830.329512105993, 5902.763889444546, 5903.350631430625, 5910.674912879661, 5925.7925972592475, 5926.259217597801, 5584.86037849057, 5720.427957204246, 5721.628094173865, 5788.768449262151, 5801.1878337033695], "value": 5533.609909723384, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.9109133629955, 635.3487675132989, 641.5188608543592, 656.3764423797393, 680.9455243580514, 41568.0, 45697.08605827886, 45987.540124598745, 45997.310040349425, 46089.76955115228, 45576.544234557645, 45886.541134588726, 46344.53655463444, 46347.53652463474, 46529.0, 8810.955945220281, 8937.106289371044, 8946.105389461067, 8963.417377870417, 8971.372003959725, 8900.37697361185, 8992.100789921022, 8997.235235005033, 9006.954965225164, 9007.909920900805, 9011.053839346872, 9024.458532488039, 9039.548022598843, 9060.728178154666, 9061.0, 8880.955595222047, 8958.910410895873, 8986.68546600866, 8994.055624159468, 8998.325125615605, 8883.37816352849, 8924.643014279422, 8944.64221431142, 8946.194842464209, 8952.686655967074, 42982.14035719299, 43144.13711725748, 43309.0, 43329.566704332865, 43457.0, 3711.851525938986, 3749.3626083565587, 3818.427235914607, 3825.158465137693, 4402.0, 34969.65030349689, 35324.82337588296, 35649.287014259826, 35650.28699425997, 36718.0, 4713.717176969393, 4733.928991065137, 4771.212749896297, 4821.68659037165, 4825.9758701206265, 375762.0, 376439.0, 377878.0, 378390.0, 379360.0, 38292.80853595714, 66955.33044669588, 67061.66469167623, 67251.0, 67275.0, 38768.80615596904, 40709.0, 40879.38680919789, 41143.38284925729, 41221.79389103036, 15356.769648455282, 15447.0, 15498.767518487231, 15499.612509687347, 15573.0, 12650.620481385573, 12676.556320528738, 12724.681882953, 12759.362031898554, 12793.232406055666, 9298.674546390845, 9300.348975571645, 9374.484403357881, 9437.480938548446, 9469.431834089977, 3468.098294443412, 3491.9825400872833, 3509.78941263525, 3522.43641017436, 3593.083763640255, 1007.4559737741538, 1055.4353420919772, 1196.1148749924994, 1241.391718058163, 1242.689327668083, 33552.32895342128, 33836.32327353489, 34124.48813267803, 34131.82934085314, 34290.48564271538, 1197.5628895453096, 1214.1197631716934, 1226.8589112252027, 1243.5833995611572, 1277.9424925878359, 17837.197326120357, 17875.910620446815, 17896.46310610684, 17941.64116717658, 18043.278268869362, 567103.0, 773663.0, 797061.0, 887575.0, 906858.0, 59453.702731486934, 60457.69771151116, 60480.0, 60560.78878422407, 60577.0, 1456.6431224350101, 1482.05148704829, 1482.1847983608973, 1484.7030593881268, 1489.6052546075298, 31736.841315793274, 32015.35969280555, 32233.51649725209, 32523.0, 32793.18017049593, 53005.0, 53358.4664153369, 53448.4655153459, 53552.73223633857, 53816.0, 419473.0, 422989.0, 423170.0, 423638.0, 423675.0, 30202.395952080395, 30444.695553044185, 30524.236894077825, 30608.540871887384, 31019.224519386295, 49286.753566233376, 52902.0, 53201.46798531965, 53471.19793203027, 54605.726971364886, 44372.33441498445, 44549.0, 44604.55395446004, 45087.54912450833, 45925.54074459346, 43347.0, 43376.349354760336, 43589.346159808265, 44103.33844992392, 44457.77771111124, 43737.78131109451, 44440.777796110815, 44671.0, 44738.10523789571, 44998.325025123995, 38082.809585951894, 38333.42499862448, 38394.23211535698, 38781.224375512895, 38906.221875561765, 29969.70030299669, 30134.698653014068, 30175.0, 30440.238994025327, 30487.39025219439], "value": 20200.117782903006, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.30274395874835, 426.62030792594595, 431.43912913212824, 432.105541529035, 439.8086832227981, 18807.247710091597, 19926.302579409705, 20959.05684244209, 21035.0, 21081.0, 17523.561910952234, 17528.824711752877, 18085.367012154577, 18215.27138914445, 18231.908840455813, 5333.839984800462, 5732.770689172428, 5735.139729040657, 5746.798862039829, 5760.510356619692, 5438.864028399282, 5585.58108141889, 5636.323641163066, 5642.4357564243655, 5679.971600141994, 5639.915401268984, 5640.0693885508845, 5656.886862262752, 5672.858178545549, 5677.716114194273, 5500.312460942382, 5646.632968857011, 5648.717564121798, 5651.802186923458, 5738.942610573882, 5138.97430512845, 5143.948560514385, 5162.819301324474, 5174.301469301634, 5177.0, 23550.882245588833, 23904.521909561885, 23944.640830387558, 24400.755992440027, 24980.0, 2513.7360577139502, 2557.6163575463643, 2627.093652689819, 3074.5849310343265, 3214.533892585562, 15193.207416392372, 15264.771028434583, 15382.0, 15490.30293636789, 15613.0, 2022.706707527415, 2096.716943212662, 2120.151939224307, 2143.228437762404, 2175.8368122390725, 75532.62233688851, 78805.60597197035, 79206.20793792047, 79345.60327198327, 80140.59929700372, 9669.806603867883, 10293.794124117625, 10526.105281051043, 10746.408947507805, 10983.066439352584, 14687.192204428859, 14756.63108422298, 14769.852301477062, 14798.408063677547, 14812.259387030605, 7859.6463159157975, 7985.961824962834, 8205.056418511827, 8223.835523289501, 8227.300679442315, 7894.842103157905, 7950.0, 7955.641996110189, 8066.717664881701, 8091.231333023354, 4463.642908567372, 4475.48531918827, 4511.639068874482, 4530.07133537624, 4574.542545745466, 2064.246550009266, 2105.3578658508995, 2141.271967531047, 2150.817180539672, 2207.6798864164607, 1002.293383164867, 1050.9224210065051, 1081.389015206406, 1164.057113737875, 1183.946722397494, 19738.60522789536, 19820.0, 20099.799002010084, 20182.697259541117, 20336.186552538027, 1066.7333166708322, 1076.6339444588878, 1087.7661302819774, 1088.4992903264429, 1115.6485707002269, 11274.492647830868, 11340.886591134147, 11460.08916727341, 11550.711232219262, 11651.359175245443, 497848.0, 497854.0, 503820.0, 505561.0, 531190.0, 97289.5135524332, 97679.0, 98043.0, 100436.0, 100726.0, 1040.7346126737784, 1048.0829274384914, 1060.0565496707936, 1065.3714308557987, 1077.0952399983894, 17792.91103544474, 17927.64144717072, 18063.367782127563, 18141.092945352942, 18289.359872404402, 42932.0, 43340.78329608332, 43546.0, 45480.31779523243, 45738.54261457343, 55465.722671386386, 56249.0, 59987.0, 61028.0, 61452.385476144664, 9074.954625226832, 9240.815183696423, 9473.526323683926, 9492.145706886413, 9660.75848103803, 12773.2336059833, 13363.866361336652, 13821.654458638212, 13989.790153147507, 14149.0, 6080.452759251689, 10267.537960791931, 11593.768124637292, 12748.298843563693, 12756.87243127594, 11905.940470297593, 12136.089793265364, 12183.208091474025, 12209.0, 12365.814512782496, 6325.430711236011, 10338.948305258426, 12681.112322137362, 12710.745785084431, 13006.0, 9380.474597866043, 9578.521073946415, 9578.856317155109, 9644.373115747454, 9719.65981190655, 11155.330680159217, 12661.113722039738, 12793.872061279268, 12892.613221603367, 12995.480180792661], "value": 9567.727166336832, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1607.9276432560534, 1612.282534272249, 1843.4746097362254, 1909.656261872864, 1932.9323473678423, 8533.87199192011, 9151.084891510855, 9246.214071803905, 9894.109530142287, 9912.702618921427, 9355.204807591346, 9696.17582505488, 9753.975832537588, 9772.951135244313, 9779.559919803609, 2523.091686992686, 2547.961780573293, 2550.7066687331007, 2552.47674226784, 2557.0794513975047, 2476.8885400157037, 2523.911663091792, 2554.3231043773417, 2557.6802899637546, 2559.1810620601414, 2506.7994560435122, 2513.9748602514014, 2521.7856482199036, 2525.734797846227, 2527.545041892459, 2413.9155129570468, 2453.5706251406023, 2464.112919349051, 2468.4075821802817, 2470.703515578133, 2446.388402899275, 2450.8652024138664, 2456.349067497115, 2456.459578892641, 2483.341914392687, 9684.61261549537, 9721.562529686182, 9761.902380976171, 9773.120419162238, 9791.0, 5447.12845944647, 5498.642588231752, 5523.475269849358, 5531.668099914018, 5570.86072848178, 3668.6881615062753, 3731.6081811409954, 3817.541894972621, 3896.883093507199, 3901.49280593521, 1262.7727009138353, 1264.1593340428603, 1270.2695949828885, 1274.5921305182346, 1282.4870051979283, 13952.790708139386, 13976.790348144787, 14003.719925601532, 14034.438622455089, 14068.437262509487, 5037.194048952223, 5142.100132476801, 5163.896722065538, 5191.714455704897, 5221.738913054332, 11755.412229388496, 11775.23460975034, 11788.29270243788, 11790.410479475991, 11803.0, 5554.2779438672715, 5639.2668953035845, 5672.801451949244, 5675.2054712340305, 5677.858053548612, 4563.178627847019, 4863.221884498464, 5032.496750324938, 5050.090983622983, 5101.107306221396, 4415.602595766396, 4419.292913133883, 4421.093675796518, 4424.358468022183, 4497.730136191839, 1372.4304413668217, 1410.1468611489902, 1413.279227593914, 1417.2842714429148, 1431.2199851080977, 879.3317079019863, 988.9208863290919, 1100.2958106811486, 1100.7303210713267, 1112.5438570186348, 6607.504437167232, 6712.899306510406, 6746.819306621322, 6834.282400347892, 6861.931380686129, 1059.9205059620406, 1070.272214893864, 1078.1805827570945, 1087.9782404351868, 1100.664297389304, 4625.606823419979, 4669.673122881366, 4675.462321833033, 4681.6722829401615, 4779.498152693986, 12216.938915305367, 12272.38638068093, 12369.196002259825, 12504.937475312565, 12573.245605263714, 11276.1542884284, 11589.24669896454, 11696.47365868538, 11944.940275298743, 12430.254184748763, 8845.911540884637, 8860.911390886138, 8886.333524985781, 8922.821543569093, 8947.3736838422, 6727.0, 6932.896006560007, 6935.167779866247, 6962.512624116263, 7035.859282814417, 11138.053265472201, 11382.829257560978, 11422.714432138931, 11495.712607184887, 11554.94222528882, 11424.543018279175, 11495.597654082067, 11603.419829008684, 11626.302421854716, 11656.941715291368, 8408.0, 8614.052454229904, 8620.396572239883, 8669.653213871374, 8750.824983500166, 9652.131308182297, 9664.855027174457, 9669.9033009669, 9743.756406089904, 9839.754006149904, 8352.7911802203, 8556.74329770108, 8563.357748168788, 8649.3512986525, 8677.956610216908, 8368.079511253878, 8400.159984001551, 8499.447535910145, 8526.0, 8541.359398045295, 7997.7600671979935, 8003.4797738146835, 8024.3179329755285, 8044.597770111588, 8100.837983240184, 5656.095024796177, 5699.943000569941, 5864.179014937998, 5887.322957859901, 5975.970120149372, 5727.599068065196, 5775.075987841925, 5780.190773291826, 5819.098039803668, 5904.439078287556], "value": 5148.837379335778, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.272262802858, 349.4862552048488, 349.6101846441218, 355.42953559536926, 359.8039068707554, 5624.521915637176, 5727.599068065237, 5823.33031701354, 5829.242198514187, 5857.326407463143, 5727.484526392624, 5729.369769325382, 5749.856253593663, 5753.5684823638185, 5755.30936287645, 4448.710833795809, 4468.039371535119, 4470.888227794315, 4472.44094488189, 4484.97757511212, 4394.077243778795, 4417.469903611571, 4446.688731788776, 4454.732716037032, 4517.25465298227, 4375.7374557526655, 4381.2037064803435, 4404.69167158299, 4412.911741765162, 4417.094495628405, 4441.356003379508, 4446.110777844412, 4451.643868490513, 4454.349661951134, 4466.017476155241, 3677.5219221501034, 3874.786886721229, 3973.145773658677, 3979.761214327121, 3987.900302492461, 5505.614606977513, 5520.227168196456, 5530.889382212374, 5549.0, 5549.1676248562635, 5035.446100928895, 5050.7222102784335, 5053.891856508258, 5061.392632884041, 5072.644914855961, 5610.4670056344585, 5873.706314684248, 5928.081147422156, 5953.58324917256, 5961.8807623847715, 4194.6853985951175, 4195.139996300751, 4219.725717828332, 4229.323308270693, 4235.661147108224, 6231.6572588507615, 6242.469390101847, 6289.748410063592, 6348.492120630339, 6361.964171465133, 4264.530901600821, 4279.828806847691, 4348.717333373384, 4362.520122786491, 4387.978060109743, 4397.384366188736, 4400.185965596375, 4408.53710360414, 4413.536578659195, 4414.4702635683925, 5016.498350164954, 5040.924386134211, 5074.619403544749, 5080.898382032338, 5109.897802043938, 5811.384876805454, 5895.145203945404, 6020.4280593343565, 6040.184575082308, 6102.115193296947, 1528.6942611477748, 1533.9463118790788, 1537.8923475356842, 1543.4135028689027, 1553.906765594068, 953.7472569769017, 958.7075941837807, 964.99035009649, 985.2708995343394, 989.7627965043696, 5252.579793616502, 5263.657862239019, 5278.838655495785, 5279.973600131974, 5303.257543943851, 5471.50756431923, 5529.944700553024, 5577.693226872561, 5605.831825045255, 5646.520045796071, 4921.926171107436, 5210.76551555181, 5245.527902488794, 5319.8138065168305, 5324.908393779266, 2956.2705817096808, 2972.2420782700274, 2985.328301132228, 2985.7611391088662, 2997.970020299813, 5658.434156584309, 5704.686242256716, 5731.885362292731, 5742.248614172718, 5841.591088623755, 5806.332271788714, 6331.873362532723, 6347.52393570484, 6353.14232578596, 6361.586496877688, 6433.292337842833, 6495.545311828127, 6498.870022599616, 6501.739930402731, 6546.967265163644, 6024.789132380346, 6202.0, 6238.251409830849, 6245.344238855037, 6272.18461599989, 6036.547258955508, 6055.031195008777, 6086.330503644507, 6141.754329826936, 6184.6598437086395, 6087.9391206087375, 6443.96778016107, 6494.707738151889, 6496.837579060561, 6505.2844187138435, 4415.602595766396, 4424.867253982386, 4426.623736982393, 4430.3575981483145, 4445.0, 5997.220361352996, 6127.20346354971, 6279.932411489966, 6290.308066112632, 6298.149749783721, 5981.312149102909, 5997.5306050018025, 6027.517798576191, 6072.240969878765, 6075.179850720273, 6065.636061836304, 6079.817605471843, 6089.269287685506, 6112.877742445037, 6137.938620613915, 5812.418758124154, 5936.762529498945, 5952.851178720567, 5982.4316689914385, 6061.424164704346, 6090.817275481742, 6093.415711914846, 6118.755249789959, 6127.540434467522, 6153.876922461436, 5676.489115979582, 5955.493783028491, 5982.252218472691, 5993.041113421831, 5999.5500337473995], "value": 4515.446879238798, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.6401209425527, 763.9847203055936, 808.474491580473, 888.3736965439364, 914.931380146489, 15574.221288935565, 15815.0, 16505.17474126295, 17691.0, 17754.0, 14157.575272741835, 14169.858301416984, 14235.359408826602, 14240.572782816533, 14287.857121428782, 829.1087081387517, 841.2638940926689, 868.0581568997645, 875.2866413872705, 876.0626130040858, 863.1368631368631, 865.091653763549, 866.5493943149559, 866.6273502393968, 869.9652013919467, 903.3811838890348, 910.5037754423822, 910.7996240827041, 913.219197586061, 914.0311270053732, 900.9414388064788, 901.0853983207018, 902.0573500691793, 903.1961554216753, 904.6426661468684, 660.1978596005828, 662.6487961380476, 663.9900401493982, 666.4967949198373, 667.1493845347172, 16354.0, 16411.0, 16515.752263716055, 16521.6695666086, 16535.338586456528, 15212.923935380362, 15495.612609684735, 15497.225138743017, 15535.223238838013, 15694.372225110981, 12750.29873356965, 12816.935915320457, 12912.418941147671, 13089.869101308961, 13145.0, 4070.633642972147, 4113.609207125318, 4152.958470415288, 4172.833086676529, 4285.485741710983, 79970.6001469989, 80076.19923800803, 80471.19528804696, 80550.0, 80632.0, 12448.875511244953, 12466.75066498665, 12475.31385773773, 12531.18547294423, 12798.488060477663, 21124.683129753066, 23305.53388932212, 23316.300510984696, 23330.0, 23391.298261052194, 9475.573599188054, 9503.762405939908, 9546.856797148048, 9556.76108097303, 9595.23238140947, 4941.629377796679, 4984.576311013604, 5002.974985125124, 5085.0338435697095, 5098.566621837112, 3745.831437585315, 3858.575556688762, 3882.2041481496226, 3903.965449155976, 3914.0801911551334, 693.1093544794915, 693.8785712500393, 696.8710788504143, 701.3302296307014, 702.378395120312, 618.088319728397, 624.537841996919, 679.1442782094498, 779.9298063174228, 803.2489622203259, 10267.435291059064, 10688.266347505147, 10703.732406689895, 10772.461376931278, 10847.67456976292, 683.6581709145428, 705.3052743048094, 788.4008153803151, 791.3748138970149, 798.2935102434387, 4973.154563724175, 5183.559397451183, 5233.738313084331, 5237.764300606482, 5240.816571419982, 80383.59808200922, 113789.0, 114203.0, 118167.40916295536, 118187.40906295413, 63219.0, 80327.59836200782, 93296.53351733333, 97815.51092244635, 99014.0, 92731.5363423192, 93156.53421732847, 93426.53286733523, 93512.99999999863, 93810.0, 9687.2734544908, 9980.051895069957, 10162.288639795439, 10229.897701023192, 10339.172866170538, 46878.0, 48312.758436207594, 55229.723851380484, 55530.72234638801, 55537.722311388185, 78476.60761696156, 78482.6075869617, 79134.20865791268, 79765.0, 80858.59570702109, 13205.603831885059, 13398.866011340151, 14236.857631423552, 14427.35076921562, 14657.706845863237, 15553.751201749521, 15939.681206376039, 16029.35882564731, 16369.09969951664, 16508.0, 14738.63153421173, 14783.556493304788, 14795.630109247355, 15004.624884377978, 15397.84602153964, 14938.701225975637, 15135.394584216949, 15182.544523664308, 15329.925581441681, 15603.921980390025, 14562.745380273995, 14588.270586470422, 14979.775303370676, 15196.544103676908, 15235.704965078092, 12198.085143614087, 12362.3818809061, 12529.248245105322, 12562.497500099893, 12604.558840440908, 12285.0, 12346.567870124503, 12465.688357790765, 12470.563530276397, 12620.242785432903], "value": 8055.387574396396, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1513.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 112.0, 109.0, 111.0, 111.0, 110.0, 109.0, 112.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 151.0, 172.0, 133.0, 156.0, 155.0, 126.0, 187.0, 126.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 162.0, 165.0, 162.0, 162.0, 165.0, 161.0, 161.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 176.0, 76.0, 76.0, 75.0, 74.0, 162.0, 76.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 160.0, 85.0, 83.0, 85.0, 141.0, 85.0, 89.0, 132.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 119.0, 117.0, 117.0, 122.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 95.0, 95.0, 95.0, 97.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 60.0, 54.0, 53.0, 54.0, 54.0, 52.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 75.0, 76.0, 76.0, 76.0, 82.0, 78.0, 78.0, 111.0, 78.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 116.0, 126.0, 118.0, 117.0, 120.0, 120.0, 128.0, 122.0, 127.0], "value": 122.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 159.0, 156.0, 157.0, 160.0, 151.0, 156.0, 160.0, 154.0, 151.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 62.0, 60.0, 63.0, 62.0, 61.0, 60.0, 59.0, 61.0, 60.0], "value": 61.6, "unit": "score"}]}]} 18:20:56 INFO - Return code: 0 18:20:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:20:56 ERROR - # TBPL SUCCESS # 18:20:56 INFO - Running post-action listener: _resource_record_post_action 18:20:56 INFO - ##### 18:20:56 INFO - ##### Finished run-tests step (success) 18:20:56 INFO - ##### 18:20:56 INFO - Running post-run listener: _resource_record_post_run 18:20:56 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 479232; Write bytes: 503889920; Read time: 76; Write time: 431948 18:20:56 INFO - TinderboxPrint: CPU usage
13.4% 18:20:56 INFO - TinderboxPrint: I/O read bytes / time
479,232 / 76 18:20:56 INFO - TinderboxPrint: I/O write bytes / time
503,889,920 / 431,948 18:20:56 INFO - TinderboxPrint: CPU idle
8,215.5 (86.6%) 18:20:56 INFO - TinderboxPrint: CPU user
1,213.1 (12.8%) 18:20:56 INFO - TinderboxPrint: Swap in / out
0 / 0 18:20:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252309504; Read time: 0; Write time: 258872 18:20:56 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 454656; Write bytes: 250851328; Read time: 64; Write time: 173056 18:20:57 INFO - Running post-run listener: _upload_blobber_files 18:20:57 INFO - Blob upload gear active. 18:20:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:20:57 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 18:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:20:57 INFO - (blobuploader) - INFO - Open directory for files ... 18:20:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:20:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:20:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:20:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:20:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:20:58 INFO - (blobuploader) - INFO - Done attempting. 18:20:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:20:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:20:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:21:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:21:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:21:02 INFO - (blobuploader) - INFO - Done attempting. 18:21:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:21:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:21:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:21:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:21:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:21:02 INFO - (blobuploader) - INFO - Done attempting. 18:21:02 INFO - (blobuploader) - INFO - Iteration through files over. 18:21:02 INFO - Return code: 0 18:21:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:21:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:21:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b784127a4098695ba52b69941ec3f183fb4ff70c3367397839498651b4880b7e6eb360c9707051a74dc374829ccdb974c10eaa23c726142902c0789587396e64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/efb381d9046c2e56a12a11006245a86a1e1113f8c341cc00f5bb2a56fcee5b46388dee15c3556b8ce675447552a66a01f0c31197ee4c724ab4b457fd1f230b16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2acc2266f9ae5f34c8963ae8d4aeb282691a50f885281c6171a01ed9bfe5aebd4885f2543e92de6ac1d7ce0688df5102c43b912b1f8047e77f6aede88df68891"} 18:21:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:21:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:21:02 INFO - Contents: 18:21:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b784127a4098695ba52b69941ec3f183fb4ff70c3367397839498651b4880b7e6eb360c9707051a74dc374829ccdb974c10eaa23c726142902c0789587396e64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/efb381d9046c2e56a12a11006245a86a1e1113f8c341cc00f5bb2a56fcee5b46388dee15c3556b8ce675447552a66a01f0c31197ee4c724ab4b457fd1f230b16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2acc2266f9ae5f34c8963ae8d4aeb282691a50f885281c6171a01ed9bfe5aebd4885f2543e92de6ac1d7ce0688df5102c43b912b1f8047e77f6aede88df68891"} 18:21:02 INFO - Running post-run listener: copy_logs_to_upload_dir 18:21:02 INFO - Copying logs to upload dir... 18:21:02 INFO - mkdir: /builds/slave/test/build/upload/logs 18:21:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.742910 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-13 18:21:02.914134) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 18:21:02.917943) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163 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-Aurora/sha512/b784127a4098695ba52b69941ec3f183fb4ff70c3367397839498651b4880b7e6eb360c9707051a74dc374829ccdb974c10eaa23c726142902c0789587396e64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/efb381d9046c2e56a12a11006245a86a1e1113f8c341cc00f5bb2a56fcee5b46388dee15c3556b8ce675447552a66a01f0c31197ee4c724ab4b457fd1f230b16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2acc2266f9ae5f34c8963ae8d4aeb282691a50f885281c6171a01ed9bfe5aebd4885f2543e92de6ac1d7ce0688df5102c43b912b1f8047e77f6aede88df68891"} build_url:https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011398 build_url: 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b784127a4098695ba52b69941ec3f183fb4ff70c3367397839498651b4880b7e6eb360c9707051a74dc374829ccdb974c10eaa23c726142902c0789587396e64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/efb381d9046c2e56a12a11006245a86a1e1113f8c341cc00f5bb2a56fcee5b46388dee15c3556b8ce675447552a66a01f0c31197ee4c724ab4b457fd1f230b16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2acc2266f9ae5f34c8963ae8d4aeb282691a50f885281c6171a01ed9bfe5aebd4885f2543e92de6ac1d7ce0688df5102c43b912b1f8047e77f6aede88df68891"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 18:21:02.944036) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:21:02.944403) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1468457657.238334-267530163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:21:03.029201) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 18:21:03.029562) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 18:21:03.029950) ========= ========= Total master_lag: 0.18 =========