builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1465739965.7 results: success (0) buildid: 20160612043006 builduid: 9f83791a0ed84a08adc8ea56ee0562bf revision: 5834abf0aebb53d59c2ab4bea68448bd62a03d74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-12 06:59:25.702471) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-12 06:59:25.703244) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-12 06:59:25.703865) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-12 06:59:25.849749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 06:59:25.850039) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-12 06:59:26-- 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% 101M=0s 2016-06-12 06:59:26 (101 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100077 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 06:59:25.969739) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 06:59:25.970428) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019196 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 06:59:26.028095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 06:59:26.028878) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5834abf0aebb53d59c2ab4bea68448bd62a03d74 --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 5834abf0aebb53d59c2ab4bea68448bd62a03d74 --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=14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-12 06:59:27,048 truncating revision to first 12 chars 2016-06-12 06:59:27,048 Setting DEBUG logging. 2016-06-12 06:59:27,048 attempt 1/10 2016-06-12 06:59:27,048 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5834abf0aebb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-12 06:59:27,351 unpacking tar archive at: mozilla-inbound-5834abf0aebb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635890 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 06:59:26.685936) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-12 06:59:26.686733) ========= script_repo_revision: 5834abf0aebb53d59c2ab4bea68448bd62a03d74 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-12 06:59:26.687715) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-12 06:59:26.688405) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-12 06:59:26.705607) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-12 06:59:26.705952) ========= /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=14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:59:27 INFO - MultiFileLogger online at 20160612 06:59:27 in /builds/slave/test 06:59:27 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 06:59:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:59:27 INFO - {'append_to_log': False, 06:59:27 INFO - 'base_work_dir': '/builds/slave/test', 06:59:27 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 06:59:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:59:27 INFO - 'branch': 'Mozilla-Inbound', 06:59:27 INFO - 'buildbot_json_path': 'buildprops.json', 06:59:27 INFO - 'config_files': ('talos/linux_config.py',), 06:59:27 INFO - 'default_actions': ('clobber', 06:59:27 INFO - 'read-buildbot-config', 06:59:27 INFO - 'download-and-extract', 06:59:27 INFO - 'populate-webroot', 06:59:27 INFO - 'create-virtualenv', 06:59:27 INFO - 'install', 06:59:27 INFO - 'run-tests'), 06:59:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:59:27 INFO - 'download_minidump_stackwalk': True, 06:59:27 INFO - 'download_symbols': 'ondemand', 06:59:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:59:27 INFO - 'tooltool.py': '/tools/tooltool.py', 06:59:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:59:27 INFO - '/tools/misc-python/virtualenv.py')}, 06:59:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:59:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:59:27 INFO - 'installer_path': 'installer.exe', 06:59:27 INFO - 'log_level': 'info', 06:59:27 INFO - 'log_name': 'talos', 06:59:27 INFO - 'log_to_console': True, 06:59:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:59:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:59:27 INFO - 'opt_config_files': (), 06:59:27 INFO - 'pip_index': False, 06:59:27 INFO - 'sps_profile': False, 06:59:27 INFO - 'sps_profile_interval': 0, 06:59:27 INFO - 'suite': 'dromaeojs', 06:59:27 INFO - 'system_bits': '32', 06:59:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:59:27 INFO - 'title': 'talos-linux64-ix-036', 06:59:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:59:27 INFO - 'use_talos_json': True, 06:59:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:59:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:59:27 INFO - 'work_dir': 'build'} 06:59:27 INFO - ##### 06:59:27 INFO - ##### Running clobber step. 06:59:27 INFO - ##### 06:59:27 INFO - Running pre-action listener: _resource_record_pre_action 06:59:27 INFO - Running main action method: clobber 06:59:27 INFO - rmtree: /builds/slave/test/build 06:59:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:59:28 INFO - Running post-action listener: _resource_record_post_action 06:59:28 INFO - ##### 06:59:28 INFO - ##### Finished clobber step (success) 06:59:28 INFO - ##### 06:59:28 INFO - ##### 06:59:28 INFO - ##### Running read-buildbot-config step. 06:59:28 INFO - ##### 06:59:28 INFO - Running pre-action listener: _resource_record_pre_action 06:59:28 INFO - Running main action method: read_buildbot_config 06:59:28 INFO - Using buildbot properties: 06:59:28 INFO - { 06:59:28 INFO - "project": "", 06:59:28 INFO - "product": "firefox", 06:59:28 INFO - "script_repo_revision": "production", 06:59:28 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 06:59:28 INFO - "repository": "", 06:59:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 06:59:28 INFO - "buildid": "20160612043006", 06:59:28 INFO - "pgo_build": "True", 06:59:28 INFO - "basedir": "/builds/slave/test", 06:59:28 INFO - "buildnumber": 1098, 06:59:28 INFO - "slavename": "talos-linux64-ix-036", 06:59:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:59:28 INFO - "platform": "ubuntu64_hw", 06:59:28 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 06:59:28 INFO - "branch": "mozilla-inbound", 06:59:28 INFO - "repo_path": "integration/mozilla-inbound", 06:59:28 INFO - "revision": "5834abf0aebb53d59c2ab4bea68448bd62a03d74", 06:59:28 INFO - "stage_platform": "linux64-pgo", 06:59:28 INFO - "builduid": "9f83791a0ed84a08adc8ea56ee0562bf", 06:59:28 INFO - "slavebuilddir": "test" 06:59:28 INFO - } 06:59:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:59:28 INFO - Running post-action listener: _resource_record_post_action 06:59:28 INFO - ##### 06:59:28 INFO - ##### Finished read-buildbot-config step (success) 06:59:28 INFO - ##### 06:59:28 INFO - ##### 06:59:28 INFO - ##### Running download-and-extract step. 06:59:28 INFO - ##### 06:59:28 INFO - Running pre-action listener: _resource_record_pre_action 06:59:28 INFO - Running main action method: download_and_extract 06:59:28 INFO - mkdir: /builds/slave/test/build/tests 06:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:28 INFO - https://queue.taskcluster.net/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:59:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:59:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:59:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:59:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:59:29 INFO - Downloaded 1361 bytes. 06:59:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:59:29 INFO - Using the following test package requirements: 06:59:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:59:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:59:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:59:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:29 INFO - u'jsshell-linux-x86_64.zip'], 06:59:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:59:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:59:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:59:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:59:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:59:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:59:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:59:29 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')]} 06:59:29 INFO - https://queue.taskcluster.net/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:59:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:59:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:59:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:59:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:59:30 INFO - Downloaded 24217897 bytes. 06:59:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:59:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:59:31 INFO - Return code: 0 06:59:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:31 INFO - https://queue.taskcluster.net/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:59:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:59:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:59:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:59:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:59:45 INFO - Downloaded 24217897 bytes. 06:59:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:59:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:59:47 INFO - Return code: 0 06:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:47 INFO - https://queue.taskcluster.net/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:59:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:59:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:59:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:59:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:59:48 INFO - Downloaded 14405384 bytes. 06:59:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:59:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:59:48 INFO - Return code: 0 06:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:48 INFO - https://queue.taskcluster.net/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:59:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:59:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:59:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:59:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:59:49 INFO - Downloaded 59322722 bytes. 06:59:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:59:49 INFO - mkdir: /builds/slave/test/properties 06:59:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:59:49 INFO - Writing to file /builds/slave/test/properties/build_url 06:59:49 INFO - Contents: 06:59:49 INFO - build_url:https://queue.taskcluster.net/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:59:50 INFO - Running post-action listener: _resource_record_post_action 06:59:50 INFO - Running post-action listener: set_extra_try_arguments 06:59:50 INFO - ##### 06:59:50 INFO - ##### Finished download-and-extract step (success) 06:59:50 INFO - ##### 06:59:50 INFO - ##### 06:59:50 INFO - ##### Running populate-webroot step. 06:59:50 INFO - ##### 06:59:50 INFO - Running pre-action listener: _resource_record_pre_action 06:59:50 INFO - Running main action method: populate_webroot 06:59:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:59:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:59:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:59:50 INFO - '--tppagecycles', 06:59:50 INFO - '7'], 06:59:50 INFO - 'tests': ['tsvgm']}}, 06:59:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:59:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:59:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:59:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:59:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:59:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:59:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:50 INFO - 'talos_options': ['--disable-e10s'], 06:59:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:59:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:59:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:50 INFO - 'talos_options': ['--disable-e10s'], 06:59:50 INFO - 'tests': ['damp', 'tps']}, 06:59:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:50 INFO - 'tests': ['damp', 'tps']}, 06:59:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:59:50 INFO - 'tests': ['dromaeo_dom']}, 06:59:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:59:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:59:50 INFO - 'tests': ['basic_compositor_video']}, 06:59:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:59:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:59:50 INFO - 'tests': ['a11yr', 06:59:50 INFO - 'ts_paint', 06:59:50 INFO - 'tpaint', 06:59:50 INFO - 'sessionrestore', 06:59:50 INFO - 'sessionrestore_no_auto_restore', 06:59:50 INFO - 'tabpaint']}, 06:59:50 INFO - 'other-e10s': {'tests': ['a11yr', 06:59:50 INFO - 'ts_paint', 06:59:50 INFO - 'tpaint', 06:59:50 INFO - 'sessionrestore', 06:59:50 INFO - 'sessionrestore_no_auto_restore', 06:59:50 INFO - 'tabpaint']}, 06:59:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:59:50 INFO - 'ts_paint', 06:59:50 INFO - 'tpaint', 06:59:50 INFO - 'sessionrestore', 06:59:50 INFO - 'sessionrestore_no_auto_restore', 06:59:50 INFO - 'tabpaint']}, 06:59:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:59:50 INFO - 'ts_paint', 06:59:50 INFO - 'tpaint', 06:59:50 INFO - 'sessionrestore', 06:59:50 INFO - 'sessionrestore_no_auto_restore', 06:59:50 INFO - 'tabpaint']}, 06:59:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:59:50 INFO - 'tests': ['a11yr', 06:59:50 INFO - 'ts_paint', 06:59:50 INFO - 'tpaint', 06:59:50 INFO - 'sessionrestore', 06:59:50 INFO - 'sessionrestore_no_auto_restore', 06:59:50 INFO - 'tabpaint']}, 06:59:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:59:50 INFO - 'tests': ['a11yr', 06:59:50 INFO - 'ts_paint', 06:59:50 INFO - 'tpaint', 06:59:50 INFO - 'sessionrestore', 06:59:50 INFO - 'sessionrestore_no_auto_restore', 06:59:50 INFO - 'tabpaint']}, 06:59:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:59:50 INFO - 'tests': ['tsvgx', 06:59:50 INFO - 'tsvgr_opacity', 06:59:50 INFO - 'tart', 06:59:50 INFO - 'tscrollx', 06:59:50 INFO - 'cart']}, 06:59:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:59:50 INFO - 'tsvgr_opacity', 06:59:50 INFO - 'tart', 06:59:50 INFO - 'tscrollx', 06:59:50 INFO - 'cart']}, 06:59:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:50 INFO - 'talos_options': ['--disable-e10s'], 06:59:50 INFO - 'tests': ['tp5o']}, 06:59:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:50 INFO - 'tests': ['tp5o']}, 06:59:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:50 INFO - 'talos_options': ['--disable-e10s', 06:59:50 INFO - '--xperf_path', 06:59:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:59:50 INFO - 'tests': ['tp5n']}, 06:59:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:50 INFO - 'talos_options': ['--xperf_path', 06:59:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:59:50 INFO - 'tests': ['tp5n']}}, 06:59:50 INFO - 'talos.zip': {'path': '', 06:59:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:59:50 INFO - Running post-action listener: _resource_record_post_action 06:59:50 INFO - ##### 06:59:50 INFO - ##### Finished populate-webroot step (success) 06:59:50 INFO - ##### 06:59:50 INFO - ##### 06:59:50 INFO - ##### Running create-virtualenv step. 06:59:50 INFO - ##### 06:59:50 INFO - Running pre-action listener: _resource_record_pre_action 06:59:50 INFO - Running main action method: create_virtualenv 06:59:50 INFO - Creating virtualenv /builds/slave/test/build/venv 06:59:50 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 06:59:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:59:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:59:50 INFO - Using real prefix '/usr' 06:59:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:59:51 INFO - Installing distribute.............................................................................................................................................................................................done. 06:59:53 INFO - Installing pip.................done. 06:59:53 INFO - Return code: 0 06:59:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42b695ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bce20>, '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 0x14c03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c0830>, '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': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', '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 06:59:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:59:53 INFO - Using env: {'DISPLAY': ':0', 06:59:53 INFO - 'HOME': '/home/cltbld', 06:59:53 INFO - 'LANG': 'en_US.UTF-8', 06:59:53 INFO - 'LANGUAGE': 'en_US:en', 06:59:53 INFO - 'LOGNAME': 'cltbld', 06:59:53 INFO - 'MAIL': '/var/mail/cltbld', 06:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:53 INFO - 'MOZ_NO_REMOTE': '1', 06:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:53 INFO - 'NO_EM_RESTART': '1', 06:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:53 INFO - 'PWD': '/builds/slave/test', 06:59:53 INFO - 'SHELL': '/bin/bash', 06:59:53 INFO - 'SHLVL': '1', 06:59:53 INFO - 'TERM': 'linux', 06:59:53 INFO - 'TMOUT': '86400', 06:59:53 INFO - 'USER': 'cltbld', 06:59:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', 06:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:53 INFO - '_': '/tools/buildbot/bin/python'} 06:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:53 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 06:59:53 INFO - Cleaning up... 06:59:53 INFO - Return code: 0 06:59:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f42b695ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bce20>, '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 0x14c03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c0830>, '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': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', '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 06:59:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:59:53 INFO - Using env: {'DISPLAY': ':0', 06:59:53 INFO - 'HOME': '/home/cltbld', 06:59:53 INFO - 'LANG': 'en_US.UTF-8', 06:59:53 INFO - 'LANGUAGE': 'en_US:en', 06:59:53 INFO - 'LOGNAME': 'cltbld', 06:59:53 INFO - 'MAIL': '/var/mail/cltbld', 06:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:53 INFO - 'MOZ_NO_REMOTE': '1', 06:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:53 INFO - 'NO_EM_RESTART': '1', 06:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:53 INFO - 'PWD': '/builds/slave/test', 06:59:53 INFO - 'SHELL': '/bin/bash', 06:59:53 INFO - 'SHLVL': '1', 06:59:53 INFO - 'TERM': 'linux', 06:59:53 INFO - 'TMOUT': '86400', 06:59:53 INFO - 'USER': 'cltbld', 06:59:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', 06:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:53 INFO - '_': '/tools/buildbot/bin/python'} 06:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:53 INFO - Downloading/unpacking psutil>=3.1.1 06:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:59:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:59:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:59:55 INFO - Installing collected packages: psutil 06:59:55 INFO - Running setup.py install for psutil 06:59:55 INFO - building 'psutil._psutil_linux' extension 06:59:55 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 06:59:56 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 06:59:56 INFO - building 'psutil._psutil_posix' extension 06:59:56 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 06:59:56 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 06:59:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:59:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:59:56 INFO - Successfully installed psutil 06:59:56 INFO - Cleaning up... 06:59:56 INFO - Return code: 0 06:59:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:56 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 0x7f42b695ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bce20>, '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 0x14c03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c0830>, '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': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', '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 06:59:56 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 06:59:56 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 06:59:56 INFO - Using env: {'DISPLAY': ':0', 06:59:56 INFO - 'HOME': '/home/cltbld', 06:59:56 INFO - 'LANG': 'en_US.UTF-8', 06:59:56 INFO - 'LANGUAGE': 'en_US:en', 06:59:56 INFO - 'LOGNAME': 'cltbld', 06:59:56 INFO - 'MAIL': '/var/mail/cltbld', 06:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:56 INFO - 'MOZ_NO_REMOTE': '1', 06:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:56 INFO - 'NO_EM_RESTART': '1', 06:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:56 INFO - 'PWD': '/builds/slave/test', 06:59:56 INFO - 'SHELL': '/bin/bash', 06:59:56 INFO - 'SHLVL': '1', 06:59:56 INFO - 'TERM': 'linux', 06:59:56 INFO - 'TMOUT': '86400', 06:59:56 INFO - 'USER': 'cltbld', 06:59:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', 06:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:56 INFO - '_': '/tools/buildbot/bin/python'} 06:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:59:58 INFO - Installing collected packages: mozsystemmonitor 06:59:58 INFO - Running setup.py install for mozsystemmonitor 06:59:58 INFO - Successfully installed mozsystemmonitor 06:59:58 INFO - Cleaning up... 06:59:58 INFO - Return code: 0 06:59:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:59:58 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')]} 06:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:58 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')]} 06:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:58 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 0x7f42b695ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bce20>, '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 0x14c03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c0830>, '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': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', '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 06:59:58 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 06:59:58 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 06:59:58 INFO - Using env: {'DISPLAY': ':0', 06:59:58 INFO - 'HOME': '/home/cltbld', 06:59:58 INFO - 'LANG': 'en_US.UTF-8', 06:59:58 INFO - 'LANGUAGE': 'en_US:en', 06:59:58 INFO - 'LOGNAME': 'cltbld', 06:59:58 INFO - 'MAIL': '/var/mail/cltbld', 06:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:58 INFO - 'MOZ_NO_REMOTE': '1', 06:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:58 INFO - 'NO_EM_RESTART': '1', 06:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:58 INFO - 'PWD': '/builds/slave/test', 06:59:58 INFO - 'SHELL': '/bin/bash', 06:59:58 INFO - 'SHLVL': '1', 06:59:58 INFO - 'TERM': 'linux', 06:59:58 INFO - 'TMOUT': '86400', 06:59:58 INFO - 'USER': 'cltbld', 06:59:58 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', 06:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:58 INFO - '_': '/tools/buildbot/bin/python'} 06:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:58 INFO - Downloading/unpacking jsonschema==2.5.1 06:59:58 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 06:59:58 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 06:59:58 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 06:59:58 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 06:59:58 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 06:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:00:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:00 INFO - Downloading functools32-3.2.3-2.tar.gz 07:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:00:00 INFO - warning: no files found matching '*.txt' 07:00:00 INFO - no previously-included directories found matching 'build' 07:00:00 INFO - no previously-included directories found matching 'dist' 07:00:00 INFO - no previously-included directories found matching '.git*' 07:00:00 INFO - Installing collected packages: jsonschema, functools32 07:00:01 INFO - Running setup.py install for functools32 07:00:01 INFO - warning: no files found matching '*.txt' 07:00:01 INFO - no previously-included directories found matching 'build' 07:00:01 INFO - no previously-included directories found matching 'dist' 07:00:01 INFO - no previously-included directories found matching '.git*' 07:00:01 INFO - Successfully installed jsonschema functools32 07:00:01 INFO - Cleaning up... 07:00:01 INFO - Return code: 0 07:00:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:01 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 0x7f42b695ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bce20>, '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 0x14c03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c0830>, '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': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:00:01 INFO - Using env: {'DISPLAY': ':0', 07:00:01 INFO - 'HOME': '/home/cltbld', 07:00:01 INFO - 'LANG': 'en_US.UTF-8', 07:00:01 INFO - 'LANGUAGE': 'en_US:en', 07:00:01 INFO - 'LOGNAME': 'cltbld', 07:00:01 INFO - 'MAIL': '/var/mail/cltbld', 07:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:01 INFO - 'MOZ_NO_REMOTE': '1', 07:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:01 INFO - 'NO_EM_RESTART': '1', 07:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:01 INFO - 'PWD': '/builds/slave/test', 07:00:01 INFO - 'SHELL': '/bin/bash', 07:00:01 INFO - 'SHLVL': '1', 07:00:01 INFO - 'TERM': 'linux', 07:00:01 INFO - 'TMOUT': '86400', 07:00:01 INFO - 'USER': 'cltbld', 07:00:01 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', 07:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:01 INFO - '_': '/tools/buildbot/bin/python'} 07:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:01 INFO - Downloading/unpacking blobuploader==1.2.4 07:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:03 INFO - Downloading blobuploader-1.2.4.tar.gz 07:00:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:00:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:00:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:04 INFO - Downloading docopt-0.6.1.tar.gz 07:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:00:04 INFO - Installing collected packages: blobuploader, requests, docopt 07:00:04 INFO - Running setup.py install for blobuploader 07:00:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:00:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:00:04 INFO - Running setup.py install for requests 07:00:04 INFO - Running setup.py install for docopt 07:00:04 INFO - Successfully installed blobuploader requests docopt 07:00:04 INFO - Cleaning up... 07:00:04 INFO - Return code: 0 07:00:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:04 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 0x7f42b695ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bce20>, '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 0x14c03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c0830>, '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': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:00:04 INFO - Using env: {'DISPLAY': ':0', 07:00:04 INFO - 'HOME': '/home/cltbld', 07:00:04 INFO - 'LANG': 'en_US.UTF-8', 07:00:04 INFO - 'LANGUAGE': 'en_US:en', 07:00:04 INFO - 'LOGNAME': 'cltbld', 07:00:04 INFO - 'MAIL': '/var/mail/cltbld', 07:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:04 INFO - 'MOZ_NO_REMOTE': '1', 07:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:04 INFO - 'NO_EM_RESTART': '1', 07:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:04 INFO - 'PWD': '/builds/slave/test', 07:00:04 INFO - 'SHELL': '/bin/bash', 07:00:04 INFO - 'SHLVL': '1', 07:00:04 INFO - 'TERM': 'linux', 07:00:04 INFO - 'TMOUT': '86400', 07:00:04 INFO - 'USER': 'cltbld', 07:00:04 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', 07:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:04 INFO - '_': '/tools/buildbot/bin/python'} 07:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:00:04 INFO - Running setup.py (path:/tmp/pip-KhGFNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:00:05 INFO - Running setup.py (path:/tmp/pip-eHv0CX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:00:05 INFO - Running setup.py (path:/tmp/pip-rfsuJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:00:05 INFO - Running setup.py (path:/tmp/pip-Pyjg1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:00:05 INFO - Running setup.py (path:/tmp/pip-WC9qZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:00:05 INFO - Running setup.py (path:/tmp/pip-fjgcsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:00:05 INFO - Running setup.py (path:/tmp/pip-5CgM42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:00:05 INFO - Running setup.py (path:/tmp/pip-96a8wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:00:05 INFO - Running setup.py (path:/tmp/pip-zUpr24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:00:05 INFO - Running setup.py (path:/tmp/pip-iYhLTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:00:05 INFO - Running setup.py (path:/tmp/pip-AMtvpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:00:05 INFO - Running setup.py (path:/tmp/pip-C103I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:00:05 INFO - Running setup.py (path:/tmp/pip-RTbmQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:00:05 INFO - Running setup.py (path:/tmp/pip-I9BlVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:05 INFO - Running setup.py (path:/tmp/pip-Jp7mhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:00:06 INFO - Running setup.py (path:/tmp/pip-KHtdCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:00:06 INFO - Running setup.py (path:/tmp/pip-gN0c86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:00:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:00:06 INFO - Running setup.py install for manifestparser 07:00:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:00:06 INFO - Running setup.py install for mozcrash 07:00:06 INFO - Running setup.py install for mozdebug 07:00:06 INFO - Running setup.py install for mozdevice 07:00:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:00:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:00:06 INFO - Running setup.py install for mozfile 07:00:06 INFO - Running setup.py install for mozhttpd 07:00:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:00:06 INFO - Running setup.py install for mozinfo 07:00:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:00:06 INFO - Running setup.py install for mozInstall 07:00:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:00:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:00:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:00:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:00:07 INFO - Running setup.py install for mozleak 07:00:07 INFO - Running setup.py install for mozlog 07:00:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:00:07 INFO - Running setup.py install for moznetwork 07:00:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:00:07 INFO - Running setup.py install for mozprocess 07:00:07 INFO - Running setup.py install for mozprofile 07:00:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:00:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:00:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:00:07 INFO - Running setup.py install for mozrunner 07:00:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:00:07 INFO - Running setup.py install for mozscreenshot 07:00:07 INFO - Running setup.py install for moztest 07:00:07 INFO - Running setup.py install for mozversion 07:00:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:00:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:00:08 INFO - Cleaning up... 07:00:08 INFO - Return code: 0 07:00:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:08 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 0x7f42b695ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bce20>, '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 0x14c03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c0830>, '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': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:00:08 INFO - Using env: {'DISPLAY': ':0', 07:00:08 INFO - 'HOME': '/home/cltbld', 07:00:08 INFO - 'LANG': 'en_US.UTF-8', 07:00:08 INFO - 'LANGUAGE': 'en_US:en', 07:00:08 INFO - 'LOGNAME': 'cltbld', 07:00:08 INFO - 'MAIL': '/var/mail/cltbld', 07:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:08 INFO - 'MOZ_NO_REMOTE': '1', 07:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:08 INFO - 'NO_EM_RESTART': '1', 07:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:08 INFO - 'PWD': '/builds/slave/test', 07:00:08 INFO - 'SHELL': '/bin/bash', 07:00:08 INFO - 'SHLVL': '1', 07:00:08 INFO - 'TERM': 'linux', 07:00:08 INFO - 'TMOUT': '86400', 07:00:08 INFO - 'USER': 'cltbld', 07:00:08 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', 07:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:08 INFO - '_': '/tools/buildbot/bin/python'} 07:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:00:08 INFO - Running setup.py (path:/tmp/pip-BVsK_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:00:08 INFO - Running setup.py (path:/tmp/pip-eqggbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:00:08 INFO - Running setup.py (path:/tmp/pip-wPSLf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:00:08 INFO - Running setup.py (path:/tmp/pip-vk2lJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:00:08 INFO - Running setup.py (path:/tmp/pip-IGODGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:00:08 INFO - Running setup.py (path:/tmp/pip-IMIPHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:00:08 INFO - Running setup.py (path:/tmp/pip-6SifMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:00:08 INFO - Running setup.py (path:/tmp/pip-i9EjuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:00:08 INFO - Running setup.py (path:/tmp/pip-vuwlua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:00:08 INFO - Running setup.py (path:/tmp/pip-WhvlQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:00:08 INFO - Running setup.py (path:/tmp/pip-mWu6Gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:00:09 INFO - Running setup.py (path:/tmp/pip-EVCwLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:00:09 INFO - Running setup.py (path:/tmp/pip-vIfuwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:00:09 INFO - Running setup.py (path:/tmp/pip-UrXKwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:09 INFO - Running setup.py (path:/tmp/pip-EYp67L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:00:09 INFO - Running setup.py (path:/tmp/pip-PiiykA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:00:09 INFO - Running setup.py (path:/tmp/pip-fnncqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:00:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:11 INFO - Downloading blessings-1.6.tar.gz 07:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:00:11 INFO - Installing collected packages: blessings 07:00:11 INFO - Running setup.py install for blessings 07:00:11 INFO - Successfully installed blessings 07:00:11 INFO - Cleaning up... 07:00:11 INFO - Return code: 0 07:00:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:00:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:11 INFO - Reading from file tmpfile_stdout 07:00:11 INFO - Current package versions: 07:00:11 INFO - argparse == 1.2.1 07:00:11 INFO - blessings == 1.6 07:00:11 INFO - blobuploader == 1.2.4 07:00:11 INFO - docopt == 0.6.1 07:00:11 INFO - functools32 == 3.2.3-2 07:00:11 INFO - jsonschema == 2.5.1 07:00:11 INFO - manifestparser == 1.1 07:00:11 INFO - mozInstall == 1.12 07:00:11 INFO - mozcrash == 0.17 07:00:11 INFO - mozdebug == 0.1 07:00:11 INFO - mozdevice == 0.48 07:00:11 INFO - mozfile == 1.2 07:00:11 INFO - mozhttpd == 0.7 07:00:11 INFO - mozinfo == 0.9 07:00:11 INFO - mozleak == 0.1 07:00:11 INFO - mozlog == 3.2 07:00:11 INFO - moznetwork == 0.27 07:00:11 INFO - mozprocess == 0.22 07:00:11 INFO - mozprofile == 0.28 07:00:11 INFO - mozrunner == 6.11 07:00:11 INFO - mozscreenshot == 0.1 07:00:11 INFO - mozsystemmonitor == 0.3 07:00:11 INFO - moztest == 0.7 07:00:11 INFO - mozversion == 1.4 07:00:11 INFO - psutil == 3.1.1 07:00:11 INFO - requests == 1.2.3 07:00:11 INFO - wsgiref == 0.1.2 07:00:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:11 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 0x7f42b695ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bce20>, '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 0x14c03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c0830>, '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': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:00:11 INFO - Using env: {'DISPLAY': ':0', 07:00:11 INFO - 'HOME': '/home/cltbld', 07:00:11 INFO - 'LANG': 'en_US.UTF-8', 07:00:11 INFO - 'LANGUAGE': 'en_US:en', 07:00:11 INFO - 'LOGNAME': 'cltbld', 07:00:11 INFO - 'MAIL': '/var/mail/cltbld', 07:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:11 INFO - 'MOZ_NO_REMOTE': '1', 07:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:11 INFO - 'NO_EM_RESTART': '1', 07:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:11 INFO - 'PWD': '/builds/slave/test', 07:00:11 INFO - 'SHELL': '/bin/bash', 07:00:11 INFO - 'SHLVL': '1', 07:00:11 INFO - 'TERM': 'linux', 07:00:11 INFO - 'TMOUT': '86400', 07:00:11 INFO - 'USER': 'cltbld', 07:00:11 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', 07:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:11 INFO - '_': '/tools/buildbot/bin/python'} 07:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:00:12 INFO - Cleaning up... 07:00:12 INFO - Return code: 0 07:00:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:12 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 0x7f42b695ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bce20>, '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 0x14c03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c0830>, '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': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:00:12 INFO - Using env: {'DISPLAY': ':0', 07:00:12 INFO - 'HOME': '/home/cltbld', 07:00:12 INFO - 'LANG': 'en_US.UTF-8', 07:00:12 INFO - 'LANGUAGE': 'en_US:en', 07:00:12 INFO - 'LOGNAME': 'cltbld', 07:00:12 INFO - 'MAIL': '/var/mail/cltbld', 07:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:12 INFO - 'MOZ_NO_REMOTE': '1', 07:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:12 INFO - 'NO_EM_RESTART': '1', 07:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:12 INFO - 'PWD': '/builds/slave/test', 07:00:12 INFO - 'SHELL': '/bin/bash', 07:00:12 INFO - 'SHLVL': '1', 07:00:12 INFO - 'TERM': 'linux', 07:00:12 INFO - 'TMOUT': '86400', 07:00:12 INFO - 'USER': 'cltbld', 07:00:12 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', 07:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:12 INFO - '_': '/tools/buildbot/bin/python'} 07:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:00:12 INFO - Cleaning up... 07:00:12 INFO - Return code: 0 07:00:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:12 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 0x7f42b695ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c22e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bce20>, '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 0x14c03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c0830>, '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': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:00:12 INFO - Using env: {'DISPLAY': ':0', 07:00:12 INFO - 'HOME': '/home/cltbld', 07:00:12 INFO - 'LANG': 'en_US.UTF-8', 07:00:12 INFO - 'LANGUAGE': 'en_US:en', 07:00:12 INFO - 'LOGNAME': 'cltbld', 07:00:12 INFO - 'MAIL': '/var/mail/cltbld', 07:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:12 INFO - 'MOZ_NO_REMOTE': '1', 07:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:12 INFO - 'NO_EM_RESTART': '1', 07:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:12 INFO - 'PWD': '/builds/slave/test', 07:00:12 INFO - 'SHELL': '/bin/bash', 07:00:12 INFO - 'SHLVL': '1', 07:00:12 INFO - 'TERM': 'linux', 07:00:12 INFO - 'TMOUT': '86400', 07:00:12 INFO - 'USER': 'cltbld', 07:00:12 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', 07:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:12 INFO - '_': '/tools/buildbot/bin/python'} 07:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:12 INFO - Downloading/unpacking flake8 07:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:00:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:00:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:00:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:00:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:00:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:00:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:00:15 INFO - no previously-included directories found matching 'docs/_build' 07:00:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:00:15 INFO - Running setup.py install for pep8 07:00:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:00:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:00:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:00:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:00:15 INFO - no previously-included directories found matching 'docs/_build' 07:00:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:00:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:00:15 INFO - Cleaning up... 07:00:15 INFO - Return code: 0 07:00:15 INFO - Running post-action listener: _resource_record_post_action 07:00:15 INFO - Running post-action listener: _start_resource_monitoring 07:00:15 INFO - Starting resource monitoring. 07:00:15 INFO - ##### 07:00:15 INFO - ##### Finished create-virtualenv step (success) 07:00:15 INFO - ##### 07:00:15 INFO - ##### 07:00:15 INFO - ##### Running install step. 07:00:15 INFO - ##### 07:00:15 INFO - Running pre-action listener: _resource_record_pre_action 07:00:15 INFO - Running main action method: install 07:00:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:15 INFO - Reading from file tmpfile_stdout 07:00:15 INFO - Detecting whether we're running mozinstall >=1.0... 07:00:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:00:15 INFO - Reading from file tmpfile_stdout 07:00:15 INFO - Output received: 07:00:15 INFO - Usage: mozinstall [options] installer 07:00:15 INFO - Options: 07:00:15 INFO - -h, --help show this help message and exit 07:00:15 INFO - -d DEST, --destination=DEST 07:00:15 INFO - Directory to install application into. [default: 07:00:15 INFO - "/builds/slave/test"] 07:00:15 INFO - --app=APP Application being installed. [default: firefox] 07:00:15 INFO - mkdir: /builds/slave/test/build/application 07:00:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:00:32 INFO - Reading from file tmpfile_stdout 07:00:32 INFO - Output received: 07:00:32 INFO - /builds/slave/test/build/application/firefox/firefox 07:00:32 INFO - Running post-action listener: _resource_record_post_action 07:00:32 INFO - ##### 07:00:32 INFO - ##### Finished install step (success) 07:00:32 INFO - ##### 07:00:32 INFO - ##### 07:00:32 INFO - ##### Running run-tests step. 07:00:32 INFO - ##### 07:00:32 INFO - Running pre-action listener: _resource_record_pre_action 07:00:32 INFO - Running main action method: run_tests 07:00:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:00:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:00:32 INFO - Python 2.7.3 07:00:32 INFO - Return code: 0 07:00:32 INFO - grabbing minidump binary from tooltool 07:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:32 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 0x14bce20>, '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 0x14c03a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c0830>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:00:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:00:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:00:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:00:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:00:32 INFO - Return code: 0 07:00:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:00:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:00:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:00:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:00:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:00:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:00:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:00:33 INFO - Return code: 0 07:00:33 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/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 07:00:33 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/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 07:00:33 INFO - Using env: {'DISPLAY': ':0', 07:00:33 INFO - 'HOME': '/home/cltbld', 07:00:33 INFO - 'LANG': 'en_US.UTF-8', 07:00:33 INFO - 'LANGUAGE': 'en_US:en', 07:00:33 INFO - 'LOGNAME': 'cltbld', 07:00:33 INFO - 'MAIL': '/var/mail/cltbld', 07:00:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:00:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:33 INFO - 'MOZ_NO_REMOTE': '1', 07:00:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:33 INFO - 'NO_EM_RESTART': '1', 07:00:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:33 INFO - 'PWD': '/builds/slave/test', 07:00:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:00:33 INFO - 'SHELL': '/bin/bash', 07:00:33 INFO - 'SHLVL': '1', 07:00:33 INFO - 'TERM': 'linux', 07:00:33 INFO - 'TMOUT': '86400', 07:00:33 INFO - 'USER': 'cltbld', 07:00:33 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904', 07:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:33 INFO - '_': '/tools/buildbot/bin/python'} 07:00:33 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/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 07:00:33 INFO - mozversion application_buildid: 20160612043006 07:00:33 INFO - mozversion application_changeset: 5834abf0aebb53d59c2ab4bea68448bd62a03d74 07:00:33 INFO - mozversion application_display_name: Nightly 07:00:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:00:33 INFO - mozversion application_name: Firefox 07:00:33 INFO - mozversion application_remotingname: firefox 07:00:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:00:33 INFO - mozversion application_vendor: Mozilla 07:00:33 INFO - mozversion application_version: 50.0a1 07:00:33 INFO - mozversion platform_buildid: 20160612043006 07:00:33 INFO - mozversion platform_changeset: 5834abf0aebb53d59c2ab4bea68448bd62a03d74 07:00:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:00:33 INFO - mozversion platform_version: 50.0a1 07:00:33 INFO - using testdate: 1465740033 07:00:33 INFO - actual date: 1465740033 07:00:33 INFO - starting webserver on 'localhost:34591' 07:00:33 INFO - SUITE-START | Running 2 tests 07:00:33 INFO - TEST-START | dromaeo_css 07:00:33 INFO - operating with platform_type : linux_ 07:00:33 INFO - Initialising browser for dromaeo_css test... 07:00:33 INFO - TEST-INFO | started process 4179 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLzznz0/profile http://localhost:34591/getInfo.html) 07:00:38 INFO - PROCESS | 4179 | __metrics Screen width/height:1600/1200 07:00:38 INFO - PROCESS | 4179 | colorDepth:24 07:00:38 INFO - PROCESS | 4179 | Browser inner width/height: 1024/697 07:00:38 INFO - PROCESS | 4179 | __metrics 07:00:39 INFO - PROCESS | 4179 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:00:39 INFO - PROCESS | 4179 | console.error: PushService: 07:00:39 INFO - PROCESS | 4179 | stateChangeProcessEnqueue: Error transitioning state 07:00:39 INFO - PROCESS | 4179 | UnknownError 07:00:40 INFO - TEST-INFO | 4179: exit 0 07:00:40 INFO - Browser initialized. 07:00:40 INFO - Running cycle 1/1 for dromaeo_css test... 07:00:40 INFO - TEST-INFO | started process 4263 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLzznz0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:00:52 INFO - PROCESS | 4263 | RSS: Main: 174116864 07:00:52 INFO - PROCESS | 4263 | 07:01:43 INFO - PROCESS | 4263 | 1465740103914 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:03:51 INFO - PROCESS | 4263 | Cycle 1(1): loaded http://localhost:34591/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34591/tests/dromaeo/cssquery-ext.html) 07:03:53 INFO - PROCESS | 4263 | RSS: Main: 303255552 07:03:53 INFO - PROCESS | 4263 | 07:06:55 INFO - PROCESS | 4263 | Cycle 1(1): loaded http://localhost:34591/tests/dromaeo/cssquery-ext.html (next: http://localhost:34591/tests/dromaeo/cssquery-jquery.html) 07:06:56 INFO - PROCESS | 4263 | RSS: Main: 262799360 07:06:56 INFO - PROCESS | 4263 | 07:09:58 INFO - PROCESS | 4263 | Cycle 1(1): loaded http://localhost:34591/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34591/tests/dromaeo/cssquery-mootools.html) 07:09:58 INFO - PROCESS | 4263 | RSS: Main: 254828544 07:09:58 INFO - PROCESS | 4263 | 07:13:00 INFO - PROCESS | 4263 | Cycle 1(1): loaded http://localhost:34591/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34591/tests/dromaeo/cssquery-prototype.html) 07:13:01 INFO - PROCESS | 4263 | RSS: Main: 258535424 07:13:01 INFO - PROCESS | 4263 | 07:16:03 INFO - PROCESS | 4263 | Cycle 1(1): loaded http://localhost:34591/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34591/tests/dromaeo/cssquery-yui.html) 07:16:04 INFO - PROCESS | 4263 | RSS: Main: 221294592 07:16:04 INFO - PROCESS | 4263 | 07:19:07 INFO - PROCESS | 4263 | Cycle 1(1): loaded http://localhost:34591/tests/dromaeo/cssquery-yui.html (next: http://localhost:34591/tests/dromaeo/cssquery-dojo.html) 07:19:07 INFO - PROCESS | 4263 | RSS: Main: 290254848 07:19:07 INFO - PROCESS | 4263 | 07:19:07 INFO - PROCESS | 4263 | __start_tp_report 07:19:07 INFO - PROCESS | 4263 | _x_x_mozilla_page_load 07:19:07 INFO - PROCESS | 4263 | _x_x_mozilla_page_load_details 07:19:07 INFO - PROCESS | 4263 | |i|pagename|runs| 07:19:07 INFO - PROCESS | 4263 | |0;dojo.html;3084.336867573472;3099.2561785171565;3104.3946430446063;3138.4507711150545;3157.5421563873238;5220.164773636219;5279;5347.946520534793;5354.598405119617;5407.567394608432;5411.053065713494;5425.077736784756;5492.890142197164;5503.7798488060425;5593.300837395325;4877.609791216694;4900.632452566054;4913.8771530711665;4961.5286547777905;4983.053219888209;5086.974565127188;5118.9488105119035;5121.743912804363;5162.896742065175;5165.380154381461;4730.219513780256;5025.1708468102715;5059.7723102460295;5087.313212716292;5103.540681338679;4752.453467851206;4867.123917694814;4872.366592343008;4925.901481970341;4961.429435614915;4841.2012018016985;4871.342368780205;4941.579965702884;4952.925706114411;4981.5267549583095;5258.0535503609335;5457.972710136424;5468.9726551367385;5469.863253418656;5503.284573005523;5792.247007888989;5807.157962095473;5835.9708201458725;5903.49820265278;5912.6156799808305;5904.940950590482;5907.379725128885;5950;5952.107183922446;5964.701764911781;5271.866548691973;5478.616496845222;5544.085225937715;5547.55619550435;5549.6115271930985;5892.440218179266;5938.406159384027;5941.792037278675;6013.54898382623;6018.789342373084;5789.797357092481;5795.1017592273265;5840.737166827418;5851.61964472308;5855.033919403336;5514.338279406497;5793.971030144822;5892.322382925932;5929.288485381696;5934.406559344117;5821.941780582225;5875.353711091777;5877.52979761618;5889.234399528034;5933.792317268875;5840.737166827503;5871.94128058714;5892.145638882338;5896.410358964069;5902.085176797603;4291.74249545022;4399.802008909607;4431.335299705005;4497.415336006364;4504.48198457175;3960.6039396060164;3964.9801750991637;3965.306071437487;3997.8800635980965;4008.498937632796;5416.539594134464;5421.512063914267;5432.972835135878;5434;5474.753636086386;5605.7197140142825;5798.88402231953;5851.970740146272;5862.032764593794;5896;5493.258410114663;5504.532114770209;5507.807226747044;5508.697021663847;5520.227168196456;5056.393232812013;5062.038212739568;5064.240363945364;5073.518015788494;5110.105731497048;5697.9430205698245;5909;5952.345242023374;5964.433378829004;6014.879702406015;5825.563082768725;5835.328937172109;5840.094785308284;5840.766369345179;5845.941540584539;5736.713164341682;5999.130126131599;6000.429959154048;6008.8798224036145;6014.699265036818;5631.577631677558;5663.631863928831;5678.914816277842;5695.658260504383;5697.1454281856395;5801.883962320646;5847.298324200953;5850.0932355484965;5850.414958504116;5856.238688970407;5491.780328786964;5600.355959064596;5641.069223578228;5703.657780533182;5714.857128571819;5620.887582248414;5677.205191273142;5681.0626246668835;5684.346300175533;5736.799212027559;5592.972035139798;5597.80407685729;5600.523955463831;5601.887962240814;5605.5235304997905;5603.8879222416135;5714.657120572779;5723.427657234243;5775.047117225611;5806.854828629149;5377.24718539397;5414.891702166014;5590.217369568182;5632.915506267327;5734.283214598176 07:19:07 INFO - PROCESS | 4263 | |1;ext.html;589.1133843565433;620.7734177025384;624.9968750156248;627.7896904536979;632.2792017100503;31274.68725312746;43888.56111438889;44904.326435103416;44975.32537011948;47892.28161577579;46199.76900115495;46629.53370466294;46663.53336466634;46669.53330466694;46683.766581167045;8052.396070294722;8984.056674049245;9143.542822858864;10703.83944240837;10978.670639880776;10815.513301901434;10902.345859248431;10903.672889813319;10910.672679819618;10914.836277455845;10919.235653504258;10950.890491095066;10964;10967.341959482457;10975.231733778639;8172.18278172181;10872.510737016813;11153.553857845676;11164.888351116466;11450.885491145065;10574.52414641343;10655.52050157737;10656.893431065668;10994.835077473765;10996.12031037523;44627.10745785066;45199.774001130114;45228.3215751764;45255;45262;3588.910277243064;3647.379945409287;3712.053426376257;4056.594340565949;4131.256373852705;34201.31597368039;34334.14164645879;34336.65663343384;34483.82758086194;34604.82697586496;3987.2224916141363;3994.8801535953967;4003.459532963042;4021.698372622065;4061.1471590965934;366641;370501;371417;371424;372591;40216.79891600523;41249.38125928114;41288.38067428991;41332;41393.1721365571;40976;41037.58962410338;41131;41192.79403602963;41194;14700.485483008044;16258.18709064542;16385.50843474698;16397;16406.507804765875;13284.667883302802;13582.456701732017;13636.93181534086;13976.790348144787;13980.930095349662;9246.86129708055;9323.766905827408;9328.160465558132;9393.859092113624;9393.953030234805;3520.207953210507;3532.2229109595846;3582.964170358315;3589.5513060867393;3633.1643721943574;1047.4867315015588;1049.1763965287214;1114.7491814341709;1141.8743938166795;1176.5352685689104;32655.67344326574;33021.17447063843;33090.338193236;33182.336353272796;33752;1141.2524796258465;1141.452102990569;1157.0801213035488;1164.714644912002;1200.5617949448388;16987.830121698626;17481.56296092608;17555.561110972074;17575.82424175742;17581.208845601977;579586;582211;586680;591402;593050;60336.396636033955;61178;61244;61287;61300.38699613036;1244.887960083597;1342.4227582139579;1379.2896658221025;1379.9655008624866;1389.7637401641746;32474.675253247166;34036;34212.48681269833;34487.4826877592;34639.4804077934;47336.289955650005;47543.52456475391;47586.28620570625;47610.28584571165;47620.76189619168;417912;421614;421677;421970;423101;26493.33766655849;29601.85199073991;29995.55006674858;30449;30652.84673576618;49727;49808.50191498183;50242;50243.74878125732;51004.74497627488;41121.794391027855;42647;42669.57330426656;43342.566574333854;44046.91671582958;42125.789371052946;42402.363964541175;42550;43136;43346.78326608347;41920.161596767284;42341.78829105958;43112.35331469968;43268.56731432645;43296.56703432925;36035.819820900724;37508.43737343996;37919;38232.808835956756;38386.6161338383;28541.714582853907;28781.85609071941;28817.85591072031;28858;29001.274968125967 07:19:07 INFO - PROCESS | 4263 | |2;jquery.html;407.63166005508003;407.8062920112946;413.2252027448534;419.1219395366706;422.2905518728535;13478.932605336984;17491.387801426954;18741.15664795084;19550;19637.410877673658;15058.322375493102;17493.82506174938;18253.817461825376;18261.452156435327;18546.443606691788;5732.684702341369;5930.614510056833;5954.672493012882;5960.284765828107;5965.61223520472;5801.593888427812;5822.82004632806;5864.794732184374;5867.207926929853;5893.233879595647;5723.370429252779;5840.211571437865;5845.473907348338;5855.941440585603;5860.531157507389;5724.427557244284;5765.481106700396;5828.358880523139;5842.707864606774;5847.502962248214;5217.034848553029;5224.582033437316;5229.450907654679;5250.789968401259;5254.6847189168775;16953.067581283023;21806;22295.331140065824;22866.31401057971;22893.88553057224;2122.7983341582526;2303.424143964009;2426.720927093389;2665.9066932657456;2919.343147791751;10466.1627069835;10468.47657617116;10475.58579591753;10503.579856805718;11764.00005999491;1878.474027272366;1938.7285779990812;2006.7892871248455;2014.9899250503654;2037.6128535578193;82390;84462.57768711117;85377.14622853755;85505.14494855034;85909.14090859074;11132.220744547965;11172.944135279271;11288.661340159808;11309.264897781617;11520.88479115198;15600.453984110502;15692.450764223197;15858.444954426539;15861.127637980022;15888.205589720468;8062.153473885275;8474.830503389898;8534.359923005799;8596.097409772008;8664.740057798275;8205.835883282301;8262.132476090044;8264.049634292012;8367.623456944451;8370.53962032094;4302.720323178984;4340.500842403101;4678.368420263289;4680.81276748933;4705.176594096088;1988.125224901039;2009.5880344529337;2065.865718728278;2069.6067747128;2090.3833369156137;911.6444586611227;982.268210183418;985.827480190978;994.0953732103751;1058.640062378795;18785.15466803997;19034.714479282822;19041.42875713703;19222.80777192238;19434;967.2552134856121;992.7220378294089;998.8851282102651;1005.7614481369977;1038.5222797513077;10097.545610447547;10814.134869210444;10903.890961090447;10910.23628346008;10910.672679819618;365961;373110;483130;502153;502356;93941.53029234947;95799;97625.53561696438;97627;98026;993.7058650573326;1046.429695815767;1050.9579616815395;1055.3984228989557;1078.5254488025244;17260.827391726423;17267.14344973009;17550.12249387551;17636.559086022953;17702;39875.2024959505;42637.36043959281;42981.57018429901;45123.774381127885;45361.09277814491;56687;64425.35574644381;65787.67106164439;65855;66277.66861165663;8822.95588522079;9041.819163616823;9057.385580745176;9252.167304942588;9351.298652600946;10571.577136914437;13600.251986140462;13955.302234888011;14139;14251;11990.820137698116;12207.328596927255;12244.142909996215;12326.705695901801;12559.372031398576;11919.225250358699;11923.761524769283;12070.637880863587;12215.816762748744;12474.688132796753;12300.323482208207;12363.814542782045;12367.257964522158;12368.505259789868;12442.564510242099;7675;8079.515229086273;8368;8387.664493420194;9310.30172737061;8828;11043;12197.817032744339;12233.3271670059;12256.938715306367 07:19:07 INFO - PROCESS | 4263 | |3;mootools.html;1300.2588524541015;1490.5826368616788;1509.788629591857;1654.6194375293683;1802.3421451170327;9019.143181397765;9438;9438.48088355141;9723.07630775077;9723.854142187854;9417.623295068206;9620.903790962087;9649.517524123801;9649.662261820838;9651.903480965188;2074.7406574178226;2358.681577986967;2432.0514999150346;2459.6802415685934;2490.414752533153;2445.645381419702;2445.7798798108165;2452;2455.84037037592;2456.115798312606;2361.8346715729904;2361.95276094478;2384.0582969726947;2391.6053851114634;2391.9760802392016;2038.9694154587694;2312.3756585721762;2381.4760752634393;2423.6364545318165;2431.1490978157503;2252.245497758253;2270.625346817773;2271.159670921753;2275.1581914691506;2318.5362927414417;9611.086946740119;9674.177694895941;9675.419474831533;9687.370320929118;9691.51542422876;5414.214938833887;5528.364238112628;5536.529395001429;5544.112941929312;5546.389897111315;3358.932821343584;3363.5963684358035;3458.481227815848;3476.2699833035094;3553.626869178725;1097.7749561339986;1131.332513816852;1142.9828552571719;1156.681912474068;1161.8780028097012;13093.672658183621;13094.279814610192;13106.934465327708;13125.671858203526;13165.144265622705;4820.385170967765;4821.108095002436;4919.458859525449;4923.77842997066;4932.408111026628;10861;10921.180911431675;10928.781424371467;10941.4529273536;10949.4525273736;5523.861903452365;5524.779008839681;5526.392096869341;5536.972315138399;5538.418466061086;4436.0906014267;5003.249512573143;5138.58891288696;5157.200633901752;5251.36983561975;4211.599898009684;4251.44731184944;4306.655467562588;4307.569243075667;4328.653707703439;1266.1390254626758;1301.0697351393799;1311.4819646239682;1311.606518044602;1312.875276848698;956.1394744729798;960.582146766159;971.1745016735719;972.8686627305365;980.0576562677766;6011.909821352683;6137.478314343331;6150.815475535652;6156.6921653918025;6190.969045154746;456.9268916973268;462.82875336125846;466.47055591902756;468.3793972985807;475.4176134235603;4167.541570427251;4215.241256573846;4234.661227101825;4243.384709217146;4255.659547236213;11275.661730147945;11864.347460889561;11912.463939122761;11916.52333906634;11926.045916326673;11711.414429278673;11756.647300580997;11764;11799.882001179878;11814.763704725858;8604.95697521521;8726.738197854074;8741.868871966926;8802.163794439519;8854.690085846965;6137.263528376623;6145.539084568764;6211.16149319836;6272.435480806749;6445.742170313322;10953.671389858317;11050.33697978124;11111.277766945122;11211.943940280573;11235.101191904792;11154.832677509681;11470;11471.254368466023;11597.594084207012;11623;7427.331540161412;8004.799880003046;8415.4109212357;8452.070272270168;8661.740147795575;9225.169734723639;9297.953510232406;9325.160735533835;9447.291453141179;9452.054794520493;8096.635651395819;8226.177382261965;8320.209580089882;8441.915580844114;8447.155284471504;7840.7864764415735;8044.235797599219;8304.335653147613;8397.118302578385;8447.746567602982;7527.247275272429;7596.392288617008;7597;7617.085949685851;7622.733204337822;5357.464253574612;5389.595780316414;5421.47777392348;5470.425605311385;5515.255440515479;5339.546138578265;5541.534017362235;5564.4713752193475;5583.944160558505;5601.831945041656 07:19:07 INFO - PROCESS | 4263 | |4;prototype.html;331.25137189950703;342.9537012503311;346.89939917423965;350.9420945543985;354.1306093540358;5176.896462070757;5276.498732620405;5291.55021823145;5368.597355198356;5383.246345511631;5291.497307755757;5313.654612450188;5324.440933701954;5342.893142137155;5345.1447768357075;4198.391233271173;4200.726952748077;4203.495580530341;4223.493180818298;4224.894377640553;4087.1621317629815;4216.47294088239;4224.387463817745;4236.110416812473;4248.468941382327;4155.2728272552185;4163.210648865267;4200.243956087903;4202.70581059326;4209.831606735727;4192.909843440697;4201.516825565069;4217.34631132175;4218.746875187483;4221.55673654265;3728.422094575318;3739.364308067608;3744.9028544015437;3749.7000239981007;3761.54861416629;4956.430010548797;5209.322788037531;5231.163013917755;5232.8691782705355;5245.606579506514;4781.904361912742;4782.473927867932;4792.400949881265;4794.089123066641;4794.37673102498;5366.6511676741275;5570.020039278967;5612.158176273591;5614.578906581982;5627.127795191752;4041;4054.2702313583545;4068.4914385701786;4069.3285607874664;4074.959250407517;5770.538356931477;5795.246617939683;5820.9708951455395;5822.767089316465;5835.854103647401;4090;4132.483439570054;4137.441445404892;4141.985213622622;4145.0051987522775;3995.4206640037614;4217.514985776614;4240.236757383701;4260.488741351058;4263.104748002954;4767.642426818003;4768.9523104768505;4770.475247722748;4785.138675038526;4785.803549112722;5312.681239125664;5599.636023658449;5603.551715862803;5604.327480702342;5619.213310136584;1329.4615680649351;1426.8513846353578;1434.0033676594876;1434.175349174229;1435.655442693746;909.7134402663272;918.6922381002305;920.7974245665943;925.5973651461636;942.0202988891476;4672.8037822223505;4679.27471241958;4725.480197178307;4757.738324392122;4758.714477131383;4996.5024482862145;5004.523665518681;5015.448300686921;5016.473270306638;5051.6716413433005;4547.681662283609;4716.528347165256;4725.5983241424865;4736.668433209711;4741.857744267678;2678.566966672821;2688.502627014009;2714.904978325749;2735.9726402736114;2739.6849362323187;5208.739563021833;5215.982883337712;5220.608454365938;5220.9738951305;5244.29202057725;4710.152172608963;5035.697858128524;5053.094470679374;5067.366579177603;5080.415752188472;5059.645824792229;5122.538971492509;5157.504323746071;5160.200168973815;5166.535011848877;4998.275250088789;5001.774920128676;5007.7746501408255;5009.974950125226;5020.991603358686;4717.787699553597;4926.285688575208;4967.82612608557;4994.475580064186;5015.592515592463;5088.287639730367;5129.589632829439;5137.948620513747;5147.58819294448;5180.6891586504935;3731.4775931369086;3747.913105199462;3754.3617585010065;3887.78617176058;3900.434437006675;5558.471945165203;5650.3219613646625;5658.971705141448;5680.460356266148;5684.289463817023;5527.751251193787;5538.418466061005;5550.361708403424;5563.499285064364;5587.860303492283;5296.576273898002;5457.20870473787;5507.7246137693755;5533.197686335539;5575.637583557056;5419.236189543282;5456.699881506555;5468.644538105011;5522.834314970557;5539.612227144061;5370.46941621636;5506.752196151103;5526.778928842801;5530.529904958124;5541.33503979525;5398.407469796341;5427.643089227693;5439.5920305976415;5458.863528411822;5477.616566840283 07:19:07 INFO - PROCESS | 4263 | |5;yui.html;687.2405991379526;700.80727799855;704.6969802984717;717.8851383778593;749.6888791151671;16616.750748738763;17349.913250433747;17503.82496175038;17546.47360579183;17549;16452.095134767584;16524.504264872074;16529.338826446958;16561.751573726404;16563.751543726852;687.9862402751942;817.5013241922422;833.1293797981094;833.6832003838533;835.9498430094213;814.3281792521165;817.1501638296165;821.6015232612178;821.7616891101574;821.8931538899965;882.1134759566659;885.406777459104;885.6236099657652;886.3396769406769;886.7827382291348;716.8100453379858;833.3957880536623;857.6655104509277;859.3297228162044;863.5854789700978;632.1213513216633;633.8985762278013;634.2705888228528;635.6186288227073;636.8121404185777;14980.850191498055;15051.623709407353;15079.472218472301;15081.472148474752;15098.320575574126;13680.179189248676;14064.22646754428;14102.506412275521;14144;14182.43270269188;13198.86801131986;13249;13355.599332020054;13509;13773.655658608515;4424.579664931826;4491.079328737634;4507.639388848885;4534.36518887356;4565.703229290086;74077.62961185213;74374.62812685902;75388.62305688491;75476.62261688657;77983.6100819498;10917.727056823644;10930.945345273381;10987.175961802897;11205.775884482264;11323.094152467782;20480.59038819215;20874.791252087587;20880;20950.37148885536;22068.558628827333;8510.404271700922;8796.252318552995;8952.104789521127;9102.180803727697;9123.349886457243;4607.44710634726;4686.250199967989;4755.762211889391;4844.685095468783;4925.285833554115;3549.04175872513;3693.9445908311395;3699.408094704834;3701.407774756026;3702.204026134394;593.3917734322268;632.0582332324803;641.0224407778176;642.078617184342;738.9261073892568;727.6580007396515;744.7356188553094;748.330244431231;778.9922100779033;781.6912319633826;9142.222911052635;9440.480773557383;9631.951840240754;10115.747106322253;10505.947470262752;561.3123923194137;665.1685393258427;673.8584897171648;687.5737043033251;716.183550752143;4728.125296820031;4754.240930855605;4764.4520880099235;4817.542333478314;4836.443808962014;117824;118607.1044671653;119052;121399;121613;104401.40669675282;104562;105188;106599;106857;95423.52288238515;96032;96276;97133.51433242789;97516.99999999857;8949.149830766068;9092.636294548409;9187.1137383407;9271.165595096474;9299.488528130747;49532.25701614551;50495.74752126216;50891.2366314513;51971.48028519667;52055.73972130115;68933;77891.61054194692;79241.60379198067;84122.47632571033;84675.57662211896;12430.875691242973;12521.471657412128;12805;12888.935555322163;12962.287074211008;13596.388162532512;13727.519536816164;13794.862051379358;14344;14483.637909052359;13539.661508462368;14107.858921410654;14199.574012779633;14732.852671473149;15364.462243821412;14275.357608907416;14319.713605728035;14409.567712968628;14423.206723630301;14575.489128806568;13690.31548422555;13888;13993.650158746113;14135.858641413453;14331.140131591721;10602.151827853908;10897;10984.670459886216;11022.118230541697;11486.253393529394;10955;11083.556657733601;11124.388158651353;11237.775244495228;11259 07:19:07 INFO - PROCESS | 4263 | __end_tp_report 07:19:07 INFO - PROCESS | 4263 | __start_cc_report 07:19:07 INFO - PROCESS | 4263 | _x_x_mozilla_cycle_collect,1062 07:19:07 INFO - PROCESS | 4263 | __end_cc_report 07:19:07 INFO - PROCESS | 4263 | __startTimestamp1465741147417__endTimestamp 07:19:07 INFO - PROCESS | 4263 | 07:19:07 INFO - PROCESS | 4263 | ------- Summary: start ------- 07:19:07 INFO - PROCESS | 4263 | Number of tests: 6 07:19:07 INFO - PROCESS | 4263 | 07:19:07 INFO - PROCESS | 4263 | [#0] dojo.html Cycles:165 Average:5407.69 Median:5600.36 stddev:618.53 (11.0%) stddev-sans-first:592.97 07:19:07 INFO - PROCESS | 4263 | Values: 3084.3 3099.3 3104.4 3138.5 3157.5 5220.2 5279.0 5347.9 5354.6 5407.6 5411.1 5425.1 5492.9 5503.8 5593.3 4877.6 4900.6 4913.9 4961.5 4983.1 5087.0 5118.9 5121.7 5162.9 5165.4 4730.2 5025.2 5059.8 5087.3 5103.5 4752.5 4867.1 4872.4 4925.9 4961.4 4841.2 4871.3 4941.6 4952.9 4981.5 5258.1 5458.0 5469.0 5469.9 5503.3 5792.2 5807.2 5836.0 5903.5 5912.6 5904.9 5907.4 5950.0 5952.1 5964.7 5271.9 5478.6 5544.1 5547.6 5549.6 5892.4 5938.4 5941.8 6013.5 6018.8 5789.8 5795.1 5840.7 5851.6 5855.0 5514.3 5794.0 5892.3 5929.3 5934.4 5821.9 5875.4 5877.5 5889.2 5933.8 5840.7 5871.9 5892.1 5896.4 5902.1 4291.7 4399.8 4431.3 4497.4 4504.5 3960.6 3965.0 3965.3 3997.9 4008.5 5416.5 5421.5 5433.0 5434.0 5474.8 5605.7 5798.9 5852.0 5862.0 5896.0 5493.3 5504.5 5507.8 5508.7 5520.2 5056.4 5062.0 5064.2 5073.5 5110.1 5697.9 5909.0 5952.3 5964.4 6014.9 5825.6 5835.3 5840.1 5840.8 5845.9 5736.7 5999.1 6000.4 6008.9 6014.7 5631.6 5663.6 5678.9 5695.7 5697.1 5801.9 5847.3 5850.1 5850.4 5856.2 5491.8 5600.4 5641.1 5703.7 5714.9 5620.9 5677.2 5681.1 5684.3 5736.8 5593.0 5597.8 5600.5 5601.9 5605.5 5603.9 5714.7 5723.4 5775.0 5806.9 5377.2 5414.9 5590.2 5632.9 5734.3 07:19:07 INFO - PROCESS | 4263 | 07:19:07 INFO - PROCESS | 4263 | [#1] ext.html Cycles:180 Average:61226.73 Median:205049.72 stddev:124546.24 (60.7%) stddev-sans-first:124812.42 07:19:07 INFO - PROCESS | 4263 | Values: 589.1 620.8 625.0 627.8 632.3 31274.7 43888.6 44904.3 44975.3 47892.3 46199.8 46629.5 46663.5 46669.5 46683.8 8052.4 8984.1 9143.5 10703.8 10978.7 10815.5 10902.3 10903.7 10910.7 10914.8 10919.2 10950.9 10964.0 10967.3 10975.2 8172.2 10872.5 11153.6 11164.9 11450.9 10574.5 10655.5 10656.9 10994.8 10996.1 44627.1 45199.8 45228.3 45255.0 45262.0 3588.9 3647.4 3712.1 4056.6 4131.3 34201.3 34334.1 34336.7 34483.8 34604.8 3987.2 3994.9 4003.5 4021.7 4061.1 366641.0 370501.0 371417.0 371424.0 372591.0 40216.8 41249.4 41288.4 41332.0 41393.2 40976.0 41037.6 41131.0 41192.8 41194.0 14700.5 16258.2 16385.5 16397.0 16406.5 13284.7 13582.5 13636.9 13976.8 13980.9 9246.9 9323.8 9328.2 9393.9 9394.0 3520.2 3532.2 3583.0 3589.6 3633.2 1047.5 1049.2 1114.7 1141.9 1176.5 32655.7 33021.2 33090.3 33182.3 33752.0 1141.3 1141.5 1157.1 1164.7 1200.6 16987.8 17481.6 17555.6 17575.8 17581.2 579586.0 582211.0 586680.0 591402.0 593050.0 60336.4 61178.0 61244.0 61287.0 61300.4 1244.9 1342.4 1379.3 1380.0 1389.8 32474.7 34036.0 34212.5 34487.5 34639.5 47336.3 47543.5 47586.3 47610.3 47620.8 417912.0 421614.0 421677.0 421970.0 423101.0 26493.3 29601.9 29995.6 30449.0 30652.8 49727.0 49808.5 50242.0 50243.7 51004.7 41121.8 42647.0 42669.6 43342.6 44046.9 42125.8 42402.4 42550.0 43136.0 43346.8 41920.2 42341.8 43112.4 43268.6 43296.6 36035.8 37508.4 37919.0 38232.8 38386.6 28541.7 28781.9 28817.9 28858.0 29001.3 07:19:07 INFO - PROCESS | 4263 | 07:19:07 INFO - PROCESS | 4263 | [#2] jquery.html Cycles:180 Average:28171.48 Median:184440.17 stddev:74694.43 (40.5%) stddev-sans-first:74874.88 07:19:07 INFO - PROCESS | 4263 | Values: 407.6 407.8 413.2 419.1 422.3 13478.9 17491.4 18741.2 19550.0 19637.4 15058.3 17493.8 18253.8 18261.5 18546.4 5732.7 5930.6 5954.7 5960.3 5965.6 5801.6 5822.8 5864.8 5867.2 5893.2 5723.4 5840.2 5845.5 5855.9 5860.5 5724.4 5765.5 5828.4 5842.7 5847.5 5217.0 5224.6 5229.5 5250.8 5254.7 16953.1 21806.0 22295.3 22866.3 22893.9 2122.8 2303.4 2426.7 2665.9 2919.3 10466.2 10468.5 10475.6 10503.6 11764.0 1878.5 1938.7 2006.8 2015.0 2037.6 82390.0 84462.6 85377.1 85505.1 85909.1 11132.2 11172.9 11288.7 11309.3 11520.9 15600.5 15692.5 15858.4 15861.1 15888.2 8062.2 8474.8 8534.4 8596.1 8664.7 8205.8 8262.1 8264.0 8367.6 8370.5 4302.7 4340.5 4678.4 4680.8 4705.2 1988.1 2009.6 2065.9 2069.6 2090.4 911.6 982.3 985.8 994.1 1058.6 18785.2 19034.7 19041.4 19222.8 19434.0 967.3 992.7 998.9 1005.8 1038.5 10097.5 10814.1 10903.9 10910.2 10910.7 365961.0 373110.0 483130.0 502153.0 502356.0 93941.5 95799.0 97625.5 97627.0 98026.0 993.7 1046.4 1051.0 1055.4 1078.5 17260.8 17267.1 17550.1 17636.6 17702.0 39875.2 42637.4 42981.6 45123.8 45361.1 56687.0 64425.4 65787.7 65855.0 66277.7 8823.0 9041.8 9057.4 9252.2 9351.3 10571.6 13600.3 13955.3 14139.0 14251.0 11990.8 12207.3 12244.1 12326.7 12559.4 11919.2 11923.8 12070.6 12215.8 12474.7 12300.3 12363.8 12367.3 12368.5 12442.6 7675.0 8079.5 8368.0 8387.7 9310.3 8828.0 11043.0 12197.8 12233.3 12256.9 07:19:07 INFO - PROCESS | 4263 | 07:19:07 INFO - PROCESS | 4263 | [#3] mootools.html Cycles:180 Average:6186.16 Median:2647.90 stddev:3644.32 (137.6%) stddev-sans-first:3636.04 07:19:07 INFO - PROCESS | 4263 | Values: 1300.3 1490.6 1509.8 1654.6 1802.3 9019.1 9438.0 9438.5 9723.1 9723.9 9417.6 9620.9 9649.5 9649.7 9651.9 2074.7 2358.7 2432.1 2459.7 2490.4 2445.6 2445.8 2452.0 2455.8 2456.1 2361.8 2362.0 2384.1 2391.6 2392.0 2039.0 2312.4 2381.5 2423.6 2431.1 2252.2 2270.6 2271.2 2275.2 2318.5 9611.1 9674.2 9675.4 9687.4 9691.5 5414.2 5528.4 5536.5 5544.1 5546.4 3358.9 3363.6 3458.5 3476.3 3553.6 1097.8 1131.3 1143.0 1156.7 1161.9 13093.7 13094.3 13106.9 13125.7 13165.1 4820.4 4821.1 4919.5 4923.8 4932.4 10861.0 10921.2 10928.8 10941.5 10949.5 5523.9 5524.8 5526.4 5537.0 5538.4 4436.1 5003.2 5138.6 5157.2 5251.4 4211.6 4251.4 4306.7 4307.6 4328.7 1266.1 1301.1 1311.5 1311.6 1312.9 956.1 960.6 971.2 972.9 980.1 6011.9 6137.5 6150.8 6156.7 6191.0 456.9 462.8 466.5 468.4 475.4 4167.5 4215.2 4234.7 4243.4 4255.7 11275.7 11864.3 11912.5 11916.5 11926.0 11711.4 11756.6 11764.0 11799.9 11814.8 8605.0 8726.7 8741.9 8802.2 8854.7 6137.3 6145.5 6211.2 6272.4 6445.7 10953.7 11050.3 11111.3 11211.9 11235.1 11154.8 11470.0 11471.3 11597.6 11623.0 7427.3 8004.8 8415.4 8452.1 8661.7 9225.2 9298.0 9325.2 9447.3 9452.1 8096.6 8226.2 8320.2 8441.9 8447.2 7840.8 8044.2 8304.3 8397.1 8447.7 7527.2 7596.4 7597.0 7617.1 7622.7 5357.5 5389.6 5421.5 5470.4 5515.3 5339.5 5541.5 5564.5 5583.9 5601.8 07:19:07 INFO - PROCESS | 4263 | 07:19:07 INFO - PROCESS | 4263 | [#4] prototype.html Cycles:180 Average:4509.69 Median:5008.87 stddev:1285.66 (25.7%) stddev-sans-first:1250.43 07:19:07 INFO - PROCESS | 4263 | Values: 331.3 343.0 346.9 350.9 354.1 5176.9 5276.5 5291.6 5368.6 5383.2 5291.5 5313.7 5324.4 5342.9 5345.1 4198.4 4200.7 4203.5 4223.5 4224.9 4087.2 4216.5 4224.4 4236.1 4248.5 4155.3 4163.2 4200.2 4202.7 4209.8 4192.9 4201.5 4217.3 4218.7 4221.6 3728.4 3739.4 3744.9 3749.7 3761.5 4956.4 5209.3 5231.2 5232.9 5245.6 4781.9 4782.5 4792.4 4794.1 4794.4 5366.7 5570.0 5612.2 5614.6 5627.1 4041.0 4054.3 4068.5 4069.3 4075.0 5770.5 5795.2 5821.0 5822.8 5835.9 4090.0 4132.5 4137.4 4142.0 4145.0 3995.4 4217.5 4240.2 4260.5 4263.1 4767.6 4769.0 4770.5 4785.1 4785.8 5312.7 5599.6 5603.6 5604.3 5619.2 1329.5 1426.9 1434.0 1434.2 1435.7 909.7 918.7 920.8 925.6 942.0 4672.8 4679.3 4725.5 4757.7 4758.7 4996.5 5004.5 5015.4 5016.5 5051.7 4547.7 4716.5 4725.6 4736.7 4741.9 2678.6 2688.5 2714.9 2736.0 2739.7 5208.7 5216.0 5220.6 5221.0 5244.3 4710.2 5035.7 5053.1 5067.4 5080.4 5059.6 5122.5 5157.5 5160.2 5166.5 4998.3 5001.8 5007.8 5010.0 5021.0 4717.8 4926.3 4967.8 4994.5 5015.6 5088.3 5129.6 5137.9 5147.6 5180.7 3731.5 3747.9 3754.4 3887.8 3900.4 5558.5 5650.3 5659.0 5680.5 5684.3 5527.8 5538.4 5550.4 5563.5 5587.9 5296.6 5457.2 5507.7 5533.2 5575.6 5419.2 5456.7 5468.6 5522.8 5539.6 5370.5 5506.8 5526.8 5530.5 5541.3 5398.4 5427.6 5439.6 5458.9 5477.6 07:19:07 INFO - PROCESS | 4263 | 07:19:07 INFO - PROCESS | 4263 | [#5] yui.html Cycles:180 Average:21653.31 Median:4550.03 stddev:31605.48 (694.6%) stddev-sans-first:31654.94 07:19:07 INFO - PROCESS | 4263 | Values: 687.2 700.8 704.7 717.9 749.7 16616.8 17349.9 17503.8 17546.5 17549.0 16452.1 16524.5 16529.3 16561.8 16563.8 688.0 817.5 833.1 833.7 835.9 814.3 817.2 821.6 821.8 821.9 882.1 885.4 885.6 886.3 886.8 716.8 833.4 857.7 859.3 863.6 632.1 633.9 634.3 635.6 636.8 14980.9 15051.6 15079.5 15081.5 15098.3 13680.2 14064.2 14102.5 14144.0 14182.4 13198.9 13249.0 13355.6 13509.0 13773.7 4424.6 4491.1 4507.6 4534.4 4565.7 74077.6 74374.6 75388.6 75476.6 77983.6 10917.7 10930.9 10987.2 11205.8 11323.1 20480.6 20874.8 20880.0 20950.4 22068.6 8510.4 8796.3 8952.1 9102.2 9123.3 4607.4 4686.3 4755.8 4844.7 4925.3 3549.0 3693.9 3699.4 3701.4 3702.2 593.4 632.1 641.0 642.1 738.9 727.7 744.7 748.3 779.0 781.7 9142.2 9440.5 9632.0 10115.7 10505.9 561.3 665.2 673.9 687.6 716.2 4728.1 4754.2 4764.5 4817.5 4836.4 117824.0 118607.1 119052.0 121399.0 121613.0 104401.4 104562.0 105188.0 106599.0 106857.0 95423.5 96032.0 96276.0 97133.5 97517.0 8949.1 9092.6 9187.1 9271.2 9299.5 49532.3 50495.7 50891.2 51971.5 52055.7 68933.0 77891.6 79241.6 84122.5 84675.6 12430.9 12521.5 12805.0 12888.9 12962.3 13596.4 13727.5 13794.9 14344.0 14483.6 13539.7 14107.9 14199.6 14732.9 15364.5 14275.4 14319.7 14409.6 14423.2 14575.5 13690.3 13888.0 13993.7 14135.9 14331.1 10602.2 10897.0 10984.7 11022.1 11486.3 10955.0 11083.6 11124.4 11237.8 11259.0 07:19:07 INFO - PROCESS | 4263 | -------- Summary: end -------- 07:19:07 INFO - PROCESS | 4263 | 07:19:08 INFO - TEST-INFO | 4263: exit 0 07:19:08 INFO - TEST-OK | dromaeo_css | took 1114260ms 07:19:08 INFO - TEST-START | kraken 07:19:08 INFO - operating with platform_type : linux_ 07:19:08 INFO - Initialising browser for kraken test... 07:19:08 INFO - TEST-INFO | started process 4447 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptHJMvT/profile http://localhost:34591/getInfo.html) 07:19:12 INFO - PROCESS | 4447 | __metrics Screen width/height:1600/1200 07:19:12 INFO - PROCESS | 4447 | colorDepth:24 07:19:12 INFO - PROCESS | 4447 | Browser inner width/height: 1024/697 07:19:12 INFO - PROCESS | 4447 | __metrics 07:19:13 INFO - PROCESS | 4447 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:19:13 INFO - PROCESS | 4447 | console.error: PushService: 07:19:13 INFO - PROCESS | 4447 | stateChangeProcessEnqueue: Error transitioning state 07:19:13 INFO - PROCESS | 4447 | UnknownError 07:19:14 INFO - TEST-INFO | 4447: exit 0 07:19:14 INFO - Browser initialized. 07:19:14 INFO - Running cycle 1/1 for kraken test... 07:19:14 INFO - TEST-INFO | started process 4532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptHJMvT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:26 INFO - PROCESS | 4532 | RSS: Main: 172847104 07:19:26 INFO - PROCESS | 4532 | 07:19:28 INFO - PROCESS | 4532 | Cycle 1(1): loaded http://localhost:34591/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34591/tests/kraken/driver.html?testName=audio-beat-detection) 07:19:29 INFO - PROCESS | 4532 | RSS: Main: 232587264 07:19:29 INFO - PROCESS | 4532 | 07:19:32 INFO - PROCESS | 4532 | Cycle 1(1): loaded http://localhost:34591/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34591/tests/kraken/driver.html?testName=audio-dft) 07:19:32 INFO - PROCESS | 4532 | RSS: Main: 219918336 07:19:32 INFO - PROCESS | 4532 | 07:19:35 INFO - PROCESS | 4532 | Cycle 1(1): loaded http://localhost:34591/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34591/tests/kraken/driver.html?testName=audio-fft) 07:19:36 INFO - PROCESS | 4532 | RSS: Main: 286420992 07:19:36 INFO - PROCESS | 4532 | 07:19:38 INFO - PROCESS | 4532 | Cycle 1(1): loaded http://localhost:34591/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34591/tests/kraken/driver.html?testName=audio-oscillator) 07:19:39 INFO - PROCESS | 4532 | RSS: Main: 197570560 07:19:39 INFO - PROCESS | 4532 | 07:19:41 INFO - PROCESS | 4532 | Cycle 1(1): loaded http://localhost:34591/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34591/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:19:42 INFO - PROCESS | 4532 | RSS: Main: 201125888 07:19:42 INFO - PROCESS | 4532 | 07:19:45 INFO - PROCESS | 4532 | Cycle 1(1): loaded http://localhost:34591/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34591/tests/kraken/driver.html?testName=imaging-darkroom) 07:19:45 INFO - PROCESS | 4532 | RSS: Main: 237268992 07:19:45 INFO - PROCESS | 4532 | 07:19:49 INFO - PROCESS | 4532 | Cycle 1(1): loaded http://localhost:34591/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34591/tests/kraken/driver.html?testName=imaging-desaturate) 07:19:49 INFO - PROCESS | 4532 | RSS: Main: 237666304 07:19:49 INFO - PROCESS | 4532 | 07:19:52 INFO - PROCESS | 4532 | Cycle 1(1): loaded http://localhost:34591/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34591/tests/kraken/driver.html?testName=json-parse-financial) 07:19:53 INFO - PROCESS | 4532 | RSS: Main: 238190592 07:19:53 INFO - PROCESS | 4532 | 07:19:54 INFO - PROCESS | 4532 | Cycle 1(1): loaded http://localhost:34591/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34591/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:19:55 INFO - PROCESS | 4532 | RSS: Main: 225538048 07:19:55 INFO - PROCESS | 4532 | 07:19:56 INFO - PROCESS | 4532 | Cycle 1(1): loaded http://localhost:34591/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34591/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:19:57 INFO - PROCESS | 4532 | RSS: Main: 230039552 07:19:57 INFO - PROCESS | 4532 | 07:19:59 INFO - PROCESS | 4532 | Cycle 1(1): loaded http://localhost:34591/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34591/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:20:00 INFO - PROCESS | 4532 | RSS: Main: 237723648 07:20:00 INFO - PROCESS | 4532 | 07:20:02 INFO - PROCESS | 4532 | Cycle 1(1): loaded http://localhost:34591/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34591/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:20:03 INFO - PROCESS | 4532 | RSS: Main: 240873472 07:20:03 INFO - PROCESS | 4532 | 07:20:06 INFO - PROCESS | 4532 | Cycle 1(1): loaded http://localhost:34591/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34591/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:20:06 INFO - PROCESS | 4532 | RSS: Main: 241225728 07:20:06 INFO - PROCESS | 4532 | 07:20:08 INFO - PROCESS | 4532 | Cycle 1(1): loaded http://localhost:34591/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34591/tests/kraken/driver.html?testName=ai-astar) 07:20:08 INFO - PROCESS | 4532 | RSS: Main: 284135424 07:20:08 INFO - PROCESS | 4532 | 07:20:08 INFO - PROCESS | 4532 | __start_tp_report 07:20:08 INFO - PROCESS | 4532 | _x_x_mozilla_page_load 07:20:08 INFO - PROCESS | 4532 | _x_x_mozilla_page_load_details 07:20:08 INFO - PROCESS | 4532 | |i|pagename|runs| 07:20:08 INFO - PROCESS | 4532 | |0;ai-astar;110;105;109;112;112;112;110;110;112;111 07:20:08 INFO - PROCESS | 4532 | |1;audio-beat-detection;152;126;130;184;129;125;151;131;164;124 07:20:08 INFO - PROCESS | 4532 | |2;audio-dft;162;162;162;163;163;163;162;161;162;162 07:20:08 INFO - PROCESS | 4532 | |3;audio-fft;84;76;75;124;76;76;75;75;97;75 07:20:08 INFO - PROCESS | 4532 | |4;audio-oscillator;84;85;124;86;87;85;117;85;86;121 07:20:08 INFO - PROCESS | 4532 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;116;117 07:20:08 INFO - PROCESS | 4532 | |6;imaging-darkroom;147;146;148;146;148;148;150;148;152;147 07:20:08 INFO - PROCESS | 4532 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;94;95 07:20:08 INFO - PROCESS | 4532 | |8;json-parse-financial;51;52;52;53;54;54;52;53;53;53 07:20:08 INFO - PROCESS | 4532 | |9;json-stringify-tinderbox;62;62;69;61;62;61;61;61;62;61 07:20:08 INFO - PROCESS | 4532 | |10;stanford-crypto-aes;79;83;82;79;79;79;82;80;113;86 07:20:08 INFO - PROCESS | 4532 | |11;stanford-crypto-ccm;122;134;121;120;121;121;119;124;144;130 07:20:08 INFO - PROCESS | 4532 | |12;stanford-crypto-pbkdf2;161;161;165;161;164;164;160;165;164;163 07:20:08 INFO - PROCESS | 4532 | |13;stanford-crypto-sha256-iterative;65;65;67;63;64;63;69;65;64;66 07:20:08 INFO - PROCESS | 4532 | __end_tp_report 07:20:08 INFO - PROCESS | 4532 | __start_cc_report 07:20:08 INFO - PROCESS | 4532 | _x_x_mozilla_cycle_collect,1619 07:20:08 INFO - PROCESS | 4532 | __end_cc_report 07:20:08 INFO - PROCESS | 4532 | __startTimestamp1465741208692__endTimestamp 07:20:08 INFO - PROCESS | 4532 | 07:20:08 INFO - PROCESS | 4532 | ------- Summary: start ------- 07:20:08 INFO - PROCESS | 4532 | Number of tests: 14 07:20:08 INFO - PROCESS | 4532 | 07:20:08 INFO - PROCESS | 4532 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:2.16 (1.9%) stddev-sans-first:2.29 07:20:08 INFO - PROCESS | 4532 | Values: 110.0 105.0 109.0 112.0 112.0 112.0 110.0 110.0 112.0 111.0 07:20:08 INFO - PROCESS | 4532 | 07:20:08 INFO - PROCESS | 4532 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:141.00 stddev:20.36 (14.4%) stddev-sans-first:21.24 07:20:08 INFO - PROCESS | 4532 | Values: 152.0 126.0 130.0 184.0 129.0 125.0 151.0 131.0 164.0 124.0 07:20:08 INFO - PROCESS | 4532 | 07:20:08 INFO - PROCESS | 4532 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 07:20:08 INFO - PROCESS | 4532 | Values: 162.0 162.0 162.0 163.0 163.0 163.0 162.0 161.0 162.0 162.0 07:20:08 INFO - PROCESS | 4532 | 07:20:08 INFO - PROCESS | 4532 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:15.92 (20.9%) stddev-sans-first:16.88 07:20:08 INFO - PROCESS | 4532 | Values: 84.0 76.0 75.0 124.0 76.0 76.0 75.0 75.0 97.0 75.0 07:20:08 INFO - PROCESS | 4532 | 07:20:08 INFO - PROCESS | 4532 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:85.00 stddev:17.12 (20.1%) stddev-sans-first:17.60 07:20:08 INFO - PROCESS | 4532 | Values: 84.0 85.0 124.0 86.0 87.0 85.0 117.0 85.0 86.0 121.0 07:20:08 INFO - PROCESS | 4532 | 07:20:08 INFO - PROCESS | 4532 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:20:08 INFO - PROCESS | 4532 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 07:20:08 INFO - PROCESS | 4532 | 07:20:08 INFO - PROCESS | 4532 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.83 (1.2%) stddev-sans-first:1.90 07:20:08 INFO - PROCESS | 4532 | Values: 147.0 146.0 148.0 146.0 148.0 148.0 150.0 148.0 152.0 147.0 07:20:08 INFO - PROCESS | 4532 | 07:20:08 INFO - PROCESS | 4532 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 07:20:08 INFO - PROCESS | 4532 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 94.0 95.0 07:20:08 INFO - PROCESS | 4532 | 07:20:08 INFO - PROCESS | 4532 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:0.95 (1.8%) stddev-sans-first:0.78 07:20:08 INFO - PROCESS | 4532 | Values: 51.0 52.0 52.0 53.0 54.0 54.0 52.0 53.0 53.0 53.0 07:20:08 INFO - PROCESS | 4532 | 07:20:08 INFO - PROCESS | 4532 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:2.44 (3.9%) stddev-sans-first:2.59 07:20:08 INFO - PROCESS | 4532 | Values: 62.0 62.0 69.0 61.0 62.0 61.0 61.0 61.0 62.0 61.0 07:20:08 INFO - PROCESS | 4532 | 07:20:08 INFO - PROCESS | 4532 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:81.00 stddev:10.38 (12.8%) stddev-sans-first:10.84 07:20:08 INFO - PROCESS | 4532 | Values: 79.0 83.0 82.0 79.0 79.0 79.0 82.0 80.0 113.0 86.0 07:20:08 INFO - PROCESS | 4532 | 07:20:08 INFO - PROCESS | 4532 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:123.00 stddev:8.04 (6.5%) stddev-sans-first:8.43 07:20:08 INFO - PROCESS | 4532 | Values: 122.0 134.0 121.0 120.0 121.0 121.0 119.0 124.0 144.0 130.0 07:20:08 INFO - PROCESS | 4532 | 07:20:08 INFO - PROCESS | 4532 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.80 Median:164.00 stddev:1.87 (1.1%) stddev-sans-first:1.87 07:20:08 INFO - PROCESS | 4532 | Values: 161.0 161.0 165.0 161.0 164.0 164.0 160.0 165.0 164.0 163.0 07:20:08 INFO - PROCESS | 4532 | 07:20:08 INFO - PROCESS | 4532 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:1.85 (2.9%) stddev-sans-first:1.96 07:20:08 INFO - PROCESS | 4532 | Values: 65.0 65.0 67.0 63.0 64.0 63.0 69.0 65.0 64.0 66.0 07:20:08 INFO - PROCESS | 4532 | -------- Summary: end -------- 07:20:08 INFO - PROCESS | 4532 | 07:20:09 INFO - TEST-INFO | 4532: exit 0 07:20:09 INFO - TEST-OK | kraken | took 61566ms 07:20:09 INFO - SUITE-END | took 1175s 07:20:09 INFO - Completed test suite (00:19:35) 07:20:09 INFO - javascript benchmark 07:20:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3084.336867573472, 3099.2561785171565, 3104.3946430446063, 3138.4507711150545, 3157.5421563873238, 5220.164773636219, 5279.0, 5347.946520534793, 5354.598405119617, 5407.567394608432, 5411.053065713494, 5425.077736784756, 5492.890142197164, 5503.7798488060425, 5593.300837395325, 4877.609791216694, 4900.632452566054, 4913.8771530711665, 4961.5286547777905, 4983.053219888209, 5086.974565127188, 5118.9488105119035, 5121.743912804363, 5162.896742065175, 5165.380154381461, 4730.219513780256, 5025.1708468102715, 5059.7723102460295, 5087.313212716292, 5103.540681338679, 4752.453467851206, 4867.123917694814, 4872.366592343008, 4925.901481970341, 4961.429435614915, 4841.2012018016985, 4871.342368780205, 4941.579965702884, 4952.925706114411, 4981.5267549583095, 5258.0535503609335, 5457.972710136424, 5468.9726551367385, 5469.863253418656, 5503.284573005523, 5792.247007888989, 5807.157962095473, 5835.9708201458725, 5903.49820265278, 5912.6156799808305, 5904.940950590482, 5907.379725128885, 5950.0, 5952.107183922446, 5964.701764911781, 5271.866548691973, 5478.616496845222, 5544.085225937715, 5547.55619550435, 5549.6115271930985, 5892.440218179266, 5938.406159384027, 5941.792037278675, 6013.54898382623, 6018.789342373084, 5789.797357092481, 5795.1017592273265, 5840.737166827418, 5851.61964472308, 5855.033919403336, 5514.338279406497, 5793.971030144822, 5892.322382925932, 5929.288485381696, 5934.406559344117, 5821.941780582225, 5875.353711091777, 5877.52979761618, 5889.234399528034, 5933.792317268875, 5840.737166827503, 5871.94128058714, 5892.145638882338, 5896.410358964069, 5902.085176797603, 4291.74249545022, 4399.802008909607, 4431.335299705005, 4497.415336006364, 4504.48198457175, 3960.6039396060164, 3964.9801750991637, 3965.306071437487, 3997.8800635980965, 4008.498937632796, 5416.539594134464, 5421.512063914267, 5432.972835135878, 5434.0, 5474.753636086386, 5605.7197140142825, 5798.88402231953, 5851.970740146272, 5862.032764593794, 5896.0, 5493.258410114663, 5504.532114770209, 5507.807226747044, 5508.697021663847, 5520.227168196456, 5056.393232812013, 5062.038212739568, 5064.240363945364, 5073.518015788494, 5110.105731497048, 5697.9430205698245, 5909.0, 5952.345242023374, 5964.433378829004, 6014.879702406015, 5825.563082768725, 5835.328937172109, 5840.094785308284, 5840.766369345179, 5845.941540584539, 5736.713164341682, 5999.130126131599, 6000.429959154048, 6008.8798224036145, 6014.699265036818, 5631.577631677558, 5663.631863928831, 5678.914816277842, 5695.658260504383, 5697.1454281856395, 5801.883962320646, 5847.298324200953, 5850.0932355484965, 5850.414958504116, 5856.238688970407, 5491.780328786964, 5600.355959064596, 5641.069223578228, 5703.657780533182, 5714.857128571819, 5620.887582248414, 5677.205191273142, 5681.0626246668835, 5684.346300175533, 5736.799212027559, 5592.972035139798, 5597.80407685729, 5600.523955463831, 5601.887962240814, 5605.5235304997905, 5603.8879222416135, 5714.657120572779, 5723.427657234243, 5775.047117225611, 5806.854828629149, 5377.24718539397, 5414.891702166014, 5590.217369568182, 5632.915506267327, 5734.283214598176], "value": 5365.613207303702, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.1133843565433, 620.7734177025384, 624.9968750156248, 627.7896904536979, 632.2792017100503, 31274.68725312746, 43888.56111438889, 44904.326435103416, 44975.32537011948, 47892.28161577579, 46199.76900115495, 46629.53370466294, 46663.53336466634, 46669.53330466694, 46683.766581167045, 8052.396070294722, 8984.056674049245, 9143.542822858864, 10703.83944240837, 10978.670639880776, 10815.513301901434, 10902.345859248431, 10903.672889813319, 10910.672679819618, 10914.836277455845, 10919.235653504258, 10950.890491095066, 10964.0, 10967.341959482457, 10975.231733778639, 8172.18278172181, 10872.510737016813, 11153.553857845676, 11164.888351116466, 11450.885491145065, 10574.52414641343, 10655.52050157737, 10656.893431065668, 10994.835077473765, 10996.12031037523, 44627.10745785066, 45199.774001130114, 45228.3215751764, 45255.0, 45262.0, 3588.910277243064, 3647.379945409287, 3712.053426376257, 4056.594340565949, 4131.256373852705, 34201.31597368039, 34334.14164645879, 34336.65663343384, 34483.82758086194, 34604.82697586496, 3987.2224916141363, 3994.8801535953967, 4003.459532963042, 4021.698372622065, 4061.1471590965934, 366641.0, 370501.0, 371417.0, 371424.0, 372591.0, 40216.79891600523, 41249.38125928114, 41288.38067428991, 41332.0, 41393.1721365571, 40976.0, 41037.58962410338, 41131.0, 41192.79403602963, 41194.0, 14700.485483008044, 16258.18709064542, 16385.50843474698, 16397.0, 16406.507804765875, 13284.667883302802, 13582.456701732017, 13636.93181534086, 13976.790348144787, 13980.930095349662, 9246.86129708055, 9323.766905827408, 9328.160465558132, 9393.859092113624, 9393.953030234805, 3520.207953210507, 3532.2229109595846, 3582.964170358315, 3589.5513060867393, 3633.1643721943574, 1047.4867315015588, 1049.1763965287214, 1114.7491814341709, 1141.8743938166795, 1176.5352685689104, 32655.67344326574, 33021.17447063843, 33090.338193236, 33182.336353272796, 33752.0, 1141.2524796258465, 1141.452102990569, 1157.0801213035488, 1164.714644912002, 1200.5617949448388, 16987.830121698626, 17481.56296092608, 17555.561110972074, 17575.82424175742, 17581.208845601977, 579586.0, 582211.0, 586680.0, 591402.0, 593050.0, 60336.396636033955, 61178.0, 61244.0, 61287.0, 61300.38699613036, 1244.887960083597, 1342.4227582139579, 1379.2896658221025, 1379.9655008624866, 1389.7637401641746, 32474.675253247166, 34036.0, 34212.48681269833, 34487.4826877592, 34639.4804077934, 47336.289955650005, 47543.52456475391, 47586.28620570625, 47610.28584571165, 47620.76189619168, 417912.0, 421614.0, 421677.0, 421970.0, 423101.0, 26493.33766655849, 29601.85199073991, 29995.55006674858, 30449.0, 30652.84673576618, 49727.0, 49808.50191498183, 50242.0, 50243.74878125732, 51004.74497627488, 41121.794391027855, 42647.0, 42669.57330426656, 43342.566574333854, 44046.91671582958, 42125.789371052946, 42402.363964541175, 42550.0, 43136.0, 43346.78326608347, 41920.161596767284, 42341.78829105958, 43112.35331469968, 43268.56731432645, 43296.56703432925, 36035.819820900724, 37508.43737343996, 37919.0, 38232.808835956756, 38386.6161338383, 28541.714582853907, 28781.85609071941, 28817.85591072031, 28858.0, 29001.274968125967], "value": 19859.815111503052, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.63166005508003, 407.8062920112946, 413.2252027448534, 419.1219395366706, 422.2905518728535, 13478.932605336984, 17491.387801426954, 18741.15664795084, 19550.0, 19637.410877673658, 15058.322375493102, 17493.82506174938, 18253.817461825376, 18261.452156435327, 18546.443606691788, 5732.684702341369, 5930.614510056833, 5954.672493012882, 5960.284765828107, 5965.61223520472, 5801.593888427812, 5822.82004632806, 5864.794732184374, 5867.207926929853, 5893.233879595647, 5723.370429252779, 5840.211571437865, 5845.473907348338, 5855.941440585603, 5860.531157507389, 5724.427557244284, 5765.481106700396, 5828.358880523139, 5842.707864606774, 5847.502962248214, 5217.034848553029, 5224.582033437316, 5229.450907654679, 5250.789968401259, 5254.6847189168775, 16953.067581283023, 21806.0, 22295.331140065824, 22866.31401057971, 22893.88553057224, 2122.7983341582526, 2303.424143964009, 2426.720927093389, 2665.9066932657456, 2919.343147791751, 10466.1627069835, 10468.47657617116, 10475.58579591753, 10503.579856805718, 11764.00005999491, 1878.474027272366, 1938.7285779990812, 2006.7892871248455, 2014.9899250503654, 2037.6128535578193, 82390.0, 84462.57768711117, 85377.14622853755, 85505.14494855034, 85909.14090859074, 11132.220744547965, 11172.944135279271, 11288.661340159808, 11309.264897781617, 11520.88479115198, 15600.453984110502, 15692.450764223197, 15858.444954426539, 15861.127637980022, 15888.205589720468, 8062.153473885275, 8474.830503389898, 8534.359923005799, 8596.097409772008, 8664.740057798275, 8205.835883282301, 8262.132476090044, 8264.049634292012, 8367.623456944451, 8370.53962032094, 4302.720323178984, 4340.500842403101, 4678.368420263289, 4680.81276748933, 4705.176594096088, 1988.125224901039, 2009.5880344529337, 2065.865718728278, 2069.6067747128, 2090.3833369156137, 911.6444586611227, 982.268210183418, 985.827480190978, 994.0953732103751, 1058.640062378795, 18785.15466803997, 19034.714479282822, 19041.42875713703, 19222.80777192238, 19434.0, 967.2552134856121, 992.7220378294089, 998.8851282102651, 1005.7614481369977, 1038.5222797513077, 10097.545610447547, 10814.134869210444, 10903.890961090447, 10910.23628346008, 10910.672679819618, 365961.0, 373110.0, 483130.0, 502153.0, 502356.0, 93941.53029234947, 95799.0, 97625.53561696438, 97627.0, 98026.0, 993.7058650573326, 1046.429695815767, 1050.9579616815395, 1055.3984228989557, 1078.5254488025244, 17260.827391726423, 17267.14344973009, 17550.12249387551, 17636.559086022953, 17702.0, 39875.2024959505, 42637.36043959281, 42981.57018429901, 45123.774381127885, 45361.09277814491, 56687.0, 64425.35574644381, 65787.67106164439, 65855.0, 66277.66861165663, 8822.95588522079, 9041.819163616823, 9057.385580745176, 9252.167304942588, 9351.298652600946, 10571.577136914437, 13600.251986140462, 13955.302234888011, 14139.0, 14251.0, 11990.820137698116, 12207.328596927255, 12244.142909996215, 12326.705695901801, 12559.372031398576, 11919.225250358699, 11923.761524769283, 12070.637880863587, 12215.816762748744, 12474.688132796753, 12300.323482208207, 12363.814542782045, 12367.257964522158, 12368.505259789868, 12442.564510242099, 7675.0, 8079.515229086273, 8368.0, 8387.664493420194, 9310.30172737061, 8828.0, 11043.0, 12197.817032744339, 12233.3271670059, 12256.938715306367], "value": 9326.400836582976, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.2588524541015, 1490.5826368616788, 1509.788629591857, 1654.6194375293683, 1802.3421451170327, 9019.143181397765, 9438.0, 9438.48088355141, 9723.07630775077, 9723.854142187854, 9417.623295068206, 9620.903790962087, 9649.517524123801, 9649.662261820838, 9651.903480965188, 2074.7406574178226, 2358.681577986967, 2432.0514999150346, 2459.6802415685934, 2490.414752533153, 2445.645381419702, 2445.7798798108165, 2452.0, 2455.84037037592, 2456.115798312606, 2361.8346715729904, 2361.95276094478, 2384.0582969726947, 2391.6053851114634, 2391.9760802392016, 2038.9694154587694, 2312.3756585721762, 2381.4760752634393, 2423.6364545318165, 2431.1490978157503, 2252.245497758253, 2270.625346817773, 2271.159670921753, 2275.1581914691506, 2318.5362927414417, 9611.086946740119, 9674.177694895941, 9675.419474831533, 9687.370320929118, 9691.51542422876, 5414.214938833887, 5528.364238112628, 5536.529395001429, 5544.112941929312, 5546.389897111315, 3358.932821343584, 3363.5963684358035, 3458.481227815848, 3476.2699833035094, 3553.626869178725, 1097.7749561339986, 1131.332513816852, 1142.9828552571719, 1156.681912474068, 1161.8780028097012, 13093.672658183621, 13094.279814610192, 13106.934465327708, 13125.671858203526, 13165.144265622705, 4820.385170967765, 4821.108095002436, 4919.458859525449, 4923.77842997066, 4932.408111026628, 10861.0, 10921.180911431675, 10928.781424371467, 10941.4529273536, 10949.4525273736, 5523.861903452365, 5524.779008839681, 5526.392096869341, 5536.972315138399, 5538.418466061086, 4436.0906014267, 5003.249512573143, 5138.58891288696, 5157.200633901752, 5251.36983561975, 4211.599898009684, 4251.44731184944, 4306.655467562588, 4307.569243075667, 4328.653707703439, 1266.1390254626758, 1301.0697351393799, 1311.4819646239682, 1311.606518044602, 1312.875276848698, 956.1394744729798, 960.582146766159, 971.1745016735719, 972.8686627305365, 980.0576562677766, 6011.909821352683, 6137.478314343331, 6150.815475535652, 6156.6921653918025, 6190.969045154746, 456.9268916973268, 462.82875336125846, 466.47055591902756, 468.3793972985807, 475.4176134235603, 4167.541570427251, 4215.241256573846, 4234.661227101825, 4243.384709217146, 4255.659547236213, 11275.661730147945, 11864.347460889561, 11912.463939122761, 11916.52333906634, 11926.045916326673, 11711.414429278673, 11756.647300580997, 11764.0, 11799.882001179878, 11814.763704725858, 8604.95697521521, 8726.738197854074, 8741.868871966926, 8802.163794439519, 8854.690085846965, 6137.263528376623, 6145.539084568764, 6211.16149319836, 6272.435480806749, 6445.742170313322, 10953.671389858317, 11050.33697978124, 11111.277766945122, 11211.943940280573, 11235.101191904792, 11154.832677509681, 11470.0, 11471.254368466023, 11597.594084207012, 11623.0, 7427.331540161412, 8004.799880003046, 8415.4109212357, 8452.070272270168, 8661.740147795575, 9225.169734723639, 9297.953510232406, 9325.160735533835, 9447.291453141179, 9452.054794520493, 8096.635651395819, 8226.177382261965, 8320.209580089882, 8441.915580844114, 8447.155284471504, 7840.7864764415735, 8044.235797599219, 8304.335653147613, 8397.118302578385, 8447.746567602982, 7527.247275272429, 7596.392288617008, 7597.0, 7617.085949685851, 7622.733204337822, 5357.464253574612, 5389.595780316414, 5421.47777392348, 5470.425605311385, 5515.255440515479, 5339.546138578265, 5541.534017362235, 5564.4713752193475, 5583.944160558505, 5601.831945041656], "value": 4789.761434524294, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.25137189950703, 342.9537012503311, 346.89939917423965, 350.9420945543985, 354.1306093540358, 5176.896462070757, 5276.498732620405, 5291.55021823145, 5368.597355198356, 5383.246345511631, 5291.497307755757, 5313.654612450188, 5324.440933701954, 5342.893142137155, 5345.1447768357075, 4198.391233271173, 4200.726952748077, 4203.495580530341, 4223.493180818298, 4224.894377640553, 4087.1621317629815, 4216.47294088239, 4224.387463817745, 4236.110416812473, 4248.468941382327, 4155.2728272552185, 4163.210648865267, 4200.243956087903, 4202.70581059326, 4209.831606735727, 4192.909843440697, 4201.516825565069, 4217.34631132175, 4218.746875187483, 4221.55673654265, 3728.422094575318, 3739.364308067608, 3744.9028544015437, 3749.7000239981007, 3761.54861416629, 4956.430010548797, 5209.322788037531, 5231.163013917755, 5232.8691782705355, 5245.606579506514, 4781.904361912742, 4782.473927867932, 4792.400949881265, 4794.089123066641, 4794.37673102498, 5366.6511676741275, 5570.020039278967, 5612.158176273591, 5614.578906581982, 5627.127795191752, 4041.0, 4054.2702313583545, 4068.4914385701786, 4069.3285607874664, 4074.959250407517, 5770.538356931477, 5795.246617939683, 5820.9708951455395, 5822.767089316465, 5835.854103647401, 4090.0, 4132.483439570054, 4137.441445404892, 4141.985213622622, 4145.0051987522775, 3995.4206640037614, 4217.514985776614, 4240.236757383701, 4260.488741351058, 4263.104748002954, 4767.642426818003, 4768.9523104768505, 4770.475247722748, 4785.138675038526, 4785.803549112722, 5312.681239125664, 5599.636023658449, 5603.551715862803, 5604.327480702342, 5619.213310136584, 1329.4615680649351, 1426.8513846353578, 1434.0033676594876, 1434.175349174229, 1435.655442693746, 909.7134402663272, 918.6922381002305, 920.7974245665943, 925.5973651461636, 942.0202988891476, 4672.8037822223505, 4679.27471241958, 4725.480197178307, 4757.738324392122, 4758.714477131383, 4996.5024482862145, 5004.523665518681, 5015.448300686921, 5016.473270306638, 5051.6716413433005, 4547.681662283609, 4716.528347165256, 4725.5983241424865, 4736.668433209711, 4741.857744267678, 2678.566966672821, 2688.502627014009, 2714.904978325749, 2735.9726402736114, 2739.6849362323187, 5208.739563021833, 5215.982883337712, 5220.608454365938, 5220.9738951305, 5244.29202057725, 4710.152172608963, 5035.697858128524, 5053.094470679374, 5067.366579177603, 5080.415752188472, 5059.645824792229, 5122.538971492509, 5157.504323746071, 5160.200168973815, 5166.535011848877, 4998.275250088789, 5001.774920128676, 5007.7746501408255, 5009.974950125226, 5020.991603358686, 4717.787699553597, 4926.285688575208, 4967.82612608557, 4994.475580064186, 5015.592515592463, 5088.287639730367, 5129.589632829439, 5137.948620513747, 5147.58819294448, 5180.6891586504935, 3731.4775931369086, 3747.913105199462, 3754.3617585010065, 3887.78617176058, 3900.434437006675, 5558.471945165203, 5650.3219613646625, 5658.971705141448, 5680.460356266148, 5684.289463817023, 5527.751251193787, 5538.418466061005, 5550.361708403424, 5563.499285064364, 5587.860303492283, 5296.576273898002, 5457.20870473787, 5507.7246137693755, 5533.197686335539, 5575.637583557056, 5419.236189543282, 5456.699881506555, 5468.644538105011, 5522.834314970557, 5539.612227144061, 5370.46941621636, 5506.752196151103, 5526.778928842801, 5530.529904958124, 5541.33503979525, 5398.407469796341, 5427.643089227693, 5439.5920305976415, 5458.863528411822, 5477.616566840283], "value": 4106.120820416687, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.2405991379526, 700.80727799855, 704.6969802984717, 717.8851383778593, 749.6888791151671, 16616.750748738763, 17349.913250433747, 17503.82496175038, 17546.47360579183, 17549.0, 16452.095134767584, 16524.504264872074, 16529.338826446958, 16561.751573726404, 16563.751543726852, 687.9862402751942, 817.5013241922422, 833.1293797981094, 833.6832003838533, 835.9498430094213, 814.3281792521165, 817.1501638296165, 821.6015232612178, 821.7616891101574, 821.8931538899965, 882.1134759566659, 885.406777459104, 885.6236099657652, 886.3396769406769, 886.7827382291348, 716.8100453379858, 833.3957880536623, 857.6655104509277, 859.3297228162044, 863.5854789700978, 632.1213513216633, 633.8985762278013, 634.2705888228528, 635.6186288227073, 636.8121404185777, 14980.850191498055, 15051.623709407353, 15079.472218472301, 15081.472148474752, 15098.320575574126, 13680.179189248676, 14064.22646754428, 14102.506412275521, 14144.0, 14182.43270269188, 13198.86801131986, 13249.0, 13355.599332020054, 13509.0, 13773.655658608515, 4424.579664931826, 4491.079328737634, 4507.639388848885, 4534.36518887356, 4565.703229290086, 74077.62961185213, 74374.62812685902, 75388.62305688491, 75476.62261688657, 77983.6100819498, 10917.727056823644, 10930.945345273381, 10987.175961802897, 11205.775884482264, 11323.094152467782, 20480.59038819215, 20874.791252087587, 20880.0, 20950.37148885536, 22068.558628827333, 8510.404271700922, 8796.252318552995, 8952.104789521127, 9102.180803727697, 9123.349886457243, 4607.44710634726, 4686.250199967989, 4755.762211889391, 4844.685095468783, 4925.285833554115, 3549.04175872513, 3693.9445908311395, 3699.408094704834, 3701.407774756026, 3702.204026134394, 593.3917734322268, 632.0582332324803, 641.0224407778176, 642.078617184342, 738.9261073892568, 727.6580007396515, 744.7356188553094, 748.330244431231, 778.9922100779033, 781.6912319633826, 9142.222911052635, 9440.480773557383, 9631.951840240754, 10115.747106322253, 10505.947470262752, 561.3123923194137, 665.1685393258427, 673.8584897171648, 687.5737043033251, 716.183550752143, 4728.125296820031, 4754.240930855605, 4764.4520880099235, 4817.542333478314, 4836.443808962014, 117824.0, 118607.1044671653, 119052.0, 121399.0, 121613.0, 104401.40669675282, 104562.0, 105188.0, 106599.0, 106857.0, 95423.52288238515, 96032.0, 96276.0, 97133.51433242789, 97516.99999999857, 8949.149830766068, 9092.636294548409, 9187.1137383407, 9271.165595096474, 9299.488528130747, 49532.25701614551, 50495.74752126216, 50891.2366314513, 51971.48028519667, 52055.73972130115, 68933.0, 77891.61054194692, 79241.60379198067, 84122.47632571033, 84675.57662211896, 12430.875691242973, 12521.471657412128, 12805.0, 12888.935555322163, 12962.287074211008, 13596.388162532512, 13727.519536816164, 13794.862051379358, 14344.0, 14483.637909052359, 13539.661508462368, 14107.858921410654, 14199.574012779633, 14732.852671473149, 15364.462243821412, 14275.357608907416, 14319.713605728035, 14409.567712968628, 14423.206723630301, 14575.489128806568, 13690.31548422555, 13888.0, 13993.650158746113, 14135.858641413453, 14331.140131591721, 10602.151827853908, 10897.0, 10984.670459886216, 11022.118230541697, 11486.253393529394, 10955.0, 11083.556657733601, 11124.388158651353, 11237.775244495228, 11259.0], "value": 7730.260081308582, "unit": "score"}], "name": "dromaeo_css", "value": 7298.196441221978, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 109.0, 112.0, 112.0, 112.0, 110.0, 110.0, 112.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 130.0, 184.0, 129.0, 125.0, 151.0, 131.0, 164.0, 124.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 163.0, 163.0, 162.0, 161.0, 162.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 76.0, 75.0, 124.0, 76.0, 76.0, 75.0, 75.0, 97.0, 75.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 124.0, 86.0, 87.0, 85.0, 117.0, 85.0, 86.0, 121.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 146.0, 148.0, 148.0, 150.0, 148.0, 152.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 52.0, 53.0, 54.0, 54.0, 52.0, 53.0, 53.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 69.0, 61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 61.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 82.0, 79.0, 79.0, 79.0, 82.0, 80.0, 113.0, 86.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 134.0, 121.0, 120.0, 121.0, 121.0, 119.0, 124.0, 144.0, 130.0], "value": 125.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 165.0, 161.0, 164.0, 164.0, 160.0, 165.0, 164.0, 163.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 63.0, 64.0, 63.0, 69.0, 65.0, 64.0, 66.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1505.6999999999998, "alertThreshold": 2.0}]} 07:20:09 INFO - Return code: 0 07:20:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:20:09 INFO - # TBPL SUCCESS # 07:20:09 INFO - Running post-action listener: _resource_record_post_action 07:20:09 INFO - ##### 07:20:09 INFO - ##### Finished run-tests step (success) 07:20:09 INFO - ##### 07:20:09 INFO - Running post-run listener: _resource_record_post_run 07:20:10 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 549437440; Read time: 0; Write time: 536008 07:20:10 INFO - TinderboxPrint: CPU usage
13.3% 07:20:10 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:20:10 INFO - TinderboxPrint: I/O write bytes / time
549,437,440 / 536,008 07:20:10 INFO - TinderboxPrint: CPU idle
8,262.8 (86.7%) 07:20:10 INFO - TinderboxPrint: CPU user
1,213.3 (12.7%) 07:20:10 INFO - TinderboxPrint: Swap in / out
0 / 0 07:20:10 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255389696; Read time: 0; Write time: 299360 07:20:10 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 293335040; Read time: 0; Write time: 236616 07:20:10 INFO - Running post-run listener: _upload_blobber_files 07:20:10 INFO - Blob upload gear active. 07:20:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:20:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:20:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:20:11 INFO - (blobuploader) - INFO - Open directory for files ... 07:20:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:20:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:20:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:11 INFO - (blobuploader) - INFO - Done attempting. 07:20:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:20:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:20:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:12 INFO - (blobuploader) - INFO - Done attempting. 07:20:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:20:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:20:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:16 INFO - (blobuploader) - INFO - Done attempting. 07:20:16 INFO - (blobuploader) - INFO - Iteration through files over. 07:20:16 INFO - Return code: 0 07:20:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:20:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:20:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8bca96276d64e548d26bc6dbf6633c453eec3d559b558bc04c9608f2c8447afe38a797818ffae144e213191e833ff6fec100d6e7c5e7ecf3046df67069e2bf09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4751c3f55d4e0845880a426bdfaf3ebfbe13dfd792f57f8a1db2a39a08d0ecd266e1ee021639a72217abaf90df153765fa5e726f80c55be8f937e034d749980d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1f226560aadf4e2f51c588d0f4310b08e36e5716861427ffbdd730d417f8d49fc3690f2aa610485e2ec5bd358ad486e9ee7085d9722f339bc391dfa707277ff4"} 07:20:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:20:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:20:16 INFO - Contents: 07:20:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8bca96276d64e548d26bc6dbf6633c453eec3d559b558bc04c9608f2c8447afe38a797818ffae144e213191e833ff6fec100d6e7c5e7ecf3046df67069e2bf09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4751c3f55d4e0845880a426bdfaf3ebfbe13dfd792f57f8a1db2a39a08d0ecd266e1ee021639a72217abaf90df153765fa5e726f80c55be8f937e034d749980d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1f226560aadf4e2f51c588d0f4310b08e36e5716861427ffbdd730d417f8d49fc3690f2aa610485e2ec5bd358ad486e9ee7085d9722f339bc391dfa707277ff4"} 07:20:16 INFO - Running post-run listener: copy_logs_to_upload_dir 07:20:16 INFO - Copying logs to upload dir... 07:20:16 INFO - mkdir: /builds/slave/test/build/upload/logs 07:20:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.441942 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-12 07:20:15.177482) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-12 07:20:15.180989) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904 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/8bca96276d64e548d26bc6dbf6633c453eec3d559b558bc04c9608f2c8447afe38a797818ffae144e213191e833ff6fec100d6e7c5e7ecf3046df67069e2bf09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4751c3f55d4e0845880a426bdfaf3ebfbe13dfd792f57f8a1db2a39a08d0ecd266e1ee021639a72217abaf90df153765fa5e726f80c55be8f937e034d749980d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1f226560aadf4e2f51c588d0f4310b08e36e5716861427ffbdd730d417f8d49fc3690f2aa610485e2ec5bd358ad486e9ee7085d9722f339bc391dfa707277ff4"} build_url:https://queue.taskcluster.net/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011546 build_url: 'https://queue.taskcluster.net/v1/task/Xl3RC63wQzyqBxwGQi5vPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8bca96276d64e548d26bc6dbf6633c453eec3d559b558bc04c9608f2c8447afe38a797818ffae144e213191e833ff6fec100d6e7c5e7ecf3046df67069e2bf09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4751c3f55d4e0845880a426bdfaf3ebfbe13dfd792f57f8a1db2a39a08d0ecd266e1ee021639a72217abaf90df153765fa5e726f80c55be8f937e034d749980d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1f226560aadf4e2f51c588d0f4310b08e36e5716861427ffbdd730d417f8d49fc3690f2aa610485e2ec5bd358ad486e9ee7085d9722f339bc391dfa707277ff4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-12 07:20:15.212906) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 07:20:15.213275) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465735337.90187-458718904 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004706 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 07:20:15.296574) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-12 07:20:15.297449) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-12 07:20:15.298254) ========= ========= Total master_lag: 0.21 =========