builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1464941957.66 results: success (0) buildid: 20160602223101 builduid: ce63a416ae014a908e50471ec102bb3c revision: 8b89d98ce322f0c68538db7837cd7eb749d1ed1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:17.660198) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:17.660791) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:17.661072) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:17.679976) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:17.680275) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 01:19: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.5M=0s 2016-06-03 01:19:17 (40.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100425 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:17.794697) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:17.795029) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014052 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:17.844148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:17.844525) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 01:19:18,087 truncating revision to first 12 chars 2016-06-03 01:19:18,087 Setting DEBUG logging. 2016-06-03 01:19:18,087 attempt 1/10 2016-06-03 01:19:18,087 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:19:18,538 unpacking tar archive at: mozilla-inbound-8b89d98ce322/testing/mozharness/ program finished with exit code 0 elapsedTime=0.776429 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:18.634079) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:18.634386) ========= script_repo_revision: 8b89d98ce322f0c68538db7837cd7eb749d1ed1c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:18.634809) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:18.635090) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:18.645138) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-06-03 01:19:18.645437) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:19:18 INFO - MultiFileLogger online at 20160603 01:19:18 in /builds/slave/test 01:19:18 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:19:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:19:18 INFO - {'append_to_log': False, 01:19:18 INFO - 'base_work_dir': '/builds/slave/test', 01:19:18 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:19:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:19:18 INFO - 'branch': 'Mozilla-Inbound', 01:19:18 INFO - 'buildbot_json_path': 'buildprops.json', 01:19:18 INFO - 'config_files': ('talos/linux_config.py',), 01:19:18 INFO - 'default_actions': ('clobber', 01:19:18 INFO - 'read-buildbot-config', 01:19:18 INFO - 'download-and-extract', 01:19:18 INFO - 'populate-webroot', 01:19:18 INFO - 'create-virtualenv', 01:19:18 INFO - 'install', 01:19:18 INFO - 'run-tests'), 01:19:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:19:18 INFO - 'download_minidump_stackwalk': True, 01:19:18 INFO - 'download_symbols': 'ondemand', 01:19:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:19:18 INFO - 'tooltool.py': '/tools/tooltool.py', 01:19:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:19:18 INFO - '/tools/misc-python/virtualenv.py')}, 01:19:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:19:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:19:18 INFO - 'installer_path': 'installer.exe', 01:19:18 INFO - 'log_level': 'info', 01:19:18 INFO - 'log_name': 'talos', 01:19:18 INFO - 'log_to_console': True, 01:19:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:19:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:19:18 INFO - 'opt_config_files': (), 01:19:18 INFO - 'pip_index': False, 01:19:18 INFO - 'sps_profile': False, 01:19:18 INFO - 'sps_profile_interval': 0, 01:19:18 INFO - 'suite': 'dromaeojs-e10s', 01:19:18 INFO - 'system_bits': '32', 01:19:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:19:18 INFO - 'title': 'talos-linux64-ix-013', 01:19:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:19:18 INFO - 'use_talos_json': True, 01:19:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:19:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:19:18 INFO - 'work_dir': 'build'} 01:19:18 INFO - ##### 01:19:18 INFO - ##### Running clobber step. 01:19:18 INFO - ##### 01:19:18 INFO - Running pre-action listener: _resource_record_pre_action 01:19:18 INFO - Running main action method: clobber 01:19:18 INFO - rmtree: /builds/slave/test/build 01:19:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:19:19 INFO - Running post-action listener: _resource_record_post_action 01:19:19 INFO - ##### 01:19:19 INFO - ##### Finished clobber step (success) 01:19:19 INFO - ##### 01:19:19 INFO - ##### 01:19:19 INFO - ##### Running read-buildbot-config step. 01:19:19 INFO - ##### 01:19:19 INFO - Running pre-action listener: _resource_record_pre_action 01:19:19 INFO - Running main action method: read_buildbot_config 01:19:19 INFO - Using buildbot properties: 01:19:19 INFO - { 01:19:19 INFO - "project": "", 01:19:19 INFO - "product": "firefox", 01:19:19 INFO - "script_repo_revision": "production", 01:19:19 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 01:19:19 INFO - "repository": "", 01:19:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 01:19:19 INFO - "buildid": "20160602223101", 01:19:19 INFO - "pgo_build": "True", 01:19:19 INFO - "basedir": "/builds/slave/test", 01:19:19 INFO - "buildnumber": 651, 01:19:19 INFO - "slavename": "talos-linux64-ix-013", 01:19:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:19:19 INFO - "platform": "ubuntu64_hw", 01:19:19 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:19:19 INFO - "branch": "mozilla-inbound", 01:19:19 INFO - "repo_path": "integration/mozilla-inbound", 01:19:19 INFO - "revision": "8b89d98ce322f0c68538db7837cd7eb749d1ed1c", 01:19:19 INFO - "stage_platform": "linux64-pgo", 01:19:19 INFO - "builduid": "ce63a416ae014a908e50471ec102bb3c", 01:19:19 INFO - "slavebuilddir": "test" 01:19:19 INFO - } 01:19:19 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:19:19 INFO - Running post-action listener: _resource_record_post_action 01:19:19 INFO - ##### 01:19:19 INFO - ##### Finished read-buildbot-config step (success) 01:19:19 INFO - ##### 01:19:19 INFO - ##### 01:19:19 INFO - ##### Running download-and-extract step. 01:19:19 INFO - ##### 01:19:19 INFO - Running pre-action listener: _resource_record_pre_action 01:19:19 INFO - Running main action method: download_and_extract 01:19:19 INFO - mkdir: /builds/slave/test/build/tests 01:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:19 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:19:19 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:19:19 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:19:19 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:19:19 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:19:21 INFO - Downloaded 1361 bytes. 01:19:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:19:21 INFO - Using the following test package requirements: 01:19:21 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:19:21 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:19:21 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:19:21 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:21 INFO - u'jsshell-linux-x86_64.zip'], 01:19:21 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:19:21 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:19:21 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:19:21 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:19:21 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:19:21 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:19:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:21 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:19:21 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:19:21 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:19:21 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:19:21 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:19:22 INFO - Downloaded 24424699 bytes. 01:19:22 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:19:22 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:19:23 INFO - Return code: 0 01:19:23 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:19: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:19: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:19: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:19: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:19: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:19: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:19:24 INFO - Downloaded 24424699 bytes. 01:19:24 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:19:24 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:19:26 INFO - Return code: 0 01:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:26 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:19:26 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:19:26 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:19:26 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:19:26 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:19:27 INFO - Downloaded 10833369 bytes. 01:19:27 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:19:27 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:19:27 INFO - Return code: 0 01:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:27 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:19:27 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:19:27 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:19:27 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:19:27 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:19:30 INFO - Downloaded 59144183 bytes. 01:19:30 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:19:30 INFO - mkdir: /builds/slave/test/properties 01:19:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:19:30 INFO - Writing to file /builds/slave/test/properties/build_url 01:19:30 INFO - Contents: 01:19:30 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:19:31 INFO - Running post-action listener: _resource_record_post_action 01:19:31 INFO - Running post-action listener: set_extra_try_arguments 01:19:31 INFO - ##### 01:19:31 INFO - ##### Finished download-and-extract step (success) 01:19:31 INFO - ##### 01:19:31 INFO - ##### 01:19:31 INFO - ##### Running populate-webroot step. 01:19:31 INFO - ##### 01:19:31 INFO - Running pre-action listener: _resource_record_pre_action 01:19:31 INFO - Running main action method: populate_webroot 01:19:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:19:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:19:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:19:31 INFO - '--tppagecycles', 01:19:31 INFO - '7'], 01:19:31 INFO - 'tests': ['tsvgm']}}, 01:19:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:19:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:19:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:19:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:19:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:19:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:19:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:31 INFO - 'talos_options': ['--disable-e10s'], 01:19:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:19:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:19:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:31 INFO - 'talos_options': ['--disable-e10s'], 01:19:31 INFO - 'tests': ['damp', 'tps']}, 01:19:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:31 INFO - 'tests': ['damp', 'tps']}, 01:19:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:19:31 INFO - 'tests': ['dromaeo_dom']}, 01:19:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:19:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:19:31 INFO - 'tests': ['a11yr', 01:19:31 INFO - 'ts_paint', 01:19:31 INFO - 'tpaint', 01:19:31 INFO - 'sessionrestore', 01:19:31 INFO - 'sessionrestore_no_auto_restore', 01:19:31 INFO - 'tabpaint']}, 01:19:31 INFO - 'other-e10s': {'tests': ['a11yr', 01:19:31 INFO - 'ts_paint', 01:19:31 INFO - 'tpaint', 01:19:31 INFO - 'sessionrestore', 01:19:31 INFO - 'sessionrestore_no_auto_restore', 01:19:31 INFO - 'tabpaint']}, 01:19:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:19:31 INFO - 'ts_paint', 01:19:31 INFO - 'tpaint', 01:19:31 INFO - 'sessionrestore', 01:19:31 INFO - 'sessionrestore_no_auto_restore', 01:19:31 INFO - 'tabpaint']}, 01:19:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:19:31 INFO - 'ts_paint', 01:19:31 INFO - 'tpaint', 01:19:31 INFO - 'sessionrestore', 01:19:31 INFO - 'sessionrestore_no_auto_restore', 01:19:31 INFO - 'tabpaint']}, 01:19:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:19:31 INFO - 'tests': ['a11yr', 01:19:31 INFO - 'ts_paint', 01:19:31 INFO - 'tpaint', 01:19:31 INFO - 'sessionrestore', 01:19:31 INFO - 'sessionrestore_no_auto_restore', 01:19:31 INFO - 'tabpaint']}, 01:19:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:19:31 INFO - 'tests': ['a11yr', 01:19:31 INFO - 'ts_paint', 01:19:31 INFO - 'tpaint', 01:19:31 INFO - 'sessionrestore', 01:19:31 INFO - 'sessionrestore_no_auto_restore', 01:19:31 INFO - 'tabpaint']}, 01:19:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:19:31 INFO - 'tests': ['tsvgx', 01:19:31 INFO - 'tsvgr_opacity', 01:19:31 INFO - 'tart', 01:19:31 INFO - 'tscrollx', 01:19:31 INFO - 'cart']}, 01:19:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:19:31 INFO - 'tsvgr_opacity', 01:19:31 INFO - 'tart', 01:19:31 INFO - 'tscrollx', 01:19:31 INFO - 'cart']}, 01:19:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:31 INFO - 'talos_options': ['--disable-e10s'], 01:19:31 INFO - 'tests': ['tp5o']}, 01:19:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:31 INFO - 'tests': ['tp5o']}, 01:19:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:31 INFO - 'talos_options': ['--disable-e10s', 01:19:31 INFO - '--xperf_path', 01:19:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:19:31 INFO - 'tests': ['tp5n']}, 01:19:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:31 INFO - 'talos_options': ['--xperf_path', 01:19:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:19:31 INFO - 'tests': ['tp5n']}}, 01:19:31 INFO - 'talos.zip': {'path': '', 01:19:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:19:31 INFO - Running post-action listener: _resource_record_post_action 01:19:31 INFO - ##### 01:19:31 INFO - ##### Finished populate-webroot step (success) 01:19:31 INFO - ##### 01:19:31 INFO - ##### 01:19:31 INFO - ##### Running create-virtualenv step. 01:19:31 INFO - ##### 01:19:31 INFO - Running pre-action listener: _resource_record_pre_action 01:19:31 INFO - Running main action method: create_virtualenv 01:19:31 INFO - Creating virtualenv /builds/slave/test/build/venv 01:19:31 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:19:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:19:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:19:31 INFO - Using real prefix '/usr' 01:19:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:19:32 INFO - Installing distribute.............................................................................................................................................................................................done. 01:19:34 INFO - Installing pip.................done. 01:19:34 INFO - Return code: 0 01:19:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:19: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:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19: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:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:34 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 0x7f11f65bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e47350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed61c0>, '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 0x1ed70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', '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:19:34 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:19:34 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:19:34 INFO - Using env: {'DISPLAY': ':0', 01:19:34 INFO - 'HOME': '/home/cltbld', 01:19:34 INFO - 'LANG': 'en_US.UTF-8', 01:19:34 INFO - 'LANGUAGE': 'en_US:en', 01:19:34 INFO - 'LOGNAME': 'cltbld', 01:19:34 INFO - 'MAIL': '/var/mail/cltbld', 01:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:34 INFO - 'MOZ_NO_REMOTE': '1', 01:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:34 INFO - 'NO_EM_RESTART': '1', 01:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:34 INFO - 'PWD': '/builds/slave/test', 01:19:34 INFO - 'SHELL': '/bin/bash', 01:19:34 INFO - 'SHLVL': '1', 01:19:34 INFO - 'TERM': 'linux', 01:19:34 INFO - 'TMOUT': '86400', 01:19:34 INFO - 'USER': 'cltbld', 01:19:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', 01:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:34 INFO - '_': '/tools/buildbot/bin/python'} 01:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:34 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:19:34 INFO - Cleaning up... 01:19:34 INFO - Return code: 0 01:19:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:19: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:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19: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:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:34 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 0x7f11f65bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e47350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed61c0>, '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 0x1ed70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', '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:19:34 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:19:34 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:19:34 INFO - Using env: {'DISPLAY': ':0', 01:19:34 INFO - 'HOME': '/home/cltbld', 01:19:34 INFO - 'LANG': 'en_US.UTF-8', 01:19:34 INFO - 'LANGUAGE': 'en_US:en', 01:19:34 INFO - 'LOGNAME': 'cltbld', 01:19:34 INFO - 'MAIL': '/var/mail/cltbld', 01:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:34 INFO - 'MOZ_NO_REMOTE': '1', 01:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:34 INFO - 'NO_EM_RESTART': '1', 01:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:34 INFO - 'PWD': '/builds/slave/test', 01:19:34 INFO - 'SHELL': '/bin/bash', 01:19:34 INFO - 'SHLVL': '1', 01:19:34 INFO - 'TERM': 'linux', 01:19:34 INFO - 'TMOUT': '86400', 01:19:34 INFO - 'USER': 'cltbld', 01:19:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', 01:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:34 INFO - '_': '/tools/buildbot/bin/python'} 01:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:34 INFO - Downloading/unpacking psutil>=3.1.1 01:19:34 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:19:34 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:19:34 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:19:34 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:19:34 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:19:34 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:19:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:19:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:19:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:19:36 INFO - Installing collected packages: psutil 01:19:36 INFO - Running setup.py install for psutil 01:19:36 INFO - building 'psutil._psutil_linux' extension 01:19:36 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:19:36 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:19:36 INFO - building 'psutil._psutil_posix' extension 01:19:36 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:19:37 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:19:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:19:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:19:37 INFO - Successfully installed psutil 01:19:37 INFO - Cleaning up... 01:19:37 INFO - Return code: 0 01:19:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:19:37 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:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:37 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:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:37 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 0x7f11f65bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e47350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed61c0>, '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 0x1ed70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', '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:19:37 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:19:37 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:19:37 INFO - Using env: {'DISPLAY': ':0', 01:19:37 INFO - 'HOME': '/home/cltbld', 01:19:37 INFO - 'LANG': 'en_US.UTF-8', 01:19:37 INFO - 'LANGUAGE': 'en_US:en', 01:19:37 INFO - 'LOGNAME': 'cltbld', 01:19:37 INFO - 'MAIL': '/var/mail/cltbld', 01:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:37 INFO - 'MOZ_NO_REMOTE': '1', 01:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:37 INFO - 'NO_EM_RESTART': '1', 01:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:37 INFO - 'PWD': '/builds/slave/test', 01:19:37 INFO - 'SHELL': '/bin/bash', 01:19:37 INFO - 'SHLVL': '1', 01:19:37 INFO - 'TERM': 'linux', 01:19:37 INFO - 'TMOUT': '86400', 01:19:37 INFO - 'USER': 'cltbld', 01:19:37 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', 01:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:37 INFO - '_': '/tools/buildbot/bin/python'} 01:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:19:37 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:19:37 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:19:37 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:19:37 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:19:37 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:19:37 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:19:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:19:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:19:39 INFO - Installing collected packages: mozsystemmonitor 01:19:39 INFO - Running setup.py install for mozsystemmonitor 01:19:39 INFO - Successfully installed mozsystemmonitor 01:19:39 INFO - Cleaning up... 01:19:39 INFO - Return code: 0 01:19:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:39 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 0x7f11f65bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e47350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed61c0>, '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 0x1ed70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', '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:19:39 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:19:39 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:19:39 INFO - Using env: {'DISPLAY': ':0', 01:19:39 INFO - 'HOME': '/home/cltbld', 01:19:39 INFO - 'LANG': 'en_US.UTF-8', 01:19:39 INFO - 'LANGUAGE': 'en_US:en', 01:19:39 INFO - 'LOGNAME': 'cltbld', 01:19:39 INFO - 'MAIL': '/var/mail/cltbld', 01:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:39 INFO - 'MOZ_NO_REMOTE': '1', 01:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:39 INFO - 'NO_EM_RESTART': '1', 01:19:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:39 INFO - 'PWD': '/builds/slave/test', 01:19:39 INFO - 'SHELL': '/bin/bash', 01:19:39 INFO - 'SHLVL': '1', 01:19:39 INFO - 'TERM': 'linux', 01:19:39 INFO - 'TMOUT': '86400', 01:19:39 INFO - 'USER': 'cltbld', 01:19:39 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', 01:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:39 INFO - '_': '/tools/buildbot/bin/python'} 01:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:39 INFO - Downloading/unpacking jsonschema==2.5.1 01:19:39 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:19:39 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:19:39 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:19:39 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:19:39 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:19:39 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:19:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:19:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:19:41 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:19:41 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:19:41 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:19:41 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:19:41 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:19:41 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:19:41 INFO - Downloading functools32-3.2.3-2.tar.gz 01:19:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:19:41 INFO - warning: no files found matching '*.txt' 01:19:41 INFO - no previously-included directories found matching 'build' 01:19:41 INFO - no previously-included directories found matching 'dist' 01:19:41 INFO - no previously-included directories found matching '.git*' 01:19:41 INFO - Installing collected packages: jsonschema, functools32 01:19:41 INFO - Running setup.py install for functools32 01:19:41 INFO - warning: no files found matching '*.txt' 01:19:41 INFO - no previously-included directories found matching 'build' 01:19:41 INFO - no previously-included directories found matching 'dist' 01:19:41 INFO - no previously-included directories found matching '.git*' 01:19:41 INFO - Successfully installed jsonschema functools32 01:19:41 INFO - Cleaning up... 01:19:42 INFO - Return code: 0 01:19:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:19:42 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:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:42 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:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:42 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 0x7f11f65bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e47350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed61c0>, '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 0x1ed70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', '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:19:42 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:19:42 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:19:42 INFO - Using env: {'DISPLAY': ':0', 01:19:42 INFO - 'HOME': '/home/cltbld', 01:19:42 INFO - 'LANG': 'en_US.UTF-8', 01:19:42 INFO - 'LANGUAGE': 'en_US:en', 01:19:42 INFO - 'LOGNAME': 'cltbld', 01:19:42 INFO - 'MAIL': '/var/mail/cltbld', 01:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:42 INFO - 'MOZ_NO_REMOTE': '1', 01:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:42 INFO - 'NO_EM_RESTART': '1', 01:19:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:42 INFO - 'PWD': '/builds/slave/test', 01:19:42 INFO - 'SHELL': '/bin/bash', 01:19:42 INFO - 'SHLVL': '1', 01:19:42 INFO - 'TERM': 'linux', 01:19:42 INFO - 'TMOUT': '86400', 01:19:42 INFO - 'USER': 'cltbld', 01:19:42 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', 01:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:42 INFO - '_': '/tools/buildbot/bin/python'} 01:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:42 INFO - Downloading/unpacking blobuploader==1.2.4 01:19:42 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:19:42 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:19:42 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:19:42 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:19:42 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:19:42 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:19:44 INFO - Downloading blobuploader-1.2.4.tar.gz 01:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:19:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:19:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:44 INFO - Downloading docopt-0.6.1.tar.gz 01:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:19:44 INFO - Installing collected packages: blobuploader, requests, docopt 01:19:44 INFO - Running setup.py install for blobuploader 01:19:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:19:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:19:45 INFO - Running setup.py install for requests 01:19:45 INFO - Running setup.py install for docopt 01:19:45 INFO - Successfully installed blobuploader requests docopt 01:19:45 INFO - Cleaning up... 01:19:45 INFO - Return code: 0 01:19:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:45 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 0x7f11f65bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e47350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed61c0>, '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 0x1ed70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', '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:19:45 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:19:45 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:19:45 INFO - Using env: {'DISPLAY': ':0', 01:19:45 INFO - 'HOME': '/home/cltbld', 01:19:45 INFO - 'LANG': 'en_US.UTF-8', 01:19:45 INFO - 'LANGUAGE': 'en_US:en', 01:19:45 INFO - 'LOGNAME': 'cltbld', 01:19:45 INFO - 'MAIL': '/var/mail/cltbld', 01:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:45 INFO - 'MOZ_NO_REMOTE': '1', 01:19:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:45 INFO - 'NO_EM_RESTART': '1', 01:19:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:45 INFO - 'PWD': '/builds/slave/test', 01:19:45 INFO - 'SHELL': '/bin/bash', 01:19:45 INFO - 'SHLVL': '1', 01:19:45 INFO - 'TERM': 'linux', 01:19:45 INFO - 'TMOUT': '86400', 01:19:45 INFO - 'USER': 'cltbld', 01:19:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', 01:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:45 INFO - '_': '/tools/buildbot/bin/python'} 01:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:19:45 INFO - Running setup.py (path:/tmp/pip-WWkRob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:19:45 INFO - Running setup.py (path:/tmp/pip-tKrdVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:19:45 INFO - Running setup.py (path:/tmp/pip-8lGzie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:19:45 INFO - Running setup.py (path:/tmp/pip-Ntx19L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:19:46 INFO - Running setup.py (path:/tmp/pip-kXt99A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:19:46 INFO - Running setup.py (path:/tmp/pip-uT_iDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:19:46 INFO - Running setup.py (path:/tmp/pip-Sgkq22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:19:46 INFO - Running setup.py (path:/tmp/pip-Eb5V2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:19:46 INFO - Running setup.py (path:/tmp/pip-Hiy0i5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:19:46 INFO - Running setup.py (path:/tmp/pip-Xo0kzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:19:46 INFO - Running setup.py (path:/tmp/pip-XpEpkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:19:46 INFO - Running setup.py (path:/tmp/pip-64jDvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:19:46 INFO - Running setup.py (path:/tmp/pip-d2ftTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:19:46 INFO - Running setup.py (path:/tmp/pip-FSAEzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:46 INFO - Running setup.py (path:/tmp/pip-C2ADsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:19:46 INFO - Running setup.py (path:/tmp/pip-8zHWg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:19:46 INFO - Running setup.py (path:/tmp/pip-8wIpp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:19:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:19:46 INFO - Running setup.py install for manifestparser 01:19:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:19:47 INFO - Running setup.py install for mozcrash 01:19:47 INFO - Running setup.py install for mozdebug 01:19:47 INFO - Running setup.py install for mozdevice 01:19:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:19:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:19:47 INFO - Running setup.py install for mozfile 01:19:47 INFO - Running setup.py install for mozhttpd 01:19:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:19:47 INFO - Running setup.py install for mozinfo 01:19:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:19:47 INFO - Running setup.py install for mozInstall 01:19:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:19:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:19:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:19:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:19:47 INFO - Running setup.py install for mozleak 01:19:47 INFO - Running setup.py install for mozlog 01:19:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:19:48 INFO - Running setup.py install for moznetwork 01:19:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:19:48 INFO - Running setup.py install for mozprocess 01:19:48 INFO - Running setup.py install for mozprofile 01:19:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:19:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:19:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:19:48 INFO - Running setup.py install for mozrunner 01:19:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:19:48 INFO - Running setup.py install for mozscreenshot 01:19:48 INFO - Running setup.py install for moztest 01:19:48 INFO - Running setup.py install for mozversion 01:19:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:19:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:19:48 INFO - Cleaning up... 01:19:48 INFO - Return code: 0 01:19:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:48 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 0x7f11f65bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e47350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed61c0>, '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 0x1ed70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', '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:19:48 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:19:48 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:19:48 INFO - Using env: {'DISPLAY': ':0', 01:19:48 INFO - 'HOME': '/home/cltbld', 01:19:48 INFO - 'LANG': 'en_US.UTF-8', 01:19:48 INFO - 'LANGUAGE': 'en_US:en', 01:19:48 INFO - 'LOGNAME': 'cltbld', 01:19:48 INFO - 'MAIL': '/var/mail/cltbld', 01:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:48 INFO - 'MOZ_NO_REMOTE': '1', 01:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:48 INFO - 'NO_EM_RESTART': '1', 01:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:48 INFO - 'PWD': '/builds/slave/test', 01:19:48 INFO - 'SHELL': '/bin/bash', 01:19:48 INFO - 'SHLVL': '1', 01:19:48 INFO - 'TERM': 'linux', 01:19:48 INFO - 'TMOUT': '86400', 01:19:48 INFO - 'USER': 'cltbld', 01:19:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', 01:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:48 INFO - '_': '/tools/buildbot/bin/python'} 01:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:19:48 INFO - Running setup.py (path:/tmp/pip-DntbJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:19:49 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:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:19:49 INFO - Running setup.py (path:/tmp/pip-Gop9W1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:19:49 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:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:19:49 INFO - Running setup.py (path:/tmp/pip-FIPN0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:19:49 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:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:19:49 INFO - Running setup.py (path:/tmp/pip-sr6rbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:19:49 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:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:19:49 INFO - Running setup.py (path:/tmp/pip-opqaWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:19:49 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:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:19:49 INFO - Running setup.py (path:/tmp/pip-kXL9ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:19:49 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:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:19:49 INFO - Running setup.py (path:/tmp/pip-XBapvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:19:49 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:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:19:49 INFO - Running setup.py (path:/tmp/pip-z6QmRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:19:49 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:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:19:49 INFO - Running setup.py (path:/tmp/pip-a5tXTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:19:49 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:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:19:49 INFO - Running setup.py (path:/tmp/pip-UIXJAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:19:49 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:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:19:49 INFO - Running setup.py (path:/tmp/pip-PaWmwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:19:49 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:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:19:49 INFO - Running setup.py (path:/tmp/pip-n8I752-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:19:49 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:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:19:49 INFO - Running setup.py (path:/tmp/pip-_ZkfTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:19:49 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:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:19:49 INFO - Running setup.py (path:/tmp/pip-MRH5EW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:19:50 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:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:50 INFO - Running setup.py (path:/tmp/pip-FKHUQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:50 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:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:19:50 INFO - Running setup.py (path:/tmp/pip-oi8nyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:19:50 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:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:19:50 INFO - Running setup.py (path:/tmp/pip-YoJKpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:19:50 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:19:50 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:19:50 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:19:50 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:19:50 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:19:50 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:19:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:52 INFO - Downloading blessings-1.6.tar.gz 01:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:19:52 INFO - Installing collected packages: blessings 01:19:52 INFO - Running setup.py install for blessings 01:19:52 INFO - Successfully installed blessings 01:19:52 INFO - Cleaning up... 01:19:52 INFO - Return code: 0 01:19:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:19:52 INFO - Reading from file tmpfile_stdout 01:19:52 INFO - Current package versions: 01:19:52 INFO - argparse == 1.2.1 01:19:52 INFO - blessings == 1.6 01:19:52 INFO - blobuploader == 1.2.4 01:19:52 INFO - docopt == 0.6.1 01:19:52 INFO - functools32 == 3.2.3-2 01:19:52 INFO - jsonschema == 2.5.1 01:19:52 INFO - manifestparser == 1.1 01:19:52 INFO - mozInstall == 1.12 01:19:52 INFO - mozcrash == 0.17 01:19:52 INFO - mozdebug == 0.1 01:19:52 INFO - mozdevice == 0.48 01:19:52 INFO - mozfile == 1.2 01:19:52 INFO - mozhttpd == 0.7 01:19:52 INFO - mozinfo == 0.9 01:19:52 INFO - mozleak == 0.1 01:19:52 INFO - mozlog == 3.2 01:19:52 INFO - moznetwork == 0.27 01:19:52 INFO - mozprocess == 0.22 01:19:52 INFO - mozprofile == 0.28 01:19:52 INFO - mozrunner == 6.11 01:19:52 INFO - mozscreenshot == 0.1 01:19:52 INFO - mozsystemmonitor == 0.3 01:19:52 INFO - moztest == 0.7 01:19:52 INFO - mozversion == 1.4 01:19:52 INFO - psutil == 3.1.1 01:19:52 INFO - requests == 1.2.3 01:19:52 INFO - wsgiref == 0.1.2 01:19:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19: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:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19: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:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:52 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 0x7f11f65bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e47350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed61c0>, '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 0x1ed70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', '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:19:52 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:19:52 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:19:52 INFO - Using env: {'DISPLAY': ':0', 01:19:52 INFO - 'HOME': '/home/cltbld', 01:19:52 INFO - 'LANG': 'en_US.UTF-8', 01:19:52 INFO - 'LANGUAGE': 'en_US:en', 01:19:52 INFO - 'LOGNAME': 'cltbld', 01:19:52 INFO - 'MAIL': '/var/mail/cltbld', 01:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:52 INFO - 'MOZ_NO_REMOTE': '1', 01:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:52 INFO - 'NO_EM_RESTART': '1', 01:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:52 INFO - 'PWD': '/builds/slave/test', 01:19:52 INFO - 'SHELL': '/bin/bash', 01:19:52 INFO - 'SHLVL': '1', 01:19:52 INFO - 'TERM': 'linux', 01:19:52 INFO - 'TMOUT': '86400', 01:19:52 INFO - 'USER': 'cltbld', 01:19:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', 01:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:52 INFO - '_': '/tools/buildbot/bin/python'} 01:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:52 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:19:52 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:19:52 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:19:52 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:19:52 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:19:52 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:19:52 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:19:52 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:19:52 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:19:52 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:19:52 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:19:52 INFO - Cleaning up... 01:19:52 INFO - Return code: 0 01:19:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:19: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:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19: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:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f11f65bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e47350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed61c0>, '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 0x1ed70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', '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:19:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:19:52 INFO - Using env: {'DISPLAY': ':0', 01:19:52 INFO - 'HOME': '/home/cltbld', 01:19:52 INFO - 'LANG': 'en_US.UTF-8', 01:19:52 INFO - 'LANGUAGE': 'en_US:en', 01:19:52 INFO - 'LOGNAME': 'cltbld', 01:19:52 INFO - 'MAIL': '/var/mail/cltbld', 01:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:52 INFO - 'MOZ_NO_REMOTE': '1', 01:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:52 INFO - 'NO_EM_RESTART': '1', 01:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:52 INFO - 'PWD': '/builds/slave/test', 01:19:52 INFO - 'SHELL': '/bin/bash', 01:19:52 INFO - 'SHLVL': '1', 01:19:52 INFO - 'TERM': 'linux', 01:19:52 INFO - 'TMOUT': '86400', 01:19:52 INFO - 'USER': 'cltbld', 01:19:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', 01:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:52 INFO - '_': '/tools/buildbot/bin/python'} 01:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:19:53 INFO - Cleaning up... 01:19:53 INFO - Return code: 0 01:19:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f11f65bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e47350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed61c0>, '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 0x1ed70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', '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:19:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:19:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:19:53 INFO - Using env: {'DISPLAY': ':0', 01:19:53 INFO - 'HOME': '/home/cltbld', 01:19:53 INFO - 'LANG': 'en_US.UTF-8', 01:19:53 INFO - 'LANGUAGE': 'en_US:en', 01:19:53 INFO - 'LOGNAME': 'cltbld', 01:19:53 INFO - 'MAIL': '/var/mail/cltbld', 01:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:53 INFO - 'MOZ_NO_REMOTE': '1', 01:19:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:53 INFO - 'NO_EM_RESTART': '1', 01:19:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:53 INFO - 'PWD': '/builds/slave/test', 01:19:53 INFO - 'SHELL': '/bin/bash', 01:19:53 INFO - 'SHLVL': '1', 01:19:53 INFO - 'TERM': 'linux', 01:19:53 INFO - 'TMOUT': '86400', 01:19:53 INFO - 'USER': 'cltbld', 01:19:53 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', 01:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:53 INFO - '_': '/tools/buildbot/bin/python'} 01:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:53 INFO - Downloading/unpacking flake8 01:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:19:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:19:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:19:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:19:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:19:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:19:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:19:56 INFO - no previously-included directories found matching 'docs/_build' 01:19:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:19:56 INFO - Running setup.py install for pep8 01:19:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:19:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:19:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:19:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:19:56 INFO - no previously-included directories found matching 'docs/_build' 01:19:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:19:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:19:56 INFO - Cleaning up... 01:19:56 INFO - Return code: 0 01:19:56 INFO - Running post-action listener: _resource_record_post_action 01:19:56 INFO - Running post-action listener: _start_resource_monitoring 01:19:56 INFO - Starting resource monitoring. 01:19:56 INFO - ##### 01:19:56 INFO - ##### Finished create-virtualenv step (success) 01:19:56 INFO - ##### 01:19:56 INFO - ##### 01:19:56 INFO - ##### Running install step. 01:19:56 INFO - ##### 01:19:56 INFO - Running pre-action listener: _resource_record_pre_action 01:19:56 INFO - Running main action method: install 01:19:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:19:56 INFO - Reading from file tmpfile_stdout 01:19:56 INFO - Detecting whether we're running mozinstall >=1.0... 01:19:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:19:56 INFO - Reading from file tmpfile_stdout 01:19:56 INFO - Output received: 01:19:56 INFO - Usage: mozinstall [options] installer 01:19:56 INFO - Options: 01:19:56 INFO - -h, --help show this help message and exit 01:19:56 INFO - -d DEST, --destination=DEST 01:19:56 INFO - Directory to install application into. [default: 01:19:56 INFO - "/builds/slave/test"] 01:19:56 INFO - --app=APP Application being installed. [default: firefox] 01:19:56 INFO - mkdir: /builds/slave/test/build/application 01:19:56 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:19:56 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:20:13 INFO - Reading from file tmpfile_stdout 01:20:13 INFO - Output received: 01:20:13 INFO - /builds/slave/test/build/application/firefox/firefox 01:20:13 INFO - Running post-action listener: _resource_record_post_action 01:20:13 INFO - ##### 01:20:13 INFO - ##### Finished install step (success) 01:20:13 INFO - ##### 01:20:13 INFO - ##### 01:20:13 INFO - ##### Running run-tests step. 01:20:13 INFO - ##### 01:20:13 INFO - Running pre-action listener: _resource_record_pre_action 01:20:13 INFO - Running main action method: run_tests 01:20:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:20:13 INFO - Python 2.7.3 01:20:13 INFO - Return code: 0 01:20:13 INFO - grabbing minidump binary from tooltool 01:20:13 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:20:13 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 0x1ed61c0>, '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 0x1ed70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:20:13 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:20:13 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:20:13 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:20:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:20:13 INFO - Return code: 0 01:20:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:20:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:20:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:20:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:20:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:20:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:20:14 INFO - Return code: 0 01:20:14 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-013', '--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:20:14 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-013 --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:20:14 INFO - Using env: {'DISPLAY': ':0', 01:20:14 INFO - 'HOME': '/home/cltbld', 01:20:14 INFO - 'LANG': 'en_US.UTF-8', 01:20:14 INFO - 'LANGUAGE': 'en_US:en', 01:20:14 INFO - 'LOGNAME': 'cltbld', 01:20:14 INFO - 'MAIL': '/var/mail/cltbld', 01:20:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:20:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:14 INFO - 'MOZ_NO_REMOTE': '1', 01:20:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:14 INFO - 'NO_EM_RESTART': '1', 01:20:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:20:14 INFO - 'PWD': '/builds/slave/test', 01:20:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:20:14 INFO - 'SHELL': '/bin/bash', 01:20:14 INFO - 'SHLVL': '1', 01:20:14 INFO - 'TERM': 'linux', 01:20:14 INFO - 'TMOUT': '86400', 01:20:14 INFO - 'USER': 'cltbld', 01:20:14 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370', 01:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:14 INFO - '_': '/tools/buildbot/bin/python'} 01:20:14 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-013', '--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:20:14 INFO - mozversion application_buildid: 20160602223101 01:20:14 INFO - mozversion application_changeset: 8b89d98ce322f0c68538db7837cd7eb749d1ed1c 01:20:14 INFO - mozversion application_display_name: Nightly 01:20:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:20:14 INFO - mozversion application_name: Firefox 01:20:14 INFO - mozversion application_remotingname: firefox 01:20:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:20:14 INFO - mozversion application_vendor: Mozilla 01:20:14 INFO - mozversion application_version: 49.0a1 01:20:14 INFO - mozversion platform_buildid: 20160602223101 01:20:14 INFO - mozversion platform_changeset: 8b89d98ce322f0c68538db7837cd7eb749d1ed1c 01:20:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:20:14 INFO - mozversion platform_version: 49.0a1 01:20:14 INFO - using testdate: 1464942014 01:20:14 INFO - actual date: 1464942014 01:20:14 INFO - starting webserver on 'localhost:45544' 01:20:14 INFO - SUITE-START | Running 2 tests 01:20:14 INFO - TEST-START | dromaeo_css 01:20:14 INFO - operating with platform_type : linux_ 01:20:14 INFO - Initialising browser for dromaeo_css test... 01:20:14 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNdE6Zm/profile http://localhost:45544/getInfo.html) 01:20:19 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 01:20:19 INFO - PROCESS | 1665 | colorDepth:24 01:20:19 INFO - PROCESS | 1665 | Browser inner width/height: 1024/697 01:20:19 INFO - PROCESS | 1665 | __metrics 01:20:20 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 01:20:20 INFO - TEST-INFO | 1665: exit 0 01:20:20 INFO - Browser initialized. 01:20:20 INFO - Running cycle 1/1 for dromaeo_css test... 01:20:20 INFO - TEST-INFO | started process 1785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNdE6Zm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:20:32 INFO - PROCESS | 1785 | RSS: Main: 166830080 01:20:32 INFO - PROCESS | 1785 | 01:21:22 INFO - PROCESS | 1785 | 1464942082147 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:23:30 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:45544/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45544/tests/dromaeo/cssquery-ext.html) 01:23:31 INFO - PROCESS | 1785 | RSS: Main: 170708992 01:23:31 INFO - PROCESS | 1785 | 01:26:33 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:45544/tests/dromaeo/cssquery-ext.html (next: http://localhost:45544/tests/dromaeo/cssquery-jquery.html) 01:26:33 INFO - PROCESS | 1785 | RSS: Main: 170426368 01:26:33 INFO - PROCESS | 1785 | 01:29:35 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:45544/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45544/tests/dromaeo/cssquery-mootools.html) 01:29:36 INFO - PROCESS | 1785 | RSS: Main: 171388928 01:29:36 INFO - PROCESS | 1785 | 01:32:38 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:45544/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45544/tests/dromaeo/cssquery-prototype.html) 01:32:38 INFO - PROCESS | 1785 | RSS: Main: 169209856 01:32:38 INFO - PROCESS | 1785 | 01:35:41 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:45544/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45544/tests/dromaeo/cssquery-yui.html) 01:35:41 INFO - PROCESS | 1785 | RSS: Main: 171003904 01:35:41 INFO - PROCESS | 1785 | 01:38:44 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:45544/tests/dromaeo/cssquery-yui.html (next: http://localhost:45544/tests/dromaeo/cssquery-dojo.html) 01:38:44 INFO - PROCESS | 1785 | RSS: Main: 171966464 01:38:44 INFO - PROCESS | 1785 | 01:38:44 INFO - PROCESS | 1785 | __start_tp_report 01:38:44 INFO - PROCESS | 1785 | _x_x_mozilla_page_load 01:38:44 INFO - PROCESS | 1785 | _x_x_mozilla_page_load_details 01:38:44 INFO - PROCESS | 1785 | |i|pagename|runs| 01:38:44 INFO - PROCESS | 1785 | |0;dojo.html;3118.859651315691;3125.7968232064927;3158.8578513966877;3169.5245713143026;3171.112088615187;5480.479354461329;5487.341519017724;5530.05988981873;5580.079286917664;5594.160875868622;5429.267048948391;5435.891282174354;5487.780488780444;5502.119660854264;5522.337319521653;4972.105021096201;5000.19996800512;5036.496350364971;5127.256547800566;5130.948690513084;5037.370328708911;5167.586593072545;5209.583233341324;5220.451852555484;5221.634485586011;4984.825531106412;4998.175301075318;4999.125153098194;5037.093323201822;5062.569681577071;5046.318746969149;5049.065922804293;5057.797688092472;5059.747012649353;5124.359455068116;4996.550310472075;5001.649884508086;5011.949880501221;5023.899522009576;5043.873903152414;5314.149736042254;5334.306540149794;5345.705986170759;5362.4637536246455;5380.058489764276;5805.129230615399;5821.825345239649;5822.854428639275;5841.123831425278;5859.2382990211;5812.970935145339;5890;5959.880802383928;6006.699665016732;6007.429294217042;5551.1673249012565;5559.11054231321;5561.58288128392;5565.526930210937;5574.052411090124;5981.910271345933;6071.362506936796;6075.119107729354;6097.024476083805;6108.847278817976;5841.094630332305;5842.474177323977;5865.530757539386;5868.882622347529;5880.353161152269;5838.737256823453;5903.291605007426;5938.732757025944;5954.970225148933;5984.700764961734;5727.627704199213;5785.30576330843;5801.88396232073;5842.357340692521;5852.4147585241135;5824.6796426196115;5850.034744267148;5880.176775251468;5881.3530511643685;5882.117682347596;4407.118576284756;4429.424174857312;4445.5776701213335;4456.844010459618;4467.15124126415;4039.838406463767;4041.636252737209;4045.9190816183514;4049.2104039712563;4070.8371665133654;5549.472800083986;5631.662100273997;5657.9434205658235;5735.8852822944145;5740.598158128974;5998.670073146019;6000.969995149996;6022.427869352405;6024.0662697282;6074.787382441594;5711.8000869969355;5733.827985160452;5735.340435849847;5735.913961290584;5744.224529688522;5035.949640503622;5062.038212739568;5096.286519887219;5115.155999260155;5119.360079990001;6148.784792532329;6156.661383623944;6165.784197553064;6167.198264225622;6187.659678717624;5919.644821310735;5953.166556681981;5967.880642387215;5984.13230081627;6026.096085587197;5899.498542623754;5970.522358211246;6044.818655440344;6054.212952316171;6067.787627433018;5802.970985145047;5803.622764520293;5810.448007439287;5814.156947242542;5814.563907707024;5898.439648233411;5909.025010873158;5912.645241285537;5916.171735957056;5919.082542205965;5765.048766953406;5822.3304320003745;5840.269966254218;5853.443922827325;5873.353931067493;5799.565032622654;5841.474267315962;5852.912206316993;5855.092460668603;5860.824175274749;5623.971880140573;5692.48767610917;5756.884862302647;5766.798162064475;5767.423257674199;5700.25896633435;5856.502197313276;5885.087811389241;5892.1161825726485;5949.464548190511;5744.109663002241;5750;5759.308882934075;5761.107028410603;5761.222234998221 01:38:44 INFO - PROCESS | 1785 | |1;ext.html;587.8500982249526;635.2155088465745;642.1683919324474;656.1994366872416;665.2781731820974;39186.41220381693;43246.35130473038;43343.34984975228;43386.34920476195;43392;44624.107517849625;45480.77259613697;45515.77242113793;45543.544564554344;45651.771741141245;8559.101294364096;8800.647974081061;8808.779780505507;8815.206631403173;8832.955835220848;8690.391672582922;8752.737417877443;8766.254868336198;8771.517566533837;8780.824383512327;8762.912370876305;8790.51652159131;8815.162559556864;8815.955920220389;8825.382223244376;8703.129687031309;8771.342149338794;8785.472871627722;8802.779930501725;8813.250873675745;8579.399442039059;8667.783305417352;8727.258183054448;8738.082501337332;8758.562071896444;41155.794221029006;41551.7922410389;41643;41654.75035748933;41789.37315940263;3351.8324083795715;3528.1708798432346;3571.2857428514403;3633.582138054131;4016.2168377166463;32381.190470238198;33084.17289567756;33176;33498.33003339944;33583.664163358546;4224.155168966188;4227.133437645306;4351.586599273064;4451.577100175478;4482.305242687356;359603;362915;365880;365910;367087.16456417815;34993;61825;62099.37900621026;62135.689321554004;62211.37788622146;35923.4611480828;38032.23935521329;38034.809825950695;38135.80932095377;38168.80915595404;15066.397344106332;15237.695246095238;15247.771283430757;15252.313645885963;15332.463363782213;12138.271703697807;12273.018158547295;12277.570285039981;12286.938565307117;12304.446299916524;8511.65953361871;8518.531480768617;8530.829383412298;8592;8631.180037896389;3243.513472979072;3335.666433356645;3336.1492819330915;3346.0463767826054;3361.781484203519;1042.7288904884633;1071.8820929697727;1094.7974624694457;1139.7720455908852;1142.959996400122;33017.3396532068;33505.497417538754;33698.32603347969;33702.66297337044;34214.0137884484;1099.8735145458215;1199.964001079969;1211.9212251203644;1214.9453274602663;1220.9145359824727;17602.91198543999;17645.470635880945;17662.293508259783;17663.701298054453;17693.292268309124;521979;524474;527565;528469;529028;59688.40311596915;59739.402605974254;60179.699101504215;60263.69868150719;60288;1360.197483484729;1363.795430685405;1375.2367436072875;1386.7711827548544;1404.1855723680242;31060.378792423573;32071.198220044687;32175;32660.51009234816;33085.83457082699;51925.7403712979;52180.47819521756;52349.7382513085;52765.47234527606;52781;419690.9015454903;420054;420252;420848;423041;29001.12996610105;29132;29302.560461592668;29315.508181804784;29492.705072948997;50132;50406.49593504018;50432.49567504278;50474;51342;43040.34157096557;43518.78240608777;43850;44577.331340029275;44650.10699786051;41731;42003.36994945139;42222.366664499445;42593.93515162146;43325;42376.364354535326;42902.78548607237;43002.78498607612;43334.78332608317;45473;36957.26085478329;37845.43231851469;37903.43144852885;39092.21815563616;39264.803675981435;28979.565306520843;29710.257243569085;29916.70083299226;30025.69974300229;30070.69929300679 01:38:44 INFO - PROCESS | 1785 | |2;jquery.html;387.24100762505486;397.16396984347966;397.4793021142302;401.9778912159831;420.35475545038355;14036.719265614707;17836.375726849565;18997.43007709771;19578.70631940522;19613.803861961394;18396.17217225225;18762.530936726555;18983.71524427135;19058.142383592738;19135.42593722187;5494.945050549483;5511.283533140696;5703.74333155009;5763.1355296705415;5765.654060756368;5637.802676906309;5654.575906806986;5678.545716342704;5696.031674615326;5717.256756621633;5414.35027796665;5662.462066103734;5692.6299790513485;5772.797952071678;5780.5664575156825;5732.856678583027;5746.9712651436685;5759.827205183851;5808.883822323551;5822.679752613604;5805;5846.941530584682;5851.941480585182;5855.736491857877;5870.765169393219;12654.430550625244;16550.50348489547;19294.903525482423;22731.659025114637;22805.42986425336;2260.7626199249007;2340.590396680574;2493.0277191895175;2493.4888347888823;2509.899604015837;10310.484475776182;10340.431276279802;10512.1590272778;10587.894121058767;10684;1892.0728842867034;1909.5352703272627;1912.4836294200627;1927.739755133067;1935.341983725526;74972;78691.81962270627;81311;81482;86074.56962715146;10574.89425105739;10728.624498142684;10876.184286178568;11018.338899666045;11086.334819910831;15412;15456.536303910902;15606.765898511532;15611.297491612904;15633.609159771097;7690.500117492345;7818.648160832662;7828.412869034845;7938.24586664266;8113.59432028408;7442.144153422318;7506.737264195727;7553.773386798295;7566.546007239584;7609.6575654095695;4393.780310984438;4547.317902314613;4554.3851580036935;4611.331356953223;4846.660733748674;1862;1922.1638587214607;1924.133041767756;1938.8642795004214;1942.4561122885614;907.5552979040223;1011.7420057885339;1023.6775415744016;1052.310736467615;1076.967690969272;18107.81892181088;18563;18750.249990000248;18948.715769263472;18969.525761855788;999.5202302894506;1003.372891942536;1011.1203253169789;1025.43601019439;1026.7176526455135;10224.897751022394;10318.122959548522;10415;10567.207459440573;10569.471526423647;465698;476548;476684;477770;479598;76082;93339.53330233306;94341.5282923581;96135;98495.50752246194;972.4262685015875;1004.8794144702682;1006.7231511334295;1008.3647302199568;1015.3095894791466;16831.24259408305;17180.140992950553;17208.483745487654;17260.91369543144;17402.47792566225;40239.597604024755;42021.36967945422;42490.57509424866;43308.35037474377;44478.77760611176;61658.075128874;63211;65545;65607.34392656204;65787.34212657812;5630.943690563206;5631.408702086222;8263.504189748634;8376.664933402595;8664.133586641537;9868.654597089067;13229.603111906657;13339.866601333862;13369.933150334575;13527.797083043566;11793.115516336138;11814.232074915102;12095.57665481739;12099.274043557414;12121.636350909486;11414.372209528223;11581.82627260575;11631.709207269885;11672.824907626562;11872.584459543874;12018.819717704067;12033.518659253532;12155.81766273489;12243.142979991315;12281.508739650313;8634;8787.91212087871;8815.338849586178;8864.290856731575;8928.553572321229;11776.646700598996;11869.40652967331;11912.880871191177;12030.218035827644;12180.939095304468 01:38:44 INFO - PROCESS | 1785 | |3;mootools.html;1500.9774853377198;1525.054466230937;1685.8819882608216;1773.8580913526919;1817.9363722269723;7878;8261.958690206555;8410.116937721543;9011.819763604732;9036.864447033291;8361.623726932288;8486;8538.103499132594;8606.440581362223;8630.223279904807;2337.0885354711677;2390.5816482115647;2391.390195500145;2392.820538459614;2397.2688330059327;2356.234223877238;2371.419002344428;2410.276916924924;2421.9515609687796;2423.8850128940708;2327.4763178284834;2362.8818559072065;2371.087131454385;2394.162043284854;2397.0891061396646;2315.629499280124;2330.5105927755194;2340.5903966805827;2342.1334106380577;2361.031976889467;2267.614505534063;2268.7277526696903;2278.612635851909;2284.0863654538152;2303.8963246653775;8614.698485552975;8622.83591715123;8688.695895643685;8698.086700896441;8743.344249181337;5175.430702622746;5257.08001099806;5289.761960711778;5289.788408463657;5321;3398.4052790761766;3403.6936675699308;3450.87921922734;3461.6365281645317;3524.1013541547;1129.5312445335176;1134.3194083549886;1136.2898837249886;1165.6619580321697;1172.9384906659486;11886.762264754656;12088.456019479145;12136.15046946714;12154.33151176685;12182.634520964473;4744.117275123807;4768.737719425396;4782.856514304576;4834.734089625034;4835.637327200474;10239.692809215736;10256.58973641061;10327;10330.793384132276;10395.272330936761;5137.486251374908;5267.209918512177;5277.498637629419;5337.092694241988;5339.172428273546;4425.911481770347;4821.686590371614;4861.586765125004;4976.4525902150735;4981.975090124599;4102.077032667626;4149.522804877417;4156.480439945007;4191.40726523919;4229.302165142779;1313.4483516922915;1352.5604178641981;1353.303048929802;1355.1801160298076;1355.3426588104762;1014.5079636376352;1020.4642562654517;1020.9336393134422;1021.6117875207374;1024.2062401638789;6022.156898034279;6055.788047418319;6063.454289113913;6133.754649814046;6449.451796597342;953.7186529973675;988.7231575158967;1020.9795804083876;1022.223110436074;1030.675581877284;4063.3701776224734;4179.26862799009;4260.510041345223;4311.827526898952;4319.6112349888035;10583.417912014913;10813.080888124598;10905.83641245382;10941.28881622692;10994.560217591366;10658.62694805678;10743.83884241737;10851.837222441669;10896.18278629106;10939.83590246147;7790.649420775965;7811.882821757678;8041.919580804117;8097.149799270992;8323.417360784808;6020.337762846171;6115.318287470981;6185.072239164161;6191.81424557264;6215.689215539295;9742.171915387271;9871.160951319218;9997.450140242065;10012.749681258027;10143;10122.898771012196;10159.390436573829;10187;10205.591776328863;10284.691459256233;6943.375096241362;7446.925530744623;7774.611269436618;7784.143744188248;7808.219178082373;8558.529280889361;8591.097934717014;8598.183172598594;8601.612927418157;8619.439736417113;7533.7363192288;7567.470277080772;7570.470067095471;7578;7815.8436831261915;7468.887966680395;7540.245975402416;7578.166401695698;7604.733834315773;7696.499727517694;6809.761658341934;6847.452203823583;6881.587104773729;6890.931090689029;6921.204061532787;5083.72039537829;5083.92374114396;5096.108181068224;5099.2860999460845;5157.8452646420665;5064.164412871983;5111.05445492585;5112.437631860418;5146.305248791366;5251.081060814418 01:38:44 INFO - PROCESS | 1785 | |4;prototype.html;326.6080177000474;339.3399837316419;342.40934388180386;343.85386210860395;344.72938743086684;5501.724913754317;5540.141278101901;5607.579431542636;5716.485516303532;5750.769969201232;5558.777648894039;5559.58303127265;5605.9538268532;5614.214010038598;5642.520385767204;4306.375575541545;4365.650747940157;4418.270985287424;4419.425474688286;4435.290353543433;4094.61101195386;4333;4341.261985462479;4379.408779814732;4396.164728701552;4300.311950087987;4307.138572285556;4311.331743579734;4337.54455782143;4346.739195648272;4357.193919124956;4362.36745671879;4369.672274579403;4391.01202229499;4404.207242696313;3734.775913445202;3777.8855237704943;3826.655600995896;3843.615638436134;3843.7693738375788;5385.838424847261;5389.9191512127345;5392.91910621341;5424.8607792363655;5459.744258820493;4933.235348520949;4970.428400733889;4988.127077761414;5002.59979201663;5013.849584512471;5680.602357834953;5797.681127537984;5838.9124163137585;5851.122331650244;5939.376365481606;4174.895627609304;4175.770332631704;4183.602557757008;4183.895402614929;4191.455110835572;6085.574009819315;6103.1455596216565;6120.632762034292;6124.540659450559;6127.172831667713;4111.108889910674;4224.394730002579;4272.444582204355;4293.227219100592;4334.566543345703;4297.935530967038;4309.806058727302;4312.719673221231;4324.8375812093955;4331.696781225347;4934.3338649282605;4961.6526843121355;4965.255211718271;4975.129352363322;4975.328330675385;5685.829425117253;5828.446297601721;5857.47282744555;5863.970680146572;5876.913695638073;1456.5994351553195;1472.409797418785;1475.0117421327736;1481.5185064853965;1493.4996776079918;930.5533343994921;936.520859546545;950.7623094226443;961.4135377419768;965.5944503308627;5007.899842003139;5099.5410413063;5111.616628752784;5120.539151476385;5121.820736274287;5407.378151512547;5434.538064264581;5459.344878614592;5485;5523.420040895729;4918.877028074256;5119.718415487184;5132.613334799262;5133.845984620468;5135.383753949475;2893.7250961158657;2932.3695405487924;2966.525355943039;2969.435807196626;2982.6719060903283;5526.668399895939;5598.216249725042;5645;5685.92463750728;5698.093972074189;5091.516305950929;5440.231924624512;5476.945230547723;5479.972600137054;5503.2020357048;5554.028869358428;5603.411641777636;5612.5229355504425;5616.747246373923;5620.775168993277;5211.270422140828;5396;5402.729863506887;5405.297311349499;5406.459354064562;5345.438728933406;5347.839564813062;5374.065336478942;5393.467278932306;5408.7566059526625;5567.415421380697;5576.804811831566;5588.245586845724;5603.439656034364;6001.319630503466;4150.107726838744;4236.957630423656;4265.680073994401;4282.850100246476;4292.163028209469;5979.760809567569;6007.339192688888;6074.848128796815;6078;6080.993272220245;5694.661754487609;5865.589408741518;5867.442592953663;5871.970640146772;5907.91138132937;5739.770409183586;5836.686745482232;5842.620229685057;5878.2064421302575;5945.34601193877;5732.971335143465;5735.483806457439;5772.249607550992;5773.480386765212;5793.217915581343;5688.288963879515;5996.160537524663;6002.8499287516415;6007.549433792396;6017.669028203491;5805.564582656233;5830.591858569859;5837.5329973601165;5897.498712609477;5953.1367951647635 01:38:44 INFO - PROCESS | 1785 | |5;yui.html;639.5746828359139;645.5287640022781;737.5353527277814;760.8668483015473;784.0591290451458;17378;18031;18100.547486312833;19011.144498497568;19045.714314285262;15299.694006119871;15407.3837046518;15698.058116513017;15804;15832.762508562351;679.8402375441767;806.6853926968487;823.074041703084;827.9668813247463;830.3523251863556;818.4475479051646;818.9017317921828;824.0729179672868;825.9628316725732;828.8383765165795;866.3285953386113;868.9261412779921;868.9608967596473;870.5908223135116;873.2271939333704;858.8840506531601;860.414917855861;864.5849992003842;865.0527672198932;867.9479231246114;632.6868200240864;633.0915136778691;633.8415396150963;635.3519410201568;636.6212103798233;16272.43046493367;16324.102174380405;16386.426475073433;16387.59031024222;16415.097169655663;14387.280635968264;14395.568132956028;14928.178950157737;15017.624559385993;15120.54638360851;12596.370181490889;12691;12928.159669621444;13088.803667944989;13092.541761038414;3922.764634121962;3941.763494190329;3966.8214930328204;3976.980115099435;4075.7758323292205;77251;78447.60776196083;80409.59795200986;80522.59738701327;81222.18777812265;11965.341906195243;12037.67585565587;12090.879091209152;12165.817512737316;12209.633710988684;20346.28787992413;21172.894135529223;22134.114635414404;22255.666165007537;22263.666045009337;8552.358573106918;8663.566821659018;8710.651573936972;8810.735677929672;8841.646334146692;4752.7385993769985;4810.975945120322;4821;4858.854234372974;4916.754162291871;3661.0481274868725;3728.9813550932613;3744.5506539214925;3760.1539653578275;3769.1896242308035;658.2298710508717;659.4658326755343;665.9667016649148;673.545356884111;679.8198477403492;670.6244503078292;772.7025095338336;798.7603718884311;804.3324041045918;827.3960009193203;10425.895741042492;10460.73848153787;10668.413237272025;10749.408782517037;10889.83665245022;769.6959700918106;773.97678069658;775.1821827971544;791.1929831571764;810.1695761844157;4953.1332016896895;5057.848264552069;5091.0836049511445;5095.490450954875;5098.439171691111;101950;114287.42856285666;116655;116891.41554292344;117242;64118.6794066036;78656.60671696719;94818.05181948231;96488.51755741176;97123;56526.43473565212;80925.59537202277;81216;81532.59233703793;81668;9389.436633801994;9643.373180743229;9956.601735930482;9979.50102494887;9990.850137247802;50089;50764.23853642272;51239;52268;52335.47664523306;70876.29123708697;74475.255247449;75132.96946921606;75270.6236468836;75353;11972.341521216069;12108.455119519467;12241.816372754594;12246.44890979926;12270.754584908073;12710.300933448749;12776.808347874976;13129.212247265195;13509.392077356346;14053.578392647827;13015.869841301466;13060.281684507443;13207.141535800141;13282.734345312847;13948.442062317394;13523.120997135155;13639.522616708367;13646.659116647856;13654.795178072138;14276.57170284893;12497.12520123619;12978.156419832681;13116.868831311565;13755;13796.379162937892;10646.254762166884;10859.837102443627;11242.550297988317;11662.825057624312;11735.119866009913;10744.731381715206;11078.667639970814;11210.43947802623;11301.208915375844;11363.147763917905 01:38:44 INFO - PROCESS | 1785 | __end_tp_report 01:38:44 INFO - PROCESS | 1785 | __start_cc_report 01:38:44 INFO - PROCESS | 1785 | _x_x_mozilla_cycle_collect,357 01:38:44 INFO - PROCESS | 1785 | __end_cc_report 01:38:44 INFO - PROCESS | 1785 | __startTimestamp1464943124587__endTimestamp 01:38:44 INFO - PROCESS | 1785 | 01:38:44 INFO - PROCESS | 1785 | ------- Summary: start ------- 01:38:44 INFO - PROCESS | 1785 | Number of tests: 6 01:38:44 INFO - PROCESS | 1785 | 01:38:44 INFO - PROCESS | 1785 | [#0] dojo.html Cycles:165 Average:5501.19 Median:5759.31 stddev:632.74 (11.0%) stddev-sans-first:606.45 01:38:44 INFO - PROCESS | 1785 | Values: 3118.9 3125.8 3158.9 3169.5 3171.1 5480.5 5487.3 5530.1 5580.1 5594.2 5429.3 5435.9 5487.8 5502.1 5522.3 4972.1 5000.2 5036.5 5127.3 5130.9 5037.4 5167.6 5209.6 5220.5 5221.6 4984.8 4998.2 4999.1 5037.1 5062.6 5046.3 5049.1 5057.8 5059.7 5124.4 4996.6 5001.6 5011.9 5023.9 5043.9 5314.1 5334.3 5345.7 5362.5 5380.1 5805.1 5821.8 5822.9 5841.1 5859.2 5813.0 5890.0 5959.9 6006.7 6007.4 5551.2 5559.1 5561.6 5565.5 5574.1 5981.9 6071.4 6075.1 6097.0 6108.8 5841.1 5842.5 5865.5 5868.9 5880.4 5838.7 5903.3 5938.7 5955.0 5984.7 5727.6 5785.3 5801.9 5842.4 5852.4 5824.7 5850.0 5880.2 5881.4 5882.1 4407.1 4429.4 4445.6 4456.8 4467.2 4039.8 4041.6 4045.9 4049.2 4070.8 5549.5 5631.7 5657.9 5735.9 5740.6 5998.7 6001.0 6022.4 6024.1 6074.8 5711.8 5733.8 5735.3 5735.9 5744.2 5035.9 5062.0 5096.3 5115.2 5119.4 6148.8 6156.7 6165.8 6167.2 6187.7 5919.6 5953.2 5967.9 5984.1 6026.1 5899.5 5970.5 6044.8 6054.2 6067.8 5803.0 5803.6 5810.4 5814.2 5814.6 5898.4 5909.0 5912.6 5916.2 5919.1 5765.0 5822.3 5840.3 5853.4 5873.4 5799.6 5841.5 5852.9 5855.1 5860.8 5624.0 5692.5 5756.9 5766.8 5767.4 5700.3 5856.5 5885.1 5892.1 5949.5 5744.1 5750.0 5759.3 5761.1 5761.2 01:38:44 INFO - PROCESS | 1785 | 01:38:44 INFO - PROCESS | 1785 | [#1] ext.html Cycles:180 Average:59363.21 Median:420153.00 stddev:117281.39 (27.9%) stddev-sans-first:117527.37 01:38:44 INFO - PROCESS | 1785 | Values: 587.9 635.2 642.2 656.2 665.3 39186.4 43246.4 43343.3 43386.3 43392.0 44624.1 45480.8 45515.8 45543.5 45651.8 8559.1 8800.6 8808.8 8815.2 8833.0 8690.4 8752.7 8766.3 8771.5 8780.8 8762.9 8790.5 8815.2 8816.0 8825.4 8703.1 8771.3 8785.5 8802.8 8813.3 8579.4 8667.8 8727.3 8738.1 8758.6 41155.8 41551.8 41643.0 41654.8 41789.4 3351.8 3528.2 3571.3 3633.6 4016.2 32381.2 33084.2 33176.0 33498.3 33583.7 4224.2 4227.1 4351.6 4451.6 4482.3 359603.0 362915.0 365880.0 365910.0 367087.2 34993.0 61825.0 62099.4 62135.7 62211.4 35923.5 38032.2 38034.8 38135.8 38168.8 15066.4 15237.7 15247.8 15252.3 15332.5 12138.3 12273.0 12277.6 12286.9 12304.4 8511.7 8518.5 8530.8 8592.0 8631.2 3243.5 3335.7 3336.1 3346.0 3361.8 1042.7 1071.9 1094.8 1139.8 1143.0 33017.3 33505.5 33698.3 33702.7 34214.0 1099.9 1200.0 1211.9 1214.9 1220.9 17602.9 17645.5 17662.3 17663.7 17693.3 521979.0 524474.0 527565.0 528469.0 529028.0 59688.4 59739.4 60179.7 60263.7 60288.0 1360.2 1363.8 1375.2 1386.8 1404.2 31060.4 32071.2 32175.0 32660.5 33085.8 51925.7 52180.5 52349.7 52765.5 52781.0 419690.9 420054.0 420252.0 420848.0 423041.0 29001.1 29132.0 29302.6 29315.5 29492.7 50132.0 50406.5 50432.5 50474.0 51342.0 43040.3 43518.8 43850.0 44577.3 44650.1 41731.0 42003.4 42222.4 42593.9 43325.0 42376.4 42902.8 43002.8 43334.8 45473.0 36957.3 37845.4 37903.4 39092.2 39264.8 28979.6 29710.3 29916.7 30025.7 30070.7 01:38:44 INFO - PROCESS | 1785 | 01:38:44 INFO - PROCESS | 1785 | [#2] jquery.html Cycles:180 Average:28554.33 Median:22768.54 stddev:78555.56 (345.0%) stddev-sans-first:78747.46 01:38:44 INFO - PROCESS | 1785 | Values: 387.2 397.2 397.5 402.0 420.4 14036.7 17836.4 18997.4 19578.7 19613.8 18396.2 18762.5 18983.7 19058.1 19135.4 5494.9 5511.3 5703.7 5763.1 5765.7 5637.8 5654.6 5678.5 5696.0 5717.3 5414.4 5662.5 5692.6 5772.8 5780.6 5732.9 5747.0 5759.8 5808.9 5822.7 5805.0 5846.9 5851.9 5855.7 5870.8 12654.4 16550.5 19294.9 22731.7 22805.4 2260.8 2340.6 2493.0 2493.5 2509.9 10310.5 10340.4 10512.2 10587.9 10684.0 1892.1 1909.5 1912.5 1927.7 1935.3 74972.0 78691.8 81311.0 81482.0 86074.6 10574.9 10728.6 10876.2 11018.3 11086.3 15412.0 15456.5 15606.8 15611.3 15633.6 7690.5 7818.6 7828.4 7938.2 8113.6 7442.1 7506.7 7553.8 7566.5 7609.7 4393.8 4547.3 4554.4 4611.3 4846.7 1862.0 1922.2 1924.1 1938.9 1942.5 907.6 1011.7 1023.7 1052.3 1077.0 18107.8 18563.0 18750.2 18948.7 18969.5 999.5 1003.4 1011.1 1025.4 1026.7 10224.9 10318.1 10415.0 10567.2 10569.5 465698.0 476548.0 476684.0 477770.0 479598.0 76082.0 93339.5 94341.5 96135.0 98495.5 972.4 1004.9 1006.7 1008.4 1015.3 16831.2 17180.1 17208.5 17260.9 17402.5 40239.6 42021.4 42490.6 43308.4 44478.8 61658.1 63211.0 65545.0 65607.3 65787.3 5630.9 5631.4 8263.5 8376.7 8664.1 9868.7 13229.6 13339.9 13369.9 13527.8 11793.1 11814.2 12095.6 12099.3 12121.6 11414.4 11581.8 11631.7 11672.8 11872.6 12018.8 12033.5 12155.8 12243.1 12281.5 8634.0 8787.9 8815.3 8864.3 8928.6 11776.6 11869.4 11912.9 12030.2 12180.9 01:38:44 INFO - PROCESS | 1785 | 01:38:44 INFO - PROCESS | 1785 | [#3] mootools.html Cycles:180 Average:5794.73 Median:4585.01 stddev:3225.07 (70.3%) stddev-sans-first:3217.98 01:38:44 INFO - PROCESS | 1785 | Values: 1501.0 1525.1 1685.9 1773.9 1817.9 7878.0 8262.0 8410.1 9011.8 9036.9 8361.6 8486.0 8538.1 8606.4 8630.2 2337.1 2390.6 2391.4 2392.8 2397.3 2356.2 2371.4 2410.3 2422.0 2423.9 2327.5 2362.9 2371.1 2394.2 2397.1 2315.6 2330.5 2340.6 2342.1 2361.0 2267.6 2268.7 2278.6 2284.1 2303.9 8614.7 8622.8 8688.7 8698.1 8743.3 5175.4 5257.1 5289.8 5289.8 5321.0 3398.4 3403.7 3450.9 3461.6 3524.1 1129.5 1134.3 1136.3 1165.7 1172.9 11886.8 12088.5 12136.2 12154.3 12182.6 4744.1 4768.7 4782.9 4834.7 4835.6 10239.7 10256.6 10327.0 10330.8 10395.3 5137.5 5267.2 5277.5 5337.1 5339.2 4425.9 4821.7 4861.6 4976.5 4982.0 4102.1 4149.5 4156.5 4191.4 4229.3 1313.4 1352.6 1353.3 1355.2 1355.3 1014.5 1020.5 1020.9 1021.6 1024.2 6022.2 6055.8 6063.5 6133.8 6449.5 953.7 988.7 1021.0 1022.2 1030.7 4063.4 4179.3 4260.5 4311.8 4319.6 10583.4 10813.1 10905.8 10941.3 10994.6 10658.6 10743.8 10851.8 10896.2 10939.8 7790.6 7811.9 8041.9 8097.1 8323.4 6020.3 6115.3 6185.1 6191.8 6215.7 9742.2 9871.2 9997.5 10012.7 10143.0 10122.9 10159.4 10187.0 10205.6 10284.7 6943.4 7446.9 7774.6 7784.1 7808.2 8558.5 8591.1 8598.2 8601.6 8619.4 7533.7 7567.5 7570.5 7578.0 7815.8 7468.9 7540.2 7578.2 7604.7 7696.5 6809.8 6847.5 6881.6 6890.9 6921.2 5083.7 5083.9 5096.1 5099.3 5157.8 5064.2 5111.1 5112.4 5146.3 5251.1 01:38:44 INFO - PROCESS | 1785 | 01:38:44 INFO - PROCESS | 1785 | [#4] prototype.html Cycles:180 Average:4783.78 Median:5404.01 stddev:1385.66 (25.6%) stddev-sans-first:1348.56 01:38:44 INFO - PROCESS | 1785 | Values: 326.6 339.3 342.4 343.9 344.7 5501.7 5540.1 5607.6 5716.5 5750.8 5558.8 5559.6 5606.0 5614.2 5642.5 4306.4 4365.7 4418.3 4419.4 4435.3 4094.6 4333.0 4341.3 4379.4 4396.2 4300.3 4307.1 4311.3 4337.5 4346.7 4357.2 4362.4 4369.7 4391.0 4404.2 3734.8 3777.9 3826.7 3843.6 3843.8 5385.8 5389.9 5392.9 5424.9 5459.7 4933.2 4970.4 4988.1 5002.6 5013.8 5680.6 5797.7 5838.9 5851.1 5939.4 4174.9 4175.8 4183.6 4183.9 4191.5 6085.6 6103.1 6120.6 6124.5 6127.2 4111.1 4224.4 4272.4 4293.2 4334.6 4297.9 4309.8 4312.7 4324.8 4331.7 4934.3 4961.7 4965.3 4975.1 4975.3 5685.8 5828.4 5857.5 5864.0 5876.9 1456.6 1472.4 1475.0 1481.5 1493.5 930.6 936.5 950.8 961.4 965.6 5007.9 5099.5 5111.6 5120.5 5121.8 5407.4 5434.5 5459.3 5485.0 5523.4 4918.9 5119.7 5132.6 5133.8 5135.4 2893.7 2932.4 2966.5 2969.4 2982.7 5526.7 5598.2 5645.0 5685.9 5698.1 5091.5 5440.2 5476.9 5480.0 5503.2 5554.0 5603.4 5612.5 5616.7 5620.8 5211.3 5396.0 5402.7 5405.3 5406.5 5345.4 5347.8 5374.1 5393.5 5408.8 5567.4 5576.8 5588.2 5603.4 6001.3 4150.1 4237.0 4265.7 4282.9 4292.2 5979.8 6007.3 6074.8 6078.0 6081.0 5694.7 5865.6 5867.4 5872.0 5907.9 5739.8 5836.7 5842.6 5878.2 5945.3 5733.0 5735.5 5772.2 5773.5 5793.2 5688.3 5996.2 6002.8 6007.5 6017.7 5805.6 5830.6 5837.5 5897.5 5953.1 01:38:44 INFO - PROCESS | 1785 | 01:38:44 INFO - PROCESS | 1785 | [#5] yui.html Cycles:180 Average:20403.65 Median:4781.86 stddev:28587.70 (597.8%) stddev-sans-first:28629.38 01:38:44 INFO - PROCESS | 1785 | Values: 639.6 645.5 737.5 760.9 784.1 17378.0 18031.0 18100.5 19011.1 19045.7 15299.7 15407.4 15698.1 15804.0 15832.8 679.8 806.7 823.1 828.0 830.4 818.4 818.9 824.1 826.0 828.8 866.3 868.9 869.0 870.6 873.2 858.9 860.4 864.6 865.1 867.9 632.7 633.1 633.8 635.4 636.6 16272.4 16324.1 16386.4 16387.6 16415.1 14387.3 14395.6 14928.2 15017.6 15120.5 12596.4 12691.0 12928.2 13088.8 13092.5 3922.8 3941.8 3966.8 3977.0 4075.8 77251.0 78447.6 80409.6 80522.6 81222.2 11965.3 12037.7 12090.9 12165.8 12209.6 20346.3 21172.9 22134.1 22255.7 22263.7 8552.4 8663.6 8710.7 8810.7 8841.6 4752.7 4811.0 4821.0 4858.9 4916.8 3661.0 3729.0 3744.6 3760.2 3769.2 658.2 659.5 666.0 673.5 679.8 670.6 772.7 798.8 804.3 827.4 10425.9 10460.7 10668.4 10749.4 10889.8 769.7 774.0 775.2 791.2 810.2 4953.1 5057.8 5091.1 5095.5 5098.4 101950.0 114287.4 116655.0 116891.4 117242.0 64118.7 78656.6 94818.1 96488.5 97123.0 56526.4 80925.6 81216.0 81532.6 81668.0 9389.4 9643.4 9956.6 9979.5 9990.9 50089.0 50764.2 51239.0 52268.0 52335.5 70876.3 74475.3 75133.0 75270.6 75353.0 11972.3 12108.5 12241.8 12246.4 12270.8 12710.3 12776.8 13129.2 13509.4 14053.6 13015.9 13060.3 13207.1 13282.7 13948.4 13523.1 13639.5 13646.7 13654.8 14276.6 12497.1 12978.2 13116.9 13755.0 13796.4 10646.3 10859.8 11242.6 11662.8 11735.1 10744.7 11078.7 11210.4 11301.2 11363.1 01:38:44 INFO - PROCESS | 1785 | -------- Summary: end -------- 01:38:44 INFO - PROCESS | 1785 | 01:38:45 INFO - TEST-INFO | 1785: exit 0 01:38:45 INFO - TEST-OK | dromaeo_css | took 1110601ms 01:38:45 INFO - TEST-START | kraken 01:38:45 INFO - operating with platform_type : linux_ 01:38:45 INFO - Initialising browser for kraken test... 01:38:45 INFO - TEST-INFO | started process 2022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHn3obL/profile http://localhost:45544/getInfo.html) 01:38:49 INFO - PROCESS | 2022 | __metrics Screen width/height:1600/1200 01:38:49 INFO - PROCESS | 2022 | colorDepth:24 01:38:49 INFO - PROCESS | 2022 | Browser inner width/height: 1024/697 01:38:49 INFO - PROCESS | 2022 | __metrics 01:38:50 ERROR - PROCESS | 2022 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 01:38:51 INFO - TEST-INFO | 2022: exit 0 01:38:51 INFO - Browser initialized. 01:38:51 INFO - Running cycle 1/1 for kraken test... 01:38:51 INFO - TEST-INFO | started process 2139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHn3obL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:39:03 INFO - PROCESS | 2139 | RSS: Main: 167378944 01:39:03 INFO - PROCESS | 2139 | 01:39:05 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:45544/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45544/tests/kraken/driver.html?testName=audio-beat-detection) 01:39:06 INFO - PROCESS | 2139 | RSS: Main: 172814336 01:39:06 INFO - PROCESS | 2139 | 01:39:09 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:45544/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45544/tests/kraken/driver.html?testName=audio-dft) 01:39:09 INFO - PROCESS | 2139 | RSS: Main: 172290048 01:39:09 INFO - PROCESS | 2139 | 01:39:12 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:45544/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45544/tests/kraken/driver.html?testName=audio-fft) 01:39:13 INFO - PROCESS | 2139 | RSS: Main: 166952960 01:39:13 INFO - PROCESS | 2139 | 01:39:15 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:45544/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45544/tests/kraken/driver.html?testName=audio-oscillator) 01:39:15 INFO - PROCESS | 2139 | RSS: Main: 167903232 01:39:15 INFO - PROCESS | 2139 | 01:39:18 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:45544/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45544/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:39:18 INFO - PROCESS | 2139 | RSS: Main: 168288256 01:39:18 INFO - PROCESS | 2139 | 01:39:21 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:45544/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45544/tests/kraken/driver.html?testName=imaging-darkroom) 01:39:22 INFO - PROCESS | 2139 | RSS: Main: 168165376 01:39:22 INFO - PROCESS | 2139 | 01:39:25 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:45544/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45544/tests/kraken/driver.html?testName=imaging-desaturate) 01:39:26 INFO - PROCESS | 2139 | RSS: Main: 166170624 01:39:26 INFO - PROCESS | 2139 | 01:39:29 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:45544/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45544/tests/kraken/driver.html?testName=json-parse-financial) 01:39:29 INFO - PROCESS | 2139 | RSS: Main: 167313408 01:39:29 INFO - PROCESS | 2139 | 01:39:31 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:45544/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45544/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:39:32 INFO - PROCESS | 2139 | RSS: Main: 167424000 01:39:32 INFO - PROCESS | 2139 | 01:39:33 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:45544/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45544/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:39:34 INFO - PROCESS | 2139 | RSS: Main: 167952384 01:39:34 INFO - PROCESS | 2139 | 01:39:36 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:45544/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45544/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:39:37 INFO - PROCESS | 2139 | RSS: Main: 168341504 01:39:37 INFO - PROCESS | 2139 | 01:39:39 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:45544/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:39:40 INFO - PROCESS | 2139 | RSS: Main: 168591360 01:39:40 INFO - PROCESS | 2139 | 01:39:43 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:45544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:39:43 INFO - PROCESS | 2139 | RSS: Main: 168415232 01:39:43 INFO - PROCESS | 2139 | 01:39:45 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:45544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45544/tests/kraken/driver.html?testName=ai-astar) 01:39:45 INFO - PROCESS | 2139 | RSS: Main: 168910848 01:39:45 INFO - PROCESS | 2139 | 01:39:45 INFO - PROCESS | 2139 | __start_tp_report 01:39:45 INFO - PROCESS | 2139 | _x_x_mozilla_page_load 01:39:45 INFO - PROCESS | 2139 | _x_x_mozilla_page_load_details 01:39:45 INFO - PROCESS | 2139 | |i|pagename|runs| 01:39:45 INFO - PROCESS | 2139 | |0;ai-astar;113;105;110;110;111;111;111;110;111;110 01:39:45 INFO - PROCESS | 2139 | |1;audio-beat-detection;163;126;153;180;128;151;150;127;186;125 01:39:45 INFO - PROCESS | 2139 | |2;audio-dft;163;163;162;163;163;167;171;163;161;163 01:39:45 INFO - PROCESS | 2139 | |3;audio-fft;74;76;74;149;75;75;75;75;175;75 01:39:45 INFO - PROCESS | 2139 | |4;audio-oscillator;84;84;157;85;84;86;135;86;85;143 01:39:45 INFO - PROCESS | 2139 | |5;imaging-gaussian-blur;117;117;118;117;117;117;118;117;119;118 01:39:45 INFO - PROCESS | 2139 | |6;imaging-darkroom;148;147;147;147;148;147;148;147;150;148 01:39:45 INFO - PROCESS | 2139 | |7;imaging-desaturate;95;95;96;95;95;95;95;96;96;96 01:39:45 INFO - PROCESS | 2139 | |8;json-parse-financial;53;55;55;54;54;55;56;53;56;58 01:39:45 INFO - PROCESS | 2139 | |9;json-stringify-tinderbox;60;61;61;61;62;61;61;62;61;60 01:39:45 INFO - PROCESS | 2139 | |10;stanford-crypto-aes;86;81;81;80;79;83;81;81;104;82 01:39:45 INFO - PROCESS | 2139 | |11;stanford-crypto-ccm;122;121;131;127;124;132;132;150;131;134 01:39:45 INFO - PROCESS | 2139 | |12;stanford-crypto-pbkdf2;166;158;160;160;162;158;160;160;158;160 01:39:45 INFO - PROCESS | 2139 | |13;stanford-crypto-sha256-iterative;64;65;64;63;67;63;65;62;62;62 01:39:45 INFO - PROCESS | 2139 | __end_tp_report 01:39:45 INFO - PROCESS | 2139 | __start_cc_report 01:39:45 INFO - PROCESS | 2139 | _x_x_mozilla_cycle_collect,891 01:39:45 INFO - PROCESS | 2139 | __end_cc_report 01:39:45 INFO - PROCESS | 2139 | __startTimestamp1464943185783__endTimestamp 01:39:45 INFO - PROCESS | 2139 | 01:39:45 INFO - PROCESS | 2139 | ------- Summary: start ------- 01:39:45 INFO - PROCESS | 2139 | Number of tests: 14 01:39:45 INFO - PROCESS | 2139 | 01:39:45 INFO - PROCESS | 2139 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.04 (1.8%) stddev-sans-first:1.90 01:39:45 INFO - PROCESS | 2139 | Values: 113.0 105.0 110.0 110.0 111.0 111.0 111.0 110.0 111.0 110.0 01:39:45 INFO - PROCESS | 2139 | 01:39:45 INFO - PROCESS | 2139 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:152.00 stddev:22.55 (14.8%) stddev-sans-first:23.33 01:39:45 INFO - PROCESS | 2139 | Values: 163.0 126.0 153.0 180.0 128.0 151.0 150.0 127.0 186.0 125.0 01:39:45 INFO - PROCESS | 2139 | 01:39:45 INFO - PROCESS | 2139 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:2.92 (1.8%) stddev-sans-first:3.08 01:39:45 INFO - PROCESS | 2139 | Values: 163.0 163.0 162.0 163.0 163.0 167.0 171.0 163.0 161.0 163.0 01:39:45 INFO - PROCESS | 2139 | 01:39:45 INFO - PROCESS | 2139 | [#3] audio-fft Cycles:10 Average:92.30 Median:75.00 stddev:37.25 (49.7%) stddev-sans-first:38.91 01:39:45 INFO - PROCESS | 2139 | Values: 74.0 76.0 74.0 149.0 75.0 75.0 75.0 75.0 175.0 75.0 01:39:45 INFO - PROCESS | 2139 | 01:39:45 INFO - PROCESS | 2139 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:84.50 stddev:29.53 (34.9%) stddev-sans-first:30.52 01:39:45 INFO - PROCESS | 2139 | Values: 84.0 84.0 157.0 85.0 84.0 86.0 135.0 86.0 85.0 143.0 01:39:45 INFO - PROCESS | 2139 | 01:39:45 INFO - PROCESS | 2139 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 01:39:45 INFO - PROCESS | 2139 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 119.0 118.0 01:39:45 INFO - PROCESS | 2139 | 01:39:45 INFO - PROCESS | 2139 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 01:39:45 INFO - PROCESS | 2139 | Values: 148.0 147.0 147.0 147.0 148.0 147.0 148.0 147.0 150.0 148.0 01:39:45 INFO - PROCESS | 2139 | 01:39:45 INFO - PROCESS | 2139 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 01:39:45 INFO - PROCESS | 2139 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 01:39:45 INFO - PROCESS | 2139 | 01:39:45 INFO - PROCESS | 2139 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.52 (2.8%) stddev-sans-first:1.45 01:39:45 INFO - PROCESS | 2139 | Values: 53.0 55.0 55.0 54.0 54.0 55.0 56.0 53.0 56.0 58.0 01:39:45 INFO - PROCESS | 2139 | 01:39:45 INFO - PROCESS | 2139 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 01:39:45 INFO - PROCESS | 2139 | Values: 60.0 61.0 61.0 61.0 62.0 61.0 61.0 62.0 61.0 60.0 01:39:45 INFO - PROCESS | 2139 | 01:39:45 INFO - PROCESS | 2139 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:81.00 stddev:7.35 (9.1%) stddev-sans-first:7.75 01:39:45 INFO - PROCESS | 2139 | Values: 86.0 81.0 81.0 80.0 79.0 83.0 81.0 81.0 104.0 82.0 01:39:45 INFO - PROCESS | 2139 | 01:39:45 INFO - PROCESS | 2139 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:131.50 stddev:8.26 (6.3%) stddev-sans-first:8.19 01:39:45 INFO - PROCESS | 2139 | Values: 122.0 121.0 131.0 127.0 124.0 132.0 132.0 150.0 131.0 134.0 01:39:45 INFO - PROCESS | 2139 | 01:39:45 INFO - PROCESS | 2139 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.00 stddev:2.39 (1.5%) stddev-sans-first:1.33 01:39:45 INFO - PROCESS | 2139 | Values: 166.0 158.0 160.0 160.0 162.0 158.0 160.0 160.0 158.0 160.0 01:39:45 INFO - PROCESS | 2139 | 01:39:45 INFO - PROCESS | 2139 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.64 (2.6%) stddev-sans-first:1.73 01:39:45 INFO - PROCESS | 2139 | Values: 64.0 65.0 64.0 63.0 67.0 63.0 65.0 62.0 62.0 62.0 01:39:45 INFO - PROCESS | 2139 | -------- Summary: end -------- 01:39:45 INFO - PROCESS | 2139 | 01:39:46 INFO - TEST-INFO | 2139: exit 0 01:39:46 INFO - TEST-OK | kraken | took 61422ms 01:39:46 INFO - SUITE-END | took 1172s 01:39:46 INFO - Completed test suite (00:19:32) 01:39:46 INFO - javascript benchmark 01:39:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7290.11048252548, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3118.859651315691, 3125.7968232064927, 3158.8578513966877, 3169.5245713143026, 3171.112088615187, 5480.479354461329, 5487.341519017724, 5530.05988981873, 5580.079286917664, 5594.160875868622, 5429.267048948391, 5435.891282174354, 5487.780488780444, 5502.119660854264, 5522.337319521653, 4972.105021096201, 5000.19996800512, 5036.496350364971, 5127.256547800566, 5130.948690513084, 5037.370328708911, 5167.586593072545, 5209.583233341324, 5220.451852555484, 5221.634485586011, 4984.825531106412, 4998.175301075318, 4999.125153098194, 5037.093323201822, 5062.569681577071, 5046.318746969149, 5049.065922804293, 5057.797688092472, 5059.747012649353, 5124.359455068116, 4996.550310472075, 5001.649884508086, 5011.949880501221, 5023.899522009576, 5043.873903152414, 5314.149736042254, 5334.306540149794, 5345.705986170759, 5362.4637536246455, 5380.058489764276, 5805.129230615399, 5821.825345239649, 5822.854428639275, 5841.123831425278, 5859.2382990211, 5812.970935145339, 5890.0, 5959.880802383928, 6006.699665016732, 6007.429294217042, 5551.1673249012565, 5559.11054231321, 5561.58288128392, 5565.526930210937, 5574.052411090124, 5981.910271345933, 6071.362506936796, 6075.119107729354, 6097.024476083805, 6108.847278817976, 5841.094630332305, 5842.474177323977, 5865.530757539386, 5868.882622347529, 5880.353161152269, 5838.737256823453, 5903.291605007426, 5938.732757025944, 5954.970225148933, 5984.700764961734, 5727.627704199213, 5785.30576330843, 5801.88396232073, 5842.357340692521, 5852.4147585241135, 5824.6796426196115, 5850.034744267148, 5880.176775251468, 5881.3530511643685, 5882.117682347596, 4407.118576284756, 4429.424174857312, 4445.5776701213335, 4456.844010459618, 4467.15124126415, 4039.838406463767, 4041.636252737209, 4045.9190816183514, 4049.2104039712563, 4070.8371665133654, 5549.472800083986, 5631.662100273997, 5657.9434205658235, 5735.8852822944145, 5740.598158128974, 5998.670073146019, 6000.969995149996, 6022.427869352405, 6024.0662697282, 6074.787382441594, 5711.8000869969355, 5733.827985160452, 5735.340435849847, 5735.913961290584, 5744.224529688522, 5035.949640503622, 5062.038212739568, 5096.286519887219, 5115.155999260155, 5119.360079990001, 6148.784792532329, 6156.661383623944, 6165.784197553064, 6167.198264225622, 6187.659678717624, 5919.644821310735, 5953.166556681981, 5967.880642387215, 5984.13230081627, 6026.096085587197, 5899.498542623754, 5970.522358211246, 6044.818655440344, 6054.212952316171, 6067.787627433018, 5802.970985145047, 5803.622764520293, 5810.448007439287, 5814.156947242542, 5814.563907707024, 5898.439648233411, 5909.025010873158, 5912.645241285537, 5916.171735957056, 5919.082542205965, 5765.048766953406, 5822.3304320003745, 5840.269966254218, 5853.443922827325, 5873.353931067493, 5799.565032622654, 5841.474267315962, 5852.912206316993, 5855.092460668603, 5860.824175274749, 5623.971880140573, 5692.48767610917, 5756.884862302647, 5766.798162064475, 5767.423257674199, 5700.25896633435, 5856.502197313276, 5885.087811389241, 5892.1161825726485, 5949.464548190511, 5744.109663002241, 5750.0, 5759.308882934075, 5761.107028410603, 5761.222234998221], "value": 5457.3939237693485, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.8500982249526, 635.2155088465745, 642.1683919324474, 656.1994366872416, 665.2781731820974, 39186.41220381693, 43246.35130473038, 43343.34984975228, 43386.34920476195, 43392.0, 44624.107517849625, 45480.77259613697, 45515.77242113793, 45543.544564554344, 45651.771741141245, 8559.101294364096, 8800.647974081061, 8808.779780505507, 8815.206631403173, 8832.955835220848, 8690.391672582922, 8752.737417877443, 8766.254868336198, 8771.517566533837, 8780.824383512327, 8762.912370876305, 8790.51652159131, 8815.162559556864, 8815.955920220389, 8825.382223244376, 8703.129687031309, 8771.342149338794, 8785.472871627722, 8802.779930501725, 8813.250873675745, 8579.399442039059, 8667.783305417352, 8727.258183054448, 8738.082501337332, 8758.562071896444, 41155.794221029006, 41551.7922410389, 41643.0, 41654.75035748933, 41789.37315940263, 3351.8324083795715, 3528.1708798432346, 3571.2857428514403, 3633.582138054131, 4016.2168377166463, 32381.190470238198, 33084.17289567756, 33176.0, 33498.33003339944, 33583.664163358546, 4224.155168966188, 4227.133437645306, 4351.586599273064, 4451.577100175478, 4482.305242687356, 359603.0, 362915.0, 365880.0, 365910.0, 367087.16456417815, 34993.0, 61825.0, 62099.37900621026, 62135.689321554004, 62211.37788622146, 35923.4611480828, 38032.23935521329, 38034.809825950695, 38135.80932095377, 38168.80915595404, 15066.397344106332, 15237.695246095238, 15247.771283430757, 15252.313645885963, 15332.463363782213, 12138.271703697807, 12273.018158547295, 12277.570285039981, 12286.938565307117, 12304.446299916524, 8511.65953361871, 8518.531480768617, 8530.829383412298, 8592.0, 8631.180037896389, 3243.513472979072, 3335.666433356645, 3336.1492819330915, 3346.0463767826054, 3361.781484203519, 1042.7288904884633, 1071.8820929697727, 1094.7974624694457, 1139.7720455908852, 1142.959996400122, 33017.3396532068, 33505.497417538754, 33698.32603347969, 33702.66297337044, 34214.0137884484, 1099.8735145458215, 1199.964001079969, 1211.9212251203644, 1214.9453274602663, 1220.9145359824727, 17602.91198543999, 17645.470635880945, 17662.293508259783, 17663.701298054453, 17693.292268309124, 521979.0, 524474.0, 527565.0, 528469.0, 529028.0, 59688.40311596915, 59739.402605974254, 60179.699101504215, 60263.69868150719, 60288.0, 1360.197483484729, 1363.795430685405, 1375.2367436072875, 1386.7711827548544, 1404.1855723680242, 31060.378792423573, 32071.198220044687, 32175.0, 32660.51009234816, 33085.83457082699, 51925.7403712979, 52180.47819521756, 52349.7382513085, 52765.47234527606, 52781.0, 419690.9015454903, 420054.0, 420252.0, 420848.0, 423041.0, 29001.12996610105, 29132.0, 29302.560461592668, 29315.508181804784, 29492.705072948997, 50132.0, 50406.49593504018, 50432.49567504278, 50474.0, 51342.0, 43040.34157096557, 43518.78240608777, 43850.0, 44577.331340029275, 44650.10699786051, 41731.0, 42003.36994945139, 42222.366664499445, 42593.93515162146, 43325.0, 42376.364354535326, 42902.78548607237, 43002.78498607612, 43334.78332608317, 45473.0, 36957.26085478329, 37845.43231851469, 37903.43144852885, 39092.21815563616, 39264.803675981435, 28979.565306520843, 29710.257243569085, 29916.70083299226, 30025.69974300229, 30070.69929300679], "value": 19284.871575322297, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.24100762505486, 397.16396984347966, 397.4793021142302, 401.9778912159831, 420.35475545038355, 14036.719265614707, 17836.375726849565, 18997.43007709771, 19578.70631940522, 19613.803861961394, 18396.17217225225, 18762.530936726555, 18983.71524427135, 19058.142383592738, 19135.42593722187, 5494.945050549483, 5511.283533140696, 5703.74333155009, 5763.1355296705415, 5765.654060756368, 5637.802676906309, 5654.575906806986, 5678.545716342704, 5696.031674615326, 5717.256756621633, 5414.35027796665, 5662.462066103734, 5692.6299790513485, 5772.797952071678, 5780.5664575156825, 5732.856678583027, 5746.9712651436685, 5759.827205183851, 5808.883822323551, 5822.679752613604, 5805.0, 5846.941530584682, 5851.941480585182, 5855.736491857877, 5870.765169393219, 12654.430550625244, 16550.50348489547, 19294.903525482423, 22731.659025114637, 22805.42986425336, 2260.7626199249007, 2340.590396680574, 2493.0277191895175, 2493.4888347888823, 2509.899604015837, 10310.484475776182, 10340.431276279802, 10512.1590272778, 10587.894121058767, 10684.0, 1892.0728842867034, 1909.5352703272627, 1912.4836294200627, 1927.739755133067, 1935.341983725526, 74972.0, 78691.81962270627, 81311.0, 81482.0, 86074.56962715146, 10574.89425105739, 10728.624498142684, 10876.184286178568, 11018.338899666045, 11086.334819910831, 15412.0, 15456.536303910902, 15606.765898511532, 15611.297491612904, 15633.609159771097, 7690.500117492345, 7818.648160832662, 7828.412869034845, 7938.24586664266, 8113.59432028408, 7442.144153422318, 7506.737264195727, 7553.773386798295, 7566.546007239584, 7609.6575654095695, 4393.780310984438, 4547.317902314613, 4554.3851580036935, 4611.331356953223, 4846.660733748674, 1862.0, 1922.1638587214607, 1924.133041767756, 1938.8642795004214, 1942.4561122885614, 907.5552979040223, 1011.7420057885339, 1023.6775415744016, 1052.310736467615, 1076.967690969272, 18107.81892181088, 18563.0, 18750.249990000248, 18948.715769263472, 18969.525761855788, 999.5202302894506, 1003.372891942536, 1011.1203253169789, 1025.43601019439, 1026.7176526455135, 10224.897751022394, 10318.122959548522, 10415.0, 10567.207459440573, 10569.471526423647, 465698.0, 476548.0, 476684.0, 477770.0, 479598.0, 76082.0, 93339.53330233306, 94341.5282923581, 96135.0, 98495.50752246194, 972.4262685015875, 1004.8794144702682, 1006.7231511334295, 1008.3647302199568, 1015.3095894791466, 16831.24259408305, 17180.140992950553, 17208.483745487654, 17260.91369543144, 17402.47792566225, 40239.597604024755, 42021.36967945422, 42490.57509424866, 43308.35037474377, 44478.77760611176, 61658.075128874, 63211.0, 65545.0, 65607.34392656204, 65787.34212657812, 5630.943690563206, 5631.408702086222, 8263.504189748634, 8376.664933402595, 8664.133586641537, 9868.654597089067, 13229.603111906657, 13339.866601333862, 13369.933150334575, 13527.797083043566, 11793.115516336138, 11814.232074915102, 12095.57665481739, 12099.274043557414, 12121.636350909486, 11414.372209528223, 11581.82627260575, 11631.709207269885, 11672.824907626562, 11872.584459543874, 12018.819717704067, 12033.518659253532, 12155.81766273489, 12243.142979991315, 12281.508739650313, 8634.0, 8787.91212087871, 8815.338849586178, 8864.290856731575, 8928.553572321229, 11776.646700598996, 11869.40652967331, 11912.880871191177, 12030.218035827644, 12180.939095304468], "value": 9124.335480494507, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.9774853377198, 1525.054466230937, 1685.8819882608216, 1773.8580913526919, 1817.9363722269723, 7878.0, 8261.958690206555, 8410.116937721543, 9011.819763604732, 9036.864447033291, 8361.623726932288, 8486.0, 8538.103499132594, 8606.440581362223, 8630.223279904807, 2337.0885354711677, 2390.5816482115647, 2391.390195500145, 2392.820538459614, 2397.2688330059327, 2356.234223877238, 2371.419002344428, 2410.276916924924, 2421.9515609687796, 2423.8850128940708, 2327.4763178284834, 2362.8818559072065, 2371.087131454385, 2394.162043284854, 2397.0891061396646, 2315.629499280124, 2330.5105927755194, 2340.5903966805827, 2342.1334106380577, 2361.031976889467, 2267.614505534063, 2268.7277526696903, 2278.612635851909, 2284.0863654538152, 2303.8963246653775, 8614.698485552975, 8622.83591715123, 8688.695895643685, 8698.086700896441, 8743.344249181337, 5175.430702622746, 5257.08001099806, 5289.761960711778, 5289.788408463657, 5321.0, 3398.4052790761766, 3403.6936675699308, 3450.87921922734, 3461.6365281645317, 3524.1013541547, 1129.5312445335176, 1134.3194083549886, 1136.2898837249886, 1165.6619580321697, 1172.9384906659486, 11886.762264754656, 12088.456019479145, 12136.15046946714, 12154.33151176685, 12182.634520964473, 4744.117275123807, 4768.737719425396, 4782.856514304576, 4834.734089625034, 4835.637327200474, 10239.692809215736, 10256.58973641061, 10327.0, 10330.793384132276, 10395.272330936761, 5137.486251374908, 5267.209918512177, 5277.498637629419, 5337.092694241988, 5339.172428273546, 4425.911481770347, 4821.686590371614, 4861.586765125004, 4976.4525902150735, 4981.975090124599, 4102.077032667626, 4149.522804877417, 4156.480439945007, 4191.40726523919, 4229.302165142779, 1313.4483516922915, 1352.5604178641981, 1353.303048929802, 1355.1801160298076, 1355.3426588104762, 1014.5079636376352, 1020.4642562654517, 1020.9336393134422, 1021.6117875207374, 1024.2062401638789, 6022.156898034279, 6055.788047418319, 6063.454289113913, 6133.754649814046, 6449.451796597342, 953.7186529973675, 988.7231575158967, 1020.9795804083876, 1022.223110436074, 1030.675581877284, 4063.3701776224734, 4179.26862799009, 4260.510041345223, 4311.827526898952, 4319.6112349888035, 10583.417912014913, 10813.080888124598, 10905.83641245382, 10941.28881622692, 10994.560217591366, 10658.62694805678, 10743.83884241737, 10851.837222441669, 10896.18278629106, 10939.83590246147, 7790.649420775965, 7811.882821757678, 8041.919580804117, 8097.149799270992, 8323.417360784808, 6020.337762846171, 6115.318287470981, 6185.072239164161, 6191.81424557264, 6215.689215539295, 9742.171915387271, 9871.160951319218, 9997.450140242065, 10012.749681258027, 10143.0, 10122.898771012196, 10159.390436573829, 10187.0, 10205.591776328863, 10284.691459256233, 6943.375096241362, 7446.925530744623, 7774.611269436618, 7784.143744188248, 7808.219178082373, 8558.529280889361, 8591.097934717014, 8598.183172598594, 8601.612927418157, 8619.439736417113, 7533.7363192288, 7567.470277080772, 7570.470067095471, 7578.0, 7815.8436831261915, 7468.887966680395, 7540.245975402416, 7578.166401695698, 7604.733834315773, 7696.499727517694, 6809.761658341934, 6847.452203823583, 6881.587104773729, 6890.931090689029, 6921.204061532787, 5083.72039537829, 5083.92374114396, 5096.108181068224, 5099.2860999460845, 5157.8452646420665, 5064.164412871983, 5111.05445492585, 5112.437631860418, 5146.305248791366, 5251.081060814418], "value": 4686.045703958499, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.6080177000474, 339.3399837316419, 342.40934388180386, 343.85386210860395, 344.72938743086684, 5501.724913754317, 5540.141278101901, 5607.579431542636, 5716.485516303532, 5750.769969201232, 5558.777648894039, 5559.58303127265, 5605.9538268532, 5614.214010038598, 5642.520385767204, 4306.375575541545, 4365.650747940157, 4418.270985287424, 4419.425474688286, 4435.290353543433, 4094.61101195386, 4333.0, 4341.261985462479, 4379.408779814732, 4396.164728701552, 4300.311950087987, 4307.138572285556, 4311.331743579734, 4337.54455782143, 4346.739195648272, 4357.193919124956, 4362.36745671879, 4369.672274579403, 4391.01202229499, 4404.207242696313, 3734.775913445202, 3777.8855237704943, 3826.655600995896, 3843.615638436134, 3843.7693738375788, 5385.838424847261, 5389.9191512127345, 5392.91910621341, 5424.8607792363655, 5459.744258820493, 4933.235348520949, 4970.428400733889, 4988.127077761414, 5002.59979201663, 5013.849584512471, 5680.602357834953, 5797.681127537984, 5838.9124163137585, 5851.122331650244, 5939.376365481606, 4174.895627609304, 4175.770332631704, 4183.602557757008, 4183.895402614929, 4191.455110835572, 6085.574009819315, 6103.1455596216565, 6120.632762034292, 6124.540659450559, 6127.172831667713, 4111.108889910674, 4224.394730002579, 4272.444582204355, 4293.227219100592, 4334.566543345703, 4297.935530967038, 4309.806058727302, 4312.719673221231, 4324.8375812093955, 4331.696781225347, 4934.3338649282605, 4961.6526843121355, 4965.255211718271, 4975.129352363322, 4975.328330675385, 5685.829425117253, 5828.446297601721, 5857.47282744555, 5863.970680146572, 5876.913695638073, 1456.5994351553195, 1472.409797418785, 1475.0117421327736, 1481.5185064853965, 1493.4996776079918, 930.5533343994921, 936.520859546545, 950.7623094226443, 961.4135377419768, 965.5944503308627, 5007.899842003139, 5099.5410413063, 5111.616628752784, 5120.539151476385, 5121.820736274287, 5407.378151512547, 5434.538064264581, 5459.344878614592, 5485.0, 5523.420040895729, 4918.877028074256, 5119.718415487184, 5132.613334799262, 5133.845984620468, 5135.383753949475, 2893.7250961158657, 2932.3695405487924, 2966.525355943039, 2969.435807196626, 2982.6719060903283, 5526.668399895939, 5598.216249725042, 5645.0, 5685.92463750728, 5698.093972074189, 5091.516305950929, 5440.231924624512, 5476.945230547723, 5479.972600137054, 5503.2020357048, 5554.028869358428, 5603.411641777636, 5612.5229355504425, 5616.747246373923, 5620.775168993277, 5211.270422140828, 5396.0, 5402.729863506887, 5405.297311349499, 5406.459354064562, 5345.438728933406, 5347.839564813062, 5374.065336478942, 5393.467278932306, 5408.7566059526625, 5567.415421380697, 5576.804811831566, 5588.245586845724, 5603.439656034364, 6001.319630503466, 4150.107726838744, 4236.957630423656, 4265.680073994401, 4282.850100246476, 4292.163028209469, 5979.760809567569, 6007.339192688888, 6074.848128796815, 6078.0, 6080.993272220245, 5694.661754487609, 5865.589408741518, 5867.442592953663, 5871.970640146772, 5907.91138132937, 5739.770409183586, 5836.686745482232, 5842.620229685057, 5878.2064421302575, 5945.34601193877, 5732.971335143465, 5735.483806457439, 5772.249607550992, 5773.480386765212, 5793.217915581343, 5688.288963879515, 5996.160537524663, 6002.8499287516415, 6007.549433792396, 6017.669028203491, 5805.564582656233, 5830.591858569859, 5837.5329973601165, 5897.498712609477, 5953.1367951647635], "value": 4339.426608274015, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.5746828359139, 645.5287640022781, 737.5353527277814, 760.8668483015473, 784.0591290451458, 17378.0, 18031.0, 18100.547486312833, 19011.144498497568, 19045.714314285262, 15299.694006119871, 15407.3837046518, 15698.058116513017, 15804.0, 15832.762508562351, 679.8402375441767, 806.6853926968487, 823.074041703084, 827.9668813247463, 830.3523251863556, 818.4475479051646, 818.9017317921828, 824.0729179672868, 825.9628316725732, 828.8383765165795, 866.3285953386113, 868.9261412779921, 868.9608967596473, 870.5908223135116, 873.2271939333704, 858.8840506531601, 860.414917855861, 864.5849992003842, 865.0527672198932, 867.9479231246114, 632.6868200240864, 633.0915136778691, 633.8415396150963, 635.3519410201568, 636.6212103798233, 16272.43046493367, 16324.102174380405, 16386.426475073433, 16387.59031024222, 16415.097169655663, 14387.280635968264, 14395.568132956028, 14928.178950157737, 15017.624559385993, 15120.54638360851, 12596.370181490889, 12691.0, 12928.159669621444, 13088.803667944989, 13092.541761038414, 3922.764634121962, 3941.763494190329, 3966.8214930328204, 3976.980115099435, 4075.7758323292205, 77251.0, 78447.60776196083, 80409.59795200986, 80522.59738701327, 81222.18777812265, 11965.341906195243, 12037.67585565587, 12090.879091209152, 12165.817512737316, 12209.633710988684, 20346.28787992413, 21172.894135529223, 22134.114635414404, 22255.666165007537, 22263.666045009337, 8552.358573106918, 8663.566821659018, 8710.651573936972, 8810.735677929672, 8841.646334146692, 4752.7385993769985, 4810.975945120322, 4821.0, 4858.854234372974, 4916.754162291871, 3661.0481274868725, 3728.9813550932613, 3744.5506539214925, 3760.1539653578275, 3769.1896242308035, 658.2298710508717, 659.4658326755343, 665.9667016649148, 673.545356884111, 679.8198477403492, 670.6244503078292, 772.7025095338336, 798.7603718884311, 804.3324041045918, 827.3960009193203, 10425.895741042492, 10460.73848153787, 10668.413237272025, 10749.408782517037, 10889.83665245022, 769.6959700918106, 773.97678069658, 775.1821827971544, 791.1929831571764, 810.1695761844157, 4953.1332016896895, 5057.848264552069, 5091.0836049511445, 5095.490450954875, 5098.439171691111, 101950.0, 114287.42856285666, 116655.0, 116891.41554292344, 117242.0, 64118.6794066036, 78656.60671696719, 94818.05181948231, 96488.51755741176, 97123.0, 56526.43473565212, 80925.59537202277, 81216.0, 81532.59233703793, 81668.0, 9389.436633801994, 9643.373180743229, 9956.601735930482, 9979.50102494887, 9990.850137247802, 50089.0, 50764.23853642272, 51239.0, 52268.0, 52335.47664523306, 70876.29123708697, 74475.255247449, 75132.96946921606, 75270.6236468836, 75353.0, 11972.341521216069, 12108.455119519467, 12241.816372754594, 12246.44890979926, 12270.754584908073, 12710.300933448749, 12776.808347874976, 13129.212247265195, 13509.392077356346, 14053.578392647827, 13015.869841301466, 13060.281684507443, 13207.141535800141, 13282.734345312847, 13948.442062317394, 13523.120997135155, 13639.522616708367, 13646.659116647856, 13654.795178072138, 14276.57170284893, 12497.12520123619, 12978.156419832681, 13116.868831311565, 13755.0, 13796.379162937892, 10646.254762166884, 10859.837102443627, 11242.550297988317, 11662.825057624312, 11735.119866009913, 10744.731381715206, 11078.667639970814, 11210.43947802623, 11301.208915375844, 11363.147763917905], "value": 7686.364688330634, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 110.0, 110.0, 111.0, 111.0, 111.0, 110.0, 111.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 126.0, 153.0, 180.0, 128.0, 151.0, 150.0, 127.0, 186.0, 125.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 163.0, 163.0, 167.0, 171.0, 163.0, 161.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 149.0, 75.0, 75.0, 75.0, 75.0, 175.0, 75.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 157.0, 85.0, 84.0, 86.0, 135.0, 86.0, 85.0, 143.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 119.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 150.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 55.0, 54.0, 54.0, 55.0, 56.0, 53.0, 56.0, 58.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 60.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 81.0, 81.0, 80.0, 79.0, 83.0, 81.0, 81.0, 104.0, 82.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 131.0, 127.0, 124.0, 132.0, 132.0, 150.0, 131.0, 134.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 158.0, 160.0, 160.0, 162.0, 158.0, 160.0, 160.0, 158.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 63.0, 67.0, 63.0, 65.0, 62.0, 62.0, 62.0], "value": 63.7, "unit": "score"}]}]} 01:39:47 INFO - Return code: 0 01:39:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:39:47 ERROR - # TBPL SUCCESS # 01:39:47 INFO - Running post-action listener: _resource_record_post_action 01:39:47 INFO - ##### 01:39:47 INFO - ##### Finished run-tests step (success) 01:39:47 INFO - ##### 01:39:47 INFO - Running post-run listener: _resource_record_post_run 01:39:47 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 16384; Write bytes: 553918464; Read time: 260; Write time: 631496 01:39:47 INFO - TinderboxPrint: CPU usage
13.5% 01:39:47 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 260 01:39:47 INFO - TinderboxPrint: I/O write bytes / time
553,918,464 / 631,496 01:39:47 INFO - TinderboxPrint: CPU idle
8,212.0 (86.5%) 01:39:47 INFO - TinderboxPrint: CPU user
1,226.2 (12.9%) 01:39:47 INFO - TinderboxPrint: Swap in / out
0 / 0 01:39:47 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 260087808; Read time: 0; Write time: 339112 01:39:47 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 16384; Write bytes: 293830656; Read time: 260; Write time: 292384 01:39:47 INFO - Running post-run listener: _upload_blobber_files 01:39:47 INFO - Blob upload gear active. 01:39:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:39:47 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:39:47 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:39:47 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:39:48 INFO - (blobuploader) - INFO - Open directory for files ... 01:39:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:39:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:39:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:48 INFO - (blobuploader) - INFO - Done attempting. 01:39:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:39:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:39:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:49 INFO - (blobuploader) - INFO - Done attempting. 01:39:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:39:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:40:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:40:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:40:18 INFO - (blobuploader) - INFO - Done attempting. 01:40:18 INFO - (blobuploader) - INFO - Iteration through files over. 01:40:18 INFO - Return code: 0 01:40:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:40:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:40:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a2d4c7cac940110839ec46c4dc1cad2cb891fc6803bd17da74fa1faaac52326c910d8967fd8b4920acfda624d4fc2065011550b96d89cd78ca2fbc5eface4f07", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/499ee1d6c5cdb12f42dc93185427497f6c80f1011cbedecf37d8371be4bb5cbf9ef931dd1480f353d0263ed40f5eac37bc7d341d1fd971b996090b304fbd2d3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/396d68587724151cc70e38e9defd1baf02616016274f3bd25cb063beaa421989edf110aa876e02b63452a6bdb2e8080b435b326a7c55ddbafae02ecb7383e393"} 01:40:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:40:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:40:18 INFO - Contents: 01:40:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a2d4c7cac940110839ec46c4dc1cad2cb891fc6803bd17da74fa1faaac52326c910d8967fd8b4920acfda624d4fc2065011550b96d89cd78ca2fbc5eface4f07", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/499ee1d6c5cdb12f42dc93185427497f6c80f1011cbedecf37d8371be4bb5cbf9ef931dd1480f353d0263ed40f5eac37bc7d341d1fd971b996090b304fbd2d3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/396d68587724151cc70e38e9defd1baf02616016274f3bd25cb063beaa421989edf110aa876e02b63452a6bdb2e8080b435b326a7c55ddbafae02ecb7383e393"} 01:40:18 INFO - Running post-run listener: copy_logs_to_upload_dir 01:40:18 INFO - Copying logs to upload dir... 01:40:18 INFO - mkdir: /builds/slave/test/build/upload/logs 01:40:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.891815 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-06-03 01:40:18.557236) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 01:40:18.560980) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370 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/a2d4c7cac940110839ec46c4dc1cad2cb891fc6803bd17da74fa1faaac52326c910d8967fd8b4920acfda624d4fc2065011550b96d89cd78ca2fbc5eface4f07", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/499ee1d6c5cdb12f42dc93185427497f6c80f1011cbedecf37d8371be4bb5cbf9ef931dd1480f353d0263ed40f5eac37bc7d341d1fd971b996090b304fbd2d3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/396d68587724151cc70e38e9defd1baf02616016274f3bd25cb063beaa421989edf110aa876e02b63452a6bdb2e8080b435b326a7c55ddbafae02ecb7383e393"} 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.011265 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/a2d4c7cac940110839ec46c4dc1cad2cb891fc6803bd17da74fa1faaac52326c910d8967fd8b4920acfda624d4fc2065011550b96d89cd78ca2fbc5eface4f07", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/499ee1d6c5cdb12f42dc93185427497f6c80f1011cbedecf37d8371be4bb5cbf9ef931dd1480f353d0263ed40f5eac37bc7d341d1fd971b996090b304fbd2d3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/396d68587724151cc70e38e9defd1baf02616016274f3bd25cb063beaa421989edf110aa876e02b63452a6bdb2e8080b435b326a7c55ddbafae02ecb7383e393"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 01:40:18.587126) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:40:18.587508) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1464941617.915899-822533370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:40:18.669599) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 01:40:18.669943) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 01:40:18.670270) ========= ========= Total master_lag: 0.17 =========