builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1467887160.28 results: success (0) buildid: 20160707004018 builduid: ba396057444d454dadbbab59d512f12c revision: a9e572ac1d5e4df9aebf5c9860bb415b8dc0a60d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 03:26:00.281559) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 03:26:00.282080) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 03:26:00.282430) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 03:26:00.320741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 03:26:00.321068) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 03:26:00-- 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% 42.9M=0s 2016-07-07 03:26:00 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122504 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 03:26:00.458261) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 03:26:00.458637) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019193 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 03:26:00.511460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-07 03:26:00.511824) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a9e572ac1d5e4df9aebf5c9860bb415b8dc0a60d --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 a9e572ac1d5e4df9aebf5c9860bb415b8dc0a60d --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=7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 03:26:00,985 truncating revision to first 12 chars 2016-07-07 03:26:00,985 Setting DEBUG logging. 2016-07-07 03:26:00,985 attempt 1/10 2016-07-07 03:26:00,985 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a9e572ac1d5e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 03:26:03,068 unpacking tar archive at: mozilla-aurora-a9e572ac1d5e/testing/mozharness/ program finished with exit code 0 elapsedTime=2.447683 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-07 03:26:02.974225) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 03:26:02.974600) ========= script_repo_revision: a9e572ac1d5e4df9aebf5c9860bb415b8dc0a60d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 03:26:02.975302) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 03:26:02.975709) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 03:26:02.987462) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-07 03:26:02.988031) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:26:03 INFO - MultiFileLogger online at 20160707 03:26:03 in /builds/slave/test 03:26:03 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:26:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:26:03 INFO - {'append_to_log': False, 03:26:03 INFO - 'base_work_dir': '/builds/slave/test', 03:26:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:26:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:26:03 INFO - 'branch': 'Mozilla-Aurora', 03:26:03 INFO - 'buildbot_json_path': 'buildprops.json', 03:26:03 INFO - 'config_files': ('talos/linux_config.py',), 03:26:03 INFO - 'default_actions': ('clobber', 03:26:03 INFO - 'read-buildbot-config', 03:26:03 INFO - 'download-and-extract', 03:26:03 INFO - 'populate-webroot', 03:26:03 INFO - 'create-virtualenv', 03:26:03 INFO - 'install', 03:26:03 INFO - 'run-tests'), 03:26:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:26:03 INFO - 'download_minidump_stackwalk': True, 03:26:03 INFO - 'download_symbols': 'ondemand', 03:26:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:26:03 INFO - 'tooltool.py': '/tools/tooltool.py', 03:26:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:26:03 INFO - '/tools/misc-python/virtualenv.py')}, 03:26:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:26:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:26:03 INFO - 'installer_path': 'installer.exe', 03:26:03 INFO - 'log_level': 'info', 03:26:03 INFO - 'log_name': 'talos', 03:26:03 INFO - 'log_to_console': True, 03:26:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:26:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:26:03 INFO - 'opt_config_files': (), 03:26:03 INFO - 'pip_index': False, 03:26:03 INFO - 'sps_profile': False, 03:26:03 INFO - 'sps_profile_interval': 0, 03:26:03 INFO - 'suite': 'dromaeojs', 03:26:03 INFO - 'system_bits': '32', 03:26:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:26:03 INFO - 'title': 'talos-linux64-ix-005', 03:26:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:26:03 INFO - 'use_talos_json': True, 03:26:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:26:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:26:03 INFO - 'work_dir': 'build'} 03:26:03 INFO - ##### 03:26:03 INFO - ##### Running clobber step. 03:26:03 INFO - ##### 03:26:03 INFO - Running pre-action listener: _resource_record_pre_action 03:26:03 INFO - Running main action method: clobber 03:26:03 INFO - rmtree: /builds/slave/test/build 03:26:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:26:04 INFO - Running post-action listener: _resource_record_post_action 03:26:04 INFO - ##### 03:26:04 INFO - ##### Finished clobber step (success) 03:26:04 INFO - ##### 03:26:04 INFO - ##### 03:26:04 INFO - ##### Running read-buildbot-config step. 03:26:04 INFO - ##### 03:26:04 INFO - Running pre-action listener: _resource_record_pre_action 03:26:04 INFO - Running main action method: read_buildbot_config 03:26:04 INFO - Using buildbot properties: 03:26:04 INFO - { 03:26:04 INFO - "project": "", 03:26:04 INFO - "product": "firefox", 03:26:04 INFO - "script_repo_revision": "production", 03:26:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:26:04 INFO - "repository": "", 03:26:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:26:04 INFO - "buildid": "20160707004018", 03:26:04 INFO - "stage_platform": "linux64-pgo", 03:26:04 INFO - "basedir": "/builds/slave/test", 03:26:04 INFO - "nightly_build": "True", 03:26:04 INFO - "buildnumber": 405, 03:26:04 INFO - "slavename": "talos-linux64-ix-005", 03:26:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:26:04 INFO - "platform": "ubuntu64_hw", 03:26:04 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:26:04 INFO - "branch": "mozilla-aurora", 03:26:04 INFO - "repo_path": "releases/mozilla-aurora", 03:26:04 INFO - "revision": "a9e572ac1d5e4df9aebf5c9860bb415b8dc0a60d", 03:26:04 INFO - "pgo_build": "True", 03:26:04 INFO - "builduid": "ba396057444d454dadbbab59d512f12c", 03:26:04 INFO - "slavebuilddir": "test" 03:26:04 INFO - } 03:26:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:26:04 INFO - Running post-action listener: _resource_record_post_action 03:26:04 INFO - ##### 03:26:04 INFO - ##### Finished read-buildbot-config step (success) 03:26:04 INFO - ##### 03:26:04 INFO - ##### 03:26:04 INFO - ##### Running download-and-extract step. 03:26:04 INFO - ##### 03:26:04 INFO - Running pre-action listener: _resource_record_pre_action 03:26:04 INFO - Running main action method: download_and_extract 03:26:04 INFO - mkdir: /builds/slave/test/build/tests 03:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:04 INFO - https://queue.taskcluster.net/v1/task/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:26:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:26:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:26:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/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:26:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/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:26:12 INFO - Downloaded 1361 bytes. 03:26:12 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:26:12 INFO - Using the following test package requirements: 03:26:12 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:26:12 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:26:12 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:26:12 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:12 INFO - u'jsshell-linux-x86_64.zip'], 03:26:12 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:26:12 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:26:12 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:26:12 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:26:12 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:26:12 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:26:12 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:12 INFO - https://queue.taskcluster.net/v1/task/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:26:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:26:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:26:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/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:26:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/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:26:16 INFO - Downloaded 24526348 bytes. 03:26:16 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:26:16 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:26:17 INFO - Return code: 0 03:26:17 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:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:17 INFO - https://queue.taskcluster.net/v1/task/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:26:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:26:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:26:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/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:26:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/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:26:22 INFO - Downloaded 24526348 bytes. 03:26:22 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:26:22 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:26:23 INFO - Return code: 0 03:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:23 INFO - https://queue.taskcluster.net/v1/task/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:26:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/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:26:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/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:26:24 INFO - Downloaded 10833369 bytes. 03:26:24 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:26:24 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:26:24 INFO - Return code: 0 03:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:24 INFO - https://queue.taskcluster.net/v1/task/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:26:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:26:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:26:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/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:26:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWcnfttYSVOFDEbJzXpbYg/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:26:26 INFO - Downloaded 63604898 bytes. 03:26:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:26:26 INFO - mkdir: /builds/slave/test/properties 03:26:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:26:26 INFO - Writing to file /builds/slave/test/properties/build_url 03:26:26 INFO - Contents: 03:26:26 INFO - build_url:https://queue.taskcluster.net/v1/task/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:26:26 INFO - Running post-action listener: _resource_record_post_action 03:26:26 INFO - Running post-action listener: set_extra_try_arguments 03:26:26 INFO - ##### 03:26:26 INFO - ##### Finished download-and-extract step (success) 03:26:26 INFO - ##### 03:26:26 INFO - ##### 03:26:26 INFO - ##### Running populate-webroot step. 03:26:26 INFO - ##### 03:26:26 INFO - Running pre-action listener: _resource_record_pre_action 03:26:26 INFO - Running main action method: populate_webroot 03:26:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:26:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:26:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:26:26 INFO - '--tppagecycles', 03:26:26 INFO - '7'], 03:26:26 INFO - 'tests': ['tsvgm']}}, 03:26:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:26:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:26:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:26:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:26:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:26:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:26:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:26 INFO - 'talos_options': ['--disable-e10s'], 03:26:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:26 INFO - 'talos_options': ['--disable-e10s'], 03:26:26 INFO - 'tests': ['damp', 'tps']}, 03:26:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:26 INFO - 'tests': ['damp', 'tps']}, 03:26:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:26:26 INFO - 'tests': ['dromaeo_dom']}, 03:26:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:26:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:26:26 INFO - 'tests': ['a11yr', 03:26:26 INFO - 'ts_paint', 03:26:26 INFO - 'tpaint', 03:26:26 INFO - 'sessionrestore', 03:26:26 INFO - 'sessionrestore_no_auto_restore', 03:26:26 INFO - 'tabpaint']}, 03:26:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:26:26 INFO - 'ts_paint', 03:26:26 INFO - 'tpaint', 03:26:26 INFO - 'sessionrestore', 03:26:26 INFO - 'sessionrestore_no_auto_restore', 03:26:26 INFO - 'tabpaint']}, 03:26:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:26:26 INFO - 'ts_paint', 03:26:26 INFO - 'tpaint', 03:26:26 INFO - 'sessionrestore', 03:26:26 INFO - 'sessionrestore_no_auto_restore', 03:26:26 INFO - 'tabpaint']}, 03:26:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:26:26 INFO - 'ts_paint', 03:26:26 INFO - 'tpaint', 03:26:26 INFO - 'sessionrestore', 03:26:26 INFO - 'sessionrestore_no_auto_restore', 03:26:26 INFO - 'tabpaint']}, 03:26:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:26:26 INFO - 'tests': ['a11yr', 03:26:26 INFO - 'ts_paint', 03:26:26 INFO - 'tpaint', 03:26:26 INFO - 'sessionrestore', 03:26:26 INFO - 'sessionrestore_no_auto_restore', 03:26:26 INFO - 'tabpaint']}, 03:26:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:26:26 INFO - 'tests': ['a11yr', 03:26:26 INFO - 'ts_paint', 03:26:26 INFO - 'tpaint', 03:26:26 INFO - 'sessionrestore', 03:26:26 INFO - 'sessionrestore_no_auto_restore', 03:26:26 INFO - 'tabpaint']}, 03:26:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:26:26 INFO - 'tests': ['tsvgx', 03:26:26 INFO - 'tsvgr_opacity', 03:26:26 INFO - 'tart', 03:26:26 INFO - 'tscrollx', 03:26:26 INFO - 'cart']}, 03:26:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:26:26 INFO - 'tsvgr_opacity', 03:26:26 INFO - 'tart', 03:26:26 INFO - 'tscrollx', 03:26:26 INFO - 'cart']}, 03:26:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:26 INFO - 'talos_options': ['--disable-e10s'], 03:26:26 INFO - 'tests': ['tp5o']}, 03:26:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:26 INFO - 'tests': ['tp5o']}, 03:26:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:26 INFO - 'talos_options': ['--disable-e10s', 03:26:26 INFO - '--xperf_path', 03:26:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:26 INFO - 'tests': ['tp5n']}, 03:26:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:26 INFO - 'talos_options': ['--xperf_path', 03:26:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:26 INFO - 'tests': ['tp5n']}}, 03:26:26 INFO - 'talos.zip': {'path': '', 03:26:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:26:26 INFO - Running post-action listener: _resource_record_post_action 03:26:26 INFO - ##### 03:26:26 INFO - ##### Finished populate-webroot step (success) 03:26:26 INFO - ##### 03:26:26 INFO - ##### 03:26:26 INFO - ##### Running create-virtualenv step. 03:26:26 INFO - ##### 03:26:26 INFO - Running pre-action listener: _resource_record_pre_action 03:26:26 INFO - Running main action method: create_virtualenv 03:26:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:26:26 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:26:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:26:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:26:27 INFO - Using real prefix '/usr' 03:26:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:26:27 INFO - Installing distribute.............................................................................................................................................................................................done. 03:26:29 INFO - Installing pip.................done. 03:26:29 INFO - Return code: 0 03:26:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:29 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 0x7fdca50eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eee1c0>, '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 0x1eef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eef550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', '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:26:29 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:26:29 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:26:29 INFO - Using env: {'DISPLAY': ':0', 03:26:29 INFO - 'HOME': '/home/cltbld', 03:26:29 INFO - 'LANG': 'en_US.UTF-8', 03:26:29 INFO - 'LANGUAGE': 'en_US:en', 03:26:29 INFO - 'LOGNAME': 'cltbld', 03:26:29 INFO - 'MAIL': '/var/mail/cltbld', 03:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:29 INFO - 'MOZ_NO_REMOTE': '1', 03:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:29 INFO - 'NO_EM_RESTART': '1', 03:26:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:29 INFO - 'PWD': '/builds/slave/test', 03:26:29 INFO - 'SHELL': '/bin/bash', 03:26:29 INFO - 'SHLVL': '1', 03:26:29 INFO - 'TERM': 'linux', 03:26:29 INFO - 'TMOUT': '86400', 03:26:29 INFO - 'USER': 'cltbld', 03:26:29 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', 03:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:29 INFO - '_': '/tools/buildbot/bin/python'} 03:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:29 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:26:29 INFO - Cleaning up... 03:26:29 INFO - Return code: 0 03:26:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:29 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 0x7fdca50eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eee1c0>, '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 0x1eef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eef550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', '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:26:29 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:26:29 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:26:29 INFO - Using env: {'DISPLAY': ':0', 03:26:29 INFO - 'HOME': '/home/cltbld', 03:26:29 INFO - 'LANG': 'en_US.UTF-8', 03:26:29 INFO - 'LANGUAGE': 'en_US:en', 03:26:29 INFO - 'LOGNAME': 'cltbld', 03:26:29 INFO - 'MAIL': '/var/mail/cltbld', 03:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:29 INFO - 'MOZ_NO_REMOTE': '1', 03:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:29 INFO - 'NO_EM_RESTART': '1', 03:26:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:29 INFO - 'PWD': '/builds/slave/test', 03:26:29 INFO - 'SHELL': '/bin/bash', 03:26:29 INFO - 'SHLVL': '1', 03:26:29 INFO - 'TERM': 'linux', 03:26:29 INFO - 'TMOUT': '86400', 03:26:29 INFO - 'USER': 'cltbld', 03:26:29 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', 03:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:29 INFO - '_': '/tools/buildbot/bin/python'} 03:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:29 INFO - Downloading/unpacking psutil>=3.1.1 03:26:29 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:26:29 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:26:29 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:26:29 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:26:29 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:26:29 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:26:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:26:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:32 INFO - Installing collected packages: psutil 03:26:32 INFO - Running setup.py install for psutil 03:26:32 INFO - building 'psutil._psutil_linux' extension 03:26:32 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:26:32 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:26:32 INFO - building 'psutil._psutil_posix' extension 03:26:32 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:26:32 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:26:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:32 INFO - Successfully installed psutil 03:26:32 INFO - Cleaning up... 03:26:32 INFO - Return code: 0 03:26:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:32 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 0x7fdca50eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eee1c0>, '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 0x1eef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eef550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', '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:26:32 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:26:32 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:26:32 INFO - Using env: {'DISPLAY': ':0', 03:26:32 INFO - 'HOME': '/home/cltbld', 03:26:32 INFO - 'LANG': 'en_US.UTF-8', 03:26:32 INFO - 'LANGUAGE': 'en_US:en', 03:26:32 INFO - 'LOGNAME': 'cltbld', 03:26:32 INFO - 'MAIL': '/var/mail/cltbld', 03:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:32 INFO - 'MOZ_NO_REMOTE': '1', 03:26:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:32 INFO - 'NO_EM_RESTART': '1', 03:26:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:32 INFO - 'PWD': '/builds/slave/test', 03:26:32 INFO - 'SHELL': '/bin/bash', 03:26:32 INFO - 'SHLVL': '1', 03:26:32 INFO - 'TERM': 'linux', 03:26:32 INFO - 'TMOUT': '86400', 03:26:32 INFO - 'USER': 'cltbld', 03:26:32 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', 03:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:32 INFO - '_': '/tools/buildbot/bin/python'} 03:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:26:32 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:26:32 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:26:32 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:26:32 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:26:32 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:26:32 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:26:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:26:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:26:34 INFO - Installing collected packages: mozsystemmonitor 03:26:34 INFO - Running setup.py install for mozsystemmonitor 03:26:34 INFO - Successfully installed mozsystemmonitor 03:26:34 INFO - Cleaning up... 03:26:34 INFO - Return code: 0 03:26:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdca50eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eee1c0>, '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 0x1eef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eef550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', '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:26:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:26:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:26:34 INFO - Using env: {'DISPLAY': ':0', 03:26:34 INFO - 'HOME': '/home/cltbld', 03:26:34 INFO - 'LANG': 'en_US.UTF-8', 03:26:34 INFO - 'LANGUAGE': 'en_US:en', 03:26:34 INFO - 'LOGNAME': 'cltbld', 03:26:34 INFO - 'MAIL': '/var/mail/cltbld', 03:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:34 INFO - 'MOZ_NO_REMOTE': '1', 03:26:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:34 INFO - 'NO_EM_RESTART': '1', 03:26:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:34 INFO - 'PWD': '/builds/slave/test', 03:26:34 INFO - 'SHELL': '/bin/bash', 03:26:34 INFO - 'SHLVL': '1', 03:26:34 INFO - 'TERM': 'linux', 03:26:34 INFO - 'TMOUT': '86400', 03:26:34 INFO - 'USER': 'cltbld', 03:26:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', 03:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:34 INFO - '_': '/tools/buildbot/bin/python'} 03:26:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:35 INFO - Downloading/unpacking jsonschema==2.5.1 03:26:35 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:26:35 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:26:35 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:26:35 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:26:35 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:26:35 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:26:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:26:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:26:36 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:26:36 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:26:36 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:26:36 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:26:36 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:26:36 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:26:37 INFO - Downloading functools32-3.2.3-2.tar.gz 03:26:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:26:37 INFO - warning: no files found matching '*.txt' 03:26:37 INFO - no previously-included directories found matching 'build' 03:26:37 INFO - no previously-included directories found matching 'dist' 03:26:37 INFO - no previously-included directories found matching '.git*' 03:26:37 INFO - Installing collected packages: jsonschema, functools32 03:26:37 INFO - Running setup.py install for functools32 03:26:37 INFO - warning: no files found matching '*.txt' 03:26:37 INFO - no previously-included directories found matching 'build' 03:26:37 INFO - no previously-included directories found matching 'dist' 03:26:37 INFO - no previously-included directories found matching '.git*' 03:26:37 INFO - Successfully installed jsonschema functools32 03:26:37 INFO - Cleaning up... 03:26:37 INFO - Return code: 0 03:26:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdca50eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eee1c0>, '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 0x1eef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eef550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', '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:26:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:26:37 INFO - Using env: {'DISPLAY': ':0', 03:26:37 INFO - 'HOME': '/home/cltbld', 03:26:37 INFO - 'LANG': 'en_US.UTF-8', 03:26:37 INFO - 'LANGUAGE': 'en_US:en', 03:26:37 INFO - 'LOGNAME': 'cltbld', 03:26:37 INFO - 'MAIL': '/var/mail/cltbld', 03:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:37 INFO - 'MOZ_NO_REMOTE': '1', 03:26:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:37 INFO - 'NO_EM_RESTART': '1', 03:26:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:37 INFO - 'PWD': '/builds/slave/test', 03:26:37 INFO - 'SHELL': '/bin/bash', 03:26:37 INFO - 'SHLVL': '1', 03:26:37 INFO - 'TERM': 'linux', 03:26:37 INFO - 'TMOUT': '86400', 03:26:37 INFO - 'USER': 'cltbld', 03:26:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', 03:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:37 INFO - '_': '/tools/buildbot/bin/python'} 03:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:37 INFO - Downloading/unpacking blobuploader==1.2.4 03:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:39 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:40 INFO - Downloading docopt-0.6.1.tar.gz 03:26:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:40 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:40 INFO - Running setup.py install for blobuploader 03:26:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:40 INFO - Running setup.py install for requests 03:26:40 INFO - Running setup.py install for docopt 03:26:40 INFO - Successfully installed blobuploader requests docopt 03:26:40 INFO - Cleaning up... 03:26:40 INFO - Return code: 0 03:26:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:40 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 0x7fdca50eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eee1c0>, '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 0x1eef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eef550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', '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:26:40 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:26:40 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:26:40 INFO - Using env: {'DISPLAY': ':0', 03:26:40 INFO - 'HOME': '/home/cltbld', 03:26:40 INFO - 'LANG': 'en_US.UTF-8', 03:26:40 INFO - 'LANGUAGE': 'en_US:en', 03:26:40 INFO - 'LOGNAME': 'cltbld', 03:26:40 INFO - 'MAIL': '/var/mail/cltbld', 03:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:40 INFO - 'MOZ_NO_REMOTE': '1', 03:26:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:40 INFO - 'NO_EM_RESTART': '1', 03:26:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:40 INFO - 'PWD': '/builds/slave/test', 03:26:40 INFO - 'SHELL': '/bin/bash', 03:26:40 INFO - 'SHLVL': '1', 03:26:40 INFO - 'TERM': 'linux', 03:26:40 INFO - 'TMOUT': '86400', 03:26:40 INFO - 'USER': 'cltbld', 03:26:40 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', 03:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:40 INFO - '_': '/tools/buildbot/bin/python'} 03:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:41 INFO - Running setup.py (path:/tmp/pip-YGEydE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:41 INFO - Running setup.py (path:/tmp/pip-NK_yrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:41 INFO - Running setup.py (path:/tmp/pip-5xc9_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:41 INFO - Running setup.py (path:/tmp/pip-rpIUNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:41 INFO - Running setup.py (path:/tmp/pip-ANDDE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:41 INFO - Running setup.py (path:/tmp/pip-qnaeaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:41 INFO - Running setup.py (path:/tmp/pip-1B4SXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:41 INFO - Running setup.py (path:/tmp/pip-XHUBg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:41 INFO - Running setup.py (path:/tmp/pip-gve5Kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:41 INFO - Running setup.py (path:/tmp/pip-dejbOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:41 INFO - Running setup.py (path:/tmp/pip-znxmmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:41 INFO - Running setup.py (path:/tmp/pip-dh_nx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:42 INFO - Running setup.py (path:/tmp/pip-54w17u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:42 INFO - Running setup.py (path:/tmp/pip-yamZz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:42 INFO - Running setup.py (path:/tmp/pip-ewHBq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:42 INFO - Running setup.py (path:/tmp/pip-KVOaDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:42 INFO - Running setup.py (path:/tmp/pip-yeddRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:42 INFO - Running setup.py install for manifestparser 03:26:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:42 INFO - Running setup.py install for mozcrash 03:26:42 INFO - Running setup.py install for mozdebug 03:26:42 INFO - Running setup.py install for mozdevice 03:26:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:26:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:42 INFO - Running setup.py install for mozfile 03:26:42 INFO - Running setup.py install for mozhttpd 03:26:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:42 INFO - Running setup.py install for mozinfo 03:26:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Running setup.py install for mozInstall 03:26:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Running setup.py install for mozleak 03:26:43 INFO - Running setup.py install for mozlog 03:26:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Running setup.py install for moznetwork 03:26:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Running setup.py install for mozprocess 03:26:43 INFO - Running setup.py install for mozprofile 03:26:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Running setup.py install for mozrunner 03:26:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Running setup.py install for mozscreenshot 03:26:43 INFO - Running setup.py install for moztest 03:26:44 INFO - Running setup.py install for mozversion 03:26:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:44 INFO - Cleaning up... 03:26:44 INFO - Return code: 0 03:26:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:44 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 0x7fdca50eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eee1c0>, '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 0x1eef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eef550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', '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:26:44 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:26:44 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:26:44 INFO - Using env: {'DISPLAY': ':0', 03:26:44 INFO - 'HOME': '/home/cltbld', 03:26:44 INFO - 'LANG': 'en_US.UTF-8', 03:26:44 INFO - 'LANGUAGE': 'en_US:en', 03:26:44 INFO - 'LOGNAME': 'cltbld', 03:26:44 INFO - 'MAIL': '/var/mail/cltbld', 03:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:44 INFO - 'MOZ_NO_REMOTE': '1', 03:26:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:44 INFO - 'NO_EM_RESTART': '1', 03:26:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:44 INFO - 'PWD': '/builds/slave/test', 03:26:44 INFO - 'SHELL': '/bin/bash', 03:26:44 INFO - 'SHLVL': '1', 03:26:44 INFO - 'TERM': 'linux', 03:26:44 INFO - 'TMOUT': '86400', 03:26:44 INFO - 'USER': 'cltbld', 03:26:44 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', 03:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:44 INFO - '_': '/tools/buildbot/bin/python'} 03:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:44 INFO - Running setup.py (path:/tmp/pip-YMfigJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:44 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:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:44 INFO - Running setup.py (path:/tmp/pip-bK74TE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:44 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:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:44 INFO - Running setup.py (path:/tmp/pip-BNBIu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:44 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:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:44 INFO - Running setup.py (path:/tmp/pip-t3TVYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:44 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:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:44 INFO - Running setup.py (path:/tmp/pip-0XJqZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:44 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:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:44 INFO - Running setup.py (path:/tmp/pip-FmrT7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:44 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:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:44 INFO - Running setup.py (path:/tmp/pip-6TGRno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:44 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:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:44 INFO - Running setup.py (path:/tmp/pip-oRZ4Rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:44 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:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:44 INFO - Running setup.py (path:/tmp/pip-nAudep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:45 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:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:45 INFO - Running setup.py (path:/tmp/pip-j2k1vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:45 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:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:45 INFO - Running setup.py (path:/tmp/pip-5jzNLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:45 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:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:45 INFO - Running setup.py (path:/tmp/pip-8ip3Jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:45 INFO - Running setup.py (path:/tmp/pip-Jh0FRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:45 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:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:45 INFO - Running setup.py (path:/tmp/pip-jg8xyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:45 INFO - Running setup.py (path:/tmp/pip-YYfCN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:45 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:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:45 INFO - Running setup.py (path:/tmp/pip-JwTEj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:45 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:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:45 INFO - Running setup.py (path:/tmp/pip-ZN3H3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:45 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:26:45 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:26:45 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:26:45 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:26:45 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:26:45 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:26:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:45 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:26:45 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:26:45 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:26:45 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:26:45 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:26:45 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:26:47 INFO - Downloading blessings-1.6.tar.gz 03:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:47 INFO - Installing collected packages: blessings 03:26:47 INFO - Running setup.py install for blessings 03:26:47 INFO - Successfully installed blessings 03:26:47 INFO - Cleaning up... 03:26:47 INFO - Return code: 0 03:26:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:47 INFO - Reading from file tmpfile_stdout 03:26:47 INFO - Current package versions: 03:26:47 INFO - argparse == 1.2.1 03:26:47 INFO - blessings == 1.6 03:26:47 INFO - blobuploader == 1.2.4 03:26:47 INFO - docopt == 0.6.1 03:26:47 INFO - functools32 == 3.2.3-2 03:26:47 INFO - jsonschema == 2.5.1 03:26:47 INFO - manifestparser == 1.1 03:26:47 INFO - mozInstall == 1.12 03:26:47 INFO - mozcrash == 0.17 03:26:47 INFO - mozdebug == 0.1 03:26:47 INFO - mozdevice == 0.48 03:26:47 INFO - mozfile == 1.2 03:26:47 INFO - mozhttpd == 0.7 03:26:47 INFO - mozinfo == 0.9 03:26:47 INFO - mozleak == 0.1 03:26:47 INFO - mozlog == 3.2 03:26:47 INFO - moznetwork == 0.27 03:26:47 INFO - mozprocess == 0.22 03:26:47 INFO - mozprofile == 0.28 03:26:47 INFO - mozrunner == 6.11 03:26:47 INFO - mozscreenshot == 0.1 03:26:47 INFO - mozsystemmonitor == 0.3 03:26:47 INFO - moztest == 0.7 03:26:47 INFO - mozversion == 1.4 03:26:47 INFO - psutil == 3.1.1 03:26:47 INFO - requests == 1.2.3 03:26:47 INFO - wsgiref == 0.1.2 03:26:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:47 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 0x7fdca50eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eee1c0>, '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 0x1eef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eef550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', '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:26:47 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:26:47 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:26:47 INFO - Using env: {'DISPLAY': ':0', 03:26:47 INFO - 'HOME': '/home/cltbld', 03:26:47 INFO - 'LANG': 'en_US.UTF-8', 03:26:47 INFO - 'LANGUAGE': 'en_US:en', 03:26:47 INFO - 'LOGNAME': 'cltbld', 03:26:47 INFO - 'MAIL': '/var/mail/cltbld', 03:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:47 INFO - 'MOZ_NO_REMOTE': '1', 03:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:47 INFO - 'NO_EM_RESTART': '1', 03:26:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:47 INFO - 'PWD': '/builds/slave/test', 03:26:47 INFO - 'SHELL': '/bin/bash', 03:26:47 INFO - 'SHLVL': '1', 03:26:47 INFO - 'TERM': 'linux', 03:26:47 INFO - 'TMOUT': '86400', 03:26:47 INFO - 'USER': 'cltbld', 03:26:47 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', 03:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:47 INFO - '_': '/tools/buildbot/bin/python'} 03:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 INFO - Cleaning up... 03:26:48 INFO - Return code: 0 03:26:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:26: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:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:48 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 0x7fdca50eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eee1c0>, '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 0x1eef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eef550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', '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:26:48 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:26:48 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:26:48 INFO - Using env: {'DISPLAY': ':0', 03:26:48 INFO - 'HOME': '/home/cltbld', 03:26:48 INFO - 'LANG': 'en_US.UTF-8', 03:26:48 INFO - 'LANGUAGE': 'en_US:en', 03:26:48 INFO - 'LOGNAME': 'cltbld', 03:26:48 INFO - 'MAIL': '/var/mail/cltbld', 03:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:48 INFO - 'MOZ_NO_REMOTE': '1', 03:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:48 INFO - 'NO_EM_RESTART': '1', 03:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:48 INFO - 'PWD': '/builds/slave/test', 03:26:48 INFO - 'SHELL': '/bin/bash', 03:26:48 INFO - 'SHLVL': '1', 03:26:48 INFO - 'TERM': 'linux', 03:26:48 INFO - 'TMOUT': '86400', 03:26:48 INFO - 'USER': 'cltbld', 03:26:48 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', 03:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:48 INFO - '_': '/tools/buildbot/bin/python'} 03:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:26:48 INFO - Cleaning up... 03:26:48 INFO - Return code: 0 03:26:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:26: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:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:48 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 0x7fdca50eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eee1c0>, '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 0x1eef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eef550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', '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:26:48 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:26:48 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:26:48 INFO - Using env: {'DISPLAY': ':0', 03:26:48 INFO - 'HOME': '/home/cltbld', 03:26:48 INFO - 'LANG': 'en_US.UTF-8', 03:26:48 INFO - 'LANGUAGE': 'en_US:en', 03:26:48 INFO - 'LOGNAME': 'cltbld', 03:26:48 INFO - 'MAIL': '/var/mail/cltbld', 03:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:48 INFO - 'MOZ_NO_REMOTE': '1', 03:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:48 INFO - 'NO_EM_RESTART': '1', 03:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:48 INFO - 'PWD': '/builds/slave/test', 03:26:48 INFO - 'SHELL': '/bin/bash', 03:26:48 INFO - 'SHLVL': '1', 03:26:48 INFO - 'TERM': 'linux', 03:26:48 INFO - 'TMOUT': '86400', 03:26:48 INFO - 'USER': 'cltbld', 03:26:48 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', 03:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:48 INFO - '_': '/tools/buildbot/bin/python'} 03:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:48 INFO - Downloading/unpacking flake8 03:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:26:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:26:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:26:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:51 INFO - no previously-included directories found matching 'docs/_build' 03:26:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:26:51 INFO - Running setup.py install for pep8 03:26:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:51 INFO - no previously-included directories found matching 'docs/_build' 03:26:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:26:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:26:51 INFO - Cleaning up... 03:26:51 INFO - Return code: 0 03:26:51 INFO - Running post-action listener: _resource_record_post_action 03:26:51 INFO - Running post-action listener: _start_resource_monitoring 03:26:51 INFO - Starting resource monitoring. 03:26:51 INFO - ##### 03:26:51 INFO - ##### Finished create-virtualenv step (success) 03:26:51 INFO - ##### 03:26:51 INFO - ##### 03:26:51 INFO - ##### Running install step. 03:26:51 INFO - ##### 03:26:51 INFO - Running pre-action listener: _resource_record_pre_action 03:26:51 INFO - Running main action method: install 03:26:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:51 INFO - Reading from file tmpfile_stdout 03:26:51 INFO - Detecting whether we're running mozinstall >=1.0... 03:26:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:26:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:26:51 INFO - Reading from file tmpfile_stdout 03:26:51 INFO - Output received: 03:26:51 INFO - Usage: mozinstall [options] installer 03:26:51 INFO - Options: 03:26:51 INFO - -h, --help show this help message and exit 03:26:51 INFO - -d DEST, --destination=DEST 03:26:51 INFO - Directory to install application into. [default: 03:26:51 INFO - "/builds/slave/test"] 03:26:51 INFO - --app=APP Application being installed. [default: firefox] 03:26:51 INFO - mkdir: /builds/slave/test/build/application 03:26:51 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:26:51 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:27:07 INFO - Reading from file tmpfile_stdout 03:27:07 INFO - Output received: 03:27:07 INFO - /builds/slave/test/build/application/firefox/firefox 03:27:07 INFO - Running post-action listener: _resource_record_post_action 03:27:07 INFO - ##### 03:27:07 INFO - ##### Finished install step (success) 03:27:07 INFO - ##### 03:27:07 INFO - ##### 03:27:07 INFO - ##### Running run-tests step. 03:27:07 INFO - ##### 03:27:07 INFO - Running pre-action listener: _resource_record_pre_action 03:27:07 INFO - Running main action method: run_tests 03:27:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:27:07 INFO - Python 2.7.3 03:27:07 INFO - Return code: 0 03:27:07 INFO - grabbing minidump binary from tooltool 03:27: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:27:07 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 0x1eee1c0>, '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 0x1eef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eef550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:27:07 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:27:07 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:27:07 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:27:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:27:07 INFO - Return code: 0 03:27:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:27:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:27:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:27:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:27:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:27:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:27:08 INFO - Return code: 0 03:27:08 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/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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:27:08 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/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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:27:08 INFO - Using env: {'DISPLAY': ':0', 03:27:08 INFO - 'HOME': '/home/cltbld', 03:27:08 INFO - 'LANG': 'en_US.UTF-8', 03:27:08 INFO - 'LANGUAGE': 'en_US:en', 03:27:08 INFO - 'LOGNAME': 'cltbld', 03:27:08 INFO - 'MAIL': '/var/mail/cltbld', 03:27:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:27:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:08 INFO - 'MOZ_NO_REMOTE': '1', 03:27:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:08 INFO - 'NO_EM_RESTART': '1', 03:27:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:08 INFO - 'PWD': '/builds/slave/test', 03:27:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:27:08 INFO - 'SHELL': '/bin/bash', 03:27:08 INFO - 'SHLVL': '1', 03:27:08 INFO - 'TERM': 'linux', 03:27:08 INFO - 'TMOUT': '86400', 03:27:08 INFO - 'USER': 'cltbld', 03:27:08 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544', 03:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:08 INFO - '_': '/tools/buildbot/bin/python'} 03:27:08 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/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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:27:08 INFO - mozversion application_buildid: 20160707004018 03:27:08 INFO - mozversion application_changeset: a9e572ac1d5e4df9aebf5c9860bb415b8dc0a60d 03:27:08 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:27:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:27:08 INFO - mozversion application_name: Firefox 03:27:08 INFO - mozversion application_remotingname: firefox-dev 03:27:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:27:08 INFO - mozversion application_vendor: Mozilla 03:27:08 INFO - mozversion application_version: 49.0a2 03:27:08 INFO - mozversion platform_buildid: 20160707004018 03:27:08 INFO - mozversion platform_changeset: a9e572ac1d5e4df9aebf5c9860bb415b8dc0a60d 03:27:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:27:08 INFO - mozversion platform_version: 49.0a2 03:27:08 INFO - using testdate: 1467887228 03:27:08 INFO - actual date: 1467887228 03:27:08 INFO - starting webserver on 'localhost:37995' 03:27:08 INFO - SUITE-START | Running 2 tests 03:27:08 INFO - TEST-START | dromaeo_css 03:27:08 INFO - operating with platform_type : linux_ 03:27:08 INFO - Initialising browser for dromaeo_css test... 03:27:08 INFO - TEST-INFO | started process 28585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqbB3XD/profile http://localhost:37995/getInfo.html) 03:27:12 INFO - PROCESS | 28585 | __metrics Screen width/height:1600/1200 03:27:12 INFO - PROCESS | 28585 | colorDepth:24 03:27:12 INFO - PROCESS | 28585 | Browser inner width/height: 1024/697 03:27:12 INFO - PROCESS | 28585 | __metrics 03:27:13 ERROR - PROCESS | 28585 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:27:14 INFO - TEST-INFO | 28585: exit 0 03:27:14 INFO - Browser initialized. 03:27:14 INFO - Running cycle 1/1 for dromaeo_css test... 03:27:14 INFO - TEST-INFO | started process 28675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqbB3XD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:26 INFO - PROCESS | 28675 | RSS: Main: 145592320 03:27:26 INFO - PROCESS | 28675 | 03:28:17 INFO - PROCESS | 28675 | 1467887297338 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:30:25 INFO - PROCESS | 28675 | Cycle 1(1): loaded http://localhost:37995/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37995/tests/dromaeo/cssquery-ext.html) 03:30:26 INFO - PROCESS | 28675 | RSS: Main: 252772352 03:30:26 INFO - PROCESS | 28675 | 03:33:28 INFO - PROCESS | 28675 | Cycle 1(1): loaded http://localhost:37995/tests/dromaeo/cssquery-ext.html (next: http://localhost:37995/tests/dromaeo/cssquery-jquery.html) 03:33:29 INFO - PROCESS | 28675 | RSS: Main: 234725376 03:33:29 INFO - PROCESS | 28675 | 03:36:31 INFO - PROCESS | 28675 | Cycle 1(1): loaded http://localhost:37995/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37995/tests/dromaeo/cssquery-mootools.html) 03:36:31 INFO - PROCESS | 28675 | RSS: Main: 234700800 03:36:31 INFO - PROCESS | 28675 | 03:39:33 INFO - PROCESS | 28675 | Cycle 1(1): loaded http://localhost:37995/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37995/tests/dromaeo/cssquery-prototype.html) 03:39:34 INFO - PROCESS | 28675 | RSS: Main: 226770944 03:39:34 INFO - PROCESS | 28675 | 03:42:36 INFO - PROCESS | 28675 | Cycle 1(1): loaded http://localhost:37995/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37995/tests/dromaeo/cssquery-yui.html) 03:42:37 INFO - PROCESS | 28675 | RSS: Main: 217583616 03:42:37 INFO - PROCESS | 28675 | 03:45:39 INFO - PROCESS | 28675 | Cycle 1(1): loaded http://localhost:37995/tests/dromaeo/cssquery-yui.html (next: http://localhost:37995/tests/dromaeo/cssquery-dojo.html) 03:45:40 INFO - PROCESS | 28675 | RSS: Main: 264458240 03:45:40 INFO - PROCESS | 28675 | 03:45:40 INFO - PROCESS | 28675 | __start_tp_report 03:45:40 INFO - PROCESS | 28675 | _x_x_mozilla_page_load 03:45:40 INFO - PROCESS | 28675 | _x_x_mozilla_page_load_details 03:45:40 INFO - PROCESS | 28675 | |i|pagename|runs| 03:45:40 INFO - PROCESS | 28675 | |0;dojo.html;3279.3277378137486;3293.8965446575403;3303.3888730584845;3311.619163796161;3351.547541081955;5303.310569625948;5395.379531353896;5404.162354834997;5404.243405923174;5414.214938833867;5368.32895888014;5392.460753924615;5399.325084364455;5405.864853378667;5406.513413792758;4811.7594120294025;4835.782389792459;4860.854174374756;4925.802967881281;4935.975320123394;4781.521847815208;4920.507949205069;4947.579455746266;4951.529604687549;4952.950470495285;4871.7076975381415;4908.7300198489065;4925.655204135712;4926.433460152075;4957.677750946195;5000.199968005102;5001.99960007998;5018.146915024455;5019.171836646949;5059.342285502879;4734;4799.1601469743;4849.878753031167;4912.066707325596;4947.90104197914;5194.35070616173;5214.765335559909;5221.947780522184;5256.737163141827;5268.4994925482015;5690.800821971253;5711.485966263056;5713.857153571194;5717.456841600041;5754.223179870705;5716.685582292972;5763.221965034751;5770.336411312669;5796.420357964212;5841.094630332263;5416.83749487516;5468.26178465906;5468.507834294893;5472.2338872557875;5481.561475081984;5750.6262092963825;5973.342932277446;5979.5515336349945;5980.910286345708;5985.431384018511;5632.436756324335;5639.154126880919;5683.062294721325;5735.627184233012;5763.6541807491685;5796.304443466811;5796.913046304308;5797.739101740432;5825.970870145707;5827.213326200908;5539.556835453154;5680.5455563554815;5777.075667893117;5787.392323806024;5794.971025144931;5711.314642242957;5791.797287094932;5791.942080579224;5795.88408231833;5829;4488.259437192826;4491.46102467706;4501.707389019703;4503.279475284005;4515.751633660115;3959.6436320731273;3961.088949541622;3992.1017771001293;4051.8987025324013;4093.038136038029;5528.391876893538;5546.667199968015;5550.972245138829;5558.277423934863;5576;5779.971100144557;5791.0734282514595;5794.594378393472;5795.739191736382;5826.475617194473;5329.040772660958;5523;5529.364123125812;5565.41563135873;5574.860628484239;4965.553100220997;5002.024605201951;5002.974985125124;5003.624728145403;5032.245163225472;6083;6139.416755408319;6153;6156.938430615726;6161.537884658668;5619.80330688424;5739.942600574108;5773.220615216892;5785.016547187072;5850.23946886902;6135.969320153371;6143.139960405636;6147.477464415396;6148.077788331786;6150.04674275488;5579.637323573955;5727.971360143172;5729.140628905698;5729.398413166724;5731.226284451713;5670.659760414388;5700.828975130753;5734.885302294014;5782.190493331022;5784.739686714024;5621.100623900156;5625.128105143709;5627.493525582717;5634.408387119457;5636.1827535008015;5455.890882182413;5484.862878428071;5579.721013949205;5633.380328163817;5635.351934527582;5591.888162236651;5639.407862174413;5641;5642.887142257214;5681.375048744552;5689.573282003949;5703.543716502752;5708.686022268815;5711.171880077282;5748.856278593069;5362.785488580569;5475.452454754652;5527.060399731975;5589.077802162597;5613.382527921844 03:45:40 INFO - PROCESS | 28675 | |1;ext.html;591.9378465261148;640.7693230437043;648.5233353485188;651.3649192037764;672.9158855143107;33804.66195338046;37157;37175.44236836446;46096.07807843841;47907.281390779164;49450.75274623622;50059.24911126336;50132.74933625336;50148.49851501493;50174.24738628914;8097;9036.412633178856;9178.265738740918;9181.632734690638;9182.127697868726;10722.731931701692;11016.724581885437;11024.283421577611;11361.602343917964;11368.31790092593;11106.278091924;11196.776064478705;11222.494987725571;11228.719282017933;11233.943830280878;8413.200745929127;10868.402237876993;11084.667459976174;11112.388818614972;11165.497552610152;10637.255392122555;11078.279911805706;11100.222984391095;11107.83338249927;11115;46897.76551117223;47473.762631186626;47571;47576;47603.285950710764;4016.518017837849;4099.1801639672185;4111.650509706678;4124.670026397881;4439.978804874897;35768.28463430743;36075.81962090199;36412;36490.63509364899;36734;4830.5652491275605;4848.393950756155;4864.148773964577;4911.852644420673;4929.014197160546;386969;388070;389209;389577.99999999715;390627;39359.40960885589;40649.79675101665;40708;42196.36705449421;70885.29114708788;41879.37180942288;42058.78970605128;42087.579124208365;42223.57776422258;42224.366634500504;16510.66978660444;16637.83362166387;16641.50075497737;16652.916735416246;16658.16709164537;12486.50053997848;12796.744065118646;13197.142185757895;13563.321833908265;13851.445942162201;9336.299777516713;9338.393004454689;9372.109649583279;9388.155066043952;9407.576659050359;3462.9480557791653;3539.752217344813;3562.412201986695;3567.2555501183365;3667.8176484991386;1121.6466812953893;1138.5559631743627;1138.815631742978;1155.6706338693432;1164.1618035014776;35052.474212886824;35362.469562956576;35646;35704;35731.642683572834;1212.7210741529498;1248.450681700049;1255.7990721484518;1263.311495235099;1364.7202323523654;15825;18388.448346549623;18425.631487370447;18685.81314186868;18938.81061189398;614858;617627;619409;619856;631164;66417;66927;66988.6650566744;67020;67072.66463667748;1353.8307711536058;1427.293489722594;1440.5246268731084;1457.5554455891056;1482.7256957462903;34978;35869.282614347045;35877;35910.461343079354;36095;54637;54858.72570637121;54880.451195487534;55191.448085518634;55233.72383138059;412357;412855;414448;415016;415247;27435.725642744117;30323.787048517814;31198.532022020143;31213.531797023516;32633;52596;53604.195937061755;53973.73013134909;54252.186217205985;54253.45746542642;43575.47485837981;43658.69277087521;44016.11967760691;44582.3312650304;45065.77467112643;43709.34435983526;44044.11911761811;44430.77784611056;45401;45522;44434.555654443044;45135.32297015482;45566.77216613896;45837.31244031276;45870.31194532151;39012.2197556053;39272;39512.802435987636;40631.1873762529;40676.3898541528;29333.70666293395;30011;30484.847575761978;30574.235644109074;30768.38463230678 03:45:40 INFO - PROCESS | 28675 | |2;jquery.html;402.3481959226053;410.1796407185629;427.8930267433142;427.97432154070776;433.2980571474212;19155.712664310027;19794.30719924803;20209.292674756387;20492.795072049255;20866.791332086676;19924.800751992476;19994.400167994947;20358;20874.791252087474;20973.47566310843;5696.25948626679;5925.170476133345;5965.015772397549;5976.4919981801595;5981.342052374235;4304.267900822499;4417.337399390085;5773.913391299134;5893.322267939199;6684.866302673943;6655.334466553354;6707.698153583076;6714.832129196785;6727.125473688438;6733.932660673379;6505.869882602321;6562.146920900276;6679.532432729711;6679.866402671943;6700.195976482829;3903.5706072332023;5573.944260557383;5893.939090963625;5904.498117660004;5921.970390148064;24282.87858560696;24533.63199552008;24667.38331541708;24874.87562562194;24911.252662420156;2282.3267136194863;2285.2344464604375;2369.5260947810507;2518.143831097436;3180.904572862818;9960.352577082467;10363.06732394088;10421.895781042169;10930.180236482296;14508.056976296613;1931.3916116423281;2021.9393418197478;2035.0740413112146;2046.0894901768718;2053.6098141353245;69420.65289673519;86944.56527717321;87655.56172219162;89639.55180224123;90761;10951.726206844733;11400.258983166068;11797.29216247028;11827.17209795306;12038.4582693779;17062.658746825244;17102.315907363565;17213.483595492155;17223.31106755716;17228.569285767706;8112.391570632226;8458.40791144614;8507.914920850711;8628.568571571397;8662.78343041429;8119.4722343047515;8142.918570814334;8155.429119961545;8206.958965205136;8237.46456480327;5027.698338099725;5096.923546146811;5142.382914050263;5154.974225128851;5249.370075590878;1828.0392020574193;1954.951126221856;1955.765308163001;1989.19437627761;2034.532057626754;1009.3439264478149;1052.7578656908954;1135.840982262484;1170.0931777872217;1176.2295696318924;19993.200271989248;20187.596248074955;20289.18843246283;20464.38606841797;20597.382078537667;1040.1730624153815;1065.0255016659669;1125.150511363915;1126.3298337489182;1142.149098921309;11095.722606934729;11396.316221026766;11513.675927268472;11521.251118677259;11548.307101573933;528784;540190;541238;547454;548348;69693;96134.51932740292;97357.51321243348;98045.50977245068;98274;1070.1652710885521;1096.1504833753904;1104.5140138339104;1108.828131639581;1116.1573012375604;18009;18277.817221827612;18323.35868244605;18369.265229390676;18401.447956561326;41007.58992410038;42719.14561708811;43977.12045759131;44089.11821763611;45722;60124.69937650284;61848.38151618606;62037;62853.05720414289;62954.68522657357;8258.132896045829;8543.743687689379;8555.57222138903;8567.186117318844;8756;11784.76430471403;13325.733485330045;13352.265625390308;13415.530456433979;13539.458421663023;11729.530818767154;11992.820107698566;12009.399530023638;12071.758564828478;12538.122331437076;10849.403282819521;11168.959714936287;11511.36687482163;11523.308601483937;11586.362750048827;11058.889411105785;11973.580924667594;12083.879161208275;12170.087243456599;12408.62774116778;8490.06609272967;8591.484510929115;8611.354148439017;8642.308615310634;8959.10408959125;8775;12284.631461056182;12334.383280836102;12462;12577.685557861127 03:45:40 INFO - PROCESS | 28675 | |3;mootools.html;1451;1588.737858253388;1622.8620567251783;1831.8992455414948;1935.748352714147;9206.401583897043;9545.522723863814;9576.664816731416;9879.3578417403;9892;9628.422294662325;9847;9857.556409961551;9890.307678462492;9896;2170.8806015669134;2465.950680986379;2516.345750104972;2544.3130354804193;2546.172493939468;2546.2106746908426;2556.2203527923975;2560.4879024195143;2563.333533281351;2563.9487210255784;2503.1864643990775;2557.9872100639473;2560.911612564662;2562.1160699558623;2563.218218443374;2127.106615221603;2403.42317843718;2478.293686299396;2482.8262021658493;2483.6647052648023;2492.8255022148455;2500.5124000819847;2519.0805356045094;2521.13021007752;2539.8222124451295;9448.149666530046;9453.43279403238;9477.47873866937;9546.809063818755;9573.712788616353;5787.450192231773;5917.289925208959;5942.316633587149;5942.346341902387;5948.613340132878;3611.295797319524;3673.779573225588;3743;3760.511133552648;3767.6797472214894;1231.119749379198;1291.238169480002;1302.5115581656878;2336.1589827662197;2401.2916189723896;13310.86689133106;13428.798568021488;13436.596902092855;13447.394867230998;13505.594832155051;4968.8757781055765;5025.3718285214345;5113.488651134857;5116.437191908887;5156.535911767959;10439.739006524898;10542.367457952547;10565.471726413649;10571.524281407355;10581.682549523526;5802.303723553201;5811;5818.883622327529;5822;5836.970815145897;4731.52684731531;5172.120739474299;5257.5005374489365;5269.78920843162;5344.625876188629;4077.715519611313;4112.259793237186;4198.349255865346;4217.91564168721;4222.451081359465;1221.151299846598;1224.1675660550911;1228.6129869091208;1230.3540641163281;1241.4661695471034;947.393668052447;965.5172413793103;1100.3562915694408;1101.2016288190998;1108.3682301088302;6598.3401659833635;6599.373059559334;6627.834304142339;6722.596644201363;6806.8638627228165;1057.8575138850024;1091.1598069486452;1099.0822663076422;1107.3909349857547;1124.8818874018275;4328.458942632171;4407.096545208225;4425.181341451842;4441.400410944546;4508.48152462471;12267.38663066843;12543.996480281738;12554.937225313815;12692.42884070219;12737;12438.937805310916;12528.123031387897;12546.81179782304;12547.24716517012;12591.433385497674;8317.168283171635;8629.525376104375;8637.0499245083;8860.246879015227;8884.333674974403;6624.304448032887;6717;6784.3554862289975;6814;6823.488238382042;11134.888651113386;11428.714282143013;11487.655370338904;11625.534978600761;11668.766624667629;11410.543578256777;11704.122190835551;11707.473163707484;11808;11823.408829558659;7862.72480463181;8335.416520843482;8513.06356300794;8671.4363566368;8805.823883522422;9455.858162127712;9475.52622368865;9521.476318802532;9551.952240238754;9565.04349565038;8398.41211115216;8575.399722019649;8581.828363432822;8673.696420625249;8687.86968195465;8125.959370203112;8212.46618969765;8421;8442.577871106543;8564.05795362522;7121.181064177686;7199.640017998974;7199.640017999184;7201.783946481614;7215;5311.994891545059;5346.385165705994;5347.1979203119845;5476.507114359727;5543.52880005204;5458.399576046552;5616.69108199053;5668.3198016236665;5682.829515114553;5782.566307527037 03:45:40 INFO - PROCESS | 28675 | |4;prototype.html;316.91443310306215;329.4070672788979;330.786642615513;337.7821305258109;338.723939988909;5381.165919282507;5420.376656684482;5435.510804027636;5444.727763611819;5491.588130890179;5074.416442109158;5193.324867767185;5229.267902493654;5245.239440281157;5384.488473595012;4019.31671615826;4078.0620457294913;4124.855630052949;4159.376093585956;4190.2248084104385;4118.135191609751;4140.213359461693;4157.815022718526;4167.708260421772;4169.207850508409;4074.9388759168637;4077.7757223352705;4128.896777580554;4159.896002599944;4165.729227600212;4124.484439445069;4128.979355103235;4137.6482998944975;4153.79539933419;4158.438610787535;3668.5414323209598;3675.9081022974638;3687.6865466435383;3701.9259614807825;3702.87039953603;5032.899342013139;5065.088284108859;5099.643024988252;5102.770375333119;5131.461196574343;4723.527647235283;4734.124187025412;4742.719465744264;4751.596114330286;4793.3768610080815;5496.697681627509;5545.417731138253;5553.444655534455;5561.443855614406;5608.803691870765;3768.9623103768886;4040.454538637305;4044.624827558644;4046.291898917707;4047.7368971017086;5785.421457854223;5818.389069147721;5836.649801011953;5845.795397161079;5855.297364316267;4035.9192816143513;4057.5739547347102;4057.69567282455;4061.7766022868436;4061.9593804061583;4121.814518346681;4128.752274863517;4131.462909821704;4139.985703502661;4141.171765646883;4520.751358675305;4699.882502937386;4718.433787945469;4718.764061796896;4734.881627959328;5645.943540564624;5652.547796176296;5655.236543066716;5667.263255776805;5672.319321681424;1339.5666636698834;1385.9605296027978;1402.5441731437325;1405.5150972914328;1408.6900881805987;876.8071024374627;907.5961197267285;915.1671978499534;923.676713150392;927.4991504587582;4906.9263961040615;4972.353594032825;5000.374953130859;5045.091883461012;5101.923471147936;5177.99029189312;5204.42751297357;5206.479352064764;5220.556252718486;5255.710935898563;4927.211646136601;4937.333459982929;4957.405111386656;4982.626303027288;5204.271402003723;3070.5854709614364;3070.7256488557446;3093.9381212376074;3095.257138286795;3102.6419920859857;6092.172348295494;6100.786472473442;6114.296855861633;6122.632642041492;6137.171481849893;5641.717914104278;5879.617824841372;5905.173275741399;5914.284857391394;5929.495992840657;6038.879222415615;6080.2399700037495;6092.1775560299675;6099.786507472217;6111.280480186275;5545.835374571224;5789.1895134680335;5800.810833779149;5846.924341858749;5861.736221869941;5682.715864206856;5686.886262274648;5703.458171473703;5715.714214289185;5716.28546431696;6101.816945491642;6148.047052706837;6158.291796443466;6163.137160797402;6174;3946.5264168299987;3993.101552150859;4068.450759147477;4095.7542547447247;4101.764538326679;5596.300462442195;5838.211841401357;5861.479563787612;5874.471297583238;5885.558583106199;5606.943930560642;5628.774849005994;5653.208550802973;5671.688057156896;5740.39725828782;5620.04459241938;5637.577181711306;5695.117256825033;5701.287339082614;5728;5359.303290572357;5590.413006634245;5606.439356064361;5633.492985631149;5642.266505354278;5633.0705433603;5695.658260504383;5711;5713.8285851424525;5732.197492351158;5463.562914966714;5550.694711790728;5563.443655634566;5563.7496312666835;5571.275734154534 03:45:40 INFO - PROCESS | 28675 | |5;yui.html;814.4176913506841;835.2357592802585;872.5375550957992;887.9467231966087;915.7847905742151;15090.849091509082;15754.76367854483;16944.915275423606;17185.312587496515;17252.74120888186;14946.626334341647;15071.547853564383;15081.321340539675;15089.471868484577;15090.17004064776;712.2201189697299;827.1356432528023;857.3955361470164;868.8696695495695;871.3290766110091;873.9169778870997;883.7746374674481;884.4295429448002;884.5754038061734;884.703624285865;906.5421961909227;911.6171208092617;912.320321360584;913.0458670689146;913.5067063785548;749.6364263332307;853.8889944307263;908.927285817133;910.5037754423822;912.5528491039342;660.5112216959463;664.1167247560733;664.9501287403416;665.424407887179;666.6200265848469;15788.210589470595;15896.602584935354;15914.681706365807;15933.123678197695;15959;14586;14806.333714982851;15086.54740357791;15109.244537773176;15310.311036003295;13804.309784510735;13982.860171398359;14009.299535023209;14164.645883852987;14331.928340358232;4601.976990115061;4673.88315292117;4690.648201384875;4748.19280722278;4794.976025119852;73395.26604733992;74680.62659686721;81008;81205.59397203036;85362.99999999937;13058.542950996669;13126.934365328112;13506.93246533761;13807.654808629664;14136.787948180785;23540.940657670446;23563.293101206993;23593.174238901556;23607.527849442915;23707;9390.67132650354;9554.092361225672;9700.369475984038;9715.224479809029;10160;5206.7917283309;5345.091334473072;5345.9732701337025;5382.300300960928;5540.639858409271;3737.0844143185095;3811.313963486599;3841.7310788244554;3849.615038496128;3851.441540976543;700.4011570107587;704.0671110778239;713.051641317047;720.7909706185147;721.5742711800063;791.125805984379;808.4138999225514;808.8058865872148;837.535167981776;860.2558786649628;10502.527386267637;10576.312539684895;10743.731406714738;10854.67435976922;10949.507272172772;711.3597762014228;712.2521352579771;742.5989965418613;809.2797410304834;816.7019038051187;4652.976735116303;4709.411323584552;4792.0895029944195;4925.1381008324115;5046.84859454217;75449.24550754423;115970.42014790041;117363.41318293524;119268;123184;98480.50759746156;98633.50683246681;99509;100073;100747.49626251822;72473;87812.99999999872;87854.56072719724;88232.55883720668;88871.55564222137;9333.486658233862;9418.434893906388;9429.43423394571;9499.715008549754;9619.159017466161;51590;52255.73872130615;52925;54093;54413;74566.25433745593;75805.24194757982;76415;78309;78483.60758196173;13666.794998074838;13856.30718464093;13886.93056534711;13904.165750055028;13937.721245575234;14880.62798430048;15023.849761502683;15260.465883694018;15691.372345106069;15868.52394428169;13215.867841321848;13337.66655833612;13752.243626600633;13825.239611821446;14214.28928553589;13801.723965520834;13946;14217.715645687234;14264.572062838131;14493.85506144925;13615.387307570985;14063.226522540948;14075.436982520585;14090.436382544583;14630.122192668474;10871.565137394731;11055.778884422105;11154.721131971766;11285.71785705364;11343.886561134283;11434.542618295174;11505.809864386742;11551.306921584395;11798.174127810971;11819.231749936227 03:45:40 INFO - PROCESS | 28675 | __end_tp_report 03:45:40 INFO - PROCESS | 28675 | __start_cc_report 03:45:40 INFO - PROCESS | 28675 | _x_x_mozilla_cycle_collect,856 03:45:40 INFO - PROCESS | 28675 | __end_cc_report 03:45:40 INFO - PROCESS | 28675 | __startTimestamp1467888340001__endTimestamp 03:45:40 INFO - PROCESS | 28675 | 03:45:40 INFO - PROCESS | 28675 | ------- Summary: start ------- 03:45:40 INFO - PROCESS | 28675 | Number of tests: 6 03:45:40 INFO - PROCESS | 28675 | 03:45:40 INFO - PROCESS | 28675 | [#0] dojo.html Cycles:165 Average:5383.93 Median:5579.72 stddev:591.27 (10.6%) stddev-sans-first:569.57 03:45:40 INFO - PROCESS | 28675 | Values: 3279.3 3293.9 3303.4 3311.6 3351.5 5303.3 5395.4 5404.2 5404.2 5414.2 5368.3 5392.5 5399.3 5405.9 5406.5 4811.8 4835.8 4860.9 4925.8 4936.0 4781.5 4920.5 4947.6 4951.5 4953.0 4871.7 4908.7 4925.7 4926.4 4957.7 5000.2 5002.0 5018.1 5019.2 5059.3 4734.0 4799.2 4849.9 4912.1 4947.9 5194.4 5214.8 5221.9 5256.7 5268.5 5690.8 5711.5 5713.9 5717.5 5754.2 5716.7 5763.2 5770.3 5796.4 5841.1 5416.8 5468.3 5468.5 5472.2 5481.6 5750.6 5973.3 5979.6 5980.9 5985.4 5632.4 5639.2 5683.1 5735.6 5763.7 5796.3 5796.9 5797.7 5826.0 5827.2 5539.6 5680.5 5777.1 5787.4 5795.0 5711.3 5791.8 5791.9 5795.9 5829.0 4488.3 4491.5 4501.7 4503.3 4515.8 3959.6 3961.1 3992.1 4051.9 4093.0 5528.4 5546.7 5551.0 5558.3 5576.0 5780.0 5791.1 5794.6 5795.7 5826.5 5329.0 5523.0 5529.4 5565.4 5574.9 4965.6 5002.0 5003.0 5003.6 5032.2 6083.0 6139.4 6153.0 6156.9 6161.5 5619.8 5739.9 5773.2 5785.0 5850.2 6136.0 6143.1 6147.5 6148.1 6150.0 5579.6 5728.0 5729.1 5729.4 5731.2 5670.7 5700.8 5734.9 5782.2 5784.7 5621.1 5625.1 5627.5 5634.4 5636.2 5455.9 5484.9 5579.7 5633.4 5635.4 5591.9 5639.4 5641.0 5642.9 5681.4 5689.6 5703.5 5708.7 5711.2 5748.9 5362.8 5475.5 5527.1 5589.1 5613.4 03:45:40 INFO - PROCESS | 28675 | 03:45:40 INFO - PROCESS | 28675 | [#1] ext.html Cycles:180 Average:63753.80 Median:21764.66 stddev:129150.09 (593.4%) stddev-sans-first:129425.32 03:45:40 INFO - PROCESS | 28675 | Values: 591.9 640.8 648.5 651.4 672.9 33804.7 37157.0 37175.4 46096.1 47907.3 49450.8 50059.2 50132.7 50148.5 50174.2 8097.0 9036.4 9178.3 9181.6 9182.1 10722.7 11016.7 11024.3 11361.6 11368.3 11106.3 11196.8 11222.5 11228.7 11233.9 8413.2 10868.4 11084.7 11112.4 11165.5 10637.3 11078.3 11100.2 11107.8 11115.0 46897.8 47473.8 47571.0 47576.0 47603.3 4016.5 4099.2 4111.7 4124.7 4440.0 35768.3 36075.8 36412.0 36490.6 36734.0 4830.6 4848.4 4864.1 4911.9 4929.0 386969.0 388070.0 389209.0 389578.0 390627.0 39359.4 40649.8 40708.0 42196.4 70885.3 41879.4 42058.8 42087.6 42223.6 42224.4 16510.7 16637.8 16641.5 16652.9 16658.2 12486.5 12796.7 13197.1 13563.3 13851.4 9336.3 9338.4 9372.1 9388.2 9407.6 3462.9 3539.8 3562.4 3567.3 3667.8 1121.6 1138.6 1138.8 1155.7 1164.2 35052.5 35362.5 35646.0 35704.0 35731.6 1212.7 1248.5 1255.8 1263.3 1364.7 15825.0 18388.4 18425.6 18685.8 18938.8 614858.0 617627.0 619409.0 619856.0 631164.0 66417.0 66927.0 66988.7 67020.0 67072.7 1353.8 1427.3 1440.5 1457.6 1482.7 34978.0 35869.3 35877.0 35910.5 36095.0 54637.0 54858.7 54880.5 55191.4 55233.7 412357.0 412855.0 414448.0 415016.0 415247.0 27435.7 30323.8 31198.5 31213.5 32633.0 52596.0 53604.2 53973.7 54252.2 54253.5 43575.5 43658.7 44016.1 44582.3 45065.8 43709.3 44044.1 44430.8 45401.0 45522.0 44434.6 45135.3 45566.8 45837.3 45870.3 39012.2 39272.0 39512.8 40631.2 40676.4 29333.7 30011.0 30484.8 30574.2 30768.4 03:45:40 INFO - PROCESS | 28675 | 03:45:40 INFO - PROCESS | 28675 | [#2] jquery.html Cycles:180 Average:31056.78 Median:13326.20 stddev:89052.48 (668.3%) stddev-sans-first:89272.55 03:45:40 INFO - PROCESS | 28675 | Values: 402.3 410.2 427.9 428.0 433.3 19155.7 19794.3 20209.3 20492.8 20866.8 19924.8 19994.4 20358.0 20874.8 20973.5 5696.3 5925.2 5965.0 5976.5 5981.3 4304.3 4417.3 5773.9 5893.3 6684.9 6655.3 6707.7 6714.8 6727.1 6733.9 6505.9 6562.1 6679.5 6679.9 6700.2 3903.6 5573.9 5893.9 5904.5 5922.0 24282.9 24533.6 24667.4 24874.9 24911.3 2282.3 2285.2 2369.5 2518.1 3180.9 9960.4 10363.1 10421.9 10930.2 14508.1 1931.4 2021.9 2035.1 2046.1 2053.6 69420.7 86944.6 87655.6 89639.6 90761.0 10951.7 11400.3 11797.3 11827.2 12038.5 17062.7 17102.3 17213.5 17223.3 17228.6 8112.4 8458.4 8507.9 8628.6 8662.8 8119.5 8142.9 8155.4 8207.0 8237.5 5027.7 5096.9 5142.4 5155.0 5249.4 1828.0 1955.0 1955.8 1989.2 2034.5 1009.3 1052.8 1135.8 1170.1 1176.2 19993.2 20187.6 20289.2 20464.4 20597.4 1040.2 1065.0 1125.2 1126.3 1142.1 11095.7 11396.3 11513.7 11521.3 11548.3 528784.0 540190.0 541238.0 547454.0 548348.0 69693.0 96134.5 97357.5 98045.5 98274.0 1070.2 1096.2 1104.5 1108.8 1116.2 18009.0 18277.8 18323.4 18369.3 18401.4 41007.6 42719.1 43977.1 44089.1 45722.0 60124.7 61848.4 62037.0 62853.1 62954.7 8258.1 8543.7 8555.6 8567.2 8756.0 11784.8 13325.7 13352.3 13415.5 13539.5 11729.5 11992.8 12009.4 12071.8 12538.1 10849.4 11169.0 11511.4 11523.3 11586.4 11058.9 11973.6 12083.9 12170.1 12408.6 8490.1 8591.5 8611.4 8642.3 8959.1 8775.0 12284.6 12334.4 12462.0 12577.7 03:45:40 INFO - PROCESS | 28675 | 03:45:40 INFO - PROCESS | 28675 | [#3] mootools.html Cycles:180 Average:6385.05 Median:4433.29 stddev:3670.30 (82.8%) stddev-sans-first:3661.87 03:45:40 INFO - PROCESS | 28675 | Values: 1451.0 1588.7 1622.9 1831.9 1935.7 9206.4 9545.5 9576.7 9879.4 9892.0 9628.4 9847.0 9857.6 9890.3 9896.0 2170.9 2466.0 2516.3 2544.3 2546.2 2546.2 2556.2 2560.5 2563.3 2563.9 2503.2 2558.0 2560.9 2562.1 2563.2 2127.1 2403.4 2478.3 2482.8 2483.7 2492.8 2500.5 2519.1 2521.1 2539.8 9448.1 9453.4 9477.5 9546.8 9573.7 5787.5 5917.3 5942.3 5942.3 5948.6 3611.3 3673.8 3743.0 3760.5 3767.7 1231.1 1291.2 1302.5 2336.2 2401.3 13310.9 13428.8 13436.6 13447.4 13505.6 4968.9 5025.4 5113.5 5116.4 5156.5 10439.7 10542.4 10565.5 10571.5 10581.7 5802.3 5811.0 5818.9 5822.0 5837.0 4731.5 5172.1 5257.5 5269.8 5344.6 4077.7 4112.3 4198.3 4217.9 4222.5 1221.2 1224.2 1228.6 1230.4 1241.5 947.4 965.5 1100.4 1101.2 1108.4 6598.3 6599.4 6627.8 6722.6 6806.9 1057.9 1091.2 1099.1 1107.4 1124.9 4328.5 4407.1 4425.2 4441.4 4508.5 12267.4 12544.0 12554.9 12692.4 12737.0 12438.9 12528.1 12546.8 12547.2 12591.4 8317.2 8629.5 8637.0 8860.2 8884.3 6624.3 6717.0 6784.4 6814.0 6823.5 11134.9 11428.7 11487.7 11625.5 11668.8 11410.5 11704.1 11707.5 11808.0 11823.4 7862.7 8335.4 8513.1 8671.4 8805.8 9455.9 9475.5 9521.5 9552.0 9565.0 8398.4 8575.4 8581.8 8673.7 8687.9 8126.0 8212.5 8421.0 8442.6 8564.1 7121.2 7199.6 7199.6 7201.8 7215.0 5312.0 5346.4 5347.2 5476.5 5543.5 5458.4 5616.7 5668.3 5682.8 5782.6 03:45:40 INFO - PROCESS | 28675 | 03:45:40 INFO - PROCESS | 28675 | [#4] prototype.html Cycles:180 Average:4700.22 Median:5224.91 stddev:1403.55 (26.9%) stddev-sans-first:1368.38 03:45:40 INFO - PROCESS | 28675 | Values: 316.9 329.4 330.8 337.8 338.7 5381.2 5420.4 5435.5 5444.7 5491.6 5074.4 5193.3 5229.3 5245.2 5384.5 4019.3 4078.1 4124.9 4159.4 4190.2 4118.1 4140.2 4157.8 4167.7 4169.2 4074.9 4077.8 4128.9 4159.9 4165.7 4124.5 4129.0 4137.6 4153.8 4158.4 3668.5 3675.9 3687.7 3701.9 3702.9 5032.9 5065.1 5099.6 5102.8 5131.5 4723.5 4734.1 4742.7 4751.6 4793.4 5496.7 5545.4 5553.4 5561.4 5608.8 3769.0 4040.5 4044.6 4046.3 4047.7 5785.4 5818.4 5836.6 5845.8 5855.3 4035.9 4057.6 4057.7 4061.8 4062.0 4121.8 4128.8 4131.5 4140.0 4141.2 4520.8 4699.9 4718.4 4718.8 4734.9 5645.9 5652.5 5655.2 5667.3 5672.3 1339.6 1386.0 1402.5 1405.5 1408.7 876.8 907.6 915.2 923.7 927.5 4906.9 4972.4 5000.4 5045.1 5101.9 5178.0 5204.4 5206.5 5220.6 5255.7 4927.2 4937.3 4957.4 4982.6 5204.3 3070.6 3070.7 3093.9 3095.3 3102.6 6092.2 6100.8 6114.3 6122.6 6137.2 5641.7 5879.6 5905.2 5914.3 5929.5 6038.9 6080.2 6092.2 6099.8 6111.3 5545.8 5789.2 5800.8 5846.9 5861.7 5682.7 5686.9 5703.5 5715.7 5716.3 6101.8 6148.0 6158.3 6163.1 6174.0 3946.5 3993.1 4068.5 4095.8 4101.8 5596.3 5838.2 5861.5 5874.5 5885.6 5606.9 5628.8 5653.2 5671.7 5740.4 5620.0 5637.6 5695.1 5701.3 5728.0 5359.3 5590.4 5606.4 5633.5 5642.3 5633.1 5695.7 5711.0 5713.8 5732.2 5463.6 5550.7 5563.4 5563.7 5571.3 03:45:40 INFO - PROCESS | 28675 | 03:45:40 INFO - PROCESS | 28675 | [#5] yui.html Cycles:180 Average:21306.41 Median:4700.03 stddev:29830.23 (634.7%) stddev-sans-first:29874.22 03:45:40 INFO - PROCESS | 28675 | Values: 814.4 835.2 872.5 887.9 915.8 15090.8 15754.8 16944.9 17185.3 17252.7 14946.6 15071.5 15081.3 15089.5 15090.2 712.2 827.1 857.4 868.9 871.3 873.9 883.8 884.4 884.6 884.7 906.5 911.6 912.3 913.0 913.5 749.6 853.9 908.9 910.5 912.6 660.5 664.1 665.0 665.4 666.6 15788.2 15896.6 15914.7 15933.1 15959.0 14586.0 14806.3 15086.5 15109.2 15310.3 13804.3 13982.9 14009.3 14164.6 14331.9 4602.0 4673.9 4690.6 4748.2 4795.0 73395.3 74680.6 81008.0 81205.6 85363.0 13058.5 13126.9 13506.9 13807.7 14136.8 23540.9 23563.3 23593.2 23607.5 23707.0 9390.7 9554.1 9700.4 9715.2 10160.0 5206.8 5345.1 5346.0 5382.3 5540.6 3737.1 3811.3 3841.7 3849.6 3851.4 700.4 704.1 713.1 720.8 721.6 791.1 808.4 808.8 837.5 860.3 10502.5 10576.3 10743.7 10854.7 10949.5 711.4 712.3 742.6 809.3 816.7 4653.0 4709.4 4792.1 4925.1 5046.8 75449.2 115970.4 117363.4 119268.0 123184.0 98480.5 98633.5 99509.0 100073.0 100747.5 72473.0 87813.0 87854.6 88232.6 88871.6 9333.5 9418.4 9429.4 9499.7 9619.2 51590.0 52255.7 52925.0 54093.0 54413.0 74566.3 75805.2 76415.0 78309.0 78483.6 13666.8 13856.3 13886.9 13904.2 13937.7 14880.6 15023.8 15260.5 15691.4 15868.5 13215.9 13337.7 13752.2 13825.2 14214.3 13801.7 13946.0 14217.7 14264.6 14493.9 13615.4 14063.2 14075.4 14090.4 14630.1 10871.6 11055.8 11154.7 11285.7 11343.9 11434.5 11505.8 11551.3 11798.2 11819.2 03:45:40 INFO - PROCESS | 28675 | -------- Summary: end -------- 03:45:40 INFO - PROCESS | 28675 | 03:45:40 INFO - TEST-INFO | 28675: exit 0 03:45:40 INFO - TEST-OK | dromaeo_css | took 1111775ms 03:45:40 INFO - TEST-START | kraken 03:45:40 INFO - operating with platform_type : linux_ 03:45:40 INFO - Initialising browser for kraken test... 03:45:40 INFO - TEST-INFO | started process 28861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpquJmA7/profile http://localhost:37995/getInfo.html) 03:45:44 INFO - PROCESS | 28861 | __metrics Screen width/height:1600/1200 03:45:44 INFO - PROCESS | 28861 | colorDepth:24 03:45:44 INFO - PROCESS | 28861 | Browser inner width/height: 1024/697 03:45:44 INFO - PROCESS | 28861 | __metrics 03:45:45 ERROR - PROCESS | 28861 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:45:46 INFO - TEST-INFO | 28861: exit 0 03:45:46 INFO - Browser initialized. 03:45:46 INFO - Running cycle 1/1 for kraken test... 03:45:46 INFO - TEST-INFO | started process 28950 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpquJmA7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:57 INFO - PROCESS | 28950 | RSS: Main: 145481728 03:45:57 INFO - PROCESS | 28950 | 03:46:00 INFO - PROCESS | 28950 | Cycle 1(1): loaded http://localhost:37995/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37995/tests/kraken/driver.html?testName=audio-beat-detection) 03:46:01 INFO - PROCESS | 28950 | RSS: Main: 194875392 03:46:01 INFO - PROCESS | 28950 | 03:46:03 INFO - PROCESS | 28950 | Cycle 1(1): loaded http://localhost:37995/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37995/tests/kraken/driver.html?testName=audio-dft) 03:46:04 INFO - PROCESS | 28950 | RSS: Main: 192311296 03:46:04 INFO - PROCESS | 28950 | 03:46:07 INFO - PROCESS | 28950 | Cycle 1(1): loaded http://localhost:37995/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37995/tests/kraken/driver.html?testName=audio-fft) 03:46:07 INFO - PROCESS | 28950 | RSS: Main: 277250048 03:46:07 INFO - PROCESS | 28950 | 03:46:10 INFO - PROCESS | 28950 | Cycle 1(1): loaded http://localhost:37995/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37995/tests/kraken/driver.html?testName=audio-oscillator) 03:46:10 INFO - PROCESS | 28950 | RSS: Main: 186920960 03:46:10 INFO - PROCESS | 28950 | 03:46:12 INFO - PROCESS | 28950 | Cycle 1(1): loaded http://localhost:37995/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37995/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:46:13 INFO - PROCESS | 28950 | RSS: Main: 186019840 03:46:13 INFO - PROCESS | 28950 | 03:46:16 INFO - PROCESS | 28950 | Cycle 1(1): loaded http://localhost:37995/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37995/tests/kraken/driver.html?testName=imaging-darkroom) 03:46:16 INFO - PROCESS | 28950 | RSS: Main: 220913664 03:46:16 INFO - PROCESS | 28950 | 03:46:20 INFO - PROCESS | 28950 | Cycle 1(1): loaded http://localhost:37995/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37995/tests/kraken/driver.html?testName=imaging-desaturate) 03:46:20 INFO - PROCESS | 28950 | RSS: Main: 221143040 03:46:20 INFO - PROCESS | 28950 | 03:46:23 INFO - PROCESS | 28950 | Cycle 1(1): loaded http://localhost:37995/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37995/tests/kraken/driver.html?testName=json-parse-financial) 03:46:24 INFO - PROCESS | 28950 | RSS: Main: 220835840 03:46:24 INFO - PROCESS | 28950 | 03:46:25 INFO - PROCESS | 28950 | Cycle 1(1): loaded http://localhost:37995/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37995/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:46:26 INFO - PROCESS | 28950 | RSS: Main: 200364032 03:46:26 INFO - PROCESS | 28950 | 03:46:27 INFO - PROCESS | 28950 | Cycle 1(1): loaded http://localhost:37995/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37995/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:46:28 INFO - PROCESS | 28950 | RSS: Main: 200912896 03:46:28 INFO - PROCESS | 28950 | 03:46:30 INFO - PROCESS | 28950 | Cycle 1(1): loaded http://localhost:37995/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37995/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:46:31 INFO - PROCESS | 28950 | RSS: Main: 208683008 03:46:31 INFO - PROCESS | 28950 | 03:46:33 INFO - PROCESS | 28950 | Cycle 1(1): loaded http://localhost:37995/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37995/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:46:34 INFO - PROCESS | 28950 | RSS: Main: 213798912 03:46:34 INFO - PROCESS | 28950 | 03:46:36 INFO - PROCESS | 28950 | Cycle 1(1): loaded http://localhost:37995/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37995/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:46:37 INFO - PROCESS | 28950 | RSS: Main: 212475904 03:46:37 INFO - PROCESS | 28950 | 03:46:39 INFO - PROCESS | 28950 | Cycle 1(1): loaded http://localhost:37995/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37995/tests/kraken/driver.html?testName=ai-astar) 03:46:39 INFO - PROCESS | 28950 | RSS: Main: 254976000 03:46:39 INFO - PROCESS | 28950 | 03:46:39 INFO - PROCESS | 28950 | __start_tp_report 03:46:39 INFO - PROCESS | 28950 | _x_x_mozilla_page_load 03:46:39 INFO - PROCESS | 28950 | _x_x_mozilla_page_load_details 03:46:39 INFO - PROCESS | 28950 | |i|pagename|runs| 03:46:39 INFO - PROCESS | 28950 | |0;ai-astar;110;106;111;112;111;111;109;109;111;108 03:46:39 INFO - PROCESS | 28950 | |1;audio-beat-detection;151;125;129;186;124;124;158;130;154;122 03:46:39 INFO - PROCESS | 28950 | |2;audio-dft;161;162;162;160;160;160;162;162;161;160 03:46:39 INFO - PROCESS | 28950 | |3;audio-fft;76;76;77;124;75;75;75;75;120;74 03:46:39 INFO - PROCESS | 28950 | |4;audio-oscillator;83;85;110;83;84;86;130;85;84;124 03:46:39 INFO - PROCESS | 28950 | |5;imaging-gaussian-blur;117;117;116;116;116;117;117;117;117;116 03:46:39 INFO - PROCESS | 28950 | |6;imaging-darkroom;146;145;146;146;146;146;146;146;145;147 03:46:39 INFO - PROCESS | 28950 | |7;imaging-desaturate;94;95;95;94;96;95;95;95;94;94 03:46:39 INFO - PROCESS | 28950 | |8;json-parse-financial;52;50;53;53;54;52;53;52;53;51 03:46:39 INFO - PROCESS | 28950 | |9;json-stringify-tinderbox;60;59;59;60;59;60;59;59;59;59 03:46:39 INFO - PROCESS | 28950 | |10;stanford-crypto-aes;75;76;75;81;83;76;78;77;108;76 03:46:39 INFO - PROCESS | 28950 | |11;stanford-crypto-ccm;128;116;120;125;114;115;126;120;125;119 03:46:39 INFO - PROCESS | 28950 | |12;stanford-crypto-pbkdf2;156;157;156;160;155;155;159;155;154;152 03:46:39 INFO - PROCESS | 28950 | |13;stanford-crypto-sha256-iterative;64;62;64;67;62;61;61;61;62;63 03:46:39 INFO - PROCESS | 28950 | __end_tp_report 03:46:39 INFO - PROCESS | 28950 | __start_cc_report 03:46:39 INFO - PROCESS | 28950 | _x_x_mozilla_cycle_collect,1551 03:46:39 INFO - PROCESS | 28950 | __end_cc_report 03:46:39 INFO - PROCESS | 28950 | __startTimestamp1467888399468__endTimestamp 03:46:39 INFO - PROCESS | 28950 | 03:46:39 INFO - PROCESS | 28950 | ------- Summary: start ------- 03:46:39 INFO - PROCESS | 28950 | Number of tests: 14 03:46:39 INFO - PROCESS | 28950 | 03:46:39 INFO - PROCESS | 28950 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:1.81 (1.6%) stddev-sans-first:1.92 03:46:39 INFO - PROCESS | 28950 | Values: 110.0 106.0 111.0 112.0 111.0 111.0 109.0 109.0 111.0 108.0 03:46:39 INFO - PROCESS | 28950 | 03:46:39 INFO - PROCESS | 28950 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:140.50 stddev:21.18 (15.1%) stddev-sans-first:22.11 03:46:39 INFO - PROCESS | 28950 | Values: 151.0 125.0 129.0 186.0 124.0 124.0 158.0 130.0 154.0 122.0 03:46:39 INFO - PROCESS | 28950 | 03:46:39 INFO - PROCESS | 28950 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:0.94 (0.6%) stddev-sans-first:1.00 03:46:39 INFO - PROCESS | 28950 | Values: 161.0 162.0 162.0 160.0 160.0 160.0 162.0 162.0 161.0 160.0 03:46:39 INFO - PROCESS | 28950 | 03:46:39 INFO - PROCESS | 28950 | [#3] audio-fft Cycles:10 Average:84.70 Median:75.00 stddev:19.70 (26.3%) stddev-sans-first:20.64 03:46:39 INFO - PROCESS | 28950 | Values: 76.0 76.0 77.0 124.0 75.0 75.0 75.0 75.0 120.0 74.0 03:46:39 INFO - PROCESS | 28950 | 03:46:39 INFO - PROCESS | 28950 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:84.00 stddev:18.56 (22.1%) stddev-sans-first:19.14 03:46:39 INFO - PROCESS | 28950 | Values: 83.0 85.0 110.0 83.0 84.0 86.0 130.0 85.0 84.0 124.0 03:46:39 INFO - PROCESS | 28950 | 03:46:39 INFO - PROCESS | 28950 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:46:39 INFO - PROCESS | 28950 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 03:46:39 INFO - PROCESS | 28950 | 03:46:39 INFO - PROCESS | 28950 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 03:46:39 INFO - PROCESS | 28950 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 147.0 03:46:39 INFO - PROCESS | 28950 | 03:46:39 INFO - PROCESS | 28950 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 03:46:39 INFO - PROCESS | 28950 | Values: 94.0 95.0 95.0 94.0 96.0 95.0 95.0 95.0 94.0 94.0 03:46:39 INFO - PROCESS | 28950 | 03:46:39 INFO - PROCESS | 28950 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:53.00 stddev:1.16 (2.2%) stddev-sans-first:1.22 03:46:39 INFO - PROCESS | 28950 | Values: 52.0 50.0 53.0 53.0 54.0 52.0 53.0 52.0 53.0 51.0 03:46:39 INFO - PROCESS | 28950 | 03:46:39 INFO - PROCESS | 28950 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 03:46:39 INFO - PROCESS | 28950 | Values: 60.0 59.0 59.0 60.0 59.0 60.0 59.0 59.0 59.0 59.0 03:46:39 INFO - PROCESS | 28950 | 03:46:39 INFO - PROCESS | 28950 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:76.50 stddev:10.01 (13.1%) stddev-sans-first:10.42 03:46:39 INFO - PROCESS | 28950 | Values: 75.0 76.0 75.0 81.0 83.0 76.0 78.0 77.0 108.0 76.0 03:46:39 INFO - PROCESS | 28950 | 03:46:39 INFO - PROCESS | 28950 | [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:122.50 stddev:4.96 (4.1%) stddev-sans-first:4.53 03:46:39 INFO - PROCESS | 28950 | Values: 128.0 116.0 120.0 125.0 114.0 115.0 126.0 120.0 125.0 119.0 03:46:39 INFO - PROCESS | 28950 | 03:46:39 INFO - PROCESS | 28950 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.90 Median:156.00 stddev:2.33 (1.5%) stddev-sans-first:2.47 03:46:39 INFO - PROCESS | 28950 | Values: 156.0 157.0 156.0 160.0 155.0 155.0 159.0 155.0 154.0 152.0 03:46:39 INFO - PROCESS | 28950 | 03:46:39 INFO - PROCESS | 28950 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.50 stddev:1.89 (3.0%) stddev-sans-first:1.94 03:46:39 INFO - PROCESS | 28950 | Values: 64.0 62.0 64.0 67.0 62.0 61.0 61.0 61.0 62.0 63.0 03:46:39 INFO - PROCESS | 28950 | -------- Summary: end -------- 03:46:39 INFO - PROCESS | 28950 | 03:46:40 INFO - TEST-INFO | 28950: exit 0 03:46:40 INFO - TEST-OK | kraken | took 59879ms 03:46:40 INFO - SUITE-END | took 1171s 03:46:40 INFO - Completed test suite (00:19:31) 03:46:40 INFO - javascript benchmark 03:46:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3279.3277378137486, 3293.8965446575403, 3303.3888730584845, 3311.619163796161, 3351.547541081955, 5303.310569625948, 5395.379531353896, 5404.162354834997, 5404.243405923174, 5414.214938833867, 5368.32895888014, 5392.460753924615, 5399.325084364455, 5405.864853378667, 5406.513413792758, 4811.7594120294025, 4835.782389792459, 4860.854174374756, 4925.802967881281, 4935.975320123394, 4781.521847815208, 4920.507949205069, 4947.579455746266, 4951.529604687549, 4952.950470495285, 4871.7076975381415, 4908.7300198489065, 4925.655204135712, 4926.433460152075, 4957.677750946195, 5000.199968005102, 5001.99960007998, 5018.146915024455, 5019.171836646949, 5059.342285502879, 4734.0, 4799.1601469743, 4849.878753031167, 4912.066707325596, 4947.90104197914, 5194.35070616173, 5214.765335559909, 5221.947780522184, 5256.737163141827, 5268.4994925482015, 5690.800821971253, 5711.485966263056, 5713.857153571194, 5717.456841600041, 5754.223179870705, 5716.685582292972, 5763.221965034751, 5770.336411312669, 5796.420357964212, 5841.094630332263, 5416.83749487516, 5468.26178465906, 5468.507834294893, 5472.2338872557875, 5481.561475081984, 5750.6262092963825, 5973.342932277446, 5979.5515336349945, 5980.910286345708, 5985.431384018511, 5632.436756324335, 5639.154126880919, 5683.062294721325, 5735.627184233012, 5763.6541807491685, 5796.304443466811, 5796.913046304308, 5797.739101740432, 5825.970870145707, 5827.213326200908, 5539.556835453154, 5680.5455563554815, 5777.075667893117, 5787.392323806024, 5794.971025144931, 5711.314642242957, 5791.797287094932, 5791.942080579224, 5795.88408231833, 5829.0, 4488.259437192826, 4491.46102467706, 4501.707389019703, 4503.279475284005, 4515.751633660115, 3959.6436320731273, 3961.088949541622, 3992.1017771001293, 4051.8987025324013, 4093.038136038029, 5528.391876893538, 5546.667199968015, 5550.972245138829, 5558.277423934863, 5576.0, 5779.971100144557, 5791.0734282514595, 5794.594378393472, 5795.739191736382, 5826.475617194473, 5329.040772660958, 5523.0, 5529.364123125812, 5565.41563135873, 5574.860628484239, 4965.553100220997, 5002.024605201951, 5002.974985125124, 5003.624728145403, 5032.245163225472, 6083.0, 6139.416755408319, 6153.0, 6156.938430615726, 6161.537884658668, 5619.80330688424, 5739.942600574108, 5773.220615216892, 5785.016547187072, 5850.23946886902, 6135.969320153371, 6143.139960405636, 6147.477464415396, 6148.077788331786, 6150.04674275488, 5579.637323573955, 5727.971360143172, 5729.140628905698, 5729.398413166724, 5731.226284451713, 5670.659760414388, 5700.828975130753, 5734.885302294014, 5782.190493331022, 5784.739686714024, 5621.100623900156, 5625.128105143709, 5627.493525582717, 5634.408387119457, 5636.1827535008015, 5455.890882182413, 5484.862878428071, 5579.721013949205, 5633.380328163817, 5635.351934527582, 5591.888162236651, 5639.407862174413, 5641.0, 5642.887142257214, 5681.375048744552, 5689.573282003949, 5703.543716502752, 5708.686022268815, 5711.171880077282, 5748.856278593069, 5362.785488580569, 5475.452454754652, 5527.060399731975, 5589.077802162597, 5613.382527921844], "value": 5346.498470665653, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.9378465261148, 640.7693230437043, 648.5233353485188, 651.3649192037764, 672.9158855143107, 33804.66195338046, 37157.0, 37175.44236836446, 46096.07807843841, 47907.281390779164, 49450.75274623622, 50059.24911126336, 50132.74933625336, 50148.49851501493, 50174.24738628914, 8097.0, 9036.412633178856, 9178.265738740918, 9181.632734690638, 9182.127697868726, 10722.731931701692, 11016.724581885437, 11024.283421577611, 11361.602343917964, 11368.31790092593, 11106.278091924, 11196.776064478705, 11222.494987725571, 11228.719282017933, 11233.943830280878, 8413.200745929127, 10868.402237876993, 11084.667459976174, 11112.388818614972, 11165.497552610152, 10637.255392122555, 11078.279911805706, 11100.222984391095, 11107.83338249927, 11115.0, 46897.76551117223, 47473.762631186626, 47571.0, 47576.0, 47603.285950710764, 4016.518017837849, 4099.1801639672185, 4111.650509706678, 4124.670026397881, 4439.978804874897, 35768.28463430743, 36075.81962090199, 36412.0, 36490.63509364899, 36734.0, 4830.5652491275605, 4848.393950756155, 4864.148773964577, 4911.852644420673, 4929.014197160546, 386969.0, 388070.0, 389209.0, 389577.99999999715, 390627.0, 39359.40960885589, 40649.79675101665, 40708.0, 42196.36705449421, 70885.29114708788, 41879.37180942288, 42058.78970605128, 42087.579124208365, 42223.57776422258, 42224.366634500504, 16510.66978660444, 16637.83362166387, 16641.50075497737, 16652.916735416246, 16658.16709164537, 12486.50053997848, 12796.744065118646, 13197.142185757895, 13563.321833908265, 13851.445942162201, 9336.299777516713, 9338.393004454689, 9372.109649583279, 9388.155066043952, 9407.576659050359, 3462.9480557791653, 3539.752217344813, 3562.412201986695, 3567.2555501183365, 3667.8176484991386, 1121.6466812953893, 1138.5559631743627, 1138.815631742978, 1155.6706338693432, 1164.1618035014776, 35052.474212886824, 35362.469562956576, 35646.0, 35704.0, 35731.642683572834, 1212.7210741529498, 1248.450681700049, 1255.7990721484518, 1263.311495235099, 1364.7202323523654, 15825.0, 18388.448346549623, 18425.631487370447, 18685.81314186868, 18938.81061189398, 614858.0, 617627.0, 619409.0, 619856.0, 631164.0, 66417.0, 66927.0, 66988.6650566744, 67020.0, 67072.66463667748, 1353.8307711536058, 1427.293489722594, 1440.5246268731084, 1457.5554455891056, 1482.7256957462903, 34978.0, 35869.282614347045, 35877.0, 35910.461343079354, 36095.0, 54637.0, 54858.72570637121, 54880.451195487534, 55191.448085518634, 55233.72383138059, 412357.0, 412855.0, 414448.0, 415016.0, 415247.0, 27435.725642744117, 30323.787048517814, 31198.532022020143, 31213.531797023516, 32633.0, 52596.0, 53604.195937061755, 53973.73013134909, 54252.186217205985, 54253.45746542642, 43575.47485837981, 43658.69277087521, 44016.11967760691, 44582.3312650304, 45065.77467112643, 43709.34435983526, 44044.11911761811, 44430.77784611056, 45401.0, 45522.0, 44434.555654443044, 45135.32297015482, 45566.77216613896, 45837.31244031276, 45870.31194532151, 39012.2197556053, 39272.0, 39512.802435987636, 40631.1873762529, 40676.3898541528, 29333.70666293395, 30011.0, 30484.847575761978, 30574.235644109074, 30768.38463230678], "value": 20753.053215036573, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.3481959226053, 410.1796407185629, 427.8930267433142, 427.97432154070776, 433.2980571474212, 19155.712664310027, 19794.30719924803, 20209.292674756387, 20492.795072049255, 20866.791332086676, 19924.800751992476, 19994.400167994947, 20358.0, 20874.791252087474, 20973.47566310843, 5696.25948626679, 5925.170476133345, 5965.015772397549, 5976.4919981801595, 5981.342052374235, 4304.267900822499, 4417.337399390085, 5773.913391299134, 5893.322267939199, 6684.866302673943, 6655.334466553354, 6707.698153583076, 6714.832129196785, 6727.125473688438, 6733.932660673379, 6505.869882602321, 6562.146920900276, 6679.532432729711, 6679.866402671943, 6700.195976482829, 3903.5706072332023, 5573.944260557383, 5893.939090963625, 5904.498117660004, 5921.970390148064, 24282.87858560696, 24533.63199552008, 24667.38331541708, 24874.87562562194, 24911.252662420156, 2282.3267136194863, 2285.2344464604375, 2369.5260947810507, 2518.143831097436, 3180.904572862818, 9960.352577082467, 10363.06732394088, 10421.895781042169, 10930.180236482296, 14508.056976296613, 1931.3916116423281, 2021.9393418197478, 2035.0740413112146, 2046.0894901768718, 2053.6098141353245, 69420.65289673519, 86944.56527717321, 87655.56172219162, 89639.55180224123, 90761.0, 10951.726206844733, 11400.258983166068, 11797.29216247028, 11827.17209795306, 12038.4582693779, 17062.658746825244, 17102.315907363565, 17213.483595492155, 17223.31106755716, 17228.569285767706, 8112.391570632226, 8458.40791144614, 8507.914920850711, 8628.568571571397, 8662.78343041429, 8119.4722343047515, 8142.918570814334, 8155.429119961545, 8206.958965205136, 8237.46456480327, 5027.698338099725, 5096.923546146811, 5142.382914050263, 5154.974225128851, 5249.370075590878, 1828.0392020574193, 1954.951126221856, 1955.765308163001, 1989.19437627761, 2034.532057626754, 1009.3439264478149, 1052.7578656908954, 1135.840982262484, 1170.0931777872217, 1176.2295696318924, 19993.200271989248, 20187.596248074955, 20289.18843246283, 20464.38606841797, 20597.382078537667, 1040.1730624153815, 1065.0255016659669, 1125.150511363915, 1126.3298337489182, 1142.149098921309, 11095.722606934729, 11396.316221026766, 11513.675927268472, 11521.251118677259, 11548.307101573933, 528784.0, 540190.0, 541238.0, 547454.0, 548348.0, 69693.0, 96134.51932740292, 97357.51321243348, 98045.50977245068, 98274.0, 1070.1652710885521, 1096.1504833753904, 1104.5140138339104, 1108.828131639581, 1116.1573012375604, 18009.0, 18277.817221827612, 18323.35868244605, 18369.265229390676, 18401.447956561326, 41007.58992410038, 42719.14561708811, 43977.12045759131, 44089.11821763611, 45722.0, 60124.69937650284, 61848.38151618606, 62037.0, 62853.05720414289, 62954.68522657357, 8258.132896045829, 8543.743687689379, 8555.57222138903, 8567.186117318844, 8756.0, 11784.76430471403, 13325.733485330045, 13352.265625390308, 13415.530456433979, 13539.458421663023, 11729.530818767154, 11992.820107698566, 12009.399530023638, 12071.758564828478, 12538.122331437076, 10849.403282819521, 11168.959714936287, 11511.36687482163, 11523.308601483937, 11586.362750048827, 11058.889411105785, 11973.580924667594, 12083.879161208275, 12170.087243456599, 12408.62774116778, 8490.06609272967, 8591.484510929115, 8611.354148439017, 8642.308615310634, 8959.10408959125, 8775.0, 12284.631461056182, 12334.383280836102, 12462.0, 12577.685557861127], "value": 9682.074214763896, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.0, 1588.737858253388, 1622.8620567251783, 1831.8992455414948, 1935.748352714147, 9206.401583897043, 9545.522723863814, 9576.664816731416, 9879.3578417403, 9892.0, 9628.422294662325, 9847.0, 9857.556409961551, 9890.307678462492, 9896.0, 2170.8806015669134, 2465.950680986379, 2516.345750104972, 2544.3130354804193, 2546.172493939468, 2546.2106746908426, 2556.2203527923975, 2560.4879024195143, 2563.333533281351, 2563.9487210255784, 2503.1864643990775, 2557.9872100639473, 2560.911612564662, 2562.1160699558623, 2563.218218443374, 2127.106615221603, 2403.42317843718, 2478.293686299396, 2482.8262021658493, 2483.6647052648023, 2492.8255022148455, 2500.5124000819847, 2519.0805356045094, 2521.13021007752, 2539.8222124451295, 9448.149666530046, 9453.43279403238, 9477.47873866937, 9546.809063818755, 9573.712788616353, 5787.450192231773, 5917.289925208959, 5942.316633587149, 5942.346341902387, 5948.613340132878, 3611.295797319524, 3673.779573225588, 3743.0, 3760.511133552648, 3767.6797472214894, 1231.119749379198, 1291.238169480002, 1302.5115581656878, 2336.1589827662197, 2401.2916189723896, 13310.86689133106, 13428.798568021488, 13436.596902092855, 13447.394867230998, 13505.594832155051, 4968.8757781055765, 5025.3718285214345, 5113.488651134857, 5116.437191908887, 5156.535911767959, 10439.739006524898, 10542.367457952547, 10565.471726413649, 10571.524281407355, 10581.682549523526, 5802.303723553201, 5811.0, 5818.883622327529, 5822.0, 5836.970815145897, 4731.52684731531, 5172.120739474299, 5257.5005374489365, 5269.78920843162, 5344.625876188629, 4077.715519611313, 4112.259793237186, 4198.349255865346, 4217.91564168721, 4222.451081359465, 1221.151299846598, 1224.1675660550911, 1228.6129869091208, 1230.3540641163281, 1241.4661695471034, 947.393668052447, 965.5172413793103, 1100.3562915694408, 1101.2016288190998, 1108.3682301088302, 6598.3401659833635, 6599.373059559334, 6627.834304142339, 6722.596644201363, 6806.8638627228165, 1057.8575138850024, 1091.1598069486452, 1099.0822663076422, 1107.3909349857547, 1124.8818874018275, 4328.458942632171, 4407.096545208225, 4425.181341451842, 4441.400410944546, 4508.48152462471, 12267.38663066843, 12543.996480281738, 12554.937225313815, 12692.42884070219, 12737.0, 12438.937805310916, 12528.123031387897, 12546.81179782304, 12547.24716517012, 12591.433385497674, 8317.168283171635, 8629.525376104375, 8637.0499245083, 8860.246879015227, 8884.333674974403, 6624.304448032887, 6717.0, 6784.3554862289975, 6814.0, 6823.488238382042, 11134.888651113386, 11428.714282143013, 11487.655370338904, 11625.534978600761, 11668.766624667629, 11410.543578256777, 11704.122190835551, 11707.473163707484, 11808.0, 11823.408829558659, 7862.72480463181, 8335.416520843482, 8513.06356300794, 8671.4363566368, 8805.823883522422, 9455.858162127712, 9475.52622368865, 9521.476318802532, 9551.952240238754, 9565.04349565038, 8398.41211115216, 8575.399722019649, 8581.828363432822, 8673.696420625249, 8687.86968195465, 8125.959370203112, 8212.46618969765, 8421.0, 8442.577871106543, 8564.05795362522, 7121.181064177686, 7199.640017998974, 7199.640017999184, 7201.783946481614, 7215.0, 5311.994891545059, 5346.385165705994, 5347.1979203119845, 5476.507114359727, 5543.52880005204, 5458.399576046552, 5616.69108199053, 5668.3198016236665, 5682.829515114553, 5782.566307527037], "value": 5109.784163491815, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.91443310306215, 329.4070672788979, 330.786642615513, 337.7821305258109, 338.723939988909, 5381.165919282507, 5420.376656684482, 5435.510804027636, 5444.727763611819, 5491.588130890179, 5074.416442109158, 5193.324867767185, 5229.267902493654, 5245.239440281157, 5384.488473595012, 4019.31671615826, 4078.0620457294913, 4124.855630052949, 4159.376093585956, 4190.2248084104385, 4118.135191609751, 4140.213359461693, 4157.815022718526, 4167.708260421772, 4169.207850508409, 4074.9388759168637, 4077.7757223352705, 4128.896777580554, 4159.896002599944, 4165.729227600212, 4124.484439445069, 4128.979355103235, 4137.6482998944975, 4153.79539933419, 4158.438610787535, 3668.5414323209598, 3675.9081022974638, 3687.6865466435383, 3701.9259614807825, 3702.87039953603, 5032.899342013139, 5065.088284108859, 5099.643024988252, 5102.770375333119, 5131.461196574343, 4723.527647235283, 4734.124187025412, 4742.719465744264, 4751.596114330286, 4793.3768610080815, 5496.697681627509, 5545.417731138253, 5553.444655534455, 5561.443855614406, 5608.803691870765, 3768.9623103768886, 4040.454538637305, 4044.624827558644, 4046.291898917707, 4047.7368971017086, 5785.421457854223, 5818.389069147721, 5836.649801011953, 5845.795397161079, 5855.297364316267, 4035.9192816143513, 4057.5739547347102, 4057.69567282455, 4061.7766022868436, 4061.9593804061583, 4121.814518346681, 4128.752274863517, 4131.462909821704, 4139.985703502661, 4141.171765646883, 4520.751358675305, 4699.882502937386, 4718.433787945469, 4718.764061796896, 4734.881627959328, 5645.943540564624, 5652.547796176296, 5655.236543066716, 5667.263255776805, 5672.319321681424, 1339.5666636698834, 1385.9605296027978, 1402.5441731437325, 1405.5150972914328, 1408.6900881805987, 876.8071024374627, 907.5961197267285, 915.1671978499534, 923.676713150392, 927.4991504587582, 4906.9263961040615, 4972.353594032825, 5000.374953130859, 5045.091883461012, 5101.923471147936, 5177.99029189312, 5204.42751297357, 5206.479352064764, 5220.556252718486, 5255.710935898563, 4927.211646136601, 4937.333459982929, 4957.405111386656, 4982.626303027288, 5204.271402003723, 3070.5854709614364, 3070.7256488557446, 3093.9381212376074, 3095.257138286795, 3102.6419920859857, 6092.172348295494, 6100.786472473442, 6114.296855861633, 6122.632642041492, 6137.171481849893, 5641.717914104278, 5879.617824841372, 5905.173275741399, 5914.284857391394, 5929.495992840657, 6038.879222415615, 6080.2399700037495, 6092.1775560299675, 6099.786507472217, 6111.280480186275, 5545.835374571224, 5789.1895134680335, 5800.810833779149, 5846.924341858749, 5861.736221869941, 5682.715864206856, 5686.886262274648, 5703.458171473703, 5715.714214289185, 5716.28546431696, 6101.816945491642, 6148.047052706837, 6158.291796443466, 6163.137160797402, 6174.0, 3946.5264168299987, 3993.101552150859, 4068.450759147477, 4095.7542547447247, 4101.764538326679, 5596.300462442195, 5838.211841401357, 5861.479563787612, 5874.471297583238, 5885.558583106199, 5606.943930560642, 5628.774849005994, 5653.208550802973, 5671.688057156896, 5740.39725828782, 5620.04459241938, 5637.577181711306, 5695.117256825033, 5701.287339082614, 5728.0, 5359.303290572357, 5590.413006634245, 5606.439356064361, 5633.492985631149, 5642.266505354278, 5633.0705433603, 5695.658260504383, 5711.0, 5713.8285851424525, 5732.197492351158, 5463.562914966714, 5550.694711790728, 5563.443655634566, 5563.7496312666835, 5571.275734154534], "value": 4249.356189072908, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.4176913506841, 835.2357592802585, 872.5375550957992, 887.9467231966087, 915.7847905742151, 15090.849091509082, 15754.76367854483, 16944.915275423606, 17185.312587496515, 17252.74120888186, 14946.626334341647, 15071.547853564383, 15081.321340539675, 15089.471868484577, 15090.17004064776, 712.2201189697299, 827.1356432528023, 857.3955361470164, 868.8696695495695, 871.3290766110091, 873.9169778870997, 883.7746374674481, 884.4295429448002, 884.5754038061734, 884.703624285865, 906.5421961909227, 911.6171208092617, 912.320321360584, 913.0458670689146, 913.5067063785548, 749.6364263332307, 853.8889944307263, 908.927285817133, 910.5037754423822, 912.5528491039342, 660.5112216959463, 664.1167247560733, 664.9501287403416, 665.424407887179, 666.6200265848469, 15788.210589470595, 15896.602584935354, 15914.681706365807, 15933.123678197695, 15959.0, 14586.0, 14806.333714982851, 15086.54740357791, 15109.244537773176, 15310.311036003295, 13804.309784510735, 13982.860171398359, 14009.299535023209, 14164.645883852987, 14331.928340358232, 4601.976990115061, 4673.88315292117, 4690.648201384875, 4748.19280722278, 4794.976025119852, 73395.26604733992, 74680.62659686721, 81008.0, 81205.59397203036, 85362.99999999937, 13058.542950996669, 13126.934365328112, 13506.93246533761, 13807.654808629664, 14136.787948180785, 23540.940657670446, 23563.293101206993, 23593.174238901556, 23607.527849442915, 23707.0, 9390.67132650354, 9554.092361225672, 9700.369475984038, 9715.224479809029, 10160.0, 5206.7917283309, 5345.091334473072, 5345.9732701337025, 5382.300300960928, 5540.639858409271, 3737.0844143185095, 3811.313963486599, 3841.7310788244554, 3849.615038496128, 3851.441540976543, 700.4011570107587, 704.0671110778239, 713.051641317047, 720.7909706185147, 721.5742711800063, 791.125805984379, 808.4138999225514, 808.8058865872148, 837.535167981776, 860.2558786649628, 10502.527386267637, 10576.312539684895, 10743.731406714738, 10854.67435976922, 10949.507272172772, 711.3597762014228, 712.2521352579771, 742.5989965418613, 809.2797410304834, 816.7019038051187, 4652.976735116303, 4709.411323584552, 4792.0895029944195, 4925.1381008324115, 5046.84859454217, 75449.24550754423, 115970.42014790041, 117363.41318293524, 119268.0, 123184.0, 98480.50759746156, 98633.50683246681, 99509.0, 100073.0, 100747.49626251822, 72473.0, 87812.99999999872, 87854.56072719724, 88232.55883720668, 88871.55564222137, 9333.486658233862, 9418.434893906388, 9429.43423394571, 9499.715008549754, 9619.159017466161, 51590.0, 52255.73872130615, 52925.0, 54093.0, 54413.0, 74566.25433745593, 75805.24194757982, 76415.0, 78309.0, 78483.60758196173, 13666.794998074838, 13856.30718464093, 13886.93056534711, 13904.165750055028, 13937.721245575234, 14880.62798430048, 15023.849761502683, 15260.465883694018, 15691.372345106069, 15868.52394428169, 13215.867841321848, 13337.66655833612, 13752.243626600633, 13825.239611821446, 14214.28928553589, 13801.723965520834, 13946.0, 14217.715645687234, 14264.572062838131, 14493.85506144925, 13615.387307570985, 14063.226522540948, 14075.436982520585, 14090.436382544583, 14630.122192668474, 10871.565137394731, 11055.778884422105, 11154.721131971766, 11285.71785705364, 11343.886561134283, 11434.542618295174, 11505.809864386742, 11551.306921584395, 11798.174127810971, 11819.231749936227], "value": 8049.307529601034, "unit": "score"}], "name": "dromaeo_css", "value": 7567.3062763957305, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 111.0, 112.0, 111.0, 111.0, 109.0, 109.0, 111.0, 108.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 129.0, 186.0, 124.0, 124.0, 158.0, 130.0, 154.0, 122.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 160.0, 160.0, 160.0, 162.0, 162.0, 161.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 124.0, 75.0, 75.0, 75.0, 75.0, 120.0, 74.0], "value": 84.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 110.0, 83.0, 84.0, 86.0, 130.0, 85.0, 84.0, 124.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 53.0, 53.0, 54.0, 52.0, 53.0, 52.0, 53.0, 51.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 81.0, 83.0, 76.0, 78.0, 77.0, 108.0, 76.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 116.0, 120.0, 125.0, 114.0, 115.0, 126.0, 120.0, 125.0, 119.0], "value": 120.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 156.0, 160.0, 155.0, 155.0, 159.0, 155.0, 154.0, 152.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 64.0, 67.0, 62.0, 61.0, 61.0, 61.0, 62.0, 63.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1479.9, "alertThreshold": 2.0}]} 03:46:40 INFO - Return code: 0 03:46:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:46:40 ERROR - # TBPL SUCCESS # 03:46:40 INFO - Running post-action listener: _resource_record_post_action 03:46:40 INFO - ##### 03:46:40 INFO - ##### Finished run-tests step (success) 03:46:40 INFO - ##### 03:46:40 INFO - Running post-run listener: _resource_record_post_run 03:46:40 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 290816; Write bytes: 507842560; Read time: 68; Write time: 317632 03:46:40 INFO - TinderboxPrint: CPU usage
13.0% 03:46:40 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 68 03:46:40 INFO - TinderboxPrint: I/O write bytes / time
507,842,560 / 317,632 03:46:40 INFO - TinderboxPrint: CPU idle
8,252.3 (87.0%) 03:46:40 INFO - TinderboxPrint: CPU user
1,194.8 (12.6%) 03:46:40 INFO - TinderboxPrint: Swap in / out
0 / 0 03:46:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 252846080; Read time: 0; Write time: 178412 03:46:40 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 254996480; Read time: 52; Write time: 139220 03:46:41 INFO - Running post-run listener: _upload_blobber_files 03:46:41 INFO - Blob upload gear active. 03:46:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:46:41 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:46:41 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:46:41 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:46:41 INFO - (blobuploader) - INFO - Open directory for files ... 03:46:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:46:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:46:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:42 INFO - (blobuploader) - INFO - Done attempting. 03:46:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:46:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:46:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:43 INFO - (blobuploader) - INFO - Done attempting. 03:46:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:46:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:46:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:46 INFO - (blobuploader) - INFO - Done attempting. 03:46:46 INFO - (blobuploader) - INFO - Iteration through files over. 03:46:46 INFO - Return code: 0 03:46:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:46:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:46:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be1aa48a57f9d22abb75ea8a6f633201e8ff2de1731a6381f1013562facd5f1b9c9c644f88548a2fa7801d5bce39db00d1164179cf7f17ef2f6ebf78a546e9e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf407b6b5f4dde9e7bac3cce1238e44518727aadb1c58fa6c6aa0ef7831a9b5ae919f1af2119c13bbf7f29087f7daab1fae3cb2955a6cb111e83179b87a38d65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/207b26be858fb0cd7c2a1e67eca8f64cedc00344e9e62f71dea52065db7dd770d09526a669811ca784efbb03551122dcebcb2ef0d09a6bef714ec6e9ab7573b8"} 03:46:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:46:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:46:46 INFO - Contents: 03:46:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be1aa48a57f9d22abb75ea8a6f633201e8ff2de1731a6381f1013562facd5f1b9c9c644f88548a2fa7801d5bce39db00d1164179cf7f17ef2f6ebf78a546e9e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf407b6b5f4dde9e7bac3cce1238e44518727aadb1c58fa6c6aa0ef7831a9b5ae919f1af2119c13bbf7f29087f7daab1fae3cb2955a6cb111e83179b87a38d65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/207b26be858fb0cd7c2a1e67eca8f64cedc00344e9e62f71dea52065db7dd770d09526a669811ca784efbb03551122dcebcb2ef0d09a6bef714ec6e9ab7573b8"} 03:46:46 INFO - Running post-run listener: copy_logs_to_upload_dir 03:46:46 INFO - Copying logs to upload dir... 03:46:46 INFO - mkdir: /builds/slave/test/build/upload/logs 03:46:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.510084 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-07 03:46:46.520759) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 03:46:46.524716) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544 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/be1aa48a57f9d22abb75ea8a6f633201e8ff2de1731a6381f1013562facd5f1b9c9c644f88548a2fa7801d5bce39db00d1164179cf7f17ef2f6ebf78a546e9e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf407b6b5f4dde9e7bac3cce1238e44518727aadb1c58fa6c6aa0ef7831a9b5ae919f1af2119c13bbf7f29087f7daab1fae3cb2955a6cb111e83179b87a38d65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/207b26be858fb0cd7c2a1e67eca8f64cedc00344e9e62f71dea52065db7dd770d09526a669811ca784efbb03551122dcebcb2ef0d09a6bef714ec6e9ab7573b8"} build_url:https://queue.taskcluster.net/v1/task/fWcnfttYSVOFDEbJzXpbYg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/fWcnfttYSVOFDEbJzXpbYg/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/be1aa48a57f9d22abb75ea8a6f633201e8ff2de1731a6381f1013562facd5f1b9c9c644f88548a2fa7801d5bce39db00d1164179cf7f17ef2f6ebf78a546e9e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf407b6b5f4dde9e7bac3cce1238e44518727aadb1c58fa6c6aa0ef7831a9b5ae919f1af2119c13bbf7f29087f7daab1fae3cb2955a6cb111e83179b87a38d65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/207b26be858fb0cd7c2a1e67eca8f64cedc00344e9e62f71dea52065db7dd770d09526a669811ca784efbb03551122dcebcb2ef0d09a6bef714ec6e9ab7573b8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 03:46:46.550395) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 03:46:46.550759) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467887159.453887-1698156544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 03:46:46.636428) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 03:46:46.636750) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 03:46:46.637046) ========= ========= Total master_lag: 0.18 =========