builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1469010826.22 results: success (0) buildid: 20160720004018 builduid: 730fd8cee3bf47e0b01f6494b3403bc9 revision: 68ca48e7a1646a4e43f1c11393c92de0fc52bb3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 03:33:46.223189) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 03:33:46.224090) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 03:33:46.224682) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 03:33:46.241138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 03:33:46.241761) ========= 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=6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 03:33:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.0M=0s 2016-07-20 03:33:46 (40.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107494 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 03:33:46.367900) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 03:33:46.368596) ========= 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=6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023932 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 03:33:46.418626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 03:33:46.418991) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 68ca48e7a1646a4e43f1c11393c92de0fc52bb3e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 68ca48e7a1646a4e43f1c11393c92de0fc52bb3e --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=6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 03:33:46,882 truncating revision to first 12 chars 2016-07-20 03:33:46,882 Setting DEBUG logging. 2016-07-20 03:33:46,882 attempt 1/10 2016-07-20 03:33:46,882 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/68ca48e7a164?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 03:33:47,180 unpacking tar archive at: mozilla-aurora-68ca48e7a164/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663561 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 03:33:47.100725) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 03:33:47.101180) ========= script_repo_revision: 68ca48e7a1646a4e43f1c11393c92de0fc52bb3e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 03:33:47.101629) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 03:33:47.101945) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 03:33:47.113877) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-20 03:33:47.114264) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:33:47 INFO - MultiFileLogger online at 20160720 03:33:47 in /builds/slave/test 03:33:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:33:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:33:47 INFO - {'append_to_log': False, 03:33:47 INFO - 'base_work_dir': '/builds/slave/test', 03:33:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:33:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:33:47 INFO - 'branch': 'Mozilla-Aurora', 03:33:47 INFO - 'buildbot_json_path': 'buildprops.json', 03:33:47 INFO - 'config_files': ('talos/linux_config.py',), 03:33:47 INFO - 'default_actions': ('clobber', 03:33:47 INFO - 'read-buildbot-config', 03:33:47 INFO - 'download-and-extract', 03:33:47 INFO - 'populate-webroot', 03:33:47 INFO - 'create-virtualenv', 03:33:47 INFO - 'install', 03:33:47 INFO - 'run-tests'), 03:33:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:33:47 INFO - 'download_minidump_stackwalk': True, 03:33:47 INFO - 'download_symbols': 'ondemand', 03:33:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:33:47 INFO - 'tooltool.py': '/tools/tooltool.py', 03:33:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:33:47 INFO - '/tools/misc-python/virtualenv.py')}, 03:33:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:33:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:33:47 INFO - 'installer_path': 'installer.exe', 03:33:47 INFO - 'log_level': 'info', 03:33:47 INFO - 'log_name': 'talos', 03:33:47 INFO - 'log_to_console': True, 03:33:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:33:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:33:47 INFO - 'opt_config_files': (), 03:33:47 INFO - 'pip_index': False, 03:33:47 INFO - 'sps_profile': False, 03:33:47 INFO - 'sps_profile_interval': 0, 03:33:47 INFO - 'suite': 'dromaeojs', 03:33:47 INFO - 'system_bits': '32', 03:33:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:33:47 INFO - 'title': 'talos-linux64-ix-050', 03:33:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:33:47 INFO - 'use_talos_json': True, 03:33:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:33:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:33:47 INFO - 'work_dir': 'build'} 03:33:47 INFO - ##### 03:33:47 INFO - ##### Running clobber step. 03:33:47 INFO - ##### 03:33:47 INFO - Running pre-action listener: _resource_record_pre_action 03:33:47 INFO - Running main action method: clobber 03:33:47 INFO - rmtree: /builds/slave/test/build 03:33:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:33:48 INFO - Running post-action listener: _resource_record_post_action 03:33:48 INFO - ##### 03:33:48 INFO - ##### Finished clobber step (success) 03:33:48 INFO - ##### 03:33:48 INFO - ##### 03:33:48 INFO - ##### Running read-buildbot-config step. 03:33:48 INFO - ##### 03:33:48 INFO - Running pre-action listener: _resource_record_pre_action 03:33:48 INFO - Running main action method: read_buildbot_config 03:33:48 INFO - Using buildbot properties: 03:33:48 INFO - { 03:33:48 INFO - "project": "", 03:33:48 INFO - "product": "firefox", 03:33:48 INFO - "script_repo_revision": "production", 03:33:48 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:33:48 INFO - "repository": "", 03:33:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:33:48 INFO - "buildid": "20160720004018", 03:33:48 INFO - "stage_platform": "linux64-pgo", 03:33:48 INFO - "basedir": "/builds/slave/test", 03:33:48 INFO - "nightly_build": "True", 03:33:48 INFO - "buildnumber": 420, 03:33:48 INFO - "slavename": "talos-linux64-ix-050", 03:33:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:33:48 INFO - "platform": "ubuntu64_hw", 03:33:48 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:33:48 INFO - "branch": "mozilla-aurora", 03:33:48 INFO - "repo_path": "releases/mozilla-aurora", 03:33:48 INFO - "revision": "68ca48e7a1646a4e43f1c11393c92de0fc52bb3e", 03:33:48 INFO - "pgo_build": "True", 03:33:48 INFO - "builduid": "730fd8cee3bf47e0b01f6494b3403bc9", 03:33:48 INFO - "slavebuilddir": "test" 03:33:48 INFO - } 03:33:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:33:48 INFO - Running post-action listener: _resource_record_post_action 03:33:48 INFO - ##### 03:33:48 INFO - ##### Finished read-buildbot-config step (success) 03:33:48 INFO - ##### 03:33:48 INFO - ##### 03:33:48 INFO - ##### Running download-and-extract step. 03:33:48 INFO - ##### 03:33:48 INFO - Running pre-action listener: _resource_record_pre_action 03:33:48 INFO - Running main action method: download_and_extract 03:33:48 INFO - mkdir: /builds/slave/test/build/tests 03:33: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')]} 03:33:48 INFO - https://queue.taskcluster.net/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:33:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:33:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:33:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:33:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:33:49 INFO - Downloaded 1361 bytes. 03:33:49 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:33:49 INFO - Using the following test package requirements: 03:33:49 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:33:49 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:49 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:33:49 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:49 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:33:49 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:49 INFO - u'jsshell-linux-x86_64.zip'], 03:33:49 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:49 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:33:49 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:33:49 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:49 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:33:49 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:49 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:33:49 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:49 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:33:49 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:49 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:33:49 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:49 INFO - https://queue.taskcluster.net/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:33:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:33:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:33:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:33:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:33:50 INFO - Downloaded 24491015 bytes. 03:33:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:33:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:33:51 INFO - Return code: 0 03:33:51 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:51 INFO - https://queue.taskcluster.net/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:33:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:33:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:33:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:33:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:33:52 INFO - Downloaded 24491015 bytes. 03:33:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:33:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:33:54 INFO - Return code: 0 03:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:54 INFO - https://queue.taskcluster.net/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:33:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:33:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:33:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:33:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:33:55 INFO - Downloaded 10833369 bytes. 03:33:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:33:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:33:55 INFO - Return code: 0 03:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:55 INFO - https://queue.taskcluster.net/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:33:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:33:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:33:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:33:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:33:56 INFO - Downloaded 63614490 bytes. 03:33:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:33:56 INFO - mkdir: /builds/slave/test/properties 03:33:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:33:56 INFO - Writing to file /builds/slave/test/properties/build_url 03:33:56 INFO - Contents: 03:33:56 INFO - build_url:https://queue.taskcluster.net/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:33:57 INFO - Running post-action listener: _resource_record_post_action 03:33:57 INFO - Running post-action listener: set_extra_try_arguments 03:33:57 INFO - ##### 03:33:57 INFO - ##### Finished download-and-extract step (success) 03:33:57 INFO - ##### 03:33:57 INFO - ##### 03:33:57 INFO - ##### Running populate-webroot step. 03:33:57 INFO - ##### 03:33:57 INFO - Running pre-action listener: _resource_record_pre_action 03:33:57 INFO - Running main action method: populate_webroot 03:33:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:33:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:33:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:33:57 INFO - '--tppagecycles', 03:33:57 INFO - '7'], 03:33:57 INFO - 'tests': ['tsvgm']}}, 03:33:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:33:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:33:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:33:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:33:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:33:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:33:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:57 INFO - 'talos_options': ['--disable-e10s'], 03:33:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:57 INFO - 'talos_options': ['--disable-e10s'], 03:33:57 INFO - 'tests': ['damp', 'tps']}, 03:33:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:57 INFO - 'tests': ['damp', 'tps']}, 03:33:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:33:57 INFO - 'tests': ['dromaeo_dom']}, 03:33:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:33:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:33:57 INFO - 'tests': ['a11yr', 03:33:57 INFO - 'ts_paint', 03:33:57 INFO - 'tpaint', 03:33:57 INFO - 'sessionrestore', 03:33:57 INFO - 'sessionrestore_no_auto_restore', 03:33:57 INFO - 'tabpaint']}, 03:33:57 INFO - 'other-e10s': {'tests': ['a11yr', 03:33:57 INFO - 'ts_paint', 03:33:57 INFO - 'tpaint', 03:33:57 INFO - 'sessionrestore', 03:33:57 INFO - 'sessionrestore_no_auto_restore', 03:33:57 INFO - 'tabpaint']}, 03:33:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:33:57 INFO - 'ts_paint', 03:33:57 INFO - 'tpaint', 03:33:57 INFO - 'sessionrestore', 03:33:57 INFO - 'sessionrestore_no_auto_restore', 03:33:57 INFO - 'tabpaint']}, 03:33:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:33:57 INFO - 'ts_paint', 03:33:57 INFO - 'tpaint', 03:33:57 INFO - 'sessionrestore', 03:33:57 INFO - 'sessionrestore_no_auto_restore', 03:33:57 INFO - 'tabpaint']}, 03:33:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:33:57 INFO - 'tests': ['a11yr', 03:33:57 INFO - 'ts_paint', 03:33:57 INFO - 'tpaint', 03:33:57 INFO - 'sessionrestore', 03:33:57 INFO - 'sessionrestore_no_auto_restore', 03:33:57 INFO - 'tabpaint']}, 03:33:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:33:57 INFO - 'tests': ['a11yr', 03:33:57 INFO - 'ts_paint', 03:33:57 INFO - 'tpaint', 03:33:57 INFO - 'sessionrestore', 03:33:57 INFO - 'sessionrestore_no_auto_restore', 03:33:57 INFO - 'tabpaint']}, 03:33:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:33:57 INFO - 'tests': ['tsvgx', 03:33:57 INFO - 'tsvgr_opacity', 03:33:57 INFO - 'tart', 03:33:57 INFO - 'tscrollx', 03:33:57 INFO - 'cart']}, 03:33:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:33:57 INFO - 'tsvgr_opacity', 03:33:57 INFO - 'tart', 03:33:57 INFO - 'tscrollx', 03:33:57 INFO - 'cart']}, 03:33:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:57 INFO - 'talos_options': ['--disable-e10s'], 03:33:57 INFO - 'tests': ['tp5o']}, 03:33:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:57 INFO - 'tests': ['tp5o']}, 03:33:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:57 INFO - 'talos_options': ['--disable-e10s', 03:33:57 INFO - '--xperf_path', 03:33:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:57 INFO - 'tests': ['tp5n']}, 03:33:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:57 INFO - 'talos_options': ['--xperf_path', 03:33:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:57 INFO - 'tests': ['tp5n']}}, 03:33:57 INFO - 'talos.zip': {'path': '', 03:33:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:33:57 INFO - Running post-action listener: _resource_record_post_action 03:33:57 INFO - ##### 03:33:57 INFO - ##### Finished populate-webroot step (success) 03:33:57 INFO - ##### 03:33:57 INFO - ##### 03:33:57 INFO - ##### Running create-virtualenv step. 03:33:57 INFO - ##### 03:33:57 INFO - Running pre-action listener: _resource_record_pre_action 03:33:57 INFO - Running main action method: create_virtualenv 03:33:57 INFO - Creating virtualenv /builds/slave/test/build/venv 03:33:57 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 03:33:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:33:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:33:57 INFO - Using real prefix '/usr' 03:33:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:33:57 INFO - Installing distribute.............................................................................................................................................................................................done. 03:33:59 INFO - Installing pip.................done. 03:33:59 INFO - Return code: 0 03:33:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93c05aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b661c0>, '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 0x1b670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b67550>, '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': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', '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 03:33:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:33:59 INFO - Using env: {'DISPLAY': ':0', 03:33:59 INFO - 'HOME': '/home/cltbld', 03:33:59 INFO - 'LANG': 'en_US.UTF-8', 03:33:59 INFO - 'LANGUAGE': 'en_US:en', 03:33:59 INFO - 'LOGNAME': 'cltbld', 03:33:59 INFO - 'MAIL': '/var/mail/cltbld', 03:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:59 INFO - 'MOZ_NO_REMOTE': '1', 03:33:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:59 INFO - 'NO_EM_RESTART': '1', 03:33:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:59 INFO - 'PWD': '/builds/slave/test', 03:33:59 INFO - 'SHELL': '/bin/bash', 03:33:59 INFO - 'SHLVL': '1', 03:33:59 INFO - 'TERM': 'linux', 03:33:59 INFO - 'TMOUT': '86400', 03:33:59 INFO - 'USER': 'cltbld', 03:33:59 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', 03:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:59 INFO - '_': '/tools/buildbot/bin/python'} 03:34:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:00 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 03:34:00 INFO - Cleaning up... 03:34:00 INFO - Return code: 0 03:34:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f93c05aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b661c0>, '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 0x1b670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b67550>, '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': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', '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 03:34:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:34:00 INFO - Using env: {'DISPLAY': ':0', 03:34:00 INFO - 'HOME': '/home/cltbld', 03:34:00 INFO - 'LANG': 'en_US.UTF-8', 03:34:00 INFO - 'LANGUAGE': 'en_US:en', 03:34:00 INFO - 'LOGNAME': 'cltbld', 03:34:00 INFO - 'MAIL': '/var/mail/cltbld', 03:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:00 INFO - 'MOZ_NO_REMOTE': '1', 03:34:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:00 INFO - 'NO_EM_RESTART': '1', 03:34:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:00 INFO - 'PWD': '/builds/slave/test', 03:34:00 INFO - 'SHELL': '/bin/bash', 03:34:00 INFO - 'SHLVL': '1', 03:34:00 INFO - 'TERM': 'linux', 03:34:00 INFO - 'TMOUT': '86400', 03:34:00 INFO - 'USER': 'cltbld', 03:34:00 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', 03:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:00 INFO - '_': '/tools/buildbot/bin/python'} 03:34:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:00 INFO - Downloading/unpacking psutil>=3.1.1 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:34:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:02 INFO - Installing collected packages: psutil 03:34:02 INFO - Running setup.py install for psutil 03:34:02 INFO - building 'psutil._psutil_linux' extension 03:34:02 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 03:34:02 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 03:34:02 INFO - building 'psutil._psutil_posix' extension 03:34:02 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 03:34:02 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 03:34:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:02 INFO - Successfully installed psutil 03:34:02 INFO - Cleaning up... 03:34:02 INFO - Return code: 0 03:34:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:34:02 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')]} 03:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:02 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')]} 03:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:02 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 0x7f93c05aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b661c0>, '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 0x1b670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b67550>, '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': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', '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 03:34:02 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 03:34:02 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 03:34:02 INFO - Using env: {'DISPLAY': ':0', 03:34:02 INFO - 'HOME': '/home/cltbld', 03:34:02 INFO - 'LANG': 'en_US.UTF-8', 03:34:02 INFO - 'LANGUAGE': 'en_US:en', 03:34:02 INFO - 'LOGNAME': 'cltbld', 03:34:02 INFO - 'MAIL': '/var/mail/cltbld', 03:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:02 INFO - 'MOZ_NO_REMOTE': '1', 03:34:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:02 INFO - 'NO_EM_RESTART': '1', 03:34:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:02 INFO - 'PWD': '/builds/slave/test', 03:34:02 INFO - 'SHELL': '/bin/bash', 03:34:02 INFO - 'SHLVL': '1', 03:34:02 INFO - 'TERM': 'linux', 03:34:02 INFO - 'TMOUT': '86400', 03:34:02 INFO - 'USER': 'cltbld', 03:34:02 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', 03:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:02 INFO - '_': '/tools/buildbot/bin/python'} 03:34:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:34:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:34:05 INFO - Installing collected packages: mozsystemmonitor 03:34:05 INFO - Running setup.py install for mozsystemmonitor 03:34:05 INFO - Successfully installed mozsystemmonitor 03:34:05 INFO - Cleaning up... 03:34:05 INFO - Return code: 0 03:34:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f93c05aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b661c0>, '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 0x1b670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b67550>, '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': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', '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 03:34:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:34:05 INFO - Using env: {'DISPLAY': ':0', 03:34:05 INFO - 'HOME': '/home/cltbld', 03:34:05 INFO - 'LANG': 'en_US.UTF-8', 03:34:05 INFO - 'LANGUAGE': 'en_US:en', 03:34:05 INFO - 'LOGNAME': 'cltbld', 03:34:05 INFO - 'MAIL': '/var/mail/cltbld', 03:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:05 INFO - 'MOZ_NO_REMOTE': '1', 03:34:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:05 INFO - 'NO_EM_RESTART': '1', 03:34:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:05 INFO - 'PWD': '/builds/slave/test', 03:34:05 INFO - 'SHELL': '/bin/bash', 03:34:05 INFO - 'SHLVL': '1', 03:34:05 INFO - 'TERM': 'linux', 03:34:05 INFO - 'TMOUT': '86400', 03:34:05 INFO - 'USER': 'cltbld', 03:34:05 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', 03:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:05 INFO - '_': '/tools/buildbot/bin/python'} 03:34:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:05 INFO - Downloading/unpacking jsonschema==2.5.1 03:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:34:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:34:07 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 03:34:07 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 03:34:07 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 03:34:07 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 03:34:07 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 03:34:07 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 03:34:07 INFO - Downloading functools32-3.2.3-2.tar.gz 03:34:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:34:07 INFO - warning: no files found matching '*.txt' 03:34:07 INFO - no previously-included directories found matching 'build' 03:34:07 INFO - no previously-included directories found matching 'dist' 03:34:07 INFO - no previously-included directories found matching '.git*' 03:34:07 INFO - Installing collected packages: jsonschema, functools32 03:34:07 INFO - Running setup.py install for functools32 03:34:07 INFO - warning: no files found matching '*.txt' 03:34:07 INFO - no previously-included directories found matching 'build' 03:34:07 INFO - no previously-included directories found matching 'dist' 03:34:07 INFO - no previously-included directories found matching '.git*' 03:34:07 INFO - Successfully installed jsonschema functools32 03:34:07 INFO - Cleaning up... 03:34:07 INFO - Return code: 0 03:34:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:34:07 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')]} 03:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:07 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')]} 03:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:07 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 0x7f93c05aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b661c0>, '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 0x1b670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b67550>, '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': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', '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 03:34:07 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 03:34:07 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 03:34:07 INFO - Using env: {'DISPLAY': ':0', 03:34:07 INFO - 'HOME': '/home/cltbld', 03:34:07 INFO - 'LANG': 'en_US.UTF-8', 03:34:07 INFO - 'LANGUAGE': 'en_US:en', 03:34:07 INFO - 'LOGNAME': 'cltbld', 03:34:07 INFO - 'MAIL': '/var/mail/cltbld', 03:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:07 INFO - 'MOZ_NO_REMOTE': '1', 03:34:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:07 INFO - 'NO_EM_RESTART': '1', 03:34:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:07 INFO - 'PWD': '/builds/slave/test', 03:34:07 INFO - 'SHELL': '/bin/bash', 03:34:07 INFO - 'SHLVL': '1', 03:34:07 INFO - 'TERM': 'linux', 03:34:07 INFO - 'TMOUT': '86400', 03:34:07 INFO - 'USER': 'cltbld', 03:34:07 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', 03:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:07 INFO - '_': '/tools/buildbot/bin/python'} 03:34:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:08 INFO - Downloading/unpacking blobuploader==1.2.4 03:34:08 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 03:34:08 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 03:34:08 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 03:34:08 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 03:34:08 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 03:34:08 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 03:34:10 INFO - Downloading blobuploader-1.2.4.tar.gz 03:34:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:34:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:34:10 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 03:34:10 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 03:34:10 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 03:34:10 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 03:34:10 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 03:34:10 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 03:34:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:34:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:34:10 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 03:34:10 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 03:34:10 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 03:34:10 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 03:34:10 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 03:34:10 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 03:34:10 INFO - Downloading docopt-0.6.1.tar.gz 03:34:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:34:11 INFO - Installing collected packages: blobuploader, requests, docopt 03:34:11 INFO - Running setup.py install for blobuploader 03:34:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:34:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:34:11 INFO - Running setup.py install for requests 03:34:11 INFO - Running setup.py install for docopt 03:34:11 INFO - Successfully installed blobuploader requests docopt 03:34:11 INFO - Cleaning up... 03:34:11 INFO - Return code: 0 03:34:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34: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')]} 03:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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')]} 03:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:11 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 0x7f93c05aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b661c0>, '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 0x1b670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b67550>, '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': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', '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 03:34:11 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 03:34:11 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 03:34:11 INFO - Using env: {'DISPLAY': ':0', 03:34:11 INFO - 'HOME': '/home/cltbld', 03:34:11 INFO - 'LANG': 'en_US.UTF-8', 03:34:11 INFO - 'LANGUAGE': 'en_US:en', 03:34:11 INFO - 'LOGNAME': 'cltbld', 03:34:11 INFO - 'MAIL': '/var/mail/cltbld', 03:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:11 INFO - 'MOZ_NO_REMOTE': '1', 03:34:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:11 INFO - 'NO_EM_RESTART': '1', 03:34:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:11 INFO - 'PWD': '/builds/slave/test', 03:34:11 INFO - 'SHELL': '/bin/bash', 03:34:11 INFO - 'SHLVL': '1', 03:34:11 INFO - 'TERM': 'linux', 03:34:11 INFO - 'TMOUT': '86400', 03:34:11 INFO - 'USER': 'cltbld', 03:34:11 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', 03:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:11 INFO - '_': '/tools/buildbot/bin/python'} 03:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:11 INFO - Running setup.py (path:/tmp/pip-4Xy9ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:11 INFO - Running setup.py (path:/tmp/pip-6AryON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:11 INFO - Running setup.py (path:/tmp/pip-xxkMWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:12 INFO - Running setup.py (path:/tmp/pip-hyRnGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:12 INFO - Running setup.py (path:/tmp/pip-LaQz8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:12 INFO - Running setup.py (path:/tmp/pip-Ktrks8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:12 INFO - Running setup.py (path:/tmp/pip-n9nDk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:12 INFO - Running setup.py (path:/tmp/pip-rBpSpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:12 INFO - Running setup.py (path:/tmp/pip-hM5y5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:12 INFO - Running setup.py (path:/tmp/pip-7Zfqip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:12 INFO - Running setup.py (path:/tmp/pip-ZD9qHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:12 INFO - Running setup.py (path:/tmp/pip-uVTCNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:12 INFO - Running setup.py (path:/tmp/pip-pP88h_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:12 INFO - Running setup.py (path:/tmp/pip-DiHLBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:12 INFO - Running setup.py (path:/tmp/pip-y3xbeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:12 INFO - Running setup.py (path:/tmp/pip-tUNFSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:12 INFO - Running setup.py (path:/tmp/pip-ftC7A8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:34:13 INFO - Running setup.py install for manifestparser 03:34:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:34:13 INFO - Running setup.py install for mozcrash 03:34:13 INFO - Running setup.py install for mozdebug 03:34:13 INFO - Running setup.py install for mozdevice 03:34:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:34:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:34:13 INFO - Running setup.py install for mozfile 03:34:13 INFO - Running setup.py install for mozhttpd 03:34:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:34:13 INFO - Running setup.py install for mozinfo 03:34:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:34:13 INFO - Running setup.py install for mozInstall 03:34:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:34:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:34:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:34:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:34:13 INFO - Running setup.py install for mozleak 03:34:13 INFO - Running setup.py install for mozlog 03:34:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:34:14 INFO - Running setup.py install for moznetwork 03:34:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:34:14 INFO - Running setup.py install for mozprocess 03:34:14 INFO - Running setup.py install for mozprofile 03:34:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:34:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:34:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:34:14 INFO - Running setup.py install for mozrunner 03:34:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:34:14 INFO - Running setup.py install for mozscreenshot 03:34:14 INFO - Running setup.py install for moztest 03:34:14 INFO - Running setup.py install for mozversion 03:34:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:34:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:34:14 INFO - Cleaning up... 03:34:14 INFO - Return code: 0 03:34:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:14 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')]} 03:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:14 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')]} 03:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:14 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 0x7f93c05aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b661c0>, '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 0x1b670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b67550>, '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': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', '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 03:34:14 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 03:34:14 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 03:34:14 INFO - Using env: {'DISPLAY': ':0', 03:34:14 INFO - 'HOME': '/home/cltbld', 03:34:14 INFO - 'LANG': 'en_US.UTF-8', 03:34:14 INFO - 'LANGUAGE': 'en_US:en', 03:34:14 INFO - 'LOGNAME': 'cltbld', 03:34:14 INFO - 'MAIL': '/var/mail/cltbld', 03:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:14 INFO - 'MOZ_NO_REMOTE': '1', 03:34:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:14 INFO - 'NO_EM_RESTART': '1', 03:34:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:14 INFO - 'PWD': '/builds/slave/test', 03:34:14 INFO - 'SHELL': '/bin/bash', 03:34:14 INFO - 'SHLVL': '1', 03:34:14 INFO - 'TERM': 'linux', 03:34:14 INFO - 'TMOUT': '86400', 03:34:14 INFO - 'USER': 'cltbld', 03:34:14 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', 03:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:14 INFO - '_': '/tools/buildbot/bin/python'} 03:34:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:15 INFO - Running setup.py (path:/tmp/pip-HtRKCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:15 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)) 03:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:15 INFO - Running setup.py (path:/tmp/pip-i_SoFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:15 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)) 03:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:15 INFO - Running setup.py (path:/tmp/pip-q06HTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:15 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)) 03:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:15 INFO - Running setup.py (path:/tmp/pip-lLiOA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:15 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)) 03:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:15 INFO - Running setup.py (path:/tmp/pip-9xFzND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:15 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)) 03:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:15 INFO - Running setup.py (path:/tmp/pip-g4p_87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:15 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)) 03:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:15 INFO - Running setup.py (path:/tmp/pip-_mHLPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:15 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)) 03:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:15 INFO - Running setup.py (path:/tmp/pip-aHEXpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:15 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)) 03:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:15 INFO - Running setup.py (path:/tmp/pip-r53dUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:15 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)) 03:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:15 INFO - Running setup.py (path:/tmp/pip-MYw4IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:15 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)) 03:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:15 INFO - Running setup.py (path:/tmp/pip-MmD2BE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:15 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)) 03:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:15 INFO - Running setup.py (path:/tmp/pip-XURPsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:15 INFO - Running setup.py (path:/tmp/pip-ZqRpoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:16 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)) 03:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:16 INFO - Running setup.py (path:/tmp/pip-bBBndv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:16 INFO - Running setup.py (path:/tmp/pip-NHRxan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:16 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)) 03:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:16 INFO - Running setup.py (path:/tmp/pip-bzB1Ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:16 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)) 03:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:16 INFO - Running setup.py (path:/tmp/pip-x1JMv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:16 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)) 03:34:16 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)) 03:34:16 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)) 03:34:16 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)) 03:34:16 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)) 03:34:16 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)) 03:34:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:21 INFO - Downloading blessings-1.6.tar.gz 03:34:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:34:22 INFO - Installing collected packages: blessings 03:34:22 INFO - Running setup.py install for blessings 03:34:22 INFO - Successfully installed blessings 03:34:22 INFO - Cleaning up... 03:34:22 INFO - Return code: 0 03:34:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:34:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:22 INFO - Reading from file tmpfile_stdout 03:34:22 INFO - Current package versions: 03:34:22 INFO - argparse == 1.2.1 03:34:22 INFO - blessings == 1.6 03:34:22 INFO - blobuploader == 1.2.4 03:34:22 INFO - docopt == 0.6.1 03:34:22 INFO - functools32 == 3.2.3-2 03:34:22 INFO - jsonschema == 2.5.1 03:34:22 INFO - manifestparser == 1.1 03:34:22 INFO - mozInstall == 1.12 03:34:22 INFO - mozcrash == 0.17 03:34:22 INFO - mozdebug == 0.1 03:34:22 INFO - mozdevice == 0.48 03:34:22 INFO - mozfile == 1.2 03:34:22 INFO - mozhttpd == 0.7 03:34:22 INFO - mozinfo == 0.9 03:34:22 INFO - mozleak == 0.1 03:34:22 INFO - mozlog == 3.2 03:34:22 INFO - moznetwork == 0.27 03:34:22 INFO - mozprocess == 0.23 03:34:22 INFO - mozprofile == 0.28 03:34:22 INFO - mozrunner == 6.12 03:34:22 INFO - mozscreenshot == 0.1 03:34:22 INFO - mozsystemmonitor == 0.3 03:34:22 INFO - moztest == 0.7 03:34:22 INFO - mozversion == 1.4 03:34:22 INFO - psutil == 3.1.1 03:34:22 INFO - requests == 1.2.3 03:34:22 INFO - wsgiref == 0.1.2 03:34:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:22 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 0x7f93c05aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b661c0>, '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 0x1b670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b67550>, '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': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', '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 03:34:22 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 03:34:22 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 03:34:22 INFO - Using env: {'DISPLAY': ':0', 03:34:22 INFO - 'HOME': '/home/cltbld', 03:34:22 INFO - 'LANG': 'en_US.UTF-8', 03:34:22 INFO - 'LANGUAGE': 'en_US:en', 03:34:22 INFO - 'LOGNAME': 'cltbld', 03:34:22 INFO - 'MAIL': '/var/mail/cltbld', 03:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:22 INFO - 'MOZ_NO_REMOTE': '1', 03:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:22 INFO - 'NO_EM_RESTART': '1', 03:34:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:22 INFO - 'PWD': '/builds/slave/test', 03:34:22 INFO - 'SHELL': '/bin/bash', 03:34:22 INFO - 'SHLVL': '1', 03:34:22 INFO - 'TERM': 'linux', 03:34:22 INFO - 'TMOUT': '86400', 03:34:22 INFO - 'USER': 'cltbld', 03:34:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', 03:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:22 INFO - '_': '/tools/buildbot/bin/python'} 03:34:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:22 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)) 03:34:22 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)) 03:34:22 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)) 03:34:22 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)) 03:34:22 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)) 03:34:22 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)) 03:34:22 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)) 03:34:22 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)) 03:34:22 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)) 03:34:22 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)) 03:34:22 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)) 03:34:22 INFO - Cleaning up... 03:34:22 INFO - Return code: 0 03:34:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:22 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 0x7f93c05aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b661c0>, '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 0x1b670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b67550>, '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': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', '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 03:34:22 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 03:34:22 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 03:34:22 INFO - Using env: {'DISPLAY': ':0', 03:34:22 INFO - 'HOME': '/home/cltbld', 03:34:22 INFO - 'LANG': 'en_US.UTF-8', 03:34:22 INFO - 'LANGUAGE': 'en_US:en', 03:34:22 INFO - 'LOGNAME': 'cltbld', 03:34:22 INFO - 'MAIL': '/var/mail/cltbld', 03:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:22 INFO - 'MOZ_NO_REMOTE': '1', 03:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:22 INFO - 'NO_EM_RESTART': '1', 03:34:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:22 INFO - 'PWD': '/builds/slave/test', 03:34:22 INFO - 'SHELL': '/bin/bash', 03:34:22 INFO - 'SHLVL': '1', 03:34:22 INFO - 'TERM': 'linux', 03:34:22 INFO - 'TMOUT': '86400', 03:34:22 INFO - 'USER': 'cltbld', 03:34:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', 03:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:22 INFO - '_': '/tools/buildbot/bin/python'} 03:34:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:34:22 INFO - Cleaning up... 03:34:22 INFO - Return code: 0 03:34:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:22 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 0x7f93c05aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b661c0>, '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 0x1b670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b67550>, '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': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', '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 03:34:22 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 03:34:22 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 03:34:22 INFO - Using env: {'DISPLAY': ':0', 03:34:22 INFO - 'HOME': '/home/cltbld', 03:34:22 INFO - 'LANG': 'en_US.UTF-8', 03:34:22 INFO - 'LANGUAGE': 'en_US:en', 03:34:22 INFO - 'LOGNAME': 'cltbld', 03:34:22 INFO - 'MAIL': '/var/mail/cltbld', 03:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:22 INFO - 'MOZ_NO_REMOTE': '1', 03:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:22 INFO - 'NO_EM_RESTART': '1', 03:34:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:22 INFO - 'PWD': '/builds/slave/test', 03:34:22 INFO - 'SHELL': '/bin/bash', 03:34:22 INFO - 'SHLVL': '1', 03:34:22 INFO - 'TERM': 'linux', 03:34:22 INFO - 'TMOUT': '86400', 03:34:22 INFO - 'USER': 'cltbld', 03:34:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', 03:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:22 INFO - '_': '/tools/buildbot/bin/python'} 03:34:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:23 INFO - Downloading/unpacking flake8 03:34:23 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 03:34:23 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 03:34:23 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 03:34:23 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 03:34:23 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 03:34:23 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 03:34:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:34:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:34:25 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 03:34:25 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 03:34:25 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 03:34:25 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 03:34:25 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 03:34:25 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 03:34:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:34:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:34:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:34:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:34:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:34:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:34:26 INFO - no previously-included directories found matching 'docs/_build' 03:34:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:34:26 INFO - Running setup.py install for pep8 03:34:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:34:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:34:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:34:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:34:26 INFO - no previously-included directories found matching 'docs/_build' 03:34:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:34:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:34:26 INFO - Cleaning up... 03:34:26 INFO - Return code: 0 03:34:26 INFO - Running post-action listener: _resource_record_post_action 03:34:26 INFO - Running post-action listener: _start_resource_monitoring 03:34:26 INFO - Starting resource monitoring. 03:34:26 INFO - ##### 03:34:26 INFO - ##### Finished create-virtualenv step (success) 03:34:26 INFO - ##### 03:34:26 INFO - ##### 03:34:26 INFO - ##### Running install step. 03:34:26 INFO - ##### 03:34:26 INFO - Running pre-action listener: _resource_record_pre_action 03:34:26 INFO - Running main action method: install 03:34:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:27 INFO - Reading from file tmpfile_stdout 03:34:27 INFO - Detecting whether we're running mozinstall >=1.0... 03:34:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:34:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:34:27 INFO - Reading from file tmpfile_stdout 03:34:27 INFO - Output received: 03:34:27 INFO - Usage: mozinstall [options] installer 03:34:27 INFO - Options: 03:34:27 INFO - -h, --help show this help message and exit 03:34:27 INFO - -d DEST, --destination=DEST 03:34:27 INFO - Directory to install application into. [default: 03:34:27 INFO - "/builds/slave/test"] 03:34:27 INFO - --app=APP Application being installed. [default: firefox] 03:34:27 INFO - mkdir: /builds/slave/test/build/application 03:34:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:34:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:34:43 INFO - Reading from file tmpfile_stdout 03:34:43 INFO - Output received: 03:34:43 INFO - /builds/slave/test/build/application/firefox/firefox 03:34:43 INFO - Running post-action listener: _resource_record_post_action 03:34:43 INFO - ##### 03:34:43 INFO - ##### Finished install step (success) 03:34:43 INFO - ##### 03:34:43 INFO - ##### 03:34:43 INFO - ##### Running run-tests step. 03:34:43 INFO - ##### 03:34:43 INFO - Running pre-action listener: _resource_record_pre_action 03:34:43 INFO - Running main action method: run_tests 03:34:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:34:43 INFO - Python 2.7.3 03:34:43 INFO - Return code: 0 03:34:43 INFO - grabbing minidump binary from tooltool 03:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:43 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 0x1b661c0>, '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 0x1b670c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b67550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:34:43 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 03:34:43 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 03:34:43 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 03:34:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:34:43 INFO - Return code: 0 03:34:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:34:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:34:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:34:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:34:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:34:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:34:44 INFO - Return code: 0 03:34:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 03:34:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 03:34:44 INFO - Using env: {'DISPLAY': ':0', 03:34:44 INFO - 'HOME': '/home/cltbld', 03:34:44 INFO - 'LANG': 'en_US.UTF-8', 03:34:44 INFO - 'LANGUAGE': 'en_US:en', 03:34:44 INFO - 'LOGNAME': 'cltbld', 03:34:44 INFO - 'MAIL': '/var/mail/cltbld', 03:34:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:34:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:44 INFO - 'MOZ_NO_REMOTE': '1', 03:34:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:34:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:44 INFO - 'NO_EM_RESTART': '1', 03:34:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:44 INFO - 'PWD': '/builds/slave/test', 03:34:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:34:44 INFO - 'SHELL': '/bin/bash', 03:34:44 INFO - 'SHLVL': '1', 03:34:44 INFO - 'TERM': 'linux', 03:34:44 INFO - 'TMOUT': '86400', 03:34:44 INFO - 'USER': 'cltbld', 03:34:44 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918', 03:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:44 INFO - '_': '/tools/buildbot/bin/python'} 03:34:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 03:34:44 INFO - mozversion application_buildid: 20160720004018 03:34:44 INFO - mozversion application_changeset: 68ca48e7a1646a4e43f1c11393c92de0fc52bb3e 03:34:44 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:34:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:34:44 INFO - mozversion application_name: Firefox 03:34:44 INFO - mozversion application_remotingname: firefox-dev 03:34:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:34:44 INFO - mozversion application_vendor: Mozilla 03:34:44 INFO - mozversion application_version: 49.0a2 03:34:44 INFO - mozversion platform_buildid: 20160720004018 03:34:44 INFO - mozversion platform_changeset: 68ca48e7a1646a4e43f1c11393c92de0fc52bb3e 03:34:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:34:44 INFO - mozversion platform_version: 49.0a2 03:34:44 INFO - using testdate: 1469010884 03:34:44 INFO - actual date: 1469010884 03:34:44 INFO - starting webserver on 'localhost:59446' 03:34:44 INFO - SUITE-START | Running 2 tests 03:34:44 INFO - TEST-START | dromaeo_css 03:34:44 INFO - operating with platform_type : linux_ 03:34:44 INFO - Initialising browser for dromaeo_css test... 03:34:44 INFO - TEST-INFO | started process 12585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQQX6iG/profile http://localhost:59446/getInfo.html) 03:34:48 INFO - PROCESS | 12585 | __metrics Screen width/height:1600/1200 03:34:48 INFO - PROCESS | 12585 | colorDepth:24 03:34:48 INFO - PROCESS | 12585 | Browser inner width/height: 1024/697 03:34:48 INFO - PROCESS | 12585 | __metrics 03:34:49 INFO - PROCESS | 12585 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:34:49 ERROR - PROCESS | 12585 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:34:50 INFO - TEST-INFO | 12585: exit 0 03:34:50 INFO - Browser initialized. 03:34:50 INFO - Running cycle 1/1 for dromaeo_css test... 03:34:50 INFO - TEST-INFO | started process 12679 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQQX6iG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:02 INFO - PROCESS | 12679 | RSS: Main: 145055744 03:35:02 INFO - PROCESS | 12679 | 03:35:53 INFO - PROCESS | 12679 | 1469010953671 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] 03:38:00 INFO - PROCESS | 12679 | Cycle 1(1): loaded http://localhost:59446/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59446/tests/dromaeo/cssquery-ext.html) 03:38:02 INFO - PROCESS | 12679 | RSS: Main: 258256896 03:38:02 INFO - PROCESS | 12679 | 03:41:04 INFO - PROCESS | 12679 | Cycle 1(1): loaded http://localhost:59446/tests/dromaeo/cssquery-ext.html (next: http://localhost:59446/tests/dromaeo/cssquery-jquery.html) 03:41:05 INFO - PROCESS | 12679 | RSS: Main: 236085248 03:41:05 INFO - PROCESS | 12679 | 03:44:06 INFO - PROCESS | 12679 | Cycle 1(1): loaded http://localhost:59446/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59446/tests/dromaeo/cssquery-mootools.html) 03:44:07 INFO - PROCESS | 12679 | RSS: Main: 224985088 03:44:07 INFO - PROCESS | 12679 | 03:47:09 INFO - PROCESS | 12679 | Cycle 1(1): loaded http://localhost:59446/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59446/tests/dromaeo/cssquery-prototype.html) 03:47:10 INFO - PROCESS | 12679 | RSS: Main: 216477696 03:47:10 INFO - PROCESS | 12679 | 03:50:12 INFO - PROCESS | 12679 | Cycle 1(1): loaded http://localhost:59446/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59446/tests/dromaeo/cssquery-yui.html) 03:50:13 INFO - PROCESS | 12679 | RSS: Main: 194433024 03:50:13 INFO - PROCESS | 12679 | 03:53:15 INFO - PROCESS | 12679 | Cycle 1(1): loaded http://localhost:59446/tests/dromaeo/cssquery-yui.html (next: http://localhost:59446/tests/dromaeo/cssquery-dojo.html) 03:53:15 INFO - PROCESS | 12679 | RSS: Main: 259076096 03:53:15 INFO - PROCESS | 12679 | 03:53:15 INFO - PROCESS | 12679 | __start_tp_report 03:53:15 INFO - PROCESS | 12679 | _x_x_mozilla_page_load 03:53:15 INFO - PROCESS | 12679 | _x_x_mozilla_page_load_details 03:53:15 INFO - PROCESS | 12679 | |i|pagename|runs| 03:53:15 INFO - PROCESS | 12679 | |0;dojo.html;3313.353895990281;3351.849166787493;3351.8994430167095;3370.140614143393;3397.6772206640376;5526.696031718259;5622.859428514289;5628.324601047875;5653.095504719246;5668.546516278693;5596.328440587135;5635.943640563593;5649.209110724501;5654.74553645086;5655.066913959192;5031.471695471978;5041.8235361762345;5081.59347252219;5088.54203121719;5112.36095488064;5048.268001139832;5058.392992840864;5061.316722242505;5090.0328937501945;5144.614153938451;5054.3176671149295;5071.746412679369;5122.692638441706;5137.845864624067;5154.922676159842;5065.645404821664;5085.466026067284;5131.153359695646;5135.12702840518;5150.768215430315;4908.803647854117;4974.975125124387;5013.222950442687;5026.396832380101;5067.847964561069;5490.725463726798;5536.612437129403;5563.638363506359;5567.192757050246;5576.888462230732;5819.476247137778;6053.394660533955;6056.06131049688;6058.030715085565;6058.1518587397795;5951.791687290924;5987.341392446828;5989.3711160327975;6067.453929146354;6079.8036584575075;5680.4319568042865;5696.601237913306;5698.601097923147;5699.202111704365;5711.600187986801;6002.219711437572;6041.879162416815;6126.027940156527;6195.473384762346;6207.441330280206;5880.176775251382;5980.880382392328;5981.611195272293;5982.73077711504;5985.760569577168;6029;6035.849103772353;6059.030555111161;6067;6074.301455332605;5839.591228614041;5891.528677705774;5943.227380440515;5980.641161530322;5992.790252341147;6009.639421634716;6033.245844269466;6042.788502402394;6065.120557519223;6067.787627433018;4631.073785242965;4638.397008388888;4641.094986477605;4641.327007583882;4664.370310008106;4024.6176613221696;4041.9595804041583;4076.103257283393;4138.482689663792;4151.543330233671;5583.860403489945;5723.7996670116345;5727.570432217517;5737.569682273846;5740.9953258180485;5965.075413310944;5971.79098731551;5973.1936188614845;5981.222441082718;6010.759569617254;5631.18347839561;5648.124540696199;5672.858178545569;5674.687892165888;5704.087346024616;5151.22731590257;5162.6386152968935;5168;5169.896602068013;5185.766640501187;6109.175261339662;6201.069839524108;6263.31103578606;6263.592866463665;6277.089821975879;5975.581709280483;6028.186194863637;6041.124037014696;6090.208272924491;6104.114903338902;6297.275813281348;6320.873582528416;6328.208973878265;6335.873282534416;6338.683065846597;5776.971115144397;5789.623674461147;5958.791442299499;5961.493273071837;5962.19510366095;5896.764129434775;5991.850203744942;5998.3401825798255;6009.338972712911;6037;5760.135979603093;5838.4453476919625;5838.737256823369;5840.269966254218;5846.473817356458;5677.630953987978;5754.142972990539;5816.069428891357;5840.649561026352;5882.058870580687;5864.354920958776;5875.059990401686;5879.412058794257;5884.529237660891;5889.646621202742;5953.077273022688;5981.850453738517;6002.399760024137;6018.699065046818;6021.307549631673;5614.915776263278;5670.121131224667;5693;5775.249217601685;5870.589058765845 03:53:15 INFO - PROCESS | 12679 | |1;ext.html;599.3616798110013;634.6128861394551;641.9582727122737;654.8755736410079;659.7031335898845;36237.81881090594;45682.314765278505;47519;47519.5248047519;51102.23346649794;48792;49264;49266.75366623171;49347.75326123373;49437.50562494374;8468.576571171448;9131.634734610607;9270.072992700743;9274.39716418434;9281.721548353526;8411.537365444898;8486.915130848705;8492.150784921489;10810.72973175673;11057.612983545578;10672.733181670443;10694.411807350592;10712.678619641423;10723.088537474325;10724.571017159344;11129.944350278238;11184.496697648625;11202;11203.271787333797;11204.21570490066;8289.751307460785;10598.417087060208;10921.563137474492;10935.28920620157;11271.774564508745;45913.31130033052;46320;46372;46377.76811115957;46396.7680161597;3374;3726.739128261023;4040.3535434330365;4371.803268852877;4497.910041799146;35146;35324.11689707778;35574.11064723377;35835.462468063;35963.82018089919;4757.643176761757;4825.083234185494;4846.345743324641;4854.441739200002;4874.926876096862;224559;226720;227221;227762;228811.99999999834;38066.42900356497;66385.33614663887;66730;66783;66808;38454;40493.59506404957;40717;40724.59275407267;40730;15383.077015379113;15407.460738874086;15503.844961550465;15520.922395388177;15561.844381556266;11813.763724725457;13228.867711322957;13559.864401356057;13657.658558536115;13675;9053.818923621622;9195.586198620944;9206.861897071549;9258.444493330422;9285.117913798178;3476.3221171871746;3476.339495495898;3510.14001569612;3523.7624108691166;3549.597908826051;1094.262315411439;1113.9777204455866;1141.720278531765;1164.2665120973732;1190.2382475215868;35484.46773298403;35724.82137589347;35775.28449430997;35869.64130358715;35987.64012359843;1199.9760004799855;1243.819646151303;1284.3000564692265;1285.8199852020725;1346.8451128120196;18494.81505184931;18816.153273102744;18921.905390473235;18948.81051189498;19102.426927192206;566202;568877;571247;571609;574172;64565.35434645593;66305.00542491867;66401.66799165973;66402;66410.66794665996;1311.3902035553513;1455.1196526101767;1483.762597984339;1493.835678075411;1524.9542513724607;34678.47982280318;35571.28857422785;35784.821075894455;36215.81892090523;36467.63532364643;56082;56634.43365566291;56652.15021774759;56655.71672141613;56806.43193568011;413351;416702;417456;419325;420414;26850.462990740467;27504.17487475299;29804;30359.848200758854;31084.378312434077;49254;53225.46774532205;54150.72924635509;54303.18545221746;55201.447985521234;42535.78732106443;43947.34078988882;44430.3335449962;45294.54705452903;45899.541004589526;43847;44481.55518444774;44989.550104498536;45679.54320456886;45982.54017459782;44403.33394999142;44899.551004489535;44933.10133797371;46018.539814602766;46101;39105.41341879931;39122;39728;40385.798071009456;40786.1842763149;29138.417231655672;29770.40459190761;29785.10644680663;29923.70076299296;30183.69816301809 03:53:15 INFO - PROCESS | 12679 | |2;jquery.html;411.1653343712263;412.9483814523185;427.6066019262279;431.85316992222636;443.08060773894175;18880.90559547202;19991.800081999158;20572.177112915484;21141.471463213387;21238.150473981063;19694.606107877833;19946.501337466572;20380.388588342335;20619.38141855743;20630.38108856733;5627.549796016309;5853;5879.559033072515;5904.409559044083;5917.674527900964;4233.111046680186;5842.44496772808;5911.113333000041;6134.723937422827;6459.224893012845;6400.03999400089;6479.546431749779;6508.967455162741;6530.8040758777315;6532.869342613169;6216.440520353145;6311.968440157792;6353.904691429632;6354.237491501003;6361.8409539761415;3908.9413658795143;5477.287952566181;5571.777128914839;5786.421357864222;5793.7392817323325;23179.76820231793;24212;24580.385490362703;24746.133885313928;24788.752112478825;2391.940201494959;2431.6230984197477;2450.2404254681105;2751.4222013377216;3122.125804774667;9870.111689947938;10376.844347334796;10534.47327633623;14576.489822856149;15593.454229101926;2024.9595008099902;2066.4007437843006;2102.8317734581196;2103.116690989788;2111.493241622015;54072.18891716628;80098.59950700267;83039.5848020762;83473;84157.57921210416;11407.429628518541;11514.424278786195;11725.648230553097;11733.530658773725;11757.412129393497;16381.426650067191;16487;16501.83498165003;16513.091779952218;16546.58633534171;8478.109798471196;8562.11633440642;8591.269742071869;8595.355348348774;8820.514871682119;8255;8325.708600198965;8372.706955256659;8409.663613455394;8482.10937851529;5026.868954485211;5052.873678158076;5053.67151135175;5098.133317336062;5121.411037730709;1787.6335351252962;2078.366098340021;3200.919977000547;3299.5710557627353;3316.2372654289647;947.3226642950324;1054.3989925742408;1077.4235783855756;1091.8307662312354;1128.4639796096953;18248.45254642363;19424.611507769765;19639.803601964082;19717;20000;992.3599278465349;1032.2877214721818;1069.2996087562658;1079.978400431987;1092.3282181458505;10707.678769636923;11113.777724445466;11116;11121.666350009513;11200.103991680646;374322;375262;376943;496202;497911;97587;104665.47667261615;104756.47621761843;104959.4752026235;105245;1064.0742553978089;1068.5245065945735;1115.6653004098737;1127.6617014895498;1133.6825688807148;17723.645527089644;17958.19188136563;18029;18097.728534071735;18536;31205.531917021715;31965.360692785547;35163;36106;40201;55991;61142;61207.693961529905;62787;62999.37000629935;8028.518288902685;8314.62584183701;8823.955880220814;9219.815603688023;9311.953440233026;13490.123141995738;14038.719225615634;14173.645658858612;14291.928540357232;14316.57050288493;12115.333656648616;12278.386080695751;12297.847876621734;12334.50661973547;12345.691357716129;12327.93836030814;12406.751864962469;12449.439775209956;12520.248785072925;12921.741565168455;12405.937970310091;12595.24428534291;12736.23582585048;12880.742385152056;12949.546765863526;8275.54484503358;8403;8495;8563.143685631387;8586.65653373858;10903.12774977984;11890.405479725807;11920.403979800802;12203.511859525519;12837.165584236995 03:53:15 INFO - PROCESS | 12679 | |3;mootools.html;1090.1496832470675;1091.9563217471302;1327.8273824402827;1390.7705228637276;1813.2112531048995;9083.818323633523;9421.905780942197;9423.293253006017;9428.29287803415;9767.36512126713;9495.382800117988;9674.08096230857;9680.903190968089;9695.806083878319;9721.562529686164;2071.2232912657755;2299.8735069571167;2344.9062037518565;2409.915652952147;2468.5926822074334;2471.1598056660823;2493.227099599121;2502.1742824867843;2503;2506.273180777572;2331.079223706635;2347.6361164019604;2354.8822558872075;2355.2463211772238;2356.446235134742;2046.8362530997485;2247.1460844878925;2317.7102862142233;2317.97682023181;2332.0555175153922;2245.303955773715;2252.222983070838;2253.5943530164564;2278.0773786616446;2409.9156529521383;9669.129778319915;9737.65918192867;9744.610215591369;9753.21974242059;9761.853572196424;5642.210090587321;5843.474087332161;5846.590738648296;5851.297844258716;5854.2096816930025;3539.522164507784;3580.4987301777774;3673.94489082664;3695.5380577427823;3739.139997800494;1222.2788554752738;1236.6104677026708;1265.2914367953974;2249.403907964391;2329.452578644017;13535.120217185851;13635.318234088256;13636.181829090287;13636.386362613706;13642.113262637897;4819.638527110411;4887.266909963534;4965.925511117336;4967.925481117786;4976.154053810788;10724.73188170302;10782.73043173927;10790.67627971162;10825.025747682746;10832.837507437394;5020.3724534433195;5714.999875021937;5755.165501002415;5761.164631128547;5762.250907382014;5209.843704688866;5366.731663416892;5367.1680889462195;5410.810621628224;5418.566514678816;4050.837966481308;4074.7555146691293;4093.2427500912427;4149.875503734893;4156.251874662529;1138.1691365303375;1183.911206659504;1192.6720151958282;1204.1691233049169;1204.9457774400173;942.9575669094908;1083.6423980086552;1085.484394912426;1091.5033659684825;1098.3464838421128;6410.839729006812;6456.54804163704;6580.934190658032;6614.338566143443;6938.930610693828;460.39228218751595;461.1744976492109;462.7246788161039;465.1650287733526;468.70471602890643;4261.722988005769;4303.354496825438;4307.806148723253;4346.239408103569;4369.584889435499;11714.121440891968;11992.76014479723;12072.094592905567;12085.818712719316;12088.395580220953;11693.181477296508;11893.762124757457;11986.940065299617;11992.160548761678;12053.819192712117;8933.15135062168;8997.640094396282;9024.232940200025;9054.81890362189;9077.137671921157;6318.399752023551;6532.542722009413;6545.672716364258;6616.139901812733;6682.565633233824;10584.100351470212;10748.677539673823;10817.783644326912;10979.835302470628;10987.285826421577;11084.390358530036;11329.150313726668;11430.1998860079;11513.481893314653;11692.064634829363;8349.081601024003;8446.113158118309;8561.01548321926;8580.699675511576;8825.955870220609;9483.051694830461;9507.572159252988;9564.66523671668;9587.472689002172;9637.132658060807;8455.957720211605;8458.450200736932;8567.828643427221;8644.178803013703;8648.783780405289;8369.874451883348;8401.495910245405;8492.363072769444;8535.95732021336;8642.82714345697;7575.621218938921;7626.923730762844;7654.387648988179;7656.196099409482;7683.154852966058;5595.832125036255;5744.655320680772;5780.94219057804;5835.591508594358;5941.970290148522;5155.304033955368;5157.277981082727;5245.082110630548;5360.276362690986;5402.378726446352 03:53:15 INFO - PROCESS | 12679 | |4;prototype.html;356.6754253629197;363.8544582167133;364.3769154745385;366.2382244930545;367.6158414456892;5456.427075157111;5467.879084787619;5496.560275177986;5514.58640601955;5545.279113715216;5373.731313434332;5401;5403.621746477748;5451.863703407417;5453.809116680917;4377.890552736191;4388.758618275993;4407.162639098561;4415.779211039435;4451.132029254297;4373.1909596724545;4375.387445757597;4384.539623339551;4393.868183954486;4426.402435671175;4370.688793361995;4374.60628543431;4390.692651514395;4390.714603550759;4401.691881568291;4032.677385809143;4280.122574872144;4317.287647538153;4321.416608757809;4398.626116780078;3795.449659799341;3805.1438426354125;3812.066043819282;3813.733038687293;3828.712846536493;5342.2253773202665;5346.304980352529;5348.91976620351;5371.731413429313;5381.219723140122;4768.690035147704;4941.579965702919;4952.975235123838;4965.652404331699;4966.47851975541;5724.570657200727;5746.827595172152;5756.942430575683;5759.157069737686;5794.595242974161;4202.85290014848;4204.26425375558;4210.989362552996;4219.092895027584;4239.130978149503;5652.699879027806;5790.88418231633;5832.358440571534;5989.3711160327975;6082.543809214327;4210.221109094828;4216.2199993001395;4227.5203678712205;4231.894202644959;4252.213340532012;4281.165172791276;4283.807228674655;4287.928017995501;4290.742555446684;4292.849750258726;4683.250679891201;4758.500357462486;4829.492903245179;4861.878453038632;4890.486498917634;5788.858122494704;5805.983952808242;5807.361190269067;5811.82564523065;5835.562332825055;1448.4133925760084;1476.9556913292618;1482.22183353738;1492.1942151238427;1492.79847220626;949.6866034208695;953.6124938214881;957.5786653872274;961.869802981494;966.9613215471443;4822.9758851206225;5010.298558201855;5022.999999999927;5036.949630503648;5048.798048078036;5210.869728256748;5213.582913366921;5220.660657057279;5286.682799032071;5288.36539615241;4994.750262486861;5021.614733001795;5045.5459008689395;5069.5944324454695;5074.720890351066;2790.400063986253;2796.748292653671;2905.8401787901867;3156.9684303157132;3164.9872040947134;6156.846078847975;6161.876762464725;6220.782272620437;6233.906491402633;6234.376562343729;5776.306843178845;6029.216201893813;6030.547708921848;6035.215421995113;6061.787837425757;6211.409916057967;6265.279492858289;6277.748890044439;6282.4974002079725;6284.497240220771;5987.700614969322;5996.001999000499;6003.249593800775;6028.336882942785;6044.365341639064;5804.796832110856;5836.307470833411;5841.6856207353;5929.205308602412;5938.257717785277;6199.380061993765;6199.814005579839;6205.627662340274;6236.844078898064;6255.028861290851;4062.857799976987;4282.164977829293;4315.244832154423;4318.503372112247;4327.3725309830525;5872.882542349214;5895.616784908967;5909.172715819703;5915.7463395131645;5936.347001829881;5730.799422020209;5761.798337058183;5763.33721622002;5769.8557536061935;5788.131780232999;5637.859053523531;5750.942490575041;5764.328344780134;5774.364819869895;5811.418858114154;5659.773609055592;5669.922714684197;5681.431856814285;5685.687287199244;5691.8292451226525;5589.748461319332;5758.366579676149;5764.682942438206;5784.797532086357;5823.650580965155;5624.353199382123;5670.489655930986;5674.375818659862;5674.77300907959;5684.232628595252 03:53:15 INFO - PROCESS | 12679 | |5;yui.html;730.6675462664488;735.8197241675789;770.8458308338332;782.7690831204798;809.9514029158255;14141.575752727409;14549.636259093528;14601.780973285397;14646.853531464682;14653.853461465382;14186.503472378468;14352.138871667707;14382.856171438283;14395;14442.783358249635;703.2264509040066;855.5123579559654;889.3107841422884;889.9421537600068;895.0467751844297;887.2901678657081;893.3433926064338;893.4996402014892;896.3725392225435;898.27239935652;743.5650144665377;941.0401390581603;941.5292353823088;941.6657086734214;942.4627962061628;773.8607050730866;776.510798197135;883.1036497954581;912.8402529557301;913.8583519554479;677.4106527321213;678.0338018323918;678.1286047429079;678.2132726037822;681.7852376501386;13854.16874987494;13907.721845563032;13965.79051314231;13981.231032293219;13999.090059146123;14606.634834129232;14898.255087245703;14923.850761492355;15029.473968411054;15037.849621503754;12222.449989750483;12958.676033099153;13375.26436046017;13635.181889086687;13847.307634618228;4739.099571081483;4784.736839473828;4796.064767370364;4887.193613053842;4961.677490963076;83356.58321708413;85760.57119714424;86020;86677;88150;11791.469383877575;11976.461059252355;12088;12110.273383597012;12126.211796233216;22402.327930162122;22405.21581744664;22416.103355865907;22426.21508247236;22438.887805561193;8362.45644033136;8554.78613034679;8756.343274254456;8831.3376496763;9049.321300902458;4681.438227412664;4724.267738500538;4768.237082066922;4814.518548145227;4872.074305881871;3625.818709064589;3756.2487502499607;3793.260314238697;3846.8653597124526;3910.7458015228917;683.3132701634925;693.6219760230687;699.4404476418845;701.6281370873445;702.118840854724;687.9724811007503;709.7125664106045;754.3060384446322;820.1101804542019;825.7481468152151;10067;10700.78598428027;10705.090067344207;10769.353838769699;10780.946095269474;680.8638272345551;688.5868478912713;731.8353370491703;739.1241378965942;832.3590835056972;4811.518848115161;4865.172920603506;4875.780589873393;4947.901041979212;4963.354763880672;72295;80028.59985700034;98279.50860245652;112708.18229544163;119570.40214799045;100288;101362;102609.48695256625;102937.48531257296;104068;87557.56221218852;87816.12183878079;90460;90602.54698726464;91105.54447227855;8797.252233560219;8916.777080573038;8940.73177804667;8996.50519221449;9047.547622618711;53088.73455632852;53603.73198133984;54219.7010930625;54524.45475545194;56138.15792763193;74403.62798185974;75571;76790.23209768055;77271.61364193143;78762.6061869687;12875.613731588068;12959.352032398154;13211.405486752927;13346;13609.727805444034;13584.184948903097;13612.591622251348;13835.930820345833;14328.570142895729;14641.414343426144;9733.805323893625;13881.192066181762;14940.626484337978;14990.475333363716;15262.08427494354;13097.670515004644;13336.86663133395;13694.963155354682;13844.169349839041;14196.503122390666;14293.64265893361;14302.070365426214;14317.785233221302;14359.210243436293;14506.782398264246;11285.943570282096;11302.547898083985;11335.206535542433;11337.149713771336;11570.132240082195;11190.608328708457;11237.213395062594;11318.773624527628;11319.434028298387;11387.886121138683 03:53:15 INFO - PROCESS | 12679 | __end_tp_report 03:53:15 INFO - PROCESS | 12679 | __start_cc_report 03:53:15 INFO - PROCESS | 12679 | _x_x_mozilla_cycle_collect,965 03:53:15 INFO - PROCESS | 12679 | __end_cc_report 03:53:15 INFO - PROCESS | 12679 | __startTimestamp1469011995821__endTimestamp 03:53:15 INFO - PROCESS | 12679 | 03:53:15 INFO - PROCESS | 12679 | ------- Summary: start ------- 03:53:15 INFO - PROCESS | 12679 | Number of tests: 6 03:53:15 INFO - PROCESS | 12679 | 03:53:15 INFO - PROCESS | 12679 | [#0] dojo.html Cycles:165 Average:5584.68 Median:5776.97 stddev:629.20 (10.9%) stddev-sans-first:605.37 03:53:15 INFO - PROCESS | 12679 | Values: 3313.4 3351.8 3351.9 3370.1 3397.7 5526.7 5622.9 5628.3 5653.1 5668.5 5596.3 5635.9 5649.2 5654.7 5655.1 5031.5 5041.8 5081.6 5088.5 5112.4 5048.3 5058.4 5061.3 5090.0 5144.6 5054.3 5071.7 5122.7 5137.8 5154.9 5065.6 5085.5 5131.2 5135.1 5150.8 4908.8 4975.0 5013.2 5026.4 5067.8 5490.7 5536.6 5563.6 5567.2 5576.9 5819.5 6053.4 6056.1 6058.0 6058.2 5951.8 5987.3 5989.4 6067.5 6079.8 5680.4 5696.6 5698.6 5699.2 5711.6 6002.2 6041.9 6126.0 6195.5 6207.4 5880.2 5980.9 5981.6 5982.7 5985.8 6029.0 6035.8 6059.0 6067.0 6074.3 5839.6 5891.5 5943.2 5980.6 5992.8 6009.6 6033.2 6042.8 6065.1 6067.8 4631.1 4638.4 4641.1 4641.3 4664.4 4024.6 4042.0 4076.1 4138.5 4151.5 5583.9 5723.8 5727.6 5737.6 5741.0 5965.1 5971.8 5973.2 5981.2 6010.8 5631.2 5648.1 5672.9 5674.7 5704.1 5151.2 5162.6 5168.0 5169.9 5185.8 6109.2 6201.1 6263.3 6263.6 6277.1 5975.6 6028.2 6041.1 6090.2 6104.1 6297.3 6320.9 6328.2 6335.9 6338.7 5777.0 5789.6 5958.8 5961.5 5962.2 5896.8 5991.9 5998.3 6009.3 6037.0 5760.1 5838.4 5838.7 5840.3 5846.5 5677.6 5754.1 5816.1 5840.6 5882.1 5864.4 5875.1 5879.4 5884.5 5889.6 5953.1 5981.9 6002.4 6018.7 6021.3 5614.9 5670.1 5693.0 5775.2 5870.6 03:53:15 INFO - PROCESS | 12679 | 03:53:15 INFO - PROCESS | 12679 | [#1] ext.html Cycles:180 Average:58273.77 Median:22266.97 stddev:114104.01 (512.4%) stddev-sans-first:114341.94 03:53:15 INFO - PROCESS | 12679 | Values: 599.4 634.6 642.0 654.9 659.7 36237.8 45682.3 47519.0 47519.5 51102.2 48792.0 49264.0 49266.8 49347.8 49437.5 8468.6 9131.6 9270.1 9274.4 9281.7 8411.5 8486.9 8492.2 10810.7 11057.6 10672.7 10694.4 10712.7 10723.1 10724.6 11129.9 11184.5 11202.0 11203.3 11204.2 8289.8 10598.4 10921.6 10935.3 11271.8 45913.3 46320.0 46372.0 46377.8 46396.8 3374.0 3726.7 4040.4 4371.8 4497.9 35146.0 35324.1 35574.1 35835.5 35963.8 4757.6 4825.1 4846.3 4854.4 4874.9 224559.0 226720.0 227221.0 227762.0 228812.0 38066.4 66385.3 66730.0 66783.0 66808.0 38454.0 40493.6 40717.0 40724.6 40730.0 15383.1 15407.5 15503.8 15520.9 15561.8 11813.8 13228.9 13559.9 13657.7 13675.0 9053.8 9195.6 9206.9 9258.4 9285.1 3476.3 3476.3 3510.1 3523.8 3549.6 1094.3 1114.0 1141.7 1164.3 1190.2 35484.5 35724.8 35775.3 35869.6 35987.6 1200.0 1243.8 1284.3 1285.8 1346.8 18494.8 18816.2 18921.9 18948.8 19102.4 566202.0 568877.0 571247.0 571609.0 574172.0 64565.4 66305.0 66401.7 66402.0 66410.7 1311.4 1455.1 1483.8 1493.8 1525.0 34678.5 35571.3 35784.8 36215.8 36467.6 56082.0 56634.4 56652.2 56655.7 56806.4 413351.0 416702.0 417456.0 419325.0 420414.0 26850.5 27504.2 29804.0 30359.8 31084.4 49254.0 53225.5 54150.7 54303.2 55201.4 42535.8 43947.3 44430.3 45294.5 45899.5 43847.0 44481.6 44989.6 45679.5 45982.5 44403.3 44899.6 44933.1 46018.5 46101.0 39105.4 39122.0 39728.0 40385.8 40786.2 29138.4 29770.4 29785.1 29923.7 30183.7 03:53:15 INFO - PROCESS | 12679 | 03:53:15 INFO - PROCESS | 12679 | [#2] jquery.html Cycles:180 Average:27710.61 Median:13321.81 stddev:71226.99 (534.7%) stddev-sans-first:71397.31 03:53:15 INFO - PROCESS | 12679 | Values: 411.2 412.9 427.6 431.9 443.1 18880.9 19991.8 20572.2 21141.5 21238.2 19694.6 19946.5 20380.4 20619.4 20630.4 5627.5 5853.0 5879.6 5904.4 5917.7 4233.1 5842.4 5911.1 6134.7 6459.2 6400.0 6479.5 6509.0 6530.8 6532.9 6216.4 6312.0 6353.9 6354.2 6361.8 3908.9 5477.3 5571.8 5786.4 5793.7 23179.8 24212.0 24580.4 24746.1 24788.8 2391.9 2431.6 2450.2 2751.4 3122.1 9870.1 10376.8 10534.5 14576.5 15593.5 2025.0 2066.4 2102.8 2103.1 2111.5 54072.2 80098.6 83039.6 83473.0 84157.6 11407.4 11514.4 11725.6 11733.5 11757.4 16381.4 16487.0 16501.8 16513.1 16546.6 8478.1 8562.1 8591.3 8595.4 8820.5 8255.0 8325.7 8372.7 8409.7 8482.1 5026.9 5052.9 5053.7 5098.1 5121.4 1787.6 2078.4 3200.9 3299.6 3316.2 947.3 1054.4 1077.4 1091.8 1128.5 18248.5 19424.6 19639.8 19717.0 20000.0 992.4 1032.3 1069.3 1080.0 1092.3 10707.7 11113.8 11116.0 11121.7 11200.1 374322.0 375262.0 376943.0 496202.0 497911.0 97587.0 104665.5 104756.5 104959.5 105245.0 1064.1 1068.5 1115.7 1127.7 1133.7 17723.6 17958.2 18029.0 18097.7 18536.0 31205.5 31965.4 35163.0 36106.0 40201.0 55991.0 61142.0 61207.7 62787.0 62999.4 8028.5 8314.6 8824.0 9219.8 9312.0 13490.1 14038.7 14173.6 14291.9 14316.6 12115.3 12278.4 12297.8 12334.5 12345.7 12327.9 12406.8 12449.4 12520.2 12921.7 12405.9 12595.2 12736.2 12880.7 12949.5 8275.5 8403.0 8495.0 8563.1 8586.7 10903.1 11890.4 11920.4 12203.5 12837.2 03:53:15 INFO - PROCESS | 12679 | 03:53:15 INFO - PROCESS | 12679 | [#3] mootools.html Cycles:180 Average:6292.56 Median:461.95 stddev:3682.89 (797.3%) stddev-sans-first:3672.47 03:53:15 INFO - PROCESS | 12679 | Values: 1090.1 1092.0 1327.8 1390.8 1813.2 9083.8 9421.9 9423.3 9428.3 9767.4 9495.4 9674.1 9680.9 9695.8 9721.6 2071.2 2299.9 2344.9 2409.9 2468.6 2471.2 2493.2 2502.2 2503.0 2506.3 2331.1 2347.6 2354.9 2355.2 2356.4 2046.8 2247.1 2317.7 2318.0 2332.1 2245.3 2252.2 2253.6 2278.1 2409.9 9669.1 9737.7 9744.6 9753.2 9761.9 5642.2 5843.5 5846.6 5851.3 5854.2 3539.5 3580.5 3673.9 3695.5 3739.1 1222.3 1236.6 1265.3 2249.4 2329.5 13535.1 13635.3 13636.2 13636.4 13642.1 4819.6 4887.3 4965.9 4967.9 4976.2 10724.7 10782.7 10790.7 10825.0 10832.8 5020.4 5715.0 5755.2 5761.2 5762.3 5209.8 5366.7 5367.2 5410.8 5418.6 4050.8 4074.8 4093.2 4149.9 4156.3 1138.2 1183.9 1192.7 1204.2 1204.9 943.0 1083.6 1085.5 1091.5 1098.3 6410.8 6456.5 6580.9 6614.3 6938.9 460.4 461.2 462.7 465.2 468.7 4261.7 4303.4 4307.8 4346.2 4369.6 11714.1 11992.8 12072.1 12085.8 12088.4 11693.2 11893.8 11986.9 11992.2 12053.8 8933.2 8997.6 9024.2 9054.8 9077.1 6318.4 6532.5 6545.7 6616.1 6682.6 10584.1 10748.7 10817.8 10979.8 10987.3 11084.4 11329.2 11430.2 11513.5 11692.1 8349.1 8446.1 8561.0 8580.7 8826.0 9483.1 9507.6 9564.7 9587.5 9637.1 8456.0 8458.5 8567.8 8644.2 8648.8 8369.9 8401.5 8492.4 8536.0 8642.8 7575.6 7626.9 7654.4 7656.2 7683.2 5595.8 5744.7 5780.9 5835.6 5942.0 5155.3 5157.3 5245.1 5360.3 5402.4 03:53:15 INFO - PROCESS | 12679 | 03:53:15 INFO - PROCESS | 12679 | [#4] prototype.html Cycles:180 Average:4827.29 Median:5391.11 stddev:1419.05 (26.3%) stddev-sans-first:1382.79 03:53:15 INFO - PROCESS | 12679 | Values: 356.7 363.9 364.4 366.2 367.6 5456.4 5467.9 5496.6 5514.6 5545.3 5373.7 5401.0 5403.6 5451.9 5453.8 4377.9 4388.8 4407.2 4415.8 4451.1 4373.2 4375.4 4384.5 4393.9 4426.4 4370.7 4374.6 4390.7 4390.7 4401.7 4032.7 4280.1 4317.3 4321.4 4398.6 3795.4 3805.1 3812.1 3813.7 3828.7 5342.2 5346.3 5348.9 5371.7 5381.2 4768.7 4941.6 4953.0 4965.7 4966.5 5724.6 5746.8 5756.9 5759.2 5794.6 4202.9 4204.3 4211.0 4219.1 4239.1 5652.7 5790.9 5832.4 5989.4 6082.5 4210.2 4216.2 4227.5 4231.9 4252.2 4281.2 4283.8 4287.9 4290.7 4292.8 4683.3 4758.5 4829.5 4861.9 4890.5 5788.9 5806.0 5807.4 5811.8 5835.6 1448.4 1477.0 1482.2 1492.2 1492.8 949.7 953.6 957.6 961.9 967.0 4823.0 5010.3 5023.0 5036.9 5048.8 5210.9 5213.6 5220.7 5286.7 5288.4 4994.8 5021.6 5045.5 5069.6 5074.7 2790.4 2796.7 2905.8 3157.0 3165.0 6156.8 6161.9 6220.8 6233.9 6234.4 5776.3 6029.2 6030.5 6035.2 6061.8 6211.4 6265.3 6277.7 6282.5 6284.5 5987.7 5996.0 6003.2 6028.3 6044.4 5804.8 5836.3 5841.7 5929.2 5938.3 6199.4 6199.8 6205.6 6236.8 6255.0 4062.9 4282.2 4315.2 4318.5 4327.4 5872.9 5895.6 5909.2 5915.7 5936.3 5730.8 5761.8 5763.3 5769.9 5788.1 5637.9 5750.9 5764.3 5774.4 5811.4 5659.8 5669.9 5681.4 5685.7 5691.8 5589.7 5758.4 5764.7 5784.8 5823.7 5624.4 5670.5 5674.4 5674.8 5684.2 03:53:15 INFO - PROCESS | 12679 | 03:53:15 INFO - PROCESS | 12679 | [#5] yui.html Cycles:180 Average:20995.56 Median:4790.40 stddev:29756.32 (621.2%) stddev-sans-first:29800.88 03:53:15 INFO - PROCESS | 12679 | Values: 730.7 735.8 770.8 782.8 810.0 14141.6 14549.6 14601.8 14646.9 14653.9 14186.5 14352.1 14382.9 14395.0 14442.8 703.2 855.5 889.3 889.9 895.0 887.3 893.3 893.5 896.4 898.3 743.6 941.0 941.5 941.7 942.5 773.9 776.5 883.1 912.8 913.9 677.4 678.0 678.1 678.2 681.8 13854.2 13907.7 13965.8 13981.2 13999.1 14606.6 14898.3 14923.9 15029.5 15037.8 12222.4 12958.7 13375.3 13635.2 13847.3 4739.1 4784.7 4796.1 4887.2 4961.7 83356.6 85760.6 86020.0 86677.0 88150.0 11791.5 11976.5 12088.0 12110.3 12126.2 22402.3 22405.2 22416.1 22426.2 22438.9 8362.5 8554.8 8756.3 8831.3 9049.3 4681.4 4724.3 4768.2 4814.5 4872.1 3625.8 3756.2 3793.3 3846.9 3910.7 683.3 693.6 699.4 701.6 702.1 688.0 709.7 754.3 820.1 825.7 10067.0 10700.8 10705.1 10769.4 10780.9 680.9 688.6 731.8 739.1 832.4 4811.5 4865.2 4875.8 4947.9 4963.4 72295.0 80028.6 98279.5 112708.2 119570.4 100288.0 101362.0 102609.5 102937.5 104068.0 87557.6 87816.1 90460.0 90602.5 91105.5 8797.3 8916.8 8940.7 8996.5 9047.5 53088.7 53603.7 54219.7 54524.5 56138.2 74403.6 75571.0 76790.2 77271.6 78762.6 12875.6 12959.4 13211.4 13346.0 13609.7 13584.2 13612.6 13835.9 14328.6 14641.4 9733.8 13881.2 14940.6 14990.5 15262.1 13097.7 13336.9 13695.0 13844.2 14196.5 14293.6 14302.1 14317.8 14359.2 14506.8 11285.9 11302.5 11335.2 11337.1 11570.1 11190.6 11237.2 11318.8 11319.4 11387.9 03:53:15 INFO - PROCESS | 12679 | -------- Summary: end -------- 03:53:15 INFO - PROCESS | 12679 | 03:53:16 INFO - TEST-INFO | 12679: exit 0 03:53:16 INFO - TEST-OK | dromaeo_css | took 1112231ms 03:53:16 INFO - TEST-START | kraken 03:53:16 INFO - operating with platform_type : linux_ 03:53:16 INFO - Initialising browser for kraken test... 03:53:16 INFO - TEST-INFO | started process 12871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgBxiLW/profile http://localhost:59446/getInfo.html) 03:53:20 INFO - PROCESS | 12871 | __metrics Screen width/height:1600/1200 03:53:20 INFO - PROCESS | 12871 | colorDepth:24 03:53:20 INFO - PROCESS | 12871 | Browser inner width/height: 1024/697 03:53:20 INFO - PROCESS | 12871 | __metrics 03:53:21 INFO - PROCESS | 12871 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:53:21 ERROR - PROCESS | 12871 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:53:21 INFO - TEST-INFO | 12871: exit 0 03:53:21 INFO - Browser initialized. 03:53:21 INFO - Running cycle 1/1 for kraken test... 03:53:21 INFO - TEST-INFO | started process 12963 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgBxiLW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:33 INFO - PROCESS | 12963 | RSS: Main: 145620992 03:53:33 INFO - PROCESS | 12963 | 03:53:36 INFO - PROCESS | 12963 | Cycle 1(1): loaded http://localhost:59446/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59446/tests/kraken/driver.html?testName=audio-beat-detection) 03:53:37 INFO - PROCESS | 12963 | RSS: Main: 194695168 03:53:37 INFO - PROCESS | 12963 | 03:53:39 INFO - PROCESS | 12963 | Cycle 1(1): loaded http://localhost:59446/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59446/tests/kraken/driver.html?testName=audio-dft) 03:53:40 INFO - PROCESS | 12963 | RSS: Main: 193679360 03:53:40 INFO - PROCESS | 12963 | 03:53:43 INFO - PROCESS | 12963 | Cycle 1(1): loaded http://localhost:59446/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59446/tests/kraken/driver.html?testName=audio-fft) 03:53:43 INFO - PROCESS | 12963 | RSS: Main: 280485888 03:53:43 INFO - PROCESS | 12963 | 03:53:45 INFO - PROCESS | 12963 | Cycle 1(1): loaded http://localhost:59446/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59446/tests/kraken/driver.html?testName=audio-oscillator) 03:53:46 INFO - PROCESS | 12963 | RSS: Main: 189501440 03:53:46 INFO - PROCESS | 12963 | 03:53:48 INFO - PROCESS | 12963 | Cycle 1(1): loaded http://localhost:59446/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59446/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:53:49 INFO - PROCESS | 12963 | RSS: Main: 189304832 03:53:49 INFO - PROCESS | 12963 | 03:53:52 INFO - PROCESS | 12963 | Cycle 1(1): loaded http://localhost:59446/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59446/tests/kraken/driver.html?testName=imaging-darkroom) 03:53:52 INFO - PROCESS | 12963 | RSS: Main: 224305152 03:53:52 INFO - PROCESS | 12963 | 03:53:56 INFO - PROCESS | 12963 | Cycle 1(1): loaded http://localhost:59446/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59446/tests/kraken/driver.html?testName=imaging-desaturate) 03:53:56 INFO - PROCESS | 12963 | RSS: Main: 225046528 03:53:56 INFO - PROCESS | 12963 | 03:53:59 INFO - PROCESS | 12963 | Cycle 1(1): loaded http://localhost:59446/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59446/tests/kraken/driver.html?testName=json-parse-financial) 03:54:00 INFO - PROCESS | 12963 | RSS: Main: 223961088 03:54:00 INFO - PROCESS | 12963 | 03:54:01 INFO - PROCESS | 12963 | Cycle 1(1): loaded http://localhost:59446/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59446/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:54:02 INFO - PROCESS | 12963 | RSS: Main: 201322496 03:54:02 INFO - PROCESS | 12963 | 03:54:03 INFO - PROCESS | 12963 | Cycle 1(1): loaded http://localhost:59446/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59446/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:54:04 INFO - PROCESS | 12963 | RSS: Main: 203145216 03:54:04 INFO - PROCESS | 12963 | 03:54:06 INFO - PROCESS | 12963 | Cycle 1(1): loaded http://localhost:59446/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59446/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:54:07 INFO - PROCESS | 12963 | RSS: Main: 209817600 03:54:07 INFO - PROCESS | 12963 | 03:54:09 INFO - PROCESS | 12963 | Cycle 1(1): loaded http://localhost:59446/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:54:10 INFO - PROCESS | 12963 | RSS: Main: 217096192 03:54:10 INFO - PROCESS | 12963 | 03:54:12 INFO - PROCESS | 12963 | Cycle 1(1): loaded http://localhost:59446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:54:13 INFO - PROCESS | 12963 | RSS: Main: 218091520 03:54:13 INFO - PROCESS | 12963 | 03:54:15 INFO - PROCESS | 12963 | Cycle 1(1): loaded http://localhost:59446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59446/tests/kraken/driver.html?testName=ai-astar) 03:54:15 INFO - PROCESS | 12963 | RSS: Main: 259653632 03:54:15 INFO - PROCESS | 12963 | 03:54:15 INFO - PROCESS | 12963 | __start_tp_report 03:54:15 INFO - PROCESS | 12963 | _x_x_mozilla_page_load 03:54:15 INFO - PROCESS | 12963 | _x_x_mozilla_page_load_details 03:54:15 INFO - PROCESS | 12963 | |i|pagename|runs| 03:54:15 INFO - PROCESS | 12963 | |0;ai-astar;111;105;111;109;111;109;111;113;110;111 03:54:15 INFO - PROCESS | 12963 | |1;audio-beat-detection;156;121;124;167;122;123;133;150;163;124 03:54:15 INFO - PROCESS | 12963 | |2;audio-dft;162;163;163;162;162;162;161;162;162;162 03:54:15 INFO - PROCESS | 12963 | |3;audio-fft;74;74;75;127;74;76;75;75;100;75 03:54:15 INFO - PROCESS | 12963 | |4;audio-oscillator;84;84;114;86;84;84;112;84;84;119 03:54:15 INFO - PROCESS | 12963 | |5;imaging-gaussian-blur;117;116;117;117;117;116;116;116;116;117 03:54:15 INFO - PROCESS | 12963 | |6;imaging-darkroom;146;145;146;146;146;145;146;145;146;145 03:54:15 INFO - PROCESS | 12963 | |7;imaging-desaturate;95;95;95;94;95;95;95;95;95;94 03:54:15 INFO - PROCESS | 12963 | |8;json-parse-financial;50;49;48;51;52;52;53;51;50;51 03:54:15 INFO - PROCESS | 12963 | |9;json-stringify-tinderbox;61;61;60;60;60;60;60;60;61;60 03:54:15 INFO - PROCESS | 12963 | |10;stanford-crypto-aes;76;82;79;80;82;79;79;75;104;81 03:54:15 INFO - PROCESS | 12963 | |11;stanford-crypto-ccm;121;120;119;124;126;118;117;125;143;127 03:54:15 INFO - PROCESS | 12963 | |12;stanford-crypto-pbkdf2;157;155;155;155;156;159;155;158;157;153 03:54:15 INFO - PROCESS | 12963 | |13;stanford-crypto-sha256-iterative;66;62;64;64;63;62;65;63;62;65 03:54:15 INFO - PROCESS | 12963 | __end_tp_report 03:54:15 INFO - PROCESS | 12963 | __start_cc_report 03:54:15 INFO - PROCESS | 12963 | _x_x_mozilla_cycle_collect,1587 03:54:15 INFO - PROCESS | 12963 | __end_cc_report 03:54:15 INFO - PROCESS | 12963 | __startTimestamp1469012055392__endTimestamp 03:54:15 INFO - PROCESS | 12963 | 03:54:15 INFO - PROCESS | 12963 | ------- Summary: start ------- 03:54:15 INFO - PROCESS | 12963 | Number of tests: 14 03:54:15 INFO - PROCESS | 12963 | 03:54:15 INFO - PROCESS | 12963 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.13 (1.9%) stddev-sans-first:2.24 03:54:15 INFO - PROCESS | 12963 | Values: 111.0 105.0 111.0 109.0 111.0 109.0 111.0 113.0 110.0 111.0 03:54:15 INFO - PROCESS | 12963 | 03:54:15 INFO - PROCESS | 12963 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:141.50 stddev:18.62 (13.2%) stddev-sans-first:18.61 03:54:15 INFO - PROCESS | 12963 | Values: 156.0 121.0 124.0 167.0 122.0 123.0 133.0 150.0 163.0 124.0 03:54:15 INFO - PROCESS | 12963 | 03:54:15 INFO - PROCESS | 12963 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 03:54:15 INFO - PROCESS | 12963 | Values: 162.0 163.0 163.0 162.0 162.0 162.0 161.0 162.0 162.0 162.0 03:54:15 INFO - PROCESS | 12963 | 03:54:15 INFO - PROCESS | 12963 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.00 stddev:17.55 (23.4%) stddev-sans-first:18.34 03:54:15 INFO - PROCESS | 12963 | Values: 74.0 74.0 75.0 127.0 74.0 76.0 75.0 75.0 100.0 75.0 03:54:15 INFO - PROCESS | 12963 | 03:54:15 INFO - PROCESS | 12963 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:84.00 stddev:14.95 (17.8%) stddev-sans-first:15.45 03:54:15 INFO - PROCESS | 12963 | Values: 84.0 84.0 114.0 86.0 84.0 84.0 112.0 84.0 84.0 119.0 03:54:15 INFO - PROCESS | 12963 | 03:54:15 INFO - PROCESS | 12963 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 03:54:15 INFO - PROCESS | 12963 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 116.0 116.0 116.0 117.0 03:54:15 INFO - PROCESS | 12963 | 03:54:15 INFO - PROCESS | 12963 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:54:15 INFO - PROCESS | 12963 | Values: 146.0 145.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 03:54:15 INFO - PROCESS | 12963 | 03:54:15 INFO - PROCESS | 12963 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:54:15 INFO - PROCESS | 12963 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 03:54:15 INFO - PROCESS | 12963 | 03:54:15 INFO - PROCESS | 12963 | [#8] json-parse-financial Cycles:10 Average:50.70 Median:51.00 stddev:1.49 (2.9%) stddev-sans-first:1.56 03:54:15 INFO - PROCESS | 12963 | Values: 50.0 49.0 48.0 51.0 52.0 52.0 53.0 51.0 50.0 51.0 03:54:15 INFO - PROCESS | 12963 | 03:54:15 INFO - PROCESS | 12963 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 03:54:15 INFO - PROCESS | 12963 | Values: 61.0 61.0 60.0 60.0 60.0 60.0 60.0 60.0 61.0 60.0 03:54:15 INFO - PROCESS | 12963 | 03:54:15 INFO - PROCESS | 12963 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:79.50 stddev:8.17 (10.3%) stddev-sans-first:8.40 03:54:15 INFO - PROCESS | 12963 | Values: 76.0 82.0 79.0 80.0 82.0 79.0 79.0 75.0 104.0 81.0 03:54:15 INFO - PROCESS | 12963 | 03:54:15 INFO - PROCESS | 12963 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:124.50 stddev:7.53 (6.0%) stddev-sans-first:7.91 03:54:15 INFO - PROCESS | 12963 | Values: 121.0 120.0 119.0 124.0 126.0 118.0 117.0 125.0 143.0 127.0 03:54:15 INFO - PROCESS | 12963 | 03:54:15 INFO - PROCESS | 12963 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.00 Median:156.50 stddev:1.76 (1.1%) stddev-sans-first:1.83 03:54:15 INFO - PROCESS | 12963 | Values: 157.0 155.0 155.0 155.0 156.0 159.0 155.0 158.0 157.0 153.0 03:54:15 INFO - PROCESS | 12963 | 03:54:15 INFO - PROCESS | 12963 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.43 (2.2%) stddev-sans-first:1.22 03:54:15 INFO - PROCESS | 12963 | Values: 66.0 62.0 64.0 64.0 63.0 62.0 65.0 63.0 62.0 65.0 03:54:15 INFO - PROCESS | 12963 | -------- Summary: end -------- 03:54:15 INFO - PROCESS | 12963 | 03:54:16 INFO - TEST-INFO | 12963: exit 0 03:54:16 INFO - TEST-OK | kraken | took 59821ms 03:54:16 INFO - SUITE-END | took 1172s 03:54:16 INFO - Completed test suite (00:19:32) 03:54:16 INFO - javascript benchmark 03:54:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3313.353895990281, 3351.849166787493, 3351.8994430167095, 3370.140614143393, 3397.6772206640376, 5526.696031718259, 5622.859428514289, 5628.324601047875, 5653.095504719246, 5668.546516278693, 5596.328440587135, 5635.943640563593, 5649.209110724501, 5654.74553645086, 5655.066913959192, 5031.471695471978, 5041.8235361762345, 5081.59347252219, 5088.54203121719, 5112.36095488064, 5048.268001139832, 5058.392992840864, 5061.316722242505, 5090.0328937501945, 5144.614153938451, 5054.3176671149295, 5071.746412679369, 5122.692638441706, 5137.845864624067, 5154.922676159842, 5065.645404821664, 5085.466026067284, 5131.153359695646, 5135.12702840518, 5150.768215430315, 4908.803647854117, 4974.975125124387, 5013.222950442687, 5026.396832380101, 5067.847964561069, 5490.725463726798, 5536.612437129403, 5563.638363506359, 5567.192757050246, 5576.888462230732, 5819.476247137778, 6053.394660533955, 6056.06131049688, 6058.030715085565, 6058.1518587397795, 5951.791687290924, 5987.341392446828, 5989.3711160327975, 6067.453929146354, 6079.8036584575075, 5680.4319568042865, 5696.601237913306, 5698.601097923147, 5699.202111704365, 5711.600187986801, 6002.219711437572, 6041.879162416815, 6126.027940156527, 6195.473384762346, 6207.441330280206, 5880.176775251382, 5980.880382392328, 5981.611195272293, 5982.73077711504, 5985.760569577168, 6029.0, 6035.849103772353, 6059.030555111161, 6067.0, 6074.301455332605, 5839.591228614041, 5891.528677705774, 5943.227380440515, 5980.641161530322, 5992.790252341147, 6009.639421634716, 6033.245844269466, 6042.788502402394, 6065.120557519223, 6067.787627433018, 4631.073785242965, 4638.397008388888, 4641.094986477605, 4641.327007583882, 4664.370310008106, 4024.6176613221696, 4041.9595804041583, 4076.103257283393, 4138.482689663792, 4151.543330233671, 5583.860403489945, 5723.7996670116345, 5727.570432217517, 5737.569682273846, 5740.9953258180485, 5965.075413310944, 5971.79098731551, 5973.1936188614845, 5981.222441082718, 6010.759569617254, 5631.18347839561, 5648.124540696199, 5672.858178545569, 5674.687892165888, 5704.087346024616, 5151.22731590257, 5162.6386152968935, 5168.0, 5169.896602068013, 5185.766640501187, 6109.175261339662, 6201.069839524108, 6263.31103578606, 6263.592866463665, 6277.089821975879, 5975.581709280483, 6028.186194863637, 6041.124037014696, 6090.208272924491, 6104.114903338902, 6297.275813281348, 6320.873582528416, 6328.208973878265, 6335.873282534416, 6338.683065846597, 5776.971115144397, 5789.623674461147, 5958.791442299499, 5961.493273071837, 5962.19510366095, 5896.764129434775, 5991.850203744942, 5998.3401825798255, 6009.338972712911, 6037.0, 5760.135979603093, 5838.4453476919625, 5838.737256823369, 5840.269966254218, 5846.473817356458, 5677.630953987978, 5754.142972990539, 5816.069428891357, 5840.649561026352, 5882.058870580687, 5864.354920958776, 5875.059990401686, 5879.412058794257, 5884.529237660891, 5889.646621202742, 5953.077273022688, 5981.850453738517, 6002.399760024137, 6018.699065046818, 6021.307549631673, 5614.915776263278, 5670.121131224667, 5693.0, 5775.249217601685, 5870.589058765845], "value": 5543.205251254244, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.3616798110013, 634.6128861394551, 641.9582727122737, 654.8755736410079, 659.7031335898845, 36237.81881090594, 45682.314765278505, 47519.0, 47519.5248047519, 51102.23346649794, 48792.0, 49264.0, 49266.75366623171, 49347.75326123373, 49437.50562494374, 8468.576571171448, 9131.634734610607, 9270.072992700743, 9274.39716418434, 9281.721548353526, 8411.537365444898, 8486.915130848705, 8492.150784921489, 10810.72973175673, 11057.612983545578, 10672.733181670443, 10694.411807350592, 10712.678619641423, 10723.088537474325, 10724.571017159344, 11129.944350278238, 11184.496697648625, 11202.0, 11203.271787333797, 11204.21570490066, 8289.751307460785, 10598.417087060208, 10921.563137474492, 10935.28920620157, 11271.774564508745, 45913.31130033052, 46320.0, 46372.0, 46377.76811115957, 46396.7680161597, 3374.0, 3726.739128261023, 4040.3535434330365, 4371.803268852877, 4497.910041799146, 35146.0, 35324.11689707778, 35574.11064723377, 35835.462468063, 35963.82018089919, 4757.643176761757, 4825.083234185494, 4846.345743324641, 4854.441739200002, 4874.926876096862, 224559.0, 226720.0, 227221.0, 227762.0, 228811.99999999834, 38066.42900356497, 66385.33614663887, 66730.0, 66783.0, 66808.0, 38454.0, 40493.59506404957, 40717.0, 40724.59275407267, 40730.0, 15383.077015379113, 15407.460738874086, 15503.844961550465, 15520.922395388177, 15561.844381556266, 11813.763724725457, 13228.867711322957, 13559.864401356057, 13657.658558536115, 13675.0, 9053.818923621622, 9195.586198620944, 9206.861897071549, 9258.444493330422, 9285.117913798178, 3476.3221171871746, 3476.339495495898, 3510.14001569612, 3523.7624108691166, 3549.597908826051, 1094.262315411439, 1113.9777204455866, 1141.720278531765, 1164.2665120973732, 1190.2382475215868, 35484.46773298403, 35724.82137589347, 35775.28449430997, 35869.64130358715, 35987.64012359843, 1199.9760004799855, 1243.819646151303, 1284.3000564692265, 1285.8199852020725, 1346.8451128120196, 18494.81505184931, 18816.153273102744, 18921.905390473235, 18948.81051189498, 19102.426927192206, 566202.0, 568877.0, 571247.0, 571609.0, 574172.0, 64565.35434645593, 66305.00542491867, 66401.66799165973, 66402.0, 66410.66794665996, 1311.3902035553513, 1455.1196526101767, 1483.762597984339, 1493.835678075411, 1524.9542513724607, 34678.47982280318, 35571.28857422785, 35784.821075894455, 36215.81892090523, 36467.63532364643, 56082.0, 56634.43365566291, 56652.15021774759, 56655.71672141613, 56806.43193568011, 413351.0, 416702.0, 417456.0, 419325.0, 420414.0, 26850.462990740467, 27504.17487475299, 29804.0, 30359.848200758854, 31084.378312434077, 49254.0, 53225.46774532205, 54150.72924635509, 54303.18545221746, 55201.447985521234, 42535.78732106443, 43947.34078988882, 44430.3335449962, 45294.54705452903, 45899.541004589526, 43847.0, 44481.55518444774, 44989.550104498536, 45679.54320456886, 45982.54017459782, 44403.33394999142, 44899.551004489535, 44933.10133797371, 46018.539814602766, 46101.0, 39105.41341879931, 39122.0, 39728.0, 40385.798071009456, 40786.1842763149, 29138.417231655672, 29770.40459190761, 29785.10644680663, 29923.70076299296, 30183.69816301809], "value": 20378.573832317696, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.1653343712263, 412.9483814523185, 427.6066019262279, 431.85316992222636, 443.08060773894175, 18880.90559547202, 19991.800081999158, 20572.177112915484, 21141.471463213387, 21238.150473981063, 19694.606107877833, 19946.501337466572, 20380.388588342335, 20619.38141855743, 20630.38108856733, 5627.549796016309, 5853.0, 5879.559033072515, 5904.409559044083, 5917.674527900964, 4233.111046680186, 5842.44496772808, 5911.113333000041, 6134.723937422827, 6459.224893012845, 6400.03999400089, 6479.546431749779, 6508.967455162741, 6530.8040758777315, 6532.869342613169, 6216.440520353145, 6311.968440157792, 6353.904691429632, 6354.237491501003, 6361.8409539761415, 3908.9413658795143, 5477.287952566181, 5571.777128914839, 5786.421357864222, 5793.7392817323325, 23179.76820231793, 24212.0, 24580.385490362703, 24746.133885313928, 24788.752112478825, 2391.940201494959, 2431.6230984197477, 2450.2404254681105, 2751.4222013377216, 3122.125804774667, 9870.111689947938, 10376.844347334796, 10534.47327633623, 14576.489822856149, 15593.454229101926, 2024.9595008099902, 2066.4007437843006, 2102.8317734581196, 2103.116690989788, 2111.493241622015, 54072.18891716628, 80098.59950700267, 83039.5848020762, 83473.0, 84157.57921210416, 11407.429628518541, 11514.424278786195, 11725.648230553097, 11733.530658773725, 11757.412129393497, 16381.426650067191, 16487.0, 16501.83498165003, 16513.091779952218, 16546.58633534171, 8478.109798471196, 8562.11633440642, 8591.269742071869, 8595.355348348774, 8820.514871682119, 8255.0, 8325.708600198965, 8372.706955256659, 8409.663613455394, 8482.10937851529, 5026.868954485211, 5052.873678158076, 5053.67151135175, 5098.133317336062, 5121.411037730709, 1787.6335351252962, 2078.366098340021, 3200.919977000547, 3299.5710557627353, 3316.2372654289647, 947.3226642950324, 1054.3989925742408, 1077.4235783855756, 1091.8307662312354, 1128.4639796096953, 18248.45254642363, 19424.611507769765, 19639.803601964082, 19717.0, 20000.0, 992.3599278465349, 1032.2877214721818, 1069.2996087562658, 1079.978400431987, 1092.3282181458505, 10707.678769636923, 11113.777724445466, 11116.0, 11121.666350009513, 11200.103991680646, 374322.0, 375262.0, 376943.0, 496202.0, 497911.0, 97587.0, 104665.47667261615, 104756.47621761843, 104959.4752026235, 105245.0, 1064.0742553978089, 1068.5245065945735, 1115.6653004098737, 1127.6617014895498, 1133.6825688807148, 17723.645527089644, 17958.19188136563, 18029.0, 18097.728534071735, 18536.0, 31205.531917021715, 31965.360692785547, 35163.0, 36106.0, 40201.0, 55991.0, 61142.0, 61207.693961529905, 62787.0, 62999.37000629935, 8028.518288902685, 8314.62584183701, 8823.955880220814, 9219.815603688023, 9311.953440233026, 13490.123141995738, 14038.719225615634, 14173.645658858612, 14291.928540357232, 14316.57050288493, 12115.333656648616, 12278.386080695751, 12297.847876621734, 12334.50661973547, 12345.691357716129, 12327.93836030814, 12406.751864962469, 12449.439775209956, 12520.248785072925, 12921.741565168455, 12405.937970310091, 12595.24428534291, 12736.23582585048, 12880.742385152056, 12949.546765863526, 8275.54484503358, 8403.0, 8495.0, 8563.143685631387, 8586.65653373858, 10903.12774977984, 11890.405479725807, 11920.403979800802, 12203.511859525519, 12837.165584236995], "value": 9697.4056967653, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1090.1496832470675, 1091.9563217471302, 1327.8273824402827, 1390.7705228637276, 1813.2112531048995, 9083.818323633523, 9421.905780942197, 9423.293253006017, 9428.29287803415, 9767.36512126713, 9495.382800117988, 9674.08096230857, 9680.903190968089, 9695.806083878319, 9721.562529686164, 2071.2232912657755, 2299.8735069571167, 2344.9062037518565, 2409.915652952147, 2468.5926822074334, 2471.1598056660823, 2493.227099599121, 2502.1742824867843, 2503.0, 2506.273180777572, 2331.079223706635, 2347.6361164019604, 2354.8822558872075, 2355.2463211772238, 2356.446235134742, 2046.8362530997485, 2247.1460844878925, 2317.7102862142233, 2317.97682023181, 2332.0555175153922, 2245.303955773715, 2252.222983070838, 2253.5943530164564, 2278.0773786616446, 2409.9156529521383, 9669.129778319915, 9737.65918192867, 9744.610215591369, 9753.21974242059, 9761.853572196424, 5642.210090587321, 5843.474087332161, 5846.590738648296, 5851.297844258716, 5854.2096816930025, 3539.522164507784, 3580.4987301777774, 3673.94489082664, 3695.5380577427823, 3739.139997800494, 1222.2788554752738, 1236.6104677026708, 1265.2914367953974, 2249.403907964391, 2329.452578644017, 13535.120217185851, 13635.318234088256, 13636.181829090287, 13636.386362613706, 13642.113262637897, 4819.638527110411, 4887.266909963534, 4965.925511117336, 4967.925481117786, 4976.154053810788, 10724.73188170302, 10782.73043173927, 10790.67627971162, 10825.025747682746, 10832.837507437394, 5020.3724534433195, 5714.999875021937, 5755.165501002415, 5761.164631128547, 5762.250907382014, 5209.843704688866, 5366.731663416892, 5367.1680889462195, 5410.810621628224, 5418.566514678816, 4050.837966481308, 4074.7555146691293, 4093.2427500912427, 4149.875503734893, 4156.251874662529, 1138.1691365303375, 1183.911206659504, 1192.6720151958282, 1204.1691233049169, 1204.9457774400173, 942.9575669094908, 1083.6423980086552, 1085.484394912426, 1091.5033659684825, 1098.3464838421128, 6410.839729006812, 6456.54804163704, 6580.934190658032, 6614.338566143443, 6938.930610693828, 460.39228218751595, 461.1744976492109, 462.7246788161039, 465.1650287733526, 468.70471602890643, 4261.722988005769, 4303.354496825438, 4307.806148723253, 4346.239408103569, 4369.584889435499, 11714.121440891968, 11992.76014479723, 12072.094592905567, 12085.818712719316, 12088.395580220953, 11693.181477296508, 11893.762124757457, 11986.940065299617, 11992.160548761678, 12053.819192712117, 8933.15135062168, 8997.640094396282, 9024.232940200025, 9054.81890362189, 9077.137671921157, 6318.399752023551, 6532.542722009413, 6545.672716364258, 6616.139901812733, 6682.565633233824, 10584.100351470212, 10748.677539673823, 10817.783644326912, 10979.835302470628, 10987.285826421577, 11084.390358530036, 11329.150313726668, 11430.1998860079, 11513.481893314653, 11692.064634829363, 8349.081601024003, 8446.113158118309, 8561.01548321926, 8580.699675511576, 8825.955870220609, 9483.051694830461, 9507.572159252988, 9564.66523671668, 9587.472689002172, 9637.132658060807, 8455.957720211605, 8458.450200736932, 8567.828643427221, 8644.178803013703, 8648.783780405289, 8369.874451883348, 8401.495910245405, 8492.363072769444, 8535.95732021336, 8642.82714345697, 7575.621218938921, 7626.923730762844, 7654.387648988179, 7656.196099409482, 7683.154852966058, 5595.832125036255, 5744.655320680772, 5780.94219057804, 5835.591508594358, 5941.970290148522, 5155.304033955368, 5157.277981082727, 5245.082110630548, 5360.276362690986, 5402.378726446352], "value": 4883.838649065682, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.6754253629197, 363.8544582167133, 364.3769154745385, 366.2382244930545, 367.6158414456892, 5456.427075157111, 5467.879084787619, 5496.560275177986, 5514.58640601955, 5545.279113715216, 5373.731313434332, 5401.0, 5403.621746477748, 5451.863703407417, 5453.809116680917, 4377.890552736191, 4388.758618275993, 4407.162639098561, 4415.779211039435, 4451.132029254297, 4373.1909596724545, 4375.387445757597, 4384.539623339551, 4393.868183954486, 4426.402435671175, 4370.688793361995, 4374.60628543431, 4390.692651514395, 4390.714603550759, 4401.691881568291, 4032.677385809143, 4280.122574872144, 4317.287647538153, 4321.416608757809, 4398.626116780078, 3795.449659799341, 3805.1438426354125, 3812.066043819282, 3813.733038687293, 3828.712846536493, 5342.2253773202665, 5346.304980352529, 5348.91976620351, 5371.731413429313, 5381.219723140122, 4768.690035147704, 4941.579965702919, 4952.975235123838, 4965.652404331699, 4966.47851975541, 5724.570657200727, 5746.827595172152, 5756.942430575683, 5759.157069737686, 5794.595242974161, 4202.85290014848, 4204.26425375558, 4210.989362552996, 4219.092895027584, 4239.130978149503, 5652.699879027806, 5790.88418231633, 5832.358440571534, 5989.3711160327975, 6082.543809214327, 4210.221109094828, 4216.2199993001395, 4227.5203678712205, 4231.894202644959, 4252.213340532012, 4281.165172791276, 4283.807228674655, 4287.928017995501, 4290.742555446684, 4292.849750258726, 4683.250679891201, 4758.500357462486, 4829.492903245179, 4861.878453038632, 4890.486498917634, 5788.858122494704, 5805.983952808242, 5807.361190269067, 5811.82564523065, 5835.562332825055, 1448.4133925760084, 1476.9556913292618, 1482.22183353738, 1492.1942151238427, 1492.79847220626, 949.6866034208695, 953.6124938214881, 957.5786653872274, 961.869802981494, 966.9613215471443, 4822.9758851206225, 5010.298558201855, 5022.999999999927, 5036.949630503648, 5048.798048078036, 5210.869728256748, 5213.582913366921, 5220.660657057279, 5286.682799032071, 5288.36539615241, 4994.750262486861, 5021.614733001795, 5045.5459008689395, 5069.5944324454695, 5074.720890351066, 2790.400063986253, 2796.748292653671, 2905.8401787901867, 3156.9684303157132, 3164.9872040947134, 6156.846078847975, 6161.876762464725, 6220.782272620437, 6233.906491402633, 6234.376562343729, 5776.306843178845, 6029.216201893813, 6030.547708921848, 6035.215421995113, 6061.787837425757, 6211.409916057967, 6265.279492858289, 6277.748890044439, 6282.4974002079725, 6284.497240220771, 5987.700614969322, 5996.001999000499, 6003.249593800775, 6028.336882942785, 6044.365341639064, 5804.796832110856, 5836.307470833411, 5841.6856207353, 5929.205308602412, 5938.257717785277, 6199.380061993765, 6199.814005579839, 6205.627662340274, 6236.844078898064, 6255.028861290851, 4062.857799976987, 4282.164977829293, 4315.244832154423, 4318.503372112247, 4327.3725309830525, 5872.882542349214, 5895.616784908967, 5909.172715819703, 5915.7463395131645, 5936.347001829881, 5730.799422020209, 5761.798337058183, 5763.33721622002, 5769.8557536061935, 5788.131780232999, 5637.859053523531, 5750.942490575041, 5764.328344780134, 5774.364819869895, 5811.418858114154, 5659.773609055592, 5669.922714684197, 5681.431856814285, 5685.687287199244, 5691.8292451226525, 5589.748461319332, 5758.366579676149, 5764.682942438206, 5784.797532086357, 5823.650580965155, 5624.353199382123, 5670.489655930986, 5674.375818659862, 5674.77300907959, 5684.232628595252], "value": 4380.0771607766665, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.6675462664488, 735.8197241675789, 770.8458308338332, 782.7690831204798, 809.9514029158255, 14141.575752727409, 14549.636259093528, 14601.780973285397, 14646.853531464682, 14653.853461465382, 14186.503472378468, 14352.138871667707, 14382.856171438283, 14395.0, 14442.783358249635, 703.2264509040066, 855.5123579559654, 889.3107841422884, 889.9421537600068, 895.0467751844297, 887.2901678657081, 893.3433926064338, 893.4996402014892, 896.3725392225435, 898.27239935652, 743.5650144665377, 941.0401390581603, 941.5292353823088, 941.6657086734214, 942.4627962061628, 773.8607050730866, 776.510798197135, 883.1036497954581, 912.8402529557301, 913.8583519554479, 677.4106527321213, 678.0338018323918, 678.1286047429079, 678.2132726037822, 681.7852376501386, 13854.16874987494, 13907.721845563032, 13965.79051314231, 13981.231032293219, 13999.090059146123, 14606.634834129232, 14898.255087245703, 14923.850761492355, 15029.473968411054, 15037.849621503754, 12222.449989750483, 12958.676033099153, 13375.26436046017, 13635.181889086687, 13847.307634618228, 4739.099571081483, 4784.736839473828, 4796.064767370364, 4887.193613053842, 4961.677490963076, 83356.58321708413, 85760.57119714424, 86020.0, 86677.0, 88150.0, 11791.469383877575, 11976.461059252355, 12088.0, 12110.273383597012, 12126.211796233216, 22402.327930162122, 22405.21581744664, 22416.103355865907, 22426.21508247236, 22438.887805561193, 8362.45644033136, 8554.78613034679, 8756.343274254456, 8831.3376496763, 9049.321300902458, 4681.438227412664, 4724.267738500538, 4768.237082066922, 4814.518548145227, 4872.074305881871, 3625.818709064589, 3756.2487502499607, 3793.260314238697, 3846.8653597124526, 3910.7458015228917, 683.3132701634925, 693.6219760230687, 699.4404476418845, 701.6281370873445, 702.118840854724, 687.9724811007503, 709.7125664106045, 754.3060384446322, 820.1101804542019, 825.7481468152151, 10067.0, 10700.78598428027, 10705.090067344207, 10769.353838769699, 10780.946095269474, 680.8638272345551, 688.5868478912713, 731.8353370491703, 739.1241378965942, 832.3590835056972, 4811.518848115161, 4865.172920603506, 4875.780589873393, 4947.901041979212, 4963.354763880672, 72295.0, 80028.59985700034, 98279.50860245652, 112708.18229544163, 119570.40214799045, 100288.0, 101362.0, 102609.48695256625, 102937.48531257296, 104068.0, 87557.56221218852, 87816.12183878079, 90460.0, 90602.54698726464, 91105.54447227855, 8797.252233560219, 8916.777080573038, 8940.73177804667, 8996.50519221449, 9047.547622618711, 53088.73455632852, 53603.73198133984, 54219.7010930625, 54524.45475545194, 56138.15792763193, 74403.62798185974, 75571.0, 76790.23209768055, 77271.61364193143, 78762.6061869687, 12875.613731588068, 12959.352032398154, 13211.405486752927, 13346.0, 13609.727805444034, 13584.184948903097, 13612.591622251348, 13835.930820345833, 14328.570142895729, 14641.414343426144, 9733.805323893625, 13881.192066181762, 14940.626484337978, 14990.475333363716, 15262.08427494354, 13097.670515004644, 13336.86663133395, 13694.963155354682, 13844.169349839041, 14196.503122390666, 14293.64265893361, 14302.070365426214, 14317.785233221302, 14359.210243436293, 14506.782398264246, 11285.943570282096, 11302.547898083985, 11335.206535542433, 11337.149713771336, 11570.132240082195, 11190.608328708457, 11237.213395062594, 11318.773624527628, 11319.434028298387, 11387.886121138683], "value": 7799.375878423022, "unit": "score"}], "name": "dromaeo_css", "value": 7533.369242329324, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 111.0, 109.0, 111.0, 109.0, 111.0, 113.0, 110.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 121.0, 124.0, 167.0, 122.0, 123.0, 133.0, 150.0, 163.0, 124.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 162.0, 162.0, 162.0, 161.0, 162.0, 162.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 127.0, 74.0, 76.0, 75.0, 75.0, 100.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 114.0, 86.0, 84.0, 84.0, 112.0, 84.0, 84.0, 119.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 48.0, 51.0, 52.0, 52.0, 53.0, 51.0, 50.0, 51.0], "value": 50.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 79.0, 80.0, 82.0, 79.0, 79.0, 75.0, 104.0, 81.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 120.0, 119.0, 124.0, 126.0, 118.0, 117.0, 125.0, 143.0, 127.0], "value": 124.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 155.0, 155.0, 155.0, 156.0, 159.0, 155.0, 158.0, 157.0, 153.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 64.0, 64.0, 63.0, 62.0, 65.0, 63.0, 62.0, 65.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1479.7, "alertThreshold": 2.0}]} 03:54:16 INFO - Return code: 0 03:54:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:54:16 ERROR - # TBPL SUCCESS # 03:54:16 INFO - Running post-action listener: _resource_record_post_action 03:54:16 INFO - ##### 03:54:16 INFO - ##### Finished run-tests step (success) 03:54:16 INFO - ##### 03:54:16 INFO - Running post-run listener: _resource_record_post_run 03:54:16 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 290816; Write bytes: 337211392; Read time: 56; Write time: 199572 03:54:16 INFO - TinderboxPrint: CPU usage
13.1% 03:54:16 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 56 03:54:16 INFO - TinderboxPrint: I/O write bytes / time
337,211,392 / 199,572 03:54:16 INFO - TinderboxPrint: CPU idle
8,249.3 (86.9%) 03:54:16 INFO - TinderboxPrint: CPU user
1,197.9 (12.6%) 03:54:16 INFO - TinderboxPrint: Swap in / out
0 / 0 03:54:16 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 82939904; Read time: 0; Write time: 51700 03:54:16 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 254271488; Read time: 40; Write time: 147872 03:54:17 INFO - Running post-run listener: _upload_blobber_files 03:54:17 INFO - Blob upload gear active. 03:54:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:54:17 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 03:54:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:54:17 INFO - (blobuploader) - INFO - Open directory for files ... 03:54:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:54:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:54:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:18 INFO - (blobuploader) - INFO - Done attempting. 03:54:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:54:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:54:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:33 INFO - (blobuploader) - INFO - Done attempting. 03:54:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:54:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:54:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:34 INFO - (blobuploader) - INFO - Done attempting. 03:54:34 INFO - (blobuploader) - INFO - Iteration through files over. 03:54:34 INFO - Return code: 0 03:54:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:54:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:54:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19d13eeea1b65421704c72c4c3ed94e87b17a1815bec9d689f7bf69365dc27452bdaa609fd4e0227634aa10b5444987adf3fe66cea4aa1f732dbe37067fa04ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03b5641b287a9425b478a3bb0f276b42ee634423631bb51d6dd2ac6e8437b2cf0c5a29f588ca0db2e61709223b4f714edec78764090e0fd4d9c3eafec9dd280b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d0f75720ad87058b003c256f1def1b76a965338c476204d8829c0fe19b716d8237f1b15b7a77b6cae20eb41003f06b9906df57abb5e3f2e099245884fe80720"} 03:54:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:54:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:54:34 INFO - Contents: 03:54:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19d13eeea1b65421704c72c4c3ed94e87b17a1815bec9d689f7bf69365dc27452bdaa609fd4e0227634aa10b5444987adf3fe66cea4aa1f732dbe37067fa04ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03b5641b287a9425b478a3bb0f276b42ee634423631bb51d6dd2ac6e8437b2cf0c5a29f588ca0db2e61709223b4f714edec78764090e0fd4d9c3eafec9dd280b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d0f75720ad87058b003c256f1def1b76a965338c476204d8829c0fe19b716d8237f1b15b7a77b6cae20eb41003f06b9906df57abb5e3f2e099245884fe80720"} 03:54:34 INFO - Running post-run listener: copy_logs_to_upload_dir 03:54:34 INFO - Copying logs to upload dir... 03:54:34 INFO - mkdir: /builds/slave/test/build/upload/logs 03:54:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.755541 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-20 03:54:33.881066) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 03:54:33.884328) ========= 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=6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918 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-Aurora/sha512/19d13eeea1b65421704c72c4c3ed94e87b17a1815bec9d689f7bf69365dc27452bdaa609fd4e0227634aa10b5444987adf3fe66cea4aa1f732dbe37067fa04ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03b5641b287a9425b478a3bb0f276b42ee634423631bb51d6dd2ac6e8437b2cf0c5a29f588ca0db2e61709223b4f714edec78764090e0fd4d9c3eafec9dd280b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d0f75720ad87058b003c256f1def1b76a965338c476204d8829c0fe19b716d8237f1b15b7a77b6cae20eb41003f06b9906df57abb5e3f2e099245884fe80720"} build_url:https://queue.taskcluster.net/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/W0WyOWj-QPWsFB3Xr6KYXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19d13eeea1b65421704c72c4c3ed94e87b17a1815bec9d689f7bf69365dc27452bdaa609fd4e0227634aa10b5444987adf3fe66cea4aa1f732dbe37067fa04ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03b5641b287a9425b478a3bb0f276b42ee634423631bb51d6dd2ac6e8437b2cf0c5a29f588ca0db2e61709223b4f714edec78764090e0fd4d9c3eafec9dd280b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d0f75720ad87058b003c256f1def1b76a965338c476204d8829c0fe19b716d8237f1b15b7a77b6cae20eb41003f06b9906df57abb5e3f2e099245884fe80720"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 03:54:33.913986) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 03:54:33.914673) ========= 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=6dbc10da6d83fee962c624be000001a8-1469010825.746002-1563362918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 03:54:33.998093) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 03:54:33.998408) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 03:54:33.998707) ========= ========= Total master_lag: 0.17 =========