builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1469447100.26 results: success (0) buildid: 20160725020629 builduid: e9cffd69a2054ead90893fbe00f05894 revision: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 04:45:00.258121) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 04:45:00.258601) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 04:45:00.258903) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 04:45:00.304602) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:45:00.304958) ========= 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=ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 04:45: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-07-25 04:45:00 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190222 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:45:00.533004) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:45:00.533327) ========= 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=ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.050556 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:45:00.594855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:45:00.595242) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 --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 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 --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=ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 04:45:00,630 truncating revision to first 12 chars 2016-07-25 04:45:00,630 Setting DEBUG logging. 2016-07-25 04:45:00,630 attempt 1/10 2016-07-25 04:45:00,630 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/517663b29d7f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 04:45:00,949 unpacking tar archive at: mozilla-aurora-517663b29d7f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660509 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:45:01.268979) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 04:45:01.269311) ========= script_repo_revision: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 04:45:01.269724) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 04:45:01.269987) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 04:45:01.279347) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-07-25 04:45:01.279645) ========= /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=ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:45:01 INFO - MultiFileLogger online at 20160725 04:45:01 in /builds/slave/test 04:45:01 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 04:45:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:45:01 INFO - {'append_to_log': False, 04:45:01 INFO - 'base_work_dir': '/builds/slave/test', 04:45:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:45:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:45:01 INFO - 'branch': 'Mozilla-Aurora', 04:45:01 INFO - 'buildbot_json_path': 'buildprops.json', 04:45:01 INFO - 'config_files': ('talos/linux_config.py',), 04:45:01 INFO - 'default_actions': ('clobber', 04:45:01 INFO - 'read-buildbot-config', 04:45:01 INFO - 'download-and-extract', 04:45:01 INFO - 'populate-webroot', 04:45:01 INFO - 'create-virtualenv', 04:45:01 INFO - 'install', 04:45:01 INFO - 'run-tests'), 04:45:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:45:01 INFO - 'download_minidump_stackwalk': True, 04:45:01 INFO - 'download_symbols': 'ondemand', 04:45:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:45:01 INFO - 'tooltool.py': '/tools/tooltool.py', 04:45:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:45:01 INFO - '/tools/misc-python/virtualenv.py')}, 04:45:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:45:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:45:01 INFO - 'installer_path': 'installer.exe', 04:45:01 INFO - 'log_level': 'info', 04:45:01 INFO - 'log_name': 'talos', 04:45:01 INFO - 'log_to_console': True, 04:45:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:45:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:45:01 INFO - 'opt_config_files': (), 04:45:01 INFO - 'pip_index': False, 04:45:01 INFO - 'sps_profile': False, 04:45:01 INFO - 'sps_profile_interval': 0, 04:45:01 INFO - 'suite': 'dromaeojs', 04:45:01 INFO - 'system_bits': '32', 04:45:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:45:01 INFO - 'title': 'talos-linux64-ix-035', 04:45:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:45:01 INFO - 'use_talos_json': True, 04:45:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:45:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:45:01 INFO - 'work_dir': 'build'} 04:45:01 INFO - ##### 04:45:01 INFO - ##### Running clobber step. 04:45:01 INFO - ##### 04:45:01 INFO - Running pre-action listener: _resource_record_pre_action 04:45:01 INFO - Running main action method: clobber 04:45:01 INFO - rmtree: /builds/slave/test/build 04:45:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:45:03 INFO - Running post-action listener: _resource_record_post_action 04:45:03 INFO - ##### 04:45:03 INFO - ##### Finished clobber step (success) 04:45:03 INFO - ##### 04:45:03 INFO - ##### 04:45:03 INFO - ##### Running read-buildbot-config step. 04:45:03 INFO - ##### 04:45:03 INFO - Running pre-action listener: _resource_record_pre_action 04:45:03 INFO - Running main action method: read_buildbot_config 04:45:03 INFO - Using buildbot properties: 04:45:03 INFO - { 04:45:03 INFO - "project": "", 04:45:03 INFO - "product": "firefox", 04:45:03 INFO - "script_repo_revision": "production", 04:45:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:45:03 INFO - "repository": "", 04:45:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:45:03 INFO - "buildid": "20160725020629", 04:45:03 INFO - "pgo_build": "True", 04:45:03 INFO - "basedir": "/builds/slave/test", 04:45:03 INFO - "buildnumber": 384, 04:45:03 INFO - "slavename": "talos-linux64-ix-035", 04:45:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:45:03 INFO - "platform": "ubuntu64_hw", 04:45:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:45:03 INFO - "branch": "mozilla-aurora", 04:45:03 INFO - "repo_path": "releases/mozilla-aurora", 04:45:03 INFO - "revision": "517663b29d7ffc2ce91f90dc7beaac4fa35e52e5", 04:45:03 INFO - "stage_platform": "linux64-pgo", 04:45:03 INFO - "builduid": "e9cffd69a2054ead90893fbe00f05894", 04:45:03 INFO - "slavebuilddir": "test" 04:45:03 INFO - } 04:45:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 04:45:03 INFO - Running post-action listener: _resource_record_post_action 04:45:03 INFO - ##### 04:45:03 INFO - ##### Finished read-buildbot-config step (success) 04:45:03 INFO - ##### 04:45:03 INFO - ##### 04:45:03 INFO - ##### Running download-and-extract step. 04:45:03 INFO - ##### 04:45:03 INFO - Running pre-action listener: _resource_record_pre_action 04:45:03 INFO - Running main action method: download_and_extract 04:45:03 INFO - mkdir: /builds/slave/test/build/tests 04:45:03 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')]} 04:45:03 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:45:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:45:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:45:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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 04:45:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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 04:45:08 INFO - Downloaded 1361 bytes. 04:45:08 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:45:08 INFO - Using the following test package requirements: 04:45:08 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:45:08 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:45:08 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:45:08 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:08 INFO - u'jsshell-linux-x86_64.zip'], 04:45:08 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:45:08 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:45:08 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:45:08 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:45:08 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:45:08 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:45:08 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:08 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:45:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:45:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:45:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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 04:45:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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 04:45:18 INFO - Downloaded 24494715 bytes. 04:45:18 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'] 04:45:18 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 04:45:20 INFO - Return code: 0 04:45:20 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 04:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:20 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:45:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:45:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:45:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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 04:45:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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 04:45:22 INFO - Downloaded 24494715 bytes. 04:45: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'] 04:45: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 04:45:24 INFO - Return code: 0 04:45: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')]} 04:45:24 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:45:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:45:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:45:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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 04:45:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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 04:45:26 INFO - Downloaded 10833369 bytes. 04:45:26 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'] 04:45:26 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 04:45:26 INFO - Return code: 0 04:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:26 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:45:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:45:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:45:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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 04:45:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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 04:45:28 INFO - Downloaded 63633994 bytes. 04:45:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:45:28 INFO - mkdir: /builds/slave/test/properties 04:45:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:45:28 INFO - Writing to file /builds/slave/test/properties/build_url 04:45:28 INFO - Contents: 04:45:28 INFO - build_url:https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:45:28 INFO - Running post-action listener: _resource_record_post_action 04:45:28 INFO - Running post-action listener: set_extra_try_arguments 04:45:28 INFO - ##### 04:45:28 INFO - ##### Finished download-and-extract step (success) 04:45:28 INFO - ##### 04:45:28 INFO - ##### 04:45:28 INFO - ##### Running populate-webroot step. 04:45:28 INFO - ##### 04:45:28 INFO - Running pre-action listener: _resource_record_pre_action 04:45:28 INFO - Running main action method: populate_webroot 04:45:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:45:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:45:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:45:28 INFO - '--tppagecycles', 04:45:28 INFO - '7'], 04:45:28 INFO - 'tests': ['tsvgm']}}, 04:45:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:45:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:45:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:45:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:45:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:45:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:45:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:28 INFO - 'talos_options': ['--disable-e10s'], 04:45:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:28 INFO - 'talos_options': ['--disable-e10s'], 04:45:28 INFO - 'tests': ['damp', 'tps']}, 04:45:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:28 INFO - 'tests': ['damp', 'tps']}, 04:45:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:45:28 INFO - 'tests': ['dromaeo_dom']}, 04:45:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:45:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:45:28 INFO - 'tests': ['a11yr', 04:45:28 INFO - 'ts_paint', 04:45:28 INFO - 'tpaint', 04:45:28 INFO - 'sessionrestore', 04:45:28 INFO - 'sessionrestore_no_auto_restore', 04:45:28 INFO - 'tabpaint']}, 04:45:28 INFO - 'other-e10s': {'tests': ['a11yr', 04:45:28 INFO - 'ts_paint', 04:45:28 INFO - 'tpaint', 04:45:28 INFO - 'sessionrestore', 04:45:28 INFO - 'sessionrestore_no_auto_restore', 04:45:28 INFO - 'tabpaint']}, 04:45:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:45:28 INFO - 'ts_paint', 04:45:28 INFO - 'tpaint', 04:45:28 INFO - 'sessionrestore', 04:45:28 INFO - 'sessionrestore_no_auto_restore', 04:45:28 INFO - 'tabpaint']}, 04:45:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:45:28 INFO - 'ts_paint', 04:45:28 INFO - 'tpaint', 04:45:28 INFO - 'sessionrestore', 04:45:28 INFO - 'sessionrestore_no_auto_restore', 04:45:28 INFO - 'tabpaint']}, 04:45:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:45:28 INFO - 'tests': ['a11yr', 04:45:28 INFO - 'ts_paint', 04:45:28 INFO - 'tpaint', 04:45:28 INFO - 'sessionrestore', 04:45:28 INFO - 'sessionrestore_no_auto_restore', 04:45:28 INFO - 'tabpaint']}, 04:45:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:45:28 INFO - 'tests': ['a11yr', 04:45:28 INFO - 'ts_paint', 04:45:28 INFO - 'tpaint', 04:45:28 INFO - 'sessionrestore', 04:45:28 INFO - 'sessionrestore_no_auto_restore', 04:45:28 INFO - 'tabpaint']}, 04:45:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:45:28 INFO - 'tests': ['tsvgx', 04:45:28 INFO - 'tsvgr_opacity', 04:45:28 INFO - 'tart', 04:45:28 INFO - 'tscrollx', 04:45:28 INFO - 'cart']}, 04:45:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:45:28 INFO - 'tsvgr_opacity', 04:45:28 INFO - 'tart', 04:45:28 INFO - 'tscrollx', 04:45:28 INFO - 'cart']}, 04:45:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:28 INFO - 'talos_options': ['--disable-e10s'], 04:45:28 INFO - 'tests': ['tp5o']}, 04:45:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:28 INFO - 'tests': ['tp5o']}, 04:45:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:28 INFO - 'talos_options': ['--disable-e10s', 04:45:28 INFO - '--xperf_path', 04:45:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:28 INFO - 'tests': ['tp5n']}, 04:45:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:28 INFO - 'talos_options': ['--xperf_path', 04:45:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:28 INFO - 'tests': ['tp5n']}}, 04:45:28 INFO - 'talos.zip': {'path': '', 04:45:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:45:28 INFO - Running post-action listener: _resource_record_post_action 04:45:28 INFO - ##### 04:45:28 INFO - ##### Finished populate-webroot step (success) 04:45:28 INFO - ##### 04:45:28 INFO - ##### 04:45:28 INFO - ##### Running create-virtualenv step. 04:45:28 INFO - ##### 04:45:28 INFO - Running pre-action listener: _resource_record_pre_action 04:45:28 INFO - Running main action method: create_virtualenv 04:45:28 INFO - Creating virtualenv /builds/slave/test/build/venv 04:45:28 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 04:45:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:45:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:45:29 INFO - Using real prefix '/usr' 04:45:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:45:30 INFO - Installing distribute.............................................................................................................................................................................................done. 04:45:32 INFO - Installing pip.................done. 04:45:32 INFO - Return code: 0 04:45:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e181b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7a1c0>, '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 0xf7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', '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 04:45: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', 'pip>=1.5'] in /builds/slave/test/build 04:45: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 pip>=1.5 04:45:32 INFO - Using env: {'DISPLAY': ':0', 04:45:32 INFO - 'HOME': '/home/cltbld', 04:45:32 INFO - 'LANG': 'en_US.UTF-8', 04:45:32 INFO - 'LANGUAGE': 'en_US:en', 04:45:32 INFO - 'LOGNAME': 'cltbld', 04:45:32 INFO - 'MAIL': '/var/mail/cltbld', 04:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:32 INFO - 'MOZ_NO_REMOTE': '1', 04:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:32 INFO - 'NO_EM_RESTART': '1', 04:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:32 INFO - 'PWD': '/builds/slave/test', 04:45:32 INFO - 'SHELL': '/bin/bash', 04:45:32 INFO - 'SHLVL': '1', 04:45:32 INFO - 'TERM': 'linux', 04:45:32 INFO - 'TMOUT': '86400', 04:45:32 INFO - 'USER': 'cltbld', 04:45:32 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', 04:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:32 INFO - '_': '/tools/buildbot/bin/python'} 04:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:32 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 04:45:32 INFO - Cleaning up... 04:45:32 INFO - Return code: 0 04:45:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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', '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 0x7f3e181b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7a1c0>, '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 0xf7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', '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 04:45: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:45: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 psutil>=3.1.1 04:45:32 INFO - Using env: {'DISPLAY': ':0', 04:45:32 INFO - 'HOME': '/home/cltbld', 04:45:32 INFO - 'LANG': 'en_US.UTF-8', 04:45:32 INFO - 'LANGUAGE': 'en_US:en', 04:45:32 INFO - 'LOGNAME': 'cltbld', 04:45:32 INFO - 'MAIL': '/var/mail/cltbld', 04:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:32 INFO - 'MOZ_NO_REMOTE': '1', 04:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:32 INFO - 'NO_EM_RESTART': '1', 04:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:32 INFO - 'PWD': '/builds/slave/test', 04:45:32 INFO - 'SHELL': '/bin/bash', 04:45:32 INFO - 'SHLVL': '1', 04:45:32 INFO - 'TERM': 'linux', 04:45:32 INFO - 'TMOUT': '86400', 04:45:32 INFO - 'USER': 'cltbld', 04:45:32 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', 04:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:32 INFO - '_': '/tools/buildbot/bin/python'} 04:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:32 INFO - Downloading/unpacking psutil>=3.1.1 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:45:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:34 INFO - Installing collected packages: psutil 04:45:34 INFO - Running setup.py install for psutil 04:45:35 INFO - building 'psutil._psutil_linux' extension 04:45:35 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 04:45:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:45:36 INFO - building 'psutil._psutil_posix' extension 04:45:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:45:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:45:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:36 INFO - Successfully installed psutil 04:45:36 INFO - Cleaning up... 04:45:36 INFO - Return code: 0 04:45:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:45:36 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')]} 04:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:36 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')]} 04:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:36 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 0x7f3e181b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7a1c0>, '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 0xf7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', '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 04:45:36 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 04:45:36 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 04:45:36 INFO - Using env: {'DISPLAY': ':0', 04:45:36 INFO - 'HOME': '/home/cltbld', 04:45:36 INFO - 'LANG': 'en_US.UTF-8', 04:45:36 INFO - 'LANGUAGE': 'en_US:en', 04:45:36 INFO - 'LOGNAME': 'cltbld', 04:45:36 INFO - 'MAIL': '/var/mail/cltbld', 04:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:36 INFO - 'MOZ_NO_REMOTE': '1', 04:45:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:36 INFO - 'NO_EM_RESTART': '1', 04:45:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:36 INFO - 'PWD': '/builds/slave/test', 04:45:36 INFO - 'SHELL': '/bin/bash', 04:45:36 INFO - 'SHLVL': '1', 04:45:36 INFO - 'TERM': 'linux', 04:45:36 INFO - 'TMOUT': '86400', 04:45:36 INFO - 'USER': 'cltbld', 04:45:36 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', 04:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:36 INFO - '_': '/tools/buildbot/bin/python'} 04:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:45:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:45:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:45:39 INFO - Installing collected packages: mozsystemmonitor 04:45:39 INFO - Running setup.py install for mozsystemmonitor 04:45:39 INFO - Successfully installed mozsystemmonitor 04:45:39 INFO - Cleaning up... 04:45:39 INFO - Return code: 0 04:45:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e181b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7a1c0>, '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 0xf7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', '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 04:45:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:45:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:45:39 INFO - Using env: {'DISPLAY': ':0', 04:45:39 INFO - 'HOME': '/home/cltbld', 04:45:39 INFO - 'LANG': 'en_US.UTF-8', 04:45:39 INFO - 'LANGUAGE': 'en_US:en', 04:45:39 INFO - 'LOGNAME': 'cltbld', 04:45:39 INFO - 'MAIL': '/var/mail/cltbld', 04:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:39 INFO - 'MOZ_NO_REMOTE': '1', 04:45:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:39 INFO - 'NO_EM_RESTART': '1', 04:45:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:39 INFO - 'PWD': '/builds/slave/test', 04:45:39 INFO - 'SHELL': '/bin/bash', 04:45:39 INFO - 'SHLVL': '1', 04:45:39 INFO - 'TERM': 'linux', 04:45:39 INFO - 'TMOUT': '86400', 04:45:39 INFO - 'USER': 'cltbld', 04:45:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', 04:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:39 INFO - '_': '/tools/buildbot/bin/python'} 04:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:39 INFO - Downloading/unpacking jsonschema==2.5.1 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:45:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:41 INFO - Downloading functools32-3.2.3-2.tar.gz 04:45:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:45:41 INFO - warning: no files found matching '*.txt' 04:45:41 INFO - no previously-included directories found matching 'build' 04:45:41 INFO - no previously-included directories found matching 'dist' 04:45:41 INFO - no previously-included directories found matching '.git*' 04:45:41 INFO - Installing collected packages: jsonschema, functools32 04:45:41 INFO - Running setup.py install for functools32 04:45:41 INFO - warning: no files found matching '*.txt' 04:45:41 INFO - no previously-included directories found matching 'build' 04:45:41 INFO - no previously-included directories found matching 'dist' 04:45:41 INFO - no previously-included directories found matching '.git*' 04:45:41 INFO - Successfully installed jsonschema functools32 04:45:41 INFO - Cleaning up... 04:45:41 INFO - Return code: 0 04:45:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:45:41 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')]} 04:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:41 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')]} 04:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:41 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 0x7f3e181b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7a1c0>, '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 0xf7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', '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 04:45:41 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 04:45:41 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 04:45:41 INFO - Using env: {'DISPLAY': ':0', 04:45:41 INFO - 'HOME': '/home/cltbld', 04:45:41 INFO - 'LANG': 'en_US.UTF-8', 04:45:41 INFO - 'LANGUAGE': 'en_US:en', 04:45:41 INFO - 'LOGNAME': 'cltbld', 04:45:41 INFO - 'MAIL': '/var/mail/cltbld', 04:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:41 INFO - 'MOZ_NO_REMOTE': '1', 04:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:41 INFO - 'NO_EM_RESTART': '1', 04:45:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:41 INFO - 'PWD': '/builds/slave/test', 04:45:41 INFO - 'SHELL': '/bin/bash', 04:45:41 INFO - 'SHLVL': '1', 04:45:41 INFO - 'TERM': 'linux', 04:45:41 INFO - 'TMOUT': '86400', 04:45:41 INFO - 'USER': 'cltbld', 04:45:41 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', 04:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:41 INFO - '_': '/tools/buildbot/bin/python'} 04:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:42 INFO - Downloading/unpacking blobuploader==1.2.4 04:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:43 INFO - Downloading blobuploader-1.2.4.tar.gz 04:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:45:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:45:43 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 04:45:43 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 04:45:43 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 04:45:43 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 04:45:43 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 04:45:43 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 04:45:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:45:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:44 INFO - Downloading docopt-0.6.1.tar.gz 04:45:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:45:44 INFO - Installing collected packages: blobuploader, requests, docopt 04:45:44 INFO - Running setup.py install for blobuploader 04:45:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:45:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:45:44 INFO - Running setup.py install for requests 04:45:45 INFO - Running setup.py install for docopt 04:45:45 INFO - Successfully installed blobuploader requests docopt 04:45:45 INFO - Cleaning up... 04:45:45 INFO - Return code: 0 04:45:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e181b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7a1c0>, '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 0xf7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', '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 04:45:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:45:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:45:45 INFO - Using env: {'DISPLAY': ':0', 04:45:45 INFO - 'HOME': '/home/cltbld', 04:45:45 INFO - 'LANG': 'en_US.UTF-8', 04:45:45 INFO - 'LANGUAGE': 'en_US:en', 04:45:45 INFO - 'LOGNAME': 'cltbld', 04:45:45 INFO - 'MAIL': '/var/mail/cltbld', 04:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:45 INFO - 'MOZ_NO_REMOTE': '1', 04:45:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:45 INFO - 'NO_EM_RESTART': '1', 04:45:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:45 INFO - 'PWD': '/builds/slave/test', 04:45:45 INFO - 'SHELL': '/bin/bash', 04:45:45 INFO - 'SHLVL': '1', 04:45:45 INFO - 'TERM': 'linux', 04:45:45 INFO - 'TMOUT': '86400', 04:45:45 INFO - 'USER': 'cltbld', 04:45:45 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', 04:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:45 INFO - '_': '/tools/buildbot/bin/python'} 04:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:45 INFO - Running setup.py (path:/tmp/pip-_JmdKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:45 INFO - Running setup.py (path:/tmp/pip-DgGE0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:45 INFO - Running setup.py (path:/tmp/pip-q3MWam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:45 INFO - Running setup.py (path:/tmp/pip-EtOXni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:45 INFO - Running setup.py (path:/tmp/pip-q12fO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:45 INFO - Running setup.py (path:/tmp/pip-dRjFe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:45 INFO - Running setup.py (path:/tmp/pip-R7CCK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:46 INFO - Running setup.py (path:/tmp/pip-ym8G7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:46 INFO - Running setup.py (path:/tmp/pip-UEIY2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:46 INFO - Running setup.py (path:/tmp/pip-bQKkJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:46 INFO - Running setup.py (path:/tmp/pip-lKXhJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:46 INFO - Running setup.py (path:/tmp/pip-eFZCCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:46 INFO - Running setup.py (path:/tmp/pip-ySEu1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:46 INFO - Running setup.py (path:/tmp/pip-w8H0mN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:46 INFO - Running setup.py (path:/tmp/pip-gJ1zOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:46 INFO - Running setup.py (path:/tmp/pip-g6bzsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:46 INFO - Running setup.py (path:/tmp/pip-_V0x2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:45:46 INFO - Running setup.py install for manifestparser 04:45:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:45:46 INFO - Running setup.py install for mozcrash 04:45:46 INFO - Running setup.py install for mozdebug 04:45:47 INFO - Running setup.py install for mozdevice 04:45:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:45:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:45:47 INFO - Running setup.py install for mozfile 04:45:47 INFO - Running setup.py install for mozhttpd 04:45:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:45:47 INFO - Running setup.py install for mozinfo 04:45:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:45:47 INFO - Running setup.py install for mozInstall 04:45:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:45:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:45:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:45:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:45:47 INFO - Running setup.py install for mozleak 04:45:47 INFO - Running setup.py install for mozlog 04:45:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:45:47 INFO - Running setup.py install for moznetwork 04:45:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:45:47 INFO - Running setup.py install for mozprocess 04:45:47 INFO - Running setup.py install for mozprofile 04:45:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:45:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:45:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:45:48 INFO - Running setup.py install for mozrunner 04:45:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:45:48 INFO - Running setup.py install for mozscreenshot 04:45:48 INFO - Running setup.py install for moztest 04:45:48 INFO - Running setup.py install for mozversion 04:45:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:45:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:45:48 INFO - Cleaning up... 04:45:48 INFO - Return code: 0 04:45:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e181b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7a1c0>, '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 0xf7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', '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 04:45:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:45:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:45:48 INFO - Using env: {'DISPLAY': ':0', 04:45:48 INFO - 'HOME': '/home/cltbld', 04:45:48 INFO - 'LANG': 'en_US.UTF-8', 04:45:48 INFO - 'LANGUAGE': 'en_US:en', 04:45:48 INFO - 'LOGNAME': 'cltbld', 04:45:48 INFO - 'MAIL': '/var/mail/cltbld', 04:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:48 INFO - 'MOZ_NO_REMOTE': '1', 04:45:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:48 INFO - 'NO_EM_RESTART': '1', 04:45:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:48 INFO - 'PWD': '/builds/slave/test', 04:45:48 INFO - 'SHELL': '/bin/bash', 04:45:48 INFO - 'SHLVL': '1', 04:45:48 INFO - 'TERM': 'linux', 04:45:48 INFO - 'TMOUT': '86400', 04:45:48 INFO - 'USER': 'cltbld', 04:45:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', 04:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:48 INFO - '_': '/tools/buildbot/bin/python'} 04:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:48 INFO - Running setup.py (path:/tmp/pip-QjvZXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:48 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)) 04:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:48 INFO - Running setup.py (path:/tmp/pip-mjmoR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:48 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)) 04:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:48 INFO - Running setup.py (path:/tmp/pip-UAXPSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:48 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)) 04:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:48 INFO - Running setup.py (path:/tmp/pip-OqDu35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:49 INFO - Running setup.py (path:/tmp/pip-uqDIfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:49 INFO - Running setup.py (path:/tmp/pip-pmpyTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:49 INFO - Running setup.py (path:/tmp/pip-AQNZNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:49 INFO - Running setup.py (path:/tmp/pip-2wSXTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:49 INFO - Running setup.py (path:/tmp/pip-rJzRqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:49 INFO - Running setup.py (path:/tmp/pip-pW_Vam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:49 INFO - Running setup.py (path:/tmp/pip-_ULX7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:49 INFO - Running setup.py (path:/tmp/pip-Wolq3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:49 INFO - Running setup.py (path:/tmp/pip-_EARQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:49 INFO - Running setup.py (path:/tmp/pip-R_hNNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:49 INFO - Running setup.py (path:/tmp/pip-BHg7nR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:49 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)) 04:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:49 INFO - Running setup.py (path:/tmp/pip-vCxYg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:49 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)) 04:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:49 INFO - Running setup.py (path:/tmp/pip-FZMEae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:49 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)) 04:45:49 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)) 04:45:49 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)) 04:45:49 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)) 04:45:49 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)) 04:45:49 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)) 04:45:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:45:49 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 04:45:49 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 04:45:49 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 04:45:49 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 04:45:49 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 04:45:49 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 04:45:52 INFO - Downloading blessings-1.6.tar.gz 04:45:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:45:52 INFO - Installing collected packages: blessings 04:45:52 INFO - Running setup.py install for blessings 04:45:52 INFO - Successfully installed blessings 04:45:52 INFO - Cleaning up... 04:45:52 INFO - Return code: 0 04:45:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:45:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:53 INFO - Reading from file tmpfile_stdout 04:45:53 INFO - Current package versions: 04:45:53 INFO - argparse == 1.2.1 04:45:53 INFO - blessings == 1.6 04:45:53 INFO - blobuploader == 1.2.4 04:45:53 INFO - docopt == 0.6.1 04:45:53 INFO - functools32 == 3.2.3-2 04:45:53 INFO - jsonschema == 2.5.1 04:45:53 INFO - manifestparser == 1.1 04:45:53 INFO - mozInstall == 1.12 04:45:53 INFO - mozcrash == 0.17 04:45:53 INFO - mozdebug == 0.1 04:45:53 INFO - mozdevice == 0.48 04:45:53 INFO - mozfile == 1.2 04:45:53 INFO - mozhttpd == 0.7 04:45:53 INFO - mozinfo == 0.9 04:45:53 INFO - mozleak == 0.1 04:45:53 INFO - mozlog == 3.2 04:45:53 INFO - moznetwork == 0.27 04:45:53 INFO - mozprocess == 0.23 04:45:53 INFO - mozprofile == 0.28 04:45:53 INFO - mozrunner == 6.12 04:45:53 INFO - mozscreenshot == 0.1 04:45:53 INFO - mozsystemmonitor == 0.3 04:45:53 INFO - moztest == 0.7 04:45:53 INFO - mozversion == 1.4 04:45:53 INFO - psutil == 3.1.1 04:45:53 INFO - requests == 1.2.3 04:45:53 INFO - wsgiref == 0.1.2 04:45:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:53 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 0x7f3e181b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7a1c0>, '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 0xf7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', '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 04:45:53 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 04:45:53 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 04:45:53 INFO - Using env: {'DISPLAY': ':0', 04:45:53 INFO - 'HOME': '/home/cltbld', 04:45:53 INFO - 'LANG': 'en_US.UTF-8', 04:45:53 INFO - 'LANGUAGE': 'en_US:en', 04:45:53 INFO - 'LOGNAME': 'cltbld', 04:45:53 INFO - 'MAIL': '/var/mail/cltbld', 04:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:53 INFO - 'MOZ_NO_REMOTE': '1', 04:45:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:53 INFO - 'NO_EM_RESTART': '1', 04:45:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:53 INFO - 'PWD': '/builds/slave/test', 04:45:53 INFO - 'SHELL': '/bin/bash', 04:45:53 INFO - 'SHLVL': '1', 04:45:53 INFO - 'TERM': 'linux', 04:45:53 INFO - 'TMOUT': '86400', 04:45:53 INFO - 'USER': 'cltbld', 04:45:53 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', 04:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:53 INFO - '_': '/tools/buildbot/bin/python'} 04:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:53 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)) 04:45:53 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)) 04:45:53 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)) 04:45:53 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)) 04:45:53 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)) 04:45:53 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)) 04:45:53 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)) 04:45:53 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)) 04:45:53 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)) 04:45:53 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)) 04:45:53 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)) 04:45:53 INFO - Cleaning up... 04:45:53 INFO - Return code: 0 04:45:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e181b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7a1c0>, '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 0xf7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', '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 04:45:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:45:53 INFO - Using env: {'DISPLAY': ':0', 04:45:53 INFO - 'HOME': '/home/cltbld', 04:45:53 INFO - 'LANG': 'en_US.UTF-8', 04:45:53 INFO - 'LANGUAGE': 'en_US:en', 04:45:53 INFO - 'LOGNAME': 'cltbld', 04:45:53 INFO - 'MAIL': '/var/mail/cltbld', 04:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:53 INFO - 'MOZ_NO_REMOTE': '1', 04:45:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:53 INFO - 'NO_EM_RESTART': '1', 04:45:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:53 INFO - 'PWD': '/builds/slave/test', 04:45:53 INFO - 'SHELL': '/bin/bash', 04:45:53 INFO - 'SHLVL': '1', 04:45:53 INFO - 'TERM': 'linux', 04:45:53 INFO - 'TMOUT': '86400', 04:45:53 INFO - 'USER': 'cltbld', 04:45:53 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', 04:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:53 INFO - '_': '/tools/buildbot/bin/python'} 04:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:45:53 INFO - Cleaning up... 04:45:53 INFO - Return code: 0 04:45:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e181b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7a1c0>, '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 0xf7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b550>, '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': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', '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 04:45:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:45:53 INFO - Using env: {'DISPLAY': ':0', 04:45:53 INFO - 'HOME': '/home/cltbld', 04:45:53 INFO - 'LANG': 'en_US.UTF-8', 04:45:53 INFO - 'LANGUAGE': 'en_US:en', 04:45:53 INFO - 'LOGNAME': 'cltbld', 04:45:53 INFO - 'MAIL': '/var/mail/cltbld', 04:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:53 INFO - 'MOZ_NO_REMOTE': '1', 04:45:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:53 INFO - 'NO_EM_RESTART': '1', 04:45:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:53 INFO - 'PWD': '/builds/slave/test', 04:45:53 INFO - 'SHELL': '/bin/bash', 04:45:53 INFO - 'SHLVL': '1', 04:45:53 INFO - 'TERM': 'linux', 04:45:53 INFO - 'TMOUT': '86400', 04:45:53 INFO - 'USER': 'cltbld', 04:45:53 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', 04:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:53 INFO - '_': '/tools/buildbot/bin/python'} 04:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:53 INFO - Downloading/unpacking flake8 04:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:45:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:45:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:45:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:45:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:45:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:45:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:45:56 INFO - no previously-included directories found matching 'docs/_build' 04:45:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:45:56 INFO - Running setup.py install for pep8 04:45:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:45:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:45:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:45:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:45:56 INFO - no previously-included directories found matching 'docs/_build' 04:45:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:45:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:45:56 INFO - Cleaning up... 04:45:56 INFO - Return code: 0 04:45:56 INFO - Running post-action listener: _resource_record_post_action 04:45:56 INFO - Running post-action listener: _start_resource_monitoring 04:45:56 INFO - Starting resource monitoring. 04:45:56 INFO - ##### 04:45:56 INFO - ##### Finished create-virtualenv step (success) 04:45:56 INFO - ##### 04:45:56 INFO - ##### 04:45:56 INFO - ##### Running install step. 04:45:56 INFO - ##### 04:45:56 INFO - Running pre-action listener: _resource_record_pre_action 04:45:56 INFO - Running main action method: install 04:45:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:57 INFO - Reading from file tmpfile_stdout 04:45:57 INFO - Detecting whether we're running mozinstall >=1.0... 04:45:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:45:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:45:57 INFO - Reading from file tmpfile_stdout 04:45:57 INFO - Output received: 04:45:57 INFO - Usage: mozinstall [options] installer 04:45:57 INFO - Options: 04:45:57 INFO - -h, --help show this help message and exit 04:45:57 INFO - -d DEST, --destination=DEST 04:45:57 INFO - Directory to install application into. [default: 04:45:57 INFO - "/builds/slave/test"] 04:45:57 INFO - --app=APP Application being installed. [default: firefox] 04:45:57 INFO - mkdir: /builds/slave/test/build/application 04:45:57 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'] 04:45:57 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 04:46:12 INFO - Reading from file tmpfile_stdout 04:46:12 INFO - Output received: 04:46:12 INFO - /builds/slave/test/build/application/firefox/firefox 04:46:12 INFO - Running post-action listener: _resource_record_post_action 04:46:12 INFO - ##### 04:46:12 INFO - ##### Finished install step (success) 04:46:12 INFO - ##### 04:46:12 INFO - ##### 04:46:12 INFO - ##### Running run-tests step. 04:46:12 INFO - ##### 04:46:12 INFO - Running pre-action listener: _resource_record_pre_action 04:46:12 INFO - Running main action method: run_tests 04:46:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:46:12 INFO - Python 2.7.3 04:46:12 INFO - Return code: 0 04:46:12 INFO - grabbing minidump binary from tooltool 04:46: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')]} 04:46:12 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 0xf7a1c0>, '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 0xf7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:46:12 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 04:46:12 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 04:46:12 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 04:46:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:46:13 INFO - Return code: 0 04:46:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:46:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:46:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:46:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:46:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:46:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:46:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:46:14 INFO - Return code: 0 04:46:14 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/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 04:46:14 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/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 04:46:14 INFO - Using env: {'DISPLAY': ':0', 04:46:14 INFO - 'HOME': '/home/cltbld', 04:46:14 INFO - 'LANG': 'en_US.UTF-8', 04:46:14 INFO - 'LANGUAGE': 'en_US:en', 04:46:14 INFO - 'LOGNAME': 'cltbld', 04:46:14 INFO - 'MAIL': '/var/mail/cltbld', 04:46:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:46:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:14 INFO - 'MOZ_NO_REMOTE': '1', 04:46:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:46:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:14 INFO - 'NO_EM_RESTART': '1', 04:46:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:14 INFO - 'PWD': '/builds/slave/test', 04:46:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:46:14 INFO - 'SHELL': '/bin/bash', 04:46:14 INFO - 'SHLVL': '1', 04:46:14 INFO - 'TERM': 'linux', 04:46:14 INFO - 'TMOUT': '86400', 04:46:14 INFO - 'USER': 'cltbld', 04:46:14 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541', 04:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:14 INFO - '_': '/tools/buildbot/bin/python'} 04:46:14 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/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 04:46:14 INFO - mozversion application_buildid: 20160725020629 04:46:14 INFO - mozversion application_changeset: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 04:46:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:46:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:46:14 INFO - mozversion application_name: Firefox 04:46:14 INFO - mozversion application_remotingname: firefox-dev 04:46:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:46:14 INFO - mozversion application_vendor: Mozilla 04:46:14 INFO - mozversion application_version: 49.0a2 04:46:14 INFO - mozversion platform_buildid: 20160725020629 04:46:14 INFO - mozversion platform_changeset: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 04:46:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:46:14 INFO - mozversion platform_version: 49.0a2 04:46:14 INFO - using testdate: 1469447174 04:46:14 INFO - actual date: 1469447174 04:46:14 INFO - starting webserver on 'localhost:53420' 04:46:14 INFO - SUITE-START | Running 2 tests 04:46:14 INFO - TEST-START | dromaeo_css 04:46:14 INFO - operating with platform_type : linux_ 04:46:14 INFO - Initialising browser for dromaeo_css test... 04:46:14 INFO - TEST-INFO | started process 3359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfALsa6/profile http://localhost:53420/getInfo.html) 04:46:19 INFO - PROCESS | 3359 | __metrics Screen width/height:1600/1200 04:46:19 INFO - PROCESS | 3359 | colorDepth:24 04:46:19 INFO - PROCESS | 3359 | Browser inner width/height: 1024/697 04:46:19 INFO - PROCESS | 3359 | __metrics 04:46:20 INFO - PROCESS | 3359 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:46:20 ERROR - PROCESS | 3359 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:46:21 INFO - TEST-INFO | 3359: exit 0 04:46:21 INFO - Browser initialized. 04:46:21 INFO - Running cycle 1/1 for dromaeo_css test... 04:46:21 INFO - TEST-INFO | started process 3451 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfALsa6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:33 INFO - PROCESS | 3451 | RSS: Main: 145477632 04:46:33 INFO - PROCESS | 3451 | 04:47:25 INFO - PROCESS | 3451 | 1469447245299 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] 04:49:32 INFO - PROCESS | 3451 | Cycle 1(1): loaded http://localhost:53420/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53420/tests/dromaeo/cssquery-ext.html) 04:49:33 INFO - PROCESS | 3451 | RSS: Main: 258535424 04:49:33 INFO - PROCESS | 3451 | 04:52:36 INFO - PROCESS | 3451 | Cycle 1(1): loaded http://localhost:53420/tests/dromaeo/cssquery-ext.html (next: http://localhost:53420/tests/dromaeo/cssquery-jquery.html) 04:52:36 INFO - PROCESS | 3451 | RSS: Main: 224579584 04:52:36 INFO - PROCESS | 3451 | 04:55:38 INFO - PROCESS | 3451 | Cycle 1(1): loaded http://localhost:53420/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53420/tests/dromaeo/cssquery-mootools.html) 04:55:39 INFO - PROCESS | 3451 | RSS: Main: 226480128 04:55:39 INFO - PROCESS | 3451 | 04:58:41 INFO - PROCESS | 3451 | Cycle 1(1): loaded http://localhost:53420/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53420/tests/dromaeo/cssquery-prototype.html) 04:58:41 INFO - PROCESS | 3451 | RSS: Main: 222814208 04:58:41 INFO - PROCESS | 3451 | 05:01:44 INFO - PROCESS | 3451 | Cycle 1(1): loaded http://localhost:53420/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53420/tests/dromaeo/cssquery-yui.html) 05:01:44 INFO - PROCESS | 3451 | RSS: Main: 225157120 05:01:44 INFO - PROCESS | 3451 | 05:04:47 INFO - PROCESS | 3451 | Cycle 1(1): loaded http://localhost:53420/tests/dromaeo/cssquery-yui.html (next: http://localhost:53420/tests/dromaeo/cssquery-dojo.html) 05:04:47 INFO - PROCESS | 3451 | RSS: Main: 261804032 05:04:47 INFO - PROCESS | 3451 | 05:04:47 INFO - PROCESS | 3451 | __start_tp_report 05:04:47 INFO - PROCESS | 3451 | _x_x_mozilla_page_load 05:04:47 INFO - PROCESS | 3451 | _x_x_mozilla_page_load_details 05:04:47 INFO - PROCESS | 3451 | |i|pagename|runs| 05:04:47 INFO - PROCESS | 3451 | |0;dojo.html;3252.333271679305;3330.4504756715137;3349.7320214382853;3384.712299454546;3394.626591074983;5438.7824487020525;5543.36251331096;5550.916736248954;5559.777608895639;5564.248826408434;5435.239066530679;5472.288602481682;5480.095784195613;5497.642653227547;5498.120300751881;4902.779374928136;4963.851084467472;4982.30247765314;4999.600031997432;5038.84883453497;4961.429435614897;4983.601311895058;4988.925166122511;5017.5484206421415;5108.1060814357525;5008.29883816266;5017.37282839645;5020.5983521318385;5056.8482945511505;5126.71803050832;5057.165567681328;5107.897842043139;5117.590592752571;5121.846344609649;5136.409312929005;4916.844541532737;4940.777665005047;4956.975215123937;5001.599872010231;5020;5422.728863556807;5428.321459817523;5451.182322651594;5479.04116779562;5494.80768173116;5647.1529270609735;5933.19901813254;5942.435468630473;5943.3759455257;5949.524038076944;5837.036888913324;5908.940910590882;5917.497012753921;5975.193348897887;6005.939940600581;5574.442555744434;5578.30271216098;5612.466815652507;5613.663180209201;5616.887662246773;5889.617174883619;5894.67579283135;6052.606580572248;6085.482733967662;6107.144999700045;5706.657600543981;5766.163906233573;5797.072468405035;5802.3037235531165;5803.303603567599;5855.853603659857;5872.794452194153;5892.823215303548;5905.763769449174;5905.852353691106;5628.127640215773;5738.426157384228;5785;5800.854978625568;5809.099589563624;5843.970780146072;5845.590808643439;5847.298324201123;5849.385814489502;5859.853503662357;4485;4525.0497395546645;4525.592696657317;4533.84131555394;4560.498345182027;3956.8615098471414;3978.3236849735613;3983.1038016446646;3993.940090898639;4037.7375470594316;5571.916421253684;5583.581231407579;5590.91613625796;5597.244372009726;5620.3255609326325;5681.630694004876;5895.941040589625;5901.144334071536;5907.675077870758;5943;5532.5297349724915;5576.97211513948;5579.609427340048;5619.213310136584;5642.633228840113;5072.644914855925;5082.542571168613;5083.161278389099;5086.567641750493;5117.130087884994;5916.083007133901;6050.57645964787;6197.938020619736;6205.720742566596;6216.906746398808;5874.706264686834;5938.881222375615;5942.58401911862;5944.167816505779;5964.135200395832;6152.384761523812;6173.351798061319;6184.690765461619;6185.6907154641185;6197.132401463708;5619.381867994599;5636.661800291996;5637.661740295595;5782.248307720138;5792.507636850914;5806.216160818404;5811.128330750252;5816.069428891357;5826.184334193132;5839.153322768259;5634.126710359901;5648.293963254593;5648.4633959773755;5648.661080335193;5669.092945128925;5512.118061110364;5684.7157642118555;5696.202531645656;5730.598858079894;5785.797497087582;5690.430956904442;5718;5727.31272247333;5728.455796699307;5731.885362292647;5818.679972601548;5823.650580965155;5878.441548052928;5878.706064696663;5880.117982302689;5392;5534.225208470898;5551.750171242223;5574.804881829116;5594.692291923983 05:04:47 INFO - PROCESS | 3451 | |1;ext.html;599.7091410665827;657.5528640524444;659.5745743995124;664.9069130321755;666.8866292730236;33987;36808.07979800503;36851.81574092132;36905;36908;37573;47608.52391476093;48756;48952.26571601429;52866.47133528673;9153.771155721093;9263.120003599648;9274.582643781046;9281.860772088425;9294.488803115826;8409.579521023956;9066.274698024143;9159;9176.403533770284;9177.678781242657;10899.83650245243;11150.330980141218;11156.944215278912;11544.826827597593;11568.884311156908;11081.667549973514;11162.441877906072;11167.274127181749;11183;11185.049270811991;8344.749657510223;8558.315334773204;10443.216758743049;10937.726556836064;11016.669499915015;45952.54047459516;46369.30446043312;46499.76750116228;46553.76723116397;46603;3729.850805967758;3741.139537906297;3807.58116607173;3891.9880830983866;4142.1922725068625;35053.649463505295;35739.64260357415;35751;36064.45903311452;36177.457338139946;4616.307553866914;4625.1443482955765;4640.141573808823;4674.883127921829;4676.532346765331;396095;397928;401412.9999999971;401570;401690;65522;65927;65939.34060659428;65971.34028659748;65997;67867.66066169637;68013;68126.318736812;68166.31833681698;68230;18722.251109955723;19342.903285483764;19391.709124363148;19399.515012124528;19399.709004364944;15151.924240378728;15152.621184470256;15227.543173704807;15243.466478673194;15246.313915873812;16392.508224753277;17626.471205863843;18045.458636240935;18106.547336316435;18312.359067432575;6043.7884674036195;6177.413145751147;6184.628922264678;6218.160548325918;6229.657368844757;1073.307716522854;1073.7100982734773;1114.777044591085;1163.5345861655405;1173.3487914207526;30475.390492190032;32607.836960815042;32757.344853102804;32835.83582082074;32976.17559560982;1188.5602327139013;1198.9700257493632;1223.920445171061;1227.6194379742308;1239.8078297863844;17777.733334;17860.374886878897;17991.73012404815;18157.818421815613;18211.90894045548;610064;612284;613930;616196;617853;63860.361396385444;64065;64123;64150.6792466044;64286.357136428975;1364.8566900475505;1366.1666383506054;1447.8841692664773;1459.8540145985316;1474.8525147485166;32031.67968320287;36327.27345453023;36572.45141322829;36607.81696091503;36643.26713465769;55142.72428637992;55354;55826;55876.44123558875;55902.44097558972;468743;471265;471749;472671;472951;28028.159155225378;30281.69718302789;49545.25682114699;50596.49403505918;51072;51506.742466287425;54467.45532544782;54876.72561637326;55198.724006379714;55717.721411394305;47118.52881471279;47212.7639361801;47215;47621.52378476171;48347.516524834304;46382;46832;47092.52907471018;47561.79158136488;47682;46701;47450.52549474599;47518.76240618775;48452;49363;38632.42051369288;40479;40766.18467630571;41242.79378603088;41647;30375.240618984702;30420.84789576038;30471.39057218799;30669.386612268077;30885.227869303446 05:04:47 INFO - PROCESS | 3451 | |2;jquery.html;419.95800419958;422.2462903716866;422.9640480559152;427.1926059747079;439.4046067578431;18419;19586.118624661907;19970.20119195232;20865.791342086573;21377.144914203414;19473.51316217095;19782.604347913035;19811.603767924633;20097.29659461919;20116.89941550294;5648.632838865471;5841.6202946808535;5877.324107727623;5881.558883083786;5886.058230683092;4187.1416359646355;4337.7180483268485;5566.972165139189;5824.417558244163;6454.0641606966965;6305.5901366411035;6425.775097871552;6437.903431448532;6444.581102228363;6491.578047426926;6255.186825712628;6303.086052522382;6346.11154438379;6352.618842869397;6409.615423074607;3905.316569600337;5230.8692282692855;5541.722913854291;5733.111367738007;5792.536597072266;23454.296371108725;23589.528209435888;23614.40963975897;23711.288661340186;23736.287911362688;2268.2854900706225;2574.45936353366;3099.550565168038;3170.9048728538182;3207.134073800084;10516.211284153718;10759.892401075967;10821.458927053616;10866.402347870864;10926.781464370748;2046.171036354203;2086.248950377863;2118.353902059871;2178.705874706926;2228.6322756745117;81261.59369203175;82217.58891205625;83568.58215708882;84344.15655843486;84670;11498;11518.193726439069;11560.248583842023;11655.941720291345;11888.108391870472;16643;16669.66660666804;16744;16794.412195573095;16800.327986880387;8005.91920090792;8371.204735550113;8491.660333586588;8615.6984505542;8705.564721764013;8243.093259741423;8244.83510329802;8253.83492330162;8299.543525106057;8337.249647531751;5053.343065401547;5105.489451054939;5170.97414512925;5176.8964620707375;5178.6374953752875;1951.1219951022097;1976.6738488149294;2017.788132246093;2045.0694933805082;2046.2122082998153;466.4822047527242;523.3013926408288;945.2201933404831;1084.6637542361893;1095.4905968724422;12129.818052729217;12880.355982200852;12905.483780648856;12912.741745165233;13121.475140994444;505.20682528430746;506.27855306188536;509.09381301283776;513.6840842881601;527.6939375162474;6551.312112228243;6843.589384636938;6871.209810871714;6906.412954898889;6947.5831450113155;451686;458714;461221;472669;554139;64081;68061.65969170221;93954;96604.51697741607;110629.44685276522;1066.7866426714688;1078.9244752867223;1093.3439936038471;1094.8905109488987;1097.6542389147394;17857.28570857151;17868.910655446638;17875.28498860031;17891.821081789014;18284.908575457037;42419;42973.785131074146;43310.350344745486;43675.12649747051;44666;61498.38501614927;61679;62031.803263993854;62319;62590;6882.69027893736;7857.214278572097;8602.354823388396;8660.48037117775;8801.603927823135;12512.37438128108;13226.603201903958;13292.468301267842;13452.730945381234;13532;11647.6505704829;11866.644000679993;11936.164468487123;12131.575394861138;12158.939205303917;11395.202335836411;11469;11513.481893314653;11815.113866459878;11842.644720658394;11180.496877640364;11547.307161570332;11943.581974630846;11985.520579177084;12208.877911220774;7679.769606911802;7888.723894663659;8856.114388561093;8875.866861996947;8888.155625215593;11368.204225704452;11578.884211158118;11598.246114002563;11630.767384652429;11699.181057325906 05:04:47 INFO - PROCESS | 3451 | |3;mootools.html;1395.218677540578;1516.5905205594486;1551.2780813297238;1737.5656085978505;1877.258482899254;8378.371622128341;8708.825823483527;8722.21500064994;8737.606807693654;8966.28269738421;8435.91564084359;8664.783380415493;8918.464892106462;8922.821543569125;8922.91077089229;2069.3998740365278;2333.6616190652344;2348.1664009276715;2400.2679182849224;2405.230326295586;2427.0730417252917;2461.5323088613104;2463.3718401807514;2469.9753002470015;2470.419451428913;2392.2225276785116;2413.4690368118986;2413.7103547574316;2414.6860908081926;2415.8188135889877;2069.286096296775;2315.9305220843316;2370.8340416170877;2373.6914201153913;2395.4849707312837;2330.5222429401933;2332.6267797152545;2334.8949297281665;2336.1356298169617;2366.857988520694;9023.323250756153;9055.275577953813;9061;9073.682421115229;9081.545922703905;5304.946950530522;5445.237666726662;5447.727613619343;5451.563874889999;5452.509274165304;3388.9322213555592;3483.5645544306963;3522.7005704515145;3528.311979164064;3566.7146628269934;1217.4643157010976;1241.757857217843;1242.3539759325101;1247.7067889046066;1282.5959822655834;12768.297743624096;12998.285094319903;13013.414396352187;13020.153690010215;13026.739465210738;4771.6898401603785;4780.067886762048;4824.372831531879;4825.252085926687;4852.733099679481;10802.837957430645;10860.076893463985;10866.891331086588;10992.670219893416;11014.779704405866;4850.151223535867;5419.539339156216;5427.891442171134;5430.294061772023;5430.484104010113;4920.975395123001;5019.949800502021;5027.723475208825;5079.187330027178;5085.338905942278;3943.4450346556864;4067.9389809152885;4191.691379868904;4199.0552125772065;4219.303814870574;1298.6169080121388;1315.986241962012;1326.0452474218548;1339.564641491519;1347.2590075458654;1003.2124782046204;1027.2860362048455;1044.8171569975225;1045.4354648489882;1046.1630695443614;6338.841528961812;6429.164208652939;6528.445082167974;6532.869342613121;6537.640429776408;482.97343646099097;491.9065377578249;497.48758778458244;501.23561568608164;519.1330478101579;4469.173202957463;4478.193925093515;4501.369808226851;4515.164694531522;4531.252343363308;10929.617463388902;11177.161712871568;11197.104231661448;11204.159688023268;11245;10803.891961080288;11038.613648522263;11137.387443690675;11164.553417863357;11429.142814288962;8337.95831020841;8467.110953349933;8467.32261419085;8475.364347673949;8484.36367272457;6443.194600674916;6547;6598.208215014037;6644.800655980328;6808.251092379934;10284.897151028394;10400.687979360631;10633.096186824207;10667.733306667395;10683.038526532338;10686.89313106859;10707.357558546511;10904;10937.234393592691;11092.611758588411;7236.167840698387;7950.840983180419;8113.35093192555;8161.265486106279;8206.22040906113;9047.909520904706;9088.500132492776;9130.817383652422;9174.311926605666;9181.49501777382;7888.566128862968;7938.24586664266;7972.681092756225;8128.9593552031865;8143.022837259567;7939.325157361458;8017.599120044091;8038.678452862054;8126.106128325998;8189.140140285184;7363.447741419523;7460.738874139379;7462.664180111799;7473.588952607442;7543.396528277615;5620.1288800236025;5650.208970744181;5661.433856614306;5699.088145896637;5859.619124756877;5543.334799824047;5603.299587551556;5646.0683987141665;5669.858253543694;5722.885542289047 05:04:47 INFO - PROCESS | 3451 | |4;prototype.html;349.5874867656166;357.23016898583546;364.51701495518427;366.5747732630148;372.9477873097765;5293.258943747874;5379.273798037264;5391.81128660496;5419.233632625322;5451.100568406218;5335.279737235472;5344.599155063366;5375.919361209585;5391.406945236021;5402.270693456382;4190.350495673168;4262.808173632194;4278.25130602145;4284.892877678052;4317.611414972652;4208.263553878074;4255.659547236229;4255.702100852942;4273.529911709709;4283.87148385549;4248.4052232687445;4251.744895306276;4252.553481884404;4261.488621365441;4292.29177185764;4190.413342132104;4248.532661407243;4260.104253607146;4260.168127705086;4304.31131019037;3771.7548359356556;3773.1887644156636;3779.5842457329672;3787.8295476703615;3800.296945065144;5141.820036298712;5178.40448348441;5179;5187.377514698261;5189.780401605657;4612.86161415158;4790.401199850019;4799.832005879777;4802.2316429371485;4807.11068452334;5500.4224556421395;5502;5505.201745746885;5517.089680202762;5535.114381698949;4056.6146216109423;4064.9390259146135;4067.3085575452246;4071.0026043619205;4097.91804163918;5583.664980101207;5778.566607504412;5791.420857914175;5797.855053623651;5820.272465941757;4034.677225821927;4084.14233011071;4084.346504559256;4087.8364865405647;4105.158442519277;4129.91740165195;4151.629962112495;4158.856314513533;4159.729617574848;4176.812043458051;4657.580817726421;4755.120302744003;4769.880752981203;4790.161721698689;4795.808167673324;5523.475269849358;5534.529564987021;5536.916946245809;5538.9169162462595;5577.9163312550345;1442.9567112986626;1458.4603696632103;1464.2678660669665;1471.279073254119;1471.6173794813212;932.4778124250441;942.528735632184;952.8999455057258;961;962.7737481691797;4800.159872102304;4828.275758636162;4857.271409288564;4871.634627402959;4872.9512704872495;5127.230915362726;5170.6380553360905;5171.5862730981435;5172.948270517322;5227.477252274818;4652.464966528893;4903.901921961612;4947.925781113287;4961.454240033593;4963.205887058126;2756.7656749176144;2775.3894143288444;2776.708445613222;2776.958640509809;2777.8333300002064;5372.274742909657;5373.462653734595;5382.811601593926;5388.191771234267;5389.083855744533;5078.5175408336145;5128.435872054071;5242.9213561796605;5243.370795504564;5264.368275806928;5227.660202086852;5276.947230527722;5310.840674779763;5357.919631205457;5373.623846330719;5130.204818253177;5161.948380516297;5174.6881995523645;5178.637495375438;5195.402528709247;4791.203298762964;5081.4664460232625;5105.183170692671;5107.310513080835;5127.79488820443;5275.868103297448;5284.392294886137;5288.788448462018;5305.177697456746;5384.380796208487;3765.2657731742047;3771.340015497332;3834.9041273968373;3867.226554689017;3876.1666241758157;4895.192293271571;4945.466905259237;5051.4443411224;5085.516875896784;5087.135187018142;4949.950500494949;4960.429550601582;4981.875453113701;4983.501649834988;4984.5575667923185;4930.13722598551;4941.3563743398545;4941.481144479922;4943.901121977612;4948.777305021211;4690.6247500199215;4917.901641967069;4967.019788127095;5010.649254552146;5015.899682006267;5057.544820966131;5058.064258112261;5069.797208111781;5092.9745351273;5112.616553758408;4812.807487700453;4928.669259300041;4977.879977005145;4998.975619749999;5012.523810238022 05:04:47 INFO - PROCESS | 3451 | |5;yui.html;828.014662551564;828.2256090555328;854.9658013679449;880.3485420788617;913.9352654157908;15417.22913854307;16138.273777680004;16431.260593273302;16447.75328370074;16509.257083431243;14476.782848257259;14581.708365832703;14631.92684036581;14656.413743450275;14674.926625366857;722.7687140115139;849.3460035772451;852.3735054734765;860.789106668867;868.9217970382664;862.5169904853271;870.3820287595814;871.0331531999476;871.1636828644508;871.8910136232971;904.9502277374742;915.4095608332622;915.455304094063;916.1296768070326;916.2029034739752;749.1123019222211;873.6243415331405;900.7748062984253;912.8311262416441;913.5797533134765;667.0261418329245;668.0780522878446;668.8929771236578;669.1201070592156;669.5246375073704;15227.086374817436;15254.923725381414;15255.08469491834;15367.15480648564;15392.230388480642;14866.702665946621;15230.847691523053;15317.923410382988;15369.769453458208;15525.611859703486;13280.46878124874;13670.658233544142;13814.171149730948;13910.443582256697;13942.790858137034;4730.668853180278;4802.375691160162;4854.2961270615915;4858.246971719389;4880.902381952376;74331;75629.24370756277;75842.62078689571;76117;76920;11838;12043.21719088274;12102.576409825613;12175.086868484723;12237.326947017822;21940.670889936664;21968.231111911005;21976.34070977873;21987.560248794933;21988.450288742588;8616.267617252604;8650.601690107214;8673.306135509145;8887.066857979818;9098.408603440756;4949.158643030693;4976.278439626306;5073.695578265316;5086.033653605803;5138.640295179302;3577.678008979204;3706.8517259309865;3709.4250391189407;3711.0907827581877;3718.8698395556025;629.0909635576639;629.858281886581;637.8245982354797;650.177525430331;655.3381085104079;672.9024291477708;673.5958424944994;682.276786606199;710.5985118408083;714.3356678289241;10048.69853904384;10358.741031474274;10442.112420444195;10469.790604187874;10520.158387328995;664.9966750166218;673.1484671890063;677.2178134254943;677.2922296200483;677.3362105136994;4766.856994290177;4847.927281090787;5603.103503439512;5727;5957.285125784933;78386.60806696044;92263.5386823075;124378;126946;129657.35171324083;69209.65395172992;106078.10492317975;108625.45687271513;110899.44550277197;112740.43629781799;98009;99153.50423247837;99992;100843;101405.49297253466;10344.689659310232;10676.83984740214;10999.890001099886;11066.612668556561;11079.279846809932;54432.727836360566;54524;55009.724951374985;55304.72347638236;55810.44189558052;74870;77886.61056694681;81745.30725448813;84620.15379846122;84698;14087.15477071379;14143.858561414665;14144.363503642566;14314.979142589245;14331.856681433052;16006.919965400099;16024.439144630349;16362.55563159065;16373.181340932668;16448.506544803677;14946.626334341729;15308.846911530742;15442.45951391696;16439.424620138718;16467.752983705013;14274.072185307921;14499.78250326267;14828;15216;15627.843721563093;13976.860231397555;14527.78208326897;14742.336594853043;14955.027923184958;15617.14105724196;11769.588064417705;12143.939280303543;12352.567660131852;12580.182288151242;12733.108682392143;12292.754144916873;12396.81404778947;12609.778869533437;12717.55488557896;12850.293233872228 05:04:47 INFO - PROCESS | 3451 | __end_tp_report 05:04:47 INFO - PROCESS | 3451 | __start_cc_report 05:04:47 INFO - PROCESS | 3451 | _x_x_mozilla_cycle_collect,968 05:04:47 INFO - PROCESS | 3451 | __end_cc_report 05:04:47 INFO - PROCESS | 3451 | __startTimestamp1469448287507__endTimestamp 05:04:47 INFO - PROCESS | 3451 | 05:04:47 INFO - PROCESS | 3451 | ------- Summary: start ------- 05:04:47 INFO - PROCESS | 3451 | Number of tests: 6 05:04:47 INFO - PROCESS | 3451 | 05:04:47 INFO - PROCESS | 3451 | [#0] dojo.html Cycles:165 Average:5467.54 Median:5634.13 stddev:600.57 (10.7%) stddev-sans-first:576.72 05:04:47 INFO - PROCESS | 3451 | Values: 3252.3 3330.5 3349.7 3384.7 3394.6 5438.8 5543.4 5550.9 5559.8 5564.2 5435.2 5472.3 5480.1 5497.6 5498.1 4902.8 4963.9 4982.3 4999.6 5038.8 4961.4 4983.6 4988.9 5017.5 5108.1 5008.3 5017.4 5020.6 5056.8 5126.7 5057.2 5107.9 5117.6 5121.8 5136.4 4916.8 4940.8 4957.0 5001.6 5020.0 5422.7 5428.3 5451.2 5479.0 5494.8 5647.2 5933.2 5942.4 5943.4 5949.5 5837.0 5908.9 5917.5 5975.2 6005.9 5574.4 5578.3 5612.5 5613.7 5616.9 5889.6 5894.7 6052.6 6085.5 6107.1 5706.7 5766.2 5797.1 5802.3 5803.3 5855.9 5872.8 5892.8 5905.8 5905.9 5628.1 5738.4 5785.0 5800.9 5809.1 5844.0 5845.6 5847.3 5849.4 5859.9 4485.0 4525.0 4525.6 4533.8 4560.5 3956.9 3978.3 3983.1 3993.9 4037.7 5571.9 5583.6 5590.9 5597.2 5620.3 5681.6 5895.9 5901.1 5907.7 5943.0 5532.5 5577.0 5579.6 5619.2 5642.6 5072.6 5082.5 5083.2 5086.6 5117.1 5916.1 6050.6 6197.9 6205.7 6216.9 5874.7 5938.9 5942.6 5944.2 5964.1 6152.4 6173.4 6184.7 6185.7 6197.1 5619.4 5636.7 5637.7 5782.2 5792.5 5806.2 5811.1 5816.1 5826.2 5839.2 5634.1 5648.3 5648.5 5648.7 5669.1 5512.1 5684.7 5696.2 5730.6 5785.8 5690.4 5718.0 5727.3 5728.5 5731.9 5818.7 5823.7 5878.4 5878.7 5880.1 5392.0 5534.2 5551.8 5574.8 5594.7 05:04:47 INFO - PROCESS | 3451 | 05:04:47 INFO - PROCESS | 3451 | [#1] ext.html Cycles:180 Average:67282.52 Median:43799.77 stddev:133465.42 (304.7%) stddev-sans-first:133745.92 05:04:47 INFO - PROCESS | 3451 | Values: 599.7 657.6 659.6 664.9 666.9 33987.0 36808.1 36851.8 36905.0 36908.0 37573.0 47608.5 48756.0 48952.3 52866.5 9153.8 9263.1 9274.6 9281.9 9294.5 8409.6 9066.3 9159.0 9176.4 9177.7 10899.8 11150.3 11156.9 11544.8 11568.9 11081.7 11162.4 11167.3 11183.0 11185.0 8344.7 8558.3 10443.2 10937.7 11016.7 45952.5 46369.3 46499.8 46553.8 46603.0 3729.9 3741.1 3807.6 3892.0 4142.2 35053.6 35739.6 35751.0 36064.5 36177.5 4616.3 4625.1 4640.1 4674.9 4676.5 396095.0 397928.0 401413.0 401570.0 401690.0 65522.0 65927.0 65939.3 65971.3 65997.0 67867.7 68013.0 68126.3 68166.3 68230.0 18722.3 19342.9 19391.7 19399.5 19399.7 15151.9 15152.6 15227.5 15243.5 15246.3 16392.5 17626.5 18045.5 18106.5 18312.4 6043.8 6177.4 6184.6 6218.2 6229.7 1073.3 1073.7 1114.8 1163.5 1173.3 30475.4 32607.8 32757.3 32835.8 32976.2 1188.6 1199.0 1223.9 1227.6 1239.8 17777.7 17860.4 17991.7 18157.8 18211.9 610064.0 612284.0 613930.0 616196.0 617853.0 63860.4 64065.0 64123.0 64150.7 64286.4 1364.9 1366.2 1447.9 1459.9 1474.9 32031.7 36327.3 36572.5 36607.8 36643.3 55142.7 55354.0 55826.0 55876.4 55902.4 468743.0 471265.0 471749.0 472671.0 472951.0 28028.2 30281.7 49545.3 50596.5 51072.0 51506.7 54467.5 54876.7 55198.7 55717.7 47118.5 47212.8 47215.0 47621.5 48347.5 46382.0 46832.0 47092.5 47561.8 47682.0 46701.0 47450.5 47518.8 48452.0 49363.0 38632.4 40479.0 40766.2 41242.8 41647.0 30375.2 30420.8 30471.4 30669.4 30885.2 05:04:47 INFO - PROCESS | 3451 | 05:04:47 INFO - PROCESS | 3451 | [#2] jquery.html Cycles:180 Average:28686.77 Median:421.10 stddev:79458.63 (18869.2%) stddev-sans-first:79653.19 05:04:47 INFO - PROCESS | 3451 | Values: 420.0 422.2 423.0 427.2 439.4 18419.0 19586.1 19970.2 20865.8 21377.1 19473.5 19782.6 19811.6 20097.3 20116.9 5648.6 5841.6 5877.3 5881.6 5886.1 4187.1 4337.7 5567.0 5824.4 6454.1 6305.6 6425.8 6437.9 6444.6 6491.6 6255.2 6303.1 6346.1 6352.6 6409.6 3905.3 5230.9 5541.7 5733.1 5792.5 23454.3 23589.5 23614.4 23711.3 23736.3 2268.3 2574.5 3099.6 3170.9 3207.1 10516.2 10759.9 10821.5 10866.4 10926.8 2046.2 2086.2 2118.4 2178.7 2228.6 81261.6 82217.6 83568.6 84344.2 84670.0 11498.0 11518.2 11560.2 11655.9 11888.1 16643.0 16669.7 16744.0 16794.4 16800.3 8005.9 8371.2 8491.7 8615.7 8705.6 8243.1 8244.8 8253.8 8299.5 8337.2 5053.3 5105.5 5171.0 5176.9 5178.6 1951.1 1976.7 2017.8 2045.1 2046.2 466.5 523.3 945.2 1084.7 1095.5 12129.8 12880.4 12905.5 12912.7 13121.5 505.2 506.3 509.1 513.7 527.7 6551.3 6843.6 6871.2 6906.4 6947.6 451686.0 458714.0 461221.0 472669.0 554139.0 64081.0 68061.7 93954.0 96604.5 110629.4 1066.8 1078.9 1093.3 1094.9 1097.7 17857.3 17868.9 17875.3 17891.8 18284.9 42419.0 42973.8 43310.4 43675.1 44666.0 61498.4 61679.0 62031.8 62319.0 62590.0 6882.7 7857.2 8602.4 8660.5 8801.6 12512.4 13226.6 13292.5 13452.7 13532.0 11647.7 11866.6 11936.2 12131.6 12158.9 11395.2 11469.0 11513.5 11815.1 11842.6 11180.5 11547.3 11943.6 11985.5 12208.9 7679.8 7888.7 8856.1 8875.9 8888.2 11368.2 11578.9 11598.2 11630.8 11699.2 05:04:47 INFO - PROCESS | 3451 | 05:04:47 INFO - PROCESS | 3451 | [#3] mootools.html Cycles:180 Average:6049.06 Median:4775.88 stddev:3445.26 (72.1%) stddev-sans-first:3437.17 05:04:47 INFO - PROCESS | 3451 | Values: 1395.2 1516.6 1551.3 1737.6 1877.3 8378.4 8708.8 8722.2 8737.6 8966.3 8435.9 8664.8 8918.5 8922.8 8922.9 2069.4 2333.7 2348.2 2400.3 2405.2 2427.1 2461.5 2463.4 2470.0 2470.4 2392.2 2413.5 2413.7 2414.7 2415.8 2069.3 2315.9 2370.8 2373.7 2395.5 2330.5 2332.6 2334.9 2336.1 2366.9 9023.3 9055.3 9061.0 9073.7 9081.5 5304.9 5445.2 5447.7 5451.6 5452.5 3388.9 3483.6 3522.7 3528.3 3566.7 1217.5 1241.8 1242.4 1247.7 1282.6 12768.3 12998.3 13013.4 13020.2 13026.7 4771.7 4780.1 4824.4 4825.3 4852.7 10802.8 10860.1 10866.9 10992.7 11014.8 4850.2 5419.5 5427.9 5430.3 5430.5 4921.0 5019.9 5027.7 5079.2 5085.3 3943.4 4067.9 4191.7 4199.1 4219.3 1298.6 1316.0 1326.0 1339.6 1347.3 1003.2 1027.3 1044.8 1045.4 1046.2 6338.8 6429.2 6528.4 6532.9 6537.6 483.0 491.9 497.5 501.2 519.1 4469.2 4478.2 4501.4 4515.2 4531.3 10929.6 11177.2 11197.1 11204.2 11245.0 10803.9 11038.6 11137.4 11164.6 11429.1 8338.0 8467.1 8467.3 8475.4 8484.4 6443.2 6547.0 6598.2 6644.8 6808.3 10284.9 10400.7 10633.1 10667.7 10683.0 10686.9 10707.4 10904.0 10937.2 11092.6 7236.2 7950.8 8113.4 8161.3 8206.2 9047.9 9088.5 9130.8 9174.3 9181.5 7888.6 7938.2 7972.7 8129.0 8143.0 7939.3 8017.6 8038.7 8126.1 8189.1 7363.4 7460.7 7462.7 7473.6 7543.4 5620.1 5650.2 5661.4 5699.1 5859.6 5543.3 5603.3 5646.1 5669.9 5722.9 05:04:47 INFO - PROCESS | 3451 | 05:04:47 INFO - PROCESS | 3451 | [#4] prototype.html Cycles:180 Average:4470.25 Median:4955.19 stddev:1238.57 (25.0%) stddev-sans-first:1202.81 05:04:47 INFO - PROCESS | 3451 | Values: 349.6 357.2 364.5 366.6 372.9 5293.3 5379.3 5391.8 5419.2 5451.1 5335.3 5344.6 5375.9 5391.4 5402.3 4190.4 4262.8 4278.3 4284.9 4317.6 4208.3 4255.7 4255.7 4273.5 4283.9 4248.4 4251.7 4252.6 4261.5 4292.3 4190.4 4248.5 4260.1 4260.2 4304.3 3771.8 3773.2 3779.6 3787.8 3800.3 5141.8 5178.4 5179.0 5187.4 5189.8 4612.9 4790.4 4799.8 4802.2 4807.1 5500.4 5502.0 5505.2 5517.1 5535.1 4056.6 4064.9 4067.3 4071.0 4097.9 5583.7 5778.6 5791.4 5797.9 5820.3 4034.7 4084.1 4084.3 4087.8 4105.2 4129.9 4151.6 4158.9 4159.7 4176.8 4657.6 4755.1 4769.9 4790.2 4795.8 5523.5 5534.5 5536.9 5538.9 5577.9 1443.0 1458.5 1464.3 1471.3 1471.6 932.5 942.5 952.9 961.0 962.8 4800.2 4828.3 4857.3 4871.6 4873.0 5127.2 5170.6 5171.6 5172.9 5227.5 4652.5 4903.9 4947.9 4961.5 4963.2 2756.8 2775.4 2776.7 2777.0 2777.8 5372.3 5373.5 5382.8 5388.2 5389.1 5078.5 5128.4 5242.9 5243.4 5264.4 5227.7 5276.9 5310.8 5357.9 5373.6 5130.2 5161.9 5174.7 5178.6 5195.4 4791.2 5081.5 5105.2 5107.3 5127.8 5275.9 5284.4 5288.8 5305.2 5384.4 3765.3 3771.3 3834.9 3867.2 3876.2 4895.2 4945.5 5051.4 5085.5 5087.1 4950.0 4960.4 4981.9 4983.5 4984.6 4930.1 4941.4 4941.5 4943.9 4948.8 4690.6 4917.9 4967.0 5010.6 5015.9 5057.5 5058.1 5069.8 5093.0 5112.6 4812.8 4928.7 4977.9 4999.0 5012.5 05:04:47 INFO - PROCESS | 3451 | 05:04:47 INFO - PROCESS | 3451 | [#5] yui.html Cycles:180 Average:21917.97 Median:3708.14 stddev:31174.69 (840.7%) stddev-sans-first:31221.93 05:04:47 INFO - PROCESS | 3451 | Values: 828.0 828.2 855.0 880.3 913.9 15417.2 16138.3 16431.3 16447.8 16509.3 14476.8 14581.7 14631.9 14656.4 14674.9 722.8 849.3 852.4 860.8 868.9 862.5 870.4 871.0 871.2 871.9 905.0 915.4 915.5 916.1 916.2 749.1 873.6 900.8 912.8 913.6 667.0 668.1 668.9 669.1 669.5 15227.1 15254.9 15255.1 15367.2 15392.2 14866.7 15230.8 15317.9 15369.8 15525.6 13280.5 13670.7 13814.2 13910.4 13942.8 4730.7 4802.4 4854.3 4858.2 4880.9 74331.0 75629.2 75842.6 76117.0 76920.0 11838.0 12043.2 12102.6 12175.1 12237.3 21940.7 21968.2 21976.3 21987.6 21988.5 8616.3 8650.6 8673.3 8887.1 9098.4 4949.2 4976.3 5073.7 5086.0 5138.6 3577.7 3706.9 3709.4 3711.1 3718.9 629.1 629.9 637.8 650.2 655.3 672.9 673.6 682.3 710.6 714.3 10048.7 10358.7 10442.1 10469.8 10520.2 665.0 673.1 677.2 677.3 677.3 4766.9 4847.9 5603.1 5727.0 5957.3 78386.6 92263.5 124378.0 126946.0 129657.4 69209.7 106078.1 108625.5 110899.4 112740.4 98009.0 99153.5 99992.0 100843.0 101405.5 10344.7 10676.8 10999.9 11066.6 11079.3 54432.7 54524.0 55009.7 55304.7 55810.4 74870.0 77886.6 81745.3 84620.2 84698.0 14087.2 14143.9 14144.4 14315.0 14331.9 16006.9 16024.4 16362.6 16373.2 16448.5 14946.6 15308.8 15442.5 16439.4 16467.8 14274.1 14499.8 14828.0 15216.0 15627.8 13976.9 14527.8 14742.3 14955.0 15617.1 11769.6 12143.9 12352.6 12580.2 12733.1 12292.8 12396.8 12609.8 12717.6 12850.3 05:04:47 INFO - PROCESS | 3451 | -------- Summary: end -------- 05:04:47 INFO - PROCESS | 3451 | 05:04:48 INFO - TEST-INFO | 3451: exit 0 05:04:48 INFO - TEST-OK | dromaeo_css | took 1113915ms 05:04:48 INFO - TEST-START | kraken 05:04:48 INFO - operating with platform_type : linux_ 05:04:48 INFO - Initialising browser for kraken test... 05:04:48 INFO - TEST-INFO | started process 3647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjsvP70/profile http://localhost:53420/getInfo.html) 05:04:51 INFO - PROCESS | 3647 | __metrics Screen width/height:1600/1200 05:04:51 INFO - PROCESS | 3647 | colorDepth:24 05:04:51 INFO - PROCESS | 3647 | Browser inner width/height: 1024/697 05:04:51 INFO - PROCESS | 3647 | __metrics 05:04:52 INFO - PROCESS | 3647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:04:52 ERROR - PROCESS | 3647 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:04:53 INFO - TEST-INFO | 3647: exit 0 05:04:53 INFO - Browser initialized. 05:04:53 INFO - Running cycle 1/1 for kraken test... 05:04:53 INFO - TEST-INFO | started process 3737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjsvP70/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:05 INFO - PROCESS | 3737 | RSS: Main: 145489920 05:05:05 INFO - PROCESS | 3737 | 05:05:08 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:53420/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53420/tests/kraken/driver.html?testName=audio-beat-detection) 05:05:08 INFO - PROCESS | 3737 | RSS: Main: 194646016 05:05:08 INFO - PROCESS | 3737 | 05:05:11 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:53420/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53420/tests/kraken/driver.html?testName=audio-dft) 05:05:12 INFO - PROCESS | 3737 | RSS: Main: 193142784 05:05:12 INFO - PROCESS | 3737 | 05:05:14 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:53420/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53420/tests/kraken/driver.html?testName=audio-fft) 05:05:15 INFO - PROCESS | 3737 | RSS: Main: 279150592 05:05:15 INFO - PROCESS | 3737 | 05:05:17 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:53420/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53420/tests/kraken/driver.html?testName=audio-oscillator) 05:05:18 INFO - PROCESS | 3737 | RSS: Main: 187666432 05:05:18 INFO - PROCESS | 3737 | 05:05:20 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:53420/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53420/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:05:20 INFO - PROCESS | 3737 | RSS: Main: 188223488 05:05:20 INFO - PROCESS | 3737 | 05:05:23 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:53420/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53420/tests/kraken/driver.html?testName=imaging-darkroom) 05:05:24 INFO - PROCESS | 3737 | RSS: Main: 222924800 05:05:24 INFO - PROCESS | 3737 | 05:05:27 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:53420/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53420/tests/kraken/driver.html?testName=imaging-desaturate) 05:05:28 INFO - PROCESS | 3737 | RSS: Main: 223166464 05:05:28 INFO - PROCESS | 3737 | 05:05:31 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:53420/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53420/tests/kraken/driver.html?testName=json-parse-financial) 05:05:31 INFO - PROCESS | 3737 | RSS: Main: 221794304 05:05:31 INFO - PROCESS | 3737 | 05:05:33 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:53420/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53420/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:05:33 INFO - PROCESS | 3737 | RSS: Main: 200437760 05:05:33 INFO - PROCESS | 3737 | 05:05:35 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:53420/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53420/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:05:36 INFO - PROCESS | 3737 | RSS: Main: 201080832 05:05:36 INFO - PROCESS | 3737 | 05:05:38 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:53420/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53420/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:05:38 INFO - PROCESS | 3737 | RSS: Main: 207474688 05:05:39 INFO - PROCESS | 3737 | 05:05:41 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:53420/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:05:42 INFO - PROCESS | 3737 | RSS: Main: 215793664 05:05:42 INFO - PROCESS | 3737 | 05:05:44 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:53420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:05:45 INFO - PROCESS | 3737 | RSS: Main: 215588864 05:05:45 INFO - PROCESS | 3737 | 05:05:46 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:53420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53420/tests/kraken/driver.html?testName=ai-astar) 05:05:47 INFO - PROCESS | 3737 | RSS: Main: 257425408 05:05:47 INFO - PROCESS | 3737 | 05:05:47 INFO - PROCESS | 3737 | __start_tp_report 05:05:47 INFO - PROCESS | 3737 | _x_x_mozilla_page_load 05:05:47 INFO - PROCESS | 3737 | _x_x_mozilla_page_load_details 05:05:47 INFO - PROCESS | 3737 | |i|pagename|runs| 05:05:47 INFO - PROCESS | 3737 | |0;ai-astar;110;105;109;110;110;110;110;111;110;109 05:05:47 INFO - PROCESS | 3737 | |1;audio-beat-detection;147;123;125;170;123;124;147;123;153;127 05:05:47 INFO - PROCESS | 3737 | |2;audio-dft;163;161;160;161;161;159;161;159;159;161 05:05:47 INFO - PROCESS | 3737 | |3;audio-fft;75;75;75;124;75;74;73;75;118;76 05:05:47 INFO - PROCESS | 3737 | |4;audio-oscillator;83;84;115;84;84;83;118;83;84;123 05:05:47 INFO - PROCESS | 3737 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 05:05:47 INFO - PROCESS | 3737 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;145;146 05:05:47 INFO - PROCESS | 3737 | |7;imaging-desaturate;95;94;96;95;95;95;95;95;95;95 05:05:47 INFO - PROCESS | 3737 | |8;json-parse-financial;58;50;50;51;50;51;52;51;53;51 05:05:47 INFO - PROCESS | 3737 | |9;json-stringify-tinderbox;60;60;59;59;64;60;58;59;58;59 05:05:47 INFO - PROCESS | 3737 | |10;stanford-crypto-aes;76;76;76;76;76;82;79;78;115;79 05:05:47 INFO - PROCESS | 3737 | |11;stanford-crypto-ccm;121;120;120;122;134;122;118;123;146;120 05:05:47 INFO - PROCESS | 3737 | |12;stanford-crypto-pbkdf2;155;151;153;156;157;155;150;155;156;149 05:05:47 INFO - PROCESS | 3737 | |13;stanford-crypto-sha256-iterative;62;61;61;60;60;60;59;60;59;61 05:05:47 INFO - PROCESS | 3737 | __end_tp_report 05:05:47 INFO - PROCESS | 3737 | __start_cc_report 05:05:47 INFO - PROCESS | 3737 | _x_x_mozilla_cycle_collect,1558 05:05:47 INFO - PROCESS | 3737 | __end_cc_report 05:05:47 INFO - PROCESS | 3737 | __startTimestamp1469448347214__endTimestamp 05:05:47 INFO - PROCESS | 3737 | 05:05:47 INFO - PROCESS | 3737 | ------- Summary: start ------- 05:05:47 INFO - PROCESS | 3737 | Number of tests: 14 05:05:47 INFO - PROCESS | 3737 | 05:05:47 INFO - PROCESS | 3737 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:1.65 (1.5%) stddev-sans-first:1.73 05:05:47 INFO - PROCESS | 3737 | Values: 110.0 105.0 109.0 110.0 110.0 110.0 110.0 111.0 110.0 109.0 05:05:47 INFO - PROCESS | 3737 | 05:05:47 INFO - PROCESS | 3737 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:137.00 stddev:16.80 (12.3%) stddev-sans-first:17.36 05:05:47 INFO - PROCESS | 3737 | Values: 147.0 123.0 125.0 170.0 123.0 124.0 147.0 123.0 153.0 127.0 05:05:47 INFO - PROCESS | 3737 | 05:05:47 INFO - PROCESS | 3737 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.27 (0.8%) stddev-sans-first:0.97 05:05:47 INFO - PROCESS | 3737 | Values: 163.0 161.0 160.0 161.0 161.0 159.0 161.0 159.0 159.0 161.0 05:05:47 INFO - PROCESS | 3737 | 05:05:47 INFO - PROCESS | 3737 | [#3] audio-fft Cycles:10 Average:84.00 Median:75.00 stddev:19.57 (26.1%) stddev-sans-first:20.48 05:05:47 INFO - PROCESS | 3737 | Values: 75.0 75.0 75.0 124.0 75.0 74.0 73.0 75.0 118.0 76.0 05:05:47 INFO - PROCESS | 3737 | 05:05:47 INFO - PROCESS | 3737 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:83.50 stddev:17.06 (20.4%) stddev-sans-first:17.62 05:05:47 INFO - PROCESS | 3737 | Values: 83.0 84.0 115.0 84.0 84.0 83.0 118.0 83.0 84.0 123.0 05:05:47 INFO - PROCESS | 3737 | 05:05:47 INFO - PROCESS | 3737 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:05:47 INFO - PROCESS | 3737 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 05:05:47 INFO - PROCESS | 3737 | 05:05:47 INFO - PROCESS | 3737 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 05:05:47 INFO - PROCESS | 3737 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 05:05:47 INFO - PROCESS | 3737 | 05:05:47 INFO - PROCESS | 3737 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 05:05:47 INFO - PROCESS | 3737 | Values: 95.0 94.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:05:47 INFO - PROCESS | 3737 | 05:05:47 INFO - PROCESS | 3737 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:51.00 stddev:2.41 (4.7%) stddev-sans-first:1.00 05:05:47 INFO - PROCESS | 3737 | Values: 58.0 50.0 50.0 51.0 50.0 51.0 52.0 51.0 53.0 51.0 05:05:47 INFO - PROCESS | 3737 | 05:05:47 INFO - PROCESS | 3737 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:59.50 stddev:1.71 (2.9%) stddev-sans-first:1.81 05:05:47 INFO - PROCESS | 3737 | Values: 60.0 60.0 59.0 59.0 64.0 60.0 58.0 59.0 58.0 59.0 05:05:47 INFO - PROCESS | 3737 | 05:05:47 INFO - PROCESS | 3737 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:77.00 stddev:12.01 (15.6%) stddev-sans-first:12.58 05:05:47 INFO - PROCESS | 3737 | Values: 76.0 76.0 76.0 76.0 76.0 82.0 79.0 78.0 115.0 79.0 05:05:47 INFO - PROCESS | 3737 | 05:05:47 INFO - PROCESS | 3737 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:122.00 stddev:8.71 (7.1%) stddev-sans-first:9.14 05:05:47 INFO - PROCESS | 3737 | Values: 121.0 120.0 120.0 122.0 134.0 122.0 118.0 123.0 146.0 120.0 05:05:47 INFO - PROCESS | 3737 | 05:05:47 INFO - PROCESS | 3737 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.70 Median:155.00 stddev:2.79 (1.8%) stddev-sans-first:2.92 05:05:47 INFO - PROCESS | 3737 | Values: 155.0 151.0 153.0 156.0 157.0 155.0 150.0 155.0 156.0 149.0 05:05:47 INFO - PROCESS | 3737 | 05:05:47 INFO - PROCESS | 3737 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.30 Median:60.50 stddev:0.95 (1.6%) stddev-sans-first:0.78 05:05:47 INFO - PROCESS | 3737 | Values: 62.0 61.0 61.0 60.0 60.0 60.0 59.0 60.0 59.0 61.0 05:05:47 INFO - PROCESS | 3737 | -------- Summary: end -------- 05:05:47 INFO - PROCESS | 3737 | 05:05:48 INFO - TEST-INFO | 3737: exit 0 05:05:48 INFO - TEST-OK | kraken | took 59972ms 05:05:48 INFO - SUITE-END | took 1173s 05:05:48 INFO - Completed test suite (00:19:34) 05:05:48 INFO - javascript benchmark 05:05:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3252.333271679305, 3330.4504756715137, 3349.7320214382853, 3384.712299454546, 3394.626591074983, 5438.7824487020525, 5543.36251331096, 5550.916736248954, 5559.777608895639, 5564.248826408434, 5435.239066530679, 5472.288602481682, 5480.095784195613, 5497.642653227547, 5498.120300751881, 4902.779374928136, 4963.851084467472, 4982.30247765314, 4999.600031997432, 5038.84883453497, 4961.429435614897, 4983.601311895058, 4988.925166122511, 5017.5484206421415, 5108.1060814357525, 5008.29883816266, 5017.37282839645, 5020.5983521318385, 5056.8482945511505, 5126.71803050832, 5057.165567681328, 5107.897842043139, 5117.590592752571, 5121.846344609649, 5136.409312929005, 4916.844541532737, 4940.777665005047, 4956.975215123937, 5001.599872010231, 5020.0, 5422.728863556807, 5428.321459817523, 5451.182322651594, 5479.04116779562, 5494.80768173116, 5647.1529270609735, 5933.19901813254, 5942.435468630473, 5943.3759455257, 5949.524038076944, 5837.036888913324, 5908.940910590882, 5917.497012753921, 5975.193348897887, 6005.939940600581, 5574.442555744434, 5578.30271216098, 5612.466815652507, 5613.663180209201, 5616.887662246773, 5889.617174883619, 5894.67579283135, 6052.606580572248, 6085.482733967662, 6107.144999700045, 5706.657600543981, 5766.163906233573, 5797.072468405035, 5802.3037235531165, 5803.303603567599, 5855.853603659857, 5872.794452194153, 5892.823215303548, 5905.763769449174, 5905.852353691106, 5628.127640215773, 5738.426157384228, 5785.0, 5800.854978625568, 5809.099589563624, 5843.970780146072, 5845.590808643439, 5847.298324201123, 5849.385814489502, 5859.853503662357, 4485.0, 4525.0497395546645, 4525.592696657317, 4533.84131555394, 4560.498345182027, 3956.8615098471414, 3978.3236849735613, 3983.1038016446646, 3993.940090898639, 4037.7375470594316, 5571.916421253684, 5583.581231407579, 5590.91613625796, 5597.244372009726, 5620.3255609326325, 5681.630694004876, 5895.941040589625, 5901.144334071536, 5907.675077870758, 5943.0, 5532.5297349724915, 5576.97211513948, 5579.609427340048, 5619.213310136584, 5642.633228840113, 5072.644914855925, 5082.542571168613, 5083.161278389099, 5086.567641750493, 5117.130087884994, 5916.083007133901, 6050.57645964787, 6197.938020619736, 6205.720742566596, 6216.906746398808, 5874.706264686834, 5938.881222375615, 5942.58401911862, 5944.167816505779, 5964.135200395832, 6152.384761523812, 6173.351798061319, 6184.690765461619, 6185.6907154641185, 6197.132401463708, 5619.381867994599, 5636.661800291996, 5637.661740295595, 5782.248307720138, 5792.507636850914, 5806.216160818404, 5811.128330750252, 5816.069428891357, 5826.184334193132, 5839.153322768259, 5634.126710359901, 5648.293963254593, 5648.4633959773755, 5648.661080335193, 5669.092945128925, 5512.118061110364, 5684.7157642118555, 5696.202531645656, 5730.598858079894, 5785.797497087582, 5690.430956904442, 5718.0, 5727.31272247333, 5728.455796699307, 5731.885362292647, 5818.679972601548, 5823.650580965155, 5878.441548052928, 5878.706064696663, 5880.117982302689, 5392.0, 5534.225208470898, 5551.750171242223, 5574.804881829116, 5594.692291923983], "value": 5429.113950513551, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.7091410665827, 657.5528640524444, 659.5745743995124, 664.9069130321755, 666.8866292730236, 33987.0, 36808.07979800503, 36851.81574092132, 36905.0, 36908.0, 37573.0, 47608.52391476093, 48756.0, 48952.26571601429, 52866.47133528673, 9153.771155721093, 9263.120003599648, 9274.582643781046, 9281.860772088425, 9294.488803115826, 8409.579521023956, 9066.274698024143, 9159.0, 9176.403533770284, 9177.678781242657, 10899.83650245243, 11150.330980141218, 11156.944215278912, 11544.826827597593, 11568.884311156908, 11081.667549973514, 11162.441877906072, 11167.274127181749, 11183.0, 11185.049270811991, 8344.749657510223, 8558.315334773204, 10443.216758743049, 10937.726556836064, 11016.669499915015, 45952.54047459516, 46369.30446043312, 46499.76750116228, 46553.76723116397, 46603.0, 3729.850805967758, 3741.139537906297, 3807.58116607173, 3891.9880830983866, 4142.1922725068625, 35053.649463505295, 35739.64260357415, 35751.0, 36064.45903311452, 36177.457338139946, 4616.307553866914, 4625.1443482955765, 4640.141573808823, 4674.883127921829, 4676.532346765331, 396095.0, 397928.0, 401412.9999999971, 401570.0, 401690.0, 65522.0, 65927.0, 65939.34060659428, 65971.34028659748, 65997.0, 67867.66066169637, 68013.0, 68126.318736812, 68166.31833681698, 68230.0, 18722.251109955723, 19342.903285483764, 19391.709124363148, 19399.515012124528, 19399.709004364944, 15151.924240378728, 15152.621184470256, 15227.543173704807, 15243.466478673194, 15246.313915873812, 16392.508224753277, 17626.471205863843, 18045.458636240935, 18106.547336316435, 18312.359067432575, 6043.7884674036195, 6177.413145751147, 6184.628922264678, 6218.160548325918, 6229.657368844757, 1073.307716522854, 1073.7100982734773, 1114.777044591085, 1163.5345861655405, 1173.3487914207526, 30475.390492190032, 32607.836960815042, 32757.344853102804, 32835.83582082074, 32976.17559560982, 1188.5602327139013, 1198.9700257493632, 1223.920445171061, 1227.6194379742308, 1239.8078297863844, 17777.733334, 17860.374886878897, 17991.73012404815, 18157.818421815613, 18211.90894045548, 610064.0, 612284.0, 613930.0, 616196.0, 617853.0, 63860.361396385444, 64065.0, 64123.0, 64150.6792466044, 64286.357136428975, 1364.8566900475505, 1366.1666383506054, 1447.8841692664773, 1459.8540145985316, 1474.8525147485166, 32031.67968320287, 36327.27345453023, 36572.45141322829, 36607.81696091503, 36643.26713465769, 55142.72428637992, 55354.0, 55826.0, 55876.44123558875, 55902.44097558972, 468743.0, 471265.0, 471749.0, 472671.0, 472951.0, 28028.159155225378, 30281.69718302789, 49545.25682114699, 50596.49403505918, 51072.0, 51506.742466287425, 54467.45532544782, 54876.72561637326, 55198.724006379714, 55717.721411394305, 47118.52881471279, 47212.7639361801, 47215.0, 47621.52378476171, 48347.516524834304, 46382.0, 46832.0, 47092.52907471018, 47561.79158136488, 47682.0, 46701.0, 47450.52549474599, 47518.76240618775, 48452.0, 49363.0, 38632.42051369288, 40479.0, 40766.18467630571, 41242.79378603088, 41647.0, 30375.240618984702, 30420.84789576038, 30471.39057218799, 30669.386612268077, 30885.227869303446], "value": 22091.11041884173, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.95800419958, 422.2462903716866, 422.9640480559152, 427.1926059747079, 439.4046067578431, 18419.0, 19586.118624661907, 19970.20119195232, 20865.791342086573, 21377.144914203414, 19473.51316217095, 19782.604347913035, 19811.603767924633, 20097.29659461919, 20116.89941550294, 5648.632838865471, 5841.6202946808535, 5877.324107727623, 5881.558883083786, 5886.058230683092, 4187.1416359646355, 4337.7180483268485, 5566.972165139189, 5824.417558244163, 6454.0641606966965, 6305.5901366411035, 6425.775097871552, 6437.903431448532, 6444.581102228363, 6491.578047426926, 6255.186825712628, 6303.086052522382, 6346.11154438379, 6352.618842869397, 6409.615423074607, 3905.316569600337, 5230.8692282692855, 5541.722913854291, 5733.111367738007, 5792.536597072266, 23454.296371108725, 23589.528209435888, 23614.40963975897, 23711.288661340186, 23736.287911362688, 2268.2854900706225, 2574.45936353366, 3099.550565168038, 3170.9048728538182, 3207.134073800084, 10516.211284153718, 10759.892401075967, 10821.458927053616, 10866.402347870864, 10926.781464370748, 2046.171036354203, 2086.248950377863, 2118.353902059871, 2178.705874706926, 2228.6322756745117, 81261.59369203175, 82217.58891205625, 83568.58215708882, 84344.15655843486, 84670.0, 11498.0, 11518.193726439069, 11560.248583842023, 11655.941720291345, 11888.108391870472, 16643.0, 16669.66660666804, 16744.0, 16794.412195573095, 16800.327986880387, 8005.91920090792, 8371.204735550113, 8491.660333586588, 8615.6984505542, 8705.564721764013, 8243.093259741423, 8244.83510329802, 8253.83492330162, 8299.543525106057, 8337.249647531751, 5053.343065401547, 5105.489451054939, 5170.97414512925, 5176.8964620707375, 5178.6374953752875, 1951.1219951022097, 1976.6738488149294, 2017.788132246093, 2045.0694933805082, 2046.2122082998153, 466.4822047527242, 523.3013926408288, 945.2201933404831, 1084.6637542361893, 1095.4905968724422, 12129.818052729217, 12880.355982200852, 12905.483780648856, 12912.741745165233, 13121.475140994444, 505.20682528430746, 506.27855306188536, 509.09381301283776, 513.6840842881601, 527.6939375162474, 6551.312112228243, 6843.589384636938, 6871.209810871714, 6906.412954898889, 6947.5831450113155, 451686.0, 458714.0, 461221.0, 472669.0, 554139.0, 64081.0, 68061.65969170221, 93954.0, 96604.51697741607, 110629.44685276522, 1066.7866426714688, 1078.9244752867223, 1093.3439936038471, 1094.8905109488987, 1097.6542389147394, 17857.28570857151, 17868.910655446638, 17875.28498860031, 17891.821081789014, 18284.908575457037, 42419.0, 42973.785131074146, 43310.350344745486, 43675.12649747051, 44666.0, 61498.38501614927, 61679.0, 62031.803263993854, 62319.0, 62590.0, 6882.69027893736, 7857.214278572097, 8602.354823388396, 8660.48037117775, 8801.603927823135, 12512.37438128108, 13226.603201903958, 13292.468301267842, 13452.730945381234, 13532.0, 11647.6505704829, 11866.644000679993, 11936.164468487123, 12131.575394861138, 12158.939205303917, 11395.202335836411, 11469.0, 11513.481893314653, 11815.113866459878, 11842.644720658394, 11180.496877640364, 11547.307161570332, 11943.581974630846, 11985.520579177084, 12208.877911220774, 7679.769606911802, 7888.723894663659, 8856.114388561093, 8875.866861996947, 8888.155625215593, 11368.204225704452, 11578.884211158118, 11598.246114002563, 11630.767384652429, 11699.181057325906], "value": 9054.292432117114, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.218677540578, 1516.5905205594486, 1551.2780813297238, 1737.5656085978505, 1877.258482899254, 8378.371622128341, 8708.825823483527, 8722.21500064994, 8737.606807693654, 8966.28269738421, 8435.91564084359, 8664.783380415493, 8918.464892106462, 8922.821543569125, 8922.91077089229, 2069.3998740365278, 2333.6616190652344, 2348.1664009276715, 2400.2679182849224, 2405.230326295586, 2427.0730417252917, 2461.5323088613104, 2463.3718401807514, 2469.9753002470015, 2470.419451428913, 2392.2225276785116, 2413.4690368118986, 2413.7103547574316, 2414.6860908081926, 2415.8188135889877, 2069.286096296775, 2315.9305220843316, 2370.8340416170877, 2373.6914201153913, 2395.4849707312837, 2330.5222429401933, 2332.6267797152545, 2334.8949297281665, 2336.1356298169617, 2366.857988520694, 9023.323250756153, 9055.275577953813, 9061.0, 9073.682421115229, 9081.545922703905, 5304.946950530522, 5445.237666726662, 5447.727613619343, 5451.563874889999, 5452.509274165304, 3388.9322213555592, 3483.5645544306963, 3522.7005704515145, 3528.311979164064, 3566.7146628269934, 1217.4643157010976, 1241.757857217843, 1242.3539759325101, 1247.7067889046066, 1282.5959822655834, 12768.297743624096, 12998.285094319903, 13013.414396352187, 13020.153690010215, 13026.739465210738, 4771.6898401603785, 4780.067886762048, 4824.372831531879, 4825.252085926687, 4852.733099679481, 10802.837957430645, 10860.076893463985, 10866.891331086588, 10992.670219893416, 11014.779704405866, 4850.151223535867, 5419.539339156216, 5427.891442171134, 5430.294061772023, 5430.484104010113, 4920.975395123001, 5019.949800502021, 5027.723475208825, 5079.187330027178, 5085.338905942278, 3943.4450346556864, 4067.9389809152885, 4191.691379868904, 4199.0552125772065, 4219.303814870574, 1298.6169080121388, 1315.986241962012, 1326.0452474218548, 1339.564641491519, 1347.2590075458654, 1003.2124782046204, 1027.2860362048455, 1044.8171569975225, 1045.4354648489882, 1046.1630695443614, 6338.841528961812, 6429.164208652939, 6528.445082167974, 6532.869342613121, 6537.640429776408, 482.97343646099097, 491.9065377578249, 497.48758778458244, 501.23561568608164, 519.1330478101579, 4469.173202957463, 4478.193925093515, 4501.369808226851, 4515.164694531522, 4531.252343363308, 10929.617463388902, 11177.161712871568, 11197.104231661448, 11204.159688023268, 11245.0, 10803.891961080288, 11038.613648522263, 11137.387443690675, 11164.553417863357, 11429.142814288962, 8337.95831020841, 8467.110953349933, 8467.32261419085, 8475.364347673949, 8484.36367272457, 6443.194600674916, 6547.0, 6598.208215014037, 6644.800655980328, 6808.251092379934, 10284.897151028394, 10400.687979360631, 10633.096186824207, 10667.733306667395, 10683.038526532338, 10686.89313106859, 10707.357558546511, 10904.0, 10937.234393592691, 11092.611758588411, 7236.167840698387, 7950.840983180419, 8113.35093192555, 8161.265486106279, 8206.22040906113, 9047.909520904706, 9088.500132492776, 9130.817383652422, 9174.311926605666, 9181.49501777382, 7888.566128862968, 7938.24586664266, 7972.681092756225, 8128.9593552031865, 8143.022837259567, 7939.325157361458, 8017.599120044091, 8038.678452862054, 8126.106128325998, 8189.140140285184, 7363.447741419523, 7460.738874139379, 7462.664180111799, 7473.588952607442, 7543.396528277615, 5620.1288800236025, 5650.208970744181, 5661.433856614306, 5699.088145896637, 5859.619124756877, 5543.334799824047, 5603.299587551556, 5646.0683987141665, 5669.858253543694, 5722.885542289047], "value": 4765.853916254977, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.5874867656166, 357.23016898583546, 364.51701495518427, 366.5747732630148, 372.9477873097765, 5293.258943747874, 5379.273798037264, 5391.81128660496, 5419.233632625322, 5451.100568406218, 5335.279737235472, 5344.599155063366, 5375.919361209585, 5391.406945236021, 5402.270693456382, 4190.350495673168, 4262.808173632194, 4278.25130602145, 4284.892877678052, 4317.611414972652, 4208.263553878074, 4255.659547236229, 4255.702100852942, 4273.529911709709, 4283.87148385549, 4248.4052232687445, 4251.744895306276, 4252.553481884404, 4261.488621365441, 4292.29177185764, 4190.413342132104, 4248.532661407243, 4260.104253607146, 4260.168127705086, 4304.31131019037, 3771.7548359356556, 3773.1887644156636, 3779.5842457329672, 3787.8295476703615, 3800.296945065144, 5141.820036298712, 5178.40448348441, 5179.0, 5187.377514698261, 5189.780401605657, 4612.86161415158, 4790.401199850019, 4799.832005879777, 4802.2316429371485, 4807.11068452334, 5500.4224556421395, 5502.0, 5505.201745746885, 5517.089680202762, 5535.114381698949, 4056.6146216109423, 4064.9390259146135, 4067.3085575452246, 4071.0026043619205, 4097.91804163918, 5583.664980101207, 5778.566607504412, 5791.420857914175, 5797.855053623651, 5820.272465941757, 4034.677225821927, 4084.14233011071, 4084.346504559256, 4087.8364865405647, 4105.158442519277, 4129.91740165195, 4151.629962112495, 4158.856314513533, 4159.729617574848, 4176.812043458051, 4657.580817726421, 4755.120302744003, 4769.880752981203, 4790.161721698689, 4795.808167673324, 5523.475269849358, 5534.529564987021, 5536.916946245809, 5538.9169162462595, 5577.9163312550345, 1442.9567112986626, 1458.4603696632103, 1464.2678660669665, 1471.279073254119, 1471.6173794813212, 932.4778124250441, 942.528735632184, 952.8999455057258, 961.0, 962.7737481691797, 4800.159872102304, 4828.275758636162, 4857.271409288564, 4871.634627402959, 4872.9512704872495, 5127.230915362726, 5170.6380553360905, 5171.5862730981435, 5172.948270517322, 5227.477252274818, 4652.464966528893, 4903.901921961612, 4947.925781113287, 4961.454240033593, 4963.205887058126, 2756.7656749176144, 2775.3894143288444, 2776.708445613222, 2776.958640509809, 2777.8333300002064, 5372.274742909657, 5373.462653734595, 5382.811601593926, 5388.191771234267, 5389.083855744533, 5078.5175408336145, 5128.435872054071, 5242.9213561796605, 5243.370795504564, 5264.368275806928, 5227.660202086852, 5276.947230527722, 5310.840674779763, 5357.919631205457, 5373.623846330719, 5130.204818253177, 5161.948380516297, 5174.6881995523645, 5178.637495375438, 5195.402528709247, 4791.203298762964, 5081.4664460232625, 5105.183170692671, 5107.310513080835, 5127.79488820443, 5275.868103297448, 5284.392294886137, 5288.788448462018, 5305.177697456746, 5384.380796208487, 3765.2657731742047, 3771.340015497332, 3834.9041273968373, 3867.226554689017, 3876.1666241758157, 4895.192293271571, 4945.466905259237, 5051.4443411224, 5085.516875896784, 5087.135187018142, 4949.950500494949, 4960.429550601582, 4981.875453113701, 4983.501649834988, 4984.5575667923185, 4930.13722598551, 4941.3563743398545, 4941.481144479922, 4943.901121977612, 4948.777305021211, 4690.6247500199215, 4917.901641967069, 4967.019788127095, 5010.649254552146, 5015.899682006267, 5057.544820966131, 5058.064258112261, 5069.797208111781, 5092.9745351273, 5112.616553758408, 4812.807487700453, 4928.669259300041, 4977.879977005145, 4998.975619749999, 5012.523810238022], "value": 4089.4497117634096, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [828.014662551564, 828.2256090555328, 854.9658013679449, 880.3485420788617, 913.9352654157908, 15417.22913854307, 16138.273777680004, 16431.260593273302, 16447.75328370074, 16509.257083431243, 14476.782848257259, 14581.708365832703, 14631.92684036581, 14656.413743450275, 14674.926625366857, 722.7687140115139, 849.3460035772451, 852.3735054734765, 860.789106668867, 868.9217970382664, 862.5169904853271, 870.3820287595814, 871.0331531999476, 871.1636828644508, 871.8910136232971, 904.9502277374742, 915.4095608332622, 915.455304094063, 916.1296768070326, 916.2029034739752, 749.1123019222211, 873.6243415331405, 900.7748062984253, 912.8311262416441, 913.5797533134765, 667.0261418329245, 668.0780522878446, 668.8929771236578, 669.1201070592156, 669.5246375073704, 15227.086374817436, 15254.923725381414, 15255.08469491834, 15367.15480648564, 15392.230388480642, 14866.702665946621, 15230.847691523053, 15317.923410382988, 15369.769453458208, 15525.611859703486, 13280.46878124874, 13670.658233544142, 13814.171149730948, 13910.443582256697, 13942.790858137034, 4730.668853180278, 4802.375691160162, 4854.2961270615915, 4858.246971719389, 4880.902381952376, 74331.0, 75629.24370756277, 75842.62078689571, 76117.0, 76920.0, 11838.0, 12043.21719088274, 12102.576409825613, 12175.086868484723, 12237.326947017822, 21940.670889936664, 21968.231111911005, 21976.34070977873, 21987.560248794933, 21988.450288742588, 8616.267617252604, 8650.601690107214, 8673.306135509145, 8887.066857979818, 9098.408603440756, 4949.158643030693, 4976.278439626306, 5073.695578265316, 5086.033653605803, 5138.640295179302, 3577.678008979204, 3706.8517259309865, 3709.4250391189407, 3711.0907827581877, 3718.8698395556025, 629.0909635576639, 629.858281886581, 637.8245982354797, 650.177525430331, 655.3381085104079, 672.9024291477708, 673.5958424944994, 682.276786606199, 710.5985118408083, 714.3356678289241, 10048.69853904384, 10358.741031474274, 10442.112420444195, 10469.790604187874, 10520.158387328995, 664.9966750166218, 673.1484671890063, 677.2178134254943, 677.2922296200483, 677.3362105136994, 4766.856994290177, 4847.927281090787, 5603.103503439512, 5727.0, 5957.285125784933, 78386.60806696044, 92263.5386823075, 124378.0, 126946.0, 129657.35171324083, 69209.65395172992, 106078.10492317975, 108625.45687271513, 110899.44550277197, 112740.43629781799, 98009.0, 99153.50423247837, 99992.0, 100843.0, 101405.49297253466, 10344.689659310232, 10676.83984740214, 10999.890001099886, 11066.612668556561, 11079.279846809932, 54432.727836360566, 54524.0, 55009.724951374985, 55304.72347638236, 55810.44189558052, 74870.0, 77886.61056694681, 81745.30725448813, 84620.15379846122, 84698.0, 14087.15477071379, 14143.858561414665, 14144.363503642566, 14314.979142589245, 14331.856681433052, 16006.919965400099, 16024.439144630349, 16362.55563159065, 16373.181340932668, 16448.506544803677, 14946.626334341729, 15308.846911530742, 15442.45951391696, 16439.424620138718, 16467.752983705013, 14274.072185307921, 14499.78250326267, 14828.0, 15216.0, 15627.843721563093, 13976.860231397555, 14527.78208326897, 14742.336594853043, 14955.027923184958, 15617.14105724196, 11769.588064417705, 12143.939280303543, 12352.567660131852, 12580.182288151242, 12733.108682392143, 12292.754144916873, 12396.81404778947, 12609.778869533437, 12717.55488557896, 12850.293233872228], "value": 8069.4421500787785, "unit": "score"}], "name": "dromaeo_css", "value": 7448.746182689055, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 109.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 125.0, 170.0, 123.0, 124.0, 147.0, 123.0, 153.0, 127.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 161.0, 161.0, 159.0, 161.0, 159.0, 159.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 124.0, 75.0, 74.0, 73.0, 75.0, 118.0, 76.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 115.0, 84.0, 84.0, 83.0, 118.0, 83.0, 84.0, 123.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 50.0, 50.0, 51.0, 50.0, 51.0, 52.0, 51.0, 53.0, 51.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 59.0, 64.0, 60.0, 58.0, 59.0, 58.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 76.0, 76.0, 82.0, 79.0, 78.0, 115.0, 79.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 120.0, 120.0, 122.0, 134.0, 122.0, 118.0, 123.0, 146.0, 120.0], "value": 124.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 151.0, 153.0, 156.0, 157.0, 155.0, 150.0, 155.0, 156.0, 149.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 61.0], "value": 60.3, "unit": "score"}], "name": "kraken", "value": 1473.1999999999998, "alertThreshold": 2.0}]} 05:05:48 INFO - Return code: 0 05:05:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:05:48 ERROR - # TBPL SUCCESS # 05:05:48 INFO - Running post-action listener: _resource_record_post_action 05:05:48 INFO - ##### 05:05:48 INFO - ##### Finished run-tests step (success) 05:05:48 INFO - ##### 05:05:48 INFO - Running post-run listener: _resource_record_post_run 05:05:48 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 7917568; Write bytes: 385208320; Read time: 1424; Write time: 288700 05:05:48 INFO - TinderboxPrint: CPU usage
13.2% 05:05:48 INFO - TinderboxPrint: I/O read bytes / time
7,917,568 / 1,424 05:05:48 INFO - TinderboxPrint: I/O write bytes / time
385,208,320 / 288,700 05:05:48 INFO - TinderboxPrint: CPU idle
8,252.4 (86.8%) 05:05:48 INFO - TinderboxPrint: CPU user
1,207.0 (12.7%) 05:05:48 INFO - TinderboxPrint: Swap in / out
0 / 0 05:05:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 9527296; Read time: 0; Write time: 4568 05:05:48 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 6156288; Write bytes: 375681024; Read time: 1324; Write time: 284132 05:05:49 INFO - Running post-run listener: _upload_blobber_files 05:05:49 INFO - Blob upload gear active. 05:05:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:05:49 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 05:05:49 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'] 05:05:49 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 05:05:49 INFO - (blobuploader) - INFO - Open directory for files ... 05:05:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:05:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:05:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:51 INFO - (blobuploader) - INFO - Done attempting. 05:05:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:05:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:06:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:11 INFO - (blobuploader) - INFO - Done attempting. 05:06:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:06:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:06:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:12 INFO - (blobuploader) - INFO - Done attempting. 05:06:12 INFO - (blobuploader) - INFO - Iteration through files over. 05:06:12 INFO - Return code: 0 05:06:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:06:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:06:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9613dc98c1007e9bbc2285922ae73fb57d05080dc81217d6b4f0348d8b8183f3519849835d823778f42e7be5b2c0d80cff3c49a8d5531ab280c783e0b066c29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a417fc8c253e9e32a2757187eea5d1eb9321a03b41117d5de9bf4c024a0e79b04305836caf2e39c1be42faa29be6e23073289adc6933cfe33dc0ccc495913679", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2fc0d39443a31373425d1731b6e590564b851bbf458f229619758c6e31833ff6913273d21d49ba174b745ba2c28b1d960dac2696b625cd00ea0e5b57c3b2860b"} 05:06:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:06:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:06:12 INFO - Contents: 05:06:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9613dc98c1007e9bbc2285922ae73fb57d05080dc81217d6b4f0348d8b8183f3519849835d823778f42e7be5b2c0d80cff3c49a8d5531ab280c783e0b066c29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a417fc8c253e9e32a2757187eea5d1eb9321a03b41117d5de9bf4c024a0e79b04305836caf2e39c1be42faa29be6e23073289adc6933cfe33dc0ccc495913679", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2fc0d39443a31373425d1731b6e590564b851bbf458f229619758c6e31833ff6913273d21d49ba174b745ba2c28b1d960dac2696b625cd00ea0e5b57c3b2860b"} 05:06:12 INFO - Running post-run listener: copy_logs_to_upload_dir 05:06:12 INFO - Copying logs to upload dir... 05:06:12 INFO - mkdir: /builds/slave/test/build/upload/logs 05:06:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.302537 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-07-25 05:06:12.593898) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 05:06:12.597818) ========= 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=ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541 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/d9613dc98c1007e9bbc2285922ae73fb57d05080dc81217d6b4f0348d8b8183f3519849835d823778f42e7be5b2c0d80cff3c49a8d5531ab280c783e0b066c29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a417fc8c253e9e32a2757187eea5d1eb9321a03b41117d5de9bf4c024a0e79b04305836caf2e39c1be42faa29be6e23073289adc6933cfe33dc0ccc495913679", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2fc0d39443a31373425d1731b6e590564b851bbf458f229619758c6e31833ff6913273d21d49ba174b745ba2c28b1d960dac2696b625cd00ea0e5b57c3b2860b"} build_url:https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/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/d9613dc98c1007e9bbc2285922ae73fb57d05080dc81217d6b4f0348d8b8183f3519849835d823778f42e7be5b2c0d80cff3c49a8d5531ab280c783e0b066c29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a417fc8c253e9e32a2757187eea5d1eb9321a03b41117d5de9bf4c024a0e79b04305836caf2e39c1be42faa29be6e23073289adc6933cfe33dc0ccc495913679", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2fc0d39443a31373425d1731b6e590564b851bbf458f229619758c6e31833ff6913273d21d49ba174b745ba2c28b1d960dac2696b625cd00ea0e5b57c3b2860b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 05:06:12.623666) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 05:06:12.624041) ========= 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=ed14279e38b05397cf4aa391000001a4-1469445434.417500-1605087541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004393 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 05:06:12.708599) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 05:06:12.709030) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 05:06:12.709674) ========= ========= Total master_lag: 0.17 =========