builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1464941988.78 results: success (0) buildid: 20160602223101 builduid: ce63a416ae014a908e50471ec102bb3c revision: 8b89d98ce322f0c68538db7837cd7eb749d1ed1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:48.786990) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:48.787822) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:48.788143) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:48.824620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:48.824938) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 01:19:49-- 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% 89.0M=0s 2016-06-03 01:19:49 (89.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118706 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:48.957543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:48.957879) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019829 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:49.010070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 01:19:49.010591) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 01:19:49,598 truncating revision to first 12 chars 2016-06-03 01:19:49,598 Setting DEBUG logging. 2016-06-03 01:19:49,598 attempt 1/10 2016-06-03 01:19:49,598 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:50,581 unpacking tar archive at: mozilla-inbound-8b89d98ce322/testing/mozharness/ program finished with exit code 0 elapsedTime=1.322928 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 01:19:50.352819) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:50.353663) ========= script_repo_revision: 8b89d98ce322f0c68538db7837cd7eb749d1ed1c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:50.354995) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:50.355364) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 01:19:50.366080) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-03 01:19:50.366398) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:19:51 INFO - MultiFileLogger online at 20160603 01:19:51 in /builds/slave/test 01:19:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:19:51 INFO - {'append_to_log': False, 01:19:51 INFO - 'base_work_dir': '/builds/slave/test', 01:19:51 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:19:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:19:51 INFO - 'branch': 'Mozilla-Inbound', 01:19:51 INFO - 'buildbot_json_path': 'buildprops.json', 01:19:51 INFO - 'config_files': ('talos/linux_config.py',), 01:19:51 INFO - 'default_actions': ('clobber', 01:19:51 INFO - 'read-buildbot-config', 01:19:51 INFO - 'download-and-extract', 01:19:51 INFO - 'populate-webroot', 01:19:51 INFO - 'create-virtualenv', 01:19:51 INFO - 'install', 01:19:51 INFO - 'run-tests'), 01:19:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:19:51 INFO - 'download_minidump_stackwalk': True, 01:19:51 INFO - 'download_symbols': 'ondemand', 01:19:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:19:51 INFO - 'tooltool.py': '/tools/tooltool.py', 01:19:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:19:51 INFO - '/tools/misc-python/virtualenv.py')}, 01:19:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:19:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:19:51 INFO - 'installer_path': 'installer.exe', 01:19:51 INFO - 'log_level': 'info', 01:19:51 INFO - 'log_name': 'talos', 01:19:51 INFO - 'log_to_console': True, 01:19:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:19:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:19:51 INFO - 'opt_config_files': (), 01:19:51 INFO - 'pip_index': False, 01:19:51 INFO - 'sps_profile': False, 01:19:51 INFO - 'sps_profile_interval': 0, 01:19:51 INFO - 'suite': 'dromaeojs', 01:19:51 INFO - 'system_bits': '32', 01:19:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:19:51 INFO - 'title': 'talos-linux64-ix-012', 01:19:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:19:51 INFO - 'use_talos_json': True, 01:19:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:19:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:19:51 INFO - 'work_dir': 'build'} 01:19:51 INFO - ##### 01:19:51 INFO - ##### Running clobber step. 01:19:51 INFO - ##### 01:19:51 INFO - Running pre-action listener: _resource_record_pre_action 01:19:51 INFO - Running main action method: clobber 01:19:51 INFO - rmtree: /builds/slave/test/build 01:19:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:19:51 INFO - Running post-action listener: _resource_record_post_action 01:19:51 INFO - ##### 01:19:51 INFO - ##### Finished clobber step (success) 01:19:51 INFO - ##### 01:19:51 INFO - ##### 01:19:51 INFO - ##### Running read-buildbot-config step. 01:19:51 INFO - ##### 01:19:51 INFO - Running pre-action listener: _resource_record_pre_action 01:19:51 INFO - Running main action method: read_buildbot_config 01:19:51 INFO - Using buildbot properties: 01:19:51 INFO - { 01:19:51 INFO - "project": "", 01:19:51 INFO - "product": "firefox", 01:19:51 INFO - "script_repo_revision": "production", 01:19:51 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 01:19:51 INFO - "repository": "", 01:19:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 01:19:51 INFO - "buildid": "20160602223101", 01:19:51 INFO - "pgo_build": "True", 01:19:51 INFO - "basedir": "/builds/slave/test", 01:19:51 INFO - "buildnumber": 1890, 01:19:51 INFO - "slavename": "talos-linux64-ix-012", 01:19:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:19:51 INFO - "platform": "ubuntu64_hw", 01:19:51 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:19:51 INFO - "branch": "mozilla-inbound", 01:19:51 INFO - "repo_path": "integration/mozilla-inbound", 01:19:51 INFO - "revision": "8b89d98ce322f0c68538db7837cd7eb749d1ed1c", 01:19:51 INFO - "stage_platform": "linux64-pgo", 01:19:51 INFO - "builduid": "ce63a416ae014a908e50471ec102bb3c", 01:19:51 INFO - "slavebuilddir": "test" 01:19:51 INFO - } 01:19:51 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:51 INFO - Running post-action listener: _resource_record_post_action 01:19:51 INFO - ##### 01:19:51 INFO - ##### Finished read-buildbot-config step (success) 01:19:51 INFO - ##### 01:19:51 INFO - ##### 01:19:51 INFO - ##### Running download-and-extract step. 01:19:51 INFO - ##### 01:19:51 INFO - Running pre-action listener: _resource_record_pre_action 01:19:51 INFO - Running main action method: download_and_extract 01:19:51 INFO - mkdir: /builds/slave/test/build/tests 01:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:51 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:51 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:51 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:51 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:51 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:52 INFO - Downloaded 1361 bytes. 01:19:52 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:19:52 INFO - Using the following test package requirements: 01:19:52 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:19:52 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:19:52 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:19:52 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:52 INFO - u'jsshell-linux-x86_64.zip'], 01:19:52 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:19:52 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:19:52 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:19:52 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:19:52 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:19:52 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:19:52 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 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 - 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:52 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:52 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:52 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:52 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:53 INFO - Downloaded 24424699 bytes. 01:19:53 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:53 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:54 INFO - Return code: 0 01:19:54 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:54 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:54 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:54 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:54 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:54 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:54 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:58 INFO - Downloaded 24424699 bytes. 01:19:58 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:58 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:59 INFO - Return code: 0 01:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:59 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:59 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:59 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:59 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:59 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:20:00 INFO - Downloaded 10833369 bytes. 01:20:00 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:20:00 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:20:00 INFO - Return code: 0 01:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:00 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:20:00 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:20:00 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:20:00 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:20:00 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:20:02 INFO - Downloaded 59144183 bytes. 01:20:02 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:20:02 INFO - mkdir: /builds/slave/test/properties 01:20:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:20:02 INFO - Writing to file /builds/slave/test/properties/build_url 01:20:02 INFO - Contents: 01:20:02 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:20:03 INFO - Running post-action listener: _resource_record_post_action 01:20:03 INFO - Running post-action listener: set_extra_try_arguments 01:20:03 INFO - ##### 01:20:03 INFO - ##### Finished download-and-extract step (success) 01:20:03 INFO - ##### 01:20:03 INFO - ##### 01:20:03 INFO - ##### Running populate-webroot step. 01:20:03 INFO - ##### 01:20:03 INFO - Running pre-action listener: _resource_record_pre_action 01:20:03 INFO - Running main action method: populate_webroot 01:20:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:20:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:20:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:20:03 INFO - '--tppagecycles', 01:20:03 INFO - '7'], 01:20:03 INFO - 'tests': ['tsvgm']}}, 01:20:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:20:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:20:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:20:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:20:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:20:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:20:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:20:03 INFO - 'talos_options': ['--disable-e10s'], 01:20:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:20:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:20:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:20:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:20:03 INFO - 'talos_options': ['--disable-e10s'], 01:20:03 INFO - 'tests': ['damp', 'tps']}, 01:20:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:20:03 INFO - 'tests': ['damp', 'tps']}, 01:20:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:20:03 INFO - 'tests': ['dromaeo_dom']}, 01:20:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:20:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:20:03 INFO - 'tests': ['a11yr', 01:20:03 INFO - 'ts_paint', 01:20:03 INFO - 'tpaint', 01:20:03 INFO - 'sessionrestore', 01:20:03 INFO - 'sessionrestore_no_auto_restore', 01:20:03 INFO - 'tabpaint']}, 01:20:03 INFO - 'other-e10s': {'tests': ['a11yr', 01:20:03 INFO - 'ts_paint', 01:20:03 INFO - 'tpaint', 01:20:03 INFO - 'sessionrestore', 01:20:03 INFO - 'sessionrestore_no_auto_restore', 01:20:03 INFO - 'tabpaint']}, 01:20:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:20:03 INFO - 'ts_paint', 01:20:03 INFO - 'tpaint', 01:20:03 INFO - 'sessionrestore', 01:20:03 INFO - 'sessionrestore_no_auto_restore', 01:20:03 INFO - 'tabpaint']}, 01:20:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:20:03 INFO - 'ts_paint', 01:20:03 INFO - 'tpaint', 01:20:03 INFO - 'sessionrestore', 01:20:03 INFO - 'sessionrestore_no_auto_restore', 01:20:03 INFO - 'tabpaint']}, 01:20:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:20:03 INFO - 'tests': ['a11yr', 01:20:03 INFO - 'ts_paint', 01:20:03 INFO - 'tpaint', 01:20:03 INFO - 'sessionrestore', 01:20:03 INFO - 'sessionrestore_no_auto_restore', 01:20:03 INFO - 'tabpaint']}, 01:20:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:20:03 INFO - 'tests': ['a11yr', 01:20:03 INFO - 'ts_paint', 01:20:03 INFO - 'tpaint', 01:20:03 INFO - 'sessionrestore', 01:20:03 INFO - 'sessionrestore_no_auto_restore', 01:20:03 INFO - 'tabpaint']}, 01:20:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:20:03 INFO - 'tests': ['tsvgx', 01:20:03 INFO - 'tsvgr_opacity', 01:20:03 INFO - 'tart', 01:20:03 INFO - 'tscrollx', 01:20:03 INFO - 'cart']}, 01:20:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:20:03 INFO - 'tsvgr_opacity', 01:20:03 INFO - 'tart', 01:20:03 INFO - 'tscrollx', 01:20:03 INFO - 'cart']}, 01:20:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:20:03 INFO - 'talos_options': ['--disable-e10s'], 01:20:03 INFO - 'tests': ['tp5o']}, 01:20:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:20:03 INFO - 'tests': ['tp5o']}, 01:20:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:20:03 INFO - 'talos_options': ['--disable-e10s', 01:20:03 INFO - '--xperf_path', 01:20:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:20:03 INFO - 'tests': ['tp5n']}, 01:20:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:20:03 INFO - 'talos_options': ['--xperf_path', 01:20:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:20:03 INFO - 'tests': ['tp5n']}}, 01:20:03 INFO - 'talos.zip': {'path': '', 01:20:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:20:03 INFO - Running post-action listener: _resource_record_post_action 01:20:03 INFO - ##### 01:20:03 INFO - ##### Finished populate-webroot step (success) 01:20:03 INFO - ##### 01:20:03 INFO - ##### 01:20:03 INFO - ##### Running create-virtualenv step. 01:20:03 INFO - ##### 01:20:03 INFO - Running pre-action listener: _resource_record_pre_action 01:20:03 INFO - Running main action method: create_virtualenv 01:20:03 INFO - Creating virtualenv /builds/slave/test/build/venv 01:20:03 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:20:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:20:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:20:03 INFO - Using real prefix '/usr' 01:20:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:20:03 INFO - Installing distribute.............................................................................................................................................................................................done. 01:20:05 INFO - Installing pip.................done. 01:20:05 INFO - Return code: 0 01:20:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:20:05 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:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:05 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:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:05 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 0x7fa907140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a3450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a322c0>, '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 0x2a331c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a33650>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', '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:20:05 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:20:05 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:20:05 INFO - Using env: {'DISPLAY': ':0', 01:20:05 INFO - 'HOME': '/home/cltbld', 01:20:05 INFO - 'LANG': 'en_US.UTF-8', 01:20:05 INFO - 'LANGUAGE': 'en_US:en', 01:20:05 INFO - 'LOGNAME': 'cltbld', 01:20:05 INFO - 'MAIL': '/var/mail/cltbld', 01:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:05 INFO - 'MOZ_NO_REMOTE': '1', 01:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:05 INFO - 'NO_EM_RESTART': '1', 01:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:20:05 INFO - 'PWD': '/builds/slave/test', 01:20:05 INFO - 'SHELL': '/bin/bash', 01:20:05 INFO - 'SHLVL': '1', 01:20:05 INFO - 'TERM': 'linux', 01:20:05 INFO - 'TMOUT': '86400', 01:20:05 INFO - 'USER': 'cltbld', 01:20:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', 01:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:05 INFO - '_': '/tools/buildbot/bin/python'} 01:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:06 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:20:06 INFO - Cleaning up... 01:20:06 INFO - Return code: 0 01:20:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa907140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a3450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a322c0>, '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 0x2a331c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a33650>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', '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:20:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:20:06 INFO - Using env: {'DISPLAY': ':0', 01:20:06 INFO - 'HOME': '/home/cltbld', 01:20:06 INFO - 'LANG': 'en_US.UTF-8', 01:20:06 INFO - 'LANGUAGE': 'en_US:en', 01:20:06 INFO - 'LOGNAME': 'cltbld', 01:20:06 INFO - 'MAIL': '/var/mail/cltbld', 01:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:06 INFO - 'MOZ_NO_REMOTE': '1', 01:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:06 INFO - 'NO_EM_RESTART': '1', 01:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:20:06 INFO - 'PWD': '/builds/slave/test', 01:20:06 INFO - 'SHELL': '/bin/bash', 01:20:06 INFO - 'SHLVL': '1', 01:20:06 INFO - 'TERM': 'linux', 01:20:06 INFO - 'TMOUT': '86400', 01:20:06 INFO - 'USER': 'cltbld', 01:20:06 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', 01:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:06 INFO - '_': '/tools/buildbot/bin/python'} 01:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:06 INFO - Downloading/unpacking psutil>=3.1.1 01:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:20:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:20:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:20:08 INFO - Installing collected packages: psutil 01:20:08 INFO - Running setup.py install for psutil 01:20:08 INFO - building 'psutil._psutil_linux' extension 01:20:08 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:20:08 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:20:08 INFO - building 'psutil._psutil_posix' extension 01:20:08 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:20:08 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:20:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:20:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:20:08 INFO - Successfully installed psutil 01:20:08 INFO - Cleaning up... 01:20:08 INFO - Return code: 0 01:20:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:20:08 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:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:08 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:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:08 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 0x7fa907140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a3450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a322c0>, '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 0x2a331c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a33650>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', '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:20:08 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:20:08 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:20:08 INFO - Using env: {'DISPLAY': ':0', 01:20:08 INFO - 'HOME': '/home/cltbld', 01:20:08 INFO - 'LANG': 'en_US.UTF-8', 01:20:08 INFO - 'LANGUAGE': 'en_US:en', 01:20:08 INFO - 'LOGNAME': 'cltbld', 01:20:08 INFO - 'MAIL': '/var/mail/cltbld', 01:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:08 INFO - 'MOZ_NO_REMOTE': '1', 01:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:08 INFO - 'NO_EM_RESTART': '1', 01:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:20:08 INFO - 'PWD': '/builds/slave/test', 01:20:08 INFO - 'SHELL': '/bin/bash', 01:20:08 INFO - 'SHLVL': '1', 01:20:08 INFO - 'TERM': 'linux', 01:20:08 INFO - 'TMOUT': '86400', 01:20:08 INFO - 'USER': 'cltbld', 01:20:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', 01:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:08 INFO - '_': '/tools/buildbot/bin/python'} 01:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:20:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:20:10 INFO - Installing collected packages: mozsystemmonitor 01:20:10 INFO - Running setup.py install for mozsystemmonitor 01:20:11 INFO - Successfully installed mozsystemmonitor 01:20:11 INFO - Cleaning up... 01:20:11 INFO - Return code: 0 01:20:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:20:11 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:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:11 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:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:11 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 0x7fa907140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a3450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a322c0>, '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 0x2a331c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a33650>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', '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:20:11 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:20:11 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:20:11 INFO - Using env: {'DISPLAY': ':0', 01:20:11 INFO - 'HOME': '/home/cltbld', 01:20:11 INFO - 'LANG': 'en_US.UTF-8', 01:20:11 INFO - 'LANGUAGE': 'en_US:en', 01:20:11 INFO - 'LOGNAME': 'cltbld', 01:20:11 INFO - 'MAIL': '/var/mail/cltbld', 01:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:11 INFO - 'MOZ_NO_REMOTE': '1', 01:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:11 INFO - 'NO_EM_RESTART': '1', 01:20:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:20:11 INFO - 'PWD': '/builds/slave/test', 01:20:11 INFO - 'SHELL': '/bin/bash', 01:20:11 INFO - 'SHLVL': '1', 01:20:11 INFO - 'TERM': 'linux', 01:20:11 INFO - 'TMOUT': '86400', 01:20:11 INFO - 'USER': 'cltbld', 01:20:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', 01:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:11 INFO - '_': '/tools/buildbot/bin/python'} 01:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:11 INFO - Downloading/unpacking jsonschema==2.5.1 01:20:11 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:20:11 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:20:11 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:20:11 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:20:11 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:20:11 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:20:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:20:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:20:13 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:20:13 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:20:13 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:20:13 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:20:13 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:20:13 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:20:13 INFO - Downloading functools32-3.2.3-2.tar.gz 01:20:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:20:13 INFO - warning: no files found matching '*.txt' 01:20:13 INFO - no previously-included directories found matching 'build' 01:20:13 INFO - no previously-included directories found matching 'dist' 01:20:13 INFO - no previously-included directories found matching '.git*' 01:20:13 INFO - Installing collected packages: jsonschema, functools32 01:20:13 INFO - Running setup.py install for functools32 01:20:13 INFO - warning: no files found matching '*.txt' 01:20:13 INFO - no previously-included directories found matching 'build' 01:20:13 INFO - no previously-included directories found matching 'dist' 01:20:13 INFO - no previously-included directories found matching '.git*' 01:20:13 INFO - Successfully installed jsonschema functools32 01:20:13 INFO - Cleaning up... 01:20:13 INFO - Return code: 0 01:20:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:13 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 0x7fa907140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a3450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a322c0>, '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 0x2a331c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a33650>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', '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:20:13 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:20:13 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:20:13 INFO - Using env: {'DISPLAY': ':0', 01:20:13 INFO - 'HOME': '/home/cltbld', 01:20:13 INFO - 'LANG': 'en_US.UTF-8', 01:20:13 INFO - 'LANGUAGE': 'en_US:en', 01:20:13 INFO - 'LOGNAME': 'cltbld', 01:20:13 INFO - 'MAIL': '/var/mail/cltbld', 01:20:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:13 INFO - 'MOZ_NO_REMOTE': '1', 01:20:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:13 INFO - 'NO_EM_RESTART': '1', 01:20:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:20:13 INFO - 'PWD': '/builds/slave/test', 01:20:13 INFO - 'SHELL': '/bin/bash', 01:20:13 INFO - 'SHLVL': '1', 01:20:13 INFO - 'TERM': 'linux', 01:20:13 INFO - 'TMOUT': '86400', 01:20:13 INFO - 'USER': 'cltbld', 01:20:13 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', 01:20:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:13 INFO - '_': '/tools/buildbot/bin/python'} 01:20:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:13 INFO - Downloading/unpacking blobuploader==1.2.4 01:20:13 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:20:13 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:20:13 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:20:13 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:20:13 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:20:13 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:20:15 INFO - Downloading blobuploader-1.2.4.tar.gz 01:20:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:20:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:20:15 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:20:15 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:20:15 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:20:15 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:20:15 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:20:15 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:20:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:20:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:16 INFO - Downloading docopt-0.6.1.tar.gz 01:20:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:20:16 INFO - Installing collected packages: blobuploader, requests, docopt 01:20:16 INFO - Running setup.py install for blobuploader 01:20:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:20:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:20:16 INFO - Running setup.py install for requests 01:20:16 INFO - Running setup.py install for docopt 01:20:17 INFO - Successfully installed blobuploader requests docopt 01:20:17 INFO - Cleaning up... 01:20:17 INFO - Return code: 0 01:20:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:17 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 0x7fa907140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a3450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a322c0>, '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 0x2a331c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a33650>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', '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:20:17 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:20:17 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:20:17 INFO - Using env: {'DISPLAY': ':0', 01:20:17 INFO - 'HOME': '/home/cltbld', 01:20:17 INFO - 'LANG': 'en_US.UTF-8', 01:20:17 INFO - 'LANGUAGE': 'en_US:en', 01:20:17 INFO - 'LOGNAME': 'cltbld', 01:20:17 INFO - 'MAIL': '/var/mail/cltbld', 01:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:17 INFO - 'MOZ_NO_REMOTE': '1', 01:20:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:17 INFO - 'NO_EM_RESTART': '1', 01:20:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:20:17 INFO - 'PWD': '/builds/slave/test', 01:20:17 INFO - 'SHELL': '/bin/bash', 01:20:17 INFO - 'SHLVL': '1', 01:20:17 INFO - 'TERM': 'linux', 01:20:17 INFO - 'TMOUT': '86400', 01:20:17 INFO - 'USER': 'cltbld', 01:20:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', 01:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:17 INFO - '_': '/tools/buildbot/bin/python'} 01:20:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:20:17 INFO - Running setup.py (path:/tmp/pip-F6QgRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:20:17 INFO - Running setup.py (path:/tmp/pip-H8CAeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:20:17 INFO - Running setup.py (path:/tmp/pip-Mi_8PI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:20:17 INFO - Running setup.py (path:/tmp/pip-M9H_Tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:20:17 INFO - Running setup.py (path:/tmp/pip-WS65Lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:20:17 INFO - Running setup.py (path:/tmp/pip-MAlSvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:20:17 INFO - Running setup.py (path:/tmp/pip-ctBtNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:20:17 INFO - Running setup.py (path:/tmp/pip-_Qf8Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:20:17 INFO - Running setup.py (path:/tmp/pip-xs9yGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:20:18 INFO - Running setup.py (path:/tmp/pip-pchVf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:20:18 INFO - Running setup.py (path:/tmp/pip-hvpST2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:20:18 INFO - Running setup.py (path:/tmp/pip-1VJ_RJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:20:18 INFO - Running setup.py (path:/tmp/pip-5oLaBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:20:18 INFO - Running setup.py (path:/tmp/pip-6lqCHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:20:18 INFO - Running setup.py (path:/tmp/pip-Y33r1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:20:18 INFO - Running setup.py (path:/tmp/pip-XbjDfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:20:18 INFO - Running setup.py (path:/tmp/pip-U5eIxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:20:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:20:18 INFO - Running setup.py install for manifestparser 01:20:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:20:18 INFO - Running setup.py install for mozcrash 01:20:18 INFO - Running setup.py install for mozdebug 01:20:18 INFO - Running setup.py install for mozdevice 01:20:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:20:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:20:19 INFO - Running setup.py install for mozfile 01:20:19 INFO - Running setup.py install for mozhttpd 01:20:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:20:19 INFO - Running setup.py install for mozinfo 01:20:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:20:19 INFO - Running setup.py install for mozInstall 01:20:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:20:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:20:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:20:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:20:19 INFO - Running setup.py install for mozleak 01:20:19 INFO - Running setup.py install for mozlog 01:20:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:20:19 INFO - Running setup.py install for moznetwork 01:20:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:20:19 INFO - Running setup.py install for mozprocess 01:20:19 INFO - Running setup.py install for mozprofile 01:20:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:20:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:20:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:20:19 INFO - Running setup.py install for mozrunner 01:20:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:20:20 INFO - Running setup.py install for mozscreenshot 01:20:20 INFO - Running setup.py install for moztest 01:20:20 INFO - Running setup.py install for mozversion 01:20:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:20:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:20:20 INFO - Cleaning up... 01:20:20 INFO - Return code: 0 01:20:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:20 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 0x7fa907140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a3450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a322c0>, '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 0x2a331c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a33650>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', '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:20:20 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:20:20 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:20:20 INFO - Using env: {'DISPLAY': ':0', 01:20:20 INFO - 'HOME': '/home/cltbld', 01:20:20 INFO - 'LANG': 'en_US.UTF-8', 01:20:20 INFO - 'LANGUAGE': 'en_US:en', 01:20:20 INFO - 'LOGNAME': 'cltbld', 01:20:20 INFO - 'MAIL': '/var/mail/cltbld', 01:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:20 INFO - 'MOZ_NO_REMOTE': '1', 01:20:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:20 INFO - 'NO_EM_RESTART': '1', 01:20:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:20:20 INFO - 'PWD': '/builds/slave/test', 01:20:20 INFO - 'SHELL': '/bin/bash', 01:20:20 INFO - 'SHLVL': '1', 01:20:20 INFO - 'TERM': 'linux', 01:20:20 INFO - 'TMOUT': '86400', 01:20:20 INFO - 'USER': 'cltbld', 01:20:20 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', 01:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:20 INFO - '_': '/tools/buildbot/bin/python'} 01:20:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:20:20 INFO - Running setup.py (path:/tmp/pip-fQPR2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:20:20 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:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:20:20 INFO - Running setup.py (path:/tmp/pip-NqnDf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:20:20 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:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:20:20 INFO - Running setup.py (path:/tmp/pip-A6gIbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:20:20 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:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:20:20 INFO - Running setup.py (path:/tmp/pip-ZKVC6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:20:20 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:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:20:20 INFO - Running setup.py (path:/tmp/pip-k6j88x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:20:20 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:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:20:20 INFO - Running setup.py (path:/tmp/pip-7xsNmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:20:21 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:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:20:21 INFO - Running setup.py (path:/tmp/pip-q4CkQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:20:21 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:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:20:21 INFO - Running setup.py (path:/tmp/pip-ynQwaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:20:21 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:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:20:21 INFO - Running setup.py (path:/tmp/pip-RTw8h8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:20:21 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:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:20:21 INFO - Running setup.py (path:/tmp/pip-NuptBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:20:21 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:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:20:21 INFO - Running setup.py (path:/tmp/pip-yh8gVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:20:21 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:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:20:21 INFO - Running setup.py (path:/tmp/pip-R6J9AK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:20:21 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:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:20:21 INFO - Running setup.py (path:/tmp/pip-ygaZMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:20:21 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:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:20:21 INFO - Running setup.py (path:/tmp/pip-7a0mLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:20:21 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:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:20:21 INFO - Running setup.py (path:/tmp/pip-tH0fKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:20:21 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:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:20:21 INFO - Running setup.py (path:/tmp/pip-VWvnoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:20:21 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:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:20:21 INFO - Running setup.py (path:/tmp/pip-nbWsaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:20:21 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:20:21 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:20:21 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:20:21 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:20:21 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:20:21 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:20:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:20:21 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:20:21 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:20:21 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:20:21 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:20:21 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:20:21 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:20:23 INFO - Downloading blessings-1.6.tar.gz 01:20:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:20:23 INFO - Installing collected packages: blessings 01:20:23 INFO - Running setup.py install for blessings 01:20:23 INFO - Successfully installed blessings 01:20:23 INFO - Cleaning up... 01:20:23 INFO - Return code: 0 01:20:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:20:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:20:24 INFO - Reading from file tmpfile_stdout 01:20:24 INFO - Current package versions: 01:20:24 INFO - argparse == 1.2.1 01:20:24 INFO - blessings == 1.6 01:20:24 INFO - blobuploader == 1.2.4 01:20:24 INFO - docopt == 0.6.1 01:20:24 INFO - functools32 == 3.2.3-2 01:20:24 INFO - jsonschema == 2.5.1 01:20:24 INFO - manifestparser == 1.1 01:20:24 INFO - mozInstall == 1.12 01:20:24 INFO - mozcrash == 0.17 01:20:24 INFO - mozdebug == 0.1 01:20:24 INFO - mozdevice == 0.48 01:20:24 INFO - mozfile == 1.2 01:20:24 INFO - mozhttpd == 0.7 01:20:24 INFO - mozinfo == 0.9 01:20:24 INFO - mozleak == 0.1 01:20:24 INFO - mozlog == 3.2 01:20:24 INFO - moznetwork == 0.27 01:20:24 INFO - mozprocess == 0.22 01:20:24 INFO - mozprofile == 0.28 01:20:24 INFO - mozrunner == 6.11 01:20:24 INFO - mozscreenshot == 0.1 01:20:24 INFO - mozsystemmonitor == 0.3 01:20:24 INFO - moztest == 0.7 01:20:24 INFO - mozversion == 1.4 01:20:24 INFO - psutil == 3.1.1 01:20:24 INFO - requests == 1.2.3 01:20:24 INFO - wsgiref == 0.1.2 01:20:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:24 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 0x7fa907140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a3450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a322c0>, '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 0x2a331c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a33650>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', '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:20:24 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:20:24 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:20:24 INFO - Using env: {'DISPLAY': ':0', 01:20:24 INFO - 'HOME': '/home/cltbld', 01:20:24 INFO - 'LANG': 'en_US.UTF-8', 01:20:24 INFO - 'LANGUAGE': 'en_US:en', 01:20:24 INFO - 'LOGNAME': 'cltbld', 01:20:24 INFO - 'MAIL': '/var/mail/cltbld', 01:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:24 INFO - 'MOZ_NO_REMOTE': '1', 01:20:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:24 INFO - 'NO_EM_RESTART': '1', 01:20:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:20:24 INFO - 'PWD': '/builds/slave/test', 01:20:24 INFO - 'SHELL': '/bin/bash', 01:20:24 INFO - 'SHLVL': '1', 01:20:24 INFO - 'TERM': 'linux', 01:20:24 INFO - 'TMOUT': '86400', 01:20:24 INFO - 'USER': 'cltbld', 01:20:24 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', 01:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:24 INFO - '_': '/tools/buildbot/bin/python'} 01:20:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:24 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:20:24 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:20:24 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:20:24 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:20:24 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:20:24 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:20:24 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:20:24 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:20:24 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:20:24 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:20:24 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:20:24 INFO - Cleaning up... 01:20:24 INFO - Return code: 0 01:20:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:24 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 0x7fa907140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a3450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a322c0>, '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 0x2a331c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a33650>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', '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:20:24 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:20:24 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:20:24 INFO - Using env: {'DISPLAY': ':0', 01:20:24 INFO - 'HOME': '/home/cltbld', 01:20:24 INFO - 'LANG': 'en_US.UTF-8', 01:20:24 INFO - 'LANGUAGE': 'en_US:en', 01:20:24 INFO - 'LOGNAME': 'cltbld', 01:20:24 INFO - 'MAIL': '/var/mail/cltbld', 01:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:24 INFO - 'MOZ_NO_REMOTE': '1', 01:20:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:24 INFO - 'NO_EM_RESTART': '1', 01:20:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:20:24 INFO - 'PWD': '/builds/slave/test', 01:20:24 INFO - 'SHELL': '/bin/bash', 01:20:24 INFO - 'SHLVL': '1', 01:20:24 INFO - 'TERM': 'linux', 01:20:24 INFO - 'TMOUT': '86400', 01:20:24 INFO - 'USER': 'cltbld', 01:20:24 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', 01:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:24 INFO - '_': '/tools/buildbot/bin/python'} 01:20:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:20:24 INFO - Cleaning up... 01:20:24 INFO - Return code: 0 01:20:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:24 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 0x7fa907140f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a3450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a322c0>, '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 0x2a331c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a33650>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', '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:20:24 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:20:24 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:20:24 INFO - Using env: {'DISPLAY': ':0', 01:20:24 INFO - 'HOME': '/home/cltbld', 01:20:24 INFO - 'LANG': 'en_US.UTF-8', 01:20:24 INFO - 'LANGUAGE': 'en_US:en', 01:20:24 INFO - 'LOGNAME': 'cltbld', 01:20:24 INFO - 'MAIL': '/var/mail/cltbld', 01:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:24 INFO - 'MOZ_NO_REMOTE': '1', 01:20:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:24 INFO - 'NO_EM_RESTART': '1', 01:20:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:20:24 INFO - 'PWD': '/builds/slave/test', 01:20:24 INFO - 'SHELL': '/bin/bash', 01:20:24 INFO - 'SHLVL': '1', 01:20:24 INFO - 'TERM': 'linux', 01:20:24 INFO - 'TMOUT': '86400', 01:20:24 INFO - 'USER': 'cltbld', 01:20:24 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', 01:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:24 INFO - '_': '/tools/buildbot/bin/python'} 01:20:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:24 INFO - Downloading/unpacking flake8 01:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:20:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:20:26 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:20:26 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:20:26 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:20:26 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:20:26 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:20:26 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:20:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:20:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:20:26 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:20:26 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:20:26 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:20:26 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:20:26 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:20:26 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:20:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:20:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:20:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:20:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:20:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:20:27 INFO - no previously-included directories found matching 'docs/_build' 01:20:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:20:27 INFO - Running setup.py install for pep8 01:20:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:20:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:20:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:20:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:20:27 INFO - no previously-included directories found matching 'docs/_build' 01:20:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:20:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:20:27 INFO - Cleaning up... 01:20:27 INFO - Return code: 0 01:20:27 INFO - Running post-action listener: _resource_record_post_action 01:20:27 INFO - Running post-action listener: _start_resource_monitoring 01:20:27 INFO - Starting resource monitoring. 01:20:27 INFO - ##### 01:20:27 INFO - ##### Finished create-virtualenv step (success) 01:20:27 INFO - ##### 01:20:27 INFO - ##### 01:20:27 INFO - ##### Running install step. 01:20:27 INFO - ##### 01:20:27 INFO - Running pre-action listener: _resource_record_pre_action 01:20:27 INFO - Running main action method: install 01:20:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:20:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:20:27 INFO - Reading from file tmpfile_stdout 01:20:27 INFO - Detecting whether we're running mozinstall >=1.0... 01:20:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:20:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:20:28 INFO - Reading from file tmpfile_stdout 01:20:28 INFO - Output received: 01:20:28 INFO - Usage: mozinstall [options] installer 01:20:28 INFO - Options: 01:20:28 INFO - -h, --help show this help message and exit 01:20:28 INFO - -d DEST, --destination=DEST 01:20:28 INFO - Directory to install application into. [default: 01:20:28 INFO - "/builds/slave/test"] 01:20:28 INFO - --app=APP Application being installed. [default: firefox] 01:20:28 INFO - mkdir: /builds/slave/test/build/application 01:20:28 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:20:28 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:44 INFO - Reading from file tmpfile_stdout 01:20:44 INFO - Output received: 01:20:44 INFO - /builds/slave/test/build/application/firefox/firefox 01:20:44 INFO - Running post-action listener: _resource_record_post_action 01:20:44 INFO - ##### 01:20:44 INFO - ##### Finished install step (success) 01:20:44 INFO - ##### 01:20:44 INFO - ##### 01:20:44 INFO - ##### Running run-tests step. 01:20:44 INFO - ##### 01:20:44 INFO - Running pre-action listener: _resource_record_pre_action 01:20:44 INFO - Running main action method: run_tests 01:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:20:44 INFO - Python 2.7.3 01:20:44 INFO - Return code: 0 01:20:44 INFO - grabbing minidump binary from tooltool 01:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:44 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 0x2a322c0>, '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 0x2a331c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a33650>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:20:44 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:44 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:44 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:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:20:44 INFO - Return code: 0 01:20:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:20:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:20:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:20:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:20:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:20:45 INFO - Return code: 0 01:20:45 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', '--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-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:20:45 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 --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-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:20:45 INFO - Using env: {'DISPLAY': ':0', 01:20:45 INFO - 'HOME': '/home/cltbld', 01:20:45 INFO - 'LANG': 'en_US.UTF-8', 01:20:45 INFO - 'LANGUAGE': 'en_US:en', 01:20:45 INFO - 'LOGNAME': 'cltbld', 01:20:45 INFO - 'MAIL': '/var/mail/cltbld', 01:20:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:20:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:45 INFO - 'MOZ_NO_REMOTE': '1', 01:20:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:20:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:45 INFO - 'NO_EM_RESTART': '1', 01:20:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:20:45 INFO - 'PWD': '/builds/slave/test', 01:20:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:20:45 INFO - 'SHELL': '/bin/bash', 01:20:45 INFO - 'SHLVL': '1', 01:20:45 INFO - 'TERM': 'linux', 01:20:45 INFO - 'TMOUT': '86400', 01:20:45 INFO - 'USER': 'cltbld', 01:20:45 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704', 01:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:45 INFO - '_': '/tools/buildbot/bin/python'} 01:20:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--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-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:20:46 INFO - mozversion application_buildid: 20160602223101 01:20:46 INFO - mozversion application_changeset: 8b89d98ce322f0c68538db7837cd7eb749d1ed1c 01:20:46 INFO - mozversion application_display_name: Nightly 01:20:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:20:46 INFO - mozversion application_name: Firefox 01:20:46 INFO - mozversion application_remotingname: firefox 01:20:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:20:46 INFO - mozversion application_vendor: Mozilla 01:20:46 INFO - mozversion application_version: 49.0a1 01:20:46 INFO - mozversion platform_buildid: 20160602223101 01:20:46 INFO - mozversion platform_changeset: 8b89d98ce322f0c68538db7837cd7eb749d1ed1c 01:20:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:20:46 INFO - mozversion platform_version: 49.0a1 01:20:46 INFO - using testdate: 1464942046 01:20:46 INFO - actual date: 1464942046 01:20:46 INFO - starting webserver on 'localhost:41999' 01:20:46 INFO - SUITE-START | Running 2 tests 01:20:46 INFO - TEST-START | dromaeo_css 01:20:46 INFO - operating with platform_type : linux_ 01:20:46 INFO - Initialising browser for dromaeo_css test... 01:20:46 INFO - TEST-INFO | started process 30343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXhkvwW/profile http://localhost:41999/getInfo.html) 01:20:49 INFO - PROCESS | 30343 | __metrics Screen width/height:1600/1200 01:20:49 INFO - PROCESS | 30343 | colorDepth:24 01:20:49 INFO - PROCESS | 30343 | Browser inner width/height: 1024/697 01:20:49 INFO - PROCESS | 30343 | __metrics 01:20:50 ERROR - PROCESS | 30343 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:20:50 INFO - TEST-INFO | 30343: exit 0 01:20:50 INFO - Browser initialized. 01:20:50 INFO - Running cycle 1/1 for dromaeo_css test... 01:20:50 INFO - TEST-INFO | started process 30428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXhkvwW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:21:02 INFO - PROCESS | 30428 | RSS: Main: 155590656 01:21:02 INFO - PROCESS | 30428 | 01:21:53 INFO - PROCESS | 30428 | 1464942113949 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:24:01 INFO - PROCESS | 30428 | Cycle 1(1): loaded http://localhost:41999/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41999/tests/dromaeo/cssquery-ext.html) 01:24:02 INFO - PROCESS | 30428 | RSS: Main: 247652352 01:24:02 INFO - PROCESS | 30428 | 01:27:04 INFO - PROCESS | 30428 | Cycle 1(1): loaded http://localhost:41999/tests/dromaeo/cssquery-ext.html (next: http://localhost:41999/tests/dromaeo/cssquery-jquery.html) 01:27:05 INFO - PROCESS | 30428 | RSS: Main: 248233984 01:27:05 INFO - PROCESS | 30428 | 01:30:07 INFO - PROCESS | 30428 | Cycle 1(1): loaded http://localhost:41999/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41999/tests/dromaeo/cssquery-mootools.html) 01:30:08 INFO - PROCESS | 30428 | RSS: Main: 253337600 01:30:08 INFO - PROCESS | 30428 | 01:33:10 INFO - PROCESS | 30428 | Cycle 1(1): loaded http://localhost:41999/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41999/tests/dromaeo/cssquery-prototype.html) 01:33:10 INFO - PROCESS | 30428 | RSS: Main: 243634176 01:33:10 INFO - PROCESS | 30428 | 01:36:13 INFO - PROCESS | 30428 | Cycle 1(1): loaded http://localhost:41999/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41999/tests/dromaeo/cssquery-yui.html) 01:36:14 INFO - PROCESS | 30428 | RSS: Main: 215609344 01:36:14 INFO - PROCESS | 30428 | 01:39:16 INFO - PROCESS | 30428 | Cycle 1(1): loaded http://localhost:41999/tests/dromaeo/cssquery-yui.html (next: http://localhost:41999/tests/dromaeo/cssquery-dojo.html) 01:39:17 INFO - PROCESS | 30428 | RSS: Main: 313851904 01:39:17 INFO - PROCESS | 30428 | 01:39:17 INFO - PROCESS | 30428 | __start_tp_report 01:39:17 INFO - PROCESS | 30428 | _x_x_mozilla_page_load 01:39:17 INFO - PROCESS | 30428 | _x_x_mozilla_page_load_details 01:39:17 INFO - PROCESS | 30428 | |i|pagename|runs| 01:39:17 INFO - PROCESS | 30428 | |0;dojo.html;3082.5530298106787;3086.7684923630727;3104.0532637545552;3126.8123912565234;3134.921626959327;5359.410464848864;5404.783808647654;5434.456554344563;5541.307336582927;5551.306086739162;5450.236966824637;5473.343198816137;5493.862653433666;5534.806281780128;5580.525655319303;4934.161192597258;5033.798648054073;5045.318881950926;5049.040682270357;5182.740862956856;5085.0338435697095;5106.234064890259;5137.101007323722;5147.613928955343;5154.201098829687;4919.237518184687;4939.678920870132;4967.403911530621;4997.875053123701;5027.773750181251;4990.326305948687;5042.924356134661;5061.190209566452;5067.974660126676;5107.106256405114;5018.924716129261;5024.296598476216;5051.469595692436;5056.317397151374;5065.518775716338;5318.042752304584;5380.78476860929;5381.219723140122;5465.808696695636;5473.425290344497;5946.256717910262;5947.345791962881;5960.552958528127;5971.671558064305;5984.8503787405225;5955.970220148872;5970.04479283317;6010.729517171738;6016;6023.668698221596;5414.7834086636485;5434.456554344534;5527.032769265363;5530.170474428827;5551.195076713854;6074.106485809174;6076.837366404027;6078.814980436019;6094.360092190256;6130.325664176937;5662.980663480613;5805.448482394166;5852.590318677651;5864.765409383577;5867.266591676041;5854.443827836349;5905.586608937419;5911.261092363455;5937.881242375129;5950;5866.325372582122;5903.852403689943;5907.1434641976675;5910.704464776744;5920.141579471038;5757.740901659436;5805.36141024487;5859.414058594107;5918.496927761188;5933.2286802716235;4443.266860967904;4444.711093778894;4447.710898791568;4483.641308695362;4486.484054333728;3941.2117576484816;3955.3275943089743;3957.3074711925874;3970.6426421621613;3997.1006523532556;5445.319335083114;5487.890242195213;5508.366537848118;5558.666480011212;5623.072193088176;5916.26046744157;5932.525397968152;5951.4941229995065;5967.791127310524;6019.849503762353;5604.803831865946;5613.158026296088;5616;5617.662940223599;5619.7471113799975;4955.4548999610015;4966.056449274626;4999.325091112726;5089.389273287229;5090.745462726849;6092.878142437126;6100.450959413585;6102.603330783573;6103.3591472894705;6142.877142457126;5880.029795083763;5886.205362276038;5890.410958904075;5912.172295878494;5925.348211696796;5930.318013428511;6036.698165091816;6058.3335833057445;6076.058210977306;6122.510199184144;5740.856478588069;5790.913136302875;5791;5800.332961709458;5803.448672376117;5837.182794408701;5890.793822216202;5923;5923.703814809329;5929.436703513159;5623.606347555632;5741.913871292018;5769.769209231584;5792.160136780059;5811.883762324815;5694.943050569441;5743.770249190153;5753.5109515689965;5756.194132821324;5770.163326317745;5492.80775172867;5671.574631902707;5680.375158732453;5680.573956953328;5685.658860468385;5673.914891276551;5689.231953686365;5712.7714891403875;5796.507296879644;5802.883942321215;5613.578981576316;5616.66300022;5618.438156184349;5618.943810561842;5668.26312579362 01:39:17 INFO - PROCESS | 30428 | |1;ext.html;622.8100429369042;639.7153266796274;645.2063961327569;648.6951132967506;660.0000998487293;30366.089017329487;43165.136697266076;43509.78245108774;44271.77864110683;48042;44586;45163.54836451635;45189;45205.54794452063;45214;8486.27866631337;8614.827703445928;8653.783655408633;8659.393842431033;8662.047174810767;8567.186117318875;8703.869441958375;8706.347023973196;8713.869291960626;8714.085021072791;8679.305655547541;8744.519051452167;8755.080716524768;8762.824743505125;8763.51800650964;8598.484090954562;8629.39594228398;8629.568521573896;8639.352048596349;8680.435771674822;8507.106753790888;8585.098564650683;8588.570571471402;8588.8711669325;8590;42145;42308;42463.78768106171;42596;42949.14101717948;3540.805255710935;3638.7816730996224;3690.6862916652117;3973.304671682473;4207.474065741782;32535.349293014246;32683.18292042694;33623.49564756531;33813.6618633813;34316;4263;4355.956440435619;4409.140217657558;4420.20436321462;4558.0655965526985;347791;351098.467045989;352080;353054.99999999744;353822;59467;59590.404095959355;59912.10131848026;59964.40035599588;59971.700141499015;63204.36795632077;63462.365376345646;63476;63522.6823865887;63561.68219158875;16295.103769292566;16525.83474165243;16551.337946482006;16553.917230413772;16561.17194140312;11882.76234475323;11906.642800715992;11912.166148369532;11926.522939082339;11931.761364772656;15991.360345586047;17307.56731081733;17418.56453588645;17430.47708568745;17547.824521754876;5507.614466987353;6395.296517383084;6408.1669382980845;6540.215174179129;6631.867362652816;999.7350702063959;1053.6206965492418;1066.664000839733;1099.087757161554;1132.6262333429947;32603.51094733581;32966.67033329684;33003.83498082542;33006;33291.83354083214;1132.971675708114;1168.6318809574957;1182.739797244622;1216.7870622641003;1239.0732411100644;16766.497005089866;17518.299268029135;17538.736918946226;17547.21037553313;17616.64766704659;589697;603324;603890;606859;608414;58706;59166.70416647889;59293.703531482926;59299.40700592939;59362;1304.8173255744202;1382.4815694114707;1416.4617445370693;1434.734574103794;1456.5411895252962;32762.83618581892;33943.490847636815;34477.31045379129;34542.48186277258;34644.48033279553;50121.49878501168;50813.23780143227;50821;50858.23712644239;50883;413727;424310;424651;425578;426398;37703;38094.42858357071;38797.2240555193;38829.805850970566;41605.167896641295;44237.77881110574;45018.3247251298;48371.5162848367;48521.75739121282;48880;40961.38557921574;41665;41778.79110604549;42425;42808.78595607002;41137;41382.172356552095;41447.171056579304;41869.1626167481;42226;41334.586654133076;41400.58599413967;41771.7911410441;41857.79071104625;42166;35608.82195589005;36586.8170659145;37745.62254377421;37929.241415172095;38259.80870095743;28205.15384538467;28292.292692682848;28690.85654571714;28930;29088.27279318034 01:39:17 INFO - PROCESS | 30428 | |2;jquery.html;388.5725701728101;389.75250715795477;392.68977507768864;400.39340399295065;416.539723605416;13390.074322704375;17428.912855435705;18206.08969551524;19931.800681993194;19936.202551897924;18100.4569862904;18656.906715466437;18872.528186795338;18938.905305473454;19029.429117126474;5718.714064296779;5858.502027327682;5866.589338746289;5874.5006674432725;5925.111233314994;4243.915121697564;5787.47912687858;5835.854103647422;6344.429001389874;6696.196456425211;6561.835954101138;6565.967170164166;6570.7844048850875;6585.0451684505715;6586.242582103047;6333.55665103443;6507.121538592277;6542.018697195411;6551.410373066399;6552.93447065528;4949.356583644103;5226.97386513065;5803.245578074823;5816.563757718146;5817.545613596601;13870.4451821927;14097.154170749685;14100.85899141016;15240;21518.462038449008;2152.989235053815;2245.5396643688005;2250.493638931244;2276.248837883511;2382.7736365045293;9476;13614.591562253148;14020.369083391271;14086.506972256024;14473.348699308557;1825.7261410788356;1868.252698920429;1893.602343507865;1956.1490751523133;1959.3827944197674;59644.701776491274;62835;68842.29046864032;73844;78783.6060819698;10567;10829.458527073615;11000.889991100146;11269.71825704364;11293.548258069584;15344.465553444566;15459.613509662124;15467.613309667347;15495.915285929877;15508.922455387876;7979.920200798034;8001.519908805491;8075.071366792894;8150.021997360236;8152.714654987047;7484.176740558534;7511.136219334737;7545.396368290633;7608.592410404093;7640.159582445926;4769.880752981203;4825.734584597881;4866.245731911559;4867.3915760529935;4916.827911023097;1938.92244310226;1981.5739615982634;1994.8108971160736;2017.8183963443066;2038.0930485933914;917.7613820406609;999.550202408919;1026.9743256418649;1047.7956798424386;1078.6494389323502;18639.66127714385;18998.43004709861;19118.139683714267;19364.32224872151;19515.609687806165;968.3512046928574;974.1345323705026;976.3751199232497;1060.4644654449453;1063.2929102146986;10434.530446129942;10833.349999000086;10975.50610222542;11007.669769906915;11027.17296202788;455395;459598;476293;477668;482199;70873.29126708666;81450.18549814426;93514;96577.5171124154;96589.5170524157;974.0454354732402;1016.6035246253966;1017.3793985668736;1025.2823023883311;1025.646152077547;17320.30718771235;17431.47705568835;17455.214515347096;17688.204030818903;17778.5555361117;42306.57693423027;43043.13913721645;43900.121997560505;44245;44914.55085449103;58954.70522647359;59753;60331;60493.395066048775;61284;8479.448835825651;8574.742757717278;8588.785280368042;8826.117388261122;8873.91126088731;13325.200487970753;13440.46238150463;13559.661008474472;13609.931950340186;13736.587902362946;10948.467214589804;11807.468663909973;12122.75754484923;12170.513179472722;12177.512899483922;6054;10488.213383996079;11803.645890623295;11842.230255033395;12226.572069977508;12172.33052182103;12429.689257768629;12455.614845966144;12458.127931044739;12759.425825837674;8656.091110433566;8975;9062.91245050598;9153.77115572116;9219.49292788903;11599.594014209462;11676.649700508999;11844.940775296069;11871.821922671339;11940.880591193976 01:39:17 INFO - PROCESS | 30428 | |3;mootools.html;1353.668351253943;1512.7882096506492;1539.2765400261876;1678.6978343898102;1845.0866820923636;8306.293965012974;8675.132486751321;8696.1303869613;8702.434341767797;8706.216440520351;8500.872486912702;8637.784055398619;8706.347023973196;8706.65173393065;8718.912810871889;2065.060397519125;2294.552562250362;2345.7536958619357;2381.6070348392495;2383.332666853284;2381.3451300892307;2383.7139543254834;2385.6063749481314;2386.5823480890863;2395.425097976482;2311.179531266401;2341.4497593065616;2348.753380895007;2357.4931389751287;2362.6574146748712;1995.34153729269;2234.340869443502;2297.862128272309;2302.113686230805;2305.965410518827;2261.4459457432868;2287.1080278691325;2290.393045842853;2290.461741490765;2312.491251924574;8672.52301123438;8700.43447175938;8719.694810681596;8724.825503489894;8744.693935712283;5265;5446.2919820423485;5454.400015998237;5457.099578569571;5459.863503412446;3380.1211684962086;3480.460528618068;3505.1762835733584;3548;3550.840212190432;1141.3323205924544;1153.7865494883474;1153.9262240639182;1184.1000839362148;1204.9939750301191;12039.578614748441;12047.457864396123;12050.69873253167;12065.276083435023;12070.27578345302;4634.884127896829;4669.159551280734;4790.640701947368;4805.063012712488;4806.8798280043275;10186.286959912883;10208.693739187836;10215.846762298572;10235.539400726986;10261.538230779634;5360.678359298455;5400.270963419966;5401.8109366172785;5405.594580406407;5412.621116521885;4422.071365013319;4759.0719809636785;4875.658703890765;4888.486708895514;4936.062148191832;4010.63904248619;4042.988741044005;4046.736962097454;4109.383592461155;4129.855455059119;1310.9410076546578;1315.6316231455207;1331.5805521260772;1339.243327519948;1350.3585796746663;872.7861673889938;962.8122516109431;972.3339512434005;989.9505024748878;1019.7450637340664;5917.733701983421;5954.732037058343;6004.729787159588;6023.668698221552;6033.487153591994;447.54797654368673;460.69363873024736;461.3978757721139;462.782492228652;471.07904047586885;3861.1270343693254;4043.595640435933;4069.267531844237;4088.4071809587444;4124.278251306009;10590.629327973484;10946.452677366258;10996.835047474295;10999.835002474969;11027.503762330714;10585.57657693699;10917.727056823644;10942.124630029579;10987.560497580007;11036.613718519813;8178;8259.008918929767;8272.793180170424;8290.08809031006;8372.497650141011;5942.881142377215;5986.551008674454;6061.545384096298;6069.726862291119;6130.908036379368;9964.153046991087;10003.249756268455;10031.749206269902;10091.848622270525;10106.646267380607;10019.699409017741;10126.645567405105;10368.066873981377;10377.636782712569;10384.584616615553;6874.9656251718425;7527.510711803715;7559.433042521943;7868.606569671608;8105.878411823709;8177.672893084448;8405.873911891204;8434.662613495637;8436.198561136682;8448.788780280542;7591.962040189764;7690.346320562815;7721.343685786771;7757.340626046849;7794.571298578632;7429.33136017761;7474.2525747427;7510.173880873209;7633.465657404151;7647.502912310682;6509.414152726277;6557.180352455943;6587.143671322698;6593.340665933561;6597.703103360456;4756.785944632569;5116.769745361542;5127.615428842777;5132.10188217068;5286.920696189483;5234.712090835041;5240.4759524047295;5245.265662807134;5267.0256002639635;5318.787248510016 01:39:17 INFO - PROCESS | 30428 | |4;prototype.html;333.5863529223762;334.16958857239763;340.0733002568002;346.347135649301;346.47509023828906;5334.679919204846;5340.25236466895;5353.464653534645;5372.38217604975;5374.7850085996515;5203.256908935511;5300.867478313044;5306.522412982831;5321.536577441196;5328.227407025988;4093.570175131613;4142.855000074998;4157.501099868013;4198.958010419888;4256.97871510642;4135.172965406916;4162;4198.559151289117;4203.285441474942;4244.49066112067;4141.130362623852;4158.8544400945975;4168.43726096976;4173.478315210598;4205.642520385755;3946.8026598670094;4008.9576710055303;4096.3036283831525;4114.218298523271;4147.958520414787;3641.1261297288725;3648.452732090181;3650.3064417760543;3652.721547458368;3668.1746607013474;4846.321514987904;5033.798648054073;5045.545900868903;5064.341635587387;5086.720230387327;4571.817127314904;4707.599854012413;4709.858704238878;4715.316279139505;4727.57451829337;5393;5410.810621628224;5431.293931788881;5460.972695136538;5499.312585926759;3773.792441415721;3990.6009399060154;3999.680025597945;4008.9198216035807;4033.0925541753163;5679;5698.800541981011;5699.173619825144;5736.196932429463;5743.157137217063;3992.2215168042535;4004.7196696231567;4022.2156679447226;4023.2154729827403;4038.6163314485666;4076.062505623723;4104.15864747726;4111.753294802322;4119.938200926988;4124;4425.402570652985;4648.465426475931;4656.790444429941;4686.461056978423;4693.178693728584;5502.98194833957;5510.9448905511235;5515.503604675599;5516.475934786269;5561.332640083216;1396.3576754692956;1400.7338605665095;1402.3619253239751;1412.9081609695336;1415.3701602786866;912.6577533424966;975.9560819763128;979.7354714227262;986.7237173591406;987.2891518106951;5228.503292187313;5280.656757310762;5288.497592728685;5305.62860599762;5369.838904832784;5580.302462192226;5628.97185514078;5633.155026746021;5649.915251271234;5651.519620832275;5168.9224661630105;5247.580193584504;5347.171188465794;5364.91952620711;5388.326459192601;2998.7301142897245;3045.330027394014;3049.87800487978;3052.4200401923563;3057.602511673468;5734.136405668174;5891.46976772084;5895.528357731371;5918.201042859245;5932.48721576004;5840.328362238397;5846.1523079153285;5854.975379308604;5858.326292476419;5869.618474799125;5859.296884373903;5918.23063001807;5924.4667979882015;5937.9406205937385;5950.923617322148;5501.229827824028;5694.857628559153;5697.202391665253;5722.771089156554;5723.141528770551;5622.5501959842295;5650.40670729584;5652.943470565242;5654.491095801398;5654.773809047592;5640.266765320482;5829.271341082364;5849.707514624337;5872.383399742966;5890.793822216202;4037.9596204038758;4051.8379264830255;4051.8784436466954;4055.858044968412;4078.286299897447;5657.915131272952;5666.773329066791;5690.203371527907;5707.6575405475805;5707.743151558107;5385.25352070439;5475.6440831345835;5516.14499752539;5580.581456390868;5585.821529603377;5452.563794896478;5476.7535460903555;5479.6164268500825;5507.917381239205;5517.668939863621;5424.562490939983;5428.131498960148;5495.945040549544;5502.367227768857;5503.834884953458;5267.78928842842;5549.556035517068;5568.49883510486;5572.359178694502;5628.971855140862;5452.400235973961;5463.699496527729;5467.808626698046;5478.589105817;5508.614396992172 01:39:17 INFO - PROCESS | 30428 | |5;yui.html;694.8853439182539;745.3887811994164;783.1502819440906;819.6106849246609;876.7588913048911;13416.597502074928;15887;16158.596035099128;16810.579735506602;16815.49553513395;15787.684246315066;16634.168291585433;16634.66730665386;16671.08309043002;16698.833011669878;689.1213702529266;815.2825513548084;823.6499487717726;823.9958800205991;824.0235321144434;805.9838803223932;818.8853560501504;820.0733171516179;827.420805436197;828.1263267253046;844.8479273730726;848.7750746052301;850.8978922529305;851.0213254757017;852.1180578101666;833.2542374574722;838.8573942429801;838.9874151887726;841.4572600672562;841.5707988925661;613.3621034124506;614.0819474885076;616.7502161624549;617.9289381721114;618.0451202891543;13782.241976691277;13814.447422103103;13815.792763108562;13818.723625527533;13819.447222111103;15211.771823422658;15382.230888455533;15458.381664733397;15691.136987465685;15736.370545178179;12265.754684906253;12422.37888105591;12441.688957776038;12461.688457788538;12681.17572357803;3958.247932892741;3963.128111815396;3975.8807235782974;3979.8408063677416;3987.182627561372;73293.9005914917;73626.26373736301;74191.62904185499;74297.62851185763;74345.62827185883;11169.720756980978;11466.770664586662;11490.13823963206;11673.241239319417;11978.760424791455;21432.78567214339;21496.892515537635;21515.139394424048;21539.461513462287;21613.243536476148;8460.57697115154;8832.646694132163;9019.954900225457;9084.545772711337;9367.718968430958;4815.181419158752;4941.555260026615;4957.578605818474;5094.872628184325;5105.9489405106215;3607.2785442911522;3744.6817020553012;3750.6999440044733;3751.6998640108727;3753.399456087013;654.9815037616457;664.139938779282;672.7275453441364;676.090658064902;702.8453740177152;687.29895506583;755.474944913291;775.6819703921478;789.4158322841056;794.5312265763228;10147;10163.94918025405;10307.330023548595;10384.117350025332;10437.895621043692;694.9826254343682;780.7384526183793;796.80079980005;797.3621103117483;802.293981296467;4734.644901632391;4935.555799978019;4947.134251505972;4961.181405068195;4965.875853103701;114641.4267928655;115348.15822101233;117898;117949.41025294819;121328;83783.5810820942;94184;96298.51850740702;97073.51463242639;99839;87880.45214890537;88394.55802720945;89312.5534372337;89512;91160.08839911649;9645.324827262304;9883.950580247052;9922.503874806374;9996.850047249443;10075.250210690336;50103.49896501134;50461.24308135454;50749.23876141787;51331.2300315503;51500.48499514957;56298.718506407204;64060.35939640544;64558;73724.63137684278;78045.21954780379;13788.241646709528;13836.654083647989;14038.438462461387;14194.077384969944;14604.707905842037;15030.173340465943;15491.457798976982;15807.13060781668;16459.506214813573;16540.172991350144;14148.575542733735;14524.85475145235;14839.554813355617;15209;15265.923670381577;14604.634884127981;14636.780448293071;14691.853081469477;15371.558373480531;15401.229938503255;13854.307284635526;14192.601844830277;14302.57092287233;14419.639509012359;14677.339519721425;12243.387830608255;12407.813882791585;12525.27655525162;12526.37368131608;12787.936060319638;12176.75646487083;12202.6949326264;12260.26438413698;12423.254604723745;12435.93782031084 01:39:17 INFO - PROCESS | 30428 | __end_tp_report 01:39:17 INFO - PROCESS | 30428 | __start_cc_report 01:39:17 INFO - PROCESS | 30428 | _x_x_mozilla_cycle_collect,866 01:39:17 INFO - PROCESS | 30428 | __end_cc_report 01:39:17 INFO - PROCESS | 30428 | __startTimestamp1464943157020__endTimestamp 01:39:17 INFO - PROCESS | 30428 | 01:39:17 INFO - PROCESS | 30428 | ------- Summary: start ------- 01:39:17 INFO - PROCESS | 30428 | Number of tests: 6 01:39:17 INFO - PROCESS | 30428 | 01:39:17 INFO - PROCESS | 30428 | [#0] dojo.html Cycles:165 Average:5470.11 Median:5668.26 stddev:637.73 (11.3%) stddev-sans-first:611.57 01:39:17 INFO - PROCESS | 30428 | Values: 3082.6 3086.8 3104.1 3126.8 3134.9 5359.4 5404.8 5434.5 5541.3 5551.3 5450.2 5473.3 5493.9 5534.8 5580.5 4934.2 5033.8 5045.3 5049.0 5182.7 5085.0 5106.2 5137.1 5147.6 5154.2 4919.2 4939.7 4967.4 4997.9 5027.8 4990.3 5042.9 5061.2 5068.0 5107.1 5018.9 5024.3 5051.5 5056.3 5065.5 5318.0 5380.8 5381.2 5465.8 5473.4 5946.3 5947.3 5960.6 5971.7 5984.9 5956.0 5970.0 6010.7 6016.0 6023.7 5414.8 5434.5 5527.0 5530.2 5551.2 6074.1 6076.8 6078.8 6094.4 6130.3 5663.0 5805.4 5852.6 5864.8 5867.3 5854.4 5905.6 5911.3 5937.9 5950.0 5866.3 5903.9 5907.1 5910.7 5920.1 5757.7 5805.4 5859.4 5918.5 5933.2 4443.3 4444.7 4447.7 4483.6 4486.5 3941.2 3955.3 3957.3 3970.6 3997.1 5445.3 5487.9 5508.4 5558.7 5623.1 5916.3 5932.5 5951.5 5967.8 6019.8 5604.8 5613.2 5616.0 5617.7 5619.7 4955.5 4966.1 4999.3 5089.4 5090.7 6092.9 6100.5 6102.6 6103.4 6142.9 5880.0 5886.2 5890.4 5912.2 5925.3 5930.3 6036.7 6058.3 6076.1 6122.5 5740.9 5790.9 5791.0 5800.3 5803.4 5837.2 5890.8 5923.0 5923.7 5929.4 5623.6 5741.9 5769.8 5792.2 5811.9 5694.9 5743.8 5753.5 5756.2 5770.2 5492.8 5671.6 5680.4 5680.6 5685.7 5673.9 5689.2 5712.8 5796.5 5802.9 5613.6 5616.7 5618.4 5618.9 5668.3 01:39:17 INFO - PROCESS | 30428 | 01:39:17 INFO - PROCESS | 30428 | [#1] ext.html Cycles:180 Average:62278.70 Median:42366.50 stddev:125197.17 (295.5%) stddev-sans-first:125462.80 01:39:17 INFO - PROCESS | 30428 | Values: 622.8 639.7 645.2 648.7 660.0 30366.1 43165.1 43509.8 44271.8 48042.0 44586.0 45163.5 45189.0 45205.5 45214.0 8486.3 8614.8 8653.8 8659.4 8662.0 8567.2 8703.9 8706.3 8713.9 8714.1 8679.3 8744.5 8755.1 8762.8 8763.5 8598.5 8629.4 8629.6 8639.4 8680.4 8507.1 8585.1 8588.6 8588.9 8590.0 42145.0 42308.0 42463.8 42596.0 42949.1 3540.8 3638.8 3690.7 3973.3 4207.5 32535.3 32683.2 33623.5 33813.7 34316.0 4263.0 4356.0 4409.1 4420.2 4558.1 347791.0 351098.5 352080.0 353055.0 353822.0 59467.0 59590.4 59912.1 59964.4 59971.7 63204.4 63462.4 63476.0 63522.7 63561.7 16295.1 16525.8 16551.3 16553.9 16561.2 11882.8 11906.6 11912.2 11926.5 11931.8 15991.4 17307.6 17418.6 17430.5 17547.8 5507.6 6395.3 6408.2 6540.2 6631.9 999.7 1053.6 1066.7 1099.1 1132.6 32603.5 32966.7 33003.8 33006.0 33291.8 1133.0 1168.6 1182.7 1216.8 1239.1 16766.5 17518.3 17538.7 17547.2 17616.6 589697.0 603324.0 603890.0 606859.0 608414.0 58706.0 59166.7 59293.7 59299.4 59362.0 1304.8 1382.5 1416.5 1434.7 1456.5 32762.8 33943.5 34477.3 34542.5 34644.5 50121.5 50813.2 50821.0 50858.2 50883.0 413727.0 424310.0 424651.0 425578.0 426398.0 37703.0 38094.4 38797.2 38829.8 41605.2 44237.8 45018.3 48371.5 48521.8 48880.0 40961.4 41665.0 41778.8 42425.0 42808.8 41137.0 41382.2 41447.2 41869.2 42226.0 41334.6 41400.6 41771.8 41857.8 42166.0 35608.8 36586.8 37745.6 37929.2 38259.8 28205.2 28292.3 28690.9 28930.0 29088.3 01:39:17 INFO - PROCESS | 30428 | 01:39:17 INFO - PROCESS | 30428 | [#2] jquery.html Cycles:180 Average:28002.99 Median:2329.51 stddev:77426.20 (3323.7%) stddev-sans-first:77615.63 01:39:17 INFO - PROCESS | 30428 | Values: 388.6 389.8 392.7 400.4 416.5 13390.1 17428.9 18206.1 19931.8 19936.2 18100.5 18656.9 18872.5 18938.9 19029.4 5718.7 5858.5 5866.6 5874.5 5925.1 4243.9 5787.5 5835.9 6344.4 6696.2 6561.8 6566.0 6570.8 6585.0 6586.2 6333.6 6507.1 6542.0 6551.4 6552.9 4949.4 5227.0 5803.2 5816.6 5817.5 13870.4 14097.2 14100.9 15240.0 21518.5 2153.0 2245.5 2250.5 2276.2 2382.8 9476.0 13614.6 14020.4 14086.5 14473.3 1825.7 1868.3 1893.6 1956.1 1959.4 59644.7 62835.0 68842.3 73844.0 78783.6 10567.0 10829.5 11000.9 11269.7 11293.5 15344.5 15459.6 15467.6 15495.9 15508.9 7979.9 8001.5 8075.1 8150.0 8152.7 7484.2 7511.1 7545.4 7608.6 7640.2 4769.9 4825.7 4866.2 4867.4 4916.8 1938.9 1981.6 1994.8 2017.8 2038.1 917.8 999.6 1027.0 1047.8 1078.6 18639.7 18998.4 19118.1 19364.3 19515.6 968.4 974.1 976.4 1060.5 1063.3 10434.5 10833.3 10975.5 11007.7 11027.2 455395.0 459598.0 476293.0 477668.0 482199.0 70873.3 81450.2 93514.0 96577.5 96589.5 974.0 1016.6 1017.4 1025.3 1025.6 17320.3 17431.5 17455.2 17688.2 17778.6 42306.6 43043.1 43900.1 44245.0 44914.6 58954.7 59753.0 60331.0 60493.4 61284.0 8479.4 8574.7 8588.8 8826.1 8873.9 13325.2 13440.5 13559.7 13609.9 13736.6 10948.5 11807.5 12122.8 12170.5 12177.5 6054.0 10488.2 11803.6 11842.2 12226.6 12172.3 12429.7 12455.6 12458.1 12759.4 8656.1 8975.0 9062.9 9153.8 9219.5 11599.6 11676.6 11844.9 11871.8 11940.9 01:39:17 INFO - PROCESS | 30428 | 01:39:17 INFO - PROCESS | 30428 | [#3] mootools.html Cycles:180 Average:5771.37 Median:4652.02 stddev:3273.88 (70.4%) stddev-sans-first:3266.22 01:39:17 INFO - PROCESS | 30428 | Values: 1353.7 1512.8 1539.3 1678.7 1845.1 8306.3 8675.1 8696.1 8702.4 8706.2 8500.9 8637.8 8706.3 8706.7 8718.9 2065.1 2294.6 2345.8 2381.6 2383.3 2381.3 2383.7 2385.6 2386.6 2395.4 2311.2 2341.4 2348.8 2357.5 2362.7 1995.3 2234.3 2297.9 2302.1 2306.0 2261.4 2287.1 2290.4 2290.5 2312.5 8672.5 8700.4 8719.7 8724.8 8744.7 5265.0 5446.3 5454.4 5457.1 5459.9 3380.1 3480.5 3505.2 3548.0 3550.8 1141.3 1153.8 1153.9 1184.1 1205.0 12039.6 12047.5 12050.7 12065.3 12070.3 4634.9 4669.2 4790.6 4805.1 4806.9 10186.3 10208.7 10215.8 10235.5 10261.5 5360.7 5400.3 5401.8 5405.6 5412.6 4422.1 4759.1 4875.7 4888.5 4936.1 4010.6 4043.0 4046.7 4109.4 4129.9 1310.9 1315.6 1331.6 1339.2 1350.4 872.8 962.8 972.3 990.0 1019.7 5917.7 5954.7 6004.7 6023.7 6033.5 447.5 460.7 461.4 462.8 471.1 3861.1 4043.6 4069.3 4088.4 4124.3 10590.6 10946.5 10996.8 10999.8 11027.5 10585.6 10917.7 10942.1 10987.6 11036.6 8178.0 8259.0 8272.8 8290.1 8372.5 5942.9 5986.6 6061.5 6069.7 6130.9 9964.2 10003.2 10031.7 10091.8 10106.6 10019.7 10126.6 10368.1 10377.6 10384.6 6875.0 7527.5 7559.4 7868.6 8105.9 8177.7 8405.9 8434.7 8436.2 8448.8 7592.0 7690.3 7721.3 7757.3 7794.6 7429.3 7474.3 7510.2 7633.5 7647.5 6509.4 6557.2 6587.1 6593.3 6597.7 4756.8 5116.8 5127.6 5132.1 5286.9 5234.7 5240.5 5245.3 5267.0 5318.8 01:39:17 INFO - PROCESS | 30428 | 01:39:17 INFO - PROCESS | 30428 | [#4] prototype.html Cycles:180 Average:4664.71 Median:5359.19 stddev:1365.96 (25.5%) stddev-sans-first:1330.54 01:39:17 INFO - PROCESS | 30428 | Values: 333.6 334.2 340.1 346.3 346.5 5334.7 5340.3 5353.5 5372.4 5374.8 5203.3 5300.9 5306.5 5321.5 5328.2 4093.6 4142.9 4157.5 4199.0 4257.0 4135.2 4162.0 4198.6 4203.3 4244.5 4141.1 4158.9 4168.4 4173.5 4205.6 3946.8 4009.0 4096.3 4114.2 4148.0 3641.1 3648.5 3650.3 3652.7 3668.2 4846.3 5033.8 5045.5 5064.3 5086.7 4571.8 4707.6 4709.9 4715.3 4727.6 5393.0 5410.8 5431.3 5461.0 5499.3 3773.8 3990.6 3999.7 4008.9 4033.1 5679.0 5698.8 5699.2 5736.2 5743.2 3992.2 4004.7 4022.2 4023.2 4038.6 4076.1 4104.2 4111.8 4119.9 4124.0 4425.4 4648.5 4656.8 4686.5 4693.2 5503.0 5510.9 5515.5 5516.5 5561.3 1396.4 1400.7 1402.4 1412.9 1415.4 912.7 976.0 979.7 986.7 987.3 5228.5 5280.7 5288.5 5305.6 5369.8 5580.3 5629.0 5633.2 5649.9 5651.5 5168.9 5247.6 5347.2 5364.9 5388.3 2998.7 3045.3 3049.9 3052.4 3057.6 5734.1 5891.5 5895.5 5918.2 5932.5 5840.3 5846.2 5855.0 5858.3 5869.6 5859.3 5918.2 5924.5 5937.9 5950.9 5501.2 5694.9 5697.2 5722.8 5723.1 5622.6 5650.4 5652.9 5654.5 5654.8 5640.3 5829.3 5849.7 5872.4 5890.8 4038.0 4051.8 4051.9 4055.9 4078.3 5657.9 5666.8 5690.2 5707.7 5707.7 5385.3 5475.6 5516.1 5580.6 5585.8 5452.6 5476.8 5479.6 5507.9 5517.7 5424.6 5428.1 5495.9 5502.4 5503.8 5267.8 5549.6 5568.5 5572.4 5629.0 5452.4 5463.7 5467.8 5478.6 5508.6 01:39:17 INFO - PROCESS | 30428 | 01:39:17 INFO - PROCESS | 30428 | [#5] yui.html Cycles:180 Average:20905.73 Median:4360.91 stddev:29458.00 (675.5%) stddev-sans-first:29501.55 01:39:17 INFO - PROCESS | 30428 | Values: 694.9 745.4 783.2 819.6 876.8 13416.6 15887.0 16158.6 16810.6 16815.5 15787.7 16634.2 16634.7 16671.1 16698.8 689.1 815.3 823.6 824.0 824.0 806.0 818.9 820.1 827.4 828.1 844.8 848.8 850.9 851.0 852.1 833.3 838.9 839.0 841.5 841.6 613.4 614.1 616.8 617.9 618.0 13782.2 13814.4 13815.8 13818.7 13819.4 15211.8 15382.2 15458.4 15691.1 15736.4 12265.8 12422.4 12441.7 12461.7 12681.2 3958.2 3963.1 3975.9 3979.8 3987.2 73293.9 73626.3 74191.6 74297.6 74345.6 11169.7 11466.8 11490.1 11673.2 11978.8 21432.8 21496.9 21515.1 21539.5 21613.2 8460.6 8832.6 9020.0 9084.5 9367.7 4815.2 4941.6 4957.6 5094.9 5105.9 3607.3 3744.7 3750.7 3751.7 3753.4 655.0 664.1 672.7 676.1 702.8 687.3 755.5 775.7 789.4 794.5 10147.0 10163.9 10307.3 10384.1 10437.9 695.0 780.7 796.8 797.4 802.3 4734.6 4935.6 4947.1 4961.2 4965.9 114641.4 115348.2 117898.0 117949.4 121328.0 83783.6 94184.0 96298.5 97073.5 99839.0 87880.5 88394.6 89312.6 89512.0 91160.1 9645.3 9884.0 9922.5 9996.9 10075.3 50103.5 50461.2 50749.2 51331.2 51500.5 56298.7 64060.4 64558.0 73724.6 78045.2 13788.2 13836.7 14038.4 14194.1 14604.7 15030.2 15491.5 15807.1 16459.5 16540.2 14148.6 14524.9 14839.6 15209.0 15265.9 14604.6 14636.8 14691.9 15371.6 15401.2 13854.3 14192.6 14302.6 14419.6 14677.3 12243.4 12407.8 12525.3 12526.4 12787.9 12176.8 12202.7 12260.3 12423.3 12435.9 01:39:17 INFO - PROCESS | 30428 | -------- Summary: end -------- 01:39:17 INFO - PROCESS | 30428 | 01:39:17 INFO - TEST-INFO | 30428: exit 0 01:39:17 INFO - TEST-OK | dromaeo_css | took 1111648ms 01:39:17 INFO - TEST-START | kraken 01:39:17 INFO - operating with platform_type : linux_ 01:39:17 INFO - Initialising browser for kraken test... 01:39:17 INFO - TEST-INFO | started process 30609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR01Irh/profile http://localhost:41999/getInfo.html) 01:39:21 INFO - PROCESS | 30609 | __metrics Screen width/height:1600/1200 01:39:21 INFO - PROCESS | 30609 | colorDepth:24 01:39:21 INFO - PROCESS | 30609 | Browser inner width/height: 1024/697 01:39:21 INFO - PROCESS | 30609 | __metrics 01:39:21 ERROR - PROCESS | 30609 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:39:22 INFO - TEST-INFO | 30609: exit 0 01:39:22 INFO - Browser initialized. 01:39:22 INFO - Running cycle 1/1 for kraken test... 01:39:22 INFO - TEST-INFO | started process 30697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR01Irh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:39:34 INFO - PROCESS | 30697 | RSS: Main: 156729344 01:39:34 INFO - PROCESS | 30697 | 01:39:36 INFO - PROCESS | 30697 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41999/tests/kraken/driver.html?testName=audio-beat-detection) 01:39:37 INFO - PROCESS | 30697 | RSS: Main: 214360064 01:39:37 INFO - PROCESS | 30697 | 01:39:40 INFO - PROCESS | 30697 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41999/tests/kraken/driver.html?testName=audio-dft) 01:39:41 INFO - PROCESS | 30697 | RSS: Main: 201011200 01:39:41 INFO - PROCESS | 30697 | 01:39:44 INFO - PROCESS | 30697 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41999/tests/kraken/driver.html?testName=audio-fft) 01:39:44 INFO - PROCESS | 30697 | RSS: Main: 268349440 01:39:44 INFO - PROCESS | 30697 | 01:39:46 INFO - PROCESS | 30697 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41999/tests/kraken/driver.html?testName=audio-oscillator) 01:39:47 INFO - PROCESS | 30697 | RSS: Main: 180051968 01:39:47 INFO - PROCESS | 30697 | 01:39:49 INFO - PROCESS | 30697 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41999/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:39:50 INFO - PROCESS | 30697 | RSS: Main: 183619584 01:39:50 INFO - PROCESS | 30697 | 01:39:53 INFO - PROCESS | 30697 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41999/tests/kraken/driver.html?testName=imaging-darkroom) 01:39:53 INFO - PROCESS | 30697 | RSS: Main: 218054656 01:39:53 INFO - PROCESS | 30697 | 01:39:57 INFO - PROCESS | 30697 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41999/tests/kraken/driver.html?testName=imaging-desaturate) 01:39:57 INFO - PROCESS | 30697 | RSS: Main: 220639232 01:39:57 INFO - PROCESS | 30697 | 01:40:00 INFO - PROCESS | 30697 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41999/tests/kraken/driver.html?testName=json-parse-financial) 01:40:01 INFO - PROCESS | 30697 | RSS: Main: 220823552 01:40:01 INFO - PROCESS | 30697 | 01:40:02 INFO - PROCESS | 30697 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41999/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:40:03 INFO - PROCESS | 30697 | RSS: Main: 207282176 01:40:03 INFO - PROCESS | 30697 | 01:40:05 INFO - PROCESS | 30697 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41999/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:40:05 INFO - PROCESS | 30697 | RSS: Main: 209911808 01:40:05 INFO - PROCESS | 30697 | 01:40:07 INFO - PROCESS | 30697 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41999/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:40:08 INFO - PROCESS | 30697 | RSS: Main: 218062848 01:40:08 INFO - PROCESS | 30697 | 01:40:10 INFO - PROCESS | 30697 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41999/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:40:11 INFO - PROCESS | 30697 | RSS: Main: 223109120 01:40:11 INFO - PROCESS | 30697 | 01:40:14 INFO - PROCESS | 30697 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41999/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:40:14 INFO - PROCESS | 30697 | RSS: Main: 223399936 01:40:14 INFO - PROCESS | 30697 | 01:40:16 INFO - PROCESS | 30697 | Cycle 1(1): loaded http://localhost:41999/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41999/tests/kraken/driver.html?testName=ai-astar) 01:40:16 INFO - PROCESS | 30697 | RSS: Main: 265981952 01:40:16 INFO - PROCESS | 30697 | 01:40:16 INFO - PROCESS | 30697 | __start_tp_report 01:40:16 INFO - PROCESS | 30697 | _x_x_mozilla_page_load 01:40:16 INFO - PROCESS | 30697 | _x_x_mozilla_page_load_details 01:40:16 INFO - PROCESS | 30697 | |i|pagename|runs| 01:40:16 INFO - PROCESS | 30697 | |0;ai-astar;110;106;111;110;110;110;109;110;110;109 01:40:16 INFO - PROCESS | 30697 | |1;audio-beat-detection;153;124;132;182;127;128;151;130;180;126 01:40:16 INFO - PROCESS | 30697 | |2;audio-dft;161;161;160;160;160;160;161;160;162;162 01:40:16 INFO - PROCESS | 30697 | |3;audio-fft;75;75;75;128;74;75;73;73;101;75 01:40:16 INFO - PROCESS | 30697 | |4;audio-oscillator;84;85;114;85;85;85;126;84;84;133 01:40:16 INFO - PROCESS | 30697 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 01:40:16 INFO - PROCESS | 30697 | |6;imaging-darkroom;146;146;145;145;145;150;146;145;146;146 01:40:16 INFO - PROCESS | 30697 | |7;imaging-desaturate;95;94;94;95;95;95;95;94;95;94 01:40:16 INFO - PROCESS | 30697 | |8;json-parse-financial;53;52;52;52;52;52;51;52;52;52 01:40:16 INFO - PROCESS | 30697 | |9;json-stringify-tinderbox;60;61;60;60;61;61;61;60;61;61 01:40:16 INFO - PROCESS | 30697 | |10;stanford-crypto-aes;80;79;79;79;85;84;81;87;132;85 01:40:16 INFO - PROCESS | 30697 | |11;stanford-crypto-ccm;123;125;120;134;122;121;128;133;139;123 01:40:16 INFO - PROCESS | 30697 | |12;stanford-crypto-pbkdf2;164;160;160;162;160;156;160;159;157;155 01:40:16 INFO - PROCESS | 30697 | |13;stanford-crypto-sha256-iterative;63;63;64;62;62;63;67;61;63;61 01:40:16 INFO - PROCESS | 30697 | __end_tp_report 01:40:16 INFO - PROCESS | 30697 | __start_cc_report 01:40:16 INFO - PROCESS | 30697 | _x_x_mozilla_cycle_collect,1596 01:40:16 INFO - PROCESS | 30697 | __end_cc_report 01:40:16 INFO - PROCESS | 30697 | __startTimestamp1464943216758__endTimestamp 01:40:16 INFO - PROCESS | 30697 | 01:40:16 INFO - PROCESS | 30697 | ------- Summary: start ------- 01:40:16 INFO - PROCESS | 30697 | Number of tests: 14 01:40:16 INFO - PROCESS | 30697 | 01:40:16 INFO - PROCESS | 30697 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 01:40:16 INFO - PROCESS | 30697 | Values: 110.0 106.0 111.0 110.0 110.0 110.0 109.0 110.0 110.0 109.0 01:40:16 INFO - PROCESS | 30697 | 01:40:16 INFO - PROCESS | 30697 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:141.50 stddev:22.30 (15.8%) stddev-sans-first:23.37 01:40:16 INFO - PROCESS | 30697 | Values: 153.0 124.0 132.0 182.0 127.0 128.0 151.0 130.0 180.0 126.0 01:40:16 INFO - PROCESS | 30697 | 01:40:16 INFO - PROCESS | 30697 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 01:40:16 INFO - PROCESS | 30697 | Values: 161.0 161.0 160.0 160.0 160.0 160.0 161.0 160.0 162.0 162.0 01:40:16 INFO - PROCESS | 30697 | 01:40:16 INFO - PROCESS | 30697 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:18.09 (24.1%) stddev-sans-first:18.99 01:40:16 INFO - PROCESS | 30697 | Values: 75.0 75.0 75.0 128.0 74.0 75.0 73.0 73.0 101.0 75.0 01:40:16 INFO - PROCESS | 30697 | 01:40:16 INFO - PROCESS | 30697 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:84.50 stddev:19.74 (23.4%) stddev-sans-first:20.41 01:40:16 INFO - PROCESS | 30697 | Values: 84.0 85.0 114.0 85.0 85.0 85.0 126.0 84.0 84.0 133.0 01:40:16 INFO - PROCESS | 30697 | 01:40:16 INFO - PROCESS | 30697 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:40:16 INFO - PROCESS | 30697 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 01:40:16 INFO - PROCESS | 30697 | 01:40:16 INFO - PROCESS | 30697 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:1.49 (1.0%) stddev-sans-first:1.58 01:40:16 INFO - PROCESS | 30697 | Values: 146.0 146.0 145.0 145.0 145.0 150.0 146.0 145.0 146.0 146.0 01:40:16 INFO - PROCESS | 30697 | 01:40:16 INFO - PROCESS | 30697 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 01:40:16 INFO - PROCESS | 30697 | Values: 95.0 94.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 01:40:16 INFO - PROCESS | 30697 | 01:40:16 INFO - PROCESS | 30697 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:0.47 (0.9%) stddev-sans-first:0.33 01:40:16 INFO - PROCESS | 30697 | Values: 53.0 52.0 52.0 52.0 52.0 52.0 51.0 52.0 52.0 52.0 01:40:16 INFO - PROCESS | 30697 | 01:40:16 INFO - PROCESS | 30697 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 01:40:16 INFO - PROCESS | 30697 | Values: 60.0 61.0 60.0 60.0 61.0 61.0 61.0 60.0 61.0 61.0 01:40:16 INFO - PROCESS | 30697 | 01:40:16 INFO - PROCESS | 30697 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:82.50 stddev:16.05 (19.5%) stddev-sans-first:16.82 01:40:16 INFO - PROCESS | 30697 | Values: 80.0 79.0 79.0 79.0 85.0 84.0 81.0 87.0 132.0 85.0 01:40:16 INFO - PROCESS | 30697 | 01:40:16 INFO - PROCESS | 30697 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:126.50 stddev:6.46 (5.1%) stddev-sans-first:6.70 01:40:16 INFO - PROCESS | 30697 | Values: 123.0 125.0 120.0 134.0 122.0 121.0 128.0 133.0 139.0 123.0 01:40:16 INFO - PROCESS | 30697 | 01:40:16 INFO - PROCESS | 30697 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.30 Median:160.00 stddev:2.71 (1.7%) stddev-sans-first:2.28 01:40:16 INFO - PROCESS | 30697 | Values: 164.0 160.0 160.0 162.0 160.0 156.0 160.0 159.0 157.0 155.0 01:40:16 INFO - PROCESS | 30697 | 01:40:16 INFO - PROCESS | 30697 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.73 (2.7%) stddev-sans-first:1.83 01:40:16 INFO - PROCESS | 30697 | Values: 63.0 63.0 64.0 62.0 62.0 63.0 67.0 61.0 63.0 61.0 01:40:16 INFO - PROCESS | 30697 | -------- Summary: end -------- 01:40:16 INFO - PROCESS | 30697 | 01:40:17 INFO - TEST-INFO | 30697: exit 0 01:40:17 INFO - TEST-OK | kraken | took 60058ms 01:40:17 INFO - SUITE-END | took 1171s 01:40:17 INFO - Completed test suite (00:19:31) 01:40:17 INFO - javascript benchmark 01:40:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.5530298106787, 3086.7684923630727, 3104.0532637545552, 3126.8123912565234, 3134.921626959327, 5359.410464848864, 5404.783808647654, 5434.456554344563, 5541.307336582927, 5551.306086739162, 5450.236966824637, 5473.343198816137, 5493.862653433666, 5534.806281780128, 5580.525655319303, 4934.161192597258, 5033.798648054073, 5045.318881950926, 5049.040682270357, 5182.740862956856, 5085.0338435697095, 5106.234064890259, 5137.101007323722, 5147.613928955343, 5154.201098829687, 4919.237518184687, 4939.678920870132, 4967.403911530621, 4997.875053123701, 5027.773750181251, 4990.326305948687, 5042.924356134661, 5061.190209566452, 5067.974660126676, 5107.106256405114, 5018.924716129261, 5024.296598476216, 5051.469595692436, 5056.317397151374, 5065.518775716338, 5318.042752304584, 5380.78476860929, 5381.219723140122, 5465.808696695636, 5473.425290344497, 5946.256717910262, 5947.345791962881, 5960.552958528127, 5971.671558064305, 5984.8503787405225, 5955.970220148872, 5970.04479283317, 6010.729517171738, 6016.0, 6023.668698221596, 5414.7834086636485, 5434.456554344534, 5527.032769265363, 5530.170474428827, 5551.195076713854, 6074.106485809174, 6076.837366404027, 6078.814980436019, 6094.360092190256, 6130.325664176937, 5662.980663480613, 5805.448482394166, 5852.590318677651, 5864.765409383577, 5867.266591676041, 5854.443827836349, 5905.586608937419, 5911.261092363455, 5937.881242375129, 5950.0, 5866.325372582122, 5903.852403689943, 5907.1434641976675, 5910.704464776744, 5920.141579471038, 5757.740901659436, 5805.36141024487, 5859.414058594107, 5918.496927761188, 5933.2286802716235, 4443.266860967904, 4444.711093778894, 4447.710898791568, 4483.641308695362, 4486.484054333728, 3941.2117576484816, 3955.3275943089743, 3957.3074711925874, 3970.6426421621613, 3997.1006523532556, 5445.319335083114, 5487.890242195213, 5508.366537848118, 5558.666480011212, 5623.072193088176, 5916.26046744157, 5932.525397968152, 5951.4941229995065, 5967.791127310524, 6019.849503762353, 5604.803831865946, 5613.158026296088, 5616.0, 5617.662940223599, 5619.7471113799975, 4955.4548999610015, 4966.056449274626, 4999.325091112726, 5089.389273287229, 5090.745462726849, 6092.878142437126, 6100.450959413585, 6102.603330783573, 6103.3591472894705, 6142.877142457126, 5880.029795083763, 5886.205362276038, 5890.410958904075, 5912.172295878494, 5925.348211696796, 5930.318013428511, 6036.698165091816, 6058.3335833057445, 6076.058210977306, 6122.510199184144, 5740.856478588069, 5790.913136302875, 5791.0, 5800.332961709458, 5803.448672376117, 5837.182794408701, 5890.793822216202, 5923.0, 5923.703814809329, 5929.436703513159, 5623.606347555632, 5741.913871292018, 5769.769209231584, 5792.160136780059, 5811.883762324815, 5694.943050569441, 5743.770249190153, 5753.5109515689965, 5756.194132821324, 5770.163326317745, 5492.80775172867, 5671.574631902707, 5680.375158732453, 5680.573956953328, 5685.658860468385, 5673.914891276551, 5689.231953686365, 5712.7714891403875, 5796.507296879644, 5802.883942321215, 5613.578981576316, 5616.66300022, 5618.438156184349, 5618.943810561842, 5668.26312579362], "value": 5425.323808270602, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.8100429369042, 639.7153266796274, 645.2063961327569, 648.6951132967506, 660.0000998487293, 30366.089017329487, 43165.136697266076, 43509.78245108774, 44271.77864110683, 48042.0, 44586.0, 45163.54836451635, 45189.0, 45205.54794452063, 45214.0, 8486.27866631337, 8614.827703445928, 8653.783655408633, 8659.393842431033, 8662.047174810767, 8567.186117318875, 8703.869441958375, 8706.347023973196, 8713.869291960626, 8714.085021072791, 8679.305655547541, 8744.519051452167, 8755.080716524768, 8762.824743505125, 8763.51800650964, 8598.484090954562, 8629.39594228398, 8629.568521573896, 8639.352048596349, 8680.435771674822, 8507.106753790888, 8585.098564650683, 8588.570571471402, 8588.8711669325, 8590.0, 42145.0, 42308.0, 42463.78768106171, 42596.0, 42949.14101717948, 3540.805255710935, 3638.7816730996224, 3690.6862916652117, 3973.304671682473, 4207.474065741782, 32535.349293014246, 32683.18292042694, 33623.49564756531, 33813.6618633813, 34316.0, 4263.0, 4355.956440435619, 4409.140217657558, 4420.20436321462, 4558.0655965526985, 347791.0, 351098.467045989, 352080.0, 353054.99999999744, 353822.0, 59467.0, 59590.404095959355, 59912.10131848026, 59964.40035599588, 59971.700141499015, 63204.36795632077, 63462.365376345646, 63476.0, 63522.6823865887, 63561.68219158875, 16295.103769292566, 16525.83474165243, 16551.337946482006, 16553.917230413772, 16561.17194140312, 11882.76234475323, 11906.642800715992, 11912.166148369532, 11926.522939082339, 11931.761364772656, 15991.360345586047, 17307.56731081733, 17418.56453588645, 17430.47708568745, 17547.824521754876, 5507.614466987353, 6395.296517383084, 6408.1669382980845, 6540.215174179129, 6631.867362652816, 999.7350702063959, 1053.6206965492418, 1066.664000839733, 1099.087757161554, 1132.6262333429947, 32603.51094733581, 32966.67033329684, 33003.83498082542, 33006.0, 33291.83354083214, 1132.971675708114, 1168.6318809574957, 1182.739797244622, 1216.7870622641003, 1239.0732411100644, 16766.497005089866, 17518.299268029135, 17538.736918946226, 17547.21037553313, 17616.64766704659, 589697.0, 603324.0, 603890.0, 606859.0, 608414.0, 58706.0, 59166.70416647889, 59293.703531482926, 59299.40700592939, 59362.0, 1304.8173255744202, 1382.4815694114707, 1416.4617445370693, 1434.734574103794, 1456.5411895252962, 32762.83618581892, 33943.490847636815, 34477.31045379129, 34542.48186277258, 34644.48033279553, 50121.49878501168, 50813.23780143227, 50821.0, 50858.23712644239, 50883.0, 413727.0, 424310.0, 424651.0, 425578.0, 426398.0, 37703.0, 38094.42858357071, 38797.2240555193, 38829.805850970566, 41605.167896641295, 44237.77881110574, 45018.3247251298, 48371.5162848367, 48521.75739121282, 48880.0, 40961.38557921574, 41665.0, 41778.79110604549, 42425.0, 42808.78595607002, 41137.0, 41382.172356552095, 41447.171056579304, 41869.1626167481, 42226.0, 41334.586654133076, 41400.58599413967, 41771.7911410441, 41857.79071104625, 42166.0, 35608.82195589005, 36586.8170659145, 37745.62254377421, 37929.241415172095, 38259.80870095743, 28205.15384538467, 28292.292692682848, 28690.85654571714, 28930.0, 29088.27279318034], "value": 20438.750017657356, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.5725701728101, 389.75250715795477, 392.68977507768864, 400.39340399295065, 416.539723605416, 13390.074322704375, 17428.912855435705, 18206.08969551524, 19931.800681993194, 19936.202551897924, 18100.4569862904, 18656.906715466437, 18872.528186795338, 18938.905305473454, 19029.429117126474, 5718.714064296779, 5858.502027327682, 5866.589338746289, 5874.5006674432725, 5925.111233314994, 4243.915121697564, 5787.47912687858, 5835.854103647422, 6344.429001389874, 6696.196456425211, 6561.835954101138, 6565.967170164166, 6570.7844048850875, 6585.0451684505715, 6586.242582103047, 6333.55665103443, 6507.121538592277, 6542.018697195411, 6551.410373066399, 6552.93447065528, 4949.356583644103, 5226.97386513065, 5803.245578074823, 5816.563757718146, 5817.545613596601, 13870.4451821927, 14097.154170749685, 14100.85899141016, 15240.0, 21518.462038449008, 2152.989235053815, 2245.5396643688005, 2250.493638931244, 2276.248837883511, 2382.7736365045293, 9476.0, 13614.591562253148, 14020.369083391271, 14086.506972256024, 14473.348699308557, 1825.7261410788356, 1868.252698920429, 1893.602343507865, 1956.1490751523133, 1959.3827944197674, 59644.701776491274, 62835.0, 68842.29046864032, 73844.0, 78783.6060819698, 10567.0, 10829.458527073615, 11000.889991100146, 11269.71825704364, 11293.548258069584, 15344.465553444566, 15459.613509662124, 15467.613309667347, 15495.915285929877, 15508.922455387876, 7979.920200798034, 8001.519908805491, 8075.071366792894, 8150.021997360236, 8152.714654987047, 7484.176740558534, 7511.136219334737, 7545.396368290633, 7608.592410404093, 7640.159582445926, 4769.880752981203, 4825.734584597881, 4866.245731911559, 4867.3915760529935, 4916.827911023097, 1938.92244310226, 1981.5739615982634, 1994.8108971160736, 2017.8183963443066, 2038.0930485933914, 917.7613820406609, 999.550202408919, 1026.9743256418649, 1047.7956798424386, 1078.6494389323502, 18639.66127714385, 18998.43004709861, 19118.139683714267, 19364.32224872151, 19515.609687806165, 968.3512046928574, 974.1345323705026, 976.3751199232497, 1060.4644654449453, 1063.2929102146986, 10434.530446129942, 10833.349999000086, 10975.50610222542, 11007.669769906915, 11027.17296202788, 455395.0, 459598.0, 476293.0, 477668.0, 482199.0, 70873.29126708666, 81450.18549814426, 93514.0, 96577.5171124154, 96589.5170524157, 974.0454354732402, 1016.6035246253966, 1017.3793985668736, 1025.2823023883311, 1025.646152077547, 17320.30718771235, 17431.47705568835, 17455.214515347096, 17688.204030818903, 17778.5555361117, 42306.57693423027, 43043.13913721645, 43900.121997560505, 44245.0, 44914.55085449103, 58954.70522647359, 59753.0, 60331.0, 60493.395066048775, 61284.0, 8479.448835825651, 8574.742757717278, 8588.785280368042, 8826.117388261122, 8873.91126088731, 13325.200487970753, 13440.46238150463, 13559.661008474472, 13609.931950340186, 13736.587902362946, 10948.467214589804, 11807.468663909973, 12122.75754484923, 12170.513179472722, 12177.512899483922, 6054.0, 10488.213383996079, 11803.645890623295, 11842.230255033395, 12226.572069977508, 12172.33052182103, 12429.689257768629, 12455.614845966144, 12458.127931044739, 12759.425825837674, 8656.091110433566, 8975.0, 9062.91245050598, 9153.77115572116, 9219.49292788903, 11599.594014209462, 11676.649700508999, 11844.940775296069, 11871.821922671339, 11940.880591193976], "value": 9208.273010451914, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.668351253943, 1512.7882096506492, 1539.2765400261876, 1678.6978343898102, 1845.0866820923636, 8306.293965012974, 8675.132486751321, 8696.1303869613, 8702.434341767797, 8706.216440520351, 8500.872486912702, 8637.784055398619, 8706.347023973196, 8706.65173393065, 8718.912810871889, 2065.060397519125, 2294.552562250362, 2345.7536958619357, 2381.6070348392495, 2383.332666853284, 2381.3451300892307, 2383.7139543254834, 2385.6063749481314, 2386.5823480890863, 2395.425097976482, 2311.179531266401, 2341.4497593065616, 2348.753380895007, 2357.4931389751287, 2362.6574146748712, 1995.34153729269, 2234.340869443502, 2297.862128272309, 2302.113686230805, 2305.965410518827, 2261.4459457432868, 2287.1080278691325, 2290.393045842853, 2290.461741490765, 2312.491251924574, 8672.52301123438, 8700.43447175938, 8719.694810681596, 8724.825503489894, 8744.693935712283, 5265.0, 5446.2919820423485, 5454.400015998237, 5457.099578569571, 5459.863503412446, 3380.1211684962086, 3480.460528618068, 3505.1762835733584, 3548.0, 3550.840212190432, 1141.3323205924544, 1153.7865494883474, 1153.9262240639182, 1184.1000839362148, 1204.9939750301191, 12039.578614748441, 12047.457864396123, 12050.69873253167, 12065.276083435023, 12070.27578345302, 4634.884127896829, 4669.159551280734, 4790.640701947368, 4805.063012712488, 4806.8798280043275, 10186.286959912883, 10208.693739187836, 10215.846762298572, 10235.539400726986, 10261.538230779634, 5360.678359298455, 5400.270963419966, 5401.8109366172785, 5405.594580406407, 5412.621116521885, 4422.071365013319, 4759.0719809636785, 4875.658703890765, 4888.486708895514, 4936.062148191832, 4010.63904248619, 4042.988741044005, 4046.736962097454, 4109.383592461155, 4129.855455059119, 1310.9410076546578, 1315.6316231455207, 1331.5805521260772, 1339.243327519948, 1350.3585796746663, 872.7861673889938, 962.8122516109431, 972.3339512434005, 989.9505024748878, 1019.7450637340664, 5917.733701983421, 5954.732037058343, 6004.729787159588, 6023.668698221552, 6033.487153591994, 447.54797654368673, 460.69363873024736, 461.3978757721139, 462.782492228652, 471.07904047586885, 3861.1270343693254, 4043.595640435933, 4069.267531844237, 4088.4071809587444, 4124.278251306009, 10590.629327973484, 10946.452677366258, 10996.835047474295, 10999.835002474969, 11027.503762330714, 10585.57657693699, 10917.727056823644, 10942.124630029579, 10987.560497580007, 11036.613718519813, 8178.0, 8259.008918929767, 8272.793180170424, 8290.08809031006, 8372.497650141011, 5942.881142377215, 5986.551008674454, 6061.545384096298, 6069.726862291119, 6130.908036379368, 9964.153046991087, 10003.249756268455, 10031.749206269902, 10091.848622270525, 10106.646267380607, 10019.699409017741, 10126.645567405105, 10368.066873981377, 10377.636782712569, 10384.584616615553, 6874.9656251718425, 7527.510711803715, 7559.433042521943, 7868.606569671608, 8105.878411823709, 8177.672893084448, 8405.873911891204, 8434.662613495637, 8436.198561136682, 8448.788780280542, 7591.962040189764, 7690.346320562815, 7721.343685786771, 7757.340626046849, 7794.571298578632, 7429.33136017761, 7474.2525747427, 7510.173880873209, 7633.465657404151, 7647.502912310682, 6509.414152726277, 6557.180352455943, 6587.143671322698, 6593.340665933561, 6597.703103360456, 4756.785944632569, 5116.769745361542, 5127.615428842777, 5132.10188217068, 5286.920696189483, 5234.712090835041, 5240.4759524047295, 5245.265662807134, 5267.0256002639635, 5318.787248510016], "value": 4557.713621278304, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.5863529223762, 334.16958857239763, 340.0733002568002, 346.347135649301, 346.47509023828906, 5334.679919204846, 5340.25236466895, 5353.464653534645, 5372.38217604975, 5374.7850085996515, 5203.256908935511, 5300.867478313044, 5306.522412982831, 5321.536577441196, 5328.227407025988, 4093.570175131613, 4142.855000074998, 4157.501099868013, 4198.958010419888, 4256.97871510642, 4135.172965406916, 4162.0, 4198.559151289117, 4203.285441474942, 4244.49066112067, 4141.130362623852, 4158.8544400945975, 4168.43726096976, 4173.478315210598, 4205.642520385755, 3946.8026598670094, 4008.9576710055303, 4096.3036283831525, 4114.218298523271, 4147.958520414787, 3641.1261297288725, 3648.452732090181, 3650.3064417760543, 3652.721547458368, 3668.1746607013474, 4846.321514987904, 5033.798648054073, 5045.545900868903, 5064.341635587387, 5086.720230387327, 4571.817127314904, 4707.599854012413, 4709.858704238878, 4715.316279139505, 4727.57451829337, 5393.0, 5410.810621628224, 5431.293931788881, 5460.972695136538, 5499.312585926759, 3773.792441415721, 3990.6009399060154, 3999.680025597945, 4008.9198216035807, 4033.0925541753163, 5679.0, 5698.800541981011, 5699.173619825144, 5736.196932429463, 5743.157137217063, 3992.2215168042535, 4004.7196696231567, 4022.2156679447226, 4023.2154729827403, 4038.6163314485666, 4076.062505623723, 4104.15864747726, 4111.753294802322, 4119.938200926988, 4124.0, 4425.402570652985, 4648.465426475931, 4656.790444429941, 4686.461056978423, 4693.178693728584, 5502.98194833957, 5510.9448905511235, 5515.503604675599, 5516.475934786269, 5561.332640083216, 1396.3576754692956, 1400.7338605665095, 1402.3619253239751, 1412.9081609695336, 1415.3701602786866, 912.6577533424966, 975.9560819763128, 979.7354714227262, 986.7237173591406, 987.2891518106951, 5228.503292187313, 5280.656757310762, 5288.497592728685, 5305.62860599762, 5369.838904832784, 5580.302462192226, 5628.97185514078, 5633.155026746021, 5649.915251271234, 5651.519620832275, 5168.9224661630105, 5247.580193584504, 5347.171188465794, 5364.91952620711, 5388.326459192601, 2998.7301142897245, 3045.330027394014, 3049.87800487978, 3052.4200401923563, 3057.602511673468, 5734.136405668174, 5891.46976772084, 5895.528357731371, 5918.201042859245, 5932.48721576004, 5840.328362238397, 5846.1523079153285, 5854.975379308604, 5858.326292476419, 5869.618474799125, 5859.296884373903, 5918.23063001807, 5924.4667979882015, 5937.9406205937385, 5950.923617322148, 5501.229827824028, 5694.857628559153, 5697.202391665253, 5722.771089156554, 5723.141528770551, 5622.5501959842295, 5650.40670729584, 5652.943470565242, 5654.491095801398, 5654.773809047592, 5640.266765320482, 5829.271341082364, 5849.707514624337, 5872.383399742966, 5890.793822216202, 4037.9596204038758, 4051.8379264830255, 4051.8784436466954, 4055.858044968412, 4078.286299897447, 5657.915131272952, 5666.773329066791, 5690.203371527907, 5707.6575405475805, 5707.743151558107, 5385.25352070439, 5475.6440831345835, 5516.14499752539, 5580.581456390868, 5585.821529603377, 5452.563794896478, 5476.7535460903555, 5479.6164268500825, 5507.917381239205, 5517.668939863621, 5424.562490939983, 5428.131498960148, 5495.945040549544, 5502.367227768857, 5503.834884953458, 5267.78928842842, 5549.556035517068, 5568.49883510486, 5572.359178694502, 5628.971855140862, 5452.400235973961, 5463.699496527729, 5467.808626698046, 5478.589105817, 5508.614396992172], "value": 4233.182024859541, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.8853439182539, 745.3887811994164, 783.1502819440906, 819.6106849246609, 876.7588913048911, 13416.597502074928, 15887.0, 16158.596035099128, 16810.579735506602, 16815.49553513395, 15787.684246315066, 16634.168291585433, 16634.66730665386, 16671.08309043002, 16698.833011669878, 689.1213702529266, 815.2825513548084, 823.6499487717726, 823.9958800205991, 824.0235321144434, 805.9838803223932, 818.8853560501504, 820.0733171516179, 827.420805436197, 828.1263267253046, 844.8479273730726, 848.7750746052301, 850.8978922529305, 851.0213254757017, 852.1180578101666, 833.2542374574722, 838.8573942429801, 838.9874151887726, 841.4572600672562, 841.5707988925661, 613.3621034124506, 614.0819474885076, 616.7502161624549, 617.9289381721114, 618.0451202891543, 13782.241976691277, 13814.447422103103, 13815.792763108562, 13818.723625527533, 13819.447222111103, 15211.771823422658, 15382.230888455533, 15458.381664733397, 15691.136987465685, 15736.370545178179, 12265.754684906253, 12422.37888105591, 12441.688957776038, 12461.688457788538, 12681.17572357803, 3958.247932892741, 3963.128111815396, 3975.8807235782974, 3979.8408063677416, 3987.182627561372, 73293.9005914917, 73626.26373736301, 74191.62904185499, 74297.62851185763, 74345.62827185883, 11169.720756980978, 11466.770664586662, 11490.13823963206, 11673.241239319417, 11978.760424791455, 21432.78567214339, 21496.892515537635, 21515.139394424048, 21539.461513462287, 21613.243536476148, 8460.57697115154, 8832.646694132163, 9019.954900225457, 9084.545772711337, 9367.718968430958, 4815.181419158752, 4941.555260026615, 4957.578605818474, 5094.872628184325, 5105.9489405106215, 3607.2785442911522, 3744.6817020553012, 3750.6999440044733, 3751.6998640108727, 3753.399456087013, 654.9815037616457, 664.139938779282, 672.7275453441364, 676.090658064902, 702.8453740177152, 687.29895506583, 755.474944913291, 775.6819703921478, 789.4158322841056, 794.5312265763228, 10147.0, 10163.94918025405, 10307.330023548595, 10384.117350025332, 10437.895621043692, 694.9826254343682, 780.7384526183793, 796.80079980005, 797.3621103117483, 802.293981296467, 4734.644901632391, 4935.555799978019, 4947.134251505972, 4961.181405068195, 4965.875853103701, 114641.4267928655, 115348.15822101233, 117898.0, 117949.41025294819, 121328.0, 83783.5810820942, 94184.0, 96298.51850740702, 97073.51463242639, 99839.0, 87880.45214890537, 88394.55802720945, 89312.5534372337, 89512.0, 91160.08839911649, 9645.324827262304, 9883.950580247052, 9922.503874806374, 9996.850047249443, 10075.250210690336, 50103.49896501134, 50461.24308135454, 50749.23876141787, 51331.2300315503, 51500.48499514957, 56298.718506407204, 64060.35939640544, 64558.0, 73724.63137684278, 78045.21954780379, 13788.241646709528, 13836.654083647989, 14038.438462461387, 14194.077384969944, 14604.707905842037, 15030.173340465943, 15491.457798976982, 15807.13060781668, 16459.506214813573, 16540.172991350144, 14148.575542733735, 14524.85475145235, 14839.554813355617, 15209.0, 15265.923670381577, 14604.634884127981, 14636.780448293071, 14691.853081469477, 15371.558373480531, 15401.229938503255, 13854.307284635526, 14192.601844830277, 14302.57092287233, 14419.639509012359, 14677.339519721425, 12243.387830608255, 12407.813882791585, 12525.27655525162, 12526.37368131608, 12787.936060319638, 12176.75646487083, 12202.6949326264, 12260.26438413698, 12423.254604723745, 12435.93782031084], "value": 7814.198596375655, "unit": "score"}], "name": "dromaeo_css", "value": 7320.944195446922, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 111.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 132.0, 182.0, 127.0, 128.0, 151.0, 130.0, 180.0, 126.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 161.0, 160.0, 162.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 128.0, 74.0, 75.0, 73.0, 73.0, 101.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 114.0, 85.0, 85.0, 85.0, 126.0, 84.0, 84.0, 133.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 150.0, 146.0, 145.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 52.0, 52.0, 52.0, 51.0, 52.0, 52.0, 52.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 85.0, 84.0, 81.0, 87.0, 132.0, 85.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 125.0, 120.0, 134.0, 122.0, 121.0, 128.0, 133.0, 139.0, 123.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 160.0, 162.0, 160.0, 156.0, 160.0, 159.0, 157.0, 155.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 62.0, 62.0, 63.0, 67.0, 61.0, 63.0, 61.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1498.6, "alertThreshold": 2.0}]} 01:40:17 INFO - Return code: 0 01:40:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:40:18 ERROR - # TBPL SUCCESS # 01:40:18 INFO - Running post-action listener: _resource_record_post_action 01:40:18 INFO - ##### 01:40:18 INFO - ##### Finished run-tests step (success) 01:40:18 INFO - ##### 01:40:18 INFO - Running post-run listener: _resource_record_post_run 01:40:18 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 545107968; Read time: 20; Write time: 421568 01:40:18 INFO - TinderboxPrint: CPU usage
13.1% 01:40:18 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 01:40:18 INFO - TinderboxPrint: I/O write bytes / time
545,107,968 / 421,568 01:40:18 INFO - TinderboxPrint: CPU idle
8,255.0 (86.9%) 01:40:18 INFO - TinderboxPrint: CPU user
1,202.8 (12.7%) 01:40:18 INFO - TinderboxPrint: Swap in / out
0 / 0 01:40:18 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247623680; Read time: 0; Write time: 226976 01:40:18 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 296730624; Read time: 20; Write time: 194548 01:40:18 INFO - Running post-run listener: _upload_blobber_files 01:40:18 INFO - Blob upload gear active. 01:40:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:40:18 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:40:18 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:40:18 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:40:19 INFO - (blobuploader) - INFO - Open directory for files ... 01:40:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:40:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:40:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:40:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:40:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:40:19 INFO - (blobuploader) - INFO - Done attempting. 01:40:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:40:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:40:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:40:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:40:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:40:24 INFO - (blobuploader) - INFO - Done attempting. 01:40:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:40:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:40:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:40:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:40:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:40:25 INFO - (blobuploader) - INFO - Done attempting. 01:40:25 INFO - (blobuploader) - INFO - Iteration through files over. 01:40:25 INFO - Return code: 0 01:40:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:40:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:40:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8d8a32b64df41f899cc440fd6be28920c5c973fe293fc4e96ba9015e7c39c582f37f097b13b335f959473007736aee802a58cb819d77dfaeef492f6849a1e627", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/99c97303fe906df50b0dd89e9f8c32925825634a0061a0699ba86fab701e8dc3d4bd5ccce754808d0e900ab91c4641e6b13625d6308ce973f8f3accd7fc36cea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/db3b6bc5417effb2327714ca362c9ed2bdeb94f623f138d549b3bbc075884587f6d221e9897fa71da9fb9f8cb8e16d961a5a5b64d3a434b4938224f719a9eb81"} 01:40:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:40:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:40:25 INFO - Contents: 01:40:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8d8a32b64df41f899cc440fd6be28920c5c973fe293fc4e96ba9015e7c39c582f37f097b13b335f959473007736aee802a58cb819d77dfaeef492f6849a1e627", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/99c97303fe906df50b0dd89e9f8c32925825634a0061a0699ba86fab701e8dc3d4bd5ccce754808d0e900ab91c4641e6b13625d6308ce973f8f3accd7fc36cea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/db3b6bc5417effb2327714ca362c9ed2bdeb94f623f138d549b3bbc075884587f6d221e9897fa71da9fb9f8cb8e16d961a5a5b64d3a434b4938224f719a9eb81"} 01:40:25 INFO - Running post-run listener: copy_logs_to_upload_dir 01:40:25 INFO - Copying logs to upload dir... 01:40:25 INFO - mkdir: /builds/slave/test/build/upload/logs 01:40:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.394371 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-03 01:40:24.795166) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 01:40:24.800113) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8d8a32b64df41f899cc440fd6be28920c5c973fe293fc4e96ba9015e7c39c582f37f097b13b335f959473007736aee802a58cb819d77dfaeef492f6849a1e627", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/99c97303fe906df50b0dd89e9f8c32925825634a0061a0699ba86fab701e8dc3d4bd5ccce754808d0e900ab91c4641e6b13625d6308ce973f8f3accd7fc36cea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/db3b6bc5417effb2327714ca362c9ed2bdeb94f623f138d549b3bbc075884587f6d221e9897fa71da9fb9f8cb8e16d961a5a5b64d3a434b4938224f719a9eb81"} 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.011223 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8d8a32b64df41f899cc440fd6be28920c5c973fe293fc4e96ba9015e7c39c582f37f097b13b335f959473007736aee802a58cb819d77dfaeef492f6849a1e627", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/99c97303fe906df50b0dd89e9f8c32925825634a0061a0699ba86fab701e8dc3d4bd5ccce754808d0e900ab91c4641e6b13625d6308ce973f8f3accd7fc36cea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/db3b6bc5417effb2327714ca362c9ed2bdeb94f623f138d549b3bbc075884587f6d221e9897fa71da9fb9f8cb8e16d961a5a5b64d3a434b4938224f719a9eb81"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 01:40:24.828445) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:40:24.828851) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464941529.528534-29806704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 01:40:24.911381) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 01:40:24.912032) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 01:40:24.912330) ========= ========= Total master_lag: 0.20 =========