builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1464941417.99 results: success (0) buildid: 20160602223101 builduid: ce63a416ae014a908e50471ec102bb3c revision: 8b89d98ce322f0c68538db7837cd7eb749d1ed1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 01:10:17.991885) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 01:10:17.992352) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 01:10:17.992662) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 01:10:18.010357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:10:18.010677) ========= 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=ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 01:10:17-- 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% 29.4M=0s 2016-06-03 01:10:18 (29.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075668 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:10:18.101171) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:10:18.101457) ========= 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=ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017824 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:10:18.151539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 01:10:18.151921) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 8b89d98ce322f0c68538db7837cd7eb749d1ed1c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 8b89d98ce322f0c68538db7837cd7eb749d1ed1c --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=ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 01:10:18,164 truncating revision to first 12 chars 2016-06-03 01:10:18,164 Setting DEBUG logging. 2016-06-03 01:10:18,164 attempt 1/10 2016-06-03 01:10:18,164 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/8b89d98ce322?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 01:10:19,733 unpacking tar archive at: mozilla-inbound-8b89d98ce322/testing/mozharness/ program finished with exit code 0 elapsedTime=1.913957 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 01:10:20.079514) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 01:10:20.079847) ========= script_repo_revision: 8b89d98ce322f0c68538db7837cd7eb749d1ed1c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 01:10:20.080266) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 01:10:20.080551) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 01:10:20.088732) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-06-03 01:10:20.089037) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:10:20 INFO - MultiFileLogger online at 20160603 01:10:20 in /builds/slave/test 01:10:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:10:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:10:20 INFO - {'append_to_log': False, 01:10:20 INFO - 'base_work_dir': '/builds/slave/test', 01:10:20 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:10:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:10:20 INFO - 'branch': 'Mozilla-Inbound', 01:10:20 INFO - 'buildbot_json_path': 'buildprops.json', 01:10:20 INFO - 'config_files': ('talos/linux_config.py',), 01:10:20 INFO - 'default_actions': ('clobber', 01:10:20 INFO - 'read-buildbot-config', 01:10:20 INFO - 'download-and-extract', 01:10:20 INFO - 'populate-webroot', 01:10:20 INFO - 'create-virtualenv', 01:10:20 INFO - 'install', 01:10:20 INFO - 'run-tests'), 01:10:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:10:20 INFO - 'download_minidump_stackwalk': True, 01:10:20 INFO - 'download_symbols': 'ondemand', 01:10:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:10:20 INFO - 'tooltool.py': '/tools/tooltool.py', 01:10:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:10:20 INFO - '/tools/misc-python/virtualenv.py')}, 01:10:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:10:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:10:20 INFO - 'installer_path': 'installer.exe', 01:10:20 INFO - 'log_level': 'info', 01:10:20 INFO - 'log_name': 'talos', 01:10:20 INFO - 'log_to_console': True, 01:10:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:10:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:10:20 INFO - 'opt_config_files': (), 01:10:20 INFO - 'pip_index': False, 01:10:20 INFO - 'sps_profile': False, 01:10:20 INFO - 'sps_profile_interval': 0, 01:10:20 INFO - 'suite': 'dromaeojs-e10s', 01:10:20 INFO - 'system_bits': '32', 01:10:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:10:20 INFO - 'title': 'talos-linux64-ix-035', 01:10:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:10:20 INFO - 'use_talos_json': True, 01:10:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:10:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:10:20 INFO - 'work_dir': 'build'} 01:10:20 INFO - ##### 01:10:20 INFO - ##### Running clobber step. 01:10:20 INFO - ##### 01:10:20 INFO - Running pre-action listener: _resource_record_pre_action 01:10:20 INFO - Running main action method: clobber 01:10:20 INFO - rmtree: /builds/slave/test/build 01:10:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:10:20 INFO - Running post-action listener: _resource_record_post_action 01:10:20 INFO - ##### 01:10:20 INFO - ##### Finished clobber step (success) 01:10:20 INFO - ##### 01:10:20 INFO - ##### 01:10:20 INFO - ##### Running read-buildbot-config step. 01:10:20 INFO - ##### 01:10:20 INFO - Running pre-action listener: _resource_record_pre_action 01:10:20 INFO - Running main action method: read_buildbot_config 01:10:20 INFO - Using buildbot properties: 01:10:20 INFO - { 01:10:20 INFO - "project": "", 01:10:20 INFO - "product": "firefox", 01:10:20 INFO - "script_repo_revision": "production", 01:10:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 01:10:20 INFO - "repository": "", 01:10:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 01:10:20 INFO - "buildid": "20160602223101", 01:10:20 INFO - "pgo_build": "True", 01:10:20 INFO - "basedir": "/builds/slave/test", 01:10:20 INFO - "buildnumber": 650, 01:10:20 INFO - "slavename": "talos-linux64-ix-035", 01:10:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:10:20 INFO - "platform": "ubuntu64_hw", 01:10:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:10:20 INFO - "branch": "mozilla-inbound", 01:10:20 INFO - "repo_path": "integration/mozilla-inbound", 01:10:20 INFO - "revision": "8b89d98ce322f0c68538db7837cd7eb749d1ed1c", 01:10:20 INFO - "stage_platform": "linux64-pgo", 01:10:20 INFO - "builduid": "ce63a416ae014a908e50471ec102bb3c", 01:10:20 INFO - "slavebuilddir": "test" 01:10:20 INFO - } 01:10:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:10:20 INFO - Running post-action listener: _resource_record_post_action 01:10:20 INFO - ##### 01:10:20 INFO - ##### Finished read-buildbot-config step (success) 01:10:20 INFO - ##### 01:10:20 INFO - ##### 01:10:20 INFO - ##### Running download-and-extract step. 01:10:20 INFO - ##### 01:10:20 INFO - Running pre-action listener: _resource_record_pre_action 01:10:20 INFO - Running main action method: download_and_extract 01:10:20 INFO - mkdir: /builds/slave/test/build/tests 01:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:20 INFO - https://queue.taskcluster.net/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:10:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:10:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:10:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:10:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:10:23 INFO - Downloaded 1361 bytes. 01:10:23 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:10:23 INFO - Using the following test package requirements: 01:10:23 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:10:23 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:10:23 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:10:23 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:23 INFO - u'jsshell-linux-x86_64.zip'], 01:10:23 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:10:23 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:10:23 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:10:23 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:10:23 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:10:23 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:10:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:10:23 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:23 INFO - https://queue.taskcluster.net/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:10:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:10:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:10:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:10:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:10:29 INFO - Downloaded 24424699 bytes. 01:10:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:10:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:10:31 INFO - Return code: 0 01:10:31 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:10:31 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')]} 01:10:31 INFO - https://queue.taskcluster.net/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:10:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:10:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:10:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:10:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:10:32 INFO - Downloaded 24424699 bytes. 01:10:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:10:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:10:34 INFO - Return code: 0 01:10:34 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')]} 01:10:34 INFO - https://queue.taskcluster.net/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:10:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:10:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:10:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:10:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:10:35 INFO - Downloaded 10833369 bytes. 01:10:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:10:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:10:35 INFO - Return code: 0 01:10: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')]} 01:10:35 INFO - https://queue.taskcluster.net/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:10:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:10:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:10:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:10:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:10:36 INFO - Downloaded 59144183 bytes. 01:10:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:10:36 INFO - mkdir: /builds/slave/test/properties 01:10:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:10:36 INFO - Writing to file /builds/slave/test/properties/build_url 01:10:36 INFO - Contents: 01:10:36 INFO - build_url:https://queue.taskcluster.net/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:10:37 INFO - Running post-action listener: _resource_record_post_action 01:10:37 INFO - Running post-action listener: set_extra_try_arguments 01:10:37 INFO - ##### 01:10:37 INFO - ##### Finished download-and-extract step (success) 01:10:37 INFO - ##### 01:10:37 INFO - ##### 01:10:37 INFO - ##### Running populate-webroot step. 01:10:37 INFO - ##### 01:10:37 INFO - Running pre-action listener: _resource_record_pre_action 01:10:37 INFO - Running main action method: populate_webroot 01:10:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:10:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:10:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:10:37 INFO - '--tppagecycles', 01:10:37 INFO - '7'], 01:10:37 INFO - 'tests': ['tsvgm']}}, 01:10:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:10:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:10:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:10:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:10:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:10:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:10:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:37 INFO - 'talos_options': ['--disable-e10s'], 01:10:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:10:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:10:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:37 INFO - 'talos_options': ['--disable-e10s'], 01:10:37 INFO - 'tests': ['damp', 'tps']}, 01:10:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:37 INFO - 'tests': ['damp', 'tps']}, 01:10:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:10:37 INFO - 'tests': ['dromaeo_dom']}, 01:10:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:10:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:10:37 INFO - 'tests': ['a11yr', 01:10:37 INFO - 'ts_paint', 01:10:37 INFO - 'tpaint', 01:10:37 INFO - 'sessionrestore', 01:10:37 INFO - 'sessionrestore_no_auto_restore', 01:10:37 INFO - 'tabpaint']}, 01:10:37 INFO - 'other-e10s': {'tests': ['a11yr', 01:10:37 INFO - 'ts_paint', 01:10:37 INFO - 'tpaint', 01:10:37 INFO - 'sessionrestore', 01:10:37 INFO - 'sessionrestore_no_auto_restore', 01:10:37 INFO - 'tabpaint']}, 01:10:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:10:37 INFO - 'ts_paint', 01:10:37 INFO - 'tpaint', 01:10:37 INFO - 'sessionrestore', 01:10:37 INFO - 'sessionrestore_no_auto_restore', 01:10:37 INFO - 'tabpaint']}, 01:10:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:10:37 INFO - 'ts_paint', 01:10:37 INFO - 'tpaint', 01:10:37 INFO - 'sessionrestore', 01:10:37 INFO - 'sessionrestore_no_auto_restore', 01:10:37 INFO - 'tabpaint']}, 01:10:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:10:37 INFO - 'tests': ['a11yr', 01:10:37 INFO - 'ts_paint', 01:10:37 INFO - 'tpaint', 01:10:37 INFO - 'sessionrestore', 01:10:37 INFO - 'sessionrestore_no_auto_restore', 01:10:37 INFO - 'tabpaint']}, 01:10:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:10:37 INFO - 'tests': ['a11yr', 01:10:37 INFO - 'ts_paint', 01:10:37 INFO - 'tpaint', 01:10:37 INFO - 'sessionrestore', 01:10:37 INFO - 'sessionrestore_no_auto_restore', 01:10:37 INFO - 'tabpaint']}, 01:10:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:10:37 INFO - 'tests': ['tsvgx', 01:10:37 INFO - 'tsvgr_opacity', 01:10:37 INFO - 'tart', 01:10:37 INFO - 'tscrollx', 01:10:37 INFO - 'cart']}, 01:10:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:10:37 INFO - 'tsvgr_opacity', 01:10:37 INFO - 'tart', 01:10:37 INFO - 'tscrollx', 01:10:37 INFO - 'cart']}, 01:10:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:37 INFO - 'talos_options': ['--disable-e10s'], 01:10:37 INFO - 'tests': ['tp5o']}, 01:10:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:37 INFO - 'tests': ['tp5o']}, 01:10:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:37 INFO - 'talos_options': ['--disable-e10s', 01:10:37 INFO - '--xperf_path', 01:10:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:10:37 INFO - 'tests': ['tp5n']}, 01:10:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:37 INFO - 'talos_options': ['--xperf_path', 01:10:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:10:37 INFO - 'tests': ['tp5n']}}, 01:10:37 INFO - 'talos.zip': {'path': '', 01:10:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:10:37 INFO - Running post-action listener: _resource_record_post_action 01:10:37 INFO - ##### 01:10:37 INFO - ##### Finished populate-webroot step (success) 01:10:37 INFO - ##### 01:10:37 INFO - ##### 01:10:37 INFO - ##### Running create-virtualenv step. 01:10:37 INFO - ##### 01:10:37 INFO - Running pre-action listener: _resource_record_pre_action 01:10:37 INFO - Running main action method: create_virtualenv 01:10:37 INFO - Creating virtualenv /builds/slave/test/build/venv 01:10:37 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 01:10:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:10:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:10:37 INFO - Using real prefix '/usr' 01:10:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:10:38 INFO - Installing distribute.............................................................................................................................................................................................done. 01:10:40 INFO - Installing pip.................done. 01:10:40 INFO - Return code: 0 01:10:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:40 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 0x7fadcc84af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19831c0>, '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 0x19840c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984550>, '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': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', '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 01:10:40 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 01:10:40 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 01:10:40 INFO - Using env: {'DISPLAY': ':0', 01:10:40 INFO - 'HOME': '/home/cltbld', 01:10:40 INFO - 'LANG': 'en_US.UTF-8', 01:10:40 INFO - 'LANGUAGE': 'en_US:en', 01:10:40 INFO - 'LOGNAME': 'cltbld', 01:10:40 INFO - 'MAIL': '/var/mail/cltbld', 01:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:40 INFO - 'MOZ_NO_REMOTE': '1', 01:10:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:40 INFO - 'NO_EM_RESTART': '1', 01:10:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:40 INFO - 'PWD': '/builds/slave/test', 01:10:40 INFO - 'SHELL': '/bin/bash', 01:10:40 INFO - 'SHLVL': '1', 01:10:40 INFO - 'TERM': 'linux', 01:10:40 INFO - 'TMOUT': '86400', 01:10:40 INFO - 'USER': 'cltbld', 01:10:40 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', 01:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:40 INFO - '_': '/tools/buildbot/bin/python'} 01:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:40 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 01:10:40 INFO - Cleaning up... 01:10:40 INFO - Return code: 0 01:10:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:40 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 0x7fadcc84af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19831c0>, '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 0x19840c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984550>, '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': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', '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 01:10:40 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 01:10:40 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 01:10:40 INFO - Using env: {'DISPLAY': ':0', 01:10:40 INFO - 'HOME': '/home/cltbld', 01:10:40 INFO - 'LANG': 'en_US.UTF-8', 01:10:40 INFO - 'LANGUAGE': 'en_US:en', 01:10:40 INFO - 'LOGNAME': 'cltbld', 01:10:40 INFO - 'MAIL': '/var/mail/cltbld', 01:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:40 INFO - 'MOZ_NO_REMOTE': '1', 01:10:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:40 INFO - 'NO_EM_RESTART': '1', 01:10:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:40 INFO - 'PWD': '/builds/slave/test', 01:10:40 INFO - 'SHELL': '/bin/bash', 01:10:40 INFO - 'SHLVL': '1', 01:10:40 INFO - 'TERM': 'linux', 01:10:40 INFO - 'TMOUT': '86400', 01:10:40 INFO - 'USER': 'cltbld', 01:10:40 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', 01:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:40 INFO - '_': '/tools/buildbot/bin/python'} 01:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:40 INFO - Downloading/unpacking psutil>=3.1.1 01:10:40 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 01:10:40 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 01:10:40 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 01:10:40 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 01:10:40 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 01:10:40 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 01:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:10:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:10:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:10:42 INFO - Installing collected packages: psutil 01:10:42 INFO - Running setup.py install for psutil 01:10:42 INFO - building 'psutil._psutil_linux' extension 01:10:42 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 01:10:42 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 01:10:42 INFO - building 'psutil._psutil_posix' extension 01:10:42 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 01:10:43 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 01:10:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:10:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:10:43 INFO - Successfully installed psutil 01:10:43 INFO - Cleaning up... 01:10:43 INFO - Return code: 0 01:10:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:43 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 0x7fadcc84af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19831c0>, '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 0x19840c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984550>, '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': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', '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 01:10:43 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 01:10:43 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 01:10:43 INFO - Using env: {'DISPLAY': ':0', 01:10:43 INFO - 'HOME': '/home/cltbld', 01:10:43 INFO - 'LANG': 'en_US.UTF-8', 01:10:43 INFO - 'LANGUAGE': 'en_US:en', 01:10:43 INFO - 'LOGNAME': 'cltbld', 01:10:43 INFO - 'MAIL': '/var/mail/cltbld', 01:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:43 INFO - 'MOZ_NO_REMOTE': '1', 01:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:43 INFO - 'NO_EM_RESTART': '1', 01:10:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:43 INFO - 'PWD': '/builds/slave/test', 01:10:43 INFO - 'SHELL': '/bin/bash', 01:10:43 INFO - 'SHLVL': '1', 01:10:43 INFO - 'TERM': 'linux', 01:10:43 INFO - 'TMOUT': '86400', 01:10:43 INFO - 'USER': 'cltbld', 01:10:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', 01:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:43 INFO - '_': '/tools/buildbot/bin/python'} 01:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:10:43 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 01:10:43 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 01:10:43 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 01:10:43 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 01:10:43 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 01:10:43 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 01:10:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:10:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:10:45 INFO - Installing collected packages: mozsystemmonitor 01:10:45 INFO - Running setup.py install for mozsystemmonitor 01:10:45 INFO - Successfully installed mozsystemmonitor 01:10:45 INFO - Cleaning up... 01:10:46 INFO - Return code: 0 01:10:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:10:46 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')]} 01:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:46 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')]} 01:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:46 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 0x7fadcc84af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19831c0>, '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 0x19840c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984550>, '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': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', '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 01:10:46 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 01:10:46 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 01:10:46 INFO - Using env: {'DISPLAY': ':0', 01:10:46 INFO - 'HOME': '/home/cltbld', 01:10:46 INFO - 'LANG': 'en_US.UTF-8', 01:10:46 INFO - 'LANGUAGE': 'en_US:en', 01:10:46 INFO - 'LOGNAME': 'cltbld', 01:10:46 INFO - 'MAIL': '/var/mail/cltbld', 01:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:46 INFO - 'MOZ_NO_REMOTE': '1', 01:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:46 INFO - 'NO_EM_RESTART': '1', 01:10:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:46 INFO - 'PWD': '/builds/slave/test', 01:10:46 INFO - 'SHELL': '/bin/bash', 01:10:46 INFO - 'SHLVL': '1', 01:10:46 INFO - 'TERM': 'linux', 01:10:46 INFO - 'TMOUT': '86400', 01:10:46 INFO - 'USER': 'cltbld', 01:10:46 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', 01:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:46 INFO - '_': '/tools/buildbot/bin/python'} 01:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:46 INFO - Downloading/unpacking jsonschema==2.5.1 01:10:46 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 01:10:46 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 01:10:46 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 01:10:46 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 01:10:46 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 01:10:46 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 01:10:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:10:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:48 INFO - Downloading functools32-3.2.3-2.tar.gz 01:10:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:10:49 INFO - warning: no files found matching '*.txt' 01:10:49 INFO - no previously-included directories found matching 'build' 01:10:49 INFO - no previously-included directories found matching 'dist' 01:10:49 INFO - no previously-included directories found matching '.git*' 01:10:49 INFO - Installing collected packages: jsonschema, functools32 01:10:49 INFO - Running setup.py install for functools32 01:10:49 INFO - warning: no files found matching '*.txt' 01:10:49 INFO - no previously-included directories found matching 'build' 01:10:49 INFO - no previously-included directories found matching 'dist' 01:10:49 INFO - no previously-included directories found matching '.git*' 01:10:49 INFO - Successfully installed jsonschema functools32 01:10:49 INFO - Cleaning up... 01:10:49 INFO - Return code: 0 01:10:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:10: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')]} 01:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10: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')]} 01:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10: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', '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 0x7fadcc84af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19831c0>, '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 0x19840c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984550>, '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': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', '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 01:10: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:10: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 blobuploader==1.2.4 01:10:49 INFO - Using env: {'DISPLAY': ':0', 01:10:49 INFO - 'HOME': '/home/cltbld', 01:10:49 INFO - 'LANG': 'en_US.UTF-8', 01:10:49 INFO - 'LANGUAGE': 'en_US:en', 01:10:49 INFO - 'LOGNAME': 'cltbld', 01:10:49 INFO - 'MAIL': '/var/mail/cltbld', 01:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:49 INFO - 'MOZ_NO_REMOTE': '1', 01:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:49 INFO - 'NO_EM_RESTART': '1', 01:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:49 INFO - 'PWD': '/builds/slave/test', 01:10:49 INFO - 'SHELL': '/bin/bash', 01:10:49 INFO - 'SHLVL': '1', 01:10:49 INFO - 'TERM': 'linux', 01:10:49 INFO - 'TMOUT': '86400', 01:10:49 INFO - 'USER': 'cltbld', 01:10:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', 01:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:49 INFO - '_': '/tools/buildbot/bin/python'} 01:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:49 INFO - Downloading/unpacking blobuploader==1.2.4 01:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:51 INFO - Downloading blobuploader-1.2.4.tar.gz 01:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:10:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:10:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:51 INFO - Downloading docopt-0.6.1.tar.gz 01:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:10:52 INFO - Installing collected packages: blobuploader, requests, docopt 01:10:52 INFO - Running setup.py install for blobuploader 01:10:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:10:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:10:52 INFO - Running setup.py install for requests 01:10:52 INFO - Running setup.py install for docopt 01:10:52 INFO - Successfully installed blobuploader requests docopt 01:10:52 INFO - Cleaning up... 01:10:52 INFO - Return code: 0 01:10:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:10: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')]} 01:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10: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')]} 01:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:52 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 0x7fadcc84af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19831c0>, '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 0x19840c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984550>, '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': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', '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 01:10:52 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 01:10:52 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 01:10:52 INFO - Using env: {'DISPLAY': ':0', 01:10:52 INFO - 'HOME': '/home/cltbld', 01:10:52 INFO - 'LANG': 'en_US.UTF-8', 01:10:52 INFO - 'LANGUAGE': 'en_US:en', 01:10:52 INFO - 'LOGNAME': 'cltbld', 01:10:52 INFO - 'MAIL': '/var/mail/cltbld', 01:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:52 INFO - 'MOZ_NO_REMOTE': '1', 01:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:52 INFO - 'NO_EM_RESTART': '1', 01:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:52 INFO - 'PWD': '/builds/slave/test', 01:10:52 INFO - 'SHELL': '/bin/bash', 01:10:52 INFO - 'SHLVL': '1', 01:10:52 INFO - 'TERM': 'linux', 01:10:52 INFO - 'TMOUT': '86400', 01:10:52 INFO - 'USER': 'cltbld', 01:10:52 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', 01:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:52 INFO - '_': '/tools/buildbot/bin/python'} 01:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:10:52 INFO - Running setup.py (path:/tmp/pip-4IdASn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:10:52 INFO - Running setup.py (path:/tmp/pip-byPWQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:10:53 INFO - Running setup.py (path:/tmp/pip-BEYDZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:10:53 INFO - Running setup.py (path:/tmp/pip-IBnbUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:10:53 INFO - Running setup.py (path:/tmp/pip-0R1Uff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:10:53 INFO - Running setup.py (path:/tmp/pip-ZBGmbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:10:53 INFO - Running setup.py (path:/tmp/pip-VVjku0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:10:53 INFO - Running setup.py (path:/tmp/pip-QgG9mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:10:53 INFO - Running setup.py (path:/tmp/pip-9TQVQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:10:53 INFO - Running setup.py (path:/tmp/pip-Zqfhih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:10:53 INFO - Running setup.py (path:/tmp/pip-I11Z30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:10:53 INFO - Running setup.py (path:/tmp/pip-90hOww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:10:53 INFO - Running setup.py (path:/tmp/pip-EQS6Kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:10:53 INFO - Running setup.py (path:/tmp/pip-b4ZbMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:10:53 INFO - Running setup.py (path:/tmp/pip-Z2y57p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:10:53 INFO - Running setup.py (path:/tmp/pip-sv9jSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:10:54 INFO - Running setup.py (path:/tmp/pip-XwDBrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:10:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:10:54 INFO - Running setup.py install for manifestparser 01:10:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:10:54 INFO - Running setup.py install for mozcrash 01:10:54 INFO - Running setup.py install for mozdebug 01:10:54 INFO - Running setup.py install for mozdevice 01:10:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:10:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:10:54 INFO - Running setup.py install for mozfile 01:10:54 INFO - Running setup.py install for mozhttpd 01:10:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:10:54 INFO - Running setup.py install for mozinfo 01:10:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:10:54 INFO - Running setup.py install for mozInstall 01:10:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:10:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:10:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:10:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:10:54 INFO - Running setup.py install for mozleak 01:10:54 INFO - Running setup.py install for mozlog 01:10:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:10:55 INFO - Running setup.py install for moznetwork 01:10:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:10:55 INFO - Running setup.py install for mozprocess 01:10:55 INFO - Running setup.py install for mozprofile 01:10:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:10:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:10:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:10:55 INFO - Running setup.py install for mozrunner 01:10:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:10:55 INFO - Running setup.py install for mozscreenshot 01:10:55 INFO - Running setup.py install for moztest 01:10:55 INFO - Running setup.py install for mozversion 01:10:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:10:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:10:55 INFO - Cleaning up... 01:10:55 INFO - Return code: 0 01:10:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:55 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 0x7fadcc84af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19831c0>, '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 0x19840c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984550>, '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': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', '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 01:10:55 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 01:10:55 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 01:10:55 INFO - Using env: {'DISPLAY': ':0', 01:10:55 INFO - 'HOME': '/home/cltbld', 01:10:55 INFO - 'LANG': 'en_US.UTF-8', 01:10:55 INFO - 'LANGUAGE': 'en_US:en', 01:10:55 INFO - 'LOGNAME': 'cltbld', 01:10:55 INFO - 'MAIL': '/var/mail/cltbld', 01:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:55 INFO - 'MOZ_NO_REMOTE': '1', 01:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:55 INFO - 'NO_EM_RESTART': '1', 01:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:55 INFO - 'PWD': '/builds/slave/test', 01:10:55 INFO - 'SHELL': '/bin/bash', 01:10:55 INFO - 'SHLVL': '1', 01:10:55 INFO - 'TERM': 'linux', 01:10:55 INFO - 'TMOUT': '86400', 01:10:55 INFO - 'USER': 'cltbld', 01:10:55 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', 01:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:55 INFO - '_': '/tools/buildbot/bin/python'} 01:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:10:56 INFO - Running setup.py (path:/tmp/pip-EZ1jXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:10:56 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)) 01:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:10:56 INFO - Running setup.py (path:/tmp/pip-CIVjuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:10:56 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)) 01:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:10:56 INFO - Running setup.py (path:/tmp/pip-wRHhMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:10:56 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)) 01:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:10:56 INFO - Running setup.py (path:/tmp/pip-VUtEjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:10:56 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)) 01:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:10:56 INFO - Running setup.py (path:/tmp/pip-5DgDZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:10:56 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)) 01:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:10:56 INFO - Running setup.py (path:/tmp/pip-O86iOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:10:56 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)) 01:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:10:56 INFO - Running setup.py (path:/tmp/pip-yw2aK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:10:56 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)) 01:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:10:56 INFO - Running setup.py (path:/tmp/pip-WxxLcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:10:56 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)) 01:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:10:56 INFO - Running setup.py (path:/tmp/pip-NLjicu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:10:56 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)) 01:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:10:56 INFO - Running setup.py (path:/tmp/pip-9e3TaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:10:56 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)) 01:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:10:56 INFO - Running setup.py (path:/tmp/pip-wOYVOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:10:56 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)) 01:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:10:56 INFO - Running setup.py (path:/tmp/pip-I_bdTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:10:56 INFO - Running setup.py (path:/tmp/pip-chSv64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:10:57 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)) 01:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:10:57 INFO - Running setup.py (path:/tmp/pip-NDIcNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:10:57 INFO - Running setup.py (path:/tmp/pip-K7ueAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:10:57 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)) 01:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:10:57 INFO - Running setup.py (path:/tmp/pip-Juhv05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:10:57 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)) 01:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:10:57 INFO - Running setup.py (path:/tmp/pip-e0Dvx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:10:57 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)) 01:10:57 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)) 01:10:57 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)) 01:10:57 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)) 01:10:57 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)) 01:10:57 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)) 01:10:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:10:57 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 01:10:57 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 01:10:57 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 01:10:57 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 01:10:57 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 01:10:57 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 01:10:59 INFO - Downloading blessings-1.6.tar.gz 01:10:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:10:59 INFO - Installing collected packages: blessings 01:10:59 INFO - Running setup.py install for blessings 01:10:59 INFO - Successfully installed blessings 01:10:59 INFO - Cleaning up... 01:10:59 INFO - Return code: 0 01:10:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:10:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:10:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:10:59 INFO - Reading from file tmpfile_stdout 01:10:59 INFO - Current package versions: 01:10:59 INFO - argparse == 1.2.1 01:10:59 INFO - blessings == 1.6 01:10:59 INFO - blobuploader == 1.2.4 01:10:59 INFO - docopt == 0.6.1 01:10:59 INFO - functools32 == 3.2.3-2 01:10:59 INFO - jsonschema == 2.5.1 01:10:59 INFO - manifestparser == 1.1 01:10:59 INFO - mozInstall == 1.12 01:10:59 INFO - mozcrash == 0.17 01:10:59 INFO - mozdebug == 0.1 01:10:59 INFO - mozdevice == 0.48 01:10:59 INFO - mozfile == 1.2 01:10:59 INFO - mozhttpd == 0.7 01:10:59 INFO - mozinfo == 0.9 01:10:59 INFO - mozleak == 0.1 01:10:59 INFO - mozlog == 3.2 01:10:59 INFO - moznetwork == 0.27 01:10:59 INFO - mozprocess == 0.22 01:10:59 INFO - mozprofile == 0.28 01:10:59 INFO - mozrunner == 6.11 01:10:59 INFO - mozscreenshot == 0.1 01:10:59 INFO - mozsystemmonitor == 0.3 01:10:59 INFO - moztest == 0.7 01:10:59 INFO - mozversion == 1.4 01:10:59 INFO - psutil == 3.1.1 01:10:59 INFO - requests == 1.2.3 01:10:59 INFO - wsgiref == 0.1.2 01:10:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:10: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')]} 01:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10: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')]} 01:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:59 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 0x7fadcc84af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19831c0>, '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 0x19840c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984550>, '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': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', '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 01:10:59 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 01:10:59 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 01:10:59 INFO - Using env: {'DISPLAY': ':0', 01:10:59 INFO - 'HOME': '/home/cltbld', 01:10:59 INFO - 'LANG': 'en_US.UTF-8', 01:10:59 INFO - 'LANGUAGE': 'en_US:en', 01:10:59 INFO - 'LOGNAME': 'cltbld', 01:10:59 INFO - 'MAIL': '/var/mail/cltbld', 01:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:59 INFO - 'MOZ_NO_REMOTE': '1', 01:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:59 INFO - 'NO_EM_RESTART': '1', 01:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:59 INFO - 'PWD': '/builds/slave/test', 01:10:59 INFO - 'SHELL': '/bin/bash', 01:10:59 INFO - 'SHLVL': '1', 01:10:59 INFO - 'TERM': 'linux', 01:10:59 INFO - 'TMOUT': '86400', 01:10:59 INFO - 'USER': 'cltbld', 01:10:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', 01:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:59 INFO - '_': '/tools/buildbot/bin/python'} 01:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:59 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)) 01:10:59 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)) 01:10:59 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)) 01:10:59 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)) 01:10:59 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)) 01:10:59 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)) 01:10:59 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)) 01:10:59 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)) 01:10:59 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)) 01:10:59 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)) 01:10:59 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)) 01:10:59 INFO - Cleaning up... 01:10:59 INFO - Return code: 0 01:10:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:10: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')]} 01:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10: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')]} 01:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadcc84af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19831c0>, '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 0x19840c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984550>, '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': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', '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 01:10:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:10:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:10:59 INFO - Using env: {'DISPLAY': ':0', 01:10:59 INFO - 'HOME': '/home/cltbld', 01:10:59 INFO - 'LANG': 'en_US.UTF-8', 01:10:59 INFO - 'LANGUAGE': 'en_US:en', 01:10:59 INFO - 'LOGNAME': 'cltbld', 01:10:59 INFO - 'MAIL': '/var/mail/cltbld', 01:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:59 INFO - 'MOZ_NO_REMOTE': '1', 01:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:59 INFO - 'NO_EM_RESTART': '1', 01:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:59 INFO - 'PWD': '/builds/slave/test', 01:10:59 INFO - 'SHELL': '/bin/bash', 01:10:59 INFO - 'SHLVL': '1', 01:10:59 INFO - 'TERM': 'linux', 01:10:59 INFO - 'TMOUT': '86400', 01:10:59 INFO - 'USER': 'cltbld', 01:10:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', 01:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:59 INFO - '_': '/tools/buildbot/bin/python'} 01:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:11:00 INFO - Cleaning up... 01:11:00 INFO - Return code: 0 01:11:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:11:00 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')]} 01:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:00 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')]} 01:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:00 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 0x7fadcc84af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19831c0>, '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 0x19840c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984550>, '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': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', '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 01:11:00 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 01:11:00 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 01:11:00 INFO - Using env: {'DISPLAY': ':0', 01:11:00 INFO - 'HOME': '/home/cltbld', 01:11:00 INFO - 'LANG': 'en_US.UTF-8', 01:11:00 INFO - 'LANGUAGE': 'en_US:en', 01:11:00 INFO - 'LOGNAME': 'cltbld', 01:11:00 INFO - 'MAIL': '/var/mail/cltbld', 01:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:00 INFO - 'MOZ_NO_REMOTE': '1', 01:11:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:11:00 INFO - 'NO_EM_RESTART': '1', 01:11:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:00 INFO - 'PWD': '/builds/slave/test', 01:11:00 INFO - 'SHELL': '/bin/bash', 01:11:00 INFO - 'SHLVL': '1', 01:11:00 INFO - 'TERM': 'linux', 01:11:00 INFO - 'TMOUT': '86400', 01:11:00 INFO - 'USER': 'cltbld', 01:11:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', 01:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:00 INFO - '_': '/tools/buildbot/bin/python'} 01:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:00 INFO - Downloading/unpacking flake8 01:11: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 01:11: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 01:11: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 01:11: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 01:11: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 01:11: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 01:11:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:11:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:11:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:11:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:11:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:11:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:11:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:11:02 INFO - no previously-included directories found matching 'docs/_build' 01:11:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:11:03 INFO - Running setup.py install for pep8 01:11:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:11:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:11:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:11:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:11:03 INFO - no previously-included directories found matching 'docs/_build' 01:11:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:11:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:11:03 INFO - Cleaning up... 01:11:03 INFO - Return code: 0 01:11:03 INFO - Running post-action listener: _resource_record_post_action 01:11:03 INFO - Running post-action listener: _start_resource_monitoring 01:11:03 INFO - Starting resource monitoring. 01:11:03 INFO - ##### 01:11:03 INFO - ##### Finished create-virtualenv step (success) 01:11:03 INFO - ##### 01:11:03 INFO - ##### 01:11:03 INFO - ##### Running install step. 01:11:03 INFO - ##### 01:11:03 INFO - Running pre-action listener: _resource_record_pre_action 01:11:03 INFO - Running main action method: install 01:11:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:11:03 INFO - Reading from file tmpfile_stdout 01:11:03 INFO - Detecting whether we're running mozinstall >=1.0... 01:11:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:11:03 INFO - Reading from file tmpfile_stdout 01:11:03 INFO - Output received: 01:11:03 INFO - Usage: mozinstall [options] installer 01:11:03 INFO - Options: 01:11:03 INFO - -h, --help show this help message and exit 01:11:03 INFO - -d DEST, --destination=DEST 01:11:03 INFO - Directory to install application into. [default: 01:11:03 INFO - "/builds/slave/test"] 01:11:03 INFO - --app=APP Application being installed. [default: firefox] 01:11:03 INFO - mkdir: /builds/slave/test/build/application 01:11:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:11:20 INFO - Reading from file tmpfile_stdout 01:11:20 INFO - Output received: 01:11:20 INFO - /builds/slave/test/build/application/firefox/firefox 01:11:20 INFO - Running post-action listener: _resource_record_post_action 01:11:20 INFO - ##### 01:11:20 INFO - ##### Finished install step (success) 01:11:20 INFO - ##### 01:11:20 INFO - ##### 01:11:20 INFO - ##### Running run-tests step. 01:11:20 INFO - ##### 01:11:20 INFO - Running pre-action listener: _resource_record_pre_action 01:11:20 INFO - Running main action method: run_tests 01:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:11:20 INFO - Python 2.7.3 01:11:20 INFO - Return code: 0 01:11:20 INFO - grabbing minidump binary from tooltool 01:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:11:20 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 0x19831c0>, '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 0x19840c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:11:20 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 01:11:20 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 01:11:20 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 01:11:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:11:20 INFO - Return code: 0 01:11:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:11:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:11:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:11:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:11:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:11:21 INFO - Return code: 0 01:11:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 01:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 01:11:21 INFO - Using env: {'DISPLAY': ':0', 01:11:21 INFO - 'HOME': '/home/cltbld', 01:11:21 INFO - 'LANG': 'en_US.UTF-8', 01:11:21 INFO - 'LANGUAGE': 'en_US:en', 01:11:21 INFO - 'LOGNAME': 'cltbld', 01:11:21 INFO - 'MAIL': '/var/mail/cltbld', 01:11:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:11:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:21 INFO - 'MOZ_NO_REMOTE': '1', 01:11:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:11:21 INFO - 'NO_EM_RESTART': '1', 01:11:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:21 INFO - 'PWD': '/builds/slave/test', 01:11:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:11:21 INFO - 'SHELL': '/bin/bash', 01:11:21 INFO - 'SHLVL': '1', 01:11:21 INFO - 'TERM': 'linux', 01:11:21 INFO - 'TMOUT': '86400', 01:11:21 INFO - 'USER': 'cltbld', 01:11:21 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570', 01:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:21 INFO - '_': '/tools/buildbot/bin/python'} 01:11:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 01:11:21 INFO - mozversion application_buildid: 20160602223101 01:11:21 INFO - mozversion application_changeset: 8b89d98ce322f0c68538db7837cd7eb749d1ed1c 01:11:21 INFO - mozversion application_display_name: Nightly 01:11:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:11:21 INFO - mozversion application_name: Firefox 01:11:21 INFO - mozversion application_remotingname: firefox 01:11:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:11:21 INFO - mozversion application_vendor: Mozilla 01:11:21 INFO - mozversion application_version: 49.0a1 01:11:21 INFO - mozversion platform_buildid: 20160602223101 01:11:21 INFO - mozversion platform_changeset: 8b89d98ce322f0c68538db7837cd7eb749d1ed1c 01:11:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:11:21 INFO - mozversion platform_version: 49.0a1 01:11:21 INFO - using testdate: 1464941481 01:11:21 INFO - actual date: 1464941481 01:11:21 INFO - starting webserver on 'localhost:59077' 01:11:21 INFO - SUITE-START | Running 2 tests 01:11:21 INFO - TEST-START | dromaeo_css 01:11:21 INFO - operating with platform_type : linux_ 01:11:21 INFO - Initialising browser for dromaeo_css test... 01:11:21 INFO - TEST-INFO | started process 3896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8W9NGi/profile http://localhost:59077/getInfo.html) 01:11:25 INFO - PROCESS | 3896 | __metrics Screen width/height:1600/1200 01:11:25 INFO - PROCESS | 3896 | colorDepth:24 01:11:25 INFO - PROCESS | 3896 | Browser inner width/height: 1024/697 01:11:25 INFO - PROCESS | 3896 | __metrics 01:11:26 ERROR - PROCESS | 3896 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 01:11:27 INFO - TEST-INFO | 3896: exit 0 01:11:27 INFO - Browser initialized. 01:11:27 INFO - Running cycle 1/1 for dromaeo_css test... 01:11:27 INFO - TEST-INFO | started process 4015 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8W9NGi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:11:39 INFO - PROCESS | 4015 | RSS: Main: 167206912 01:11:39 INFO - PROCESS | 4015 | 01:12:28 INFO - PROCESS | 4015 | 1464941548964 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] 01:14:36 INFO - PROCESS | 4015 | Cycle 1(1): loaded http://localhost:59077/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59077/tests/dromaeo/cssquery-ext.html) 01:14:37 INFO - PROCESS | 4015 | RSS: Main: 170778624 01:14:37 INFO - PROCESS | 4015 | 01:17:39 INFO - PROCESS | 4015 | Cycle 1(1): loaded http://localhost:59077/tests/dromaeo/cssquery-ext.html (next: http://localhost:59077/tests/dromaeo/cssquery-jquery.html) 01:17:40 INFO - PROCESS | 4015 | RSS: Main: 170311680 01:17:40 INFO - PROCESS | 4015 | 01:20:41 INFO - PROCESS | 4015 | Cycle 1(1): loaded http://localhost:59077/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59077/tests/dromaeo/cssquery-mootools.html) 01:20:42 INFO - PROCESS | 4015 | RSS: Main: 170954752 01:20:42 INFO - PROCESS | 4015 | 01:23:44 INFO - PROCESS | 4015 | Cycle 1(1): loaded http://localhost:59077/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59077/tests/dromaeo/cssquery-prototype.html) 01:23:44 INFO - PROCESS | 4015 | RSS: Main: 168390656 01:23:44 INFO - PROCESS | 4015 | 01:26:47 INFO - PROCESS | 4015 | Cycle 1(1): loaded http://localhost:59077/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59077/tests/dromaeo/cssquery-yui.html) 01:26:47 INFO - PROCESS | 4015 | RSS: Main: 169996288 01:26:47 INFO - PROCESS | 4015 | 01:29:50 INFO - PROCESS | 4015 | Cycle 1(1): loaded http://localhost:59077/tests/dromaeo/cssquery-yui.html (next: http://localhost:59077/tests/dromaeo/cssquery-dojo.html) 01:29:50 INFO - PROCESS | 4015 | RSS: Main: 171376640 01:29:50 INFO - PROCESS | 4015 | 01:29:50 INFO - PROCESS | 4015 | __start_tp_report 01:29:50 INFO - PROCESS | 4015 | _x_x_mozilla_page_load 01:29:50 INFO - PROCESS | 4015 | _x_x_mozilla_page_load_details 01:29:50 INFO - PROCESS | 4015 | |i|pagename|runs| 01:29:50 INFO - PROCESS | 4015 | |0;dojo.html;3123.531470279458;3127.906162815116;3153.795003324782;3166.097662166283;3183.172375182452;5484.177373393993;5516.227728118067;5571.832845014651;5622.269105016342;5630.465105814951;5443.074677304858;5488.121900495921;5525.557955363572;5540.778368865251;5545.112781954888;4959;4992.750362481879;5098.719570423626;5137.101007323722;5189.3772747270195;716.5195976853852;5047.242913562958;5082.186850103984;5090.541851233388;5094.7197904115255;5021.748912554376;5030.220315851031;5033.999999999982;5037.773300201499;5109.667871588354;4969.7515124244;5057.797688092472;5080.441151473335;5083.898322033576;5086.821961231339;4970.179920313144;4979.253112033188;5029.119904016819;5030.446650868402;5040.319556859814;5455.918161227585;5482.205080263379;5496.890062198773;5508.807191748309;5560.304961879765;5712.542996560265;5759.107338362561;5870.324912635059;5892.175095486636;5901.380355062743;5831.329397119343;5841.88316233673;5900.321463031763;5916.763329466816;5920.674362910038;5460.481254280837;5497.147942068986;5502.944970550323;5507.752151153168;5508.944910550883;5961.135635332939;5971.671558064349;6073.1497590337385;6076.787312444043;6079;5686.715664216773;5724.685142317213;5735.598508104476;5745.913811292834;5789.594728368974;5824.708764561755;5831.79588714393;5833.620814647034;5838.095095260242;5838.67887266196;5763.106718458645;5768.653880767168;5791.305043394819;5825.33008703996;5907.763689452459;5913.9112913306335;5918.733656985446;5956.940430595725;5969.970150149308;5980.940190598125;4476.798544065525;4485.506594274627;4502.842400515966;4509.233430316854;4544.931826022612;3964.048628329238;3971.3645816669195;4015.377616469452;4035.9192816143513;4052.513698356216;5630.577706672016;5651.632643878217;5695.288088988877;5709.914351284734;5720.342160651495;5956.940430595725;5977.312609049928;5980.102984552352;5981.730822113015;5992.640441573432;5587.1339942309005;5587.664740115606;5680.857978550486;5683.658980461186;5684.232628595087;5055.9241611375855;5056.898862022739;5076;5117.462666420047;5150.587952963754;6116.143739876421;6118.632882027093;6162.952298109332;6166.1983942087245;6168.629882207082;5892.263467066617;5902.2622172228475;5924;5937.9406205937385;5994.790182343597;6106.816795496142;6138.662373569318;6178.258608966953;6188.566800323934;6194.5973511721595;5811.506021988009;5816.185733997159;5820.912686309624;5848.122781582627;5872.500837428695;5783.045797443543;5821.09772985188;5936.37668044849;5965.4929331005615;5983.521318294613;5711.600187986801;5752.33848107473;5755.050416681201;5774.105013722712;5798.739056742541;5772.624779389326;5781.364049954585;5784.132380143013;5785.537157027344;5793.15999180125;5501.559875210054;5572.554195664418;5637.43625637433;5655.830325090254;5706.144078388275;5760.214333556611;5825.94174058254;5836.620619659709;5841.883162336814;5843.2403787507355;5633;5654.378018417889;5678.602497825278;5694.487496125369;5707.058335374617 01:29:50 INFO - PROCESS | 4015 | |1;ext.html;577.6851615869351;625.4652272307177;636.9235691716989;653.865957478717;661.0183876942739;33050.338993220124;35888.28223435533;42777.572224277785;43588.564114358844;43751.78124109383;43682.34476482847;44627.55372446275;44833;44851.08467949581;45108;8533.104024077476;8652.61063252152;8683.869741953844;8721.215090641841;8721.215090641841;8581.570921453902;8712.912870871274;8715;8721.084286149959;8740.4755714657;8709.52097634633;8767.693130740425;8825.02924678285;8829.470231786081;8838.072002439747;8693.826123477527;8730.432521886058;8732.432391894537;8779.385443018991;8786.428882122642;8634.352423568194;8675.479471231683;8710.825783484359;8715.869261961076;8728.781780455476;41460.1707965842;41943.58056419427;41943.79028104871;41971.58028419707;42079.36880946788;3559.626239244894;3656.067702735812;3681.889543313705;3687.6681098701247;3715.981420092909;30976.845115774504;31221.53167702486;31310;31725.84137079323;32447.837760811282;4331.566843315643;4390.714603550759;4402.405675233835;4418.352547507423;4437.689361744679;279452;280848.7660493598;281148;282588;283982;35304.64695353065;36527.26945461076;36576.63423365785;58475.41524584785;59665;37957;38429.80785096057;38585.80707096447;38638.420423693104;38685.419718704245;14966.476173333882;15062;15079.095254284777;15211.391544338103;15231.847681523264;12415.689607759878;12428.56500022495;12495.25028498293;12556.121071525089;12610.432530536147;8565.571721413904;8575.614097365633;8622.913770862337;8633.525156116348;8648.091950345122;3298.142482954401;3324.384988777084;3352.4803655433448;3380.8985730428126;3397.3205358928312;1097.4074000040048;1115.1524841120806;1116.1963386361806;1150.539784086372;1226.9141160118884;32862;32933.17667058343;33218.16954576155;33290.500642490384;33296.1675958103;1157.65270418874;1174.2250114924109;1184.6979020349756;1224.12475080318;1247.7379750252549;16634.83365166357;17122.229499672296;17354.39259625907;17457.127143642767;17537.17917965943;564559;565549;571186;576907;578415;59442.70278648579;59854;59959.700201498716;60009.399906000384;60264.09603855946;1369.103237379518;1379.475799196299;1399.8040274361597;1421.587739555538;1424.9287535623384;31159.688403115677;31627.367452650356;31876.362472749952;32002.359952800347;32885.17787055343;52261.7386913063;52457.21314180214;52461;52555;52583.211251830486;432446;442156;443414;444261;445370;28512.42975140527;28662.570061448678;29137.562936555543;29191.7080829189;29207.85396073006;48828.5117148824;49542.75228623834;49721.75139124281;50340.24489632732;50472;41301.586984129775;41599.168016640106;41705.37441938434;42029;42794.78602606967;40632.59367406288;40717;40744.3888341681;41481.79259103685;42164;37596.62403375931;41672;41824;42038.78980605077;42950.570494295906;36204.81897590495;36679;37767.24465510729;38188.07682713894;38721.4191787129;27484;28425.28936776597;28746.712532874404;28750.712492875642;29955.251118722208 01:29:50 INFO - PROCESS | 4015 | |2;jquery.html;388.5046565628825;389.2662331505113;398.7308566717465;401.6746435387336;424.6008751773333;18281.63436731266;19520.804791952076;19797.307094251722;19863.900680496612;20647.38057858263;18946.905265473688;19368.51578710533;19451.805481945175;19482.610347793037;19594.21623135073;5687.090065589507;5732.2548068751;5872.530197584183;5887.528997680175;5897.233359663238;5809.651420914737;5863.355030946593;5869.325027621814;5890.087036509348;5893.292804863422;5575.944240557604;5888.440598143191;5896.97051514744;5897.616654917438;5901.645901245917;5401.27082843815;5803.883922321551;5835.5915085944;5846.473817356458;5867.4719275265215;5537.750801213955;5586.497215250647;5617.494425501724;5619.4942455178825;5633.211350410946;16663.583410414714;22551.887240563858;23273.301800946;23374.298771036894;23397.298081057597;2027.9898600507051;2124.171573086482;2217.756046834847;2229.665550167472;2386.021731090262;10180.287379883412;10226.284160108795;10348.120409765179;12022.51909923602;14372.281385930663;1854.6568884756364;1925.5859990102056;1940.602176553803;2013.4362378534033;2056.629806634805;79637.60181199115;83100.58449707713;85391;85718;86757.56621216853;10969.177311701655;11273;11290.548378064785;11316.20786544934;11435.428228588537;15577.766333505006;15603.063816171067;15650.608734781494;15732.370705171665;15763.448279310398;7430.145533263744;7703.614819259014;7708.113566939874;7744.225577442211;7798.1811909749795;7044.542104763174;7133.964330178316;7219.783406497813;7222.963885180646;7228.566286022856;4759.309900064472;4851.854444366674;4862.9756851216225;4894.706317620883;4904.141775189328;2036.6028624418095;2042.4179108953876;2044.9897750511152;2066;2069.0896005757418;968.4770224078918;996.14829320931;1010.6008126789877;1038.1383451735194;1075.231209685079;19352.225910963687;19461.708074378897;19598.804011959983;19673;19717.211311547664;973.0707174648194;994.6419289055934;999.3304485994402;1017.3387298256192;1067.9252452328417;10591.152707783358;11170.776584468265;11208.439578021067;11252.943735281435;11289.830652540219;478844;479022;485604;489244;495100;77926.2207377919;88829.55585222032;90228.5488572553;97264.51367743258;99732.5013374943;987.116530705015;1014.0417305646241;1020.8264595019014;1026.6201505443034;1026.8305729554688;17944.37194698179;18018.459446216635;18130.45608631743;18182.636347273245;18227.54431139232;41872.581274186865;42018.57981420147;42742.14515709731;43063.784681076395;45102.54897451115;60002;60549.69725151346;60880.391196089244;61294.69352653208;61537;7234.385077268491;7875.621766191009;8505.872411913702;8782.824343513223;9000.279977601645;13075.084744068205;13459.394327255493;13520.459181632625;13688.52090176839;13780.448782048607;11860.58487952952;11874.881251187378;11946.581869634521;11971.281723096643;12029.939850300692;5491.505764481056;10716.571337146426;11552.82670759956;11992.880071199525;12087.39563021863;12344.753104937672;12575;12603.684907877376;12711;12884.806727898902;7667.961660191663;7985.680572777024;8140.511569305861;8752.51861147643;9105.863412048957;9235.76910577241;12210.877891220975;12280.263184208976;12317.076219283768;12387.62837114888 01:29:50 INFO - PROCESS | 4015 | |3;mootools.html;1492.6044598181481;1526.0767235822325;1679.202378870037;1781.9465416037508;1809.873308868379;7831.843363132734;8300.377471689617;8406.831863362744;8873.866891996617;8897.777555561113;8491.617877195526;8726.738197854058;8743.081976392466;8744.43161194522;8812.77968050799;2350.9882450587725;2369.905203791855;2388.844725092872;2390.3665528634924;2396.0775101585928;2369.3484291819714;2385.2486466763003;2392.95214095718;2393.7606239376096;2396.4847557775074;2353.235198560466;2361.53949979754;2375.9406014849596;2413.5776239158163;2413.722421921484;2240.8319376046697;2254;2258.8757618330983;2264.490489639826;2319.6404557293477;2298.3107416049193;2301.5972204864247;2303.7235531736133;2333.3116730564357;2334.276374323948;8688.218060374596;8763.56182190888;8787.824243515157;8817.206451419403;8857.867131993025;5247.685138891678;5455.399906010336;5457.918131228034;5467.398586155519;5470.753816078286;3323.2854936188837;3411.232472693649;3453.3438646657305;3459.6021457532456;3668.192997540537;1170.678063532527;1182.3851597169423;1212.1393810394543;1215.6778453709774;1217.6103646833017;12015.459304331414;12068.215565988183;12094.092943029307;12113.878861211364;12114.939425302817;4634;4754.619630429557;4768.3085952536685;4785.617150627942;4919.2867034279825;10331.896681033093;10337.483125843677;10353.63762268317;10361.689149325532;10364.637237696645;5325.600579956519;5386.91919621206;5396.62223644349;5407.134858422633;5430.13117901134;4385.144896745168;4822.107910036654;4937.703737775673;4988.5260900214425;5013.799448022111;3968.2460332537303;4018.8593399230886;4065.3901914712437;4086.5709100544013;4134.64855487281;1322.5040609771336;1341.3695563085334;1344.932753362328;1349.0758830201344;1358.436248956672;992.8758905136858;1008.1229330482381;1022.3508072373947;1025.3847691385108;1031.8452232165084;6085.847853803691;6222.12890195373;6242.375762423721;6276.46650034743;6590.868182636321;984.9261305402124;999.4652860719481;1018.3279035836313;1029.6344797596746;1041.3962497753525;4284.143171365677;4447.399601053817;4479.910401791946;4499;4520.321951707205;10059;10634.361938283728;10950.507227174796;10951.178661600412;10977.231593788358;10598.417087060287;10695.572177112985;10706.78586428267;10722.89277107219;10747.677569672922;7883.448158628841;8046.114927357986;8062.516249025077;8112.22933821286;8125.390595705346;5980.222571065734;6108.969455152695;6201.193844800147;6244.313125556276;6288.496920246461;10135.543900524346;10146.441945693057;10153.847692284475;10162.18702503783;10294.227932904912;9739.269554783277;10120.544575494268;10168.796624067625;10343.94828025855;10384.844227336445;7277.490575659653;7653.732119375795;7877.527348359117;7910.248526389983;8042.517448953082;8690.565471726515;8730.083341249077;8741.781455463664;8769.780755481164;8824.955875220583;7531.435142364235;7640.541567505968;7662.8084297893;7721.150673425806;7994.0407151142235;7593.810154746176;7690.730824421118;7712.344450721752;7727.49771264866;7836.686532538863;7067.787966361017;7097.7160913562875;7148.392386647193;7172.820679483055;7195.820104497429;5059.215821547666;5210.478952104911;5265.157574788015;5383.300170977748;5395.190721391823;5418.45815418455;5422.590305911487;5437;5449.564034877121;5601.747921343631 01:29:50 INFO - PROCESS | 4015 | |4;prototype.html;332.2010564592157;332.4332013916273;341.87008936604093;346.3436787288089;349.35892637011085;5451.672899626025;5516.420775818541;5674;5688.29351194641;5711.457411545907;5577.9163312550245;5588.692621905793;5589.580781441387;5606.35526914405;5616.52259557938;4360.36774667673;4360.912781744363;4372.55137123212;4377.737335759849;4395.340698895176;4045.757254564721;4302.97848510757;4318.136372725452;4380.956190438103;4409.713368631029;4235.131797981407;4254.6170844623975;4259.318509038554;4287.399764033023;4304.849330273441;4265.978670106645;4266.722663026893;4284.764337961411;4318.438602981592;4337.501187363462;3575.9987203583037;3769.981150094259;3801.7528860624247;3803.8098095095133;3804.258169656918;5372.206452644642;5384.623076384654;5390.924494069812;5394.595405344615;5415.729213539307;4910.582600478963;4931.876703082416;4933.851984440473;4936.259561065869;4941.925871111936;5505.3393592768725;5793.333766616851;5793.594448388614;5796.275465566804;5808.82573522795;4124.216398884202;4131.772752498611;4134.3178375567995;4144.8756537303625;4148.377743338493;6080.939190608082;6100.145979562821;6176.764647070604;6191.938080619181;6204.286507051702;4193.30810416284;4266.573342665771;4266.765327906933;4274.978625106854;4309.202797482476;4321.546237645002;4322.092360604308;4345.695801293879;4353.782310884507;4362.541933097043;4913.434954980152;4919.508049195123;4939.036887806915;4956.504349565014;4967.478414766398;5649.152627105967;5772.278465191851;5793.580572759616;5874.765009399576;5889.263842019747;1450.8103355248595;1473.4400927647425;1479.963000924964;1492.925353732309;1494.275276490901;926.7822061815468;947.824652439301;951.5622813505727;964.8456247000446;965.9951700241454;5010.298558201855;5068.493150684976;5102.821401250939;5118.36212412032;5120.308758317579;5317.8404647860625;5375.650582712111;5405.945840561131;5424.430434804289;5516.696581687966;4919.311296418504;5099.745012749422;5132.692038477703;5177;5197.66215196011;2862.155664079102;2877.5827505011657;2882.8990985315413;2892.1056707856387;2922.795404321677;5484.561235101182;5493.7802487900835;5508.228847961289;5525.861853453695;5555.416681248492;5116.386033675983;5415.268938693226;5438.238646589481;5454.972725136349;5495.670259784426;5503.394626591072;5517.227588137664;5522.723863806794;5570.108782594765;5584.413636568183;5078.577998160521;5245.868853278698;5343.839684809462;5358.383785864676;5400.405955344988;5289.629725919149;5310.787568497217;5311.681299122065;5316.601254905975;5341.813036543857;5542.72286385671;5572.442755724395;5587.74855131512;5596.048671725898;6028.6985650716415;4084.795760212037;4248.150369925966;4258.190943720683;4264.445622069111;4269.829206831692;5985.191999080069;6023.879522409615;6026.939730602813;6053.757849685963;6055.545834062551;5686.488216060575;5825.475707186204;5832.591718579659;5878.382769809108;5902.1441890926435;5748.338941021836;5775.653460792366;5778.046622307273;5802;5820.243368362086;5697.7151142443545;5742.483176514133;5754.482096611325;5772.220750198838;5797.6521408713925;5572.804951826666;5798.6810725410505;5805.593608447368;5819.301683797971;5894.823155305347;5640.210370548209;5733.827985160452;5743.10981797822;5766.711664416846;5776.682282474504 01:29:50 INFO - PROCESS | 4015 | |5;yui.html;765.9080910290766;771.9575423351716;828.8466633672771;866.3459088388266;879.0769691823585;15696.215189240535;15763;17163;17206.56983575411;17237.741433878502;15648.687026259468;15664.765028524553;15680.76478852818;15723.213839308046;15814.76277855833;665.3978149774462;788.0858204482801;840.474703310431;843.3211264931728;843.4686147726924;820.8153165537766;821.1542111625006;821.4988856797349;825.6697321071589;827.71443851871;863.4171933944593;865.5845194306705;869.4956924983494;870.8214815962713;872.85161522541;859.3984211052257;861.4314552395421;862.9395942284043;864.5245115186622;866.4411454611803;627.8179327994922;628.3904612525843;629.5435809038411;630.6562923206864;633.1104797759156;15739.134347610876;15740.60648483797;15744.921275393664;15748.68502629941;15809.367625294974;15596.14221217844;15634.530964070982;15651.217439127999;15676.764848527282;15924.601884952854;11666.70833229176;11686.12354073448;11699.76600467986;11830;11957.530663198673;3842.692584593226;3959.78221197834;3982.7411218270718;3984.780837053961;4103.712740108193;77559.61220193919;77871.61064194643;78585;79142;79404;11488.138389620644;11507.654770356903;11667.88332116685;11672.416379181008;11932;20541.63771166305;20593;20596.27913023037;20616.896915515328;20656.793432065788;8613.956930215309;8652.264557512683;8783.692570759993;8807.823843523094;8853.15894989975;4602.654800889946;4669.95330046702;4813.9037219255415;4897.1772383033185;4952.380952380952;3496.5804103507744;3575.5173051638217;3584;3599.856005759793;3609.512715783336;650.2749434380631;655.6197405504796;659.1069101367674;669.2872091222832;677.3497442455298;655.9341070760015;703.5708217987126;716.9068021157216;729.6680010595167;749.726349882289;9244.722658320261;9716.708498745049;9726.513674316257;9758.414495130315;9851;660.7059858362983;694.5797792335666;695.6935380773274;711.210556282526;715.3669002932443;4596.49438561758;4808.495108013608;4831.299461578052;4841.273808928689;4869.123557759637;112203.4389828062;114129;116744;120772.3961380205;122706.38646806887;98966;102260;103048;103274;103498;58255;62108.68945655243;88578;89656;89907.10092898988;8963.865542016745;8966.327525435488;9014.233790127913;9095.636174552943;9105.135012173832;52214.73892630664;52996.47003529916;53833.78283887692;54201.45798541964;56544;74350.62824685842;77014.614926925;77209;77293.61353193199;81180;10588.894111058791;10802;10836.241463097824;11006.119510439306;11031.448427578749;14225.786613201017;14801.555953321418;15244.237788110771;15585.29866156003;16742.916285418494;14774.48289309869;14890.702185956437;15121;15232.086074835544;15284.465043723416;14858.777118343018;14903.105813651217;14971.475998340005;15659.765103523685;16047.919760401122;11992.64022079339;13024.934875325564;14750.55748327552;14856.182909939625;14915.105093694414;11466.598669046543;11467.885321147016;11654.242474239147;11750.529978800752;11935.641930742091;11617.5352985883;11741.941290293495;12506.562270320495;12624.179428337497;12687.365631718561 01:29:50 INFO - PROCESS | 4015 | __end_tp_report 01:29:50 INFO - PROCESS | 4015 | __start_cc_report 01:29:50 INFO - PROCESS | 4015 | _x_x_mozilla_cycle_collect,345 01:29:50 INFO - PROCESS | 4015 | __end_cc_report 01:29:50 INFO - PROCESS | 4015 | __startTimestamp1464942590743__endTimestamp 01:29:50 INFO - PROCESS | 4015 | 01:29:50 INFO - PROCESS | 4015 | ------- Summary: start ------- 01:29:50 INFO - PROCESS | 4015 | Number of tests: 6 01:29:50 INFO - PROCESS | 4015 | 01:29:50 INFO - PROCESS | 4015 | [#0] dojo.html Cycles:165 Average:5461.03 Median:5707.06 stddev:727.19 (12.7%) stddev-sans-first:705.93 01:29:50 INFO - PROCESS | 4015 | Values: 3123.5 3127.9 3153.8 3166.1 3183.2 5484.2 5516.2 5571.8 5622.3 5630.5 5443.1 5488.1 5525.6 5540.8 5545.1 4959.0 4992.8 5098.7 5137.1 5189.4 716.5 5047.2 5082.2 5090.5 5094.7 5021.7 5030.2 5034.0 5037.8 5109.7 4969.8 5057.8 5080.4 5083.9 5086.8 4970.2 4979.3 5029.1 5030.4 5040.3 5455.9 5482.2 5496.9 5508.8 5560.3 5712.5 5759.1 5870.3 5892.2 5901.4 5831.3 5841.9 5900.3 5916.8 5920.7 5460.5 5497.1 5502.9 5507.8 5508.9 5961.1 5971.7 6073.1 6076.8 6079.0 5686.7 5724.7 5735.6 5745.9 5789.6 5824.7 5831.8 5833.6 5838.1 5838.7 5763.1 5768.7 5791.3 5825.3 5907.8 5913.9 5918.7 5956.9 5970.0 5980.9 4476.8 4485.5 4502.8 4509.2 4544.9 3964.0 3971.4 4015.4 4035.9 4052.5 5630.6 5651.6 5695.3 5709.9 5720.3 5956.9 5977.3 5980.1 5981.7 5992.6 5587.1 5587.7 5680.9 5683.7 5684.2 5055.9 5056.9 5076.0 5117.5 5150.6 6116.1 6118.6 6163.0 6166.2 6168.6 5892.3 5902.3 5924.0 5937.9 5994.8 6106.8 6138.7 6178.3 6188.6 6194.6 5811.5 5816.2 5820.9 5848.1 5872.5 5783.0 5821.1 5936.4 5965.5 5983.5 5711.6 5752.3 5755.1 5774.1 5798.7 5772.6 5781.4 5784.1 5785.5 5793.2 5501.6 5572.6 5637.4 5655.8 5706.1 5760.2 5825.9 5836.6 5841.9 5843.2 5633.0 5654.4 5678.6 5694.5 5707.1 01:29:50 INFO - PROCESS | 4015 | 01:29:50 INFO - PROCESS | 4015 | [#1] ext.html Cycles:180 Average:58206.59 Median:41470.98 stddev:119249.22 (287.5%) stddev-sans-first:119505.25 01:29:50 INFO - PROCESS | 4015 | Values: 577.7 625.5 636.9 653.9 661.0 33050.3 35888.3 42777.6 43588.6 43751.8 43682.3 44627.6 44833.0 44851.1 45108.0 8533.1 8652.6 8683.9 8721.2 8721.2 8581.6 8712.9 8715.0 8721.1 8740.5 8709.5 8767.7 8825.0 8829.5 8838.1 8693.8 8730.4 8732.4 8779.4 8786.4 8634.4 8675.5 8710.8 8715.9 8728.8 41460.2 41943.6 41943.8 41971.6 42079.4 3559.6 3656.1 3681.9 3687.7 3716.0 30976.8 31221.5 31310.0 31725.8 32447.8 4331.6 4390.7 4402.4 4418.4 4437.7 279452.0 280848.8 281148.0 282588.0 283982.0 35304.6 36527.3 36576.6 58475.4 59665.0 37957.0 38429.8 38585.8 38638.4 38685.4 14966.5 15062.0 15079.1 15211.4 15231.8 12415.7 12428.6 12495.3 12556.1 12610.4 8565.6 8575.6 8622.9 8633.5 8648.1 3298.1 3324.4 3352.5 3380.9 3397.3 1097.4 1115.2 1116.2 1150.5 1226.9 32862.0 32933.2 33218.2 33290.5 33296.2 1157.7 1174.2 1184.7 1224.1 1247.7 16634.8 17122.2 17354.4 17457.1 17537.2 564559.0 565549.0 571186.0 576907.0 578415.0 59442.7 59854.0 59959.7 60009.4 60264.1 1369.1 1379.5 1399.8 1421.6 1424.9 31159.7 31627.4 31876.4 32002.4 32885.2 52261.7 52457.2 52461.0 52555.0 52583.2 432446.0 442156.0 443414.0 444261.0 445370.0 28512.4 28662.6 29137.6 29191.7 29207.9 48828.5 49542.8 49721.8 50340.2 50472.0 41301.6 41599.2 41705.4 42029.0 42794.8 40632.6 40717.0 40744.4 41481.8 42164.0 37596.6 41672.0 41824.0 42038.8 42950.6 36204.8 36679.0 37767.2 38188.1 38721.4 27484.0 28425.3 28746.7 28750.7 29955.3 01:29:50 INFO - PROCESS | 4015 | 01:29:50 INFO - PROCESS | 4015 | [#2] jquery.html Cycles:180 Average:29088.80 Median:12891.66 stddev:80163.77 (621.8%) stddev-sans-first:80359.69 01:29:50 INFO - PROCESS | 4015 | Values: 388.5 389.3 398.7 401.7 424.6 18281.6 19520.8 19797.3 19863.9 20647.4 18946.9 19368.5 19451.8 19482.6 19594.2 5687.1 5732.3 5872.5 5887.5 5897.2 5809.7 5863.4 5869.3 5890.1 5893.3 5575.9 5888.4 5897.0 5897.6 5901.6 5401.3 5803.9 5835.6 5846.5 5867.5 5537.8 5586.5 5617.5 5619.5 5633.2 16663.6 22551.9 23273.3 23374.3 23397.3 2028.0 2124.2 2217.8 2229.7 2386.0 10180.3 10226.3 10348.1 12022.5 14372.3 1854.7 1925.6 1940.6 2013.4 2056.6 79637.6 83100.6 85391.0 85718.0 86757.6 10969.2 11273.0 11290.5 11316.2 11435.4 15577.8 15603.1 15650.6 15732.4 15763.4 7430.1 7703.6 7708.1 7744.2 7798.2 7044.5 7134.0 7219.8 7223.0 7228.6 4759.3 4851.9 4863.0 4894.7 4904.1 2036.6 2042.4 2045.0 2066.0 2069.1 968.5 996.1 1010.6 1038.1 1075.2 19352.2 19461.7 19598.8 19673.0 19717.2 973.1 994.6 999.3 1017.3 1067.9 10591.2 11170.8 11208.4 11252.9 11289.8 478844.0 479022.0 485604.0 489244.0 495100.0 77926.2 88829.6 90228.5 97264.5 99732.5 987.1 1014.0 1020.8 1026.6 1026.8 17944.4 18018.5 18130.5 18182.6 18227.5 41872.6 42018.6 42742.1 43063.8 45102.5 60002.0 60549.7 60880.4 61294.7 61537.0 7234.4 7875.6 8505.9 8782.8 9000.3 13075.1 13459.4 13520.5 13688.5 13780.4 11860.6 11874.9 11946.6 11971.3 12029.9 5491.5 10716.6 11552.8 11992.9 12087.4 12344.8 12575.0 12603.7 12711.0 12884.8 7668.0 7985.7 8140.5 8752.5 9105.9 9235.8 12210.9 12280.3 12317.1 12387.6 01:29:50 INFO - PROCESS | 4015 | 01:29:50 INFO - PROCESS | 4015 | [#3] mootools.html Cycles:180 Average:5853.96 Median:4509.66 stddev:3236.54 (71.8%) stddev-sans-first:3229.02 01:29:50 INFO - PROCESS | 4015 | Values: 1492.6 1526.1 1679.2 1781.9 1809.9 7831.8 8300.4 8406.8 8873.9 8897.8 8491.6 8726.7 8743.1 8744.4 8812.8 2351.0 2369.9 2388.8 2390.4 2396.1 2369.3 2385.2 2393.0 2393.8 2396.5 2353.2 2361.5 2375.9 2413.6 2413.7 2240.8 2254.0 2258.9 2264.5 2319.6 2298.3 2301.6 2303.7 2333.3 2334.3 8688.2 8763.6 8787.8 8817.2 8857.9 5247.7 5455.4 5457.9 5467.4 5470.8 3323.3 3411.2 3453.3 3459.6 3668.2 1170.7 1182.4 1212.1 1215.7 1217.6 12015.5 12068.2 12094.1 12113.9 12114.9 4634.0 4754.6 4768.3 4785.6 4919.3 10331.9 10337.5 10353.6 10361.7 10364.6 5325.6 5386.9 5396.6 5407.1 5430.1 4385.1 4822.1 4937.7 4988.5 5013.8 3968.2 4018.9 4065.4 4086.6 4134.6 1322.5 1341.4 1344.9 1349.1 1358.4 992.9 1008.1 1022.4 1025.4 1031.8 6085.8 6222.1 6242.4 6276.5 6590.9 984.9 999.5 1018.3 1029.6 1041.4 4284.1 4447.4 4479.9 4499.0 4520.3 10059.0 10634.4 10950.5 10951.2 10977.2 10598.4 10695.6 10706.8 10722.9 10747.7 7883.4 8046.1 8062.5 8112.2 8125.4 5980.2 6109.0 6201.2 6244.3 6288.5 10135.5 10146.4 10153.8 10162.2 10294.2 9739.3 10120.5 10168.8 10343.9 10384.8 7277.5 7653.7 7877.5 7910.2 8042.5 8690.6 8730.1 8741.8 8769.8 8825.0 7531.4 7640.5 7662.8 7721.2 7994.0 7593.8 7690.7 7712.3 7727.5 7836.7 7067.8 7097.7 7148.4 7172.8 7195.8 5059.2 5210.5 5265.2 5383.3 5395.2 5418.5 5422.6 5437.0 5449.6 5601.7 01:29:50 INFO - PROCESS | 4015 | 01:29:50 INFO - PROCESS | 4015 | [#4] prototype.html Cycles:180 Average:4748.77 Median:5365.30 stddev:1374.62 (25.6%) stddev-sans-first:1337.91 01:29:50 INFO - PROCESS | 4015 | Values: 332.2 332.4 341.9 346.3 349.4 5451.7 5516.4 5674.0 5688.3 5711.5 5577.9 5588.7 5589.6 5606.4 5616.5 4360.4 4360.9 4372.6 4377.7 4395.3 4045.8 4303.0 4318.1 4381.0 4409.7 4235.1 4254.6 4259.3 4287.4 4304.8 4266.0 4266.7 4284.8 4318.4 4337.5 3576.0 3770.0 3801.8 3803.8 3804.3 5372.2 5384.6 5390.9 5394.6 5415.7 4910.6 4931.9 4933.9 4936.3 4941.9 5505.3 5793.3 5793.6 5796.3 5808.8 4124.2 4131.8 4134.3 4144.9 4148.4 6080.9 6100.1 6176.8 6191.9 6204.3 4193.3 4266.6 4266.8 4275.0 4309.2 4321.5 4322.1 4345.7 4353.8 4362.5 4913.4 4919.5 4939.0 4956.5 4967.5 5649.2 5772.3 5793.6 5874.8 5889.3 1450.8 1473.4 1480.0 1492.9 1494.3 926.8 947.8 951.6 964.8 966.0 5010.3 5068.5 5102.8 5118.4 5120.3 5317.8 5375.7 5405.9 5424.4 5516.7 4919.3 5099.7 5132.7 5177.0 5197.7 2862.2 2877.6 2882.9 2892.1 2922.8 5484.6 5493.8 5508.2 5525.9 5555.4 5116.4 5415.3 5438.2 5455.0 5495.7 5503.4 5517.2 5522.7 5570.1 5584.4 5078.6 5245.9 5343.8 5358.4 5400.4 5289.6 5310.8 5311.7 5316.6 5341.8 5542.7 5572.4 5587.7 5596.0 6028.7 4084.8 4248.2 4258.2 4264.4 4269.8 5985.2 6023.9 6026.9 6053.8 6055.5 5686.5 5825.5 5832.6 5878.4 5902.1 5748.3 5775.7 5778.0 5802.0 5820.2 5697.7 5742.5 5754.5 5772.2 5797.7 5572.8 5798.7 5805.6 5819.3 5894.8 5640.2 5733.8 5743.1 5766.7 5776.7 01:29:50 INFO - PROCESS | 4015 | 01:29:50 INFO - PROCESS | 4015 | [#5] yui.html Cycles:180 Average:21129.00 Median:4636.30 stddev:30276.53 (653.0%) stddev-sans-first:30322.85 01:29:50 INFO - PROCESS | 4015 | Values: 765.9 772.0 828.8 866.3 879.1 15696.2 15763.0 17163.0 17206.6 17237.7 15648.7 15664.8 15680.8 15723.2 15814.8 665.4 788.1 840.5 843.3 843.5 820.8 821.2 821.5 825.7 827.7 863.4 865.6 869.5 870.8 872.9 859.4 861.4 862.9 864.5 866.4 627.8 628.4 629.5 630.7 633.1 15739.1 15740.6 15744.9 15748.7 15809.4 15596.1 15634.5 15651.2 15676.8 15924.6 11666.7 11686.1 11699.8 11830.0 11957.5 3842.7 3959.8 3982.7 3984.8 4103.7 77559.6 77871.6 78585.0 79142.0 79404.0 11488.1 11507.7 11667.9 11672.4 11932.0 20541.6 20593.0 20596.3 20616.9 20656.8 8614.0 8652.3 8783.7 8807.8 8853.2 4602.7 4670.0 4813.9 4897.2 4952.4 3496.6 3575.5 3584.0 3599.9 3609.5 650.3 655.6 659.1 669.3 677.3 655.9 703.6 716.9 729.7 749.7 9244.7 9716.7 9726.5 9758.4 9851.0 660.7 694.6 695.7 711.2 715.4 4596.5 4808.5 4831.3 4841.3 4869.1 112203.4 114129.0 116744.0 120772.4 122706.4 98966.0 102260.0 103048.0 103274.0 103498.0 58255.0 62108.7 88578.0 89656.0 89907.1 8963.9 8966.3 9014.2 9095.6 9105.1 52214.7 52996.5 53833.8 54201.5 56544.0 74350.6 77014.6 77209.0 77293.6 81180.0 10588.9 10802.0 10836.2 11006.1 11031.4 14225.8 14801.6 15244.2 15585.3 16742.9 14774.5 14890.7 15121.0 15232.1 15284.5 14858.8 14903.1 14971.5 15659.8 16047.9 11992.6 13024.9 14750.6 14856.2 14915.1 11466.6 11467.9 11654.2 11750.5 11935.6 11617.5 11741.9 12506.6 12624.2 12687.4 01:29:50 INFO - PROCESS | 4015 | -------- Summary: end -------- 01:29:50 INFO - PROCESS | 4015 | 01:29:51 INFO - TEST-INFO | 4015: exit 0 01:29:51 INFO - TEST-OK | dromaeo_css | took 1109763ms 01:29:51 INFO - TEST-START | kraken 01:29:51 INFO - operating with platform_type : linux_ 01:29:51 INFO - Initialising browser for kraken test... 01:29:51 INFO - TEST-INFO | started process 4248 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_RSu13/profile http://localhost:59077/getInfo.html) 01:29:55 INFO - PROCESS | 4248 | __metrics Screen width/height:1600/1200 01:29:55 INFO - PROCESS | 4248 | colorDepth:24 01:29:55 INFO - PROCESS | 4248 | Browser inner width/height: 1024/697 01:29:55 INFO - PROCESS | 4248 | __metrics 01:29:56 ERROR - PROCESS | 4248 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 01:29:57 INFO - TEST-INFO | 4248: exit 0 01:29:57 INFO - Browser initialized. 01:29:57 INFO - Running cycle 1/1 for kraken test... 01:29:57 INFO - TEST-INFO | started process 4368 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_RSu13/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:30:09 INFO - PROCESS | 4368 | RSS: Main: 167174144 01:30:09 INFO - PROCESS | 4368 | 01:30:11 INFO - PROCESS | 4368 | Cycle 1(1): loaded http://localhost:59077/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59077/tests/kraken/driver.html?testName=audio-beat-detection) 01:30:12 INFO - PROCESS | 4368 | RSS: Main: 172548096 01:30:12 INFO - PROCESS | 4368 | 01:30:15 INFO - PROCESS | 4368 | Cycle 1(1): loaded http://localhost:59077/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59077/tests/kraken/driver.html?testName=audio-dft) 01:30:15 INFO - PROCESS | 4368 | RSS: Main: 171929600 01:30:15 INFO - PROCESS | 4368 | 01:30:18 INFO - PROCESS | 4368 | Cycle 1(1): loaded http://localhost:59077/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59077/tests/kraken/driver.html?testName=audio-fft) 01:30:19 INFO - PROCESS | 4368 | RSS: Main: 166346752 01:30:19 INFO - PROCESS | 4368 | 01:30:21 INFO - PROCESS | 4368 | Cycle 1(1): loaded http://localhost:59077/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59077/tests/kraken/driver.html?testName=audio-oscillator) 01:30:22 INFO - PROCESS | 4368 | RSS: Main: 167124992 01:30:22 INFO - PROCESS | 4368 | 01:30:24 INFO - PROCESS | 4368 | Cycle 1(1): loaded http://localhost:59077/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59077/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:30:24 INFO - PROCESS | 4368 | RSS: Main: 167587840 01:30:24 INFO - PROCESS | 4368 | 01:30:27 INFO - PROCESS | 4368 | Cycle 1(1): loaded http://localhost:59077/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59077/tests/kraken/driver.html?testName=imaging-darkroom) 01:30:28 INFO - PROCESS | 4368 | RSS: Main: 167682048 01:30:28 INFO - PROCESS | 4368 | 01:30:31 INFO - PROCESS | 4368 | Cycle 1(1): loaded http://localhost:59077/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59077/tests/kraken/driver.html?testName=imaging-desaturate) 01:30:32 INFO - PROCESS | 4368 | RSS: Main: 168386560 01:30:32 INFO - PROCESS | 4368 | 01:30:35 INFO - PROCESS | 4368 | Cycle 1(1): loaded http://localhost:59077/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59077/tests/kraken/driver.html?testName=json-parse-financial) 01:30:35 INFO - PROCESS | 4368 | RSS: Main: 168509440 01:30:35 INFO - PROCESS | 4368 | 01:30:37 INFO - PROCESS | 4368 | Cycle 1(1): loaded http://localhost:59077/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59077/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:30:38 INFO - PROCESS | 4368 | RSS: Main: 168292352 01:30:38 INFO - PROCESS | 4368 | 01:30:39 INFO - PROCESS | 4368 | Cycle 1(1): loaded http://localhost:59077/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59077/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:30:40 INFO - PROCESS | 4368 | RSS: Main: 168407040 01:30:40 INFO - PROCESS | 4368 | 01:30:42 INFO - PROCESS | 4368 | Cycle 1(1): loaded http://localhost:59077/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59077/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:30:43 INFO - PROCESS | 4368 | RSS: Main: 168468480 01:30:43 INFO - PROCESS | 4368 | 01:30:45 INFO - PROCESS | 4368 | Cycle 1(1): loaded http://localhost:59077/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:30:46 INFO - PROCESS | 4368 | RSS: Main: 169086976 01:30:46 INFO - PROCESS | 4368 | 01:30:49 INFO - PROCESS | 4368 | Cycle 1(1): loaded http://localhost:59077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:30:49 INFO - PROCESS | 4368 | RSS: Main: 168902656 01:30:49 INFO - PROCESS | 4368 | 01:30:51 INFO - PROCESS | 4368 | Cycle 1(1): loaded http://localhost:59077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59077/tests/kraken/driver.html?testName=ai-astar) 01:30:51 INFO - PROCESS | 4368 | RSS: Main: 169365504 01:30:51 INFO - PROCESS | 4368 | 01:30:51 INFO - PROCESS | 4368 | __start_tp_report 01:30:51 INFO - PROCESS | 4368 | _x_x_mozilla_page_load 01:30:51 INFO - PROCESS | 4368 | _x_x_mozilla_page_load_details 01:30:51 INFO - PROCESS | 4368 | |i|pagename|runs| 01:30:51 INFO - PROCESS | 4368 | |0;ai-astar;111;104;111;111;112;112;110;113;111;110 01:30:51 INFO - PROCESS | 4368 | |1;audio-beat-detection;153;129;148;179;133;157;162;128;180;125 01:30:51 INFO - PROCESS | 4368 | |2;audio-dft;166;162;161;166;162;164;174;162;162;160 01:30:51 INFO - PROCESS | 4368 | |3;audio-fft;79;74;74;157;76;82;75;74;180;75 01:30:51 INFO - PROCESS | 4368 | |4;audio-oscillator;85;86;144;85;87;85;140;85;84;149 01:30:51 INFO - PROCESS | 4368 | |5;imaging-gaussian-blur;118;118;118;118;117;117;118;117;118;117 01:30:51 INFO - PROCESS | 4368 | |6;imaging-darkroom;146;146;147;147;148;147;148;148;146;147 01:30:51 INFO - PROCESS | 4368 | |7;imaging-desaturate;95;95;95;96;100;95;95;97;96;95 01:30:51 INFO - PROCESS | 4368 | |8;json-parse-financial;54;53;53;55;53;55;58;56;53;53 01:30:51 INFO - PROCESS | 4368 | |9;json-stringify-tinderbox;61;61;60;60;61;60;60;60;61;60 01:30:51 INFO - PROCESS | 4368 | |10;stanford-crypto-aes;79;82;85;86;81;90;81;81;107;82 01:30:51 INFO - PROCESS | 4368 | |11;stanford-crypto-ccm;141;124;123;124;121;121;123;124;131;122 01:30:51 INFO - PROCESS | 4368 | |12;stanford-crypto-pbkdf2;160;171;165;167;157;168;159;166;159;158 01:30:51 INFO - PROCESS | 4368 | |13;stanford-crypto-sha256-iterative;63;64;65;63;62;63;61;62;62;62 01:30:51 INFO - PROCESS | 4368 | __end_tp_report 01:30:51 INFO - PROCESS | 4368 | __start_cc_report 01:30:51 INFO - PROCESS | 4368 | _x_x_mozilla_cycle_collect,871 01:30:51 INFO - PROCESS | 4368 | __end_cc_report 01:30:51 INFO - PROCESS | 4368 | __startTimestamp1464942651762__endTimestamp 01:30:51 INFO - PROCESS | 4368 | 01:30:51 INFO - PROCESS | 4368 | ------- Summary: start ------- 01:30:51 INFO - PROCESS | 4368 | Number of tests: 14 01:30:51 INFO - PROCESS | 4368 | 01:30:51 INFO - PROCESS | 4368 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:2.46 (2.2%) stddev-sans-first:2.60 01:30:51 INFO - PROCESS | 4368 | Values: 111.0 104.0 111.0 111.0 112.0 112.0 110.0 113.0 111.0 110.0 01:30:51 INFO - PROCESS | 4368 | 01:30:51 INFO - PROCESS | 4368 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:155.00 stddev:20.50 (13.2%) stddev-sans-first:21.70 01:30:51 INFO - PROCESS | 4368 | Values: 153.0 129.0 148.0 179.0 133.0 157.0 162.0 128.0 180.0 125.0 01:30:51 INFO - PROCESS | 4368 | 01:30:51 INFO - PROCESS | 4368 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:4.07 (2.5%) stddev-sans-first:4.24 01:30:51 INFO - PROCESS | 4368 | Values: 166.0 162.0 161.0 166.0 162.0 164.0 174.0 162.0 162.0 160.0 01:30:51 INFO - PROCESS | 4368 | 01:30:51 INFO - PROCESS | 4368 | [#3] audio-fft Cycles:10 Average:94.60 Median:75.00 stddev:39.41 (52.5%) stddev-sans-first:41.39 01:30:51 INFO - PROCESS | 4368 | Values: 79.0 74.0 74.0 157.0 76.0 82.0 75.0 74.0 180.0 75.0 01:30:51 INFO - PROCESS | 4368 | 01:30:51 INFO - PROCESS | 4368 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:85.00 stddev:28.61 (33.7%) stddev-sans-first:29.60 01:30:51 INFO - PROCESS | 4368 | Values: 85.0 86.0 144.0 85.0 87.0 85.0 140.0 85.0 84.0 149.0 01:30:51 INFO - PROCESS | 4368 | 01:30:51 INFO - PROCESS | 4368 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 01:30:51 INFO - PROCESS | 4368 | Values: 118.0 118.0 118.0 118.0 117.0 117.0 118.0 117.0 118.0 117.0 01:30:51 INFO - PROCESS | 4368 | 01:30:51 INFO - PROCESS | 4368 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 01:30:51 INFO - PROCESS | 4368 | Values: 146.0 146.0 147.0 147.0 148.0 147.0 148.0 148.0 146.0 147.0 01:30:51 INFO - PROCESS | 4368 | 01:30:51 INFO - PROCESS | 4368 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.00 stddev:1.60 (1.7%) stddev-sans-first:1.66 01:30:51 INFO - PROCESS | 4368 | Values: 95.0 95.0 95.0 96.0 100.0 95.0 95.0 97.0 96.0 95.0 01:30:51 INFO - PROCESS | 4368 | 01:30:51 INFO - PROCESS | 4368 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:1.70 (3.1%) stddev-sans-first:1.80 01:30:51 INFO - PROCESS | 4368 | Values: 54.0 53.0 53.0 55.0 53.0 55.0 58.0 56.0 53.0 53.0 01:30:51 INFO - PROCESS | 4368 | 01:30:51 INFO - PROCESS | 4368 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 01:30:51 INFO - PROCESS | 4368 | Values: 61.0 61.0 60.0 60.0 61.0 60.0 60.0 60.0 61.0 60.0 01:30:51 INFO - PROCESS | 4368 | 01:30:51 INFO - PROCESS | 4368 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:82.00 stddev:8.24 (10.0%) stddev-sans-first:8.40 01:30:51 INFO - PROCESS | 4368 | Values: 79.0 82.0 85.0 86.0 81.0 90.0 81.0 81.0 107.0 82.0 01:30:51 INFO - PROCESS | 4368 | 01:30:51 INFO - PROCESS | 4368 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:124.00 stddev:6.17 (5.0%) stddev-sans-first:3.00 01:30:51 INFO - PROCESS | 4368 | Values: 141.0 124.0 123.0 124.0 121.0 121.0 123.0 124.0 131.0 122.0 01:30:51 INFO - PROCESS | 4368 | 01:30:51 INFO - PROCESS | 4368 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:165.50 stddev:4.94 (3.0%) stddev-sans-first:5.12 01:30:51 INFO - PROCESS | 4368 | Values: 160.0 171.0 165.0 167.0 157.0 168.0 159.0 166.0 159.0 158.0 01:30:51 INFO - PROCESS | 4368 | 01:30:51 INFO - PROCESS | 4368 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.16 (1.8%) stddev-sans-first:1.22 01:30:51 INFO - PROCESS | 4368 | Values: 63.0 64.0 65.0 63.0 62.0 63.0 61.0 62.0 62.0 62.0 01:30:51 INFO - PROCESS | 4368 | -------- Summary: end -------- 01:30:51 INFO - PROCESS | 4368 | 01:30:52 INFO - TEST-INFO | 4368: exit 0 01:30:52 INFO - TEST-OK | kraken | took 61283ms 01:30:52 INFO - SUITE-END | took 1171s 01:30:52 INFO - Completed test suite (00:19:31) 01:30:52 INFO - javascript benchmark 01:30:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7288.71721662373, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3123.531470279458, 3127.906162815116, 3153.795003324782, 3166.097662166283, 3183.172375182452, 5484.177373393993, 5516.227728118067, 5571.832845014651, 5622.269105016342, 5630.465105814951, 5443.074677304858, 5488.121900495921, 5525.557955363572, 5540.778368865251, 5545.112781954888, 4959.0, 4992.750362481879, 5098.719570423626, 5137.101007323722, 5189.3772747270195, 716.5195976853852, 5047.242913562958, 5082.186850103984, 5090.541851233388, 5094.7197904115255, 5021.748912554376, 5030.220315851031, 5033.999999999982, 5037.773300201499, 5109.667871588354, 4969.7515124244, 5057.797688092472, 5080.441151473335, 5083.898322033576, 5086.821961231339, 4970.179920313144, 4979.253112033188, 5029.119904016819, 5030.446650868402, 5040.319556859814, 5455.918161227585, 5482.205080263379, 5496.890062198773, 5508.807191748309, 5560.304961879765, 5712.542996560265, 5759.107338362561, 5870.324912635059, 5892.175095486636, 5901.380355062743, 5831.329397119343, 5841.88316233673, 5900.321463031763, 5916.763329466816, 5920.674362910038, 5460.481254280837, 5497.147942068986, 5502.944970550323, 5507.752151153168, 5508.944910550883, 5961.135635332939, 5971.671558064349, 6073.1497590337385, 6076.787312444043, 6079.0, 5686.715664216773, 5724.685142317213, 5735.598508104476, 5745.913811292834, 5789.594728368974, 5824.708764561755, 5831.79588714393, 5833.620814647034, 5838.095095260242, 5838.67887266196, 5763.106718458645, 5768.653880767168, 5791.305043394819, 5825.33008703996, 5907.763689452459, 5913.9112913306335, 5918.733656985446, 5956.940430595725, 5969.970150149308, 5980.940190598125, 4476.798544065525, 4485.506594274627, 4502.842400515966, 4509.233430316854, 4544.931826022612, 3964.048628329238, 3971.3645816669195, 4015.377616469452, 4035.9192816143513, 4052.513698356216, 5630.577706672016, 5651.632643878217, 5695.288088988877, 5709.914351284734, 5720.342160651495, 5956.940430595725, 5977.312609049928, 5980.102984552352, 5981.730822113015, 5992.640441573432, 5587.1339942309005, 5587.664740115606, 5680.857978550486, 5683.658980461186, 5684.232628595087, 5055.9241611375855, 5056.898862022739, 5076.0, 5117.462666420047, 5150.587952963754, 6116.143739876421, 6118.632882027093, 6162.952298109332, 6166.1983942087245, 6168.629882207082, 5892.263467066617, 5902.2622172228475, 5924.0, 5937.9406205937385, 5994.790182343597, 6106.816795496142, 6138.662373569318, 6178.258608966953, 6188.566800323934, 6194.5973511721595, 5811.506021988009, 5816.185733997159, 5820.912686309624, 5848.122781582627, 5872.500837428695, 5783.045797443543, 5821.09772985188, 5936.37668044849, 5965.4929331005615, 5983.521318294613, 5711.600187986801, 5752.33848107473, 5755.050416681201, 5774.105013722712, 5798.739056742541, 5772.624779389326, 5781.364049954585, 5784.132380143013, 5785.537157027344, 5793.15999180125, 5501.559875210054, 5572.554195664418, 5637.43625637433, 5655.830325090254, 5706.144078388275, 5760.214333556611, 5825.94174058254, 5836.620619659709, 5841.883162336814, 5843.2403787507355, 5633.0, 5654.378018417889, 5678.602497825278, 5694.487496125369, 5707.058335374617], "value": 5413.499313452038, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.6851615869351, 625.4652272307177, 636.9235691716989, 653.865957478717, 661.0183876942739, 33050.338993220124, 35888.28223435533, 42777.572224277785, 43588.564114358844, 43751.78124109383, 43682.34476482847, 44627.55372446275, 44833.0, 44851.08467949581, 45108.0, 8533.104024077476, 8652.61063252152, 8683.869741953844, 8721.215090641841, 8721.215090641841, 8581.570921453902, 8712.912870871274, 8715.0, 8721.084286149959, 8740.4755714657, 8709.52097634633, 8767.693130740425, 8825.02924678285, 8829.470231786081, 8838.072002439747, 8693.826123477527, 8730.432521886058, 8732.432391894537, 8779.385443018991, 8786.428882122642, 8634.352423568194, 8675.479471231683, 8710.825783484359, 8715.869261961076, 8728.781780455476, 41460.1707965842, 41943.58056419427, 41943.79028104871, 41971.58028419707, 42079.36880946788, 3559.626239244894, 3656.067702735812, 3681.889543313705, 3687.6681098701247, 3715.981420092909, 30976.845115774504, 31221.53167702486, 31310.0, 31725.84137079323, 32447.837760811282, 4331.566843315643, 4390.714603550759, 4402.405675233835, 4418.352547507423, 4437.689361744679, 279452.0, 280848.7660493598, 281148.0, 282588.0, 283982.0, 35304.64695353065, 36527.26945461076, 36576.63423365785, 58475.41524584785, 59665.0, 37957.0, 38429.80785096057, 38585.80707096447, 38638.420423693104, 38685.419718704245, 14966.476173333882, 15062.0, 15079.095254284777, 15211.391544338103, 15231.847681523264, 12415.689607759878, 12428.56500022495, 12495.25028498293, 12556.121071525089, 12610.432530536147, 8565.571721413904, 8575.614097365633, 8622.913770862337, 8633.525156116348, 8648.091950345122, 3298.142482954401, 3324.384988777084, 3352.4803655433448, 3380.8985730428126, 3397.3205358928312, 1097.4074000040048, 1115.1524841120806, 1116.1963386361806, 1150.539784086372, 1226.9141160118884, 32862.0, 32933.17667058343, 33218.16954576155, 33290.500642490384, 33296.1675958103, 1157.65270418874, 1174.2250114924109, 1184.6979020349756, 1224.12475080318, 1247.7379750252549, 16634.83365166357, 17122.229499672296, 17354.39259625907, 17457.127143642767, 17537.17917965943, 564559.0, 565549.0, 571186.0, 576907.0, 578415.0, 59442.70278648579, 59854.0, 59959.700201498716, 60009.399906000384, 60264.09603855946, 1369.103237379518, 1379.475799196299, 1399.8040274361597, 1421.587739555538, 1424.9287535623384, 31159.688403115677, 31627.367452650356, 31876.362472749952, 32002.359952800347, 32885.17787055343, 52261.7386913063, 52457.21314180214, 52461.0, 52555.0, 52583.211251830486, 432446.0, 442156.0, 443414.0, 444261.0, 445370.0, 28512.42975140527, 28662.570061448678, 29137.562936555543, 29191.7080829189, 29207.85396073006, 48828.5117148824, 49542.75228623834, 49721.75139124281, 50340.24489632732, 50472.0, 41301.586984129775, 41599.168016640106, 41705.37441938434, 42029.0, 42794.78602606967, 40632.59367406288, 40717.0, 40744.3888341681, 41481.79259103685, 42164.0, 37596.62403375931, 41672.0, 41824.0, 42038.78980605077, 42950.570494295906, 36204.81897590495, 36679.0, 37767.24465510729, 38188.07682713894, 38721.4191787129, 27484.0, 28425.28936776597, 28746.712532874404, 28750.712492875642, 29955.251118722208], "value": 18945.736854122177, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.5046565628825, 389.2662331505113, 398.7308566717465, 401.6746435387336, 424.6008751773333, 18281.63436731266, 19520.804791952076, 19797.307094251722, 19863.900680496612, 20647.38057858263, 18946.905265473688, 19368.51578710533, 19451.805481945175, 19482.610347793037, 19594.21623135073, 5687.090065589507, 5732.2548068751, 5872.530197584183, 5887.528997680175, 5897.233359663238, 5809.651420914737, 5863.355030946593, 5869.325027621814, 5890.087036509348, 5893.292804863422, 5575.944240557604, 5888.440598143191, 5896.97051514744, 5897.616654917438, 5901.645901245917, 5401.27082843815, 5803.883922321551, 5835.5915085944, 5846.473817356458, 5867.4719275265215, 5537.750801213955, 5586.497215250647, 5617.494425501724, 5619.4942455178825, 5633.211350410946, 16663.583410414714, 22551.887240563858, 23273.301800946, 23374.298771036894, 23397.298081057597, 2027.9898600507051, 2124.171573086482, 2217.756046834847, 2229.665550167472, 2386.021731090262, 10180.287379883412, 10226.284160108795, 10348.120409765179, 12022.51909923602, 14372.281385930663, 1854.6568884756364, 1925.5859990102056, 1940.602176553803, 2013.4362378534033, 2056.629806634805, 79637.60181199115, 83100.58449707713, 85391.0, 85718.0, 86757.56621216853, 10969.177311701655, 11273.0, 11290.548378064785, 11316.20786544934, 11435.428228588537, 15577.766333505006, 15603.063816171067, 15650.608734781494, 15732.370705171665, 15763.448279310398, 7430.145533263744, 7703.614819259014, 7708.113566939874, 7744.225577442211, 7798.1811909749795, 7044.542104763174, 7133.964330178316, 7219.783406497813, 7222.963885180646, 7228.566286022856, 4759.309900064472, 4851.854444366674, 4862.9756851216225, 4894.706317620883, 4904.141775189328, 2036.6028624418095, 2042.4179108953876, 2044.9897750511152, 2066.0, 2069.0896005757418, 968.4770224078918, 996.14829320931, 1010.6008126789877, 1038.1383451735194, 1075.231209685079, 19352.225910963687, 19461.708074378897, 19598.804011959983, 19673.0, 19717.211311547664, 973.0707174648194, 994.6419289055934, 999.3304485994402, 1017.3387298256192, 1067.9252452328417, 10591.152707783358, 11170.776584468265, 11208.439578021067, 11252.943735281435, 11289.830652540219, 478844.0, 479022.0, 485604.0, 489244.0, 495100.0, 77926.2207377919, 88829.55585222032, 90228.5488572553, 97264.51367743258, 99732.5013374943, 987.116530705015, 1014.0417305646241, 1020.8264595019014, 1026.6201505443034, 1026.8305729554688, 17944.37194698179, 18018.459446216635, 18130.45608631743, 18182.636347273245, 18227.54431139232, 41872.581274186865, 42018.57981420147, 42742.14515709731, 43063.784681076395, 45102.54897451115, 60002.0, 60549.69725151346, 60880.391196089244, 61294.69352653208, 61537.0, 7234.385077268491, 7875.621766191009, 8505.872411913702, 8782.824343513223, 9000.279977601645, 13075.084744068205, 13459.394327255493, 13520.459181632625, 13688.52090176839, 13780.448782048607, 11860.58487952952, 11874.881251187378, 11946.581869634521, 11971.281723096643, 12029.939850300692, 5491.505764481056, 10716.571337146426, 11552.82670759956, 11992.880071199525, 12087.39563021863, 12344.753104937672, 12575.0, 12603.684907877376, 12711.0, 12884.806727898902, 7667.961660191663, 7985.680572777024, 8140.511569305861, 8752.51861147643, 9105.863412048957, 9235.76910577241, 12210.877891220975, 12280.263184208976, 12317.076219283768, 12387.62837114888], "value": 9283.988535233566, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1492.6044598181481, 1526.0767235822325, 1679.202378870037, 1781.9465416037508, 1809.873308868379, 7831.843363132734, 8300.377471689617, 8406.831863362744, 8873.866891996617, 8897.777555561113, 8491.617877195526, 8726.738197854058, 8743.081976392466, 8744.43161194522, 8812.77968050799, 2350.9882450587725, 2369.905203791855, 2388.844725092872, 2390.3665528634924, 2396.0775101585928, 2369.3484291819714, 2385.2486466763003, 2392.95214095718, 2393.7606239376096, 2396.4847557775074, 2353.235198560466, 2361.53949979754, 2375.9406014849596, 2413.5776239158163, 2413.722421921484, 2240.8319376046697, 2254.0, 2258.8757618330983, 2264.490489639826, 2319.6404557293477, 2298.3107416049193, 2301.5972204864247, 2303.7235531736133, 2333.3116730564357, 2334.276374323948, 8688.218060374596, 8763.56182190888, 8787.824243515157, 8817.206451419403, 8857.867131993025, 5247.685138891678, 5455.399906010336, 5457.918131228034, 5467.398586155519, 5470.753816078286, 3323.2854936188837, 3411.232472693649, 3453.3438646657305, 3459.6021457532456, 3668.192997540537, 1170.678063532527, 1182.3851597169423, 1212.1393810394543, 1215.6778453709774, 1217.6103646833017, 12015.459304331414, 12068.215565988183, 12094.092943029307, 12113.878861211364, 12114.939425302817, 4634.0, 4754.619630429557, 4768.3085952536685, 4785.617150627942, 4919.2867034279825, 10331.896681033093, 10337.483125843677, 10353.63762268317, 10361.689149325532, 10364.637237696645, 5325.600579956519, 5386.91919621206, 5396.62223644349, 5407.134858422633, 5430.13117901134, 4385.144896745168, 4822.107910036654, 4937.703737775673, 4988.5260900214425, 5013.799448022111, 3968.2460332537303, 4018.8593399230886, 4065.3901914712437, 4086.5709100544013, 4134.64855487281, 1322.5040609771336, 1341.3695563085334, 1344.932753362328, 1349.0758830201344, 1358.436248956672, 992.8758905136858, 1008.1229330482381, 1022.3508072373947, 1025.3847691385108, 1031.8452232165084, 6085.847853803691, 6222.12890195373, 6242.375762423721, 6276.46650034743, 6590.868182636321, 984.9261305402124, 999.4652860719481, 1018.3279035836313, 1029.6344797596746, 1041.3962497753525, 4284.143171365677, 4447.399601053817, 4479.910401791946, 4499.0, 4520.321951707205, 10059.0, 10634.361938283728, 10950.507227174796, 10951.178661600412, 10977.231593788358, 10598.417087060287, 10695.572177112985, 10706.78586428267, 10722.89277107219, 10747.677569672922, 7883.448158628841, 8046.114927357986, 8062.516249025077, 8112.22933821286, 8125.390595705346, 5980.222571065734, 6108.969455152695, 6201.193844800147, 6244.313125556276, 6288.496920246461, 10135.543900524346, 10146.441945693057, 10153.847692284475, 10162.18702503783, 10294.227932904912, 9739.269554783277, 10120.544575494268, 10168.796624067625, 10343.94828025855, 10384.844227336445, 7277.490575659653, 7653.732119375795, 7877.527348359117, 7910.248526389983, 8042.517448953082, 8690.565471726515, 8730.083341249077, 8741.781455463664, 8769.780755481164, 8824.955875220583, 7531.435142364235, 7640.541567505968, 7662.8084297893, 7721.150673425806, 7994.0407151142235, 7593.810154746176, 7690.730824421118, 7712.344450721752, 7727.49771264866, 7836.686532538863, 7067.787966361017, 7097.7160913562875, 7148.392386647193, 7172.820679483055, 7195.820104497429, 5059.215821547666, 5210.478952104911, 5265.157574788015, 5383.300170977748, 5395.190721391823, 5418.45815418455, 5422.590305911487, 5437.0, 5449.564034877121, 5601.747921343631], "value": 4734.352676189332, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.2010564592157, 332.4332013916273, 341.87008936604093, 346.3436787288089, 349.35892637011085, 5451.672899626025, 5516.420775818541, 5674.0, 5688.29351194641, 5711.457411545907, 5577.9163312550245, 5588.692621905793, 5589.580781441387, 5606.35526914405, 5616.52259557938, 4360.36774667673, 4360.912781744363, 4372.55137123212, 4377.737335759849, 4395.340698895176, 4045.757254564721, 4302.97848510757, 4318.136372725452, 4380.956190438103, 4409.713368631029, 4235.131797981407, 4254.6170844623975, 4259.318509038554, 4287.399764033023, 4304.849330273441, 4265.978670106645, 4266.722663026893, 4284.764337961411, 4318.438602981592, 4337.501187363462, 3575.9987203583037, 3769.981150094259, 3801.7528860624247, 3803.8098095095133, 3804.258169656918, 5372.206452644642, 5384.623076384654, 5390.924494069812, 5394.595405344615, 5415.729213539307, 4910.582600478963, 4931.876703082416, 4933.851984440473, 4936.259561065869, 4941.925871111936, 5505.3393592768725, 5793.333766616851, 5793.594448388614, 5796.275465566804, 5808.82573522795, 4124.216398884202, 4131.772752498611, 4134.3178375567995, 4144.8756537303625, 4148.377743338493, 6080.939190608082, 6100.145979562821, 6176.764647070604, 6191.938080619181, 6204.286507051702, 4193.30810416284, 4266.573342665771, 4266.765327906933, 4274.978625106854, 4309.202797482476, 4321.546237645002, 4322.092360604308, 4345.695801293879, 4353.782310884507, 4362.541933097043, 4913.434954980152, 4919.508049195123, 4939.036887806915, 4956.504349565014, 4967.478414766398, 5649.152627105967, 5772.278465191851, 5793.580572759616, 5874.765009399576, 5889.263842019747, 1450.8103355248595, 1473.4400927647425, 1479.963000924964, 1492.925353732309, 1494.275276490901, 926.7822061815468, 947.824652439301, 951.5622813505727, 964.8456247000446, 965.9951700241454, 5010.298558201855, 5068.493150684976, 5102.821401250939, 5118.36212412032, 5120.308758317579, 5317.8404647860625, 5375.650582712111, 5405.945840561131, 5424.430434804289, 5516.696581687966, 4919.311296418504, 5099.745012749422, 5132.692038477703, 5177.0, 5197.66215196011, 2862.155664079102, 2877.5827505011657, 2882.8990985315413, 2892.1056707856387, 2922.795404321677, 5484.561235101182, 5493.7802487900835, 5508.228847961289, 5525.861853453695, 5555.416681248492, 5116.386033675983, 5415.268938693226, 5438.238646589481, 5454.972725136349, 5495.670259784426, 5503.394626591072, 5517.227588137664, 5522.723863806794, 5570.108782594765, 5584.413636568183, 5078.577998160521, 5245.868853278698, 5343.839684809462, 5358.383785864676, 5400.405955344988, 5289.629725919149, 5310.787568497217, 5311.681299122065, 5316.601254905975, 5341.813036543857, 5542.72286385671, 5572.442755724395, 5587.74855131512, 5596.048671725898, 6028.6985650716415, 4084.795760212037, 4248.150369925966, 4258.190943720683, 4264.445622069111, 4269.829206831692, 5985.191999080069, 6023.879522409615, 6026.939730602813, 6053.757849685963, 6055.545834062551, 5686.488216060575, 5825.475707186204, 5832.591718579659, 5878.382769809108, 5902.1441890926435, 5748.338941021836, 5775.653460792366, 5778.046622307273, 5802.0, 5820.243368362086, 5697.7151142443545, 5742.483176514133, 5754.482096611325, 5772.220750198838, 5797.6521408713925, 5572.804951826666, 5798.6810725410505, 5805.593608447368, 5819.301683797971, 5894.823155305347, 5640.210370548209, 5733.827985160452, 5743.10981797822, 5766.711664416846, 5776.682282474504], "value": 4310.026268877084, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.9080910290766, 771.9575423351716, 828.8466633672771, 866.3459088388266, 879.0769691823585, 15696.215189240535, 15763.0, 17163.0, 17206.56983575411, 17237.741433878502, 15648.687026259468, 15664.765028524553, 15680.76478852818, 15723.213839308046, 15814.76277855833, 665.3978149774462, 788.0858204482801, 840.474703310431, 843.3211264931728, 843.4686147726924, 820.8153165537766, 821.1542111625006, 821.4988856797349, 825.6697321071589, 827.71443851871, 863.4171933944593, 865.5845194306705, 869.4956924983494, 870.8214815962713, 872.85161522541, 859.3984211052257, 861.4314552395421, 862.9395942284043, 864.5245115186622, 866.4411454611803, 627.8179327994922, 628.3904612525843, 629.5435809038411, 630.6562923206864, 633.1104797759156, 15739.134347610876, 15740.60648483797, 15744.921275393664, 15748.68502629941, 15809.367625294974, 15596.14221217844, 15634.530964070982, 15651.217439127999, 15676.764848527282, 15924.601884952854, 11666.70833229176, 11686.12354073448, 11699.76600467986, 11830.0, 11957.530663198673, 3842.692584593226, 3959.78221197834, 3982.7411218270718, 3984.780837053961, 4103.712740108193, 77559.61220193919, 77871.61064194643, 78585.0, 79142.0, 79404.0, 11488.138389620644, 11507.654770356903, 11667.88332116685, 11672.416379181008, 11932.0, 20541.63771166305, 20593.0, 20596.27913023037, 20616.896915515328, 20656.793432065788, 8613.956930215309, 8652.264557512683, 8783.692570759993, 8807.823843523094, 8853.15894989975, 4602.654800889946, 4669.95330046702, 4813.9037219255415, 4897.1772383033185, 4952.380952380952, 3496.5804103507744, 3575.5173051638217, 3584.0, 3599.856005759793, 3609.512715783336, 650.2749434380631, 655.6197405504796, 659.1069101367674, 669.2872091222832, 677.3497442455298, 655.9341070760015, 703.5708217987126, 716.9068021157216, 729.6680010595167, 749.726349882289, 9244.722658320261, 9716.708498745049, 9726.513674316257, 9758.414495130315, 9851.0, 660.7059858362983, 694.5797792335666, 695.6935380773274, 711.210556282526, 715.3669002932443, 4596.49438561758, 4808.495108013608, 4831.299461578052, 4841.273808928689, 4869.123557759637, 112203.4389828062, 114129.0, 116744.0, 120772.3961380205, 122706.38646806887, 98966.0, 102260.0, 103048.0, 103274.0, 103498.0, 58255.0, 62108.68945655243, 88578.0, 89656.0, 89907.10092898988, 8963.865542016745, 8966.327525435488, 9014.233790127913, 9095.636174552943, 9105.135012173832, 52214.73892630664, 52996.47003529916, 53833.78283887692, 54201.45798541964, 56544.0, 74350.62824685842, 77014.614926925, 77209.0, 77293.61353193199, 81180.0, 10588.894111058791, 10802.0, 10836.241463097824, 11006.119510439306, 11031.448427578749, 14225.786613201017, 14801.555953321418, 15244.237788110771, 15585.29866156003, 16742.916285418494, 14774.48289309869, 14890.702185956437, 15121.0, 15232.086074835544, 15284.465043723416, 14858.777118343018, 14903.105813651217, 14971.475998340005, 15659.765103523685, 16047.919760401122, 11992.64022079339, 13024.934875325564, 14750.55748327552, 14856.182909939625, 14915.105093694414, 11466.598669046543, 11467.885321147016, 11654.242474239147, 11750.529978800752, 11935.641930742091, 11617.5352985883, 11741.941290293495, 12506.562270320495, 12624.179428337497, 12687.365631718561], "value": 7716.150887062363, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 111.0, 111.0, 112.0, 112.0, 110.0, 113.0, 111.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 129.0, 148.0, 179.0, 133.0, 157.0, 162.0, 128.0, 180.0, 125.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 161.0, 166.0, 162.0, 164.0, 174.0, 162.0, 162.0, 160.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 74.0, 157.0, 76.0, 82.0, 75.0, 74.0, 180.0, 75.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 144.0, 85.0, 87.0, 85.0, 140.0, 85.0, 84.0, 149.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 148.0, 147.0, 148.0, 148.0, 146.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 100.0, 95.0, 95.0, 97.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 55.0, 53.0, 55.0, 58.0, 56.0, 53.0, 53.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 61.0, 60.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 85.0, 86.0, 81.0, 90.0, 81.0, 81.0, 107.0, 82.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 124.0, 123.0, 124.0, 121.0, 121.0, 123.0, 124.0, 131.0, 122.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 171.0, 165.0, 167.0, 157.0, 168.0, 159.0, 166.0, 159.0, 158.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 63.0, 62.0, 63.0, 61.0, 62.0, 62.0, 62.0], "value": 62.7, "unit": "score"}]}]} 01:30:53 INFO - Return code: 0 01:30:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:30:53 ERROR - # TBPL SUCCESS # 01:30:53 INFO - Running post-action listener: _resource_record_post_action 01:30:53 INFO - ##### 01:30:53 INFO - ##### Finished run-tests step (success) 01:30:53 INFO - ##### 01:30:53 INFO - Running post-run listener: _resource_record_post_run 01:30:53 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 471040; Write bytes: 292573184; Read time: 264; Write time: 214440 01:30:53 INFO - TinderboxPrint: CPU usage
13.5% 01:30:53 INFO - TinderboxPrint: I/O read bytes / time
471,040 / 264 01:30:53 INFO - TinderboxPrint: I/O write bytes / time
292,573,184 / 214,440 01:30:53 INFO - TinderboxPrint: CPU idle
8,208.1 (86.5%) 01:30:53 INFO - TinderboxPrint: CPU user
1,222.9 (12.9%) 01:30:53 INFO - TinderboxPrint: Swap in / out
0 / 0 01:30:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1314816; Read time: 0; Write time: 80 01:30:53 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 471040; Write bytes: 291258368; Read time: 264; Write time: 214360 01:30:53 INFO - Running post-run listener: _upload_blobber_files 01:30:53 INFO - Blob upload gear active. 01:30:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:30:53 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 01:30:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:30:54 INFO - (blobuploader) - INFO - Open directory for files ... 01:30:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:30:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:30:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:30:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:30:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:30:54 INFO - (blobuploader) - INFO - Done attempting. 01:30:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:30:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:30:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:30:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:30:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:30:59 INFO - (blobuploader) - INFO - Done attempting. 01:30:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:30:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:30:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:31:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:31:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:31:00 INFO - (blobuploader) - INFO - Done attempting. 01:31:00 INFO - (blobuploader) - INFO - Iteration through files over. 01:31:00 INFO - Return code: 0 01:31:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:31:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:31:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e573afe6db15443de720df78562b50b0827879a93049cc0d46be4a0fb5a469caa4ffb0a4af6ef539fd347509bc7168eda6f80f24d9b7099ae89bda7bed204d63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/588d9d72f21d5f9452c9c7039dd13742bb6af741f2afd8f643a1207cecbb1e352c1e6e8de6a5981a4999070cb9138dd49a89ee35a0f23aa53a6f2f3686358f0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/835aeccdb126fbfb1483b70ee585bfe4400917fa6a50c1c243642a9bc02f3ebc5c7a418afb53aed16022f0fd56c1b6adf3d1dbd57d111a9d3599919d01a16c10"} 01:31:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:31:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:31:00 INFO - Contents: 01:31:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e573afe6db15443de720df78562b50b0827879a93049cc0d46be4a0fb5a469caa4ffb0a4af6ef539fd347509bc7168eda6f80f24d9b7099ae89bda7bed204d63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/588d9d72f21d5f9452c9c7039dd13742bb6af741f2afd8f643a1207cecbb1e352c1e6e8de6a5981a4999070cb9138dd49a89ee35a0f23aa53a6f2f3686358f0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/835aeccdb126fbfb1483b70ee585bfe4400917fa6a50c1c243642a9bc02f3ebc5c7a418afb53aed16022f0fd56c1b6adf3d1dbd57d111a9d3599919d01a16c10"} 01:31:00 INFO - Running post-run listener: copy_logs_to_upload_dir 01:31:00 INFO - Copying logs to upload dir... 01:31:00 INFO - mkdir: /builds/slave/test/build/upload/logs 01:31:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.381020 ========= master_lag: 27.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-06-03 01:31:27.487617) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 01:31:27.491094) ========= 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=ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e573afe6db15443de720df78562b50b0827879a93049cc0d46be4a0fb5a469caa4ffb0a4af6ef539fd347509bc7168eda6f80f24d9b7099ae89bda7bed204d63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/588d9d72f21d5f9452c9c7039dd13742bb6af741f2afd8f643a1207cecbb1e352c1e6e8de6a5981a4999070cb9138dd49a89ee35a0f23aa53a6f2f3686358f0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/835aeccdb126fbfb1483b70ee585bfe4400917fa6a50c1c243642a9bc02f3ebc5c7a418afb53aed16022f0fd56c1b6adf3d1dbd57d111a9d3599919d01a16c10"} build_url:https://queue.taskcluster.net/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011417 build_url: 'https://queue.taskcluster.net/v1/task/SaDnACP2R_6FN3gRb-tQUA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e573afe6db15443de720df78562b50b0827879a93049cc0d46be4a0fb5a469caa4ffb0a4af6ef539fd347509bc7168eda6f80f24d9b7099ae89bda7bed204d63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/588d9d72f21d5f9452c9c7039dd13742bb6af741f2afd8f643a1207cecbb1e352c1e6e8de6a5981a4999070cb9138dd49a89ee35a0f23aa53a6f2f3686358f0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/835aeccdb126fbfb1483b70ee585bfe4400917fa6a50c1c243642a9bc02f3ebc5c7a418afb53aed16022f0fd56c1b6adf3d1dbd57d111a9d3599919d01a16c10"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 01:31:27.544479) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:31:27.544851) ========= 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=ed14279e38b05397cf4aa391000001a4-1464941364.920260-632153570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:31:27.596092) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 01:31:27.596622) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 01:31:27.597091) ========= ========= Total master_lag: 27.17 =========