builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1465640605.81 results: success (0) buildid: 20160611004009 builduid: c2666fad52f4480085240219fb7a3cde revision: 4253296f212b3cca52992ec5f6cd824b13153abd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-11 03:23:25.813352) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-11 03:23:25.813765) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-11 03:23:25.814041) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-11 03:23:25.861732) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 03:23:25.862000) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-11 03:23:25-- 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% 51.1M=0s 2016-06-11 03:23:25 (51.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144901 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 03:23:26.030395) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 03:23:26.030740) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.158431 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 03:23:26.202681) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 03:23:26.203007) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4253296f212b3cca52992ec5f6cd824b13153abd --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 4253296f212b3cca52992ec5f6cd824b13153abd --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-11 03:23:26,234 truncating revision to first 12 chars 2016-06-11 03:23:26,234 Setting DEBUG logging. 2016-06-11 03:23:26,234 attempt 1/10 2016-06-11 03:23:26,235 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4253296f212b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-11 03:23:26,548 unpacking tar archive at: mozilla-aurora-4253296f212b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647161 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 03:23:26.865340) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-11 03:23:26.865866) ========= script_repo_revision: 4253296f212b3cca52992ec5f6cd824b13153abd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-11 03:23:26.866418) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-11 03:23:26.866946) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-11 03:23:26.883094) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-11 03:23:26.883499) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:23:27 INFO - MultiFileLogger online at 20160611 03:23:27 in /builds/slave/test 03:23:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:23:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:23:27 INFO - {'append_to_log': False, 03:23:27 INFO - 'base_work_dir': '/builds/slave/test', 03:23:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:23:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:23:27 INFO - 'branch': 'Mozilla-Aurora', 03:23:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:23:27 INFO - 'config_files': ('talos/linux_config.py',), 03:23:27 INFO - 'default_actions': ('clobber', 03:23:27 INFO - 'read-buildbot-config', 03:23:27 INFO - 'download-and-extract', 03:23:27 INFO - 'populate-webroot', 03:23:27 INFO - 'create-virtualenv', 03:23:27 INFO - 'install', 03:23:27 INFO - 'run-tests'), 03:23:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:23:27 INFO - 'download_minidump_stackwalk': True, 03:23:27 INFO - 'download_symbols': 'ondemand', 03:23:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:23:27 INFO - 'tooltool.py': '/tools/tooltool.py', 03:23:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:23:27 INFO - '/tools/misc-python/virtualenv.py')}, 03:23:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:23:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:23:27 INFO - 'installer_path': 'installer.exe', 03:23:27 INFO - 'log_level': 'info', 03:23:27 INFO - 'log_name': 'talos', 03:23:27 INFO - 'log_to_console': True, 03:23:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:23:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:23:27 INFO - 'opt_config_files': (), 03:23:27 INFO - 'pip_index': False, 03:23:27 INFO - 'sps_profile': False, 03:23:27 INFO - 'sps_profile_interval': 0, 03:23:27 INFO - 'suite': 'dromaeojs', 03:23:27 INFO - 'system_bits': '32', 03:23:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:23:27 INFO - 'title': 'talos-linux64-ix-050', 03:23:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:23:27 INFO - 'use_talos_json': True, 03:23:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:23:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:23:27 INFO - 'work_dir': 'build'} 03:23:27 INFO - ##### 03:23:27 INFO - ##### Running clobber step. 03:23:27 INFO - ##### 03:23:27 INFO - Running pre-action listener: _resource_record_pre_action 03:23:27 INFO - Running main action method: clobber 03:23:27 INFO - rmtree: /builds/slave/test/build 03:23:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:23:29 INFO - Running post-action listener: _resource_record_post_action 03:23:29 INFO - ##### 03:23:29 INFO - ##### Finished clobber step (success) 03:23:29 INFO - ##### 03:23:29 INFO - ##### 03:23:29 INFO - ##### Running read-buildbot-config step. 03:23:29 INFO - ##### 03:23:29 INFO - Running pre-action listener: _resource_record_pre_action 03:23:29 INFO - Running main action method: read_buildbot_config 03:23:29 INFO - Using buildbot properties: 03:23:29 INFO - { 03:23:29 INFO - "project": "", 03:23:29 INFO - "product": "firefox", 03:23:29 INFO - "script_repo_revision": "production", 03:23:29 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:23:29 INFO - "repository": "", 03:23:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:23:29 INFO - "buildid": "20160611004009", 03:23:29 INFO - "stage_platform": "linux64-pgo", 03:23:29 INFO - "basedir": "/builds/slave/test", 03:23:29 INFO - "nightly_build": "True", 03:23:29 INFO - "buildnumber": 296, 03:23:29 INFO - "slavename": "talos-linux64-ix-050", 03:23:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:23:29 INFO - "platform": "ubuntu64_hw", 03:23:29 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:23:29 INFO - "branch": "mozilla-aurora", 03:23:29 INFO - "repo_path": "releases/mozilla-aurora", 03:23:29 INFO - "revision": "4253296f212b3cca52992ec5f6cd824b13153abd", 03:23:29 INFO - "pgo_build": "True", 03:23:29 INFO - "builduid": "c2666fad52f4480085240219fb7a3cde", 03:23:29 INFO - "slavebuilddir": "test" 03:23:29 INFO - } 03:23:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:23:29 INFO - Running post-action listener: _resource_record_post_action 03:23:29 INFO - ##### 03:23:29 INFO - ##### Finished read-buildbot-config step (success) 03:23:29 INFO - ##### 03:23:29 INFO - ##### 03:23:29 INFO - ##### Running download-and-extract step. 03:23:29 INFO - ##### 03:23:29 INFO - Running pre-action listener: _resource_record_pre_action 03:23:29 INFO - Running main action method: download_and_extract 03:23:29 INFO - mkdir: /builds/slave/test/build/tests 03:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:29 INFO - https://queue.taskcluster.net/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:23:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:23:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:23:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:23:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:23:38 INFO - Downloaded 1361 bytes. 03:23:38 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:23:38 INFO - Using the following test package requirements: 03:23:38 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:23:38 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:23:38 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:23:38 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:38 INFO - u'jsshell-linux-x86_64.zip'], 03:23:38 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:23:38 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:23:38 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:23:38 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:23:38 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:23:38 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:23:38 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:23: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')]} 03:23:38 INFO - https://queue.taskcluster.net/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:23:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:23:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:23:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:23:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:23:50 INFO - Downloaded 24472846 bytes. 03:23:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:23:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:23:51 INFO - Return code: 0 03:23:51 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:51 INFO - https://queue.taskcluster.net/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:23:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:23:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:23:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:23:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:23:52 INFO - Downloaded 24472846 bytes. 03:23:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:23:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:23:54 INFO - Return code: 0 03:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:54 INFO - https://queue.taskcluster.net/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:23:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:23:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:23:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:23:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:23:55 INFO - Downloaded 10833369 bytes. 03:23:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:23:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:23:56 INFO - Return code: 0 03:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:56 INFO - https://queue.taskcluster.net/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:23:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:23:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:23:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:23:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:24:03 INFO - Downloaded 63543510 bytes. 03:24:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:24:03 INFO - mkdir: /builds/slave/test/properties 03:24:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:24:03 INFO - Writing to file /builds/slave/test/properties/build_url 03:24:03 INFO - Contents: 03:24:03 INFO - build_url:https://queue.taskcluster.net/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:24:03 INFO - Running post-action listener: _resource_record_post_action 03:24:03 INFO - Running post-action listener: set_extra_try_arguments 03:24:03 INFO - ##### 03:24:03 INFO - ##### Finished download-and-extract step (success) 03:24:03 INFO - ##### 03:24:03 INFO - ##### 03:24:03 INFO - ##### Running populate-webroot step. 03:24:03 INFO - ##### 03:24:03 INFO - Running pre-action listener: _resource_record_pre_action 03:24:03 INFO - Running main action method: populate_webroot 03:24:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:24:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:24:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:24:03 INFO - '--tppagecycles', 03:24:03 INFO - '7'], 03:24:03 INFO - 'tests': ['tsvgm']}}, 03:24:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:24:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:24:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:24:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:24:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:24:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:24:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:03 INFO - 'talos_options': ['--disable-e10s'], 03:24:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:24:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:24:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:03 INFO - 'talos_options': ['--disable-e10s'], 03:24:03 INFO - 'tests': ['damp', 'tps']}, 03:24:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:03 INFO - 'tests': ['damp', 'tps']}, 03:24:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:24:03 INFO - 'tests': ['dromaeo_dom']}, 03:24:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:24:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:24:03 INFO - 'tests': ['a11yr', 03:24:03 INFO - 'ts_paint', 03:24:03 INFO - 'tpaint', 03:24:03 INFO - 'sessionrestore', 03:24:03 INFO - 'sessionrestore_no_auto_restore', 03:24:03 INFO - 'tabpaint']}, 03:24:03 INFO - 'other-e10s': {'tests': ['a11yr', 03:24:03 INFO - 'ts_paint', 03:24:03 INFO - 'tpaint', 03:24:03 INFO - 'sessionrestore', 03:24:03 INFO - 'sessionrestore_no_auto_restore', 03:24:03 INFO - 'tabpaint']}, 03:24:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:24:03 INFO - 'ts_paint', 03:24:03 INFO - 'tpaint', 03:24:03 INFO - 'sessionrestore', 03:24:03 INFO - 'sessionrestore_no_auto_restore', 03:24:03 INFO - 'tabpaint']}, 03:24:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:24:03 INFO - 'ts_paint', 03:24:03 INFO - 'tpaint', 03:24:03 INFO - 'sessionrestore', 03:24:03 INFO - 'sessionrestore_no_auto_restore', 03:24:03 INFO - 'tabpaint']}, 03:24:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:24:03 INFO - 'tests': ['a11yr', 03:24:03 INFO - 'ts_paint', 03:24:03 INFO - 'tpaint', 03:24:03 INFO - 'sessionrestore', 03:24:03 INFO - 'sessionrestore_no_auto_restore', 03:24:03 INFO - 'tabpaint']}, 03:24:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:24:03 INFO - 'tests': ['a11yr', 03:24:03 INFO - 'ts_paint', 03:24:03 INFO - 'tpaint', 03:24:03 INFO - 'sessionrestore', 03:24:03 INFO - 'sessionrestore_no_auto_restore', 03:24:03 INFO - 'tabpaint']}, 03:24:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:24:03 INFO - 'tests': ['tsvgx', 03:24:03 INFO - 'tsvgr_opacity', 03:24:03 INFO - 'tart', 03:24:03 INFO - 'tscrollx', 03:24:03 INFO - 'cart']}, 03:24:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:24:03 INFO - 'tsvgr_opacity', 03:24:03 INFO - 'tart', 03:24:03 INFO - 'tscrollx', 03:24:03 INFO - 'cart']}, 03:24:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:03 INFO - 'talos_options': ['--disable-e10s'], 03:24:03 INFO - 'tests': ['tp5o']}, 03:24:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:03 INFO - 'tests': ['tp5o']}, 03:24:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:03 INFO - 'talos_options': ['--disable-e10s', 03:24:03 INFO - '--xperf_path', 03:24:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:24:03 INFO - 'tests': ['tp5n']}, 03:24:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:03 INFO - 'talos_options': ['--xperf_path', 03:24:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:24:03 INFO - 'tests': ['tp5n']}}, 03:24:03 INFO - 'talos.zip': {'path': '', 03:24:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:24:03 INFO - Running post-action listener: _resource_record_post_action 03:24:03 INFO - ##### 03:24:03 INFO - ##### Finished populate-webroot step (success) 03:24:03 INFO - ##### 03:24:03 INFO - ##### 03:24:03 INFO - ##### Running create-virtualenv step. 03:24:03 INFO - ##### 03:24:03 INFO - Running pre-action listener: _resource_record_pre_action 03:24:03 INFO - Running main action method: create_virtualenv 03:24:03 INFO - Creating virtualenv /builds/slave/test/build/venv 03:24:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:24:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:24:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:24:03 INFO - Using real prefix '/usr' 03:24:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:24:04 INFO - Installing distribute.............................................................................................................................................................................................done. 03:24:06 INFO - Installing pip.................done. 03:24:06 INFO - Return code: 0 03:24:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:06 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 0x7f905939bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ac1c0>, '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 0x17ad0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ad550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:24:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:24:06 INFO - Using env: {'DISPLAY': ':0', 03:24:06 INFO - 'HOME': '/home/cltbld', 03:24:06 INFO - 'LANG': 'en_US.UTF-8', 03:24:06 INFO - 'LANGUAGE': 'en_US:en', 03:24:06 INFO - 'LOGNAME': 'cltbld', 03:24:06 INFO - 'MAIL': '/var/mail/cltbld', 03:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:06 INFO - 'MOZ_NO_REMOTE': '1', 03:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:06 INFO - 'NO_EM_RESTART': '1', 03:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:06 INFO - 'PWD': '/builds/slave/test', 03:24:06 INFO - 'SHELL': '/bin/bash', 03:24:06 INFO - 'SHLVL': '1', 03:24:06 INFO - 'TERM': 'linux', 03:24:06 INFO - 'TMOUT': '86400', 03:24:06 INFO - 'USER': 'cltbld', 03:24:06 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 03:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:06 INFO - '_': '/tools/buildbot/bin/python'} 03:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:24:06 INFO - Cleaning up... 03:24:06 INFO - Return code: 0 03:24:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:06 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 0x7f905939bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ac1c0>, '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 0x17ad0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ad550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:24:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:24:06 INFO - Using env: {'DISPLAY': ':0', 03:24:06 INFO - 'HOME': '/home/cltbld', 03:24:06 INFO - 'LANG': 'en_US.UTF-8', 03:24:06 INFO - 'LANGUAGE': 'en_US:en', 03:24:06 INFO - 'LOGNAME': 'cltbld', 03:24:06 INFO - 'MAIL': '/var/mail/cltbld', 03:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:06 INFO - 'MOZ_NO_REMOTE': '1', 03:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:06 INFO - 'NO_EM_RESTART': '1', 03:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:06 INFO - 'PWD': '/builds/slave/test', 03:24:06 INFO - 'SHELL': '/bin/bash', 03:24:06 INFO - 'SHLVL': '1', 03:24:06 INFO - 'TERM': 'linux', 03:24:06 INFO - 'TMOUT': '86400', 03:24:06 INFO - 'USER': 'cltbld', 03:24:06 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 03:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:06 INFO - '_': '/tools/buildbot/bin/python'} 03:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:07 INFO - Downloading/unpacking psutil>=3.1.1 03:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:24:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:24:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:24:09 INFO - Installing collected packages: psutil 03:24:09 INFO - Running setup.py install for psutil 03:24:09 INFO - building 'psutil._psutil_linux' extension 03:24:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:24:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:24:10 INFO - building 'psutil._psutil_posix' extension 03:24:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:24:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:24:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:24:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:24:10 INFO - Successfully installed psutil 03:24:10 INFO - Cleaning up... 03:24:10 INFO - Return code: 0 03:24:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:10 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 0x7f905939bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ac1c0>, '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 0x17ad0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ad550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:24:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:24:10 INFO - Using env: {'DISPLAY': ':0', 03:24:10 INFO - 'HOME': '/home/cltbld', 03:24:10 INFO - 'LANG': 'en_US.UTF-8', 03:24:10 INFO - 'LANGUAGE': 'en_US:en', 03:24:10 INFO - 'LOGNAME': 'cltbld', 03:24:10 INFO - 'MAIL': '/var/mail/cltbld', 03:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:10 INFO - 'MOZ_NO_REMOTE': '1', 03:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:10 INFO - 'NO_EM_RESTART': '1', 03:24:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:10 INFO - 'PWD': '/builds/slave/test', 03:24:10 INFO - 'SHELL': '/bin/bash', 03:24:10 INFO - 'SHLVL': '1', 03:24:10 INFO - 'TERM': 'linux', 03:24:10 INFO - 'TMOUT': '86400', 03:24:10 INFO - 'USER': 'cltbld', 03:24:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 03:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:10 INFO - '_': '/tools/buildbot/bin/python'} 03:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:24:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:24:12 INFO - Installing collected packages: mozsystemmonitor 03:24:12 INFO - Running setup.py install for mozsystemmonitor 03:24:13 INFO - Successfully installed mozsystemmonitor 03:24:13 INFO - Cleaning up... 03:24:13 INFO - Return code: 0 03:24:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:24:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:13 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 0x7f905939bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ac1c0>, '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 0x17ad0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ad550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:24:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:24:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:24:13 INFO - Using env: {'DISPLAY': ':0', 03:24:13 INFO - 'HOME': '/home/cltbld', 03:24:13 INFO - 'LANG': 'en_US.UTF-8', 03:24:13 INFO - 'LANGUAGE': 'en_US:en', 03:24:13 INFO - 'LOGNAME': 'cltbld', 03:24:13 INFO - 'MAIL': '/var/mail/cltbld', 03:24:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:13 INFO - 'MOZ_NO_REMOTE': '1', 03:24:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:13 INFO - 'NO_EM_RESTART': '1', 03:24:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:13 INFO - 'PWD': '/builds/slave/test', 03:24:13 INFO - 'SHELL': '/bin/bash', 03:24:13 INFO - 'SHLVL': '1', 03:24:13 INFO - 'TERM': 'linux', 03:24:13 INFO - 'TMOUT': '86400', 03:24:13 INFO - 'USER': 'cltbld', 03:24:13 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 03:24:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:13 INFO - '_': '/tools/buildbot/bin/python'} 03:24:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:13 INFO - Downloading/unpacking jsonschema==2.5.1 03:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:24:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:15 INFO - Downloading functools32-3.2.3-2.tar.gz 03:24:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:24:15 INFO - warning: no files found matching '*.txt' 03:24:15 INFO - no previously-included directories found matching 'build' 03:24:15 INFO - no previously-included directories found matching 'dist' 03:24:15 INFO - no previously-included directories found matching '.git*' 03:24:15 INFO - Installing collected packages: jsonschema, functools32 03:24:15 INFO - Running setup.py install for functools32 03:24:15 INFO - warning: no files found matching '*.txt' 03:24:15 INFO - no previously-included directories found matching 'build' 03:24:15 INFO - no previously-included directories found matching 'dist' 03:24:15 INFO - no previously-included directories found matching '.git*' 03:24:15 INFO - Successfully installed jsonschema functools32 03:24:15 INFO - Cleaning up... 03:24:15 INFO - Return code: 0 03:24:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:15 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 0x7f905939bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ac1c0>, '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 0x17ad0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ad550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:24:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:24:15 INFO - Using env: {'DISPLAY': ':0', 03:24:15 INFO - 'HOME': '/home/cltbld', 03:24:15 INFO - 'LANG': 'en_US.UTF-8', 03:24:15 INFO - 'LANGUAGE': 'en_US:en', 03:24:15 INFO - 'LOGNAME': 'cltbld', 03:24:15 INFO - 'MAIL': '/var/mail/cltbld', 03:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:15 INFO - 'MOZ_NO_REMOTE': '1', 03:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:15 INFO - 'NO_EM_RESTART': '1', 03:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:15 INFO - 'PWD': '/builds/slave/test', 03:24:15 INFO - 'SHELL': '/bin/bash', 03:24:15 INFO - 'SHLVL': '1', 03:24:15 INFO - 'TERM': 'linux', 03:24:15 INFO - 'TMOUT': '86400', 03:24:15 INFO - 'USER': 'cltbld', 03:24:15 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 03:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:15 INFO - '_': '/tools/buildbot/bin/python'} 03:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:15 INFO - Downloading/unpacking blobuploader==1.2.4 03:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:17 INFO - Downloading blobuploader-1.2.4.tar.gz 03:24:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:24:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:24:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:18 INFO - Downloading docopt-0.6.1.tar.gz 03:24:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:24:18 INFO - Installing collected packages: blobuploader, requests, docopt 03:24:18 INFO - Running setup.py install for blobuploader 03:24:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:24:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:24:18 INFO - Running setup.py install for requests 03:24:18 INFO - Running setup.py install for docopt 03:24:19 INFO - Successfully installed blobuploader requests docopt 03:24:19 INFO - Cleaning up... 03:24:19 INFO - Return code: 0 03:24:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24: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')]} 03:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24: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')]} 03:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:19 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 0x7f905939bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ac1c0>, '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 0x17ad0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ad550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:24:19 INFO - Using env: {'DISPLAY': ':0', 03:24:19 INFO - 'HOME': '/home/cltbld', 03:24:19 INFO - 'LANG': 'en_US.UTF-8', 03:24:19 INFO - 'LANGUAGE': 'en_US:en', 03:24:19 INFO - 'LOGNAME': 'cltbld', 03:24:19 INFO - 'MAIL': '/var/mail/cltbld', 03:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:19 INFO - 'MOZ_NO_REMOTE': '1', 03:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:19 INFO - 'NO_EM_RESTART': '1', 03:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:19 INFO - 'PWD': '/builds/slave/test', 03:24:19 INFO - 'SHELL': '/bin/bash', 03:24:19 INFO - 'SHLVL': '1', 03:24:19 INFO - 'TERM': 'linux', 03:24:19 INFO - 'TMOUT': '86400', 03:24:19 INFO - 'USER': 'cltbld', 03:24:19 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 03:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:19 INFO - '_': '/tools/buildbot/bin/python'} 03:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:24:19 INFO - Running setup.py (path:/tmp/pip-bEuOVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:24:19 INFO - Running setup.py (path:/tmp/pip-wfqCry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:24:19 INFO - Running setup.py (path:/tmp/pip-LYIFjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:24:19 INFO - Running setup.py (path:/tmp/pip-yq6CIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:24:19 INFO - Running setup.py (path:/tmp/pip-40cxcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:24:19 INFO - Running setup.py (path:/tmp/pip-QCMW2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:24:19 INFO - Running setup.py (path:/tmp/pip-Do3OWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:24:19 INFO - Running setup.py (path:/tmp/pip-rw3vsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:24:19 INFO - Running setup.py (path:/tmp/pip-97Laya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:24:19 INFO - Running setup.py (path:/tmp/pip-UDCeeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:24:20 INFO - Running setup.py (path:/tmp/pip-5GVlor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:24:20 INFO - Running setup.py (path:/tmp/pip-HUUcTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:24:20 INFO - Running setup.py (path:/tmp/pip-ANuuI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:24:20 INFO - Running setup.py (path:/tmp/pip-CSJyD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:20 INFO - Running setup.py (path:/tmp/pip-5XYCQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:24:20 INFO - Running setup.py (path:/tmp/pip-DyCltW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:24:20 INFO - Running setup.py (path:/tmp/pip-nzPa9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:24:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:24:20 INFO - Running setup.py install for manifestparser 03:24:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:24:20 INFO - Running setup.py install for mozcrash 03:24:20 INFO - Running setup.py install for mozdebug 03:24:20 INFO - Running setup.py install for mozdevice 03:24:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:24:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:24:20 INFO - Running setup.py install for mozfile 03:24:21 INFO - Running setup.py install for mozhttpd 03:24:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:24:21 INFO - Running setup.py install for mozinfo 03:24:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:24:21 INFO - Running setup.py install for mozInstall 03:24:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:24:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:24:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:24:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:24:21 INFO - Running setup.py install for mozleak 03:24:21 INFO - Running setup.py install for mozlog 03:24:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:24:21 INFO - Running setup.py install for moznetwork 03:24:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:24:21 INFO - Running setup.py install for mozprocess 03:24:21 INFO - Running setup.py install for mozprofile 03:24:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:24:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:24:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:24:21 INFO - Running setup.py install for mozrunner 03:24:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:24:22 INFO - Running setup.py install for mozscreenshot 03:24:22 INFO - Running setup.py install for moztest 03:24:22 INFO - Running setup.py install for mozversion 03:24:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:24:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:24:22 INFO - Cleaning up... 03:24:22 INFO - Return code: 0 03:24:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:22 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 0x7f905939bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ac1c0>, '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 0x17ad0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ad550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:24:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:24:22 INFO - Using env: {'DISPLAY': ':0', 03:24:22 INFO - 'HOME': '/home/cltbld', 03:24:22 INFO - 'LANG': 'en_US.UTF-8', 03:24:22 INFO - 'LANGUAGE': 'en_US:en', 03:24:22 INFO - 'LOGNAME': 'cltbld', 03:24:22 INFO - 'MAIL': '/var/mail/cltbld', 03:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:22 INFO - 'MOZ_NO_REMOTE': '1', 03:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:22 INFO - 'NO_EM_RESTART': '1', 03:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:22 INFO - 'PWD': '/builds/slave/test', 03:24:22 INFO - 'SHELL': '/bin/bash', 03:24:22 INFO - 'SHLVL': '1', 03:24:22 INFO - 'TERM': 'linux', 03:24:22 INFO - 'TMOUT': '86400', 03:24:22 INFO - 'USER': 'cltbld', 03:24:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 03:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:22 INFO - '_': '/tools/buildbot/bin/python'} 03:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:24:22 INFO - Running setup.py (path:/tmp/pip-lOBwAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:24:22 INFO - Running setup.py (path:/tmp/pip-7IqzFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:24:22 INFO - Running setup.py (path:/tmp/pip-UQVh6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:24:22 INFO - Running setup.py (path:/tmp/pip-r0GeEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:24:22 INFO - Running setup.py (path:/tmp/pip-qUL8BF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:24:22 INFO - Running setup.py (path:/tmp/pip-mCpV_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:24:22 INFO - Running setup.py (path:/tmp/pip-MsKQni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:24:23 INFO - Running setup.py (path:/tmp/pip-kZPSof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:24:23 INFO - Running setup.py (path:/tmp/pip-2Cms8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:24:23 INFO - Running setup.py (path:/tmp/pip-NwR0EY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:24:23 INFO - Running setup.py (path:/tmp/pip-pxUp2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:24:23 INFO - Running setup.py (path:/tmp/pip-jUzB87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:24:23 INFO - Running setup.py (path:/tmp/pip-QdJ7zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:24:23 INFO - Running setup.py (path:/tmp/pip-VD1xcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:23 INFO - Running setup.py (path:/tmp/pip-xDDGuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:24:23 INFO - Running setup.py (path:/tmp/pip-nYs3Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:24:23 INFO - Running setup.py (path:/tmp/pip-ODX8WR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:24:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:25 INFO - Downloading blessings-1.6.tar.gz 03:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:24:25 INFO - Installing collected packages: blessings 03:24:25 INFO - Running setup.py install for blessings 03:24:25 INFO - Successfully installed blessings 03:24:25 INFO - Cleaning up... 03:24:25 INFO - Return code: 0 03:24:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:24:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:24:26 INFO - Reading from file tmpfile_stdout 03:24:26 INFO - Current package versions: 03:24:26 INFO - argparse == 1.2.1 03:24:26 INFO - blessings == 1.6 03:24:26 INFO - blobuploader == 1.2.4 03:24:26 INFO - docopt == 0.6.1 03:24:26 INFO - functools32 == 3.2.3-2 03:24:26 INFO - jsonschema == 2.5.1 03:24:26 INFO - manifestparser == 1.1 03:24:26 INFO - mozInstall == 1.12 03:24:26 INFO - mozcrash == 0.17 03:24:26 INFO - mozdebug == 0.1 03:24:26 INFO - mozdevice == 0.48 03:24:26 INFO - mozfile == 1.2 03:24:26 INFO - mozhttpd == 0.7 03:24:26 INFO - mozinfo == 0.9 03:24:26 INFO - mozleak == 0.1 03:24:26 INFO - mozlog == 3.2 03:24:26 INFO - moznetwork == 0.27 03:24:26 INFO - mozprocess == 0.22 03:24:26 INFO - mozprofile == 0.28 03:24:26 INFO - mozrunner == 6.11 03:24:26 INFO - mozscreenshot == 0.1 03:24:26 INFO - mozsystemmonitor == 0.3 03:24:26 INFO - moztest == 0.7 03:24:26 INFO - mozversion == 1.4 03:24:26 INFO - psutil == 3.1.1 03:24:26 INFO - requests == 1.2.3 03:24:26 INFO - wsgiref == 0.1.2 03:24:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:26 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 0x7f905939bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ac1c0>, '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 0x17ad0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ad550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:24:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:24:26 INFO - Using env: {'DISPLAY': ':0', 03:24:26 INFO - 'HOME': '/home/cltbld', 03:24:26 INFO - 'LANG': 'en_US.UTF-8', 03:24:26 INFO - 'LANGUAGE': 'en_US:en', 03:24:26 INFO - 'LOGNAME': 'cltbld', 03:24:26 INFO - 'MAIL': '/var/mail/cltbld', 03:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:26 INFO - 'MOZ_NO_REMOTE': '1', 03:24:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:26 INFO - 'NO_EM_RESTART': '1', 03:24:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:26 INFO - 'PWD': '/builds/slave/test', 03:24:26 INFO - 'SHELL': '/bin/bash', 03:24:26 INFO - 'SHLVL': '1', 03:24:26 INFO - 'TERM': 'linux', 03:24:26 INFO - 'TMOUT': '86400', 03:24:26 INFO - 'USER': 'cltbld', 03:24:26 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 03:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:26 INFO - '_': '/tools/buildbot/bin/python'} 03:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:24:26 INFO - Cleaning up... 03:24:26 INFO - Return code: 0 03:24:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:26 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 0x7f905939bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ac1c0>, '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 0x17ad0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ad550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:24:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:24:26 INFO - Using env: {'DISPLAY': ':0', 03:24:26 INFO - 'HOME': '/home/cltbld', 03:24:26 INFO - 'LANG': 'en_US.UTF-8', 03:24:26 INFO - 'LANGUAGE': 'en_US:en', 03:24:26 INFO - 'LOGNAME': 'cltbld', 03:24:26 INFO - 'MAIL': '/var/mail/cltbld', 03:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:26 INFO - 'MOZ_NO_REMOTE': '1', 03:24:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:26 INFO - 'NO_EM_RESTART': '1', 03:24:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:26 INFO - 'PWD': '/builds/slave/test', 03:24:26 INFO - 'SHELL': '/bin/bash', 03:24:26 INFO - 'SHLVL': '1', 03:24:26 INFO - 'TERM': 'linux', 03:24:26 INFO - 'TMOUT': '86400', 03:24:26 INFO - 'USER': 'cltbld', 03:24:26 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 03:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:26 INFO - '_': '/tools/buildbot/bin/python'} 03:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:24:26 INFO - Cleaning up... 03:24:26 INFO - Return code: 0 03:24:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:26 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 0x7f905939bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ac1c0>, '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 0x17ad0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ad550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:24:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:24:26 INFO - Using env: {'DISPLAY': ':0', 03:24:26 INFO - 'HOME': '/home/cltbld', 03:24:26 INFO - 'LANG': 'en_US.UTF-8', 03:24:26 INFO - 'LANGUAGE': 'en_US:en', 03:24:26 INFO - 'LOGNAME': 'cltbld', 03:24:26 INFO - 'MAIL': '/var/mail/cltbld', 03:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:26 INFO - 'MOZ_NO_REMOTE': '1', 03:24:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:26 INFO - 'NO_EM_RESTART': '1', 03:24:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:26 INFO - 'PWD': '/builds/slave/test', 03:24:26 INFO - 'SHELL': '/bin/bash', 03:24:26 INFO - 'SHLVL': '1', 03:24:26 INFO - 'TERM': 'linux', 03:24:26 INFO - 'TMOUT': '86400', 03:24:26 INFO - 'USER': 'cltbld', 03:24:26 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 03:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:26 INFO - '_': '/tools/buildbot/bin/python'} 03:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:26 INFO - Downloading/unpacking flake8 03:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:24:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:24:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:24:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:24:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:24:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:24:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:24:30 INFO - no previously-included directories found matching 'docs/_build' 03:24:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:24:30 INFO - Running setup.py install for pep8 03:24:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:24:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:24:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:24:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:24:30 INFO - no previously-included directories found matching 'docs/_build' 03:24:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:24:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:24:30 INFO - Cleaning up... 03:24:30 INFO - Return code: 0 03:24:30 INFO - Running post-action listener: _resource_record_post_action 03:24:30 INFO - Running post-action listener: _start_resource_monitoring 03:24:30 INFO - Starting resource monitoring. 03:24:30 INFO - ##### 03:24:30 INFO - ##### Finished create-virtualenv step (success) 03:24:30 INFO - ##### 03:24:30 INFO - ##### 03:24:30 INFO - ##### Running install step. 03:24:30 INFO - ##### 03:24:30 INFO - Running pre-action listener: _resource_record_pre_action 03:24:30 INFO - Running main action method: install 03:24:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:24:30 INFO - Reading from file tmpfile_stdout 03:24:30 INFO - Detecting whether we're running mozinstall >=1.0... 03:24:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:24:30 INFO - Reading from file tmpfile_stdout 03:24:30 INFO - Output received: 03:24:30 INFO - Usage: mozinstall [options] installer 03:24:30 INFO - Options: 03:24:30 INFO - -h, --help show this help message and exit 03:24:30 INFO - -d DEST, --destination=DEST 03:24:30 INFO - Directory to install application into. [default: 03:24:30 INFO - "/builds/slave/test"] 03:24:30 INFO - --app=APP Application being installed. [default: firefox] 03:24:30 INFO - mkdir: /builds/slave/test/build/application 03:24:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:24:46 INFO - Reading from file tmpfile_stdout 03:24:46 INFO - Output received: 03:24:46 INFO - /builds/slave/test/build/application/firefox/firefox 03:24:46 INFO - Running post-action listener: _resource_record_post_action 03:24:46 INFO - ##### 03:24:46 INFO - ##### Finished install step (success) 03:24:46 INFO - ##### 03:24:46 INFO - ##### 03:24:46 INFO - ##### Running run-tests step. 03:24:46 INFO - ##### 03:24:46 INFO - Running pre-action listener: _resource_record_pre_action 03:24:46 INFO - Running main action method: run_tests 03:24:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:24:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:24:46 INFO - Python 2.7.3 03:24:46 INFO - Return code: 0 03:24:46 INFO - grabbing minidump binary from tooltool 03:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:46 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 0x17ac1c0>, '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 0x17ad0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ad550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:24:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:24:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:24:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:24:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:24:46 INFO - Return code: 0 03:24:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:24:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:24:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:24:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:24:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:24:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:24:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:24:48 INFO - Return code: 0 03:24:48 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/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:24:48 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/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:24:48 INFO - Using env: {'DISPLAY': ':0', 03:24:48 INFO - 'HOME': '/home/cltbld', 03:24:48 INFO - 'LANG': 'en_US.UTF-8', 03:24:48 INFO - 'LANGUAGE': 'en_US:en', 03:24:48 INFO - 'LOGNAME': 'cltbld', 03:24:48 INFO - 'MAIL': '/var/mail/cltbld', 03:24:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:24:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:48 INFO - 'MOZ_NO_REMOTE': '1', 03:24:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:48 INFO - 'NO_EM_RESTART': '1', 03:24:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:48 INFO - 'PWD': '/builds/slave/test', 03:24:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:24:48 INFO - 'SHELL': '/bin/bash', 03:24:48 INFO - 'SHLVL': '1', 03:24:48 INFO - 'TERM': 'linux', 03:24:48 INFO - 'TMOUT': '86400', 03:24:48 INFO - 'USER': 'cltbld', 03:24:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750', 03:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:48 INFO - '_': '/tools/buildbot/bin/python'} 03:24:48 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/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:24:48 INFO - mozversion application_buildid: 20160611004009 03:24:48 INFO - mozversion application_changeset: 4253296f212b3cca52992ec5f6cd824b13153abd 03:24:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:24:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:24:48 INFO - mozversion application_name: Firefox 03:24:48 INFO - mozversion application_remotingname: firefox-dev 03:24:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:24:48 INFO - mozversion application_vendor: Mozilla 03:24:48 INFO - mozversion application_version: 49.0a2 03:24:48 INFO - mozversion platform_buildid: 20160611004009 03:24:48 INFO - mozversion platform_changeset: 4253296f212b3cca52992ec5f6cd824b13153abd 03:24:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:24:48 INFO - mozversion platform_version: 49.0a2 03:24:48 INFO - using testdate: 1465640688 03:24:48 INFO - actual date: 1465640688 03:24:48 INFO - starting webserver on 'localhost:51141' 03:24:48 INFO - SUITE-START | Running 2 tests 03:24:48 INFO - TEST-START | dromaeo_css 03:24:48 INFO - operating with platform_type : linux_ 03:24:48 INFO - Initialising browser for dromaeo_css test... 03:24:48 INFO - TEST-INFO | started process 3349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmcP4Y1/profile http://localhost:51141/getInfo.html) 03:24:53 INFO - PROCESS | 3349 | __metrics Screen width/height:1600/1200 03:24:53 INFO - PROCESS | 3349 | colorDepth:24 03:24:53 INFO - PROCESS | 3349 | Browser inner width/height: 1024/697 03:24:53 INFO - PROCESS | 3349 | __metrics 03:24:54 ERROR - PROCESS | 3349 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:24:54 INFO - PROCESS | 3349 | console.error: PushService: 03:24:54 INFO - PROCESS | 3349 | stateChangeProcessEnqueue: Error transitioning state 03:24:54 INFO - PROCESS | 3349 | UnknownError 03:24:54 INFO - TEST-INFO | 3349: exit 0 03:24:54 INFO - Browser initialized. 03:24:54 INFO - Running cycle 1/1 for dromaeo_css test... 03:24:54 INFO - TEST-INFO | started process 3440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmcP4Y1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:25:06 INFO - PROCESS | 3440 | RSS: Main: 145723392 03:25:06 INFO - PROCESS | 3440 | 03:25:57 INFO - PROCESS | 3440 | 1465640757862 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:28:06 INFO - PROCESS | 3440 | Cycle 1(1): loaded http://localhost:51141/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51141/tests/dromaeo/cssquery-ext.html) 03:28:07 INFO - PROCESS | 3440 | RSS: Main: 285388800 03:28:07 INFO - PROCESS | 3440 | 03:31:10 INFO - PROCESS | 3440 | Cycle 1(1): loaded http://localhost:51141/tests/dromaeo/cssquery-ext.html (next: http://localhost:51141/tests/dromaeo/cssquery-jquery.html) 03:31:10 INFO - PROCESS | 3440 | RSS: Main: 228737024 03:31:10 INFO - PROCESS | 3440 | 03:34:12 INFO - PROCESS | 3440 | Cycle 1(1): loaded http://localhost:51141/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51141/tests/dromaeo/cssquery-mootools.html) 03:34:13 INFO - PROCESS | 3440 | RSS: Main: 221929472 03:34:13 INFO - PROCESS | 3440 | 03:37:15 INFO - PROCESS | 3440 | Cycle 1(1): loaded http://localhost:51141/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51141/tests/dromaeo/cssquery-prototype.html) 03:37:15 INFO - PROCESS | 3440 | RSS: Main: 223195136 03:37:15 INFO - PROCESS | 3440 | 03:40:18 INFO - PROCESS | 3440 | Cycle 1(1): loaded http://localhost:51141/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51141/tests/dromaeo/cssquery-yui.html) 03:40:19 INFO - PROCESS | 3440 | RSS: Main: 218439680 03:40:19 INFO - PROCESS | 3440 | 03:43:21 INFO - PROCESS | 3440 | Cycle 1(1): loaded http://localhost:51141/tests/dromaeo/cssquery-yui.html (next: http://localhost:51141/tests/dromaeo/cssquery-dojo.html) 03:43:21 INFO - PROCESS | 3440 | RSS: Main: 245858304 03:43:21 INFO - PROCESS | 3440 | 03:43:21 INFO - PROCESS | 3440 | __start_tp_report 03:43:21 INFO - PROCESS | 3440 | _x_x_mozilla_page_load 03:43:21 INFO - PROCESS | 3440 | _x_x_mozilla_page_load_details 03:43:21 INFO - PROCESS | 3440 | |i|pagename|runs| 03:43:21 INFO - PROCESS | 3440 | |0;dojo.html;3372.460406334986;3391.6777906098914;3393.9830300848494;3416.572928383952;3431.965680343196;5560.52735517481;5654.491095801377;5656.858578535539;5671.489565939065;5693.715314234292;5558.138488534284;5617.466340697627;5617.494425501704;5620.606557540974;5653.1520271959225;4953.331300274453;5025.0954828130925;5087.9745601272125;5088.160453525174;5127.179651255799;5035.748212589374;5047.369078865142;5067;5099.4900509949075;5169.017886601552;5079.644424890241;5094.184930411135;5125.410577783547;5161.0968080585935;5183.818566350178;5153.793848246066;5153.845384638448;5158.40678321994;5177.197534382177;5196.1166601677805;4674.813007479696;4923.18767403378;5039.72281524516;5042.445331013586;5069.315642388267;5533.806316778893;5543;5555.250041244421;5564.054110801174;5610.18652295419;6067.605605635619;6071.362506936796;6084.002470660909;6119.44924956756;6133.44798968095;5930.851728706773;6095.207623009025;6115.199568338832;6125.663088530129;6130.2452696569835;5748.827535173951;5754.050581654022;5758.596898217126;5762;5765.279340082489;6254.093156492283;6259.812205633838;6260.593061450991;6261.279952805395;6261.843453913689;5781.653100813881;5845.064789633723;5879.470847623735;5897.705114744245;6044.667543285073;6021.548383871227;6028.246469191351;6036.667983260875;6056.485198758067;6067.514598832083;5951.702414879239;5986.610870293417;6003.6397816131175;6013.308469525973;6015.759369625253;5848.356680765112;5925.200097986716;5962.284525856925;5962.910556341659;5999.610025348338;4625.398698169284;4633.582977532038;4634;4653.302004699254;4653.371794807726;4135.234981528427;4144.3990621359735;4147.419361289422;4148.23257697321;4170.998960249518;5595.720213989284;5642.210090587321;5660.179274005246;5771.9711401443565;5777.826665200051;6052.273727152769;6053.939460605337;6059;6066.908996365058;6085.513158947274;5703.515201207943;5725.227094342294;5733.569982251264;5742.712864356766;5750;5066.695998240118;5146.356705411824;5212.296339994053;5217.9478205217465;5221.55616772571;6315.084312774622;6318.462930650946;6319.05214217871;6330.651814150174;6337.96831015842;6039.969800150971;6098.847528811638;6113.57204995646;6119.694015299307;6123.540734445023;6092.725827337692;6208.348123447154;6244.2819075806865;6266.68666566679;6367.522435817425;6040;6044.304904935989;6048.818535443944;6050.2437195350585;6082.391760823883;5890.4993075589055;6086.513078953762;6147.0779383092895;6148.569600127948;6153.4154255345675;5830.883382332415;5880.647161170344;5882.411758824083;5923.466887980103;5927.7036148191555;5925.022371308686;5926.585139040399;5929.495992840484;5933.2880054393745;5937.198478205387;5650.26546548946;5702.885942281048;5829.358770535153;5836.153757705194;5842.824715258549;5760.0783874579865;5829.59192856496;5830.387809279964;5831.970840145772;5904.232449781501;5753.453421924911;5785.884282314246;5786.537077033911;5787.9421205789085;5801.158831969426 03:43:21 INFO - PROCESS | 3440 | |1;ext.html;585.5491271720775;635.4154178156095;648.4909346163262;665.0921492163199;674.5750177388245;32884;44539.10921781566;45206.321905171404;45375;45409.0918181637;46801.76599117008;47079;47143.29285060727;47181;47271.29093063598;8455.281301089415;9063.320250981169;9262.44425334482;9264.11990860867;10917.126629869632;10591.523381447814;11139.721506962309;11143.72140696485;11148;11151.219414640978;11150.330980141176;11245;11259.662210133669;11274.267172633794;11276.210665253435;8473.872891906596;11011.28426652273;11078.169137314693;11297.265677731004;11309.264897781617;11026.614068507644;11144.66566003013;11146;11158.1631377647;11175.664730058112;42842.35736463955;43291.78354108209;43296.56703432957;43332;43363.56636433627;3969.7816620085882;3969.8809035728973;3985.3822657488136;4093.3450647896193;4343.847965321199;33413.83293083544;35702.821485892404;36680.633193668255;36785.81607091974;37065.62934370676;4738.810447582093;4757.429108506966;4813.181759100961;4863.927041094386;4922.384701912261;388086;393347;395925.99999999715;398350;400816;67826;67864.3213567858;68194.65902670554;68265;68294.65852670804;39429.40855887164;40108.59891401107;40140.79929600392;41914;42103.57896421058;19455.610887782164;19520.70718939217;19618.70571941422;19618.901905490668;19625.509362266057;13656.248906310248;14667.92666036663;14912.179830109448;14930.776038359434;15286.312115954808;21166.259180928595;21459.46351341229;21586.35240942774;21586.78413215879;21672.458188545097;7431.665575049135;7602.42981776369;7661.620908236571;7753.922460775433;7783.455158138876;1072.1797824664138;1109.8834622364698;1119.065580240492;1143.9885601143883;1162.959296424621;34631.65368346284;34652.48021279683;34708.30583388318;34736;34840.30319393598;1235.2773627428055;1275.1647670775471;1305.895528357729;1330.6274243211917;1394.7489451898755;17972.347950829655;19088.33190838314;19363.32228372;19371;20069.598608027758;581927;583310;584265;585397;586349;64645.353546464874;64858.675706621165;64901.35098649048;65249;65295.673521633034;1376.483818568037;1487.6429656882488;1488.9106653600818;1532.0348180646122;1541.0984574024096;33636;34014.65985340214;34281;34497.827510862284;34977.30045399129;53555.196672050726;54084.18873716976;54160.45839541554;54247.72876135594;54361.456385437225;439858;452619;452958;458422;459654;27154.592681110193;29098;29345.55981660234;29452.705472944996;31411.84294078515;50348.748256258485;51050.23424648559;51095;52146.739266303426;52574.21138682999;42052.57947420487;42549.36175957425;42599.148017040105;42727;43289.783551082044;40131.1973760529;40208.396874047496;40799.38800918048;41536.376954345105;42454;42353.78823105988;43307.56692433036;43401.56598433975;43867.341989869536;43950.78024609856;35267.11832204215;35866.46200306945;37268.813655931546;37345.06637334089;37728;28927.42145157127;29093.563596545646;29099.85450072736;29284;29587.408251835273 03:43:21 INFO - PROCESS | 3440 | |2;jquery.html;421.38688208656396;435.31872619350713;441.16399423093236;441.401900424924;441.54300299190345;18750.062496875154;20536.281230156947;20701.482462938417;21265;21590.676139857915;19514.707279390786;19610.60778784427;19705.211791528356;20143.697844532344;20192.19231230749;5859.091840764678;5973.342932277446;5987.401259874021;6014.308354539218;6034.396560343975;5759.539236861041;5796.536277097843;5911.704414779266;5935.732892019848;5941.494972927307;5841.824745257649;5864.706764661772;5876.294844618652;5886.823395298148;5894.852628684274;5728.770849166029;5876.44173803488;5937.910931336033;5940.881182376372;6047.0627052806885;5273.841784746463;5399.433059528771;5408.972955135238;5411.242426060355;5411.810586629488;23678.64482032771;23704.762952370427;23795.643065354034;23888.761112388827;24073.15743948971;2574.5494538455696;2625.6061590761346;2663.3741070848337;2783.9304017399522;3011.5031019881694;14231.217283049427;14839.851601483955;15023.09861408319;15293.61765955849;15457.5362739118;2040.8061234182728;2140.4220860367614;2140.7538133114736;2191.222116148776;2199.516106456577;81147.18852811455;83127;85093;85740.57129714312;86425;11203;11444.828327575093;11626.70933226676;11759.294442333487;11871.287722736492;16348.591285217726;16449.519543241167;16513.91743041277;16530.338786448407;16537.83462165387;8785.868211976825;9086.318526110568;9171.541422928827;9190.632374704937;9201.723948281428;8867.778305542284;8903.554822258991;8947.507887066275;9070.410423322595;9076.636934522545;6965.756198533027;7066.535107074017;7158.2841715829045;7170.924361345736;7178.533395329287;1788.6289445048988;2000.4998750312423;2028.6408106568636;2041.2447394463845;2101.8633788803677;893.4460634406579;1029.2897900448816;1058.074185088048;1065.7868426314612;1090.1605763562013;18354.174062166967;18872.81127188738;19298.456123510365;19474.123664435134;19878.304259350854;1005.607812952949;1033.7467320506523;1045.8065257927308;1047.371577053777;1051.138066785244;10440;11127.443627818577;11199.160062995308;11213.55145794159;11224.326540407601;487142.3857284287;498402;501901;503534;519941;87184;87832;87877.56061219652;87928.12071879327;88884.5555772217;1103.779244151173;1115.893990070942;1127.1490025031048;1133.54091592905;1140.0594509529506;17717.557061073578;17800.732989005435;18015.81984180194;18117.184726687596;18419.539511511783;29066.41867162687;29793.851030744707;30087.69912300849;32584.83707581447;42326.15347692967;54480.45519544754;54887.72556137353;55138;55902.44097558972;60355.09467358081;7480.551166930001;7952.960235198787;9185;9255.305852061258;9430.811383772423;10514.894851051391;13103.410346534238;13130.474781008652;13392.531261405804;13539.86460135386;11809.82285265739;12017.939910300393;12026.49668791401;12248.938755306166;12294.938525307316;10637.14902807758;10960.506777195205;11274.549018039515;11375.20373573842;11491;6468.838279042873;10460.63387781424;11193.768685444757;12244.387780610756;12297.139200255897;7929.326007289445;7930.206979302024;7974.082980457089;7997.560134192675;7998.800029999296;8568.52873091986;11591.76816463683;12048.397580120783;12076.275423474268;12119.394030298627 03:43:21 INFO - PROCESS | 3440 | |3;mootools.html;1383.4742797736858;1570.8900376973609;1581.0434687014356;1799.865010124241;1929.0644037641741;8672.219500244977;8953;8976.05751396103;9226.261899048077;9233.39982901111;8783.297336213103;8957.596908139132;8962.283017358612;8962.41744286621;8973.102689731024;2193.243331050785;2440.6583078369044;2461.0770960889668;2499.0503608628696;2500.112460076674;2255.9210427635035;2258.616035273999;2259.548090381922;2262.46831994482;2262.9434264143447;2450.5834008218644;2493.227099599121;2498.0507407185337;2498.8625625590585;2503.2114883811632;2090.8431867609916;2306.169778879602;2353.505763789606;2358.445765245166;2369.3010561884284;2361.197192954404;2381.8570885746735;2389.7012873390827;2390.53384590005;2419.9395015124587;9118.58966346516;9139;9189;9192.862107068398;9197;5607.691576963265;5746.913796293059;5752.252207213078;5766.077427611562;5772.8845423091725;3472.5138480612736;3534.151803567151;3586.605473397924;3667;3671.284099600579;1212.563477148226;1224.9632511024683;1226.4542278685988;2316.455632926261;2372.905083796646;13618.727625447436;13744.106633068819;13771.586852394545;13771.862281377258;13772.586822395244;4792.7363994980615;4905.607551395879;4941.555260026615;4953.702777833341;4997.550220480101;10423.270371073952;10541.472926353652;10545.789084218273;10569.365838049587;10574.841377379345;5079.339685840817;5711.942880571224;5755.510781583528;5755.913661295084;5760.683162426023;5236.9738151309;5312.495312945264;5336.573074154058;5380.1929710542945;5391.16436952273;4160.1471698301775;4191.224623444673;4211.642010429086;4230.471191101113;4283.528811830696;1238.238483332762;1259.8456639147162;1260.8928241099609;1275.67470295076;1277.5911708253454;920.8572671235969;969.5879251318162;991.7718924647371;1082.3992684060422;1083.712816103733;6669.599824010478;6701.765438209737;6705.396514313735;6749.6962636681465;6794.45644348451;1025.4923812712755;1047.7328281288223;1051.2115913065202;1057.8571892794528;1076.8600081989448;4535.274356103007;4685.765711714401;4686.81252749893;4704.717716936994;4723.291506274018;11767.293962362286;11993.940030299967;12054.337011464278;12092.818607720892;12141.575044873387;11315.377654228932;11898.881011189951;12001.339926304137;12017.098717596215;12018.15872888907;8665.480071195623;9047.81904361909;9048.638054477879;9093;9103.863442048374;6614.900776488453;6803.217629972616;6829;6851.486138539729;6877.3810357068105;10693;10941.507632156412;10964.28732132409;11021.228514003942;11148.331100134017;10948.288361256493;11129.387883666475;11163.274387164809;11284.153688473561;11316.717082073013;7607.23927607257;8297.377696672653;8501.19238672325;8543.231109200202;8697.043325234092;9359.157675808938;9359.485228312507;9397.624095036123;9450.858237126586;9452.810943781224;8378.078411374621;8505.617247223767;8571.785705357166;8650.048494665456;8681.348898832486;7639.159692433939;7891.487053341514;8232.917670823455;8273.669053237803;8569.228769410784;7616.428767842544;7732.652030658522;7739.574323412041;7747.18654541265;7750.186230445722;5529.474699903502;5535.446455354432;5573.16402539606;5604.187392828098;5633.464820842013;5560.360558535658;5578.748956296895;5594.636348637326;5636.971815140898;5637.859053523531 03:43:21 INFO - PROCESS | 3440 | |4;prototype.html;353.8991387454575;357.460235045082;358.48915295703614;361.99457008144884;362.25556481430647;5423.810166644168;5519.75805443776;5520.144377621465;5534.667919924802;5568.303962004749;5413.53984911283;5435.347758269013;5440.591955603326;5446.428125046872;5473.863153421166;3853.9229215415676;4039.4142849286836;4257.7445353278745;4283.485981682203;4308.246056940038;4232.174725928445;4267.935980960273;4282.657387409015;4285.442892423996;4309.396684464177;4077.3272410052455;4248.490181178247;4248.766317852517;4251.80866860992;4296.419983302246;4176.770277634729;4227.640650544708;4258.510271318807;4263.59495847894;4266.743995360288;3796.924061518782;3814.9809250953845;3820.9683385485764;3829.7893615851117;3832.693384529231;5222.582193424517;5227.3465816772905;5251.789928402859;5257.211418287249;5280;4894.657373983822;4898.706077635354;4929.285253638238;4944.975275123601;4969.962315450684;5485.35439368188;5611.242482264883;5666.546676265889;5758.884822303572;5769.855753606152;4068.471098757172;4152.252594532983;4158.064435502018;4186.476690413699;4193.6645068394455;5725.227094342252;5871.588988770745;5878.5297176225795;5880.617759845596;5894.204282421861;4107.383892416162;4237.512686041083;4258.510271318776;4265.1469706058915;4280.507741609693;4294.935575966363;4311.245532031882;4322.978385108055;4338.392625032498;4338.436003319548;4876.8780780480065;4889.877753056131;4905.190643543775;4908.680935739166;4911.361523002059;5483.725813709299;5695.202671625976;5712.971435142881;5725.570582206351;5726.570507211975;1484.398818478518;1497.7903093566908;1503.669192777587;1505.8569435903792;1508.2081906998912;968.6077138758814;979.1579241852002;985.610683779903;993.5975929748463;1001.9899801002042;4925.1381008324115;4928.285398617252;4978.352814134139;4997.30037794709;5000.67495612784;5200.817971370984;5210;5211.5830733541225;5229.712365819841;5252.29094072303;4978.950210497921;5024.949750502521;5035.690720412719;5308.389535203424;5726.627769195073;3110.6889311069162;3154.8580313885473;3166.841657917095;3166.9074169411515;3175.6506784253716;6124.601900876429;6127.253732686163;6189.721462534197;6202.596831206048;6220.253569571681;5682.943170568324;5980.760769569256;6000.369961154016;6002.969985150046;6020.488258498077;5838.941610583925;5974.312954010345;6057.60625559346;6090.421409966046;6143.692815359214;5849.034909239927;5895.616784908967;5896.262967129109;5917.260342457193;5944.673042982505;5782.884342313214;5799.333076696234;5815.79644712433;5817.505512031525;5849.181114644039;5921.348651648229;6120.020796672511;6159.96920015415;6184;6204.821083994208;4304.311310190355;4364.5635436456105;4381.452318460192;4387.539308372702;4409.7795110245;5818.389069147678;5863.237779088691;5894.70526473666;5959;5988.251468566429;5722.5135863450405;5723.084306510938;5746.454086861741;5747.453991870766;5769.07694768835;5690.378242200953;5703.543716502752;5732.398098199629;5746.367899530965;5760.6255593386295;5427.972860135674;5583.274174357308;5620.960122377373;5634.661920284796;5656.632318899258;5719.685417302088;5733.713314334183;5739.167820666064;5751.223584815996;5774.971125144348;5385.192221166856;5646.209530665792;5666.206731057573;5673.751774609579;5685.545156387397 03:43:21 INFO - PROCESS | 3440 | |5;yui.html;857.09148302799;874.2743522876013;874.763813770282;890.6927110147001;924.4037595750739;15312.770308445368;16804.159792010396;17201.569960750956;17260.395886143986;17277.30890764368;15611.219439028031;15931.20343982802;16079.11564863932;16082.437114700959;16120.274587643555;755.2447552447552;885.716570697377;900.5632268349846;903.7288813356;905.7237542549519;868.8609822428413;889.6130183370223;896.6144557840158;907.7412937312868;910.544727636182;957.8658987741721;959.3716115944032;959.8512230604267;963.8120566489538;964.28642804325;788.6017561131649;933;958.3866325551618;960.1214888377126;960.2749923807551;701.6982697440098;707.1337611426013;707.2962402409584;707.3421717802441;708.1042481261209;15034.398624055135;15187.164705941279;15203.771943420857;15206.16366099864;15218.086914785148;15563.766543501857;15893.125878076702;16013;16115.919420402823;16152.950058246177;13747.312634368342;13926.234057126854;14006.22965736884;14101;14146.221957792317;4670.859874203779;4675.929861052087;4731.621470282404;4768.0463907218345;4881.438634557036;79172;81738;82028.76956845712;82101.17898820995;82111;12244.326562039174;12381.319027453397;12390.194637348544;12792;12805.935970320275;23558.293251202493;23621.29136125919;23635.054597815895;23699;23781.762182377955;9105.408148470327;9140.360174787702;9240.122188392092;9263.351565390358;9373.062693730708;5099.719515426687;5105.693658380509;5107.412647545506;5113.360829896263;5265.4997775211295;3658;3789.829457674411;3792.1278106035215;3793.260314238752;3794.051487128218;653.6372313366032;660.5079215984123;663.5156335874839;664.7706541243264;671.3353779758102;686.8969654551858;705.5731282574071;707.773512476013;763.4007304266124;820.2904487618167;10026.598936042623;10135.341202821794;10220.284580079324;10245.948770256251;10319;655.0763423572739;782.9021372328459;794.1978601612414;813.2274339377615;816;5116.488351164928;5184.307229961266;5296.311479507639;5481;5516.475934786189;72102;116819.41590292164;117188;120273;122661;97879;101052;103340;103693;104338;92023.99999999866;92025;92997;95098;96726.51636741772;9983.750406239902;10110.443925584164;10201.54093065799;10201.582798267704;10207.183425326104;53105.46894531005;53268.73365633147;53381.733091334296;54184.45815541794;55036.174457383975;64932;65247.34752652413;66223.33776662171;71928.64035679789;72860.35698214962;14113.788293175405;14129.929350353594;14360.210188439736;14492.855071449572;14826.332815023134;15115;15276.694466110393;15789;16119.838801611833;16128.193590320203;10658;13617.114887532278;14764.852351476347;15769.211539423213;15820.762688559911;14466.927665362027;14645;14698.706025879637;14904.105753654381;15011;14247.358868850719;14429.711405772036;14887.553373398816;14944.476943306932;15454.304556294768;11573.18987670855;11966.22219555726;12104.45529951172;12129;12372.505099795908;12758.808617870554;12883.48466061347;12963.805542917053;13057.934710326388;13063.804042939553 03:43:21 INFO - PROCESS | 3440 | __end_tp_report 03:43:21 INFO - PROCESS | 3440 | __start_cc_report 03:43:21 INFO - PROCESS | 3440 | _x_x_mozilla_cycle_collect,1250 03:43:21 INFO - PROCESS | 3440 | __end_cc_report 03:43:21 INFO - PROCESS | 3440 | __startTimestamp1465641801669__endTimestamp 03:43:21 INFO - PROCESS | 3440 | 03:43:21 INFO - PROCESS | 3440 | ------- Summary: start ------- 03:43:21 INFO - PROCESS | 3440 | Number of tests: 6 03:43:21 INFO - PROCESS | 3440 | 03:43:21 INFO - PROCESS | 3440 | [#0] dojo.html Cycles:165 Average:5609.62 Median:5787.94 stddev:633.90 (11.0%) stddev-sans-first:611.07 03:43:21 INFO - PROCESS | 3440 | Values: 3372.5 3391.7 3394.0 3416.6 3432.0 5560.5 5654.5 5656.9 5671.5 5693.7 5558.1 5617.5 5617.5 5620.6 5653.2 4953.3 5025.1 5088.0 5088.2 5127.2 5035.7 5047.4 5067.0 5099.5 5169.0 5079.6 5094.2 5125.4 5161.1 5183.8 5153.8 5153.8 5158.4 5177.2 5196.1 4674.8 4923.2 5039.7 5042.4 5069.3 5533.8 5543.0 5555.3 5564.1 5610.2 6067.6 6071.4 6084.0 6119.4 6133.4 5930.9 6095.2 6115.2 6125.7 6130.2 5748.8 5754.1 5758.6 5762.0 5765.3 6254.1 6259.8 6260.6 6261.3 6261.8 5781.7 5845.1 5879.5 5897.7 6044.7 6021.5 6028.2 6036.7 6056.5 6067.5 5951.7 5986.6 6003.6 6013.3 6015.8 5848.4 5925.2 5962.3 5962.9 5999.6 4625.4 4633.6 4634.0 4653.3 4653.4 4135.2 4144.4 4147.4 4148.2 4171.0 5595.7 5642.2 5660.2 5772.0 5777.8 6052.3 6053.9 6059.0 6066.9 6085.5 5703.5 5725.2 5733.6 5742.7 5750.0 5066.7 5146.4 5212.3 5217.9 5221.6 6315.1 6318.5 6319.1 6330.7 6338.0 6040.0 6098.8 6113.6 6119.7 6123.5 6092.7 6208.3 6244.3 6266.7 6367.5 6040.0 6044.3 6048.8 6050.2 6082.4 5890.5 6086.5 6147.1 6148.6 6153.4 5830.9 5880.6 5882.4 5923.5 5927.7 5925.0 5926.6 5929.5 5933.3 5937.2 5650.3 5702.9 5829.4 5836.2 5842.8 5760.1 5829.6 5830.4 5832.0 5904.2 5753.5 5785.9 5786.5 5787.9 5801.2 03:43:21 INFO - PROCESS | 3440 | 03:43:21 INFO - PROCESS | 3440 | [#1] ext.html Cycles:180 Average:64478.14 Median:3969.83 stddev:128289.89 (3231.6%) stddev-sans-first:128560.09 03:43:21 INFO - PROCESS | 3440 | Values: 585.5 635.4 648.5 665.1 674.6 32884.0 44539.1 45206.3 45375.0 45409.1 46801.8 47079.0 47143.3 47181.0 47271.3 8455.3 9063.3 9262.4 9264.1 10917.1 10591.5 11139.7 11143.7 11148.0 11151.2 11150.3 11245.0 11259.7 11274.3 11276.2 8473.9 11011.3 11078.2 11297.3 11309.3 11026.6 11144.7 11146.0 11158.2 11175.7 42842.4 43291.8 43296.6 43332.0 43363.6 3969.8 3969.9 3985.4 4093.3 4343.8 33413.8 35702.8 36680.6 36785.8 37065.6 4738.8 4757.4 4813.2 4863.9 4922.4 388086.0 393347.0 395926.0 398350.0 400816.0 67826.0 67864.3 68194.7 68265.0 68294.7 39429.4 40108.6 40140.8 41914.0 42103.6 19455.6 19520.7 19618.7 19618.9 19625.5 13656.2 14667.9 14912.2 14930.8 15286.3 21166.3 21459.5 21586.4 21586.8 21672.5 7431.7 7602.4 7661.6 7753.9 7783.5 1072.2 1109.9 1119.1 1144.0 1163.0 34631.7 34652.5 34708.3 34736.0 34840.3 1235.3 1275.2 1305.9 1330.6 1394.7 17972.3 19088.3 19363.3 19371.0 20069.6 581927.0 583310.0 584265.0 585397.0 586349.0 64645.4 64858.7 64901.4 65249.0 65295.7 1376.5 1487.6 1488.9 1532.0 1541.1 33636.0 34014.7 34281.0 34497.8 34977.3 53555.2 54084.2 54160.5 54247.7 54361.5 439858.0 452619.0 452958.0 458422.0 459654.0 27154.6 29098.0 29345.6 29452.7 31411.8 50348.7 51050.2 51095.0 52146.7 52574.2 42052.6 42549.4 42599.1 42727.0 43289.8 40131.2 40208.4 40799.4 41536.4 42454.0 42353.8 43307.6 43401.6 43867.3 43950.8 35267.1 35866.5 37268.8 37345.1 37728.0 28927.4 29093.6 29099.9 29284.0 29587.4 03:43:21 INFO - PROCESS | 3440 | 03:43:21 INFO - PROCESS | 3440 | [#2] jquery.html Cycles:180 Average:29386.38 Median:23980.96 stddev:82618.22 (344.5%) stddev-sans-first:82821.36 03:43:21 INFO - PROCESS | 3440 | Values: 421.4 435.3 441.2 441.4 441.5 18750.1 20536.3 20701.5 21265.0 21590.7 19514.7 19610.6 19705.2 20143.7 20192.2 5859.1 5973.3 5987.4 6014.3 6034.4 5759.5 5796.5 5911.7 5935.7 5941.5 5841.8 5864.7 5876.3 5886.8 5894.9 5728.8 5876.4 5937.9 5940.9 6047.1 5273.8 5399.4 5409.0 5411.2 5411.8 23678.6 23704.8 23795.6 23888.8 24073.2 2574.5 2625.6 2663.4 2783.9 3011.5 14231.2 14839.9 15023.1 15293.6 15457.5 2040.8 2140.4 2140.8 2191.2 2199.5 81147.2 83127.0 85093.0 85740.6 86425.0 11203.0 11444.8 11626.7 11759.3 11871.3 16348.6 16449.5 16513.9 16530.3 16537.8 8785.9 9086.3 9171.5 9190.6 9201.7 8867.8 8903.6 8947.5 9070.4 9076.6 6965.8 7066.5 7158.3 7170.9 7178.5 1788.6 2000.5 2028.6 2041.2 2101.9 893.4 1029.3 1058.1 1065.8 1090.2 18354.2 18872.8 19298.5 19474.1 19878.3 1005.6 1033.7 1045.8 1047.4 1051.1 10440.0 11127.4 11199.2 11213.6 11224.3 487142.4 498402.0 501901.0 503534.0 519941.0 87184.0 87832.0 87877.6 87928.1 88884.6 1103.8 1115.9 1127.1 1133.5 1140.1 17717.6 17800.7 18015.8 18117.2 18419.5 29066.4 29793.9 30087.7 32584.8 42326.2 54480.5 54887.7 55138.0 55902.4 60355.1 7480.6 7953.0 9185.0 9255.3 9430.8 10514.9 13103.4 13130.5 13392.5 13539.9 11809.8 12017.9 12026.5 12248.9 12294.9 10637.1 10960.5 11274.5 11375.2 11491.0 6468.8 10460.6 11193.8 12244.4 12297.1 7929.3 7930.2 7974.1 7997.6 7998.8 8568.5 11591.8 12048.4 12076.3 12119.4 03:43:21 INFO - PROCESS | 3440 | 03:43:21 INFO - PROCESS | 3440 | [#3] mootools.html Cycles:180 Average:6270.36 Median:4714.00 stddev:3574.52 (75.8%) stddev-sans-first:3565.68 03:43:21 INFO - PROCESS | 3440 | Values: 1383.5 1570.9 1581.0 1799.9 1929.1 8672.2 8953.0 8976.1 9226.3 9233.4 8783.3 8957.6 8962.3 8962.4 8973.1 2193.2 2440.7 2461.1 2499.1 2500.1 2255.9 2258.6 2259.5 2262.5 2262.9 2450.6 2493.2 2498.1 2498.9 2503.2 2090.8 2306.2 2353.5 2358.4 2369.3 2361.2 2381.9 2389.7 2390.5 2419.9 9118.6 9139.0 9189.0 9192.9 9197.0 5607.7 5746.9 5752.3 5766.1 5772.9 3472.5 3534.2 3586.6 3667.0 3671.3 1212.6 1225.0 1226.5 2316.5 2372.9 13618.7 13744.1 13771.6 13771.9 13772.6 4792.7 4905.6 4941.6 4953.7 4997.6 10423.3 10541.5 10545.8 10569.4 10574.8 5079.3 5711.9 5755.5 5755.9 5760.7 5237.0 5312.5 5336.6 5380.2 5391.2 4160.1 4191.2 4211.6 4230.5 4283.5 1238.2 1259.8 1260.9 1275.7 1277.6 920.9 969.6 991.8 1082.4 1083.7 6669.6 6701.8 6705.4 6749.7 6794.5 1025.5 1047.7 1051.2 1057.9 1076.9 4535.3 4685.8 4686.8 4704.7 4723.3 11767.3 11993.9 12054.3 12092.8 12141.6 11315.4 11898.9 12001.3 12017.1 12018.2 8665.5 9047.8 9048.6 9093.0 9103.9 6614.9 6803.2 6829.0 6851.5 6877.4 10693.0 10941.5 10964.3 11021.2 11148.3 10948.3 11129.4 11163.3 11284.2 11316.7 7607.2 8297.4 8501.2 8543.2 8697.0 9359.2 9359.5 9397.6 9450.9 9452.8 8378.1 8505.6 8571.8 8650.0 8681.3 7639.2 7891.5 8232.9 8273.7 8569.2 7616.4 7732.7 7739.6 7747.2 7750.2 5529.5 5535.4 5573.2 5604.2 5633.5 5560.4 5578.7 5594.6 5637.0 5637.9 03:43:21 INFO - PROCESS | 3440 | 03:43:21 INFO - PROCESS | 3440 | [#4] prototype.html Cycles:180 Average:4796.17 Median:5399.37 stddev:1392.82 (25.8%) stddev-sans-first:1356.23 03:43:21 INFO - PROCESS | 3440 | Values: 353.9 357.5 358.5 362.0 362.3 5423.8 5519.8 5520.1 5534.7 5568.3 5413.5 5435.3 5440.6 5446.4 5473.9 3853.9 4039.4 4257.7 4283.5 4308.2 4232.2 4267.9 4282.7 4285.4 4309.4 4077.3 4248.5 4248.8 4251.8 4296.4 4176.8 4227.6 4258.5 4263.6 4266.7 3796.9 3815.0 3821.0 3829.8 3832.7 5222.6 5227.3 5251.8 5257.2 5280.0 4894.7 4898.7 4929.3 4945.0 4970.0 5485.4 5611.2 5666.5 5758.9 5769.9 4068.5 4152.3 4158.1 4186.5 4193.7 5725.2 5871.6 5878.5 5880.6 5894.2 4107.4 4237.5 4258.5 4265.1 4280.5 4294.9 4311.2 4323.0 4338.4 4338.4 4876.9 4889.9 4905.2 4908.7 4911.4 5483.7 5695.2 5713.0 5725.6 5726.6 1484.4 1497.8 1503.7 1505.9 1508.2 968.6 979.2 985.6 993.6 1002.0 4925.1 4928.3 4978.4 4997.3 5000.7 5200.8 5210.0 5211.6 5229.7 5252.3 4979.0 5024.9 5035.7 5308.4 5726.6 3110.7 3154.9 3166.8 3166.9 3175.7 6124.6 6127.3 6189.7 6202.6 6220.3 5682.9 5980.8 6000.4 6003.0 6020.5 5838.9 5974.3 6057.6 6090.4 6143.7 5849.0 5895.6 5896.3 5917.3 5944.7 5782.9 5799.3 5815.8 5817.5 5849.2 5921.3 6120.0 6160.0 6184.0 6204.8 4304.3 4364.6 4381.5 4387.5 4409.8 5818.4 5863.2 5894.7 5959.0 5988.3 5722.5 5723.1 5746.5 5747.5 5769.1 5690.4 5703.5 5732.4 5746.4 5760.6 5428.0 5583.3 5621.0 5634.7 5656.6 5719.7 5733.7 5739.2 5751.2 5775.0 5385.2 5646.2 5666.2 5673.8 5685.5 03:43:21 INFO - PROCESS | 3440 | 03:43:21 INFO - PROCESS | 3440 | [#5] yui.html Cycles:180 Average:21604.67 Median:3793.66 stddev:30248.74 (797.4%) stddev-sans-first:30293.47 03:43:21 INFO - PROCESS | 3440 | Values: 857.1 874.3 874.8 890.7 924.4 15312.8 16804.2 17201.6 17260.4 17277.3 15611.2 15931.2 16079.1 16082.4 16120.3 755.2 885.7 900.6 903.7 905.7 868.9 889.6 896.6 907.7 910.5 957.9 959.4 959.9 963.8 964.3 788.6 933.0 958.4 960.1 960.3 701.7 707.1 707.3 707.3 708.1 15034.4 15187.2 15203.8 15206.2 15218.1 15563.8 15893.1 16013.0 16115.9 16153.0 13747.3 13926.2 14006.2 14101.0 14146.2 4670.9 4675.9 4731.6 4768.0 4881.4 79172.0 81738.0 82028.8 82101.2 82111.0 12244.3 12381.3 12390.2 12792.0 12805.9 23558.3 23621.3 23635.1 23699.0 23781.8 9105.4 9140.4 9240.1 9263.4 9373.1 5099.7 5105.7 5107.4 5113.4 5265.5 3658.0 3789.8 3792.1 3793.3 3794.1 653.6 660.5 663.5 664.8 671.3 686.9 705.6 707.8 763.4 820.3 10026.6 10135.3 10220.3 10245.9 10319.0 655.1 782.9 794.2 813.2 816.0 5116.5 5184.3 5296.3 5481.0 5516.5 72102.0 116819.4 117188.0 120273.0 122661.0 97879.0 101052.0 103340.0 103693.0 104338.0 92024.0 92025.0 92997.0 95098.0 96726.5 9983.8 10110.4 10201.5 10201.6 10207.2 53105.5 53268.7 53381.7 54184.5 55036.2 64932.0 65247.3 66223.3 71928.6 72860.4 14113.8 14129.9 14360.2 14492.9 14826.3 15115.0 15276.7 15789.0 16119.8 16128.2 10658.0 13617.1 14764.9 15769.2 15820.8 14466.9 14645.0 14698.7 14904.1 15011.0 14247.4 14429.7 14887.6 14944.5 15454.3 11573.2 11966.2 12104.5 12129.0 12372.5 12758.8 12883.5 12963.8 13057.9 13063.8 03:43:21 INFO - PROCESS | 3440 | -------- Summary: end -------- 03:43:21 INFO - PROCESS | 3440 | 03:43:22 INFO - TEST-INFO | 3440: exit 0 03:43:22 INFO - TEST-OK | dromaeo_css | took 1113740ms 03:43:22 INFO - TEST-START | kraken 03:43:22 INFO - operating with platform_type : linux_ 03:43:22 INFO - Initialising browser for kraken test... 03:43:22 INFO - TEST-INFO | started process 3634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp06Qh1l/profile http://localhost:51141/getInfo.html) 03:43:26 INFO - PROCESS | 3634 | __metrics Screen width/height:1600/1200 03:43:26 INFO - PROCESS | 3634 | colorDepth:24 03:43:26 INFO - PROCESS | 3634 | Browser inner width/height: 1024/697 03:43:26 INFO - PROCESS | 3634 | __metrics 03:43:27 ERROR - PROCESS | 3634 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:43:27 INFO - PROCESS | 3634 | console.error: PushService: 03:43:27 INFO - PROCESS | 3634 | stateChangeProcessEnqueue: Error transitioning state 03:43:27 INFO - PROCESS | 3634 | UnknownError 03:43:28 INFO - TEST-INFO | 3634: exit 0 03:43:28 INFO - Browser initialized. 03:43:28 INFO - Running cycle 1/1 for kraken test... 03:43:28 INFO - TEST-INFO | started process 3725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp06Qh1l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:43:39 INFO - PROCESS | 3725 | RSS: Main: 145494016 03:43:39 INFO - PROCESS | 3725 | 03:43:42 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:51141/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51141/tests/kraken/driver.html?testName=audio-beat-detection) 03:43:43 INFO - PROCESS | 3725 | RSS: Main: 194400256 03:43:43 INFO - PROCESS | 3725 | 03:43:45 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:51141/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51141/tests/kraken/driver.html?testName=audio-dft) 03:43:46 INFO - PROCESS | 3725 | RSS: Main: 188338176 03:43:46 INFO - PROCESS | 3725 | 03:43:49 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:51141/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51141/tests/kraken/driver.html?testName=audio-fft) 03:43:49 INFO - PROCESS | 3725 | RSS: Main: 279212032 03:43:49 INFO - PROCESS | 3725 | 03:43:51 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:51141/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51141/tests/kraken/driver.html?testName=audio-oscillator) 03:43:52 INFO - PROCESS | 3725 | RSS: Main: 187736064 03:43:52 INFO - PROCESS | 3725 | 03:43:54 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:51141/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51141/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:43:55 INFO - PROCESS | 3725 | RSS: Main: 188841984 03:43:55 INFO - PROCESS | 3725 | 03:43:58 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:51141/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51141/tests/kraken/driver.html?testName=imaging-darkroom) 03:43:58 INFO - PROCESS | 3725 | RSS: Main: 223318016 03:43:58 INFO - PROCESS | 3725 | 03:44:02 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:51141/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51141/tests/kraken/driver.html?testName=imaging-desaturate) 03:44:02 INFO - PROCESS | 3725 | RSS: Main: 222928896 03:44:02 INFO - PROCESS | 3725 | 03:44:05 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:51141/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51141/tests/kraken/driver.html?testName=json-parse-financial) 03:44:06 INFO - PROCESS | 3725 | RSS: Main: 222838784 03:44:06 INFO - PROCESS | 3725 | 03:44:07 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:51141/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51141/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:44:08 INFO - PROCESS | 3725 | RSS: Main: 201125888 03:44:08 INFO - PROCESS | 3725 | 03:44:09 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:51141/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51141/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:44:10 INFO - PROCESS | 3725 | RSS: Main: 203309056 03:44:10 INFO - PROCESS | 3725 | 03:44:12 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:51141/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51141/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:44:13 INFO - PROCESS | 3725 | RSS: Main: 209244160 03:44:13 INFO - PROCESS | 3725 | 03:44:15 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:51141/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51141/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:44:16 INFO - PROCESS | 3725 | RSS: Main: 214831104 03:44:16 INFO - PROCESS | 3725 | 03:44:18 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:51141/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51141/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:44:19 INFO - PROCESS | 3725 | RSS: Main: 211501056 03:44:19 INFO - PROCESS | 3725 | 03:44:21 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:51141/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51141/tests/kraken/driver.html?testName=ai-astar) 03:44:21 INFO - PROCESS | 3725 | RSS: Main: 254529536 03:44:21 INFO - PROCESS | 3725 | 03:44:21 INFO - PROCESS | 3725 | __start_tp_report 03:44:21 INFO - PROCESS | 3725 | _x_x_mozilla_page_load 03:44:21 INFO - PROCESS | 3725 | _x_x_mozilla_page_load_details 03:44:21 INFO - PROCESS | 3725 | |i|pagename|runs| 03:44:21 INFO - PROCESS | 3725 | |0;ai-astar;111;105;110;109;111;109;110;112;110;110 03:44:21 INFO - PROCESS | 3725 | |1;audio-beat-detection;156;131;145;172;125;126;153;123;184;130 03:44:21 INFO - PROCESS | 3725 | |2;audio-dft;161;163;160;161;160;160;160;162;160;159 03:44:21 INFO - PROCESS | 3725 | |3;audio-fft;75;75;75;120;74;74;76;74;96;75 03:44:21 INFO - PROCESS | 3725 | |4;audio-oscillator;85;85;115;85;85;85;110;84;84;126 03:44:21 INFO - PROCESS | 3725 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;117;116 03:44:21 INFO - PROCESS | 3725 | |6;imaging-darkroom;146;145;145;146;147;145;145;146;145;146 03:44:21 INFO - PROCESS | 3725 | |7;imaging-desaturate;95;94;95;95;96;96;95;95;96;95 03:44:21 INFO - PROCESS | 3725 | |8;json-parse-financial;52;50;54;50;52;51;52;51;50;50 03:44:21 INFO - PROCESS | 3725 | |9;json-stringify-tinderbox;61;61;60;61;62;60;61;61;62;61 03:44:21 INFO - PROCESS | 3725 | |10;stanford-crypto-aes;75;75;76;76;75;77;83;76;111;76 03:44:21 INFO - PROCESS | 3725 | |11;stanford-crypto-ccm;117;131;124;125;125;123;125;121;128;117 03:44:21 INFO - PROCESS | 3725 | |12;stanford-crypto-pbkdf2;156;162;157;153;155;155;156;154;155;157 03:44:21 INFO - PROCESS | 3725 | |13;stanford-crypto-sha256-iterative;62;61;62;62;63;61;66;61;61;60 03:44:21 INFO - PROCESS | 3725 | __end_tp_report 03:44:21 INFO - PROCESS | 3725 | __start_cc_report 03:44:21 INFO - PROCESS | 3725 | _x_x_mozilla_cycle_collect,1588 03:44:21 INFO - PROCESS | 3725 | __end_cc_report 03:44:21 INFO - PROCESS | 3725 | __startTimestamp1465641861431__endTimestamp 03:44:21 INFO - PROCESS | 3725 | 03:44:21 INFO - PROCESS | 3725 | ------- Summary: start ------- 03:44:21 INFO - PROCESS | 3725 | Number of tests: 14 03:44:21 INFO - PROCESS | 3725 | 03:44:21 INFO - PROCESS | 3725 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:1.89 (1.7%) stddev-sans-first:1.94 03:44:21 INFO - PROCESS | 3725 | Values: 111.0 105.0 110.0 109.0 111.0 109.0 110.0 112.0 110.0 110.0 03:44:21 INFO - PROCESS | 3725 | 03:44:21 INFO - PROCESS | 3725 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:149.00 stddev:21.34 (14.3%) stddev-sans-first:22.22 03:44:21 INFO - PROCESS | 3725 | Values: 156.0 131.0 145.0 172.0 125.0 126.0 153.0 123.0 184.0 130.0 03:44:21 INFO - PROCESS | 3725 | 03:44:21 INFO - PROCESS | 3725 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.17 (0.7%) stddev-sans-first:1.24 03:44:21 INFO - PROCESS | 3725 | Values: 161.0 163.0 160.0 161.0 160.0 160.0 160.0 162.0 160.0 159.0 03:44:21 INFO - PROCESS | 3725 | 03:44:21 INFO - PROCESS | 3725 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:15.13 (20.2%) stddev-sans-first:15.87 03:44:21 INFO - PROCESS | 3725 | Values: 75.0 75.0 75.0 120.0 74.0 74.0 76.0 74.0 96.0 75.0 03:44:21 INFO - PROCESS | 3725 | 03:44:21 INFO - PROCESS | 3725 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:85.00 stddev:16.07 (18.9%) stddev-sans-first:16.68 03:44:21 INFO - PROCESS | 3725 | Values: 85.0 85.0 115.0 85.0 85.0 85.0 110.0 84.0 84.0 126.0 03:44:21 INFO - PROCESS | 3725 | 03:44:21 INFO - PROCESS | 3725 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:44:21 INFO - PROCESS | 3725 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 03:44:21 INFO - PROCESS | 3725 | 03:44:21 INFO - PROCESS | 3725 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 03:44:21 INFO - PROCESS | 3725 | Values: 146.0 145.0 145.0 146.0 147.0 145.0 145.0 146.0 145.0 146.0 03:44:21 INFO - PROCESS | 3725 | 03:44:21 INFO - PROCESS | 3725 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 03:44:21 INFO - PROCESS | 3725 | Values: 95.0 94.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 03:44:21 INFO - PROCESS | 3725 | 03:44:21 INFO - PROCESS | 3725 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.50 stddev:1.32 (2.6%) stddev-sans-first:1.36 03:44:21 INFO - PROCESS | 3725 | Values: 52.0 50.0 54.0 50.0 52.0 51.0 52.0 51.0 50.0 50.0 03:44:21 INFO - PROCESS | 3725 | 03:44:21 INFO - PROCESS | 3725 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 03:44:21 INFO - PROCESS | 3725 | Values: 61.0 61.0 60.0 61.0 62.0 60.0 61.0 61.0 62.0 61.0 03:44:21 INFO - PROCESS | 3725 | 03:44:21 INFO - PROCESS | 3725 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:76.00 stddev:11.15 (14.7%) stddev-sans-first:11.67 03:44:21 INFO - PROCESS | 3725 | Values: 75.0 75.0 76.0 76.0 75.0 77.0 83.0 76.0 111.0 76.0 03:44:21 INFO - PROCESS | 3725 | 03:44:21 INFO - PROCESS | 3725 | [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:125.00 stddev:4.40 (3.5%) stddev-sans-first:3.97 03:44:21 INFO - PROCESS | 3725 | Values: 117.0 131.0 124.0 125.0 125.0 123.0 125.0 121.0 128.0 117.0 03:44:21 INFO - PROCESS | 3725 | 03:44:21 INFO - PROCESS | 3725 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.00 Median:156.00 stddev:2.45 (1.6%) stddev-sans-first:2.60 03:44:21 INFO - PROCESS | 3725 | Values: 156.0 162.0 157.0 153.0 155.0 155.0 156.0 154.0 155.0 157.0 03:44:21 INFO - PROCESS | 3725 | 03:44:21 INFO - PROCESS | 3725 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.66 (2.7%) stddev-sans-first:1.76 03:44:21 INFO - PROCESS | 3725 | Values: 62.0 61.0 62.0 62.0 63.0 61.0 66.0 61.0 61.0 60.0 03:44:21 INFO - PROCESS | 3725 | -------- Summary: end -------- 03:44:21 INFO - PROCESS | 3725 | 03:44:22 INFO - TEST-INFO | 3725: exit 0 03:44:22 INFO - TEST-OK | kraken | took 60027ms 03:44:22 INFO - SUITE-END | took 1173s 03:44:22 INFO - Completed test suite (00:19:34) 03:44:22 INFO - javascript benchmark 03:44:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3372.460406334986, 3391.6777906098914, 3393.9830300848494, 3416.572928383952, 3431.965680343196, 5560.52735517481, 5654.491095801377, 5656.858578535539, 5671.489565939065, 5693.715314234292, 5558.138488534284, 5617.466340697627, 5617.494425501704, 5620.606557540974, 5653.1520271959225, 4953.331300274453, 5025.0954828130925, 5087.9745601272125, 5088.160453525174, 5127.179651255799, 5035.748212589374, 5047.369078865142, 5067.0, 5099.4900509949075, 5169.017886601552, 5079.644424890241, 5094.184930411135, 5125.410577783547, 5161.0968080585935, 5183.818566350178, 5153.793848246066, 5153.845384638448, 5158.40678321994, 5177.197534382177, 5196.1166601677805, 4674.813007479696, 4923.18767403378, 5039.72281524516, 5042.445331013586, 5069.315642388267, 5533.806316778893, 5543.0, 5555.250041244421, 5564.054110801174, 5610.18652295419, 6067.605605635619, 6071.362506936796, 6084.002470660909, 6119.44924956756, 6133.44798968095, 5930.851728706773, 6095.207623009025, 6115.199568338832, 6125.663088530129, 6130.2452696569835, 5748.827535173951, 5754.050581654022, 5758.596898217126, 5762.0, 5765.279340082489, 6254.093156492283, 6259.812205633838, 6260.593061450991, 6261.279952805395, 6261.843453913689, 5781.653100813881, 5845.064789633723, 5879.470847623735, 5897.705114744245, 6044.667543285073, 6021.548383871227, 6028.246469191351, 6036.667983260875, 6056.485198758067, 6067.514598832083, 5951.702414879239, 5986.610870293417, 6003.6397816131175, 6013.308469525973, 6015.759369625253, 5848.356680765112, 5925.200097986716, 5962.284525856925, 5962.910556341659, 5999.610025348338, 4625.398698169284, 4633.582977532038, 4634.0, 4653.302004699254, 4653.371794807726, 4135.234981528427, 4144.3990621359735, 4147.419361289422, 4148.23257697321, 4170.998960249518, 5595.720213989284, 5642.210090587321, 5660.179274005246, 5771.9711401443565, 5777.826665200051, 6052.273727152769, 6053.939460605337, 6059.0, 6066.908996365058, 6085.513158947274, 5703.515201207943, 5725.227094342294, 5733.569982251264, 5742.712864356766, 5750.0, 5066.695998240118, 5146.356705411824, 5212.296339994053, 5217.9478205217465, 5221.55616772571, 6315.084312774622, 6318.462930650946, 6319.05214217871, 6330.651814150174, 6337.96831015842, 6039.969800150971, 6098.847528811638, 6113.57204995646, 6119.694015299307, 6123.540734445023, 6092.725827337692, 6208.348123447154, 6244.2819075806865, 6266.68666566679, 6367.522435817425, 6040.0, 6044.304904935989, 6048.818535443944, 6050.2437195350585, 6082.391760823883, 5890.4993075589055, 6086.513078953762, 6147.0779383092895, 6148.569600127948, 6153.4154255345675, 5830.883382332415, 5880.647161170344, 5882.411758824083, 5923.466887980103, 5927.7036148191555, 5925.022371308686, 5926.585139040399, 5929.495992840484, 5933.2880054393745, 5937.198478205387, 5650.26546548946, 5702.885942281048, 5829.358770535153, 5836.153757705194, 5842.824715258549, 5760.0783874579865, 5829.59192856496, 5830.387809279964, 5831.970840145772, 5904.232449781501, 5753.453421924911, 5785.884282314246, 5786.537077033911, 5787.9421205789085, 5801.158831969426], "value": 5568.110743837085, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.5491271720775, 635.4154178156095, 648.4909346163262, 665.0921492163199, 674.5750177388245, 32884.0, 44539.10921781566, 45206.321905171404, 45375.0, 45409.0918181637, 46801.76599117008, 47079.0, 47143.29285060727, 47181.0, 47271.29093063598, 8455.281301089415, 9063.320250981169, 9262.44425334482, 9264.11990860867, 10917.126629869632, 10591.523381447814, 11139.721506962309, 11143.72140696485, 11148.0, 11151.219414640978, 11150.330980141176, 11245.0, 11259.662210133669, 11274.267172633794, 11276.210665253435, 8473.872891906596, 11011.28426652273, 11078.169137314693, 11297.265677731004, 11309.264897781617, 11026.614068507644, 11144.66566003013, 11146.0, 11158.1631377647, 11175.664730058112, 42842.35736463955, 43291.78354108209, 43296.56703432957, 43332.0, 43363.56636433627, 3969.7816620085882, 3969.8809035728973, 3985.3822657488136, 4093.3450647896193, 4343.847965321199, 33413.83293083544, 35702.821485892404, 36680.633193668255, 36785.81607091974, 37065.62934370676, 4738.810447582093, 4757.429108506966, 4813.181759100961, 4863.927041094386, 4922.384701912261, 388086.0, 393347.0, 395925.99999999715, 398350.0, 400816.0, 67826.0, 67864.3213567858, 68194.65902670554, 68265.0, 68294.65852670804, 39429.40855887164, 40108.59891401107, 40140.79929600392, 41914.0, 42103.57896421058, 19455.610887782164, 19520.70718939217, 19618.70571941422, 19618.901905490668, 19625.509362266057, 13656.248906310248, 14667.92666036663, 14912.179830109448, 14930.776038359434, 15286.312115954808, 21166.259180928595, 21459.46351341229, 21586.35240942774, 21586.78413215879, 21672.458188545097, 7431.665575049135, 7602.42981776369, 7661.620908236571, 7753.922460775433, 7783.455158138876, 1072.1797824664138, 1109.8834622364698, 1119.065580240492, 1143.9885601143883, 1162.959296424621, 34631.65368346284, 34652.48021279683, 34708.30583388318, 34736.0, 34840.30319393598, 1235.2773627428055, 1275.1647670775471, 1305.895528357729, 1330.6274243211917, 1394.7489451898755, 17972.347950829655, 19088.33190838314, 19363.32228372, 19371.0, 20069.598608027758, 581927.0, 583310.0, 584265.0, 585397.0, 586349.0, 64645.353546464874, 64858.675706621165, 64901.35098649048, 65249.0, 65295.673521633034, 1376.483818568037, 1487.6429656882488, 1488.9106653600818, 1532.0348180646122, 1541.0984574024096, 33636.0, 34014.65985340214, 34281.0, 34497.827510862284, 34977.30045399129, 53555.196672050726, 54084.18873716976, 54160.45839541554, 54247.72876135594, 54361.456385437225, 439858.0, 452619.0, 452958.0, 458422.0, 459654.0, 27154.592681110193, 29098.0, 29345.55981660234, 29452.705472944996, 31411.84294078515, 50348.748256258485, 51050.23424648559, 51095.0, 52146.739266303426, 52574.21138682999, 42052.57947420487, 42549.36175957425, 42599.148017040105, 42727.0, 43289.783551082044, 40131.1973760529, 40208.396874047496, 40799.38800918048, 41536.376954345105, 42454.0, 42353.78823105988, 43307.56692433036, 43401.56598433975, 43867.341989869536, 43950.78024609856, 35267.11832204215, 35866.46200306945, 37268.813655931546, 37345.06637334089, 37728.0, 28927.42145157127, 29093.563596545646, 29099.85450072736, 29284.0, 29587.408251835273], "value": 21826.534706447437, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.38688208656396, 435.31872619350713, 441.16399423093236, 441.401900424924, 441.54300299190345, 18750.062496875154, 20536.281230156947, 20701.482462938417, 21265.0, 21590.676139857915, 19514.707279390786, 19610.60778784427, 19705.211791528356, 20143.697844532344, 20192.19231230749, 5859.091840764678, 5973.342932277446, 5987.401259874021, 6014.308354539218, 6034.396560343975, 5759.539236861041, 5796.536277097843, 5911.704414779266, 5935.732892019848, 5941.494972927307, 5841.824745257649, 5864.706764661772, 5876.294844618652, 5886.823395298148, 5894.852628684274, 5728.770849166029, 5876.44173803488, 5937.910931336033, 5940.881182376372, 6047.0627052806885, 5273.841784746463, 5399.433059528771, 5408.972955135238, 5411.242426060355, 5411.810586629488, 23678.64482032771, 23704.762952370427, 23795.643065354034, 23888.761112388827, 24073.15743948971, 2574.5494538455696, 2625.6061590761346, 2663.3741070848337, 2783.9304017399522, 3011.5031019881694, 14231.217283049427, 14839.851601483955, 15023.09861408319, 15293.61765955849, 15457.5362739118, 2040.8061234182728, 2140.4220860367614, 2140.7538133114736, 2191.222116148776, 2199.516106456577, 81147.18852811455, 83127.0, 85093.0, 85740.57129714312, 86425.0, 11203.0, 11444.828327575093, 11626.70933226676, 11759.294442333487, 11871.287722736492, 16348.591285217726, 16449.519543241167, 16513.91743041277, 16530.338786448407, 16537.83462165387, 8785.868211976825, 9086.318526110568, 9171.541422928827, 9190.632374704937, 9201.723948281428, 8867.778305542284, 8903.554822258991, 8947.507887066275, 9070.410423322595, 9076.636934522545, 6965.756198533027, 7066.535107074017, 7158.2841715829045, 7170.924361345736, 7178.533395329287, 1788.6289445048988, 2000.4998750312423, 2028.6408106568636, 2041.2447394463845, 2101.8633788803677, 893.4460634406579, 1029.2897900448816, 1058.074185088048, 1065.7868426314612, 1090.1605763562013, 18354.174062166967, 18872.81127188738, 19298.456123510365, 19474.123664435134, 19878.304259350854, 1005.607812952949, 1033.7467320506523, 1045.8065257927308, 1047.371577053777, 1051.138066785244, 10440.0, 11127.443627818577, 11199.160062995308, 11213.55145794159, 11224.326540407601, 487142.3857284287, 498402.0, 501901.0, 503534.0, 519941.0, 87184.0, 87832.0, 87877.56061219652, 87928.12071879327, 88884.5555772217, 1103.779244151173, 1115.893990070942, 1127.1490025031048, 1133.54091592905, 1140.0594509529506, 17717.557061073578, 17800.732989005435, 18015.81984180194, 18117.184726687596, 18419.539511511783, 29066.41867162687, 29793.851030744707, 30087.69912300849, 32584.83707581447, 42326.15347692967, 54480.45519544754, 54887.72556137353, 55138.0, 55902.44097558972, 60355.09467358081, 7480.551166930001, 7952.960235198787, 9185.0, 9255.305852061258, 9430.811383772423, 10514.894851051391, 13103.410346534238, 13130.474781008652, 13392.531261405804, 13539.86460135386, 11809.82285265739, 12017.939910300393, 12026.49668791401, 12248.938755306166, 12294.938525307316, 10637.14902807758, 10960.506777195205, 11274.549018039515, 11375.20373573842, 11491.0, 6468.838279042873, 10460.63387781424, 11193.768685444757, 12244.387780610756, 12297.139200255897, 7929.326007289445, 7930.206979302024, 7974.082980457089, 7997.560134192675, 7998.800029999296, 8568.52873091986, 11591.76816463683, 12048.397580120783, 12076.275423474268, 12119.394030298627], "value": 9607.757058349775, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.4742797736858, 1570.8900376973609, 1581.0434687014356, 1799.865010124241, 1929.0644037641741, 8672.219500244977, 8953.0, 8976.05751396103, 9226.261899048077, 9233.39982901111, 8783.297336213103, 8957.596908139132, 8962.283017358612, 8962.41744286621, 8973.102689731024, 2193.243331050785, 2440.6583078369044, 2461.0770960889668, 2499.0503608628696, 2500.112460076674, 2255.9210427635035, 2258.616035273999, 2259.548090381922, 2262.46831994482, 2262.9434264143447, 2450.5834008218644, 2493.227099599121, 2498.0507407185337, 2498.8625625590585, 2503.2114883811632, 2090.8431867609916, 2306.169778879602, 2353.505763789606, 2358.445765245166, 2369.3010561884284, 2361.197192954404, 2381.8570885746735, 2389.7012873390827, 2390.53384590005, 2419.9395015124587, 9118.58966346516, 9139.0, 9189.0, 9192.862107068398, 9197.0, 5607.691576963265, 5746.913796293059, 5752.252207213078, 5766.077427611562, 5772.8845423091725, 3472.5138480612736, 3534.151803567151, 3586.605473397924, 3667.0, 3671.284099600579, 1212.563477148226, 1224.9632511024683, 1226.4542278685988, 2316.455632926261, 2372.905083796646, 13618.727625447436, 13744.106633068819, 13771.586852394545, 13771.862281377258, 13772.586822395244, 4792.7363994980615, 4905.607551395879, 4941.555260026615, 4953.702777833341, 4997.550220480101, 10423.270371073952, 10541.472926353652, 10545.789084218273, 10569.365838049587, 10574.841377379345, 5079.339685840817, 5711.942880571224, 5755.510781583528, 5755.913661295084, 5760.683162426023, 5236.9738151309, 5312.495312945264, 5336.573074154058, 5380.1929710542945, 5391.16436952273, 4160.1471698301775, 4191.224623444673, 4211.642010429086, 4230.471191101113, 4283.528811830696, 1238.238483332762, 1259.8456639147162, 1260.8928241099609, 1275.67470295076, 1277.5911708253454, 920.8572671235969, 969.5879251318162, 991.7718924647371, 1082.3992684060422, 1083.712816103733, 6669.599824010478, 6701.765438209737, 6705.396514313735, 6749.6962636681465, 6794.45644348451, 1025.4923812712755, 1047.7328281288223, 1051.2115913065202, 1057.8571892794528, 1076.8600081989448, 4535.274356103007, 4685.765711714401, 4686.81252749893, 4704.717716936994, 4723.291506274018, 11767.293962362286, 11993.940030299967, 12054.337011464278, 12092.818607720892, 12141.575044873387, 11315.377654228932, 11898.881011189951, 12001.339926304137, 12017.098717596215, 12018.15872888907, 8665.480071195623, 9047.81904361909, 9048.638054477879, 9093.0, 9103.863442048374, 6614.900776488453, 6803.217629972616, 6829.0, 6851.486138539729, 6877.3810357068105, 10693.0, 10941.507632156412, 10964.28732132409, 11021.228514003942, 11148.331100134017, 10948.288361256493, 11129.387883666475, 11163.274387164809, 11284.153688473561, 11316.717082073013, 7607.23927607257, 8297.377696672653, 8501.19238672325, 8543.231109200202, 8697.043325234092, 9359.157675808938, 9359.485228312507, 9397.624095036123, 9450.858237126586, 9452.810943781224, 8378.078411374621, 8505.617247223767, 8571.785705357166, 8650.048494665456, 8681.348898832486, 7639.159692433939, 7891.487053341514, 8232.917670823455, 8273.669053237803, 8569.228769410784, 7616.428767842544, 7732.652030658522, 7739.574323412041, 7747.18654541265, 7750.186230445722, 5529.474699903502, 5535.446455354432, 5573.16402539606, 5604.187392828098, 5633.464820842013, 5560.360558535658, 5578.748956296895, 5594.636348637326, 5636.971815140898, 5637.859053523531], "value": 5017.430689621896, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.8991387454575, 357.460235045082, 358.48915295703614, 361.99457008144884, 362.25556481430647, 5423.810166644168, 5519.75805443776, 5520.144377621465, 5534.667919924802, 5568.303962004749, 5413.53984911283, 5435.347758269013, 5440.591955603326, 5446.428125046872, 5473.863153421166, 3853.9229215415676, 4039.4142849286836, 4257.7445353278745, 4283.485981682203, 4308.246056940038, 4232.174725928445, 4267.935980960273, 4282.657387409015, 4285.442892423996, 4309.396684464177, 4077.3272410052455, 4248.490181178247, 4248.766317852517, 4251.80866860992, 4296.419983302246, 4176.770277634729, 4227.640650544708, 4258.510271318807, 4263.59495847894, 4266.743995360288, 3796.924061518782, 3814.9809250953845, 3820.9683385485764, 3829.7893615851117, 3832.693384529231, 5222.582193424517, 5227.3465816772905, 5251.789928402859, 5257.211418287249, 5280.0, 4894.657373983822, 4898.706077635354, 4929.285253638238, 4944.975275123601, 4969.962315450684, 5485.35439368188, 5611.242482264883, 5666.546676265889, 5758.884822303572, 5769.855753606152, 4068.471098757172, 4152.252594532983, 4158.064435502018, 4186.476690413699, 4193.6645068394455, 5725.227094342252, 5871.588988770745, 5878.5297176225795, 5880.617759845596, 5894.204282421861, 4107.383892416162, 4237.512686041083, 4258.510271318776, 4265.1469706058915, 4280.507741609693, 4294.935575966363, 4311.245532031882, 4322.978385108055, 4338.392625032498, 4338.436003319548, 4876.8780780480065, 4889.877753056131, 4905.190643543775, 4908.680935739166, 4911.361523002059, 5483.725813709299, 5695.202671625976, 5712.971435142881, 5725.570582206351, 5726.570507211975, 1484.398818478518, 1497.7903093566908, 1503.669192777587, 1505.8569435903792, 1508.2081906998912, 968.6077138758814, 979.1579241852002, 985.610683779903, 993.5975929748463, 1001.9899801002042, 4925.1381008324115, 4928.285398617252, 4978.352814134139, 4997.30037794709, 5000.67495612784, 5200.817971370984, 5210.0, 5211.5830733541225, 5229.712365819841, 5252.29094072303, 4978.950210497921, 5024.949750502521, 5035.690720412719, 5308.389535203424, 5726.627769195073, 3110.6889311069162, 3154.8580313885473, 3166.841657917095, 3166.9074169411515, 3175.6506784253716, 6124.601900876429, 6127.253732686163, 6189.721462534197, 6202.596831206048, 6220.253569571681, 5682.943170568324, 5980.760769569256, 6000.369961154016, 6002.969985150046, 6020.488258498077, 5838.941610583925, 5974.312954010345, 6057.60625559346, 6090.421409966046, 6143.692815359214, 5849.034909239927, 5895.616784908967, 5896.262967129109, 5917.260342457193, 5944.673042982505, 5782.884342313214, 5799.333076696234, 5815.79644712433, 5817.505512031525, 5849.181114644039, 5921.348651648229, 6120.020796672511, 6159.96920015415, 6184.0, 6204.821083994208, 4304.311310190355, 4364.5635436456105, 4381.452318460192, 4387.539308372702, 4409.7795110245, 5818.389069147678, 5863.237779088691, 5894.70526473666, 5959.0, 5988.251468566429, 5722.5135863450405, 5723.084306510938, 5746.454086861741, 5747.453991870766, 5769.07694768835, 5690.378242200953, 5703.543716502752, 5732.398098199629, 5746.367899530965, 5760.6255593386295, 5427.972860135674, 5583.274174357308, 5620.960122377373, 5634.661920284796, 5656.632318899258, 5719.685417302088, 5733.713314334183, 5739.167820666064, 5751.223584815996, 5774.971125144348, 5385.192221166856, 5646.209530665792, 5666.206731057573, 5673.751774609579, 5685.545156387397], "value": 4360.314785028587, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [857.09148302799, 874.2743522876013, 874.763813770282, 890.6927110147001, 924.4037595750739, 15312.770308445368, 16804.159792010396, 17201.569960750956, 17260.395886143986, 17277.30890764368, 15611.219439028031, 15931.20343982802, 16079.11564863932, 16082.437114700959, 16120.274587643555, 755.2447552447552, 885.716570697377, 900.5632268349846, 903.7288813356, 905.7237542549519, 868.8609822428413, 889.6130183370223, 896.6144557840158, 907.7412937312868, 910.544727636182, 957.8658987741721, 959.3716115944032, 959.8512230604267, 963.8120566489538, 964.28642804325, 788.6017561131649, 933.0, 958.3866325551618, 960.1214888377126, 960.2749923807551, 701.6982697440098, 707.1337611426013, 707.2962402409584, 707.3421717802441, 708.1042481261209, 15034.398624055135, 15187.164705941279, 15203.771943420857, 15206.16366099864, 15218.086914785148, 15563.766543501857, 15893.125878076702, 16013.0, 16115.919420402823, 16152.950058246177, 13747.312634368342, 13926.234057126854, 14006.22965736884, 14101.0, 14146.221957792317, 4670.859874203779, 4675.929861052087, 4731.621470282404, 4768.0463907218345, 4881.438634557036, 79172.0, 81738.0, 82028.76956845712, 82101.17898820995, 82111.0, 12244.326562039174, 12381.319027453397, 12390.194637348544, 12792.0, 12805.935970320275, 23558.293251202493, 23621.29136125919, 23635.054597815895, 23699.0, 23781.762182377955, 9105.408148470327, 9140.360174787702, 9240.122188392092, 9263.351565390358, 9373.062693730708, 5099.719515426687, 5105.693658380509, 5107.412647545506, 5113.360829896263, 5265.4997775211295, 3658.0, 3789.829457674411, 3792.1278106035215, 3793.260314238752, 3794.051487128218, 653.6372313366032, 660.5079215984123, 663.5156335874839, 664.7706541243264, 671.3353779758102, 686.8969654551858, 705.5731282574071, 707.773512476013, 763.4007304266124, 820.2904487618167, 10026.598936042623, 10135.341202821794, 10220.284580079324, 10245.948770256251, 10319.0, 655.0763423572739, 782.9021372328459, 794.1978601612414, 813.2274339377615, 816.0, 5116.488351164928, 5184.307229961266, 5296.311479507639, 5481.0, 5516.475934786189, 72102.0, 116819.41590292164, 117188.0, 120273.0, 122661.0, 97879.0, 101052.0, 103340.0, 103693.0, 104338.0, 92023.99999999866, 92025.0, 92997.0, 95098.0, 96726.51636741772, 9983.750406239902, 10110.443925584164, 10201.54093065799, 10201.582798267704, 10207.183425326104, 53105.46894531005, 53268.73365633147, 53381.733091334296, 54184.45815541794, 55036.174457383975, 64932.0, 65247.34752652413, 66223.33776662171, 71928.64035679789, 72860.35698214962, 14113.788293175405, 14129.929350353594, 14360.210188439736, 14492.855071449572, 14826.332815023134, 15115.0, 15276.694466110393, 15789.0, 16119.838801611833, 16128.193590320203, 10658.0, 13617.114887532278, 14764.852351476347, 15769.211539423213, 15820.762688559911, 14466.927665362027, 14645.0, 14698.706025879637, 14904.105753654381, 15011.0, 14247.358868850719, 14429.711405772036, 14887.553373398816, 14944.476943306932, 15454.304556294768, 11573.18987670855, 11966.22219555726, 12104.45529951172, 12129.0, 12372.505099795908, 12758.808617870554, 12883.48466061347, 12963.805542917053, 13057.934710326388, 13063.804042939553], "value": 8171.075742399586, "unit": "score"}], "name": "dromaeo_css", "value": 7702.047637661776, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 109.0, 111.0, 109.0, 110.0, 112.0, 110.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 131.0, 145.0, 172.0, 125.0, 126.0, 153.0, 123.0, 184.0, 130.0], "value": 144.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 160.0, 161.0, 160.0, 160.0, 160.0, 162.0, 160.0, 159.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 120.0, 74.0, 74.0, 76.0, 74.0, 96.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 115.0, 85.0, 85.0, 85.0, 110.0, 84.0, 84.0, 126.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 147.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 54.0, 50.0, 52.0, 51.0, 52.0, 51.0, 50.0, 50.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 62.0, 60.0, 61.0, 61.0, 62.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 76.0, 75.0, 77.0, 83.0, 76.0, 111.0, 76.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 131.0, 124.0, 125.0, 125.0, 123.0, 125.0, 121.0, 128.0, 117.0], "value": 123.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 162.0, 157.0, 153.0, 155.0, 155.0, 156.0, 154.0, 155.0, 157.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 62.0, 63.0, 61.0, 66.0, 61.0, 61.0, 60.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1481.8000000000002, "alertThreshold": 2.0}]} 03:44:22 INFO - Return code: 0 03:44:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:44:22 ERROR - # TBPL SUCCESS # 03:44:22 INFO - Running post-action listener: _resource_record_post_action 03:44:22 INFO - ##### 03:44:22 INFO - ##### Finished run-tests step (success) 03:44:22 INFO - ##### 03:44:22 INFO - Running post-run listener: _resource_record_post_run 03:44:22 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 7925760; Write bytes: 455811072; Read time: 1792; Write time: 335628 03:44:22 INFO - TinderboxPrint: CPU usage
13.0% 03:44:22 INFO - TinderboxPrint: I/O read bytes / time
7,925,760 / 1,792 03:44:22 INFO - TinderboxPrint: I/O write bytes / time
455,811,072 / 335,628 03:44:22 INFO - TinderboxPrint: CPU idle
8,264.8 (86.9%) 03:44:22 INFO - TinderboxPrint: CPU user
1,196.6 (12.6%) 03:44:22 INFO - TinderboxPrint: Swap in / out
0 / 0 03:44:22 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 79278080; Read time: 0; Write time: 42240 03:44:22 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 6160384; Write bytes: 310435840; Read time: 1528; Write time: 238120 03:44:23 INFO - Running post-run listener: _upload_blobber_files 03:44:23 INFO - Blob upload gear active. 03:44:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:44:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:44:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:44:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:44:23 INFO - (blobuploader) - INFO - Open directory for files ... 03:44:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:44:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:44:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:24 INFO - (blobuploader) - INFO - Done attempting. 03:44:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:44:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:44:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:28 INFO - (blobuploader) - INFO - Done attempting. 03:44:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:44:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:44:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:29 INFO - (blobuploader) - INFO - Done attempting. 03:44:29 INFO - (blobuploader) - INFO - Iteration through files over. 03:44:29 INFO - Return code: 0 03:44:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:44:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:44:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/74a3159ba530c95bc677cbc96235c4f8ca4ec0d0fca8a88c0f09544197c562f462a6f3bf5d6c46806237ea5c7d2c5d88886a34820c1f00ffc34170c74c881ac0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2e6258ae58027dc28b0fa4fa78e6e13cdd4d32874e4a001c12303dc63176465d63be44bea6fe0fd4cdb6335aa0cdccd32ab4ab46d01b0fd8a21ec0c8d72cff1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ab64af1d01166695b864eaf740a6707cd0eabb8b128454fabe86f5f2177e7bd7743686f9574b328913cf571fecef9e8c2be1f960d7d7d823c0faf566d32071a"} 03:44:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:44:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:44:29 INFO - Contents: 03:44:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/74a3159ba530c95bc677cbc96235c4f8ca4ec0d0fca8a88c0f09544197c562f462a6f3bf5d6c46806237ea5c7d2c5d88886a34820c1f00ffc34170c74c881ac0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2e6258ae58027dc28b0fa4fa78e6e13cdd4d32874e4a001c12303dc63176465d63be44bea6fe0fd4cdb6335aa0cdccd32ab4ab46d01b0fd8a21ec0c8d72cff1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ab64af1d01166695b864eaf740a6707cd0eabb8b128454fabe86f5f2177e7bd7743686f9574b328913cf571fecef9e8c2be1f960d7d7d823c0faf566d32071a"} 03:44:29 INFO - Running post-run listener: copy_logs_to_upload_dir 03:44:29 INFO - Copying logs to upload dir... 03:44:29 INFO - mkdir: /builds/slave/test/build/upload/logs 03:44:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.210252 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-11 03:44:29.101555) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-11 03:44:29.104980) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750 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/74a3159ba530c95bc677cbc96235c4f8ca4ec0d0fca8a88c0f09544197c562f462a6f3bf5d6c46806237ea5c7d2c5d88886a34820c1f00ffc34170c74c881ac0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2e6258ae58027dc28b0fa4fa78e6e13cdd4d32874e4a001c12303dc63176465d63be44bea6fe0fd4cdb6335aa0cdccd32ab4ab46d01b0fd8a21ec0c8d72cff1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ab64af1d01166695b864eaf740a6707cd0eabb8b128454fabe86f5f2177e7bd7743686f9574b328913cf571fecef9e8c2be1f960d7d7d823c0faf566d32071a"} build_url:https://queue.taskcluster.net/v1/task/P7PvFMPtTRuF9CgWzWod5g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011068 build_url: 'https://queue.taskcluster.net/v1/task/P7PvFMPtTRuF9CgWzWod5g/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/74a3159ba530c95bc677cbc96235c4f8ca4ec0d0fca8a88c0f09544197c562f462a6f3bf5d6c46806237ea5c7d2c5d88886a34820c1f00ffc34170c74c881ac0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2e6258ae58027dc28b0fa4fa78e6e13cdd4d32874e4a001c12303dc63176465d63be44bea6fe0fd4cdb6335aa0cdccd32ab4ab46d01b0fd8a21ec0c8d72cff1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ab64af1d01166695b864eaf740a6707cd0eabb8b128454fabe86f5f2177e7bd7743686f9574b328913cf571fecef9e8c2be1f960d7d7d823c0faf566d32071a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-11 03:44:29.130637) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 03:44:29.130969) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1465638093.61714-1504712750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 03:44:29.211879) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-11 03:44:29.212199) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-11 03:44:29.212492) ========= ========= Total master_lag: 0.15 =========