builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1470035277.05 results: success (0) buildid: 20160731213223 builduid: ac320091f307454abb38c4c3073acd14 revision: f3790db5cbcbc2084db461e050b58203de5879b4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 00:07:57.052097) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 00:07:57.052496) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 00:07:57.052769) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 00:07:57.090327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 00:07:57.090683) ========= 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=62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 00:07:57-- 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% 112M=0s 2016-08-01 00:07:57 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.347286 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 00:07:57.455825) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 00:07:57.456229) ========= 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=62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015206 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 00:07:57.506079) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 00:07:57.506439) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f3790db5cbcbc2084db461e050b58203de5879b4 --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 f3790db5cbcbc2084db461e050b58203de5879b4 --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=62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 00:07:57,522 truncating revision to first 12 chars 2016-08-01 00:07:57,522 Setting DEBUG logging. 2016-08-01 00:07:57,522 attempt 1/10 2016-08-01 00:07:57,522 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f3790db5cbcb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 00:07:57,836 unpacking tar archive at: mozilla-aurora-f3790db5cbcb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673090 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 00:07:58.194285) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 00:07:58.194633) ========= script_repo_revision: f3790db5cbcbc2084db461e050b58203de5879b4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 00:07:58.195027) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 00:07:58.195331) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 00:07:58.206953) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-01 00:07:58.207251) ========= /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=62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:07:58 INFO - MultiFileLogger online at 20160801 00:07:58 in /builds/slave/test 00:07:58 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 00:07:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:07:58 INFO - {'append_to_log': False, 00:07:58 INFO - 'base_work_dir': '/builds/slave/test', 00:07:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 00:07:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:07:58 INFO - 'branch': 'Mozilla-Aurora', 00:07:58 INFO - 'buildbot_json_path': 'buildprops.json', 00:07:58 INFO - 'config_files': ('talos/linux_config.py',), 00:07:58 INFO - 'default_actions': ('clobber', 00:07:58 INFO - 'read-buildbot-config', 00:07:58 INFO - 'download-and-extract', 00:07:58 INFO - 'populate-webroot', 00:07:58 INFO - 'create-virtualenv', 00:07:58 INFO - 'install', 00:07:58 INFO - 'run-tests'), 00:07:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:07:58 INFO - 'download_minidump_stackwalk': True, 00:07:58 INFO - 'download_symbols': 'ondemand', 00:07:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:07:58 INFO - 'tooltool.py': '/tools/tooltool.py', 00:07:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:07:58 INFO - '/tools/misc-python/virtualenv.py')}, 00:07:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:07:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:07:58 INFO - 'installer_path': 'installer.exe', 00:07:58 INFO - 'log_level': 'info', 00:07:58 INFO - 'log_name': 'talos', 00:07:58 INFO - 'log_to_console': True, 00:07:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:07:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:07:58 INFO - 'opt_config_files': (), 00:07:58 INFO - 'pip_index': False, 00:07:58 INFO - 'sps_profile': False, 00:07:58 INFO - 'sps_profile_interval': 0, 00:07:58 INFO - 'suite': 'dromaeojs', 00:07:58 INFO - 'system_bits': '32', 00:07:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:07:58 INFO - 'title': 'talos-linux64-ix-018', 00:07:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:07:58 INFO - 'use_talos_json': True, 00:07:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:07:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:07:58 INFO - 'work_dir': 'build'} 00:07:58 INFO - ##### 00:07:58 INFO - ##### Running clobber step. 00:07:58 INFO - ##### 00:07:58 INFO - Running pre-action listener: _resource_record_pre_action 00:07:58 INFO - Running main action method: clobber 00:07:58 INFO - rmtree: /builds/slave/test/build 00:07:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:07:59 INFO - Running post-action listener: _resource_record_post_action 00:07:59 INFO - ##### 00:07:59 INFO - ##### Finished clobber step (success) 00:07:59 INFO - ##### 00:07:59 INFO - ##### 00:07:59 INFO - ##### Running read-buildbot-config step. 00:07:59 INFO - ##### 00:07:59 INFO - Running pre-action listener: _resource_record_pre_action 00:07:59 INFO - Running main action method: read_buildbot_config 00:07:59 INFO - Using buildbot properties: 00:07:59 INFO - { 00:07:59 INFO - "project": "", 00:07:59 INFO - "product": "firefox", 00:07:59 INFO - "script_repo_revision": "production", 00:07:59 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 00:07:59 INFO - "repository": "", 00:07:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 00:07:59 INFO - "buildid": "20160731213223", 00:07:59 INFO - "pgo_build": "True", 00:07:59 INFO - "basedir": "/builds/slave/test", 00:07:59 INFO - "buildnumber": 646, 00:07:59 INFO - "slavename": "talos-linux64-ix-018", 00:07:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:07:59 INFO - "platform": "ubuntu64_hw", 00:07:59 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 00:07:59 INFO - "branch": "mozilla-aurora", 00:07:59 INFO - "repo_path": "releases/mozilla-aurora", 00:07:59 INFO - "revision": "f3790db5cbcbc2084db461e050b58203de5879b4", 00:07:59 INFO - "stage_platform": "linux64-pgo", 00:07:59 INFO - "builduid": "ac320091f307454abb38c4c3073acd14", 00:07:59 INFO - "slavebuilddir": "test" 00:07:59 INFO - } 00:07:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 00:07:59 INFO - Running post-action listener: _resource_record_post_action 00:07:59 INFO - ##### 00:07:59 INFO - ##### Finished read-buildbot-config step (success) 00:07:59 INFO - ##### 00:07:59 INFO - ##### 00:07:59 INFO - ##### Running download-and-extract step. 00:07:59 INFO - ##### 00:07:59 INFO - Running pre-action listener: _resource_record_pre_action 00:07:59 INFO - Running main action method: download_and_extract 00:07:59 INFO - mkdir: /builds/slave/test/build/tests 00:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:07:59 INFO - https://queue.taskcluster.net/v1/task/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:07:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 00:07:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 00:07:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/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 00:07:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/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 00:08:02 INFO - Downloaded 1361 bytes. 00:08:02 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 00:08:02 INFO - Using the following test package requirements: 00:08:02 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 00:08:02 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 00:08:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 00:08:02 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 00:08:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 00:08:02 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 00:08:02 INFO - u'jsshell-linux-x86_64.zip'], 00:08:02 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 00:08:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 00:08:02 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 00:08:02 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 00:08:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 00:08:02 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 00:08:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 00:08:02 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 00:08:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 00:08:02 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 00:08:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 00:08:02 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:08:02 INFO - https://queue.taskcluster.net/v1/task/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:08:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 00:08:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 00:08:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/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 00:08:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/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 00:08:07 INFO - Downloaded 21970445 bytes. 00:08:07 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'] 00:08:07 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 00:08:08 INFO - Return code: 0 00:08:08 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 00:08: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')]} 00:08:08 INFO - https://queue.taskcluster.net/v1/task/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:08:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 00:08:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 00:08:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/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 00:08:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/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 00:08:10 INFO - Downloaded 21970445 bytes. 00:08:10 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'] 00:08:10 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 00:08:12 INFO - Return code: 0 00:08: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')]} 00:08:12 INFO - https://queue.taskcluster.net/v1/task/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:08:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 00:08:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 00:08:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/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 00:08:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/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 00:08:14 INFO - Downloaded 10833369 bytes. 00:08:14 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'] 00:08:14 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 00:08:14 INFO - Return code: 0 00:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:08:14 INFO - https://queue.taskcluster.net/v1/task/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:08:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 00:08:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 00:08:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/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 00:08:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N-qfo_KAQjGUo0eEZ129eg/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 00:08:16 INFO - Downloaded 61987527 bytes. 00:08:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 00:08:16 INFO - mkdir: /builds/slave/test/properties 00:08:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:08:16 INFO - Writing to file /builds/slave/test/properties/build_url 00:08:16 INFO - Contents: 00:08:16 INFO - build_url:https://queue.taskcluster.net/v1/task/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 00:08:16 INFO - Running post-action listener: _resource_record_post_action 00:08:16 INFO - Running post-action listener: set_extra_try_arguments 00:08:16 INFO - ##### 00:08:16 INFO - ##### Finished download-and-extract step (success) 00:08:16 INFO - ##### 00:08:16 INFO - ##### 00:08:16 INFO - ##### Running populate-webroot step. 00:08:16 INFO - ##### 00:08:16 INFO - Running pre-action listener: _resource_record_pre_action 00:08:16 INFO - Running main action method: populate_webroot 00:08:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:08:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:08:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:08:16 INFO - '--tppagecycles', 00:08:16 INFO - '7'], 00:08:16 INFO - 'tests': ['tsvgm']}}, 00:08:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:08:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:08:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:08:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:08:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:08:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:08:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:08:16 INFO - 'talos_options': ['--disable-e10s'], 00:08:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:08:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:08:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:08:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:08:16 INFO - 'talos_options': ['--disable-e10s'], 00:08:16 INFO - 'tests': ['damp', 'tps']}, 00:08:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:08:16 INFO - 'tests': ['damp', 'tps']}, 00:08:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:08:16 INFO - 'tests': ['dromaeo_dom']}, 00:08:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:08:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:08:16 INFO - 'tests': ['a11yr', 00:08:16 INFO - 'ts_paint', 00:08:16 INFO - 'tpaint', 00:08:16 INFO - 'sessionrestore', 00:08:16 INFO - 'sessionrestore_no_auto_restore', 00:08:16 INFO - 'tabpaint']}, 00:08:16 INFO - 'other-e10s': {'tests': ['a11yr', 00:08:16 INFO - 'ts_paint', 00:08:16 INFO - 'tpaint', 00:08:16 INFO - 'sessionrestore', 00:08:16 INFO - 'sessionrestore_no_auto_restore', 00:08:16 INFO - 'tabpaint']}, 00:08:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:08:16 INFO - 'ts_paint', 00:08:16 INFO - 'tpaint', 00:08:16 INFO - 'sessionrestore', 00:08:16 INFO - 'sessionrestore_no_auto_restore', 00:08:16 INFO - 'tabpaint']}, 00:08:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:08:16 INFO - 'ts_paint', 00:08:16 INFO - 'tpaint', 00:08:16 INFO - 'sessionrestore', 00:08:16 INFO - 'sessionrestore_no_auto_restore', 00:08:16 INFO - 'tabpaint']}, 00:08:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:08:16 INFO - 'tests': ['a11yr', 00:08:16 INFO - 'ts_paint', 00:08:16 INFO - 'tpaint', 00:08:16 INFO - 'sessionrestore', 00:08:16 INFO - 'sessionrestore_no_auto_restore', 00:08:16 INFO - 'tabpaint']}, 00:08:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:08:16 INFO - 'tests': ['a11yr', 00:08:16 INFO - 'ts_paint', 00:08:16 INFO - 'tpaint', 00:08:16 INFO - 'sessionrestore', 00:08:16 INFO - 'sessionrestore_no_auto_restore', 00:08:16 INFO - 'tabpaint']}, 00:08:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:08:16 INFO - 'tests': ['tsvgx', 00:08:16 INFO - 'tsvgr_opacity', 00:08:16 INFO - 'tart', 00:08:16 INFO - 'tscrollx', 00:08:16 INFO - 'cart']}, 00:08:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:08:16 INFO - 'tsvgr_opacity', 00:08:16 INFO - 'tart', 00:08:16 INFO - 'tscrollx', 00:08:16 INFO - 'cart']}, 00:08:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:08:16 INFO - 'talos_options': ['--disable-e10s'], 00:08:16 INFO - 'tests': ['tp5o']}, 00:08:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:08:16 INFO - 'tests': ['tp5o']}, 00:08:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:08:16 INFO - 'talos_options': ['--disable-e10s', 00:08:16 INFO - '--xperf_path', 00:08:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:08:16 INFO - 'tests': ['tp5n']}, 00:08:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:08:16 INFO - 'talos_options': ['--xperf_path', 00:08:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:08:16 INFO - 'tests': ['tp5n']}}, 00:08:16 INFO - 'talos.zip': {'path': '', 00:08:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:08:16 INFO - Running post-action listener: _resource_record_post_action 00:08:16 INFO - ##### 00:08:16 INFO - ##### Finished populate-webroot step (success) 00:08:16 INFO - ##### 00:08:16 INFO - ##### 00:08:16 INFO - ##### Running create-virtualenv step. 00:08:16 INFO - ##### 00:08:16 INFO - Running pre-action listener: _resource_record_pre_action 00:08:16 INFO - Running main action method: create_virtualenv 00:08:16 INFO - Creating virtualenv /builds/slave/test/build/venv 00:08:16 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 00:08:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:08:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:08:17 INFO - Using real prefix '/usr' 00:08:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:08:17 INFO - Installing distribute.............................................................................................................................................................................................done. 00:08:19 INFO - Installing pip.................done. 00:08:19 INFO - Return code: 0 00:08:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:08:19 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')]} 00:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:19 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')]} 00:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:19 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 0x7f4b78135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc81c0>, '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 0xdc90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc9550>, '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': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', '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 00:08:19 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 00:08:19 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 00:08:19 INFO - Using env: {'DISPLAY': ':0', 00:08:19 INFO - 'HOME': '/home/cltbld', 00:08:19 INFO - 'LANG': 'en_US.UTF-8', 00:08:19 INFO - 'LANGUAGE': 'en_US:en', 00:08:19 INFO - 'LOGNAME': 'cltbld', 00:08:19 INFO - 'MAIL': '/var/mail/cltbld', 00:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:19 INFO - 'MOZ_NO_REMOTE': '1', 00:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:19 INFO - 'NO_EM_RESTART': '1', 00:08:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:19 INFO - 'PWD': '/builds/slave/test', 00:08:19 INFO - 'SHELL': '/bin/bash', 00:08:19 INFO - 'SHLVL': '1', 00:08:19 INFO - 'TERM': 'linux', 00:08:19 INFO - 'TMOUT': '86400', 00:08:19 INFO - 'USER': 'cltbld', 00:08:19 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', 00:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:19 INFO - '_': '/tools/buildbot/bin/python'} 00:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:19 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 00:08:19 INFO - Cleaning up... 00:08:19 INFO - Return code: 0 00:08:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:08:19 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')]} 00:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:19 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')]} 00:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:19 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 0x7f4b78135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc81c0>, '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 0xdc90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc9550>, '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': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', '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 00:08:19 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 00:08:19 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 00:08:19 INFO - Using env: {'DISPLAY': ':0', 00:08:19 INFO - 'HOME': '/home/cltbld', 00:08:19 INFO - 'LANG': 'en_US.UTF-8', 00:08:19 INFO - 'LANGUAGE': 'en_US:en', 00:08:19 INFO - 'LOGNAME': 'cltbld', 00:08:19 INFO - 'MAIL': '/var/mail/cltbld', 00:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:19 INFO - 'MOZ_NO_REMOTE': '1', 00:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:19 INFO - 'NO_EM_RESTART': '1', 00:08:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:19 INFO - 'PWD': '/builds/slave/test', 00:08:19 INFO - 'SHELL': '/bin/bash', 00:08:19 INFO - 'SHLVL': '1', 00:08:19 INFO - 'TERM': 'linux', 00:08:19 INFO - 'TMOUT': '86400', 00:08:19 INFO - 'USER': 'cltbld', 00:08:19 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', 00:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:19 INFO - '_': '/tools/buildbot/bin/python'} 00:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:19 INFO - Downloading/unpacking psutil>=3.1.1 00:08:19 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 00:08:19 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 00:08:19 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 00:08:19 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 00:08:19 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 00:08:19 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 00:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:08:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:08:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:08:21 INFO - Installing collected packages: psutil 00:08:21 INFO - Running setup.py install for psutil 00:08:22 INFO - building 'psutil._psutil_linux' extension 00:08:22 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 00:08:22 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 00:08:22 INFO - building 'psutil._psutil_posix' extension 00:08:22 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 00:08:22 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 00:08:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:08:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:08:22 INFO - Successfully installed psutil 00:08:22 INFO - Cleaning up... 00:08:22 INFO - Return code: 0 00:08:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4b78135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc81c0>, '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 0xdc90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc9550>, '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': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', '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 00:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:08:22 INFO - Using env: {'DISPLAY': ':0', 00:08:22 INFO - 'HOME': '/home/cltbld', 00:08:22 INFO - 'LANG': 'en_US.UTF-8', 00:08:22 INFO - 'LANGUAGE': 'en_US:en', 00:08:22 INFO - 'LOGNAME': 'cltbld', 00:08:22 INFO - 'MAIL': '/var/mail/cltbld', 00:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:22 INFO - 'MOZ_NO_REMOTE': '1', 00:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:22 INFO - 'NO_EM_RESTART': '1', 00:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:22 INFO - 'PWD': '/builds/slave/test', 00:08:22 INFO - 'SHELL': '/bin/bash', 00:08:22 INFO - 'SHLVL': '1', 00:08:22 INFO - 'TERM': 'linux', 00:08:22 INFO - 'TMOUT': '86400', 00:08:22 INFO - 'USER': 'cltbld', 00:08:22 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', 00:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:22 INFO - '_': '/tools/buildbot/bin/python'} 00:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:08:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:08:24 INFO - Installing collected packages: mozsystemmonitor 00:08:24 INFO - Running setup.py install for mozsystemmonitor 00:08:25 INFO - Successfully installed mozsystemmonitor 00:08:25 INFO - Cleaning up... 00:08:25 INFO - Return code: 0 00:08:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:08:25 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')]} 00:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:25 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')]} 00:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:25 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 0x7f4b78135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc81c0>, '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 0xdc90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc9550>, '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': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', '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 00:08:25 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 00:08:25 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 00:08:25 INFO - Using env: {'DISPLAY': ':0', 00:08:25 INFO - 'HOME': '/home/cltbld', 00:08:25 INFO - 'LANG': 'en_US.UTF-8', 00:08:25 INFO - 'LANGUAGE': 'en_US:en', 00:08:25 INFO - 'LOGNAME': 'cltbld', 00:08:25 INFO - 'MAIL': '/var/mail/cltbld', 00:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:25 INFO - 'MOZ_NO_REMOTE': '1', 00:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:25 INFO - 'NO_EM_RESTART': '1', 00:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:25 INFO - 'PWD': '/builds/slave/test', 00:08:25 INFO - 'SHELL': '/bin/bash', 00:08:25 INFO - 'SHLVL': '1', 00:08:25 INFO - 'TERM': 'linux', 00:08:25 INFO - 'TMOUT': '86400', 00:08:25 INFO - 'USER': 'cltbld', 00:08:25 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', 00:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:25 INFO - '_': '/tools/buildbot/bin/python'} 00:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:25 INFO - Downloading/unpacking jsonschema==2.5.1 00:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:08:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:27 INFO - Downloading functools32-3.2.3-2.tar.gz 00:08:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:08:27 INFO - warning: no files found matching '*.txt' 00:08:27 INFO - no previously-included directories found matching 'build' 00:08:27 INFO - no previously-included directories found matching 'dist' 00:08:27 INFO - no previously-included directories found matching '.git*' 00:08:27 INFO - Installing collected packages: jsonschema, functools32 00:08:27 INFO - Running setup.py install for functools32 00:08:27 INFO - warning: no files found matching '*.txt' 00:08:27 INFO - no previously-included directories found matching 'build' 00:08:27 INFO - no previously-included directories found matching 'dist' 00:08:27 INFO - no previously-included directories found matching '.git*' 00:08:27 INFO - Successfully installed jsonschema functools32 00:08:27 INFO - Cleaning up... 00:08:27 INFO - Return code: 0 00:08:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:08:27 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')]} 00:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:27 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')]} 00:08:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:27 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 0x7f4b78135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc81c0>, '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 0xdc90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc9550>, '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': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', '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 00:08:27 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 00:08:27 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 00:08:27 INFO - Using env: {'DISPLAY': ':0', 00:08:27 INFO - 'HOME': '/home/cltbld', 00:08:27 INFO - 'LANG': 'en_US.UTF-8', 00:08:27 INFO - 'LANGUAGE': 'en_US:en', 00:08:27 INFO - 'LOGNAME': 'cltbld', 00:08:27 INFO - 'MAIL': '/var/mail/cltbld', 00:08:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:27 INFO - 'MOZ_NO_REMOTE': '1', 00:08:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:27 INFO - 'NO_EM_RESTART': '1', 00:08:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:27 INFO - 'PWD': '/builds/slave/test', 00:08:27 INFO - 'SHELL': '/bin/bash', 00:08:27 INFO - 'SHLVL': '1', 00:08:27 INFO - 'TERM': 'linux', 00:08:27 INFO - 'TMOUT': '86400', 00:08:27 INFO - 'USER': 'cltbld', 00:08:27 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', 00:08:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:27 INFO - '_': '/tools/buildbot/bin/python'} 00:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:28 INFO - Downloading/unpacking blobuploader==1.2.4 00:08:28 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 00:08:28 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 00:08:28 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 00:08:28 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 00:08:28 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 00:08:28 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 00:08:29 INFO - Downloading blobuploader-1.2.4.tar.gz 00:08:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:08:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:08:30 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 00:08:30 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 00:08:30 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 00:08:30 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 00:08:30 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 00:08:30 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 00:08:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:08:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:08:30 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 00:08:30 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 00:08:30 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 00:08:30 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 00:08:30 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 00:08:30 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 00:08:30 INFO - Downloading docopt-0.6.1.tar.gz 00:08:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:08:30 INFO - Installing collected packages: blobuploader, requests, docopt 00:08:30 INFO - Running setup.py install for blobuploader 00:08:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:08:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:08:30 INFO - Running setup.py install for requests 00:08:31 INFO - Running setup.py install for docopt 00:08:31 INFO - Successfully installed blobuploader requests docopt 00:08:31 INFO - Cleaning up... 00:08:31 INFO - Return code: 0 00:08:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:31 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 0x7f4b78135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc81c0>, '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 0xdc90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc9550>, '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': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', '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 00:08:31 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 00:08:31 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 00:08:31 INFO - Using env: {'DISPLAY': ':0', 00:08:31 INFO - 'HOME': '/home/cltbld', 00:08:31 INFO - 'LANG': 'en_US.UTF-8', 00:08:31 INFO - 'LANGUAGE': 'en_US:en', 00:08:31 INFO - 'LOGNAME': 'cltbld', 00:08:31 INFO - 'MAIL': '/var/mail/cltbld', 00:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:31 INFO - 'MOZ_NO_REMOTE': '1', 00:08:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:31 INFO - 'NO_EM_RESTART': '1', 00:08:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:31 INFO - 'PWD': '/builds/slave/test', 00:08:31 INFO - 'SHELL': '/bin/bash', 00:08:31 INFO - 'SHLVL': '1', 00:08:31 INFO - 'TERM': 'linux', 00:08:31 INFO - 'TMOUT': '86400', 00:08:31 INFO - 'USER': 'cltbld', 00:08:31 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', 00:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:31 INFO - '_': '/tools/buildbot/bin/python'} 00:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:08:31 INFO - Running setup.py (path:/tmp/pip-OXDp0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:08:31 INFO - Running setup.py (path:/tmp/pip-sbLnke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:08:31 INFO - Running setup.py (path:/tmp/pip-igKC4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:08:31 INFO - Running setup.py (path:/tmp/pip-qfuGGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:08:31 INFO - Running setup.py (path:/tmp/pip-wOth2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:08:31 INFO - Running setup.py (path:/tmp/pip-F_87WN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:08:31 INFO - Running setup.py (path:/tmp/pip-iC2ypo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:08:32 INFO - Running setup.py (path:/tmp/pip-Xa4MxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:08:32 INFO - Running setup.py (path:/tmp/pip-lU27VM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:08:32 INFO - Running setup.py (path:/tmp/pip-7O4NYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:08:32 INFO - Running setup.py (path:/tmp/pip-DQ_2Uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:08:32 INFO - Running setup.py (path:/tmp/pip-d6Gqas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:08:32 INFO - Running setup.py (path:/tmp/pip-dHnvB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:08:32 INFO - Running setup.py (path:/tmp/pip-OoBSbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:08:32 INFO - Running setup.py (path:/tmp/pip-0C6D9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:08:32 INFO - Running setup.py (path:/tmp/pip-LbrvGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:08:32 INFO - Running setup.py (path:/tmp/pip-FY55aV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:08:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:08:32 INFO - Running setup.py install for manifestparser 00:08:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:08:32 INFO - Running setup.py install for mozcrash 00:08:32 INFO - Running setup.py install for mozdebug 00:08:33 INFO - Running setup.py install for mozdevice 00:08:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:08:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:08:33 INFO - Running setup.py install for mozfile 00:08:33 INFO - Running setup.py install for mozhttpd 00:08:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:08:33 INFO - Running setup.py install for mozinfo 00:08:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:08:33 INFO - Running setup.py install for mozInstall 00:08:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:08:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:08:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:08:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:08:33 INFO - Running setup.py install for mozleak 00:08:33 INFO - Running setup.py install for mozlog 00:08:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:08:33 INFO - Running setup.py install for moznetwork 00:08:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:08:33 INFO - Running setup.py install for mozprocess 00:08:33 INFO - Running setup.py install for mozprofile 00:08:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:08:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:08:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:08:34 INFO - Running setup.py install for mozrunner 00:08:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:08:34 INFO - Running setup.py install for mozscreenshot 00:08:34 INFO - Running setup.py install for moztest 00:08:34 INFO - Running setup.py install for mozversion 00:08:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:08:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:08:34 INFO - Cleaning up... 00:08:34 INFO - Return code: 0 00:08:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:34 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 0x7f4b78135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc81c0>, '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 0xdc90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc9550>, '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': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', '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 00:08:34 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 00:08:34 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 00:08:34 INFO - Using env: {'DISPLAY': ':0', 00:08:34 INFO - 'HOME': '/home/cltbld', 00:08:34 INFO - 'LANG': 'en_US.UTF-8', 00:08:34 INFO - 'LANGUAGE': 'en_US:en', 00:08:34 INFO - 'LOGNAME': 'cltbld', 00:08:34 INFO - 'MAIL': '/var/mail/cltbld', 00:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:34 INFO - 'MOZ_NO_REMOTE': '1', 00:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:34 INFO - 'NO_EM_RESTART': '1', 00:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:34 INFO - 'PWD': '/builds/slave/test', 00:08:34 INFO - 'SHELL': '/bin/bash', 00:08:34 INFO - 'SHLVL': '1', 00:08:34 INFO - 'TERM': 'linux', 00:08:34 INFO - 'TMOUT': '86400', 00:08:34 INFO - 'USER': 'cltbld', 00:08:34 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', 00:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:34 INFO - '_': '/tools/buildbot/bin/python'} 00:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:08:34 INFO - Running setup.py (path:/tmp/pip-40CrF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:08:34 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)) 00:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:08:34 INFO - Running setup.py (path:/tmp/pip-5j5Ugr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:08:34 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)) 00:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:08:34 INFO - Running setup.py (path:/tmp/pip-yTkffV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:08:34 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)) 00:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:08:34 INFO - Running setup.py (path:/tmp/pip-G57qIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:08:35 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)) 00:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:08:35 INFO - Running setup.py (path:/tmp/pip-vmGrNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:08:35 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)) 00:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:08:35 INFO - Running setup.py (path:/tmp/pip-OLavzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:08:35 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)) 00:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:08:35 INFO - Running setup.py (path:/tmp/pip-9WELO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:08:35 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)) 00:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:08:35 INFO - Running setup.py (path:/tmp/pip-13zBne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:08:35 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)) 00:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:08:35 INFO - Running setup.py (path:/tmp/pip-yKyRGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:08:35 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)) 00:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:08:35 INFO - Running setup.py (path:/tmp/pip-kkWjIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:08:35 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)) 00:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:08:35 INFO - Running setup.py (path:/tmp/pip-0efsM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:08:35 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)) 00:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:08:35 INFO - Running setup.py (path:/tmp/pip-jHoMUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:08:35 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)) 00:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:08:35 INFO - Running setup.py (path:/tmp/pip-CSVvU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:08:35 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)) 00:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:08:35 INFO - Running setup.py (path:/tmp/pip-4gHMqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:08:35 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)) 00:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:08:35 INFO - Running setup.py (path:/tmp/pip-JGegh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:08:35 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)) 00:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:08:35 INFO - Running setup.py (path:/tmp/pip-CJKQt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:08:35 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)) 00:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:08:35 INFO - Running setup.py (path:/tmp/pip-mQZVmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:08:35 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)) 00:08:35 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)) 00:08:35 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)) 00:08:35 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)) 00:08:35 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)) 00:08:35 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)) 00:08:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:37 INFO - Downloading blessings-1.6.tar.gz 00:08:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:08:37 INFO - Installing collected packages: blessings 00:08:37 INFO - Running setup.py install for blessings 00:08:38 INFO - Successfully installed blessings 00:08:38 INFO - Cleaning up... 00:08:38 INFO - Return code: 0 00:08:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:08:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:08:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:08:38 INFO - Reading from file tmpfile_stdout 00:08:38 INFO - Current package versions: 00:08:38 INFO - argparse == 1.2.1 00:08:38 INFO - blessings == 1.6 00:08:38 INFO - blobuploader == 1.2.4 00:08:38 INFO - docopt == 0.6.1 00:08:38 INFO - functools32 == 3.2.3-2 00:08:38 INFO - jsonschema == 2.5.1 00:08:38 INFO - manifestparser == 1.1 00:08:38 INFO - mozInstall == 1.12 00:08:38 INFO - mozcrash == 0.17 00:08:38 INFO - mozdebug == 0.1 00:08:38 INFO - mozdevice == 0.48 00:08:38 INFO - mozfile == 1.2 00:08:38 INFO - mozhttpd == 0.7 00:08:38 INFO - mozinfo == 0.9 00:08:38 INFO - mozleak == 0.1 00:08:38 INFO - mozlog == 3.2 00:08:38 INFO - moznetwork == 0.27 00:08:38 INFO - mozprocess == 0.23 00:08:38 INFO - mozprofile == 0.28 00:08:38 INFO - mozrunner == 6.12 00:08:38 INFO - mozscreenshot == 0.1 00:08:38 INFO - mozsystemmonitor == 0.3 00:08:38 INFO - moztest == 0.7 00:08:38 INFO - mozversion == 1.4 00:08:38 INFO - psutil == 3.1.1 00:08:38 INFO - requests == 1.2.3 00:08:38 INFO - wsgiref == 0.1.2 00:08:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:08:38 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')]} 00:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:38 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')]} 00:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:38 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 0x7f4b78135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc81c0>, '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 0xdc90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc9550>, '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': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', '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 00:08:38 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 00:08:38 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 00:08:38 INFO - Using env: {'DISPLAY': ':0', 00:08:38 INFO - 'HOME': '/home/cltbld', 00:08:38 INFO - 'LANG': 'en_US.UTF-8', 00:08:38 INFO - 'LANGUAGE': 'en_US:en', 00:08:38 INFO - 'LOGNAME': 'cltbld', 00:08:38 INFO - 'MAIL': '/var/mail/cltbld', 00:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:38 INFO - 'MOZ_NO_REMOTE': '1', 00:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:38 INFO - 'NO_EM_RESTART': '1', 00:08:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:38 INFO - 'PWD': '/builds/slave/test', 00:08:38 INFO - 'SHELL': '/bin/bash', 00:08:38 INFO - 'SHLVL': '1', 00:08:38 INFO - 'TERM': 'linux', 00:08:38 INFO - 'TMOUT': '86400', 00:08:38 INFO - 'USER': 'cltbld', 00:08:38 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', 00:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:38 INFO - '_': '/tools/buildbot/bin/python'} 00:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:38 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)) 00:08:38 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)) 00:08:38 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)) 00:08:38 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)) 00:08:38 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)) 00:08:38 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)) 00:08:38 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)) 00:08:38 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)) 00:08:38 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)) 00:08:38 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)) 00:08:38 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)) 00:08:38 INFO - Cleaning up... 00:08:38 INFO - Return code: 0 00:08:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:08:38 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')]} 00:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:38 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')]} 00:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:38 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 0x7f4b78135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc81c0>, '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 0xdc90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc9550>, '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': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', '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 00:08:38 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 00:08:38 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 00:08:38 INFO - Using env: {'DISPLAY': ':0', 00:08:38 INFO - 'HOME': '/home/cltbld', 00:08:38 INFO - 'LANG': 'en_US.UTF-8', 00:08:38 INFO - 'LANGUAGE': 'en_US:en', 00:08:38 INFO - 'LOGNAME': 'cltbld', 00:08:38 INFO - 'MAIL': '/var/mail/cltbld', 00:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:38 INFO - 'MOZ_NO_REMOTE': '1', 00:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:38 INFO - 'NO_EM_RESTART': '1', 00:08:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:38 INFO - 'PWD': '/builds/slave/test', 00:08:38 INFO - 'SHELL': '/bin/bash', 00:08:38 INFO - 'SHLVL': '1', 00:08:38 INFO - 'TERM': 'linux', 00:08:38 INFO - 'TMOUT': '86400', 00:08:38 INFO - 'USER': 'cltbld', 00:08:38 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', 00:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:38 INFO - '_': '/tools/buildbot/bin/python'} 00:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:08:38 INFO - Cleaning up... 00:08:38 INFO - Return code: 0 00:08:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:08:38 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')]} 00:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:38 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')]} 00:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:08:38 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 0x7f4b78135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd39350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc81c0>, '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 0xdc90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc9550>, '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': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', '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 00:08:38 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 00:08:38 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 00:08:38 INFO - Using env: {'DISPLAY': ':0', 00:08:38 INFO - 'HOME': '/home/cltbld', 00:08:38 INFO - 'LANG': 'en_US.UTF-8', 00:08:38 INFO - 'LANGUAGE': 'en_US:en', 00:08:38 INFO - 'LOGNAME': 'cltbld', 00:08:38 INFO - 'MAIL': '/var/mail/cltbld', 00:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:38 INFO - 'MOZ_NO_REMOTE': '1', 00:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:38 INFO - 'NO_EM_RESTART': '1', 00:08:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:38 INFO - 'PWD': '/builds/slave/test', 00:08:38 INFO - 'SHELL': '/bin/bash', 00:08:38 INFO - 'SHLVL': '1', 00:08:38 INFO - 'TERM': 'linux', 00:08:38 INFO - 'TMOUT': '86400', 00:08:38 INFO - 'USER': 'cltbld', 00:08:38 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', 00:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:38 INFO - '_': '/tools/buildbot/bin/python'} 00:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:08:38 INFO - Downloading/unpacking flake8 00:08:38 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 00:08:38 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 00:08:38 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 00:08:38 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 00:08:38 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 00:08:38 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 00:08:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:08:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:08:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:08:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:08: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 00:08: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 00:08: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 00:08: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 00:08: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 00:08: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 00:08:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:08: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 00:08: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 00:08: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 00:08: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 00:08: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 00:08: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 00:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:08:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:08:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:08:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:08:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:08:41 INFO - no previously-included directories found matching 'docs/_build' 00:08:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:08:41 INFO - Running setup.py install for pep8 00:08:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:08:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:08:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:08:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:08:41 INFO - no previously-included directories found matching 'docs/_build' 00:08:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:08:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:08:41 INFO - Cleaning up... 00:08:41 INFO - Return code: 0 00:08:41 INFO - Running post-action listener: _resource_record_post_action 00:08:41 INFO - Running post-action listener: _start_resource_monitoring 00:08:41 INFO - Starting resource monitoring. 00:08:41 INFO - ##### 00:08:41 INFO - ##### Finished create-virtualenv step (success) 00:08:41 INFO - ##### 00:08:41 INFO - ##### 00:08:41 INFO - ##### Running install step. 00:08:41 INFO - ##### 00:08:41 INFO - Running pre-action listener: _resource_record_pre_action 00:08:41 INFO - Running main action method: install 00:08:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:08:42 INFO - Reading from file tmpfile_stdout 00:08:42 INFO - Detecting whether we're running mozinstall >=1.0... 00:08:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:08:42 INFO - Reading from file tmpfile_stdout 00:08:42 INFO - Output received: 00:08:42 INFO - Usage: mozinstall [options] installer 00:08:42 INFO - Options: 00:08:42 INFO - -h, --help show this help message and exit 00:08:42 INFO - -d DEST, --destination=DEST 00:08:42 INFO - Directory to install application into. [default: 00:08:42 INFO - "/builds/slave/test"] 00:08:42 INFO - --app=APP Application being installed. [default: firefox] 00:08:42 INFO - mkdir: /builds/slave/test/build/application 00:08:42 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'] 00:08:42 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 00:08:57 INFO - Reading from file tmpfile_stdout 00:08:57 INFO - Output received: 00:08:57 INFO - /builds/slave/test/build/application/firefox/firefox 00:08:57 INFO - Running post-action listener: _resource_record_post_action 00:08:57 INFO - ##### 00:08:57 INFO - ##### Finished install step (success) 00:08:57 INFO - ##### 00:08:57 INFO - ##### 00:08:57 INFO - ##### Running run-tests step. 00:08:57 INFO - ##### 00:08:57 INFO - Running pre-action listener: _resource_record_pre_action 00:08:57 INFO - Running main action method: run_tests 00:08:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:08:57 INFO - Python 2.7.3 00:08:57 INFO - Return code: 0 00:08:57 INFO - grabbing minidump binary from tooltool 00:08:57 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')]} 00:08:57 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 0xdc81c0>, '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 0xdc90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc9550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:08:57 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 00:08:57 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 00:08:57 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 00:08:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:08:57 INFO - Return code: 0 00:08:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:08:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:08:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:08:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:08:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:08:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:08:58 INFO - Return code: 0 00:08:58 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/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 00:08:58 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/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 00:08:58 INFO - Using env: {'DISPLAY': ':0', 00:08:58 INFO - 'HOME': '/home/cltbld', 00:08:58 INFO - 'LANG': 'en_US.UTF-8', 00:08:58 INFO - 'LANGUAGE': 'en_US:en', 00:08:58 INFO - 'LOGNAME': 'cltbld', 00:08:58 INFO - 'MAIL': '/var/mail/cltbld', 00:08:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:08:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:08:58 INFO - 'MOZ_NO_REMOTE': '1', 00:08:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:08:58 INFO - 'NO_EM_RESTART': '1', 00:08:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:08:58 INFO - 'PWD': '/builds/slave/test', 00:08:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:08:58 INFO - 'SHELL': '/bin/bash', 00:08:58 INFO - 'SHLVL': '1', 00:08:58 INFO - 'TERM': 'linux', 00:08:58 INFO - 'TMOUT': '86400', 00:08:58 INFO - 'USER': 'cltbld', 00:08:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917', 00:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:08:58 INFO - '_': '/tools/buildbot/bin/python'} 00:08:58 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/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 00:08:58 INFO - mozversion application_buildid: 20160731213223 00:08:58 INFO - mozversion application_changeset: f3790db5cbcbc2084db461e050b58203de5879b4 00:08:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 00:08:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:08:58 INFO - mozversion application_name: Firefox 00:08:58 INFO - mozversion application_remotingname: firefox-dev 00:08:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:08:58 INFO - mozversion application_vendor: Mozilla 00:08:58 INFO - mozversion application_version: 49.0a2 00:08:58 INFO - mozversion platform_buildid: 20160731213223 00:08:58 INFO - mozversion platform_changeset: f3790db5cbcbc2084db461e050b58203de5879b4 00:08:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:08:58 INFO - mozversion platform_version: 49.0a2 00:08:58 INFO - using testdate: 1470035338 00:08:58 INFO - actual date: 1470035338 00:08:58 INFO - starting webserver on 'localhost:47933' 00:08:58 INFO - SUITE-START | Running 2 tests 00:08:58 INFO - TEST-START | dromaeo_css 00:08:58 INFO - operating with platform_type : linux_ 00:08:58 INFO - Initialising browser for dromaeo_css test... 00:08:58 INFO - TEST-INFO | started process 10877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTsmKOh/profile http://localhost:47933/getInfo.html) 00:09:02 INFO - PROCESS | 10877 | __metrics Screen width/height:1600/1200 00:09:02 INFO - PROCESS | 10877 | colorDepth:24 00:09:02 INFO - PROCESS | 10877 | Browser inner width/height: 1024/697 00:09:02 INFO - PROCESS | 10877 | __metrics 00:09:03 INFO - PROCESS | 10877 | 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" 00:09:03 ERROR - PROCESS | 10877 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:09:04 INFO - TEST-INFO | 10877: exit 0 00:09:04 INFO - Browser initialized. 00:09:04 INFO - Running cycle 1/1 for dromaeo_css test... 00:09:04 INFO - TEST-INFO | started process 10965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTsmKOh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:09:16 INFO - PROCESS | 10965 | RSS: Main: 146292736 00:09:16 INFO - PROCESS | 10965 | 00:10:07 INFO - PROCESS | 10965 | 1470035407750 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] 00:12:15 INFO - PROCESS | 10965 | Cycle 1(1): loaded http://localhost:47933/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47933/tests/dromaeo/cssquery-ext.html) 00:12:16 INFO - PROCESS | 10965 | RSS: Main: 251305984 00:12:16 INFO - PROCESS | 10965 | 00:15:18 INFO - PROCESS | 10965 | Cycle 1(1): loaded http://localhost:47933/tests/dromaeo/cssquery-ext.html (next: http://localhost:47933/tests/dromaeo/cssquery-jquery.html) 00:15:19 INFO - PROCESS | 10965 | RSS: Main: 229572608 00:15:19 INFO - PROCESS | 10965 | 00:18:21 INFO - PROCESS | 10965 | Cycle 1(1): loaded http://localhost:47933/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47933/tests/dromaeo/cssquery-mootools.html) 00:18:22 INFO - PROCESS | 10965 | RSS: Main: 224301056 00:18:22 INFO - PROCESS | 10965 | 00:21:24 INFO - PROCESS | 10965 | Cycle 1(1): loaded http://localhost:47933/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47933/tests/dromaeo/cssquery-prototype.html) 00:21:24 INFO - PROCESS | 10965 | RSS: Main: 220381184 00:21:24 INFO - PROCESS | 10965 | 00:24:27 INFO - PROCESS | 10965 | Cycle 1(1): loaded http://localhost:47933/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47933/tests/dromaeo/cssquery-yui.html) 00:24:27 INFO - PROCESS | 10965 | RSS: Main: 218886144 00:24:27 INFO - PROCESS | 10965 | 00:27:30 INFO - PROCESS | 10965 | Cycle 1(1): loaded http://localhost:47933/tests/dromaeo/cssquery-yui.html (next: http://localhost:47933/tests/dromaeo/cssquery-dojo.html) 00:27:30 INFO - PROCESS | 10965 | RSS: Main: 277651456 00:27:30 INFO - PROCESS | 10965 | 00:27:30 INFO - PROCESS | 10965 | __start_tp_report 00:27:30 INFO - PROCESS | 10965 | _x_x_mozilla_page_load 00:27:30 INFO - PROCESS | 10965 | _x_x_mozilla_page_load_details 00:27:30 INFO - PROCESS | 10965 | |i|pagename|runs| 00:27:30 INFO - PROCESS | 10965 | |0;dojo.html;3279.1965968337754;3303.322818822142;3311.039798458447;3323.5513205717252;3351.4135026370377;5340.225667278242;5379.273798037264;5398.109311963526;5423.078076726956;5424.050791111559;5323.201519772036;5369.140937450009;5376.435474275204;5377.4084850666395;5378.515933565978;4820.517948205186;4879.268109783534;4892.681975671588;4956.033573453178;4967.602591792648;4782.641301902354;4916.680415772981;4969.25461180824;4969.4036715594175;4977.800887964477;4889.8777530561665;4910.1652719037675;4925.48282430345;4929.876753081184;4961.727105009223;5013.548780609726;5021.5480606745205;5026.723530205837;5037.0681423936685;5051.79792808289;4806.038792241566;4826.372571565674;4867.4889136640495;4923.113839508887;4969.726665033421;5179.689218646856;5206.088934436459;5211.322528071327;5219.321488206547;5259.421463638997;5743.770249190027;5748.109043098327;5761.711914404305;5771.538276937835;5774.076147816371;5724.513416359614;5790.33411157718;5791.44981226787;5804.8839023219725;5839.7664093436215;5429.53848922842;5474.589405794542;5476.096444086721;5482.780688772445;5485.890282194334;5697.145428185722;5971.731272092767;5974.074018527135;5981.252343457068;5981.910271345933;5572.331320241516;5629.634073785191;5641.717914104361;5653.519450846642;5703.258576385043;5740.6268592541355;5742.253507044141;5745.109508026179;5746.42535746422;5769.9711501442225;5560.666360018331;5667.716614169275;5699.316082070178;5715.399883012224;5717.142428635738;5718.399568045378;5797.333306669787;5800.419958004166;5802.82591522255;5839.737211825478;4525.094981003813;4525.683202175816;4528.728276303433;4531.071130418256;4553.977230113828;3964.0882597002274;3981.3231750602467;3985.9202815943518;4053.3919912013434;4090.1615168890307;5412.269343638558;5427.050266203399;5431.782728690808;5436.29328187341;5439.374471935778;5741.7990370337675;5766.682832444172;5767.653940763567;5773.076307790818;5812.302523697099;5238.790448382022;5369.060414427459;5394.730263486888;5424.647397919122;5452.291202143696;4945.282933974553;4972.229304457743;4973.1297023020825;4974.030064137459;5005.549500544968;5792.594518383757;5971.940280597225;6011.248593925759;6028.879422411527;6034.396560344018;5636.098224284095;5699.401562836008;5706.914396284142;5768.077107662753;5799.710014499343;5906.468417842415;5909.409059094056;5917.112433135064;5924.555658325557;5997.610155340063;5553.555715542828;5677.971610142088;5680.630759000652;5682.9431705684065;5686.658800471985;5580.2745643067765;5587.3015873015875;5632.85917852057;5683.431656834284;5685.0335442973965;5574.637648552831;5598.468145526169;5601.103823388401;5603.523700485504;5604.299462567179;5439.728013599225;5557.666540007613;5564.276644036249;5566.053770858883;5567.359753628384;5523.475269849358;5576.832695019156;5590;5594;5623.128415095667;5663.575231857545;5710.971445142748;5737.512311453574;5744.540436765133;5748.166515855261;5382.434844341445;5440.972795135999;5474.206240095244;5519.972400138135;5605.579581531483 00:27:30 INFO - PROCESS | 10965 | |1;ext.html;598.5809933046868;641.7208514296282;648.8086014625682;655.3741177175796;662.5262937000044;31831.363372732532;45159.322610160874;45658.08683826322;46060.53939460613;46075;47326;47890;47948.04103917928;47980.52019479804;47988.28017579731;8198.057223419324;9043.140901614335;9187.310951678617;9191.31065170115;10817;10522.31604945676;10642.62750803722;10959.890401095967;10980.835287470694;11006.559737610485;11035.117190624731;11127.944360278187;11130.49912753928;11132.053775429098;11133.387663678495;8238.382121340894;10798;11003.61487347943;11073.280236784583;11073.280236784583;10939.56241750329;10971.506282217319;11014.284071535325;11016.228863979524;11020.614278500294;45287;45604.771976139906;45690;45690;45804.312935306;3633.418653015531;3716.9070773230615;3828.453344780429;4085.3259212229946;4199.91600167998;34061.48907766386;34189.65810341889;34506.137346566284;35156.29687406238;36072.639273607194;4669.089527542131;4673.415823022122;4686.742229177394;4711.717296962193;4769.260764581495;395586;399217;400760;400925;401036;39342.409863852066;40132.19735605272;68002;68046.65976670085;68426;39640.405393919114;39665.40501892416;39746.60253397487;39775.40336894949;39803;17548.29806807739;17727.822721772616;17731.822681773017;17735;17742.556436089202;12484.50061997528;13531;13652.658683532793;13674.453021879212;14029.649258768408;9366.391184573116;9389.483578403253;9417.858732119024;9452.57463414148;9482.431054136774;3487.877924272689;3487.9306210535074;3523.2777280657406;3563.2873425315042;3598.4962105305276;1020.3877673395903;1118.1278602689915;1122.747381839096;1184.4965889497103;1205.3069485046133;33619.495707564405;33635.32729345448;34022;34125;34206.65793342084;1134.500819639356;1167.7606090751544;1173.935433551163;1227.643983244849;1268.2580690296095;17292.22185001653;17735.37926172578;17739;17910.731339029924;17951.640967180585;649717;654116;655475;655763;657037;62732.37267627357;64204.357956420776;64288;64301.35698643047;64320.67839660772;1352.4049418255936;1433.340663294896;1439.6185010972101;1471.8013068235866;1479.6153000219806;32580;34742.30515389729;34749.82625086858;35153.82423087868;35222.491267069156;52981;53420.73289633527;53629.7318513405;53678;53714.46285537095;431287;435439;435540;436160;436183;27317.863410682818;29860.253493662833;30493.54259686151;30538.389232215675;32196.678033219367;49987.50012499828;50838;51787.223191652905;52457.7377113112;52489.737551312;43081;43202.78398607987;43259.783701081295;43744;43809.34285985777;45814.31278530758;45908;46129;46868.765656172865;47868.521314786405;43747.781261094766;43857.78071109752;44564.55435445734;44727.77636111798;44819.55180448154;36182;37678.62321376751;37850.62149378581;38615;39290;29439.411211775216;29565.704342956295;29730.702692972794;29832;30109.397812044073 00:27:30 INFO - PROCESS | 10965 | |2;jquery.html;416.98957526061844;424.81945173301347;425.1878911279457;425.351339207708;435.3752365355715;19058.90470547647;19438.805611943877;20481.795182048176;20493.282735104276;20647.38057858263;14336.875591596157;16638.83361166388;19289.614207715837;19417.805821941776;20659.483512912146;5605.915911261324;5642;5871.471567558919;5930.733117009745;5964.19483369746;5900.055991041434;5912.4974377178;5928.436798504157;5938.613990090652;5954.225950626413;4029.9395509067385;5540;5875.559333050017;5914.290285165786;5917.20117784098;5775.364709881909;5826.912596311059;5859.414058594107;5863.472287494124;5868.9413105868825;5524.281843360378;5676.489115979582;5782.653040817564;5784.363719990798;5786.508146807527;14520.273986300643;14586.781198282035;14716.264186790724;14737.189454579993;14934.775978360334;2208.2491952735986;2251.763564825686;2261.061659411342;2367.7987371073477;3006.8947586834574;10497.580096796119;10654.680359589225;10834.67495975122;14054.578362649137;14759.70480590393;1889.263187356932;1893.4130419569976;1937.7190307405488;1963.0462021917665;2004.7794742578305;71496;75355.62322188409;76884.61557692231;84945;85165.57417212936;11220.55117795279;11622.302661840316;11740.706482337839;11840.987032204546;11985.580504682293;16908.492745217663;16957.40649077301;17047.91476042612;17061.232244549024;17072.82927170737;8467.280281176047;8810.691625793066;9017.954910225408;9036.683716069905;9074.500902450296;8753.649854005896;8878.86681699775;8902.376833621584;8985.595648195847;8999.505027223566;5084.161113416245;5117.334746482933;5138.58891288696;5157.664751791197;5233.188855727369;2045.4886278430392;2060.958780824405;2076.2733043434678;2082.2295750572384;2085.708000879878;484.73824134966725;923.9953800231091;1053.0514559234266;1081.9296745711504;1092.792369449802;11876.703082422835;12268.141230113984;12612.243265404106;12649.873501265054;12828.935855320664;482.642844295219;487.2909916072107;493.7481884238992;501.85947934578377;509.1268474566137;6868.759593414206;6872.278410766798;6924.307569243036;6938.618375989268;6949.89575156373;514536;522481;524149;526826;527050;65782;103014.48492757489;104721;105143.4742826281;105859.470702646;1068.9946550267198;1083.7344850511674;1106.6126855600637;1109.312226419625;1110.9833352499718;17969.550761231072;18080.638387232444;18207.807032781282;18221.817781822014;18266.178021988777;40651.59348406478;42293.577064228964;42870.57129428666;43725.78137109294;43920.78039609781;59593;60210.910869445805;60526;60988;61901.380986189564;7839.647215875413;8162.632681529227;8387.580620968805;8459.95770021146;8761.29909607217;9063.32025098107;9364.625414983597;13446.058775885595;13629.659258518617;13711.588652340446;12123.090768192244;12128.514859405524;12182.939085304517;12239.632811015685;12289.692757680772;5818.7090645466715;10991.890081099087;11301.71745706331;11895.76208475843;12149.1495595311;11809;12384.318862462651;12615.621531354074;12639;12721.681957951125;8753.431026983226;8940.597673104596;9094.909050909671;9116.27069834425;9186.265098791948;12153.149279550347;12526.436310365872;12594.433250503565;12620.36898155107;12695.047871409497 00:27:30 INFO - PROCESS | 10965 | |3;mootools.html;1377.2356342230057;1504.2253239581617;1565.248680633296;1741.4514427955194;1864.7343477674622;9167.449953002817;9511.191548718358;9529;9749;9754.170895473875;9521.761955951104;9735.756606084851;9739.805203895936;9744.269179811507;9755.365901216433;2156.644153714635;2229.3869185973904;2372.620380739082;2378;2411;2460.2004348586693;2470.765277298654;2471.1968610201666;2472.9629055564183;2474.5174690935273;2356.5522550715395;2401.6037353836596;2402.327348342467;2402.9158979435724;2404.4349577849193;2088.550961543268;2313.7339205991275;2326.1160758911674;2394.4971555973093;2400.7719266669637;2398.196604137616;2407.915722949706;2429.161939130997;2431.55016321981;2432.3311089450367;9695.51522423883;9758.072983066597;9759.65841195562;9766.658166964122;9776.804463910754;5406.08096623575;5530.115181570929;5534.169874518814;5541.5843811714285;5543.057680194336;3208.406444807718;3301.6863397977154;3372.291818718072;3378.054144839449;3415.829208539588;1069.909057730086;1085.3542142425324;1103.178132291448;1146.0774076868117;2311.5261371418987;13144.40850161745;13555.59333220005;13651.38568764408;13651.795223071662;13657.385417656229;4792.448868380181;4796.352492413549;4810.6632535722165;4821.276808478756;4854.466008739036;10684.679459616224;10771;10771.084457821016;10774.892251077388;10781.460926953621;5603.635763675429;5627.437256274422;5633;5633.746481408347;5636.943630563642;4658.534146585383;4769.689970151929;4917.459079501252;4932.8520144395725;4967.3542439482635;4041.515018197835;4045.8417191136905;4078.4290199372113;4115.54728979812;4118.5263694674895;1159.8724140344555;1162.3258510064143;1168.894799468052;1170.163333216737;1199.8680145184198;972.9854052189223;1002.4987506246877;1011.0950699124243;1081.502508845924;1090.9236353455183;6489.935100648933;6596.670166491656;6650.70071846768;6673.432758215509;6941.167059952838;482.39700374531833;490.2376804069635;490.3992609053952;498.41685228282995;498.86780003299157;4484.865454036384;4488.349189367524;4491.595756381941;4493.191225579361;4508.661850361236;11583.76832463363;11863.76272474563;12193.207441516273;12310.692232694075;12326.32205228721;12166.756664866652;12249;12284.754304913851;12286.508539658493;12290.692732681755;8744.737657870273;8925.330600204881;8963.103689630985;8983.416077954913;9028.954855225813;6497.382748638872;6849.691763870737;6887.345702158287;6951.965240173767;6992.4406047517095;10774.946125269324;11269.267497612957;11280.435978201222;11446.599369022044;11472.94263528677;11170.050545703707;11280.210385272952;11589.362585057903;11594.362310073027;11617.593384231512;8276.540364402339;8687;8799.780005499657;8810.207081362709;8814.735557933273;9249.953750231205;9260.30547708938;9283.071692830934;9295.581698823704;9326;8502.957485212535;8511.404201705822;8545.359098067795;8567.057623661516;8750.081241469808;8304.792380190544;8342.916570834457;8358.205970432798;8438.493690378597;8441.915580844114;7490;7492.662830172546;7538.849223015619;7539.886901696369;7542.321191092828;5547.7780888764;5631.070873306023;5675.035244008446;5733.111367738007;5758.769649214152;5589.273394458694;5721.628094173865;5737.397573254748;5766.913496297643;5801.071828507418 00:27:30 INFO - PROCESS | 10965 | |4;prototype.html;337.52577628432033;338.050079277231;341.4639016743712;351.2430711816036;356.4599631558189;5283.8150664726745;5456.91814622781;5457.126859702448;5474.562035037197;5539.833804985852;5450.209719590657;5464.6994415307145;5480.849021705447;5486.710623003591;5513.283273174492;4320.870373888788;4325.718828276168;4347.434833471644;4359.803808828595;4372.693911426201;3945.763254204757;3984;4334.653227741773;4357.821089455272;4361.171377438292;4266.445362102922;4291.678124140686;4305.806238719249;4309.439772829528;4323.502797178317;4264;4294.527601963766;4294.677899157545;4299.14017196562;4332.566743325674;3752.9249415011545;3818.369968955119;3844.500214972036;3847.153626202231;3873.4770805941403;5168;5205.947940520584;5206.453322401131;5229.947700523022;5231.973840130813;4869.662561970239;4880.536349046871;4889.902201955941;4890.217565189552;4922.187839006559;5580.302462192226;5605.691686957216;5665.631733937281;5694.373618901917;5717;4135.6898232632675;4137.089840235173;4189.72766770162;4191.161767646452;4193.97903010483;5840.890230856124;5853.487907255655;5923.733431995571;5944.940550594439;5972.193753843219;4210.536840947493;4259.318509038539;4309.892252693645;4316.546762589883;4328.870133895988;4312.568743125725;4340.197063543254;4343.478782546114;4349.26062569364;4355.825766969286;4882.462929077798;4917.704937703677;4921.975390123026;4924.581410580069;4936.432310284364;5471.50756431923;5771.220885180531;5788.421157884178;5801.622894511843;5811.970940145272;1457.1402872305391;1470.9485168019069;1505.7214415333199;1512.2287633306873;1521.4826958834049;962.855571664256;981.7923953537047;982.2485798364257;984.1142971325864;993.9105480506645;4954.117435374606;5001.724560237116;5012.273220383097;5040.420351659533;5058.190689489664;5233.226390013223;5238.790448382022;5241.633085683966;5261.710605916712;5266.183741520071;4731.645126615517;4961.280614310905;4975.751212439363;4981.875453113628;5010.874728131826;2753.719520422973;2793.469240844274;2796;2812.690604033555;2834.447282779838;5357.276767636319;5411.648242864201;5442.945570544323;5453.15476101205;5463.453654634504;5122.769475373617;5162.244836755521;5293.444188360244;5297.205419187076;5337.973310133502;5411.214299281228;5427.999999999921;5450.291462109901;5456.91814622781;5483;5179.766910488962;5220.9477905220465;5284.894302114013;5306.469353064663;5309.973315210293;4910.558049775537;5143;5149.459306772885;5151.562117220078;5170.768269831356;5288.338957630296;5353.072893758322;5359.839204823861;5392.811251606175;5401.432849550741;3901.731937120504;3909.6481316681634;3926.3521518949055;3930.1157239620857;3969.7816620086173;4921.311016457627;5173.92239116406;5205.531502164823;5629.802956896653;5710.685912274698;5676.672564248638;5685.545156387397;5702.34423041339;5728.79949201776;5741.45456181662;5687.43125687428;5708.8572785679025;5712.485876271156;5715;5740.569457290803;5533.972330138324;5550.222968784293;5590.077637189818;5620.4660557247;5650.773969041193;5682.346530149086;5693.117566777156;5755.884882302246;5758.62568933018;5797.956367853827;5437.8368648940595;5599.776008959596;5626.127950167731;5634.830955071355;5669.546436285004 00:27:30 INFO - PROCESS | 10965 | |5;yui.html;728.1553398058247;736.7053178728511;772.8183876788958;866.3199388480043;928.0487500312179;15476.458323958665;16282.104484253361;16527.752083718722;16882.240299186535;17059.23233454496;13813.723725525484;13915.095518791271;13938.581842544714;13940.163590184597;13958;725.2095216214325;742.5544673196066;745.8135466133467;869.7738587967111;880.8634661627426;741.8590467811125;858.0389963241147;878.1350369885689;879.5514287713248;886.9379143459961;922.3681777982071;923.1968187676731;925.8842644669417;926.9629214831399;928.1368327455464;751.7970148059993;883.2713011765319;923.8337099322085;925.5279807298293;925.7407925780758;668.2482207516543;671.1543455246425;671.6977360187935;672.2067959807425;672.9427998620123;13981.510647127403;13984.580462586138;14013.509527166601;14017.43930242789;14022.439102435992;15076.924615376962;15502.147381893992;15541.378344866305;15663.608409789733;15847.366105355772;13645.727085458335;13973.860261397358;14131;14181.645458863508;14304.856951430456;4712.6465515086165;4727.479977202505;4734.763261836894;4780.569748722632;4896.755162241873;65287;66908.6654566729;67021.329786702;75769.99999999945;76188.61905690435;12272.877271227351;12453.779173790206;12533.060020498498;12757;12797.104202705721;21820;21857.562848743255;21873.562528749335;21925.451863703536;21927.561448770935;8726.432781869158;8778;8972.327075469235;8986.101389860962;9042.412243204171;4926.537994598703;4957.628177886673;4971.105201063771;4996.825111121093;5152.639315247897;3765.661090501868;3865.69074474047;3865.9806700966315;3866.7679939203736;3877.360235561101;674.0293976673672;679.3715812873072;680.5916450129882;681.3799442507394;689.334791925794;631.7599312261403;689.407109885498;798.648594618366;810.4205493072482;824.6907409721355;10675.679729608124;10687.091597214323;10781.514831832586;10862.837057444145;10973.177011724152;672.5477340009171;687.5221720904024;690.6305126757161;708.1572928215408;717.121526130486;4590.219662657356;4884.083749863356;4937.843765316268;4951.628627852925;4968.403791544965;67904.6604766973;68403;73260.26739732534;116209.4189529047;118607;95852;97344;97653.51173244088;97882;100157;88068.5596572013;90210;90388.5480572593;91259;92277.53861230651;8641.438306510057;8706.91293087061;8856.690015849414;9520.714378568655;9773;41641.58358416498;48382.27426588534;51361.64331805536;51775.22337165021;52087.218691718896;52590.474095258556;52607.73696131495;59297.70351148216;75901.24098759162;76561.23438765763;12015.871518173035;12088.093392995384;12230.816537752118;12571.275039555738;12629;13513.729725405634;13659.453621855411;13824.170549767046;13867;14633.853661463248;12566.685832854251;12766.68083297925;12905.290209038592;13007.609771706864;13404.463821447032;13078.476860925457;13103.2138071716;13139.60581182566;13312.733745324846;13556.186628802303;12343.317191765866;12457.750844983231;12678.98568114567;12733.490660373853;12750;10424.270301078852;10532.157427405942;10717.5583105903;11001.944990274997;11163.330200188015;9936.354136981074;10565.366078035342;10646.787064258517;10852.565897364017;10902.454877255946 00:27:30 INFO - PROCESS | 10965 | __end_tp_report 00:27:30 INFO - PROCESS | 10965 | __start_cc_report 00:27:30 INFO - PROCESS | 10965 | _x_x_mozilla_cycle_collect,845 00:27:30 INFO - PROCESS | 10965 | __end_cc_report 00:27:30 INFO - PROCESS | 10965 | __startTimestamp1470036450556__endTimestamp 00:27:30 INFO - PROCESS | 10965 | 00:27:30 INFO - PROCESS | 10965 | ------- Summary: start ------- 00:27:30 INFO - PROCESS | 10965 | Number of tests: 6 00:27:30 INFO - PROCESS | 10965 | 00:27:30 INFO - PROCESS | 10965 | [#0] dojo.html Cycles:165 Average:5353.70 Median:5557.67 stddev:565.44 (10.2%) stddev-sans-first:543.25 00:27:30 INFO - PROCESS | 10965 | Values: 3279.2 3303.3 3311.0 3323.6 3351.4 5340.2 5379.3 5398.1 5423.1 5424.1 5323.2 5369.1 5376.4 5377.4 5378.5 4820.5 4879.3 4892.7 4956.0 4967.6 4782.6 4916.7 4969.3 4969.4 4977.8 4889.9 4910.2 4925.5 4929.9 4961.7 5013.5 5021.5 5026.7 5037.1 5051.8 4806.0 4826.4 4867.5 4923.1 4969.7 5179.7 5206.1 5211.3 5219.3 5259.4 5743.8 5748.1 5761.7 5771.5 5774.1 5724.5 5790.3 5791.4 5804.9 5839.8 5429.5 5474.6 5476.1 5482.8 5485.9 5697.1 5971.7 5974.1 5981.3 5981.9 5572.3 5629.6 5641.7 5653.5 5703.3 5740.6 5742.3 5745.1 5746.4 5770.0 5560.7 5667.7 5699.3 5715.4 5717.1 5718.4 5797.3 5800.4 5802.8 5839.7 4525.1 4525.7 4528.7 4531.1 4554.0 3964.1 3981.3 3985.9 4053.4 4090.2 5412.3 5427.1 5431.8 5436.3 5439.4 5741.8 5766.7 5767.7 5773.1 5812.3 5238.8 5369.1 5394.7 5424.6 5452.3 4945.3 4972.2 4973.1 4974.0 5005.5 5792.6 5971.9 6011.2 6028.9 6034.4 5636.1 5699.4 5706.9 5768.1 5799.7 5906.5 5909.4 5917.1 5924.6 5997.6 5553.6 5678.0 5680.6 5682.9 5686.7 5580.3 5587.3 5632.9 5683.4 5685.0 5574.6 5598.5 5601.1 5603.5 5604.3 5439.7 5557.7 5564.3 5566.1 5567.4 5523.5 5576.8 5590.0 5594.0 5623.1 5663.6 5711.0 5737.5 5744.5 5748.2 5382.4 5441.0 5474.2 5520.0 5605.6 00:27:30 INFO - PROCESS | 10965 | 00:27:30 INFO - PROCESS | 10965 | [#1] ext.html Cycles:180 Average:65373.81 Median:217613.20 stddev:135608.42 (62.3%) stddev-sans-first:135901.62 00:27:30 INFO - PROCESS | 10965 | Values: 598.6 641.7 648.8 655.4 662.5 31831.4 45159.3 45658.1 46060.5 46075.0 47326.0 47890.0 47948.0 47980.5 47988.3 8198.1 9043.1 9187.3 9191.3 10817.0 10522.3 10642.6 10959.9 10980.8 11006.6 11035.1 11127.9 11130.5 11132.1 11133.4 8238.4 10798.0 11003.6 11073.3 11073.3 10939.6 10971.5 11014.3 11016.2 11020.6 45287.0 45604.8 45690.0 45690.0 45804.3 3633.4 3716.9 3828.5 4085.3 4199.9 34061.5 34189.7 34506.1 35156.3 36072.6 4669.1 4673.4 4686.7 4711.7 4769.3 395586.0 399217.0 400760.0 400925.0 401036.0 39342.4 40132.2 68002.0 68046.7 68426.0 39640.4 39665.4 39746.6 39775.4 39803.0 17548.3 17727.8 17731.8 17735.0 17742.6 12484.5 13531.0 13652.7 13674.5 14029.6 9366.4 9389.5 9417.9 9452.6 9482.4 3487.9 3487.9 3523.3 3563.3 3598.5 1020.4 1118.1 1122.7 1184.5 1205.3 33619.5 33635.3 34022.0 34125.0 34206.7 1134.5 1167.8 1173.9 1227.6 1268.3 17292.2 17735.4 17739.0 17910.7 17951.6 649717.0 654116.0 655475.0 655763.0 657037.0 62732.4 64204.4 64288.0 64301.4 64320.7 1352.4 1433.3 1439.6 1471.8 1479.6 32580.0 34742.3 34749.8 35153.8 35222.5 52981.0 53420.7 53629.7 53678.0 53714.5 431287.0 435439.0 435540.0 436160.0 436183.0 27317.9 29860.3 30493.5 30538.4 32196.7 49987.5 50838.0 51787.2 52457.7 52489.7 43081.0 43202.8 43259.8 43744.0 43809.3 45814.3 45908.0 46129.0 46868.8 47868.5 43747.8 43857.8 44564.6 44727.8 44819.6 36182.0 37678.6 37850.6 38615.0 39290.0 29439.4 29565.7 29730.7 29832.0 30109.4 00:27:30 INFO - PROCESS | 10965 | 00:27:30 INFO - PROCESS | 10965 | [#2] jquery.html Cycles:180 Average:29749.04 Median:20534.29 stddev:86257.35 (420.1%) stddev-sans-first:86471.20 00:27:30 INFO - PROCESS | 10965 | Values: 417.0 424.8 425.2 425.4 435.4 19058.9 19438.8 20481.8 20493.3 20647.4 14336.9 16638.8 19289.6 19417.8 20659.5 5605.9 5642.0 5871.5 5930.7 5964.2 5900.1 5912.5 5928.4 5938.6 5954.2 4029.9 5540.0 5875.6 5914.3 5917.2 5775.4 5826.9 5859.4 5863.5 5868.9 5524.3 5676.5 5782.7 5784.4 5786.5 14520.3 14586.8 14716.3 14737.2 14934.8 2208.2 2251.8 2261.1 2367.8 3006.9 10497.6 10654.7 10834.7 14054.6 14759.7 1889.3 1893.4 1937.7 1963.0 2004.8 71496.0 75355.6 76884.6 84945.0 85165.6 11220.6 11622.3 11740.7 11841.0 11985.6 16908.5 16957.4 17047.9 17061.2 17072.8 8467.3 8810.7 9018.0 9036.7 9074.5 8753.6 8878.9 8902.4 8985.6 8999.5 5084.2 5117.3 5138.6 5157.7 5233.2 2045.5 2061.0 2076.3 2082.2 2085.7 484.7 924.0 1053.1 1081.9 1092.8 11876.7 12268.1 12612.2 12649.9 12828.9 482.6 487.3 493.7 501.9 509.1 6868.8 6872.3 6924.3 6938.6 6949.9 514536.0 522481.0 524149.0 526826.0 527050.0 65782.0 103014.5 104721.0 105143.5 105859.5 1069.0 1083.7 1106.6 1109.3 1111.0 17969.6 18080.6 18207.8 18221.8 18266.2 40651.6 42293.6 42870.6 43725.8 43920.8 59593.0 60210.9 60526.0 60988.0 61901.4 7839.6 8162.6 8387.6 8460.0 8761.3 9063.3 9364.6 13446.1 13629.7 13711.6 12123.1 12128.5 12182.9 12239.6 12289.7 5818.7 10991.9 11301.7 11895.8 12149.1 11809.0 12384.3 12615.6 12639.0 12721.7 8753.4 8940.6 9094.9 9116.3 9186.3 12153.1 12526.4 12594.4 12620.4 12695.0 00:27:30 INFO - PROCESS | 10965 | 00:27:30 INFO - PROCESS | 10965 | [#3] mootools.html Cycles:180 Average:6300.33 Median:4781.07 stddev:3713.40 (77.7%) stddev-sans-first:3705.39 00:27:30 INFO - PROCESS | 10965 | Values: 1377.2 1504.2 1565.2 1741.5 1864.7 9167.4 9511.2 9529.0 9749.0 9754.2 9521.8 9735.8 9739.8 9744.3 9755.4 2156.6 2229.4 2372.6 2378.0 2411.0 2460.2 2470.8 2471.2 2473.0 2474.5 2356.6 2401.6 2402.3 2402.9 2404.4 2088.6 2313.7 2326.1 2394.5 2400.8 2398.2 2407.9 2429.2 2431.6 2432.3 9695.5 9758.1 9759.7 9766.7 9776.8 5406.1 5530.1 5534.2 5541.6 5543.1 3208.4 3301.7 3372.3 3378.1 3415.8 1069.9 1085.4 1103.2 1146.1 2311.5 13144.4 13555.6 13651.4 13651.8 13657.4 4792.4 4796.4 4810.7 4821.3 4854.5 10684.7 10771.0 10771.1 10774.9 10781.5 5603.6 5627.4 5633.0 5633.7 5636.9 4658.5 4769.7 4917.5 4932.9 4967.4 4041.5 4045.8 4078.4 4115.5 4118.5 1159.9 1162.3 1168.9 1170.2 1199.9 973.0 1002.5 1011.1 1081.5 1090.9 6489.9 6596.7 6650.7 6673.4 6941.2 482.4 490.2 490.4 498.4 498.9 4484.9 4488.3 4491.6 4493.2 4508.7 11583.8 11863.8 12193.2 12310.7 12326.3 12166.8 12249.0 12284.8 12286.5 12290.7 8744.7 8925.3 8963.1 8983.4 9029.0 6497.4 6849.7 6887.3 6952.0 6992.4 10774.9 11269.3 11280.4 11446.6 11472.9 11170.1 11280.2 11589.4 11594.4 11617.6 8276.5 8687.0 8799.8 8810.2 8814.7 9250.0 9260.3 9283.1 9295.6 9326.0 8503.0 8511.4 8545.4 8567.1 8750.1 8304.8 8342.9 8358.2 8438.5 8441.9 7490.0 7492.7 7538.8 7539.9 7542.3 5547.8 5631.1 5675.0 5733.1 5758.8 5589.3 5721.6 5737.4 5766.9 5801.1 00:27:30 INFO - PROCESS | 10965 | 00:27:30 INFO - PROCESS | 10965 | [#4] prototype.html Cycles:180 Average:4645.35 Median:5192.65 stddev:1318.20 (25.4%) stddev-sans-first:1281.63 00:27:30 INFO - PROCESS | 10965 | Values: 337.5 338.1 341.5 351.2 356.5 5283.8 5456.9 5457.1 5474.6 5539.8 5450.2 5464.7 5480.8 5486.7 5513.3 4320.9 4325.7 4347.4 4359.8 4372.7 3945.8 3984.0 4334.7 4357.8 4361.2 4266.4 4291.7 4305.8 4309.4 4323.5 4264.0 4294.5 4294.7 4299.1 4332.6 3752.9 3818.4 3844.5 3847.2 3873.5 5168.0 5205.9 5206.5 5229.9 5232.0 4869.7 4880.5 4889.9 4890.2 4922.2 5580.3 5605.7 5665.6 5694.4 5717.0 4135.7 4137.1 4189.7 4191.2 4194.0 5840.9 5853.5 5923.7 5944.9 5972.2 4210.5 4259.3 4309.9 4316.5 4328.9 4312.6 4340.2 4343.5 4349.3 4355.8 4882.5 4917.7 4922.0 4924.6 4936.4 5471.5 5771.2 5788.4 5801.6 5812.0 1457.1 1470.9 1505.7 1512.2 1521.5 962.9 981.8 982.2 984.1 993.9 4954.1 5001.7 5012.3 5040.4 5058.2 5233.2 5238.8 5241.6 5261.7 5266.2 4731.6 4961.3 4975.8 4981.9 5010.9 2753.7 2793.5 2796.0 2812.7 2834.4 5357.3 5411.6 5442.9 5453.2 5463.5 5122.8 5162.2 5293.4 5297.2 5338.0 5411.2 5428.0 5450.3 5456.9 5483.0 5179.8 5220.9 5284.9 5306.5 5310.0 4910.6 5143.0 5149.5 5151.6 5170.8 5288.3 5353.1 5359.8 5392.8 5401.4 3901.7 3909.6 3926.4 3930.1 3969.8 4921.3 5173.9 5205.5 5629.8 5710.7 5676.7 5685.5 5702.3 5728.8 5741.5 5687.4 5708.9 5712.5 5715.0 5740.6 5534.0 5550.2 5590.1 5620.5 5650.8 5682.3 5693.1 5755.9 5758.6 5798.0 5437.8 5599.8 5626.1 5634.8 5669.5 00:27:30 INFO - PROCESS | 10965 | 00:27:30 INFO - PROCESS | 10965 | [#5] yui.html Cycles:180 Average:19689.01 Median:4911.65 stddev:27424.68 (558.4%) stddev-sans-first:27464.66 00:27:30 INFO - PROCESS | 10965 | Values: 728.2 736.7 772.8 866.3 928.0 15476.5 16282.1 16527.8 16882.2 17059.2 13813.7 13915.1 13938.6 13940.2 13958.0 725.2 742.6 745.8 869.8 880.9 741.9 858.0 878.1 879.6 886.9 922.4 923.2 925.9 927.0 928.1 751.8 883.3 923.8 925.5 925.7 668.2 671.2 671.7 672.2 672.9 13981.5 13984.6 14013.5 14017.4 14022.4 15076.9 15502.1 15541.4 15663.6 15847.4 13645.7 13973.9 14131.0 14181.6 14304.9 4712.6 4727.5 4734.8 4780.6 4896.8 65287.0 66908.7 67021.3 75770.0 76188.6 12272.9 12453.8 12533.1 12757.0 12797.1 21820.0 21857.6 21873.6 21925.5 21927.6 8726.4 8778.0 8972.3 8986.1 9042.4 4926.5 4957.6 4971.1 4996.8 5152.6 3765.7 3865.7 3866.0 3866.8 3877.4 674.0 679.4 680.6 681.4 689.3 631.8 689.4 798.6 810.4 824.7 10675.7 10687.1 10781.5 10862.8 10973.2 672.5 687.5 690.6 708.2 717.1 4590.2 4884.1 4937.8 4951.6 4968.4 67904.7 68403.0 73260.3 116209.4 118607.0 95852.0 97344.0 97653.5 97882.0 100157.0 88068.6 90210.0 90388.5 91259.0 92277.5 8641.4 8706.9 8856.7 9520.7 9773.0 41641.6 48382.3 51361.6 51775.2 52087.2 52590.5 52607.7 59297.7 75901.2 76561.2 12015.9 12088.1 12230.8 12571.3 12629.0 13513.7 13659.5 13824.2 13867.0 14633.9 12566.7 12766.7 12905.3 13007.6 13404.5 13078.5 13103.2 13139.6 13312.7 13556.2 12343.3 12457.8 12679.0 12733.5 12750.0 10424.3 10532.2 10717.6 11001.9 11163.3 9936.4 10565.4 10646.8 10852.6 10902.5 00:27:30 INFO - PROCESS | 10965 | -------- Summary: end -------- 00:27:30 INFO - PROCESS | 10965 | 00:27:31 INFO - TEST-INFO | 10965: exit 0 00:27:31 INFO - TEST-OK | dromaeo_css | took 1112451ms 00:27:31 INFO - TEST-START | kraken 00:27:31 INFO - operating with platform_type : linux_ 00:27:31 INFO - Initialising browser for kraken test... 00:27:31 INFO - TEST-INFO | started process 11151 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmWZkM3/profile http://localhost:47933/getInfo.html) 00:27:34 INFO - PROCESS | 11151 | __metrics Screen width/height:1600/1200 00:27:34 INFO - PROCESS | 11151 | colorDepth:24 00:27:34 INFO - PROCESS | 11151 | Browser inner width/height: 1024/697 00:27:34 INFO - PROCESS | 11151 | __metrics 00:27:35 INFO - PROCESS | 11151 | 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" 00:27:35 ERROR - PROCESS | 11151 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:27:36 INFO - TEST-INFO | 11151: exit 0 00:27:36 INFO - Browser initialized. 00:27:36 INFO - Running cycle 1/1 for kraken test... 00:27:36 INFO - TEST-INFO | started process 11242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmWZkM3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:27:48 INFO - PROCESS | 11242 | RSS: Main: 142585856 00:27:48 INFO - PROCESS | 11242 | 00:27:51 INFO - PROCESS | 11242 | Cycle 1(1): loaded http://localhost:47933/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47933/tests/kraken/driver.html?testName=audio-beat-detection) 00:27:51 INFO - PROCESS | 11242 | RSS: Main: 192761856 00:27:51 INFO - PROCESS | 11242 | 00:27:54 INFO - PROCESS | 11242 | Cycle 1(1): loaded http://localhost:47933/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47933/tests/kraken/driver.html?testName=audio-dft) 00:27:55 INFO - PROCESS | 11242 | RSS: Main: 190849024 00:27:55 INFO - PROCESS | 11242 | 00:27:57 INFO - PROCESS | 11242 | Cycle 1(1): loaded http://localhost:47933/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47933/tests/kraken/driver.html?testName=audio-fft) 00:27:58 INFO - PROCESS | 11242 | RSS: Main: 277004288 00:27:58 INFO - PROCESS | 11242 | 00:28:00 INFO - PROCESS | 11242 | Cycle 1(1): loaded http://localhost:47933/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47933/tests/kraken/driver.html?testName=audio-oscillator) 00:28:01 INFO - PROCESS | 11242 | RSS: Main: 185319424 00:28:01 INFO - PROCESS | 11242 | 00:28:03 INFO - PROCESS | 11242 | Cycle 1(1): loaded http://localhost:47933/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47933/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:28:03 INFO - PROCESS | 11242 | RSS: Main: 186040320 00:28:03 INFO - PROCESS | 11242 | 00:28:06 INFO - PROCESS | 11242 | Cycle 1(1): loaded http://localhost:47933/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47933/tests/kraken/driver.html?testName=imaging-darkroom) 00:28:07 INFO - PROCESS | 11242 | RSS: Main: 220188672 00:28:07 INFO - PROCESS | 11242 | 00:28:10 INFO - PROCESS | 11242 | Cycle 1(1): loaded http://localhost:47933/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47933/tests/kraken/driver.html?testName=imaging-desaturate) 00:28:11 INFO - PROCESS | 11242 | RSS: Main: 220712960 00:28:11 INFO - PROCESS | 11242 | 00:28:14 INFO - PROCESS | 11242 | Cycle 1(1): loaded http://localhost:47933/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47933/tests/kraken/driver.html?testName=json-parse-financial) 00:28:14 INFO - PROCESS | 11242 | RSS: Main: 220839936 00:28:14 INFO - PROCESS | 11242 | 00:28:16 INFO - PROCESS | 11242 | Cycle 1(1): loaded http://localhost:47933/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47933/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:28:16 INFO - PROCESS | 11242 | RSS: Main: 199561216 00:28:16 INFO - PROCESS | 11242 | 00:28:18 INFO - PROCESS | 11242 | Cycle 1(1): loaded http://localhost:47933/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47933/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:28:19 INFO - PROCESS | 11242 | RSS: Main: 203370496 00:28:19 INFO - PROCESS | 11242 | 00:28:21 INFO - PROCESS | 11242 | Cycle 1(1): loaded http://localhost:47933/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47933/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:28:21 INFO - PROCESS | 11242 | RSS: Main: 208752640 00:28:21 INFO - PROCESS | 11242 | 00:28:24 INFO - PROCESS | 11242 | Cycle 1(1): loaded http://localhost:47933/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:28:24 INFO - PROCESS | 11242 | RSS: Main: 211869696 00:28:24 INFO - PROCESS | 11242 | 00:28:27 INFO - PROCESS | 11242 | Cycle 1(1): loaded http://localhost:47933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:28:28 INFO - PROCESS | 11242 | RSS: Main: 211980288 00:28:28 INFO - PROCESS | 11242 | 00:28:29 INFO - PROCESS | 11242 | Cycle 1(1): loaded http://localhost:47933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47933/tests/kraken/driver.html?testName=ai-astar) 00:28:30 INFO - PROCESS | 11242 | RSS: Main: 255381504 00:28:30 INFO - PROCESS | 11242 | 00:28:30 INFO - PROCESS | 11242 | __start_tp_report 00:28:30 INFO - PROCESS | 11242 | _x_x_mozilla_page_load 00:28:30 INFO - PROCESS | 11242 | _x_x_mozilla_page_load_details 00:28:30 INFO - PROCESS | 11242 | |i|pagename|runs| 00:28:30 INFO - PROCESS | 11242 | |0;ai-astar;112;105;110;110;111;111;110;111;110;111 00:28:30 INFO - PROCESS | 11242 | |1;audio-beat-detection;154;124;128;173;130;124;149;122;152;130 00:28:30 INFO - PROCESS | 11242 | |2;audio-dft;160;161;163;158;160;160;160;159;160;160 00:28:30 INFO - PROCESS | 11242 | |3;audio-fft;75;74;75;100;75;75;74;75;102;75 00:28:30 INFO - PROCESS | 11242 | |4;audio-oscillator;84;85;110;84;84;86;118;85;85;125 00:28:30 INFO - PROCESS | 11242 | |5;imaging-gaussian-blur;116;117;118;116;117;116;117;117;117;116 00:28:30 INFO - PROCESS | 11242 | |6;imaging-darkroom;145;146;145;145;145;145;146;146;147;145 00:28:30 INFO - PROCESS | 11242 | |7;imaging-desaturate;95;95;95;94;95;94;96;95;95;95 00:28:30 INFO - PROCESS | 11242 | |8;json-parse-financial;50;51;50;51;52;52;52;52;52;52 00:28:30 INFO - PROCESS | 11242 | |9;json-stringify-tinderbox;61;61;59;60;61;60;61;60;60;62 00:28:30 INFO - PROCESS | 11242 | |10;stanford-crypto-aes;76;76;75;76;78;77;77;83;109;77 00:28:30 INFO - PROCESS | 11242 | |11;stanford-crypto-ccm;127;118;128;122;115;121;115;117;138;131 00:28:30 INFO - PROCESS | 11242 | |12;stanford-crypto-pbkdf2;156;158;156;160;159;152;154;154;153;158 00:28:30 INFO - PROCESS | 11242 | |13;stanford-crypto-sha256-iterative;62;62;62;61;61;61;63;60;60;60 00:28:30 INFO - PROCESS | 11242 | __end_tp_report 00:28:30 INFO - PROCESS | 11242 | __start_cc_report 00:28:30 INFO - PROCESS | 11242 | _x_x_mozilla_cycle_collect,1550 00:28:30 INFO - PROCESS | 11242 | __end_cc_report 00:28:30 INFO - PROCESS | 11242 | __startTimestamp1470036510072__endTimestamp 00:28:30 INFO - PROCESS | 11242 | 00:28:30 INFO - PROCESS | 11242 | ------- Summary: start ------- 00:28:30 INFO - PROCESS | 11242 | Number of tests: 14 00:28:30 INFO - PROCESS | 11242 | 00:28:30 INFO - PROCESS | 11242 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:1.91 (1.7%) stddev-sans-first:1.90 00:28:30 INFO - PROCESS | 11242 | Values: 112.0 105.0 110.0 110.0 111.0 111.0 110.0 111.0 110.0 111.0 00:28:30 INFO - PROCESS | 11242 | 00:28:30 INFO - PROCESS | 11242 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:139.50 stddev:17.23 (12.3%) stddev-sans-first:17.35 00:28:30 INFO - PROCESS | 11242 | Values: 154.0 124.0 128.0 173.0 130.0 124.0 149.0 122.0 152.0 130.0 00:28:30 INFO - PROCESS | 11242 | 00:28:30 INFO - PROCESS | 11242 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:1.29 (0.8%) stddev-sans-first:1.36 00:28:30 INFO - PROCESS | 11242 | Values: 160.0 161.0 163.0 158.0 160.0 160.0 160.0 159.0 160.0 160.0 00:28:30 INFO - PROCESS | 11242 | 00:28:30 INFO - PROCESS | 11242 | [#3] audio-fft Cycles:10 Average:80.00 Median:75.00 stddev:11.09 (14.8%) stddev-sans-first:11.61 00:28:30 INFO - PROCESS | 11242 | Values: 75.0 74.0 75.0 100.0 75.0 75.0 74.0 75.0 102.0 75.0 00:28:30 INFO - PROCESS | 11242 | 00:28:30 INFO - PROCESS | 11242 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:84.50 stddev:16.32 (19.3%) stddev-sans-first:16.85 00:28:30 INFO - PROCESS | 11242 | Values: 84.0 85.0 110.0 84.0 84.0 86.0 118.0 85.0 85.0 125.0 00:28:30 INFO - PROCESS | 11242 | 00:28:30 INFO - PROCESS | 11242 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 00:28:30 INFO - PROCESS | 11242 | Values: 116.0 117.0 118.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 00:28:30 INFO - PROCESS | 11242 | 00:28:30 INFO - PROCESS | 11242 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 00:28:30 INFO - PROCESS | 11242 | Values: 145.0 146.0 145.0 145.0 145.0 145.0 146.0 146.0 147.0 145.0 00:28:30 INFO - PROCESS | 11242 | 00:28:30 INFO - PROCESS | 11242 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 00:28:30 INFO - PROCESS | 11242 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 96.0 95.0 95.0 95.0 00:28:30 INFO - PROCESS | 11242 | 00:28:30 INFO - PROCESS | 11242 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:52.00 stddev:0.84 (1.6%) stddev-sans-first:0.73 00:28:30 INFO - PROCESS | 11242 | Values: 50.0 51.0 50.0 51.0 52.0 52.0 52.0 52.0 52.0 52.0 00:28:30 INFO - PROCESS | 11242 | 00:28:30 INFO - PROCESS | 11242 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 00:28:30 INFO - PROCESS | 11242 | Values: 61.0 61.0 59.0 60.0 61.0 60.0 61.0 60.0 60.0 62.0 00:28:30 INFO - PROCESS | 11242 | 00:28:30 INFO - PROCESS | 11242 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:77.00 stddev:10.29 (13.4%) stddev-sans-first:10.79 00:28:30 INFO - PROCESS | 11242 | Values: 76.0 76.0 75.0 76.0 78.0 77.0 77.0 83.0 109.0 77.0 00:28:30 INFO - PROCESS | 11242 | 00:28:30 INFO - PROCESS | 11242 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:124.50 stddev:7.63 (6.1%) stddev-sans-first:7.97 00:28:30 INFO - PROCESS | 11242 | Values: 127.0 118.0 128.0 122.0 115.0 121.0 115.0 117.0 138.0 131.0 00:28:30 INFO - PROCESS | 11242 | 00:28:30 INFO - PROCESS | 11242 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.00 Median:157.00 stddev:2.71 (1.7%) stddev-sans-first:2.87 00:28:30 INFO - PROCESS | 11242 | Values: 156.0 158.0 156.0 160.0 159.0 152.0 154.0 154.0 153.0 158.0 00:28:30 INFO - PROCESS | 11242 | 00:28:30 INFO - PROCESS | 11242 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.20 Median:61.50 stddev:1.03 (1.7%) stddev-sans-first:1.05 00:28:30 INFO - PROCESS | 11242 | Values: 62.0 62.0 62.0 61.0 61.0 61.0 63.0 60.0 60.0 60.0 00:28:30 INFO - PROCESS | 11242 | -------- Summary: end -------- 00:28:30 INFO - PROCESS | 11242 | 00:28:31 INFO - TEST-INFO | 11242: exit 0 00:28:31 INFO - TEST-OK | kraken | took 59852ms 00:28:31 INFO - SUITE-END | took 1172s 00:28:31 INFO - Completed test suite (00:19:32) 00:28:31 INFO - javascript benchmark 00:28:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3279.1965968337754, 3303.322818822142, 3311.039798458447, 3323.5513205717252, 3351.4135026370377, 5340.225667278242, 5379.273798037264, 5398.109311963526, 5423.078076726956, 5424.050791111559, 5323.201519772036, 5369.140937450009, 5376.435474275204, 5377.4084850666395, 5378.515933565978, 4820.517948205186, 4879.268109783534, 4892.681975671588, 4956.033573453178, 4967.602591792648, 4782.641301902354, 4916.680415772981, 4969.25461180824, 4969.4036715594175, 4977.800887964477, 4889.8777530561665, 4910.1652719037675, 4925.48282430345, 4929.876753081184, 4961.727105009223, 5013.548780609726, 5021.5480606745205, 5026.723530205837, 5037.0681423936685, 5051.79792808289, 4806.038792241566, 4826.372571565674, 4867.4889136640495, 4923.113839508887, 4969.726665033421, 5179.689218646856, 5206.088934436459, 5211.322528071327, 5219.321488206547, 5259.421463638997, 5743.770249190027, 5748.109043098327, 5761.711914404305, 5771.538276937835, 5774.076147816371, 5724.513416359614, 5790.33411157718, 5791.44981226787, 5804.8839023219725, 5839.7664093436215, 5429.53848922842, 5474.589405794542, 5476.096444086721, 5482.780688772445, 5485.890282194334, 5697.145428185722, 5971.731272092767, 5974.074018527135, 5981.252343457068, 5981.910271345933, 5572.331320241516, 5629.634073785191, 5641.717914104361, 5653.519450846642, 5703.258576385043, 5740.6268592541355, 5742.253507044141, 5745.109508026179, 5746.42535746422, 5769.9711501442225, 5560.666360018331, 5667.716614169275, 5699.316082070178, 5715.399883012224, 5717.142428635738, 5718.399568045378, 5797.333306669787, 5800.419958004166, 5802.82591522255, 5839.737211825478, 4525.094981003813, 4525.683202175816, 4528.728276303433, 4531.071130418256, 4553.977230113828, 3964.0882597002274, 3981.3231750602467, 3985.9202815943518, 4053.3919912013434, 4090.1615168890307, 5412.269343638558, 5427.050266203399, 5431.782728690808, 5436.29328187341, 5439.374471935778, 5741.7990370337675, 5766.682832444172, 5767.653940763567, 5773.076307790818, 5812.302523697099, 5238.790448382022, 5369.060414427459, 5394.730263486888, 5424.647397919122, 5452.291202143696, 4945.282933974553, 4972.229304457743, 4973.1297023020825, 4974.030064137459, 5005.549500544968, 5792.594518383757, 5971.940280597225, 6011.248593925759, 6028.879422411527, 6034.396560344018, 5636.098224284095, 5699.401562836008, 5706.914396284142, 5768.077107662753, 5799.710014499343, 5906.468417842415, 5909.409059094056, 5917.112433135064, 5924.555658325557, 5997.610155340063, 5553.555715542828, 5677.971610142088, 5680.630759000652, 5682.9431705684065, 5686.658800471985, 5580.2745643067765, 5587.3015873015875, 5632.85917852057, 5683.431656834284, 5685.0335442973965, 5574.637648552831, 5598.468145526169, 5601.103823388401, 5603.523700485504, 5604.299462567179, 5439.728013599225, 5557.666540007613, 5564.276644036249, 5566.053770858883, 5567.359753628384, 5523.475269849358, 5576.832695019156, 5590.0, 5594.0, 5623.128415095667, 5663.575231857545, 5710.971445142748, 5737.512311453574, 5744.540436765133, 5748.166515855261, 5382.434844341445, 5440.972795135999, 5474.206240095244, 5519.972400138135, 5605.579581531483], "value": 5319.085193014943, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.5809933046868, 641.7208514296282, 648.8086014625682, 655.3741177175796, 662.5262937000044, 31831.363372732532, 45159.322610160874, 45658.08683826322, 46060.53939460613, 46075.0, 47326.0, 47890.0, 47948.04103917928, 47980.52019479804, 47988.28017579731, 8198.057223419324, 9043.140901614335, 9187.310951678617, 9191.31065170115, 10817.0, 10522.31604945676, 10642.62750803722, 10959.890401095967, 10980.835287470694, 11006.559737610485, 11035.117190624731, 11127.944360278187, 11130.49912753928, 11132.053775429098, 11133.387663678495, 8238.382121340894, 10798.0, 11003.61487347943, 11073.280236784583, 11073.280236784583, 10939.56241750329, 10971.506282217319, 11014.284071535325, 11016.228863979524, 11020.614278500294, 45287.0, 45604.771976139906, 45690.0, 45690.0, 45804.312935306, 3633.418653015531, 3716.9070773230615, 3828.453344780429, 4085.3259212229946, 4199.91600167998, 34061.48907766386, 34189.65810341889, 34506.137346566284, 35156.29687406238, 36072.639273607194, 4669.089527542131, 4673.415823022122, 4686.742229177394, 4711.717296962193, 4769.260764581495, 395586.0, 399217.0, 400760.0, 400925.0, 401036.0, 39342.409863852066, 40132.19735605272, 68002.0, 68046.65976670085, 68426.0, 39640.405393919114, 39665.40501892416, 39746.60253397487, 39775.40336894949, 39803.0, 17548.29806807739, 17727.822721772616, 17731.822681773017, 17735.0, 17742.556436089202, 12484.50061997528, 13531.0, 13652.658683532793, 13674.453021879212, 14029.649258768408, 9366.391184573116, 9389.483578403253, 9417.858732119024, 9452.57463414148, 9482.431054136774, 3487.877924272689, 3487.9306210535074, 3523.2777280657406, 3563.2873425315042, 3598.4962105305276, 1020.3877673395903, 1118.1278602689915, 1122.747381839096, 1184.4965889497103, 1205.3069485046133, 33619.495707564405, 33635.32729345448, 34022.0, 34125.0, 34206.65793342084, 1134.500819639356, 1167.7606090751544, 1173.935433551163, 1227.643983244849, 1268.2580690296095, 17292.22185001653, 17735.37926172578, 17739.0, 17910.731339029924, 17951.640967180585, 649717.0, 654116.0, 655475.0, 655763.0, 657037.0, 62732.37267627357, 64204.357956420776, 64288.0, 64301.35698643047, 64320.67839660772, 1352.4049418255936, 1433.340663294896, 1439.6185010972101, 1471.8013068235866, 1479.6153000219806, 32580.0, 34742.30515389729, 34749.82625086858, 35153.82423087868, 35222.491267069156, 52981.0, 53420.73289633527, 53629.7318513405, 53678.0, 53714.46285537095, 431287.0, 435439.0, 435540.0, 436160.0, 436183.0, 27317.863410682818, 29860.253493662833, 30493.54259686151, 30538.389232215675, 32196.678033219367, 49987.50012499828, 50838.0, 51787.223191652905, 52457.7377113112, 52489.737551312, 43081.0, 43202.78398607987, 43259.783701081295, 43744.0, 43809.34285985777, 45814.31278530758, 45908.0, 46129.0, 46868.765656172865, 47868.521314786405, 43747.781261094766, 43857.78071109752, 44564.55435445734, 44727.77636111798, 44819.55180448154, 36182.0, 37678.62321376751, 37850.62149378581, 38615.0, 39290.0, 29439.411211775216, 29565.704342956295, 29730.702692972794, 29832.0, 30109.397812044073], "value": 20645.913015761154, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.98957526061844, 424.81945173301347, 425.1878911279457, 425.351339207708, 435.3752365355715, 19058.90470547647, 19438.805611943877, 20481.795182048176, 20493.282735104276, 20647.38057858263, 14336.875591596157, 16638.83361166388, 19289.614207715837, 19417.805821941776, 20659.483512912146, 5605.915911261324, 5642.0, 5871.471567558919, 5930.733117009745, 5964.19483369746, 5900.055991041434, 5912.4974377178, 5928.436798504157, 5938.613990090652, 5954.225950626413, 4029.9395509067385, 5540.0, 5875.559333050017, 5914.290285165786, 5917.20117784098, 5775.364709881909, 5826.912596311059, 5859.414058594107, 5863.472287494124, 5868.9413105868825, 5524.281843360378, 5676.489115979582, 5782.653040817564, 5784.363719990798, 5786.508146807527, 14520.273986300643, 14586.781198282035, 14716.264186790724, 14737.189454579993, 14934.775978360334, 2208.2491952735986, 2251.763564825686, 2261.061659411342, 2367.7987371073477, 3006.8947586834574, 10497.580096796119, 10654.680359589225, 10834.67495975122, 14054.578362649137, 14759.70480590393, 1889.263187356932, 1893.4130419569976, 1937.7190307405488, 1963.0462021917665, 2004.7794742578305, 71496.0, 75355.62322188409, 76884.61557692231, 84945.0, 85165.57417212936, 11220.55117795279, 11622.302661840316, 11740.706482337839, 11840.987032204546, 11985.580504682293, 16908.492745217663, 16957.40649077301, 17047.91476042612, 17061.232244549024, 17072.82927170737, 8467.280281176047, 8810.691625793066, 9017.954910225408, 9036.683716069905, 9074.500902450296, 8753.649854005896, 8878.86681699775, 8902.376833621584, 8985.595648195847, 8999.505027223566, 5084.161113416245, 5117.334746482933, 5138.58891288696, 5157.664751791197, 5233.188855727369, 2045.4886278430392, 2060.958780824405, 2076.2733043434678, 2082.2295750572384, 2085.708000879878, 484.73824134966725, 923.9953800231091, 1053.0514559234266, 1081.9296745711504, 1092.792369449802, 11876.703082422835, 12268.141230113984, 12612.243265404106, 12649.873501265054, 12828.935855320664, 482.642844295219, 487.2909916072107, 493.7481884238992, 501.85947934578377, 509.1268474566137, 6868.759593414206, 6872.278410766798, 6924.307569243036, 6938.618375989268, 6949.89575156373, 514536.0, 522481.0, 524149.0, 526826.0, 527050.0, 65782.0, 103014.48492757489, 104721.0, 105143.4742826281, 105859.470702646, 1068.9946550267198, 1083.7344850511674, 1106.6126855600637, 1109.312226419625, 1110.9833352499718, 17969.550761231072, 18080.638387232444, 18207.807032781282, 18221.817781822014, 18266.178021988777, 40651.59348406478, 42293.577064228964, 42870.57129428666, 43725.78137109294, 43920.78039609781, 59593.0, 60210.910869445805, 60526.0, 60988.0, 61901.380986189564, 7839.647215875413, 8162.632681529227, 8387.580620968805, 8459.95770021146, 8761.29909607217, 9063.32025098107, 9364.625414983597, 13446.058775885595, 13629.659258518617, 13711.588652340446, 12123.090768192244, 12128.514859405524, 12182.939085304517, 12239.632811015685, 12289.692757680772, 5818.7090645466715, 10991.890081099087, 11301.71745706331, 11895.76208475843, 12149.1495595311, 11809.0, 12384.318862462651, 12615.621531354074, 12639.0, 12721.681957951125, 8753.431026983226, 8940.597673104596, 9094.909050909671, 9116.27069834425, 9186.265098791948, 12153.149279550347, 12526.436310365872, 12594.433250503565, 12620.36898155107, 12695.047871409497], "value": 8962.944694472877, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1377.2356342230057, 1504.2253239581617, 1565.248680633296, 1741.4514427955194, 1864.7343477674622, 9167.449953002817, 9511.191548718358, 9529.0, 9749.0, 9754.170895473875, 9521.761955951104, 9735.756606084851, 9739.805203895936, 9744.269179811507, 9755.365901216433, 2156.644153714635, 2229.3869185973904, 2372.620380739082, 2378.0, 2411.0, 2460.2004348586693, 2470.765277298654, 2471.1968610201666, 2472.9629055564183, 2474.5174690935273, 2356.5522550715395, 2401.6037353836596, 2402.327348342467, 2402.9158979435724, 2404.4349577849193, 2088.550961543268, 2313.7339205991275, 2326.1160758911674, 2394.4971555973093, 2400.7719266669637, 2398.196604137616, 2407.915722949706, 2429.161939130997, 2431.55016321981, 2432.3311089450367, 9695.51522423883, 9758.072983066597, 9759.65841195562, 9766.658166964122, 9776.804463910754, 5406.08096623575, 5530.115181570929, 5534.169874518814, 5541.5843811714285, 5543.057680194336, 3208.406444807718, 3301.6863397977154, 3372.291818718072, 3378.054144839449, 3415.829208539588, 1069.909057730086, 1085.3542142425324, 1103.178132291448, 1146.0774076868117, 2311.5261371418987, 13144.40850161745, 13555.59333220005, 13651.38568764408, 13651.795223071662, 13657.385417656229, 4792.448868380181, 4796.352492413549, 4810.6632535722165, 4821.276808478756, 4854.466008739036, 10684.679459616224, 10771.0, 10771.084457821016, 10774.892251077388, 10781.460926953621, 5603.635763675429, 5627.437256274422, 5633.0, 5633.746481408347, 5636.943630563642, 4658.534146585383, 4769.689970151929, 4917.459079501252, 4932.8520144395725, 4967.3542439482635, 4041.515018197835, 4045.8417191136905, 4078.4290199372113, 4115.54728979812, 4118.5263694674895, 1159.8724140344555, 1162.3258510064143, 1168.894799468052, 1170.163333216737, 1199.8680145184198, 972.9854052189223, 1002.4987506246877, 1011.0950699124243, 1081.502508845924, 1090.9236353455183, 6489.935100648933, 6596.670166491656, 6650.70071846768, 6673.432758215509, 6941.167059952838, 482.39700374531833, 490.2376804069635, 490.3992609053952, 498.41685228282995, 498.86780003299157, 4484.865454036384, 4488.349189367524, 4491.595756381941, 4493.191225579361, 4508.661850361236, 11583.76832463363, 11863.76272474563, 12193.207441516273, 12310.692232694075, 12326.32205228721, 12166.756664866652, 12249.0, 12284.754304913851, 12286.508539658493, 12290.692732681755, 8744.737657870273, 8925.330600204881, 8963.103689630985, 8983.416077954913, 9028.954855225813, 6497.382748638872, 6849.691763870737, 6887.345702158287, 6951.965240173767, 6992.4406047517095, 10774.946125269324, 11269.267497612957, 11280.435978201222, 11446.599369022044, 11472.94263528677, 11170.050545703707, 11280.210385272952, 11589.362585057903, 11594.362310073027, 11617.593384231512, 8276.540364402339, 8687.0, 8799.780005499657, 8810.207081362709, 8814.735557933273, 9249.953750231205, 9260.30547708938, 9283.071692830934, 9295.581698823704, 9326.0, 8502.957485212535, 8511.404201705822, 8545.359098067795, 8567.057623661516, 8750.081241469808, 8304.792380190544, 8342.916570834457, 8358.205970432798, 8438.493690378597, 8441.915580844114, 7490.0, 7492.662830172546, 7538.849223015619, 7539.886901696369, 7542.321191092828, 5547.7780888764, 5631.070873306023, 5675.035244008446, 5733.111367738007, 5758.769649214152, 5589.273394458694, 5721.628094173865, 5737.397573254748, 5766.913496297643, 5801.071828507418], "value": 4884.237535942696, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.52577628432033, 338.050079277231, 341.4639016743712, 351.2430711816036, 356.4599631558189, 5283.8150664726745, 5456.91814622781, 5457.126859702448, 5474.562035037197, 5539.833804985852, 5450.209719590657, 5464.6994415307145, 5480.849021705447, 5486.710623003591, 5513.283273174492, 4320.870373888788, 4325.718828276168, 4347.434833471644, 4359.803808828595, 4372.693911426201, 3945.763254204757, 3984.0, 4334.653227741773, 4357.821089455272, 4361.171377438292, 4266.445362102922, 4291.678124140686, 4305.806238719249, 4309.439772829528, 4323.502797178317, 4264.0, 4294.527601963766, 4294.677899157545, 4299.14017196562, 4332.566743325674, 3752.9249415011545, 3818.369968955119, 3844.500214972036, 3847.153626202231, 3873.4770805941403, 5168.0, 5205.947940520584, 5206.453322401131, 5229.947700523022, 5231.973840130813, 4869.662561970239, 4880.536349046871, 4889.902201955941, 4890.217565189552, 4922.187839006559, 5580.302462192226, 5605.691686957216, 5665.631733937281, 5694.373618901917, 5717.0, 4135.6898232632675, 4137.089840235173, 4189.72766770162, 4191.161767646452, 4193.97903010483, 5840.890230856124, 5853.487907255655, 5923.733431995571, 5944.940550594439, 5972.193753843219, 4210.536840947493, 4259.318509038539, 4309.892252693645, 4316.546762589883, 4328.870133895988, 4312.568743125725, 4340.197063543254, 4343.478782546114, 4349.26062569364, 4355.825766969286, 4882.462929077798, 4917.704937703677, 4921.975390123026, 4924.581410580069, 4936.432310284364, 5471.50756431923, 5771.220885180531, 5788.421157884178, 5801.622894511843, 5811.970940145272, 1457.1402872305391, 1470.9485168019069, 1505.7214415333199, 1512.2287633306873, 1521.4826958834049, 962.855571664256, 981.7923953537047, 982.2485798364257, 984.1142971325864, 993.9105480506645, 4954.117435374606, 5001.724560237116, 5012.273220383097, 5040.420351659533, 5058.190689489664, 5233.226390013223, 5238.790448382022, 5241.633085683966, 5261.710605916712, 5266.183741520071, 4731.645126615517, 4961.280614310905, 4975.751212439363, 4981.875453113628, 5010.874728131826, 2753.719520422973, 2793.469240844274, 2796.0, 2812.690604033555, 2834.447282779838, 5357.276767636319, 5411.648242864201, 5442.945570544323, 5453.15476101205, 5463.453654634504, 5122.769475373617, 5162.244836755521, 5293.444188360244, 5297.205419187076, 5337.973310133502, 5411.214299281228, 5427.999999999921, 5450.291462109901, 5456.91814622781, 5483.0, 5179.766910488962, 5220.9477905220465, 5284.894302114013, 5306.469353064663, 5309.973315210293, 4910.558049775537, 5143.0, 5149.459306772885, 5151.562117220078, 5170.768269831356, 5288.338957630296, 5353.072893758322, 5359.839204823861, 5392.811251606175, 5401.432849550741, 3901.731937120504, 3909.6481316681634, 3926.3521518949055, 3930.1157239620857, 3969.7816620086173, 4921.311016457627, 5173.92239116406, 5205.531502164823, 5629.802956896653, 5710.685912274698, 5676.672564248638, 5685.545156387397, 5702.34423041339, 5728.79949201776, 5741.45456181662, 5687.43125687428, 5708.8572785679025, 5712.485876271156, 5715.0, 5740.569457290803, 5533.972330138324, 5550.222968784293, 5590.077637189818, 5620.4660557247, 5650.773969041193, 5682.346530149086, 5693.117566777156, 5755.884882302246, 5758.62568933018, 5797.956367853827, 5437.8368648940595, 5599.776008959596, 5626.127950167731, 5634.830955071355, 5669.546436285004], "value": 4231.7496743985075, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.1553398058247, 736.7053178728511, 772.8183876788958, 866.3199388480043, 928.0487500312179, 15476.458323958665, 16282.104484253361, 16527.752083718722, 16882.240299186535, 17059.23233454496, 13813.723725525484, 13915.095518791271, 13938.581842544714, 13940.163590184597, 13958.0, 725.2095216214325, 742.5544673196066, 745.8135466133467, 869.7738587967111, 880.8634661627426, 741.8590467811125, 858.0389963241147, 878.1350369885689, 879.5514287713248, 886.9379143459961, 922.3681777982071, 923.1968187676731, 925.8842644669417, 926.9629214831399, 928.1368327455464, 751.7970148059993, 883.2713011765319, 923.8337099322085, 925.5279807298293, 925.7407925780758, 668.2482207516543, 671.1543455246425, 671.6977360187935, 672.2067959807425, 672.9427998620123, 13981.510647127403, 13984.580462586138, 14013.509527166601, 14017.43930242789, 14022.439102435992, 15076.924615376962, 15502.147381893992, 15541.378344866305, 15663.608409789733, 15847.366105355772, 13645.727085458335, 13973.860261397358, 14131.0, 14181.645458863508, 14304.856951430456, 4712.6465515086165, 4727.479977202505, 4734.763261836894, 4780.569748722632, 4896.755162241873, 65287.0, 66908.6654566729, 67021.329786702, 75769.99999999945, 76188.61905690435, 12272.877271227351, 12453.779173790206, 12533.060020498498, 12757.0, 12797.104202705721, 21820.0, 21857.562848743255, 21873.562528749335, 21925.451863703536, 21927.561448770935, 8726.432781869158, 8778.0, 8972.327075469235, 8986.101389860962, 9042.412243204171, 4926.537994598703, 4957.628177886673, 4971.105201063771, 4996.825111121093, 5152.639315247897, 3765.661090501868, 3865.69074474047, 3865.9806700966315, 3866.7679939203736, 3877.360235561101, 674.0293976673672, 679.3715812873072, 680.5916450129882, 681.3799442507394, 689.334791925794, 631.7599312261403, 689.407109885498, 798.648594618366, 810.4205493072482, 824.6907409721355, 10675.679729608124, 10687.091597214323, 10781.514831832586, 10862.837057444145, 10973.177011724152, 672.5477340009171, 687.5221720904024, 690.6305126757161, 708.1572928215408, 717.121526130486, 4590.219662657356, 4884.083749863356, 4937.843765316268, 4951.628627852925, 4968.403791544965, 67904.6604766973, 68403.0, 73260.26739732534, 116209.4189529047, 118607.0, 95852.0, 97344.0, 97653.51173244088, 97882.0, 100157.0, 88068.5596572013, 90210.0, 90388.5480572593, 91259.0, 92277.53861230651, 8641.438306510057, 8706.91293087061, 8856.690015849414, 9520.714378568655, 9773.0, 41641.58358416498, 48382.27426588534, 51361.64331805536, 51775.22337165021, 52087.218691718896, 52590.474095258556, 52607.73696131495, 59297.70351148216, 75901.24098759162, 76561.23438765763, 12015.871518173035, 12088.093392995384, 12230.816537752118, 12571.275039555738, 12629.0, 13513.729725405634, 13659.453621855411, 13824.170549767046, 13867.0, 14633.853661463248, 12566.685832854251, 12766.68083297925, 12905.290209038592, 13007.609771706864, 13404.463821447032, 13078.476860925457, 13103.2138071716, 13139.60581182566, 13312.733745324846, 13556.186628802303, 12343.317191765866, 12457.750844983231, 12678.98568114567, 12733.490660373853, 12750.0, 10424.270301078852, 10532.157427405942, 10717.5583105903, 11001.944990274997, 11163.330200188015, 9936.354136981074, 10565.366078035342, 10646.787064258517, 10852.565897364017, 10902.454877255946], "value": 7625.386155822567, "unit": "score"}], "name": "dromaeo_css", "value": 7330.3393806699105, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 110.0, 110.0, 111.0, 111.0, 110.0, 111.0, 110.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 128.0, 173.0, 130.0, 124.0, 149.0, 122.0, 152.0, 130.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 163.0, 158.0, 160.0, 160.0, 160.0, 159.0, 160.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 100.0, 75.0, 75.0, 74.0, 75.0, 102.0, 75.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 110.0, 84.0, 84.0, 86.0, 118.0, 85.0, 85.0, 125.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 118.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 147.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 51.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 59.0, 60.0, 61.0, 60.0, 61.0, 60.0, 60.0, 62.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 76.0, 78.0, 77.0, 77.0, 83.0, 109.0, 77.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 118.0, 128.0, 122.0, 115.0, 121.0, 115.0, 117.0, 138.0, 131.0], "value": 123.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 158.0, 156.0, 160.0, 159.0, 152.0, 154.0, 154.0, 153.0, 158.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 61.0, 61.0, 63.0, 60.0, 60.0, 60.0], "value": 61.2, "unit": "score"}], "name": "kraken", "value": 1473.2000000000003, "alertThreshold": 2.0}]} 00:28:31 INFO - Return code: 0 00:28:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:28:31 ERROR - # TBPL SUCCESS # 00:28:31 INFO - Running post-action listener: _resource_record_post_action 00:28:31 INFO - ##### 00:28:31 INFO - ##### Finished run-tests step (success) 00:28:31 INFO - ##### 00:28:31 INFO - Running post-run listener: _resource_record_post_run 00:28:31 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 331776; Write bytes: 251637760; Read time: 84; Write time: 176276 00:28:31 INFO - TinderboxPrint: CPU usage
13.1% 00:28:31 INFO - TinderboxPrint: I/O read bytes / time
331,776 / 84 00:28:31 INFO - TinderboxPrint: I/O write bytes / time
251,637,760 / 176,276 00:28:31 INFO - TinderboxPrint: CPU idle
8,242.0 (86.8%) 00:28:31 INFO - TinderboxPrint: CPU user
1,203.9 (12.7%) 00:28:31 INFO - TinderboxPrint: Swap in / out
0 / 0 00:28:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1134592; Read time: 0; Write time: 36 00:28:31 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 307200; Write bytes: 250503168; Read time: 76; Write time: 176240 00:28:32 INFO - Running post-run listener: _upload_blobber_files 00:28:32 INFO - Blob upload gear active. 00:28:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:28:32 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 00:28:32 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'] 00:28:32 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 00:28:32 INFO - (blobuploader) - INFO - Open directory for files ... 00:28:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:28:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:28:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:28:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:28:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:28:33 INFO - (blobuploader) - INFO - Done attempting. 00:28:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:28:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:28:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:28:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:28:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:28:33 INFO - (blobuploader) - INFO - Done attempting. 00:28:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:28:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:28:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:28:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:28:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:28:37 INFO - (blobuploader) - INFO - Done attempting. 00:28:37 INFO - (blobuploader) - INFO - Iteration through files over. 00:28:37 INFO - Return code: 0 00:28:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:28:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:28:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a239d5953236b04232911f29ec8ff2c53bba9bbb013b06471f33417371e4544eb83a9f3f075e4a1e56543f92e5fb1ebf5079b8feb347ce34fa5c8c6901d387b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d369b3506984146cf1c62f67e73564ec5c6ba16399cdaa09d42e838cc696a00ea36a15759f098a6d63199494704fcde779b499feeafa617c7094768d40ac9bc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c86d8af7dcecc2aea82a397e32d523521af2cdef2b761bcbfbfa094c17191e331ffb64e84246c6860ae14a0786441afab007fb0f1084034d3988319b370fb22"} 00:28:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:28:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:28:37 INFO - Contents: 00:28:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a239d5953236b04232911f29ec8ff2c53bba9bbb013b06471f33417371e4544eb83a9f3f075e4a1e56543f92e5fb1ebf5079b8feb347ce34fa5c8c6901d387b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d369b3506984146cf1c62f67e73564ec5c6ba16399cdaa09d42e838cc696a00ea36a15759f098a6d63199494704fcde779b499feeafa617c7094768d40ac9bc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c86d8af7dcecc2aea82a397e32d523521af2cdef2b761bcbfbfa094c17191e331ffb64e84246c6860ae14a0786441afab007fb0f1084034d3988319b370fb22"} 00:28:37 INFO - Running post-run listener: copy_logs_to_upload_dir 00:28:37 INFO - Copying logs to upload dir... 00:28:37 INFO - mkdir: /builds/slave/test/build/upload/logs 00:28:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.874643 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-01 00:28:37.102866) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 00:28:37.106790) ========= 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=62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917 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/2a239d5953236b04232911f29ec8ff2c53bba9bbb013b06471f33417371e4544eb83a9f3f075e4a1e56543f92e5fb1ebf5079b8feb347ce34fa5c8c6901d387b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d369b3506984146cf1c62f67e73564ec5c6ba16399cdaa09d42e838cc696a00ea36a15759f098a6d63199494704fcde779b499feeafa617c7094768d40ac9bc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c86d8af7dcecc2aea82a397e32d523521af2cdef2b761bcbfbfa094c17191e331ffb64e84246c6860ae14a0786441afab007fb0f1084034d3988319b370fb22"} build_url:https://queue.taskcluster.net/v1/task/N-qfo_KAQjGUo0eEZ129eg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011326 build_url: 'https://queue.taskcluster.net/v1/task/N-qfo_KAQjGUo0eEZ129eg/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/2a239d5953236b04232911f29ec8ff2c53bba9bbb013b06471f33417371e4544eb83a9f3f075e4a1e56543f92e5fb1ebf5079b8feb347ce34fa5c8c6901d387b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d369b3506984146cf1c62f67e73564ec5c6ba16399cdaa09d42e838cc696a00ea36a15759f098a6d63199494704fcde779b499feeafa617c7094768d40ac9bc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c86d8af7dcecc2aea82a397e32d523521af2cdef2b761bcbfbfa094c17191e331ffb64e84246c6860ae14a0786441afab007fb0f1084034d3988319b370fb22"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 00:28:37.133783) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 00:28:37.134350) ========= 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=62c568580acbfdaac3eec7be000001dc-1470035029.688405-1563656917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 00:28:37.219621) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 00:28:37.220186) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 00:28:37.220676) ========= ========= Total master_lag: 0.18 =========