builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1468664819.98 results: success (0) buildid: 20160716005252 builduid: 61b91706ac42454eae968a14d7043a74 revision: 1c72f075dd79e2f4013909681c7541d4e2275345 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 03:26:59.982780) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 03:26:59.983532) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 03:26:59.983848) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 03:26:59.998819) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:26:59.999120) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-16 03:26:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2016-07-16 03:27:00 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113117 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:27:00.126654) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:27:00.126992) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014229 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:27:00.177087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:27:00.177480) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1c72f075dd79e2f4013909681c7541d4e2275345 --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 1c72f075dd79e2f4013909681c7541d4e2275345 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-16 03:27:00,220 truncating revision to first 12 chars 2016-07-16 03:27:00,220 Setting DEBUG logging. 2016-07-16 03:27:00,221 attempt 1/10 2016-07-16 03:27:00,221 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1c72f075dd79?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 03:27:00,675 unpacking tar archive at: mozilla-aurora-1c72f075dd79/testing/mozharness/ program finished with exit code 0 elapsedTime=0.808133 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:27:00.999291) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 03:27:00.999615) ========= script_repo_revision: 1c72f075dd79e2f4013909681c7541d4e2275345 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 03:27:01.000022) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 03:27:01.000325) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 03:27:01.011123) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-16 03:27:01.011447) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:27:01 INFO - MultiFileLogger online at 20160716 03:27:01 in /builds/slave/test 03:27:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:27:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:27:01 INFO - {'append_to_log': False, 03:27:01 INFO - 'base_work_dir': '/builds/slave/test', 03:27:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:27:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:27:01 INFO - 'branch': 'Mozilla-Aurora', 03:27:01 INFO - 'buildbot_json_path': 'buildprops.json', 03:27:01 INFO - 'config_files': ('talos/linux_config.py',), 03:27:01 INFO - 'default_actions': ('clobber', 03:27:01 INFO - 'read-buildbot-config', 03:27:01 INFO - 'download-and-extract', 03:27:01 INFO - 'populate-webroot', 03:27:01 INFO - 'create-virtualenv', 03:27:01 INFO - 'install', 03:27:01 INFO - 'run-tests'), 03:27:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:27:01 INFO - 'download_minidump_stackwalk': True, 03:27:01 INFO - 'download_symbols': 'ondemand', 03:27:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:27:01 INFO - 'tooltool.py': '/tools/tooltool.py', 03:27:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:27:01 INFO - '/tools/misc-python/virtualenv.py')}, 03:27:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:27:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:27:01 INFO - 'installer_path': 'installer.exe', 03:27:01 INFO - 'log_level': 'info', 03:27:01 INFO - 'log_name': 'talos', 03:27:01 INFO - 'log_to_console': True, 03:27:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:27:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:27:01 INFO - 'opt_config_files': (), 03:27:01 INFO - 'pip_index': False, 03:27:01 INFO - 'sps_profile': False, 03:27:01 INFO - 'sps_profile_interval': 0, 03:27:01 INFO - 'suite': 'dromaeojs', 03:27:01 INFO - 'system_bits': '32', 03:27:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:27:01 INFO - 'title': 'talos-linux64-ix-018', 03:27:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:27:01 INFO - 'use_talos_json': True, 03:27:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:27:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:27:01 INFO - 'work_dir': 'build'} 03:27:01 INFO - ##### 03:27:01 INFO - ##### Running clobber step. 03:27:01 INFO - ##### 03:27:01 INFO - Running pre-action listener: _resource_record_pre_action 03:27:01 INFO - Running main action method: clobber 03:27:01 INFO - rmtree: /builds/slave/test/build 03:27:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:27:01 INFO - Running post-action listener: _resource_record_post_action 03:27:01 INFO - ##### 03:27:01 INFO - ##### Finished clobber step (success) 03:27:01 INFO - ##### 03:27:01 INFO - ##### 03:27:01 INFO - ##### Running read-buildbot-config step. 03:27:01 INFO - ##### 03:27:01 INFO - Running pre-action listener: _resource_record_pre_action 03:27:01 INFO - Running main action method: read_buildbot_config 03:27:01 INFO - Using buildbot properties: 03:27:01 INFO - { 03:27:01 INFO - "project": "", 03:27:01 INFO - "product": "firefox", 03:27:01 INFO - "script_repo_revision": "production", 03:27:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:27:01 INFO - "repository": "", 03:27:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:27:01 INFO - "buildid": "20160716005252", 03:27:01 INFO - "pgo_build": "True", 03:27:01 INFO - "basedir": "/builds/slave/test", 03:27:01 INFO - "buildnumber": 611, 03:27:01 INFO - "slavename": "talos-linux64-ix-018", 03:27:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:27:01 INFO - "platform": "ubuntu64_hw", 03:27:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:27:01 INFO - "branch": "mozilla-aurora", 03:27:01 INFO - "repo_path": "releases/mozilla-aurora", 03:27:01 INFO - "revision": "1c72f075dd79e2f4013909681c7541d4e2275345", 03:27:01 INFO - "stage_platform": "linux64-pgo", 03:27:01 INFO - "builduid": "61b91706ac42454eae968a14d7043a74", 03:27:01 INFO - "slavebuilddir": "test" 03:27:01 INFO - } 03:27:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:27:01 INFO - Running post-action listener: _resource_record_post_action 03:27:01 INFO - ##### 03:27:01 INFO - ##### Finished read-buildbot-config step (success) 03:27:01 INFO - ##### 03:27:01 INFO - ##### 03:27:01 INFO - ##### Running download-and-extract step. 03:27:01 INFO - ##### 03:27:01 INFO - Running pre-action listener: _resource_record_pre_action 03:27:01 INFO - Running main action method: download_and_extract 03:27:01 INFO - mkdir: /builds/slave/test/build/tests 03:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:01 INFO - https://queue.taskcluster.net/v1/task/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:27:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:27:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:27:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/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:27:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/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:27:07 INFO - Downloaded 1361 bytes. 03:27:07 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:27:07 INFO - Using the following test package requirements: 03:27:07 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:27:07 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:27:07 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:27:07 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:07 INFO - u'jsshell-linux-x86_64.zip'], 03:27:07 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:27:07 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:27:07 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:27:07 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:27:07 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:27:07 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:07 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:27:07 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:07 INFO - https://queue.taskcluster.net/v1/task/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:27:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:27:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:27:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/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:27:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/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:27:12 INFO - Downloaded 24490637 bytes. 03:27:12 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:27:12 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:27:14 INFO - Return code: 0 03:27:14 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:27:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:14 INFO - https://queue.taskcluster.net/v1/task/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:27:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:27:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:27:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/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:27:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/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:27:15 INFO - Downloaded 24490637 bytes. 03:27:15 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:27:15 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:27:16 INFO - Return code: 0 03:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:16 INFO - https://queue.taskcluster.net/v1/task/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:27:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:27:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:27:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/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:27:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/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:27:17 INFO - Downloaded 10833369 bytes. 03:27:17 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:27:17 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:27:17 INFO - Return code: 0 03:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:17 INFO - https://queue.taskcluster.net/v1/task/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:27:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:27:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:27:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/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:27:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eFGRkjuwRaGS5pPd7c8ACA/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:27:19 INFO - Downloaded 63640587 bytes. 03:27:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:27:19 INFO - mkdir: /builds/slave/test/properties 03:27:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:27:19 INFO - Writing to file /builds/slave/test/properties/build_url 03:27:19 INFO - Contents: 03:27:19 INFO - build_url:https://queue.taskcluster.net/v1/task/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:27:19 INFO - Running post-action listener: _resource_record_post_action 03:27:19 INFO - Running post-action listener: set_extra_try_arguments 03:27:19 INFO - ##### 03:27:19 INFO - ##### Finished download-and-extract step (success) 03:27:19 INFO - ##### 03:27:19 INFO - ##### 03:27:19 INFO - ##### Running populate-webroot step. 03:27:19 INFO - ##### 03:27:19 INFO - Running pre-action listener: _resource_record_pre_action 03:27:19 INFO - Running main action method: populate_webroot 03:27:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:27:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:27:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:27:19 INFO - '--tppagecycles', 03:27:19 INFO - '7'], 03:27:19 INFO - 'tests': ['tsvgm']}}, 03:27:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:27:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:27:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:27:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:27:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:27:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:27:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:19 INFO - 'talos_options': ['--disable-e10s'], 03:27:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:27:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:27:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:19 INFO - 'talos_options': ['--disable-e10s'], 03:27:19 INFO - 'tests': ['damp', 'tps']}, 03:27:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:19 INFO - 'tests': ['damp', 'tps']}, 03:27:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:27:19 INFO - 'tests': ['dromaeo_dom']}, 03:27:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:27:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:27:19 INFO - 'tests': ['a11yr', 03:27:19 INFO - 'ts_paint', 03:27:19 INFO - 'tpaint', 03:27:19 INFO - 'sessionrestore', 03:27:19 INFO - 'sessionrestore_no_auto_restore', 03:27:19 INFO - 'tabpaint']}, 03:27:19 INFO - 'other-e10s': {'tests': ['a11yr', 03:27:19 INFO - 'ts_paint', 03:27:19 INFO - 'tpaint', 03:27:19 INFO - 'sessionrestore', 03:27:19 INFO - 'sessionrestore_no_auto_restore', 03:27:19 INFO - 'tabpaint']}, 03:27:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:27:19 INFO - 'ts_paint', 03:27:19 INFO - 'tpaint', 03:27:19 INFO - 'sessionrestore', 03:27:19 INFO - 'sessionrestore_no_auto_restore', 03:27:19 INFO - 'tabpaint']}, 03:27:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:27:19 INFO - 'ts_paint', 03:27:19 INFO - 'tpaint', 03:27:19 INFO - 'sessionrestore', 03:27:19 INFO - 'sessionrestore_no_auto_restore', 03:27:19 INFO - 'tabpaint']}, 03:27:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:27:19 INFO - 'tests': ['a11yr', 03:27:19 INFO - 'ts_paint', 03:27:19 INFO - 'tpaint', 03:27:19 INFO - 'sessionrestore', 03:27:19 INFO - 'sessionrestore_no_auto_restore', 03:27:19 INFO - 'tabpaint']}, 03:27:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:27:19 INFO - 'tests': ['a11yr', 03:27:19 INFO - 'ts_paint', 03:27:19 INFO - 'tpaint', 03:27:19 INFO - 'sessionrestore', 03:27:19 INFO - 'sessionrestore_no_auto_restore', 03:27:19 INFO - 'tabpaint']}, 03:27:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:27:19 INFO - 'tests': ['tsvgx', 03:27:19 INFO - 'tsvgr_opacity', 03:27:19 INFO - 'tart', 03:27:19 INFO - 'tscrollx', 03:27:19 INFO - 'cart']}, 03:27:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:27:19 INFO - 'tsvgr_opacity', 03:27:19 INFO - 'tart', 03:27:19 INFO - 'tscrollx', 03:27:19 INFO - 'cart']}, 03:27:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:19 INFO - 'talos_options': ['--disable-e10s'], 03:27:19 INFO - 'tests': ['tp5o']}, 03:27:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:19 INFO - 'tests': ['tp5o']}, 03:27:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:19 INFO - 'talos_options': ['--disable-e10s', 03:27:19 INFO - '--xperf_path', 03:27:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:27:19 INFO - 'tests': ['tp5n']}, 03:27:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:19 INFO - 'talos_options': ['--xperf_path', 03:27:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:27:19 INFO - 'tests': ['tp5n']}}, 03:27:19 INFO - 'talos.zip': {'path': '', 03:27:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:27:19 INFO - Running post-action listener: _resource_record_post_action 03:27:19 INFO - ##### 03:27:19 INFO - ##### Finished populate-webroot step (success) 03:27:19 INFO - ##### 03:27:19 INFO - ##### 03:27:19 INFO - ##### Running create-virtualenv step. 03:27:19 INFO - ##### 03:27:19 INFO - Running pre-action listener: _resource_record_pre_action 03:27:19 INFO - Running main action method: create_virtualenv 03:27:19 INFO - Creating virtualenv /builds/slave/test/build/venv 03:27:19 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:27:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:27:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:27:19 INFO - Using real prefix '/usr' 03:27:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:27:20 INFO - Installing distribute.............................................................................................................................................................................................done. 03:27:22 INFO - Installing pip.................done. 03:27:22 INFO - Return code: 0 03:27:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:27: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:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa22e5b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259e2e0>, '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 0x250a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', '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:27:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:27:22 INFO - Using env: {'DISPLAY': ':0', 03:27:22 INFO - 'HOME': '/home/cltbld', 03:27:22 INFO - 'LANG': 'en_US.UTF-8', 03:27:22 INFO - 'LANGUAGE': 'en_US:en', 03:27:22 INFO - 'LOGNAME': 'cltbld', 03:27:22 INFO - 'MAIL': '/var/mail/cltbld', 03:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:22 INFO - 'MOZ_NO_REMOTE': '1', 03:27:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:22 INFO - 'NO_EM_RESTART': '1', 03:27:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:22 INFO - 'PWD': '/builds/slave/test', 03:27:22 INFO - 'SHELL': '/bin/bash', 03:27:22 INFO - 'SHLVL': '1', 03:27:22 INFO - 'TERM': 'linux', 03:27:22 INFO - 'TMOUT': '86400', 03:27:22 INFO - 'USER': 'cltbld', 03:27:22 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', 03:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:22 INFO - '_': '/tools/buildbot/bin/python'} 03:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:22 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:27:22 INFO - Cleaning up... 03:27:22 INFO - Return code: 0 03:27:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:27: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:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa22e5b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259e2e0>, '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 0x250a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', '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:27:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:27:22 INFO - Using env: {'DISPLAY': ':0', 03:27:22 INFO - 'HOME': '/home/cltbld', 03:27:22 INFO - 'LANG': 'en_US.UTF-8', 03:27:22 INFO - 'LANGUAGE': 'en_US:en', 03:27:22 INFO - 'LOGNAME': 'cltbld', 03:27:22 INFO - 'MAIL': '/var/mail/cltbld', 03:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:22 INFO - 'MOZ_NO_REMOTE': '1', 03:27:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:22 INFO - 'NO_EM_RESTART': '1', 03:27:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:22 INFO - 'PWD': '/builds/slave/test', 03:27:22 INFO - 'SHELL': '/bin/bash', 03:27:22 INFO - 'SHLVL': '1', 03:27:22 INFO - 'TERM': 'linux', 03:27:22 INFO - 'TMOUT': '86400', 03:27:22 INFO - 'USER': 'cltbld', 03:27:22 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', 03:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:22 INFO - '_': '/tools/buildbot/bin/python'} 03:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:22 INFO - Downloading/unpacking psutil>=3.1.1 03:27:22 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:27:22 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:27:22 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:27:22 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:27:22 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:27:22 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:27:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:27:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:25 INFO - Installing collected packages: psutil 03:27:25 INFO - Running setup.py install for psutil 03:27:25 INFO - building 'psutil._psutil_linux' extension 03:27:25 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:27:25 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:27:25 INFO - building 'psutil._psutil_posix' extension 03:27:25 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:27:26 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:27:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:26 INFO - Successfully installed psutil 03:27:26 INFO - Cleaning up... 03:27:26 INFO - Return code: 0 03:27:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:27: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:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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:27:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa22e5b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259e2e0>, '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 0x250a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', '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:27: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:27: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 mozsystemmonitor==0.3 03:27:26 INFO - Using env: {'DISPLAY': ':0', 03:27:26 INFO - 'HOME': '/home/cltbld', 03:27:26 INFO - 'LANG': 'en_US.UTF-8', 03:27:26 INFO - 'LANGUAGE': 'en_US:en', 03:27:26 INFO - 'LOGNAME': 'cltbld', 03:27:26 INFO - 'MAIL': '/var/mail/cltbld', 03:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:26 INFO - 'MOZ_NO_REMOTE': '1', 03:27:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:26 INFO - 'NO_EM_RESTART': '1', 03:27:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:26 INFO - 'PWD': '/builds/slave/test', 03:27:26 INFO - 'SHELL': '/bin/bash', 03:27:26 INFO - 'SHLVL': '1', 03:27:26 INFO - 'TERM': 'linux', 03:27:26 INFO - 'TMOUT': '86400', 03:27:26 INFO - 'USER': 'cltbld', 03:27:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', 03:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:26 INFO - '_': '/tools/buildbot/bin/python'} 03:27:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:27: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:27: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:27: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:27: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:27: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:27: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:27:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:27:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:27:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:27:28 INFO - Installing collected packages: mozsystemmonitor 03:27:28 INFO - Running setup.py install for mozsystemmonitor 03:27:28 INFO - Successfully installed mozsystemmonitor 03:27:28 INFO - Cleaning up... 03:27:28 INFO - Return code: 0 03:27:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:27:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:28 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 0x7fa22e5b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259e2e0>, '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 0x250a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', '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:27:28 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:27:28 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:27:28 INFO - Using env: {'DISPLAY': ':0', 03:27:28 INFO - 'HOME': '/home/cltbld', 03:27:28 INFO - 'LANG': 'en_US.UTF-8', 03:27:28 INFO - 'LANGUAGE': 'en_US:en', 03:27:28 INFO - 'LOGNAME': 'cltbld', 03:27:28 INFO - 'MAIL': '/var/mail/cltbld', 03:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:28 INFO - 'MOZ_NO_REMOTE': '1', 03:27:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:28 INFO - 'NO_EM_RESTART': '1', 03:27:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:28 INFO - 'PWD': '/builds/slave/test', 03:27:28 INFO - 'SHELL': '/bin/bash', 03:27:28 INFO - 'SHLVL': '1', 03:27:28 INFO - 'TERM': 'linux', 03:27:28 INFO - 'TMOUT': '86400', 03:27:28 INFO - 'USER': 'cltbld', 03:27:28 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', 03:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:28 INFO - '_': '/tools/buildbot/bin/python'} 03:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:28 INFO - Downloading/unpacking jsonschema==2.5.1 03:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:27:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:27: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:27: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:27: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:27: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:27: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:27: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:27:30 INFO - Downloading functools32-3.2.3-2.tar.gz 03:27:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:27:30 INFO - warning: no files found matching '*.txt' 03:27:30 INFO - no previously-included directories found matching 'build' 03:27:30 INFO - no previously-included directories found matching 'dist' 03:27:30 INFO - no previously-included directories found matching '.git*' 03:27:30 INFO - Installing collected packages: jsonschema, functools32 03:27:31 INFO - Running setup.py install for functools32 03:27:31 INFO - warning: no files found matching '*.txt' 03:27:31 INFO - no previously-included directories found matching 'build' 03:27:31 INFO - no previously-included directories found matching 'dist' 03:27:31 INFO - no previously-included directories found matching '.git*' 03:27:31 INFO - Successfully installed jsonschema functools32 03:27:31 INFO - Cleaning up... 03:27:31 INFO - Return code: 0 03:27:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:31 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 0x7fa22e5b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259e2e0>, '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 0x250a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', '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:27:31 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:27:31 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:27:31 INFO - Using env: {'DISPLAY': ':0', 03:27:31 INFO - 'HOME': '/home/cltbld', 03:27:31 INFO - 'LANG': 'en_US.UTF-8', 03:27:31 INFO - 'LANGUAGE': 'en_US:en', 03:27:31 INFO - 'LOGNAME': 'cltbld', 03:27:31 INFO - 'MAIL': '/var/mail/cltbld', 03:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:31 INFO - 'MOZ_NO_REMOTE': '1', 03:27:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:31 INFO - 'NO_EM_RESTART': '1', 03:27:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:31 INFO - 'PWD': '/builds/slave/test', 03:27:31 INFO - 'SHELL': '/bin/bash', 03:27:31 INFO - 'SHLVL': '1', 03:27:31 INFO - 'TERM': 'linux', 03:27:31 INFO - 'TMOUT': '86400', 03:27:31 INFO - 'USER': 'cltbld', 03:27:31 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', 03:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:31 INFO - '_': '/tools/buildbot/bin/python'} 03:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:31 INFO - Downloading/unpacking blobuploader==1.2.4 03:27:31 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:27:31 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:27:31 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:27:31 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:27:31 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:27:31 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:27:33 INFO - Downloading blobuploader-1.2.4.tar.gz 03:27:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:27:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:27:33 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:27:33 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:27:33 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:27:33 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:27:33 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:27:33 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:27:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:27:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:27:33 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:27:33 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:27:33 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:27:33 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:27:33 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:27:33 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:27:33 INFO - Downloading docopt-0.6.1.tar.gz 03:27:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:27:34 INFO - Installing collected packages: blobuploader, requests, docopt 03:27:34 INFO - Running setup.py install for blobuploader 03:27:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:27:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:27:34 INFO - Running setup.py install for requests 03:27:34 INFO - Running setup.py install for docopt 03:27:34 INFO - Successfully installed blobuploader requests docopt 03:27:34 INFO - Cleaning up... 03:27:34 INFO - Return code: 0 03:27:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:34 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 0x7fa22e5b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259e2e0>, '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 0x250a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', '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:27:34 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:27:34 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:27:34 INFO - Using env: {'DISPLAY': ':0', 03:27:34 INFO - 'HOME': '/home/cltbld', 03:27:34 INFO - 'LANG': 'en_US.UTF-8', 03:27:34 INFO - 'LANGUAGE': 'en_US:en', 03:27:34 INFO - 'LOGNAME': 'cltbld', 03:27:34 INFO - 'MAIL': '/var/mail/cltbld', 03:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:34 INFO - 'MOZ_NO_REMOTE': '1', 03:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:34 INFO - 'NO_EM_RESTART': '1', 03:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:34 INFO - 'PWD': '/builds/slave/test', 03:27:34 INFO - 'SHELL': '/bin/bash', 03:27:34 INFO - 'SHLVL': '1', 03:27:34 INFO - 'TERM': 'linux', 03:27:34 INFO - 'TMOUT': '86400', 03:27:34 INFO - 'USER': 'cltbld', 03:27:34 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', 03:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:34 INFO - '_': '/tools/buildbot/bin/python'} 03:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:34 INFO - Running setup.py (path:/tmp/pip-JtI9b1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:34 INFO - Running setup.py (path:/tmp/pip-6F1_UW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:35 INFO - Running setup.py (path:/tmp/pip-rZUFHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:35 INFO - Running setup.py (path:/tmp/pip-0EROG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:35 INFO - Running setup.py (path:/tmp/pip-ShtQi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:35 INFO - Running setup.py (path:/tmp/pip-Wgm8Wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:35 INFO - Running setup.py (path:/tmp/pip-Yjf7KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:35 INFO - Running setup.py (path:/tmp/pip-naV_rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:35 INFO - Running setup.py (path:/tmp/pip-ztFnRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:35 INFO - Running setup.py (path:/tmp/pip-QKRdhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:35 INFO - Running setup.py (path:/tmp/pip-JXEmCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:35 INFO - Running setup.py (path:/tmp/pip-7ApfaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:35 INFO - Running setup.py (path:/tmp/pip-SwOiRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:35 INFO - Running setup.py (path:/tmp/pip-iSpPtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:35 INFO - Running setup.py (path:/tmp/pip-yVfovk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:35 INFO - Running setup.py (path:/tmp/pip-9xIXua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:36 INFO - Running setup.py (path:/tmp/pip-91OcYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:27:36 INFO - Running setup.py install for manifestparser 03:27:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:27:36 INFO - Running setup.py install for mozcrash 03:27:36 INFO - Running setup.py install for mozdebug 03:27:36 INFO - Running setup.py install for mozdevice 03:27:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:27:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:27:36 INFO - Running setup.py install for mozfile 03:27:36 INFO - Running setup.py install for mozhttpd 03:27:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:27:36 INFO - Running setup.py install for mozinfo 03:27:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:27:36 INFO - Running setup.py install for mozInstall 03:27:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:27:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:27:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:27:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:27:36 INFO - Running setup.py install for mozleak 03:27:36 INFO - Running setup.py install for mozlog 03:27:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:27:37 INFO - Running setup.py install for moznetwork 03:27:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:27:37 INFO - Running setup.py install for mozprocess 03:27:37 INFO - Running setup.py install for mozprofile 03:27:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:27:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:27:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:27:37 INFO - Running setup.py install for mozrunner 03:27:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:27:37 INFO - Running setup.py install for mozscreenshot 03:27:37 INFO - Running setup.py install for moztest 03:27:37 INFO - Running setup.py install for mozversion 03:27:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:27:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:27:37 INFO - Cleaning up... 03:27:37 INFO - Return code: 0 03:27:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:37 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 0x7fa22e5b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259e2e0>, '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 0x250a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', '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:27:37 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:27:37 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:27:37 INFO - Using env: {'DISPLAY': ':0', 03:27:37 INFO - 'HOME': '/home/cltbld', 03:27:37 INFO - 'LANG': 'en_US.UTF-8', 03:27:37 INFO - 'LANGUAGE': 'en_US:en', 03:27:37 INFO - 'LOGNAME': 'cltbld', 03:27:37 INFO - 'MAIL': '/var/mail/cltbld', 03:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:37 INFO - 'MOZ_NO_REMOTE': '1', 03:27:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:37 INFO - 'NO_EM_RESTART': '1', 03:27:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:37 INFO - 'PWD': '/builds/slave/test', 03:27:37 INFO - 'SHELL': '/bin/bash', 03:27:37 INFO - 'SHLVL': '1', 03:27:37 INFO - 'TERM': 'linux', 03:27:37 INFO - 'TMOUT': '86400', 03:27:37 INFO - 'USER': 'cltbld', 03:27:37 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', 03:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:37 INFO - '_': '/tools/buildbot/bin/python'} 03:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:38 INFO - Running setup.py (path:/tmp/pip-CdYP39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:38 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:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:38 INFO - Running setup.py (path:/tmp/pip-2ptKL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:38 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:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:38 INFO - Running setup.py (path:/tmp/pip-G6L2Db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:38 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:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:38 INFO - Running setup.py (path:/tmp/pip-znkHRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:38 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:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:38 INFO - Running setup.py (path:/tmp/pip-q6GIyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:38 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:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:38 INFO - Running setup.py (path:/tmp/pip-VZKnp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:38 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:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:38 INFO - Running setup.py (path:/tmp/pip-WiAxwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:38 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:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:38 INFO - Running setup.py (path:/tmp/pip-oU5spd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:38 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:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:38 INFO - Running setup.py (path:/tmp/pip-DSNFYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:38 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:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:38 INFO - Running setup.py (path:/tmp/pip-UqSR2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:38 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:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:38 INFO - Running setup.py (path:/tmp/pip-5tMySQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:38 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:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:38 INFO - Running setup.py (path:/tmp/pip-0dh2zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:38 INFO - Running setup.py (path:/tmp/pip-Y6dmqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:39 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:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:39 INFO - Running setup.py (path:/tmp/pip-nCsvpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:39 INFO - Running setup.py (path:/tmp/pip-g2jc4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:39 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:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:39 INFO - Running setup.py (path:/tmp/pip-AgJLSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:39 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:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:39 INFO - Running setup.py (path:/tmp/pip-W2ng8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:39 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:27:39 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:27:39 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:27:39 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:27:39 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:27:39 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:27:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:41 INFO - Downloading blessings-1.6.tar.gz 03:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:27:41 INFO - Installing collected packages: blessings 03:27:41 INFO - Running setup.py install for blessings 03:27:41 INFO - Successfully installed blessings 03:27:41 INFO - Cleaning up... 03:27:41 INFO - Return code: 0 03:27:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:27:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:41 INFO - Reading from file tmpfile_stdout 03:27:41 INFO - Current package versions: 03:27:41 INFO - argparse == 1.2.1 03:27:41 INFO - blessings == 1.6 03:27:41 INFO - blobuploader == 1.2.4 03:27:41 INFO - docopt == 0.6.1 03:27:41 INFO - functools32 == 3.2.3-2 03:27:41 INFO - jsonschema == 2.5.1 03:27:41 INFO - manifestparser == 1.1 03:27:41 INFO - mozInstall == 1.12 03:27:41 INFO - mozcrash == 0.17 03:27:41 INFO - mozdebug == 0.1 03:27:41 INFO - mozdevice == 0.48 03:27:41 INFO - mozfile == 1.2 03:27:41 INFO - mozhttpd == 0.7 03:27:41 INFO - mozinfo == 0.9 03:27:41 INFO - mozleak == 0.1 03:27:41 INFO - mozlog == 3.2 03:27:41 INFO - moznetwork == 0.27 03:27:41 INFO - mozprocess == 0.23 03:27:41 INFO - mozprofile == 0.28 03:27:41 INFO - mozrunner == 6.12 03:27:41 INFO - mozscreenshot == 0.1 03:27:41 INFO - mozsystemmonitor == 0.3 03:27:41 INFO - moztest == 0.7 03:27:41 INFO - mozversion == 1.4 03:27:41 INFO - psutil == 3.1.1 03:27:41 INFO - requests == 1.2.3 03:27:41 INFO - wsgiref == 0.1.2 03:27:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:41 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 0x7fa22e5b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259e2e0>, '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 0x250a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', '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:27:41 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:27:41 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:27:41 INFO - Using env: {'DISPLAY': ':0', 03:27:41 INFO - 'HOME': '/home/cltbld', 03:27:41 INFO - 'LANG': 'en_US.UTF-8', 03:27:41 INFO - 'LANGUAGE': 'en_US:en', 03:27:41 INFO - 'LOGNAME': 'cltbld', 03:27:41 INFO - 'MAIL': '/var/mail/cltbld', 03:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:41 INFO - 'MOZ_NO_REMOTE': '1', 03:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:41 INFO - 'NO_EM_RESTART': '1', 03:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:41 INFO - 'PWD': '/builds/slave/test', 03:27:41 INFO - 'SHELL': '/bin/bash', 03:27:41 INFO - 'SHLVL': '1', 03:27:41 INFO - 'TERM': 'linux', 03:27:41 INFO - 'TMOUT': '86400', 03:27:41 INFO - 'USER': 'cltbld', 03:27:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', 03:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:41 INFO - '_': '/tools/buildbot/bin/python'} 03:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:41 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:27:41 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:27:41 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:27:41 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:27:41 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:27:41 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:27:41 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:27:41 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:27:41 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:27:41 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:27:41 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:27:41 INFO - Cleaning up... 03:27:41 INFO - Return code: 0 03:27:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa22e5b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259e2e0>, '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 0x250a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', '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:27:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:27:41 INFO - Using env: {'DISPLAY': ':0', 03:27:41 INFO - 'HOME': '/home/cltbld', 03:27:41 INFO - 'LANG': 'en_US.UTF-8', 03:27:41 INFO - 'LANGUAGE': 'en_US:en', 03:27:41 INFO - 'LOGNAME': 'cltbld', 03:27:41 INFO - 'MAIL': '/var/mail/cltbld', 03:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:41 INFO - 'MOZ_NO_REMOTE': '1', 03:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:41 INFO - 'NO_EM_RESTART': '1', 03:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:41 INFO - 'PWD': '/builds/slave/test', 03:27:41 INFO - 'SHELL': '/bin/bash', 03:27:41 INFO - 'SHLVL': '1', 03:27:41 INFO - 'TERM': 'linux', 03:27:41 INFO - 'TMOUT': '86400', 03:27:41 INFO - 'USER': 'cltbld', 03:27:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', 03:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:41 INFO - '_': '/tools/buildbot/bin/python'} 03:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:27:42 INFO - Cleaning up... 03:27:42 INFO - Return code: 0 03:27:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:42 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 0x7fa22e5b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259e2e0>, '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 0x250a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', '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:27:42 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:27:42 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:27:42 INFO - Using env: {'DISPLAY': ':0', 03:27:42 INFO - 'HOME': '/home/cltbld', 03:27:42 INFO - 'LANG': 'en_US.UTF-8', 03:27:42 INFO - 'LANGUAGE': 'en_US:en', 03:27:42 INFO - 'LOGNAME': 'cltbld', 03:27:42 INFO - 'MAIL': '/var/mail/cltbld', 03:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:42 INFO - 'MOZ_NO_REMOTE': '1', 03:27:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:42 INFO - 'NO_EM_RESTART': '1', 03:27:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:42 INFO - 'PWD': '/builds/slave/test', 03:27:42 INFO - 'SHELL': '/bin/bash', 03:27:42 INFO - 'SHLVL': '1', 03:27:42 INFO - 'TERM': 'linux', 03:27:42 INFO - 'TMOUT': '86400', 03:27:42 INFO - 'USER': 'cltbld', 03:27:42 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', 03:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:42 INFO - '_': '/tools/buildbot/bin/python'} 03:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:42 INFO - Downloading/unpacking flake8 03:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:27:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:27:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:27:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:27:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:27:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:27:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:27:44 INFO - no previously-included directories found matching 'docs/_build' 03:27:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:27:45 INFO - Running setup.py install for pep8 03:27:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:27:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:27:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:27:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:27:45 INFO - no previously-included directories found matching 'docs/_build' 03:27:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:27:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:27:45 INFO - Cleaning up... 03:27:45 INFO - Return code: 0 03:27:45 INFO - Running post-action listener: _resource_record_post_action 03:27:45 INFO - Running post-action listener: _start_resource_monitoring 03:27:45 INFO - Starting resource monitoring. 03:27:45 INFO - ##### 03:27:45 INFO - ##### Finished create-virtualenv step (success) 03:27:45 INFO - ##### 03:27:45 INFO - ##### 03:27:45 INFO - ##### Running install step. 03:27:45 INFO - ##### 03:27:45 INFO - Running pre-action listener: _resource_record_pre_action 03:27:45 INFO - Running main action method: install 03:27:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:45 INFO - Reading from file tmpfile_stdout 03:27:45 INFO - Detecting whether we're running mozinstall >=1.0... 03:27:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:27:45 INFO - Reading from file tmpfile_stdout 03:27:45 INFO - Output received: 03:27:45 INFO - Usage: mozinstall [options] installer 03:27:45 INFO - Options: 03:27:45 INFO - -h, --help show this help message and exit 03:27:45 INFO - -d DEST, --destination=DEST 03:27:45 INFO - Directory to install application into. [default: 03:27:45 INFO - "/builds/slave/test"] 03:27:45 INFO - --app=APP Application being installed. [default: firefox] 03:27:45 INFO - mkdir: /builds/slave/test/build/application 03:27:45 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:27:45 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:28:01 INFO - Reading from file tmpfile_stdout 03:28:01 INFO - Output received: 03:28:01 INFO - /builds/slave/test/build/application/firefox/firefox 03:28:01 INFO - Running post-action listener: _resource_record_post_action 03:28:01 INFO - ##### 03:28:01 INFO - ##### Finished install step (success) 03:28:01 INFO - ##### 03:28:01 INFO - ##### 03:28:01 INFO - ##### Running run-tests step. 03:28:01 INFO - ##### 03:28:01 INFO - Running pre-action listener: _resource_record_pre_action 03:28:01 INFO - Running main action method: run_tests 03:28:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:28:01 INFO - Python 2.7.3 03:28:01 INFO - Return code: 0 03:28:01 INFO - grabbing minidump binary from tooltool 03:28:01 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:28:01 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 0x259e2e0>, '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 0x250a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:28:01 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:28:01 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:28:01 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:28:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:28:01 INFO - Return code: 0 03:28:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:28:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:28:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:28:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:28:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:28:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:28:02 INFO - Return code: 0 03:28:02 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/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:28:02 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/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:28:02 INFO - Using env: {'DISPLAY': ':0', 03:28:02 INFO - 'HOME': '/home/cltbld', 03:28:02 INFO - 'LANG': 'en_US.UTF-8', 03:28:02 INFO - 'LANGUAGE': 'en_US:en', 03:28:02 INFO - 'LOGNAME': 'cltbld', 03:28:02 INFO - 'MAIL': '/var/mail/cltbld', 03:28:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:28:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:02 INFO - 'MOZ_NO_REMOTE': '1', 03:28:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:02 INFO - 'NO_EM_RESTART': '1', 03:28:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:02 INFO - 'PWD': '/builds/slave/test', 03:28:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:28:02 INFO - 'SHELL': '/bin/bash', 03:28:02 INFO - 'SHLVL': '1', 03:28:02 INFO - 'TERM': 'linux', 03:28:02 INFO - 'TMOUT': '86400', 03:28:02 INFO - 'USER': 'cltbld', 03:28:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262', 03:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:02 INFO - '_': '/tools/buildbot/bin/python'} 03:28:02 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/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:28:02 INFO - mozversion application_buildid: 20160716005252 03:28:02 INFO - mozversion application_changeset: 1c72f075dd79e2f4013909681c7541d4e2275345 03:28:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:28:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:28:02 INFO - mozversion application_name: Firefox 03:28:02 INFO - mozversion application_remotingname: firefox-dev 03:28:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:28:02 INFO - mozversion application_vendor: Mozilla 03:28:02 INFO - mozversion application_version: 49.0a2 03:28:02 INFO - mozversion platform_buildid: 20160716005252 03:28:02 INFO - mozversion platform_changeset: 1c72f075dd79e2f4013909681c7541d4e2275345 03:28:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:28:02 INFO - mozversion platform_version: 49.0a2 03:28:02 INFO - using testdate: 1468664882 03:28:02 INFO - actual date: 1468664882 03:28:02 INFO - starting webserver on 'localhost:42074' 03:28:02 INFO - SUITE-START | Running 2 tests 03:28:02 INFO - TEST-START | dromaeo_css 03:28:02 INFO - operating with platform_type : linux_ 03:28:02 INFO - Initialising browser for dromaeo_css test... 03:28:02 INFO - TEST-INFO | started process 6893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWB3whV/profile http://localhost:42074/getInfo.html) 03:28:06 INFO - PROCESS | 6893 | __metrics Screen width/height:1600/1200 03:28:06 INFO - PROCESS | 6893 | colorDepth:24 03:28:06 INFO - PROCESS | 6893 | Browser inner width/height: 1024/697 03:28:06 INFO - PROCESS | 6893 | __metrics 03:28:07 INFO - PROCESS | 6893 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:28:07 ERROR - PROCESS | 6893 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:28:08 INFO - TEST-INFO | 6893: exit 0 03:28:08 INFO - Browser initialized. 03:28:08 INFO - Running cycle 1/1 for dromaeo_css test... 03:28:08 INFO - TEST-INFO | started process 6983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWB3whV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:28:20 INFO - PROCESS | 6983 | RSS: Main: 145666048 03:28:20 INFO - PROCESS | 6983 | 03:29:10 INFO - PROCESS | 6983 | 1468664950760 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:31:19 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:42074/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42074/tests/dromaeo/cssquery-ext.html) 03:31:20 INFO - PROCESS | 6983 | RSS: Main: 256155648 03:31:20 INFO - PROCESS | 6983 | 03:34:22 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:42074/tests/dromaeo/cssquery-ext.html (next: http://localhost:42074/tests/dromaeo/cssquery-jquery.html) 03:34:23 INFO - PROCESS | 6983 | RSS: Main: 227753984 03:34:23 INFO - PROCESS | 6983 | 03:37:25 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:42074/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42074/tests/dromaeo/cssquery-mootools.html) 03:37:25 INFO - PROCESS | 6983 | RSS: Main: 231837696 03:37:25 INFO - PROCESS | 6983 | 03:40:27 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:42074/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42074/tests/dromaeo/cssquery-prototype.html) 03:40:28 INFO - PROCESS | 6983 | RSS: Main: 218697728 03:40:28 INFO - PROCESS | 6983 | 03:43:30 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:42074/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42074/tests/dromaeo/cssquery-yui.html) 03:43:31 INFO - PROCESS | 6983 | RSS: Main: 193368064 03:43:31 INFO - PROCESS | 6983 | 03:46:33 INFO - PROCESS | 6983 | Cycle 1(1): loaded http://localhost:42074/tests/dromaeo/cssquery-yui.html (next: http://localhost:42074/tests/dromaeo/cssquery-dojo.html) 03:46:34 INFO - PROCESS | 6983 | RSS: Main: 257036288 03:46:34 INFO - PROCESS | 6983 | 03:46:34 INFO - PROCESS | 6983 | __start_tp_report 03:46:34 INFO - PROCESS | 6983 | _x_x_mozilla_page_load 03:46:34 INFO - PROCESS | 6983 | _x_x_mozilla_page_load_details 03:46:34 INFO - PROCESS | 6983 | |i|pagename|runs| 03:46:34 INFO - PROCESS | 6983 | |0;dojo.html;3330.7002369786724;3355.7483188760834;3367.30970151119;3381.4251577231867;3403.6256011838695;5453.754581043852;5512.924979628969;5550.111982082867;5558.944410555893;5562.471565201305;5482.23248745176;5534.114541673333;5543.944560554393;5549.694766787825;5561.805336813212;4876.731779752112;4951.084049450845;5014.147594908874;5037.49625037497;5066.771995260222;4969.900601987976;5064.670796398223;5069.417017043032;5111.744412779365;5186.3257776489;5112.565431938289;5117.027764724709;5134.460881607433;5190.584753219752;5197.1424714922;5131.153359695646;5195.376554813409;5197.168453047513;5205.609579281531;5228.320318358627;4850.514948505156;4914.33656456381;5034.924476132861;5040.949590504085;5095.643304968654;5426.864328391783;5443.891122177534;5450.972745136289;5470.097433923398;5491.780328786844;5891.440313170242;5904.350521442638;5923.644581325134;5934.732937017845;5946.791862284799;5595.21666966625;5828.184054232411;5838.065909454467;5859.970700146515;5970.044792833126;5555.138953462219;5581.832545023615;5582.162675598652;5584.413636568183;5591.8042868499815;5842.415758424124;6050.606710563799;6063.484603808725;6066.211392518944;6072.332043475214;5792.333881603669;5834.795782147689;5844.357120716718;5893.027650437715;5938.732757025944;5956.463918247378;5963.075723262901;5999.160117583542;5999.670018149044;6011;5683.5737319700365;5699.857503562444;5893.410658934158;5897.32180799205;5904.261967254093;5753.913691294634;5811.389804070596;5813.302403711497;5821.068629019336;5851.736671849777;4465.977670111693;4487.596116349544;4499.707519011254;4499.797509112098;4525.773711314421;4024.3158663027357;4035.8183881725395;4039.51525816898;4081.734687245379;4085.7140000200293;5683.715814209273;5692.459216374438;5701.686407247641;5705.771769129188;5706.686132262683;5984.581079324405;6008.729607167688;6022.397760223943;6028.306744724325;6063.514918806573;5416.810411635653;5549.361823390281;5645.858853528694;5651.208830763697;5682.431756824367;5137.049645815461;5139.383274007068;5153;5154.123798954187;5155.329807125125;5966.85082872923;6265.530085243625;6277.435030847246;6281.968590157111;6289.308176100625;5878.912401205791;5929.318128415288;5935.228420305505;5998.610090344114;6003.489703375262;6209.515077830756;6239.032949892774;6249.875002500015;6252.218472690914;6254.093156492374;5685.346185188756;5688.431156884279;5871.060630299132;5880.617759845596;5907.113932910098;5783.450572195635;5871.1486834409625;5871.2073870027;5876.676782776988;5911.438413350725;5691.544676425959;5695.487406133302;5722.5421966241765;5738.053221218619;5741.799037033684;5563.13771365439;5719.5710321726865;5729.02606556878;5750.194972703741;5765.538756899354;5776.42235776419;5777.191193233035;5779.2198053263955;5779.739911703899;5810;5884.941150588439;5897.351291358033;5933.732982015733;5933.881322373615;5935.732892019783;5581.609287349846;5599.496045355938;5624.803131890364;5645.096784514622;5802.6808525531505 03:46:34 INFO - PROCESS | 6983 | |1;ext.html;606.2058703098941;654.9803505894823;658.9802305930824;666.9861810048725;667.8029981155564;33669.494957575625;46689.76655116728;47741.76129119358;47954.760226198865;48009.27986080203;49449.75275123619;49959.25061124086;49959.50040499594;50055.49944500554;50061;8410.873836892451;9095.135962083608;9248.6300547978;10898.673039808818;11218.551257949672;10906;11008.779824403508;11010;11014;11028.22802403832;11118.832522585133;11154.498047587838;11176.273542219771;11181.44092795357;11182.27315224512;8455.408121431472;10761.83857242138;11035.227534072617;11038.724031899266;11379.886201137966;10957.83563246552;11021.614243501519;11028.889711102867;11041.779164416746;11050.889491105067;45637.543624563994;46028.07943841104;46206;46261.074778504575;46262.76868615669;3490.598581163148;3543.5747710274672;3546.2198316370614;3670.8164591770574;4038.7172897896867;34515.82742086299;34756.47865282023;35261.82369088164;35366.46950295748;35521.28957420837;4478.350639157336;4502.167099086647;4558.475775285851;4602.263637817933;4617.561331673485;366410;368771;369213;369901;370783.14608427056;37938;38965.610343896195;63454.36545634484;64382;64408.67795661085;41129.383059254134;41201.79399102985;41287;41314;41358.1728365431;14956.252187390586;16592.917035414986;16777;16781.07704076263;16783.580410489834;13590.93204533971;13841.377138028813;13870.4451821926;14188.148711077369;14218.217998010208;9236.353455258202;9241.95379023114;9247.167754901957;9297.860532092023;9305.674301399555;3550.25444656625;3586.5875424326537;3608.386574282378;3609.512715783336;3624.818759062089;934.3226161033197;988;1002.7242508310273;1062.6918193723734;1065.3235195650664;33165.834170829476;33894.32211355808;34015.489767653504;34079.82960085184;34110.31779364399;1064.6912395405245;1090.1660229924114;1103.933763974148;1112.0880877680224;1125.5722825326325;17265.352844110355;17905.400379826362;18248.45254642363;18285.63428731418;18299.72550411745;600804;607152;610658;613034;613423;64246.678766605866;64598;64860.67569662121;65083.67458162679;65170.348296517375;1311.5016293808292;1355.7559639265028;1372.972595427081;1381.9309034548432;1405.3956798576505;31370.843145784125;33924.49113263352;34402.139946501535;34697.1325716849;34894.65105348914;54463;60410.69794650999;62342;62580;70152;543193;543500;547164;548389;548579;39141;44273;45044.77477612591;49038.50961490339;49750.502494974586;51468.74265628648;52245;52251.47748522618;52914;53265.46734532605;42355.7882210587;43312.78343608262;43875.12249755051;44360.11279774322;44723.32915006213;42029;42444.78777606092;42857.57142428536;42966.14067718566;44169.33745993749;42723.7863810679;43975;44145;44278.55721442744;44380.556194437646;37675;37737.62262377341;38336.041598959135;38903;39055.2188956225;29272.56091158592;29281.092347527385;29361.706382935896;29676.851615741783;29730.554041689826 03:46:34 INFO - PROCESS | 6983 | |2;jquery.html;406.3376695985543;407.3299422450068;414.22746577632705;432.8095637919315;442.88484993901574;18668.159932803024;19810.70283945742;20240.59518809625;20936.16255349788;21510.354689359305;18395.724064139016;18430.631387372243;18577.90711046446;18610.627787444242;19982.12246114121;5637.3517045539875;5866.530677545786;5878.382769809173;5879.7648094076185;5882.264716910387;4205.13794672093;5497.9828731684565;5706.343770466408;5736;6280.057991301319;6320.525960552977;6366.713497892606;6396.808095757135;6473.643949582771;6500.3174666660025;6284.214473190851;6323.30443651198;6456.2575303840185;6466.547341686084;6471.935280647181;3829.2341531693496;5331.093714068617;5657.8019769307875;5739.598228124033;5756.8848623027725;24201.152959646504;24224.757752422425;24656.506869862504;25107.49785004308;25183.496330073478;2166.73999120105;2439.878006099688;2537.479816637603;2670.7329267073333;2824.4209936962875;10027;10643.095336896373;10643.095336896373;10762.408067556282;10890.237683362167;1941.6116776644728;2006.6989951507392;2082.6563617003176;2110.6306396380573;2112.7781582933726;65758;81920.59039704764;84388.57805710993;85317.57341213254;88225.11774882233;11418.486168122454;11462.598809041643;11583.710407239718;11596.420178991186;11826.467808948619;16728.749068763977;16749.66500670004;16850.410235641695;16852.91573542149;16890.915545422195;8578.18507241811;8763.123687631314;8774.692885748967;8811.691590794291;8928.196462318423;8553.871691924625;8565.48607083577;8692.826143477096;8719.346049046348;8916.019237883827;4868.172410690191;4927.43334516528;4959.950400496021;4968.254761785689;5023.171176755867;1825.0671636612449;2021.5855749571303;2035.2571311471206;2054.989725051365;2090.7595626502844;860.9827803443897;912.2291663544295;931.9748276895361;939.8778158839444;1011.8077565262577;19046.428607141806;19129.426117216506;19289.03554822253;19379.903100484407;20113.99430028493;899.8020435504178;907.5326207003399;967.4243824924159;1002.5338217728645;1046.4140081554353;10602.734931626772;10910.454477276264;10973.615923442641;10974.286671366335;11008.834867476995;468980;469550;481288;487825.56087219337;490665;97349;100099;102337.48831255797;102497.48751256346;103029.48485257526;1029.0789743179962;1051.8369652703843;1061.6549621373085;1079.5519859258477;1080.1197024425069;17353.913230433765;17361;17369;17774.20016099253;17820.198091085673;41650.791746041075;44105.33841992437;44549.55450445454;45485.54514454813;45844.54155458403;61237.693811530655;62286.68856655688;62576;62783.37216627775;64208;9118.133777291147;9236.815263694554;9237.214836738953;9350.859737104085;9531.666391676257;12516.749665006831;13145.802812957621;13433.731325373634;13620.591382258548;13726.588202353945;11503.76992460163;11628.6511404658;11718.648440546796;11756.118291128028;11861.110416718608;11280;11550.133739969368;11563.826542601699;11706.648800535997;11794.115441341763;11576.652700419001;11937.224080434744;11949.880501194877;11977.101717371406;12000.279983200686;9077.500737459502;9175.128362805523;9182.954085229798;9303;9375.437473751597;10411.687649370531;11361.261518001304;11383.943080284545;11453.770924581628;11577 03:46:34 INFO - PROCESS | 6983 | |3;mootools.html;1370.506617617658;1549.7133030389375;1575.228138212276;1779.656359448616;1934.9129289181985;8997.685081022166;9343.859842102365;9403.153716165543;9662.130408263254;9666.27502937279;9397.530123493832;9579.904200958006;9581.473018983954;9592.52037398129;9607.375520591157;2470.765277298658;2483.0316176691103;2487.825852190347;2499.9375015624573;2500.6374075759004;2481.10680155144;2552.119518766032;2553.234029791055;2557.1689201009744;2558.744125587445;2469.9135530256444;2474.8391354561986;2496.488219914922;2506.5613517634433;2512;2377.7741114594087;2384.7615238476187;2390.3546042568582;2441.6703744994375;2444.3766839455825;2369.2300002499082;2381.8094552435764;2387.9164229252065;2397.137030668958;2440.9511809763885;8817.426867253673;8983.640654373818;9426.811463770755;9447.669331573363;9487.952560237154;5482.342118945712;5605.467480589337;5609.467100625434;5613.66318020916;5617.21359009739;3542.220711443478;3563.4832949222478;3621.2938476996997;3626.202235508184;3640.763350382243;1132.9433528323634;1145.043888353226;1178.2459226095307;1201.0391686650732;2233.1737257214936;13305.86694133056;13622.591322260248;13738.313084345742;13765.724685506333;13791.10357826738;4650.883727906762;4675.298705194248;4721.173794586002;4723.126221649006;4745.430548334153;10669.413182274895;10721.142308615292;10731.785364292671;10765.084967777826;10774.19193560486;5601.29983752031;5602.467765562265;5604.495595396434;5609.859753506195;5610.831675049755;4404.533461261703;4433.091216300651;4456.955430445654;5098.719570423662;5155.123628983082;4006.719529632898;4075.836966521306;4119.711620186618;4128.3601041837965;4173.916521669549;1198.6044605280238;1220.1093201962617;1227.5642147037852;1230.5939040116739;1237.189640785287;1005.0150852164919;1014.8886968769186;1049.879263884663;1055.3245922609535;1058.5183741397645;6416.679166041679;6436.967815160988;6457.580257283262;6501.219853617502;6676.9666151668935;446.66276960894965;455.5785898044362;471.16838779554115;476.2855716425362;495.44510148633043;4438.60052595268;4467;4512.887177820581;4646.1172377248895;4655.092257009918;11468.655940321803;11986.460609272604;12021.459034343301;12023.158378913393;12029.15795894279;11389.658310250707;11795.35125568085;11862.822057669142;12020.158588898868;12063.577774778016;8767.25478334336;8931.19619234272;8963.417377870417;8967.910320896837;8971.730848074569;6514.771982980573;6791.083203767428;6793.2867048961125;6943.062686537252;6955.478339124687;10951.83572246433;11108.61119860801;11110.111640830373;11250.268732532359;11276.210665253682;11175.944120279346;11483.196176267582;11525.962663360338;11674.533018679158;11690.532378704756;7609.162992070757;8189.79525511867;8382.16178382157;8386.11945745688;8633.95683021581;9288.303377246599;9334.906650933404;9356;9379;9382.765430864283;8207.589620518831;8250.174982501701;8252.174782521699;8398.664053437795;8402.579871006303;7936.484128531627;7951;8226.794330141554;8243.629036693243;8278.586070696321;7427.740029099172;7443.627818609156;7503.09962804467;7510.061242344707;7515;5335.973320133375;5348.064088784369;5380.596455265949;5528.806491772769;5541.778328866801;5405.918911216414;5533.916991245215;5629.0712032514175;5651.632643878134;5691.203231547669 03:46:34 INFO - PROCESS | 6983 | |4;prototype.html;342.6179809512393;353.4115697363889;355.30892414254254;361.34235691042295;361.3423569104231;5469.425710300421;5522.723863806814;5564.1931919871595;5603.523700485463;5640.323161220655;5168.198929165976;5218.191180367049;5310.13252843465;5378.731063446822;5467.234587157801;4312.5903039211225;4320.395144679747;4330.350447432878;4335.43639326887;4345.130973805251;4332.9566704332865;4339.153864996327;4343.413639158721;4346.84786032489;4351.347297905324;4143.177002119073;4291.468033860022;4302.096559722462;4305.418768466248;4337.436133302666;4249.4475718156755;4252.893677658052;4271.860182765665;4272.658187345036;4299.91400171998;3765.1151979284846;3784.9621503784883;3785.6782173515285;3813.9237215255816;3821.4840996465678;5161.6121308858665;5290.81482148123;5322.121849894801;5328.46715328468;5391.78432862685;4797.673128532659;4857.101436234308;4886.364772579577;4890.926636100426;4891.4863939286215;5682.039696304768;5694.259746232963;5696.943030569682;5697.4587414196;5729.856753581152;3951.8221680024467;4163.542010378856;4186.748795072275;4189.72766770159;4195.139996300751;5918.970405147947;5985.371535988746;5991.760329586811;6003.429674180946;6009.978303688384;4289.528151903288;4293.914121717548;4300.462442194726;4312.7627980461375;4313;3948.2103579284258;4080.6332327250125;4145.97927010369;4352.956470435319;4353.717008394444;4782.880427989328;4786.569208771228;4789.688670236424;4794.232922732416;4809.78355973982;5727.165053298644;5750.88498230033;5760.913586296209;5787.977355737722;5817.556626216999;1478.5268714011413;1479.3899504881485;1487.7247709173837;1491.7836913647461;1493.7527164817282;949.4113649537331;959.4866746290841;963.3160456076124;965.7875267441152;970.1995853420815;4945.4807245238735;4976.2286845539;5057.468965758542;5120;5127.282180494733;5256.816011439658;5264.973675131677;5265.447128051576;5275.472452754694;5298.165481467474;4813.422389313305;4914.238293064581;5034.471380505068;5039.874003149877;5047.217681259411;2768.321761168527;2785.4986102501744;2787.5539913613725;2789.3445040415486;2820.2244382794897;5459;5493.972530137324;5517.69652669099;5535.750891209906;5538.839852457545;5322.760475778599;5325.86685332862;5461.5357694596405;6012.549058820518;6045.274567051982;6172.845678858064;6195.81412557615;6198.938010619836;6221.875562488815;6242.375762423721;5705.486506214461;5913.142594323713;5920.3783602722815;5977.163197152315;5984.222051133499;5861.882762344814;5885.705714714333;5888.381719919346;5929.00585204469;5963.671998040149;6071.878562428815;6174.907376389448;6204.5036397089025;6254.343293954069;6265.843353916189;4110.321796903597;4143.316352801875;4288.549702281215;4330.7401555906745;4339.004058133168;5834.38738932423;5922.318933322723;5965.433283838029;5966;5969.925413425625;5749.1663708762835;5781.884362312814;5790.739416726342;5821.825345239649;5842.474177324061;5656.830295091154;5743.195952566728;5760.654360738369;5782.335031471266;5787.826365209051;5733.795902860446;5746.913796292975;5770.855728606651;5770.942290577041;5783.710814459344;5657.10486986864;5879.382664820303;5888.793892213752;5889.5582831286965;5901.793437229677;5764.59647824665;5769.644133628678;5775.978407557489;5786.594938354443;5787 03:46:34 INFO - PROCESS | 6983 | |5;yui.html;692.5498426023088;759.8290384663452;784.9646765895534;792.3661071143084;839.2530647723523;15516.767248491282;16546.420875269367;16573.834261657394;16603.169841507908;16632.25154868031;14938.327775250113;15123.395064197446;15131.62170945727;15228.162451065187;15316.770248446282;686.8797960356942;832.4921797703396;852.3607294529088;867.4361664917823;869.0657543141117;839.6221700234919;842;845.5941148248844;847.1274587175219;847.504210037129;912.3750231091724;914.2137761525083;914.2777206007246;914.6204325205032;914.6615752171706;751.2525037587608;857.7298151082421;898.1961144775422;904.5115637555712;917.4311926605548;677.6510097299895;678.6165816313767;679.1171477079826;679.5481005131581;679.9286074962107;15792.289346979414;15830.20848957559;15837.762433563506;15842.603934901605;15857.286422111032;15147.54557363281;15460.381584736597;15468.458603948808;15504.147271900041;15822.52532424029;13573.389197486038;13582.864171358258;13592.592222233348;13644.181349119084;14054.43782248719;4630.120277147331;4670.206064968964;4695.319178719066;4710.505396933307;4757.09615173116;79621;80114;80290;81271.18728812695;81440.18559814444;12142.271463712206;12189.634310970509;12626.936865315614;12702;12920;20770.273040443513;21494.677579836316;21504.13983440676;22362.105515779513;22425.32724018282;9109.453432794053;9288.953555232181;9558.856617150748;9621.08599683029;9750.853737193947;4921.729304888194;5007.349044624249;5040.672356296829;5086.5422112009355;5176.663516871391;3725.1245957200035;3786.053486628343;3811.6760075393904;3819.3125237457525;3824.847006119724;630.2846269484169;687.7764726463919;695.9373656370951;705.340506626306;706.7067167125688;612.5865041097242;643.9291677915426;704.723727513426;759.8252401947583;773.6325245508339;10585;11055.336619866119;11261.43692815356;11265.493052812642;11295.887041129483;666.4235436347622;678.3657280442802;708.482807550491;774.6126936531734;799.6681377228501;5272.420033796279;5281.9207711884355;5338.813141540028;5379.300690910157;5392.40683524812;73317.6334118326;111098.44450777695;112644.1122684261;115513;120202.3989880045;97633.51183244039;98608;103672.48163759134;104333.47833260937;104409;84772.99999999876;86712.5664371674;89315.55342223248;89710.55144724365;89843.55078224567;9810.607575696893;9969.252306076929;10086.798264034825;10100.343477673927;10122.139618132542;54239;54377;54457.18314225369;54553.45446545484;55593.444065558826;67619.66190169018;72916.27083729306;79391.60304198442;80281;80336.59831700804;13741.793873091712;13981.684123415485;14358.56924292273;14403.42386304578;14749.778753318495;15040.623984400478;15999.520014399586;16021.51935441892;16157.515274541782;16453.753193702345;13969.155113994273;14094.224817635128;14612.92693536568;14823;15180.316885739947;13998.720025599634;14030.719385612434;14518.346674399889;14586.927065364605;15318.770218446509;14223;14502;14594.489192878198;14762.852371476149;15093.169875656944;12598.433070512032;12846.678833028875;12978.545750898673;13182.60452186436;13272;12641.178323408949;12696.428660710106;12722.554710585086;13089.934550327187;13112 03:46:34 INFO - PROCESS | 6983 | __end_tp_report 03:46:34 INFO - PROCESS | 6983 | __start_cc_report 03:46:34 INFO - PROCESS | 6983 | _x_x_mozilla_cycle_collect,945 03:46:34 INFO - PROCESS | 6983 | __end_cc_report 03:46:34 INFO - PROCESS | 6983 | __startTimestamp1468665994108__endTimestamp 03:46:34 INFO - PROCESS | 6983 | 03:46:34 INFO - PROCESS | 6983 | ------- Summary: start ------- 03:46:34 INFO - PROCESS | 6983 | Number of tests: 6 03:46:34 INFO - PROCESS | 6983 | 03:46:34 INFO - PROCESS | 6983 | [#0] dojo.html Cycles:165 Average:5513.68 Median:5695.49 stddev:607.19 (10.7%) stddev-sans-first:584.40 03:46:34 INFO - PROCESS | 6983 | Values: 3330.7 3355.7 3367.3 3381.4 3403.6 5453.8 5512.9 5550.1 5558.9 5562.5 5482.2 5534.1 5543.9 5549.7 5561.8 4876.7 4951.1 5014.1 5037.5 5066.8 4969.9 5064.7 5069.4 5111.7 5186.3 5112.6 5117.0 5134.5 5190.6 5197.1 5131.2 5195.4 5197.2 5205.6 5228.3 4850.5 4914.3 5034.9 5040.9 5095.6 5426.9 5443.9 5451.0 5470.1 5491.8 5891.4 5904.4 5923.6 5934.7 5946.8 5595.2 5828.2 5838.1 5860.0 5970.0 5555.1 5581.8 5582.2 5584.4 5591.8 5842.4 6050.6 6063.5 6066.2 6072.3 5792.3 5834.8 5844.4 5893.0 5938.7 5956.5 5963.1 5999.2 5999.7 6011.0 5683.6 5699.9 5893.4 5897.3 5904.3 5753.9 5811.4 5813.3 5821.1 5851.7 4466.0 4487.6 4499.7 4499.8 4525.8 4024.3 4035.8 4039.5 4081.7 4085.7 5683.7 5692.5 5701.7 5705.8 5706.7 5984.6 6008.7 6022.4 6028.3 6063.5 5416.8 5549.4 5645.9 5651.2 5682.4 5137.0 5139.4 5153.0 5154.1 5155.3 5966.9 6265.5 6277.4 6282.0 6289.3 5878.9 5929.3 5935.2 5998.6 6003.5 6209.5 6239.0 6249.9 6252.2 6254.1 5685.3 5688.4 5871.1 5880.6 5907.1 5783.5 5871.1 5871.2 5876.7 5911.4 5691.5 5695.5 5722.5 5738.1 5741.8 5563.1 5719.6 5729.0 5750.2 5765.5 5776.4 5777.2 5779.2 5779.7 5810.0 5884.9 5897.4 5933.7 5933.9 5935.7 5581.6 5599.5 5624.8 5645.1 5802.7 03:46:34 INFO - PROCESS | 6983 | 03:46:34 INFO - PROCESS | 6983 | [#1] ext.html Cycles:180 Average:67023.78 Median:39098.11 stddev:137924.42 (352.8%) stddev-sans-first:138221.18 03:46:34 INFO - PROCESS | 6983 | Values: 606.2 655.0 659.0 667.0 667.8 33669.5 46689.8 47741.8 47954.8 48009.3 49449.8 49959.3 49959.5 50055.5 50061.0 8410.9 9095.1 9248.6 10898.7 11218.6 10906.0 11008.8 11010.0 11014.0 11028.2 11118.8 11154.5 11176.3 11181.4 11182.3 8455.4 10761.8 11035.2 11038.7 11379.9 10957.8 11021.6 11028.9 11041.8 11050.9 45637.5 46028.1 46206.0 46261.1 46262.8 3490.6 3543.6 3546.2 3670.8 4038.7 34515.8 34756.5 35261.8 35366.5 35521.3 4478.4 4502.2 4558.5 4602.3 4617.6 366410.0 368771.0 369213.0 369901.0 370783.1 37938.0 38965.6 63454.4 64382.0 64408.7 41129.4 41201.8 41287.0 41314.0 41358.2 14956.3 16592.9 16777.0 16781.1 16783.6 13590.9 13841.4 13870.4 14188.1 14218.2 9236.4 9242.0 9247.2 9297.9 9305.7 3550.3 3586.6 3608.4 3609.5 3624.8 934.3 988.0 1002.7 1062.7 1065.3 33165.8 33894.3 34015.5 34079.8 34110.3 1064.7 1090.2 1103.9 1112.1 1125.6 17265.4 17905.4 18248.5 18285.6 18299.7 600804.0 607152.0 610658.0 613034.0 613423.0 64246.7 64598.0 64860.7 65083.7 65170.3 1311.5 1355.8 1373.0 1381.9 1405.4 31370.8 33924.5 34402.1 34697.1 34894.7 54463.0 60410.7 62342.0 62580.0 70152.0 543193.0 543500.0 547164.0 548389.0 548579.0 39141.0 44273.0 45044.8 49038.5 49750.5 51468.7 52245.0 52251.5 52914.0 53265.5 42355.8 43312.8 43875.1 44360.1 44723.3 42029.0 42444.8 42857.6 42966.1 44169.3 42723.8 43975.0 44145.0 44278.6 44380.6 37675.0 37737.6 38336.0 38903.0 39055.2 29272.6 29281.1 29361.7 29676.9 29730.6 03:46:34 INFO - PROCESS | 6983 | 03:46:34 INFO - PROCESS | 6983 | [#2] jquery.html Cycles:180 Average:29424.19 Median:13548.19 stddev:79400.81 (586.1%) stddev-sans-first:79593.66 03:46:34 INFO - PROCESS | 6983 | Values: 406.3 407.3 414.2 432.8 442.9 18668.2 19810.7 20240.6 20936.2 21510.4 18395.7 18430.6 18577.9 18610.6 19982.1 5637.4 5866.5 5878.4 5879.8 5882.3 4205.1 5498.0 5706.3 5736.0 6280.1 6320.5 6366.7 6396.8 6473.6 6500.3 6284.2 6323.3 6456.3 6466.5 6471.9 3829.2 5331.1 5657.8 5739.6 5756.9 24201.2 24224.8 24656.5 25107.5 25183.5 2166.7 2439.9 2537.5 2670.7 2824.4 10027.0 10643.1 10643.1 10762.4 10890.2 1941.6 2006.7 2082.7 2110.6 2112.8 65758.0 81920.6 84388.6 85317.6 88225.1 11418.5 11462.6 11583.7 11596.4 11826.5 16728.7 16749.7 16850.4 16852.9 16890.9 8578.2 8763.1 8774.7 8811.7 8928.2 8553.9 8565.5 8692.8 8719.3 8916.0 4868.2 4927.4 4960.0 4968.3 5023.2 1825.1 2021.6 2035.3 2055.0 2090.8 861.0 912.2 932.0 939.9 1011.8 19046.4 19129.4 19289.0 19379.9 20114.0 899.8 907.5 967.4 1002.5 1046.4 10602.7 10910.5 10973.6 10974.3 11008.8 468980.0 469550.0 481288.0 487825.6 490665.0 97349.0 100099.0 102337.5 102497.5 103029.5 1029.1 1051.8 1061.7 1079.6 1080.1 17353.9 17361.0 17369.0 17774.2 17820.2 41650.8 44105.3 44549.6 45485.5 45844.5 61237.7 62286.7 62576.0 62783.4 64208.0 9118.1 9236.8 9237.2 9350.9 9531.7 12516.7 13145.8 13433.7 13620.6 13726.6 11503.8 11628.7 11718.6 11756.1 11861.1 11280.0 11550.1 11563.8 11706.6 11794.1 11576.7 11937.2 11949.9 11977.1 12000.3 9077.5 9175.1 9183.0 9303.0 9375.4 10411.7 11361.3 11383.9 11453.8 11577.0 03:46:34 INFO - PROCESS | 6983 | 03:46:34 INFO - PROCESS | 6983 | [#3] mootools.html Cycles:180 Average:6238.98 Median:4489.94 stddev:3639.62 (81.1%) stddev-sans-first:3631.44 03:46:34 INFO - PROCESS | 6983 | Values: 1370.5 1549.7 1575.2 1779.7 1934.9 8997.7 9343.9 9403.2 9662.1 9666.3 9397.5 9579.9 9581.5 9592.5 9607.4 2470.8 2483.0 2487.8 2499.9 2500.6 2481.1 2552.1 2553.2 2557.2 2558.7 2469.9 2474.8 2496.5 2506.6 2512.0 2377.8 2384.8 2390.4 2441.7 2444.4 2369.2 2381.8 2387.9 2397.1 2441.0 8817.4 8983.6 9426.8 9447.7 9488.0 5482.3 5605.5 5609.5 5613.7 5617.2 3542.2 3563.5 3621.3 3626.2 3640.8 1132.9 1145.0 1178.2 1201.0 2233.2 13305.9 13622.6 13738.3 13765.7 13791.1 4650.9 4675.3 4721.2 4723.1 4745.4 10669.4 10721.1 10731.8 10765.1 10774.2 5601.3 5602.5 5604.5 5609.9 5610.8 4404.5 4433.1 4457.0 5098.7 5155.1 4006.7 4075.8 4119.7 4128.4 4173.9 1198.6 1220.1 1227.6 1230.6 1237.2 1005.0 1014.9 1049.9 1055.3 1058.5 6416.7 6437.0 6457.6 6501.2 6677.0 446.7 455.6 471.2 476.3 495.4 4438.6 4467.0 4512.9 4646.1 4655.1 11468.7 11986.5 12021.5 12023.2 12029.2 11389.7 11795.4 11862.8 12020.2 12063.6 8767.3 8931.2 8963.4 8967.9 8971.7 6514.8 6791.1 6793.3 6943.1 6955.5 10951.8 11108.6 11110.1 11250.3 11276.2 11175.9 11483.2 11526.0 11674.5 11690.5 7609.2 8189.8 8382.2 8386.1 8634.0 9288.3 9334.9 9356.0 9379.0 9382.8 8207.6 8250.2 8252.2 8398.7 8402.6 7936.5 7951.0 8226.8 8243.6 8278.6 7427.7 7443.6 7503.1 7510.1 7515.0 5336.0 5348.1 5380.6 5528.8 5541.8 5405.9 5533.9 5629.1 5651.6 5691.2 03:46:34 INFO - PROCESS | 6983 | 03:46:34 INFO - PROCESS | 6983 | [#4] prototype.html Cycles:180 Average:4784.18 Median:5322.44 stddev:1411.78 (26.5%) stddev-sans-first:1375.82 03:46:34 INFO - PROCESS | 6983 | Values: 342.6 353.4 355.3 361.3 361.3 5469.4 5522.7 5564.2 5603.5 5640.3 5168.2 5218.2 5310.1 5378.7 5467.2 4312.6 4320.4 4330.4 4335.4 4345.1 4333.0 4339.2 4343.4 4346.8 4351.3 4143.2 4291.5 4302.1 4305.4 4337.4 4249.4 4252.9 4271.9 4272.7 4299.9 3765.1 3785.0 3785.7 3813.9 3821.5 5161.6 5290.8 5322.1 5328.5 5391.8 4797.7 4857.1 4886.4 4890.9 4891.5 5682.0 5694.3 5696.9 5697.5 5729.9 3951.8 4163.5 4186.7 4189.7 4195.1 5919.0 5985.4 5991.8 6003.4 6010.0 4289.5 4293.9 4300.5 4312.8 4313.0 3948.2 4080.6 4146.0 4353.0 4353.7 4782.9 4786.6 4789.7 4794.2 4809.8 5727.2 5750.9 5760.9 5788.0 5817.6 1478.5 1479.4 1487.7 1491.8 1493.8 949.4 959.5 963.3 965.8 970.2 4945.5 4976.2 5057.5 5120.0 5127.3 5256.8 5265.0 5265.4 5275.5 5298.2 4813.4 4914.2 5034.5 5039.9 5047.2 2768.3 2785.5 2787.6 2789.3 2820.2 5459.0 5494.0 5517.7 5535.8 5538.8 5322.8 5325.9 5461.5 6012.5 6045.3 6172.8 6195.8 6198.9 6221.9 6242.4 5705.5 5913.1 5920.4 5977.2 5984.2 5861.9 5885.7 5888.4 5929.0 5963.7 6071.9 6174.9 6204.5 6254.3 6265.8 4110.3 4143.3 4288.5 4330.7 4339.0 5834.4 5922.3 5965.4 5966.0 5969.9 5749.2 5781.9 5790.7 5821.8 5842.5 5656.8 5743.2 5760.7 5782.3 5787.8 5733.8 5746.9 5770.9 5770.9 5783.7 5657.1 5879.4 5888.8 5889.6 5901.8 5764.6 5769.6 5776.0 5786.6 5787.0 03:46:34 INFO - PROCESS | 6983 | 03:46:34 INFO - PROCESS | 6983 | [#5] yui.html Cycles:180 Average:21514.75 Median:4650.16 stddev:29910.16 (643.2%) stddev-sans-first:29953.20 03:46:34 INFO - PROCESS | 6983 | Values: 692.5 759.8 785.0 792.4 839.3 15516.8 16546.4 16573.8 16603.2 16632.3 14938.3 15123.4 15131.6 15228.2 15316.8 686.9 832.5 852.4 867.4 869.1 839.6 842.0 845.6 847.1 847.5 912.4 914.2 914.3 914.6 914.7 751.3 857.7 898.2 904.5 917.4 677.7 678.6 679.1 679.5 679.9 15792.3 15830.2 15837.8 15842.6 15857.3 15147.5 15460.4 15468.5 15504.1 15822.5 13573.4 13582.9 13592.6 13644.2 14054.4 4630.1 4670.2 4695.3 4710.5 4757.1 79621.0 80114.0 80290.0 81271.2 81440.2 12142.3 12189.6 12626.9 12702.0 12920.0 20770.3 21494.7 21504.1 22362.1 22425.3 9109.5 9289.0 9558.9 9621.1 9750.9 4921.7 5007.3 5040.7 5086.5 5176.7 3725.1 3786.1 3811.7 3819.3 3824.8 630.3 687.8 695.9 705.3 706.7 612.6 643.9 704.7 759.8 773.6 10585.0 11055.3 11261.4 11265.5 11295.9 666.4 678.4 708.5 774.6 799.7 5272.4 5281.9 5338.8 5379.3 5392.4 73317.6 111098.4 112644.1 115513.0 120202.4 97633.5 98608.0 103672.5 104333.5 104409.0 84773.0 86712.6 89315.6 89710.6 89843.6 9810.6 9969.3 10086.8 10100.3 10122.1 54239.0 54377.0 54457.2 54553.5 55593.4 67619.7 72916.3 79391.6 80281.0 80336.6 13741.8 13981.7 14358.6 14403.4 14749.8 15040.6 15999.5 16021.5 16157.5 16453.8 13969.2 14094.2 14612.9 14823.0 15180.3 13998.7 14030.7 14518.3 14586.9 15318.8 14223.0 14502.0 14594.5 14762.9 15093.2 12598.4 12846.7 12978.5 13182.6 13272.0 12641.2 12696.4 12722.6 13089.9 13112.0 03:46:34 INFO - PROCESS | 6983 | -------- Summary: end -------- 03:46:34 INFO - PROCESS | 6983 | 03:46:34 INFO - TEST-INFO | 6983: exit 0 03:46:34 INFO - TEST-OK | dromaeo_css | took 1112257ms 03:46:34 INFO - TEST-START | kraken 03:46:34 INFO - operating with platform_type : linux_ 03:46:34 INFO - Initialising browser for kraken test... 03:46:34 INFO - TEST-INFO | started process 7168 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP2M77v/profile http://localhost:42074/getInfo.html) 03:46:38 INFO - PROCESS | 7168 | __metrics Screen width/height:1600/1200 03:46:38 INFO - PROCESS | 7168 | colorDepth:24 03:46:38 INFO - PROCESS | 7168 | Browser inner width/height: 1024/697 03:46:38 INFO - PROCESS | 7168 | __metrics 03:46:39 INFO - PROCESS | 7168 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:46:39 ERROR - PROCESS | 7168 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:46:40 INFO - TEST-INFO | 7168: exit 0 03:46:40 INFO - Browser initialized. 03:46:40 INFO - Running cycle 1/1 for kraken test... 03:46:40 INFO - TEST-INFO | started process 7259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP2M77v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:46:52 INFO - PROCESS | 7259 | RSS: Main: 145354752 03:46:52 INFO - PROCESS | 7259 | 03:46:54 INFO - PROCESS | 7259 | Cycle 1(1): loaded http://localhost:42074/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42074/tests/kraken/driver.html?testName=audio-beat-detection) 03:46:55 INFO - PROCESS | 7259 | RSS: Main: 194908160 03:46:55 INFO - PROCESS | 7259 | 03:46:58 INFO - PROCESS | 7259 | Cycle 1(1): loaded http://localhost:42074/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42074/tests/kraken/driver.html?testName=audio-dft) 03:46:58 INFO - PROCESS | 7259 | RSS: Main: 193024000 03:46:58 INFO - PROCESS | 7259 | 03:47:01 INFO - PROCESS | 7259 | Cycle 1(1): loaded http://localhost:42074/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42074/tests/kraken/driver.html?testName=audio-fft) 03:47:02 INFO - PROCESS | 7259 | RSS: Main: 279138304 03:47:02 INFO - PROCESS | 7259 | 03:47:04 INFO - PROCESS | 7259 | Cycle 1(1): loaded http://localhost:42074/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42074/tests/kraken/driver.html?testName=audio-oscillator) 03:47:04 INFO - PROCESS | 7259 | RSS: Main: 187936768 03:47:04 INFO - PROCESS | 7259 | 03:47:07 INFO - PROCESS | 7259 | Cycle 1(1): loaded http://localhost:42074/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42074/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:47:07 INFO - PROCESS | 7259 | RSS: Main: 188633088 03:47:07 INFO - PROCESS | 7259 | 03:47:10 INFO - PROCESS | 7259 | Cycle 1(1): loaded http://localhost:42074/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42074/tests/kraken/driver.html?testName=imaging-darkroom) 03:47:11 INFO - PROCESS | 7259 | RSS: Main: 223338496 03:47:11 INFO - PROCESS | 7259 | 03:47:14 INFO - PROCESS | 7259 | Cycle 1(1): loaded http://localhost:42074/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42074/tests/kraken/driver.html?testName=imaging-desaturate) 03:47:15 INFO - PROCESS | 7259 | RSS: Main: 224264192 03:47:15 INFO - PROCESS | 7259 | 03:47:17 INFO - PROCESS | 7259 | Cycle 1(1): loaded http://localhost:42074/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42074/tests/kraken/driver.html?testName=json-parse-financial) 03:47:18 INFO - PROCESS | 7259 | RSS: Main: 223236096 03:47:18 INFO - PROCESS | 7259 | 03:47:20 INFO - PROCESS | 7259 | Cycle 1(1): loaded http://localhost:42074/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42074/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:47:20 INFO - PROCESS | 7259 | RSS: Main: 201105408 03:47:20 INFO - PROCESS | 7259 | 03:47:22 INFO - PROCESS | 7259 | Cycle 1(1): loaded http://localhost:42074/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42074/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:47:22 INFO - PROCESS | 7259 | RSS: Main: 202612736 03:47:22 INFO - PROCESS | 7259 | 03:47:24 INFO - PROCESS | 7259 | Cycle 1(1): loaded http://localhost:42074/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42074/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:47:25 INFO - PROCESS | 7259 | RSS: Main: 209682432 03:47:25 INFO - PROCESS | 7259 | 03:47:28 INFO - PROCESS | 7259 | Cycle 1(1): loaded http://localhost:42074/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42074/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:47:28 INFO - PROCESS | 7259 | RSS: Main: 215728128 03:47:28 INFO - PROCESS | 7259 | 03:47:31 INFO - PROCESS | 7259 | Cycle 1(1): loaded http://localhost:42074/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42074/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:47:31 INFO - PROCESS | 7259 | RSS: Main: 216399872 03:47:31 INFO - PROCESS | 7259 | 03:47:33 INFO - PROCESS | 7259 | Cycle 1(1): loaded http://localhost:42074/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42074/tests/kraken/driver.html?testName=ai-astar) 03:47:33 INFO - PROCESS | 7259 | RSS: Main: 259158016 03:47:33 INFO - PROCESS | 7259 | 03:47:33 INFO - PROCESS | 7259 | __start_tp_report 03:47:33 INFO - PROCESS | 7259 | _x_x_mozilla_page_load 03:47:33 INFO - PROCESS | 7259 | _x_x_mozilla_page_load_details 03:47:33 INFO - PROCESS | 7259 | |i|pagename|runs| 03:47:33 INFO - PROCESS | 7259 | |0;ai-astar;109;104;109;111;109;111;109;111;110;109 03:47:33 INFO - PROCESS | 7259 | |1;audio-beat-detection;155;122;125;168;128;128;147;127;178;124 03:47:33 INFO - PROCESS | 7259 | |2;audio-dft;160;161;162;159;159;160;161;164;161;159 03:47:33 INFO - PROCESS | 7259 | |3;audio-fft;74;75;74;126;74;74;75;75;96;77 03:47:33 INFO - PROCESS | 7259 | |4;audio-oscillator;84;85;117;85;84;84;122;84;83;129 03:47:33 INFO - PROCESS | 7259 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;116;117 03:47:33 INFO - PROCESS | 7259 | |6;imaging-darkroom;145;146;145;145;145;145;145;146;145;145 03:47:33 INFO - PROCESS | 7259 | |7;imaging-desaturate;94;94;95;95;95;94;95;95;94;95 03:47:33 INFO - PROCESS | 7259 | |8;json-parse-financial;50;52;54;50;51;52;51;51;51;50 03:47:33 INFO - PROCESS | 7259 | |9;json-stringify-tinderbox;59;58;58;58;59;59;58;59;58;59 03:47:33 INFO - PROCESS | 7259 | |10;stanford-crypto-aes;80;76;75;80;82;82;80;76;111;80 03:47:33 INFO - PROCESS | 7259 | |11;stanford-crypto-ccm;120;128;117;119;122;121;115;116;131;118 03:47:33 INFO - PROCESS | 7259 | |12;stanford-crypto-pbkdf2;154;152;152;151;150;155;157;152;149;147 03:47:33 INFO - PROCESS | 7259 | |13;stanford-crypto-sha256-iterative;62;61;60;60;64;60;60;60;60;59 03:47:33 INFO - PROCESS | 7259 | __end_tp_report 03:47:33 INFO - PROCESS | 7259 | __start_cc_report 03:47:33 INFO - PROCESS | 7259 | _x_x_mozilla_cycle_collect,1586 03:47:33 INFO - PROCESS | 7259 | __end_cc_report 03:47:33 INFO - PROCESS | 7259 | __startTimestamp1468666053768__endTimestamp 03:47:33 INFO - PROCESS | 7259 | 03:47:33 INFO - PROCESS | 7259 | ------- Summary: start ------- 03:47:33 INFO - PROCESS | 7259 | Number of tests: 14 03:47:33 INFO - PROCESS | 7259 | 03:47:33 INFO - PROCESS | 7259 | [#0] ai-astar Cycles:10 Average:109.20 Median:109.50 stddev:2.04 (1.9%) stddev-sans-first:2.17 03:47:33 INFO - PROCESS | 7259 | Values: 109.0 104.0 109.0 111.0 109.0 111.0 109.0 111.0 110.0 109.0 03:47:33 INFO - PROCESS | 7259 | 03:47:33 INFO - PROCESS | 7259 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:137.50 stddev:20.45 (14.9%) stddev-sans-first:20.98 03:47:33 INFO - PROCESS | 7259 | Values: 155.0 122.0 125.0 168.0 128.0 128.0 147.0 127.0 178.0 124.0 03:47:33 INFO - PROCESS | 7259 | 03:47:33 INFO - PROCESS | 7259 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.58 (1.0%) stddev-sans-first:1.66 03:47:33 INFO - PROCESS | 7259 | Values: 160.0 161.0 162.0 159.0 159.0 160.0 161.0 164.0 161.0 159.0 03:47:33 INFO - PROCESS | 7259 | 03:47:33 INFO - PROCESS | 7259 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.00 stddev:16.87 (22.5%) stddev-sans-first:17.64 03:47:33 INFO - PROCESS | 7259 | Values: 74.0 75.0 74.0 126.0 74.0 74.0 75.0 75.0 96.0 77.0 03:47:33 INFO - PROCESS | 7259 | 03:47:33 INFO - PROCESS | 7259 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:84.00 stddev:18.83 (22.4%) stddev-sans-first:19.49 03:47:33 INFO - PROCESS | 7259 | Values: 84.0 85.0 117.0 85.0 84.0 84.0 122.0 84.0 83.0 129.0 03:47:33 INFO - PROCESS | 7259 | 03:47:33 INFO - PROCESS | 7259 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:47:33 INFO - PROCESS | 7259 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 03:47:33 INFO - PROCESS | 7259 | 03:47:33 INFO - PROCESS | 7259 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 03:47:33 INFO - PROCESS | 7259 | Values: 145.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 03:47:33 INFO - PROCESS | 7259 | 03:47:33 INFO - PROCESS | 7259 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 03:47:33 INFO - PROCESS | 7259 | Values: 94.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 03:47:33 INFO - PROCESS | 7259 | 03:47:33 INFO - PROCESS | 7259 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.00 stddev:1.23 (2.4%) stddev-sans-first:1.22 03:47:33 INFO - PROCESS | 7259 | Values: 50.0 52.0 54.0 50.0 51.0 52.0 51.0 51.0 51.0 50.0 03:47:33 INFO - PROCESS | 7259 | 03:47:33 INFO - PROCESS | 7259 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:59.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 03:47:33 INFO - PROCESS | 7259 | Values: 59.0 58.0 58.0 58.0 59.0 59.0 58.0 59.0 58.0 59.0 03:47:33 INFO - PROCESS | 7259 | 03:47:33 INFO - PROCESS | 7259 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:80.00 stddev:10.42 (13.0%) stddev-sans-first:11.02 03:47:33 INFO - PROCESS | 7259 | Values: 80.0 76.0 75.0 80.0 82.0 82.0 80.0 76.0 111.0 80.0 03:47:33 INFO - PROCESS | 7259 | 03:47:33 INFO - PROCESS | 7259 | [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:120.50 stddev:5.17 (4.3%) stddev-sans-first:5.47 03:47:33 INFO - PROCESS | 7259 | Values: 120.0 128.0 117.0 119.0 122.0 121.0 115.0 116.0 131.0 118.0 03:47:33 INFO - PROCESS | 7259 | 03:47:33 INFO - PROCESS | 7259 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:152.00 stddev:2.92 (1.9%) stddev-sans-first:3.00 03:47:33 INFO - PROCESS | 7259 | Values: 154.0 152.0 152.0 151.0 150.0 155.0 157.0 152.0 149.0 147.0 03:47:33 INFO - PROCESS | 7259 | 03:47:33 INFO - PROCESS | 7259 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.60 Median:60.00 stddev:1.43 (2.4%) stddev-sans-first:1.42 03:47:33 INFO - PROCESS | 7259 | Values: 62.0 61.0 60.0 60.0 64.0 60.0 60.0 60.0 60.0 59.0 03:47:33 INFO - PROCESS | 7259 | -------- Summary: end -------- 03:47:33 INFO - PROCESS | 7259 | 03:47:34 INFO - TEST-INFO | 7259: exit 0 03:47:34 INFO - TEST-OK | kraken | took 59838ms 03:47:34 INFO - SUITE-END | took 1172s 03:47:34 INFO - Completed test suite (00:19:32) 03:47:34 INFO - javascript benchmark 03:47:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3330.7002369786724, 3355.7483188760834, 3367.30970151119, 3381.4251577231867, 3403.6256011838695, 5453.754581043852, 5512.924979628969, 5550.111982082867, 5558.944410555893, 5562.471565201305, 5482.23248745176, 5534.114541673333, 5543.944560554393, 5549.694766787825, 5561.805336813212, 4876.731779752112, 4951.084049450845, 5014.147594908874, 5037.49625037497, 5066.771995260222, 4969.900601987976, 5064.670796398223, 5069.417017043032, 5111.744412779365, 5186.3257776489, 5112.565431938289, 5117.027764724709, 5134.460881607433, 5190.584753219752, 5197.1424714922, 5131.153359695646, 5195.376554813409, 5197.168453047513, 5205.609579281531, 5228.320318358627, 4850.514948505156, 4914.33656456381, 5034.924476132861, 5040.949590504085, 5095.643304968654, 5426.864328391783, 5443.891122177534, 5450.972745136289, 5470.097433923398, 5491.780328786844, 5891.440313170242, 5904.350521442638, 5923.644581325134, 5934.732937017845, 5946.791862284799, 5595.21666966625, 5828.184054232411, 5838.065909454467, 5859.970700146515, 5970.044792833126, 5555.138953462219, 5581.832545023615, 5582.162675598652, 5584.413636568183, 5591.8042868499815, 5842.415758424124, 6050.606710563799, 6063.484603808725, 6066.211392518944, 6072.332043475214, 5792.333881603669, 5834.795782147689, 5844.357120716718, 5893.027650437715, 5938.732757025944, 5956.463918247378, 5963.075723262901, 5999.160117583542, 5999.670018149044, 6011.0, 5683.5737319700365, 5699.857503562444, 5893.410658934158, 5897.32180799205, 5904.261967254093, 5753.913691294634, 5811.389804070596, 5813.302403711497, 5821.068629019336, 5851.736671849777, 4465.977670111693, 4487.596116349544, 4499.707519011254, 4499.797509112098, 4525.773711314421, 4024.3158663027357, 4035.8183881725395, 4039.51525816898, 4081.734687245379, 4085.7140000200293, 5683.715814209273, 5692.459216374438, 5701.686407247641, 5705.771769129188, 5706.686132262683, 5984.581079324405, 6008.729607167688, 6022.397760223943, 6028.306744724325, 6063.514918806573, 5416.810411635653, 5549.361823390281, 5645.858853528694, 5651.208830763697, 5682.431756824367, 5137.049645815461, 5139.383274007068, 5153.0, 5154.123798954187, 5155.329807125125, 5966.85082872923, 6265.530085243625, 6277.435030847246, 6281.968590157111, 6289.308176100625, 5878.912401205791, 5929.318128415288, 5935.228420305505, 5998.610090344114, 6003.489703375262, 6209.515077830756, 6239.032949892774, 6249.875002500015, 6252.218472690914, 6254.093156492374, 5685.346185188756, 5688.431156884279, 5871.060630299132, 5880.617759845596, 5907.113932910098, 5783.450572195635, 5871.1486834409625, 5871.2073870027, 5876.676782776988, 5911.438413350725, 5691.544676425959, 5695.487406133302, 5722.5421966241765, 5738.053221218619, 5741.799037033684, 5563.13771365439, 5719.5710321726865, 5729.02606556878, 5750.194972703741, 5765.538756899354, 5776.42235776419, 5777.191193233035, 5779.2198053263955, 5779.739911703899, 5810.0, 5884.941150588439, 5897.351291358033, 5933.732982015733, 5933.881322373615, 5935.732892019783, 5581.609287349846, 5599.496045355938, 5624.803131890364, 5645.096784514622, 5802.6808525531505], "value": 5474.819797970236, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.2058703098941, 654.9803505894823, 658.9802305930824, 666.9861810048725, 667.8029981155564, 33669.494957575625, 46689.76655116728, 47741.76129119358, 47954.760226198865, 48009.27986080203, 49449.75275123619, 49959.25061124086, 49959.50040499594, 50055.49944500554, 50061.0, 8410.873836892451, 9095.135962083608, 9248.6300547978, 10898.673039808818, 11218.551257949672, 10906.0, 11008.779824403508, 11010.0, 11014.0, 11028.22802403832, 11118.832522585133, 11154.498047587838, 11176.273542219771, 11181.44092795357, 11182.27315224512, 8455.408121431472, 10761.83857242138, 11035.227534072617, 11038.724031899266, 11379.886201137966, 10957.83563246552, 11021.614243501519, 11028.889711102867, 11041.779164416746, 11050.889491105067, 45637.543624563994, 46028.07943841104, 46206.0, 46261.074778504575, 46262.76868615669, 3490.598581163148, 3543.5747710274672, 3546.2198316370614, 3670.8164591770574, 4038.7172897896867, 34515.82742086299, 34756.47865282023, 35261.82369088164, 35366.46950295748, 35521.28957420837, 4478.350639157336, 4502.167099086647, 4558.475775285851, 4602.263637817933, 4617.561331673485, 366410.0, 368771.0, 369213.0, 369901.0, 370783.14608427056, 37938.0, 38965.610343896195, 63454.36545634484, 64382.0, 64408.67795661085, 41129.383059254134, 41201.79399102985, 41287.0, 41314.0, 41358.1728365431, 14956.252187390586, 16592.917035414986, 16777.0, 16781.07704076263, 16783.580410489834, 13590.93204533971, 13841.377138028813, 13870.4451821926, 14188.148711077369, 14218.217998010208, 9236.353455258202, 9241.95379023114, 9247.167754901957, 9297.860532092023, 9305.674301399555, 3550.25444656625, 3586.5875424326537, 3608.386574282378, 3609.512715783336, 3624.818759062089, 934.3226161033197, 988.0, 1002.7242508310273, 1062.6918193723734, 1065.3235195650664, 33165.834170829476, 33894.32211355808, 34015.489767653504, 34079.82960085184, 34110.31779364399, 1064.6912395405245, 1090.1660229924114, 1103.933763974148, 1112.0880877680224, 1125.5722825326325, 17265.352844110355, 17905.400379826362, 18248.45254642363, 18285.63428731418, 18299.72550411745, 600804.0, 607152.0, 610658.0, 613034.0, 613423.0, 64246.678766605866, 64598.0, 64860.67569662121, 65083.67458162679, 65170.348296517375, 1311.5016293808292, 1355.7559639265028, 1372.972595427081, 1381.9309034548432, 1405.3956798576505, 31370.843145784125, 33924.49113263352, 34402.139946501535, 34697.1325716849, 34894.65105348914, 54463.0, 60410.69794650999, 62342.0, 62580.0, 70152.0, 543193.0, 543500.0, 547164.0, 548389.0, 548579.0, 39141.0, 44273.0, 45044.77477612591, 49038.50961490339, 49750.502494974586, 51468.74265628648, 52245.0, 52251.47748522618, 52914.0, 53265.46734532605, 42355.7882210587, 43312.78343608262, 43875.12249755051, 44360.11279774322, 44723.32915006213, 42029.0, 42444.78777606092, 42857.57142428536, 42966.14067718566, 44169.33745993749, 42723.7863810679, 43975.0, 44145.0, 44278.55721442744, 44380.556194437646, 37675.0, 37737.62262377341, 38336.041598959135, 38903.0, 39055.2188956225, 29272.56091158592, 29281.092347527385, 29361.706382935896, 29676.851615741783, 29730.554041689826], "value": 20867.087758727423, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.3376695985543, 407.3299422450068, 414.22746577632705, 432.8095637919315, 442.88484993901574, 18668.159932803024, 19810.70283945742, 20240.59518809625, 20936.16255349788, 21510.354689359305, 18395.724064139016, 18430.631387372243, 18577.90711046446, 18610.627787444242, 19982.12246114121, 5637.3517045539875, 5866.530677545786, 5878.382769809173, 5879.7648094076185, 5882.264716910387, 4205.13794672093, 5497.9828731684565, 5706.343770466408, 5736.0, 6280.057991301319, 6320.525960552977, 6366.713497892606, 6396.808095757135, 6473.643949582771, 6500.3174666660025, 6284.214473190851, 6323.30443651198, 6456.2575303840185, 6466.547341686084, 6471.935280647181, 3829.2341531693496, 5331.093714068617, 5657.8019769307875, 5739.598228124033, 5756.8848623027725, 24201.152959646504, 24224.757752422425, 24656.506869862504, 25107.49785004308, 25183.496330073478, 2166.73999120105, 2439.878006099688, 2537.479816637603, 2670.7329267073333, 2824.4209936962875, 10027.0, 10643.095336896373, 10643.095336896373, 10762.408067556282, 10890.237683362167, 1941.6116776644728, 2006.6989951507392, 2082.6563617003176, 2110.6306396380573, 2112.7781582933726, 65758.0, 81920.59039704764, 84388.57805710993, 85317.57341213254, 88225.11774882233, 11418.486168122454, 11462.598809041643, 11583.710407239718, 11596.420178991186, 11826.467808948619, 16728.749068763977, 16749.66500670004, 16850.410235641695, 16852.91573542149, 16890.915545422195, 8578.18507241811, 8763.123687631314, 8774.692885748967, 8811.691590794291, 8928.196462318423, 8553.871691924625, 8565.48607083577, 8692.826143477096, 8719.346049046348, 8916.019237883827, 4868.172410690191, 4927.43334516528, 4959.950400496021, 4968.254761785689, 5023.171176755867, 1825.0671636612449, 2021.5855749571303, 2035.2571311471206, 2054.989725051365, 2090.7595626502844, 860.9827803443897, 912.2291663544295, 931.9748276895361, 939.8778158839444, 1011.8077565262577, 19046.428607141806, 19129.426117216506, 19289.03554822253, 19379.903100484407, 20113.99430028493, 899.8020435504178, 907.5326207003399, 967.4243824924159, 1002.5338217728645, 1046.4140081554353, 10602.734931626772, 10910.454477276264, 10973.615923442641, 10974.286671366335, 11008.834867476995, 468980.0, 469550.0, 481288.0, 487825.56087219337, 490665.0, 97349.0, 100099.0, 102337.48831255797, 102497.48751256346, 103029.48485257526, 1029.0789743179962, 1051.8369652703843, 1061.6549621373085, 1079.5519859258477, 1080.1197024425069, 17353.913230433765, 17361.0, 17369.0, 17774.20016099253, 17820.198091085673, 41650.791746041075, 44105.33841992437, 44549.55450445454, 45485.54514454813, 45844.54155458403, 61237.693811530655, 62286.68856655688, 62576.0, 62783.37216627775, 64208.0, 9118.133777291147, 9236.815263694554, 9237.214836738953, 9350.859737104085, 9531.666391676257, 12516.749665006831, 13145.802812957621, 13433.731325373634, 13620.591382258548, 13726.588202353945, 11503.76992460163, 11628.6511404658, 11718.648440546796, 11756.118291128028, 11861.110416718608, 11280.0, 11550.133739969368, 11563.826542601699, 11706.648800535997, 11794.115441341763, 11576.652700419001, 11937.224080434744, 11949.880501194877, 11977.101717371406, 12000.279983200686, 9077.500737459502, 9175.128362805523, 9182.954085229798, 9303.0, 9375.437473751597, 10411.687649370531, 11361.261518001304, 11383.943080284545, 11453.770924581628, 11577.0], "value": 9528.99347890171, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.506617617658, 1549.7133030389375, 1575.228138212276, 1779.656359448616, 1934.9129289181985, 8997.685081022166, 9343.859842102365, 9403.153716165543, 9662.130408263254, 9666.27502937279, 9397.530123493832, 9579.904200958006, 9581.473018983954, 9592.52037398129, 9607.375520591157, 2470.765277298658, 2483.0316176691103, 2487.825852190347, 2499.9375015624573, 2500.6374075759004, 2481.10680155144, 2552.119518766032, 2553.234029791055, 2557.1689201009744, 2558.744125587445, 2469.9135530256444, 2474.8391354561986, 2496.488219914922, 2506.5613517634433, 2512.0, 2377.7741114594087, 2384.7615238476187, 2390.3546042568582, 2441.6703744994375, 2444.3766839455825, 2369.2300002499082, 2381.8094552435764, 2387.9164229252065, 2397.137030668958, 2440.9511809763885, 8817.426867253673, 8983.640654373818, 9426.811463770755, 9447.669331573363, 9487.952560237154, 5482.342118945712, 5605.467480589337, 5609.467100625434, 5613.66318020916, 5617.21359009739, 3542.220711443478, 3563.4832949222478, 3621.2938476996997, 3626.202235508184, 3640.763350382243, 1132.9433528323634, 1145.043888353226, 1178.2459226095307, 1201.0391686650732, 2233.1737257214936, 13305.86694133056, 13622.591322260248, 13738.313084345742, 13765.724685506333, 13791.10357826738, 4650.883727906762, 4675.298705194248, 4721.173794586002, 4723.126221649006, 4745.430548334153, 10669.413182274895, 10721.142308615292, 10731.785364292671, 10765.084967777826, 10774.19193560486, 5601.29983752031, 5602.467765562265, 5604.495595396434, 5609.859753506195, 5610.831675049755, 4404.533461261703, 4433.091216300651, 4456.955430445654, 5098.719570423662, 5155.123628983082, 4006.719529632898, 4075.836966521306, 4119.711620186618, 4128.3601041837965, 4173.916521669549, 1198.6044605280238, 1220.1093201962617, 1227.5642147037852, 1230.5939040116739, 1237.189640785287, 1005.0150852164919, 1014.8886968769186, 1049.879263884663, 1055.3245922609535, 1058.5183741397645, 6416.679166041679, 6436.967815160988, 6457.580257283262, 6501.219853617502, 6676.9666151668935, 446.66276960894965, 455.5785898044362, 471.16838779554115, 476.2855716425362, 495.44510148633043, 4438.60052595268, 4467.0, 4512.887177820581, 4646.1172377248895, 4655.092257009918, 11468.655940321803, 11986.460609272604, 12021.459034343301, 12023.158378913393, 12029.15795894279, 11389.658310250707, 11795.35125568085, 11862.822057669142, 12020.158588898868, 12063.577774778016, 8767.25478334336, 8931.19619234272, 8963.417377870417, 8967.910320896837, 8971.730848074569, 6514.771982980573, 6791.083203767428, 6793.2867048961125, 6943.062686537252, 6955.478339124687, 10951.83572246433, 11108.61119860801, 11110.111640830373, 11250.268732532359, 11276.210665253682, 11175.944120279346, 11483.196176267582, 11525.962663360338, 11674.533018679158, 11690.532378704756, 7609.162992070757, 8189.79525511867, 8382.16178382157, 8386.11945745688, 8633.95683021581, 9288.303377246599, 9334.906650933404, 9356.0, 9379.0, 9382.765430864283, 8207.589620518831, 8250.174982501701, 8252.174782521699, 8398.664053437795, 8402.579871006303, 7936.484128531627, 7951.0, 8226.794330141554, 8243.629036693243, 8278.586070696321, 7427.740029099172, 7443.627818609156, 7503.09962804467, 7510.061242344707, 7515.0, 5335.973320133375, 5348.064088784369, 5380.596455265949, 5528.806491772769, 5541.778328866801, 5405.918911216414, 5533.916991245215, 5629.0712032514175, 5651.632643878134, 5691.203231547669], "value": 4874.20208153346, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.6179809512393, 353.4115697363889, 355.30892414254254, 361.34235691042295, 361.3423569104231, 5469.425710300421, 5522.723863806814, 5564.1931919871595, 5603.523700485463, 5640.323161220655, 5168.198929165976, 5218.191180367049, 5310.13252843465, 5378.731063446822, 5467.234587157801, 4312.5903039211225, 4320.395144679747, 4330.350447432878, 4335.43639326887, 4345.130973805251, 4332.9566704332865, 4339.153864996327, 4343.413639158721, 4346.84786032489, 4351.347297905324, 4143.177002119073, 4291.468033860022, 4302.096559722462, 4305.418768466248, 4337.436133302666, 4249.4475718156755, 4252.893677658052, 4271.860182765665, 4272.658187345036, 4299.91400171998, 3765.1151979284846, 3784.9621503784883, 3785.6782173515285, 3813.9237215255816, 3821.4840996465678, 5161.6121308858665, 5290.81482148123, 5322.121849894801, 5328.46715328468, 5391.78432862685, 4797.673128532659, 4857.101436234308, 4886.364772579577, 4890.926636100426, 4891.4863939286215, 5682.039696304768, 5694.259746232963, 5696.943030569682, 5697.4587414196, 5729.856753581152, 3951.8221680024467, 4163.542010378856, 4186.748795072275, 4189.72766770159, 4195.139996300751, 5918.970405147947, 5985.371535988746, 5991.760329586811, 6003.429674180946, 6009.978303688384, 4289.528151903288, 4293.914121717548, 4300.462442194726, 4312.7627980461375, 4313.0, 3948.2103579284258, 4080.6332327250125, 4145.97927010369, 4352.956470435319, 4353.717008394444, 4782.880427989328, 4786.569208771228, 4789.688670236424, 4794.232922732416, 4809.78355973982, 5727.165053298644, 5750.88498230033, 5760.913586296209, 5787.977355737722, 5817.556626216999, 1478.5268714011413, 1479.3899504881485, 1487.7247709173837, 1491.7836913647461, 1493.7527164817282, 949.4113649537331, 959.4866746290841, 963.3160456076124, 965.7875267441152, 970.1995853420815, 4945.4807245238735, 4976.2286845539, 5057.468965758542, 5120.0, 5127.282180494733, 5256.816011439658, 5264.973675131677, 5265.447128051576, 5275.472452754694, 5298.165481467474, 4813.422389313305, 4914.238293064581, 5034.471380505068, 5039.874003149877, 5047.217681259411, 2768.321761168527, 2785.4986102501744, 2787.5539913613725, 2789.3445040415486, 2820.2244382794897, 5459.0, 5493.972530137324, 5517.69652669099, 5535.750891209906, 5538.839852457545, 5322.760475778599, 5325.86685332862, 5461.5357694596405, 6012.549058820518, 6045.274567051982, 6172.845678858064, 6195.81412557615, 6198.938010619836, 6221.875562488815, 6242.375762423721, 5705.486506214461, 5913.142594323713, 5920.3783602722815, 5977.163197152315, 5984.222051133499, 5861.882762344814, 5885.705714714333, 5888.381719919346, 5929.00585204469, 5963.671998040149, 6071.878562428815, 6174.907376389448, 6204.5036397089025, 6254.343293954069, 6265.843353916189, 4110.321796903597, 4143.316352801875, 4288.549702281215, 4330.7401555906745, 4339.004058133168, 5834.38738932423, 5922.318933322723, 5965.433283838029, 5966.0, 5969.925413425625, 5749.1663708762835, 5781.884362312814, 5790.739416726342, 5821.825345239649, 5842.474177324061, 5656.830295091154, 5743.195952566728, 5760.654360738369, 5782.335031471266, 5787.826365209051, 5733.795902860446, 5746.913796292975, 5770.855728606651, 5770.942290577041, 5783.710814459344, 5657.10486986864, 5879.382664820303, 5888.793892213752, 5889.5582831286965, 5901.793437229677, 5764.59647824665, 5769.644133628678, 5775.978407557489, 5786.594938354443, 5787.0], "value": 4338.926961995962, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.5498426023088, 759.8290384663452, 784.9646765895534, 792.3661071143084, 839.2530647723523, 15516.767248491282, 16546.420875269367, 16573.834261657394, 16603.169841507908, 16632.25154868031, 14938.327775250113, 15123.395064197446, 15131.62170945727, 15228.162451065187, 15316.770248446282, 686.8797960356942, 832.4921797703396, 852.3607294529088, 867.4361664917823, 869.0657543141117, 839.6221700234919, 842.0, 845.5941148248844, 847.1274587175219, 847.504210037129, 912.3750231091724, 914.2137761525083, 914.2777206007246, 914.6204325205032, 914.6615752171706, 751.2525037587608, 857.7298151082421, 898.1961144775422, 904.5115637555712, 917.4311926605548, 677.6510097299895, 678.6165816313767, 679.1171477079826, 679.5481005131581, 679.9286074962107, 15792.289346979414, 15830.20848957559, 15837.762433563506, 15842.603934901605, 15857.286422111032, 15147.54557363281, 15460.381584736597, 15468.458603948808, 15504.147271900041, 15822.52532424029, 13573.389197486038, 13582.864171358258, 13592.592222233348, 13644.181349119084, 14054.43782248719, 4630.120277147331, 4670.206064968964, 4695.319178719066, 4710.505396933307, 4757.09615173116, 79621.0, 80114.0, 80290.0, 81271.18728812695, 81440.18559814444, 12142.271463712206, 12189.634310970509, 12626.936865315614, 12702.0, 12920.0, 20770.273040443513, 21494.677579836316, 21504.13983440676, 22362.105515779513, 22425.32724018282, 9109.453432794053, 9288.953555232181, 9558.856617150748, 9621.08599683029, 9750.853737193947, 4921.729304888194, 5007.349044624249, 5040.672356296829, 5086.5422112009355, 5176.663516871391, 3725.1245957200035, 3786.053486628343, 3811.6760075393904, 3819.3125237457525, 3824.847006119724, 630.2846269484169, 687.7764726463919, 695.9373656370951, 705.340506626306, 706.7067167125688, 612.5865041097242, 643.9291677915426, 704.723727513426, 759.8252401947583, 773.6325245508339, 10585.0, 11055.336619866119, 11261.43692815356, 11265.493052812642, 11295.887041129483, 666.4235436347622, 678.3657280442802, 708.482807550491, 774.6126936531734, 799.6681377228501, 5272.420033796279, 5281.9207711884355, 5338.813141540028, 5379.300690910157, 5392.40683524812, 73317.6334118326, 111098.44450777695, 112644.1122684261, 115513.0, 120202.3989880045, 97633.51183244039, 98608.0, 103672.48163759134, 104333.47833260937, 104409.0, 84772.99999999876, 86712.5664371674, 89315.55342223248, 89710.55144724365, 89843.55078224567, 9810.607575696893, 9969.252306076929, 10086.798264034825, 10100.343477673927, 10122.139618132542, 54239.0, 54377.0, 54457.18314225369, 54553.45446545484, 55593.444065558826, 67619.66190169018, 72916.27083729306, 79391.60304198442, 80281.0, 80336.59831700804, 13741.793873091712, 13981.684123415485, 14358.56924292273, 14403.42386304578, 14749.778753318495, 15040.623984400478, 15999.520014399586, 16021.51935441892, 16157.515274541782, 16453.753193702345, 13969.155113994273, 14094.224817635128, 14612.92693536568, 14823.0, 15180.316885739947, 13998.720025599634, 14030.719385612434, 14518.346674399889, 14586.927065364605, 15318.770218446509, 14223.0, 14502.0, 14594.489192878198, 14762.852371476149, 15093.169875656944, 12598.433070512032, 12846.678833028875, 12978.545750898673, 13182.60452186436, 13272.0, 12641.178323408949, 12696.428660710106, 12722.554710585086, 13089.934550327187, 13112.0], "value": 8062.976075053183, "unit": "score"}], "name": "dromaeo_css", "value": 7552.961722846398, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 104.0, 109.0, 111.0, 109.0, 111.0, 109.0, 111.0, 110.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 125.0, 168.0, 128.0, 128.0, 147.0, 127.0, 178.0, 124.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 159.0, 159.0, 160.0, 161.0, 164.0, 161.0, 159.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 126.0, 74.0, 74.0, 75.0, 75.0, 96.0, 77.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 117.0, 85.0, 84.0, 84.0, 122.0, 84.0, 83.0, 129.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 54.0, 50.0, 51.0, 52.0, 51.0, 51.0, 51.0, 50.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 58.0, 59.0, 59.0, 58.0, 59.0, 58.0, 59.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 75.0, 80.0, 82.0, 82.0, 80.0, 76.0, 111.0, 80.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 128.0, 117.0, 119.0, 122.0, 121.0, 115.0, 116.0, 131.0, 118.0], "value": 120.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 152.0, 152.0, 151.0, 150.0, 155.0, 157.0, 152.0, 149.0, 147.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 60.0, 64.0, 60.0, 60.0, 60.0, 60.0, 59.0], "value": 60.6, "unit": "score"}], "name": "kraken", "value": 1469.3000000000002, "alertThreshold": 2.0}]} 03:47:34 INFO - Return code: 0 03:47:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:47:35 ERROR - # TBPL SUCCESS # 03:47:35 INFO - Running post-action listener: _resource_record_post_action 03:47:35 INFO - ##### 03:47:35 INFO - ##### Finished run-tests step (success) 03:47:35 INFO - ##### 03:47:35 INFO - Running post-run listener: _resource_record_post_run 03:47:35 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 368640; Write bytes: 507031552; Read time: 80; Write time: 535140 03:47:35 INFO - TinderboxPrint: CPU usage
13.1% 03:47:35 INFO - TinderboxPrint: I/O read bytes / time
368,640 / 80 03:47:35 INFO - TinderboxPrint: I/O write bytes / time
507,031,552 / 535,140 03:47:35 INFO - TinderboxPrint: CPU idle
8,245.6 (86.9%) 03:47:35 INFO - TinderboxPrint: CPU user
1,198.4 (12.6%) 03:47:35 INFO - TinderboxPrint: Swap in / out
0 / 0 03:47:35 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252542976; Read time: 0; Write time: 345220 03:47:35 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 344064; Write bytes: 253902848; Read time: 56; Write time: 189904 03:47:35 INFO - Running post-run listener: _upload_blobber_files 03:47:35 INFO - Blob upload gear active. 03:47:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:47:35 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:47:35 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:47:35 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:47:36 INFO - (blobuploader) - INFO - Open directory for files ... 03:47:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:47:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:47:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:36 INFO - (blobuploader) - INFO - Done attempting. 03:47:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:47:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:47:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:37 INFO - (blobuploader) - INFO - Done attempting. 03:47:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:47:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:47:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:41 INFO - (blobuploader) - INFO - Done attempting. 03:47:41 INFO - (blobuploader) - INFO - Iteration through files over. 03:47:41 INFO - Return code: 0 03:47:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:47:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:47:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ecc579a704ccd0d5bc054ffd6da3cac4e84093a2463a8e3ab2dbe8c37ef9fdbfb6e3044b4db9b7ab3e0f56d5def935d8a2f9294020f6b7fa22da079ca04bcdaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/288101bc8f1736d77a5539d0828a6fe88134f76b918a8d91b3862809f28ce1ee82bb9ca99204a3fca2db7e1b7a39d6cd230bf909cad79a8b557b23588b382f0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73d97dbedb032fecd4dcd13cabb9aefebb147c88d6c3fb5c832c1f8a0660b6ef670bd81f4adeb32d9fd297c6945f27877062ef6d3849dfc5c44af89a9df34c52"} 03:47:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:47:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:47:41 INFO - Contents: 03:47:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ecc579a704ccd0d5bc054ffd6da3cac4e84093a2463a8e3ab2dbe8c37ef9fdbfb6e3044b4db9b7ab3e0f56d5def935d8a2f9294020f6b7fa22da079ca04bcdaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/288101bc8f1736d77a5539d0828a6fe88134f76b918a8d91b3862809f28ce1ee82bb9ca99204a3fca2db7e1b7a39d6cd230bf909cad79a8b557b23588b382f0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73d97dbedb032fecd4dcd13cabb9aefebb147c88d6c3fb5c832c1f8a0660b6ef670bd81f4adeb32d9fd297c6945f27877062ef6d3849dfc5c44af89a9df34c52"} 03:47:41 INFO - Running post-run listener: copy_logs_to_upload_dir 03:47:41 INFO - Copying logs to upload dir... 03:47:41 INFO - mkdir: /builds/slave/test/build/upload/logs 03:47:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.284902 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-16 03:47:41.323529) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 03:47:41.327730) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262 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/ecc579a704ccd0d5bc054ffd6da3cac4e84093a2463a8e3ab2dbe8c37ef9fdbfb6e3044b4db9b7ab3e0f56d5def935d8a2f9294020f6b7fa22da079ca04bcdaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/288101bc8f1736d77a5539d0828a6fe88134f76b918a8d91b3862809f28ce1ee82bb9ca99204a3fca2db7e1b7a39d6cd230bf909cad79a8b557b23588b382f0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73d97dbedb032fecd4dcd13cabb9aefebb147c88d6c3fb5c832c1f8a0660b6ef670bd81f4adeb32d9fd297c6945f27877062ef6d3849dfc5c44af89a9df34c52"} build_url:https://queue.taskcluster.net/v1/task/eFGRkjuwRaGS5pPd7c8ACA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/eFGRkjuwRaGS5pPd7c8ACA/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/ecc579a704ccd0d5bc054ffd6da3cac4e84093a2463a8e3ab2dbe8c37ef9fdbfb6e3044b4db9b7ab3e0f56d5def935d8a2f9294020f6b7fa22da079ca04bcdaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/288101bc8f1736d77a5539d0828a6fe88134f76b918a8d91b3862809f28ce1ee82bb9ca99204a3fca2db7e1b7a39d6cd230bf909cad79a8b557b23588b382f0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73d97dbedb032fecd4dcd13cabb9aefebb147c88d6c3fb5c832c1f8a0660b6ef670bd81f4adeb32d9fd297c6945f27877062ef6d3849dfc5c44af89a9df34c52"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 03:47:41.353549) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:47:41.353969) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1468663625.757883-1079288262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:47:41.438183) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 03:47:41.438504) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 03:47:41.438779) ========= ========= Total master_lag: 0.19 =========