builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1469874912.53 results: success (0) buildid: 20160730004003 builduid: 338216dfdbe9485c98cd3403364e062f revision: 8847dd9e9a2da7a4ad074ab97e085295e50746c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 03:35:12.532008) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 03:35:12.532360) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 03:35:12.532626) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 03:35:12.548133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:35:12.548607) ========= 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=c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-30 03:35:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-07-30 03:35:13 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103940 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:35:12.667176) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:35:12.667612) ========= 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=c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015834 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:35:12.716419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-30 03:35:12.716715) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8847dd9e9a2da7a4ad074ab97e085295e50746c3 --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 8847dd9e9a2da7a4ad074ab97e085295e50746c3 --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=c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-30 03:35:13,360 truncating revision to first 12 chars 2016-07-30 03:35:13,360 Setting DEBUG logging. 2016-07-30 03:35:13,360 attempt 1/10 2016-07-30 03:35:13,360 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8847dd9e9a2d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-30 03:35:14,274 unpacking tar archive at: mozilla-aurora-8847dd9e9a2d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.307186 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-30 03:35:14.037626) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 03:35:14.037964) ========= script_repo_revision: 8847dd9e9a2da7a4ad074ab97e085295e50746c3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 03:35:14.038350) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 03:35:14.038619) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 03:35:14.051591) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-30 03:35:14.051899) ========= /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=c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:35:14 INFO - MultiFileLogger online at 20160730 03:35:14 in /builds/slave/test 03:35:14 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:35:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:35:14 INFO - {'append_to_log': False, 03:35:14 INFO - 'base_work_dir': '/builds/slave/test', 03:35:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:35:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:35:14 INFO - 'branch': 'Mozilla-Aurora', 03:35:14 INFO - 'buildbot_json_path': 'buildprops.json', 03:35:14 INFO - 'config_files': ('talos/linux_config.py',), 03:35:14 INFO - 'default_actions': ('clobber', 03:35:14 INFO - 'read-buildbot-config', 03:35:14 INFO - 'download-and-extract', 03:35:14 INFO - 'populate-webroot', 03:35:14 INFO - 'create-virtualenv', 03:35:14 INFO - 'install', 03:35:14 INFO - 'run-tests'), 03:35:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:35:14 INFO - 'download_minidump_stackwalk': True, 03:35:14 INFO - 'download_symbols': 'ondemand', 03:35:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:35:14 INFO - 'tooltool.py': '/tools/tooltool.py', 03:35:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:35:14 INFO - '/tools/misc-python/virtualenv.py')}, 03:35:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:35:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:35:14 INFO - 'installer_path': 'installer.exe', 03:35:14 INFO - 'log_level': 'info', 03:35:14 INFO - 'log_name': 'talos', 03:35:14 INFO - 'log_to_console': True, 03:35:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:35:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:35:14 INFO - 'opt_config_files': (), 03:35:14 INFO - 'pip_index': False, 03:35:14 INFO - 'sps_profile': False, 03:35:14 INFO - 'sps_profile_interval': 0, 03:35:14 INFO - 'suite': 'dromaeojs', 03:35:14 INFO - 'system_bits': '32', 03:35:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:35:14 INFO - 'title': 'talos-linux64-ix-004', 03:35:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:35:14 INFO - 'use_talos_json': True, 03:35:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:35:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:35:14 INFO - 'work_dir': 'build'} 03:35:14 INFO - ##### 03:35:14 INFO - ##### Running clobber step. 03:35:14 INFO - ##### 03:35:14 INFO - Running pre-action listener: _resource_record_pre_action 03:35:14 INFO - Running main action method: clobber 03:35:14 INFO - rmtree: /builds/slave/test/build 03:35:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:35:15 INFO - Running post-action listener: _resource_record_post_action 03:35:15 INFO - ##### 03:35:15 INFO - ##### Finished clobber step (success) 03:35:15 INFO - ##### 03:35:15 INFO - ##### 03:35:15 INFO - ##### Running read-buildbot-config step. 03:35:15 INFO - ##### 03:35:15 INFO - Running pre-action listener: _resource_record_pre_action 03:35:15 INFO - Running main action method: read_buildbot_config 03:35:15 INFO - Using buildbot properties: 03:35:15 INFO - { 03:35:15 INFO - "project": "", 03:35:15 INFO - "product": "firefox", 03:35:15 INFO - "script_repo_revision": "production", 03:35:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:35:15 INFO - "repository": "", 03:35:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:35:15 INFO - "buildid": "20160730004003", 03:35:15 INFO - "stage_platform": "linux64-pgo", 03:35:15 INFO - "basedir": "/builds/slave/test", 03:35:15 INFO - "nightly_build": "True", 03:35:15 INFO - "buildnumber": 436, 03:35:15 INFO - "slavename": "talos-linux64-ix-004", 03:35:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:35:15 INFO - "platform": "ubuntu64_hw", 03:35:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:35:15 INFO - "branch": "mozilla-aurora", 03:35:15 INFO - "repo_path": "releases/mozilla-aurora", 03:35:15 INFO - "revision": "8847dd9e9a2da7a4ad074ab97e085295e50746c3", 03:35:15 INFO - "pgo_build": "True", 03:35:15 INFO - "builduid": "338216dfdbe9485c98cd3403364e062f", 03:35:15 INFO - "slavebuilddir": "test" 03:35:15 INFO - } 03:35:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:35:15 INFO - Running post-action listener: _resource_record_post_action 03:35:15 INFO - ##### 03:35:15 INFO - ##### Finished read-buildbot-config step (success) 03:35:15 INFO - ##### 03:35:15 INFO - ##### 03:35:15 INFO - ##### Running download-and-extract step. 03:35:15 INFO - ##### 03:35:15 INFO - Running pre-action listener: _resource_record_pre_action 03:35:15 INFO - Running main action method: download_and_extract 03:35:15 INFO - mkdir: /builds/slave/test/build/tests 03:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:15 INFO - https://queue.taskcluster.net/v1/task/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:35:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:35:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:35:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/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:35:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/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:35:15 INFO - Downloaded 1361 bytes. 03:35:15 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:35:15 INFO - Using the following test package requirements: 03:35:15 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:35:15 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:35:15 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:35:15 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:15 INFO - u'jsshell-linux-x86_64.zip'], 03:35:15 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:35:15 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:35:15 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:35:15 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:35:15 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:35:15 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:35:15 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:15 INFO - https://queue.taskcluster.net/v1/task/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:35:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:35:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:35:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/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:35:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/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:35:16 INFO - Downloaded 24394141 bytes. 03:35:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:35:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:35:18 INFO - Return code: 0 03:35:18 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:35:18 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:35:18 INFO - https://queue.taskcluster.net/v1/task/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:35:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:35:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:35:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/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:35:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/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:35:19 INFO - Downloaded 24394141 bytes. 03:35:19 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:35:19 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:35:20 INFO - Return code: 0 03:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:20 INFO - https://queue.taskcluster.net/v1/task/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:35:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:35:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:35:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/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:35:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/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:35:21 INFO - Downloaded 10833369 bytes. 03:35:21 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:35:21 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:35:21 INFO - Return code: 0 03:35:21 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:35:21 INFO - https://queue.taskcluster.net/v1/task/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:35:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:35:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:35:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/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:35:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TAW81gvxQt2i0vjUyRcItg/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:35:22 INFO - Downloaded 62864243 bytes. 03:35:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:35:22 INFO - mkdir: /builds/slave/test/properties 03:35:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:35:22 INFO - Writing to file /builds/slave/test/properties/build_url 03:35:22 INFO - Contents: 03:35:22 INFO - build_url:https://queue.taskcluster.net/v1/task/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:35:23 INFO - Running post-action listener: _resource_record_post_action 03:35:23 INFO - Running post-action listener: set_extra_try_arguments 03:35:23 INFO - ##### 03:35:23 INFO - ##### Finished download-and-extract step (success) 03:35:23 INFO - ##### 03:35:23 INFO - ##### 03:35:23 INFO - ##### Running populate-webroot step. 03:35:23 INFO - ##### 03:35:23 INFO - Running pre-action listener: _resource_record_pre_action 03:35:23 INFO - Running main action method: populate_webroot 03:35:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:35:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:35:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:35:23 INFO - '--tppagecycles', 03:35:23 INFO - '7'], 03:35:23 INFO - 'tests': ['tsvgm']}}, 03:35:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:35:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:35:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:35:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:35:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:35:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:35:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:23 INFO - 'talos_options': ['--disable-e10s'], 03:35:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:35:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:35:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:23 INFO - 'talos_options': ['--disable-e10s'], 03:35:23 INFO - 'tests': ['damp', 'tps']}, 03:35:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:23 INFO - 'tests': ['damp', 'tps']}, 03:35:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:35:23 INFO - 'tests': ['dromaeo_dom']}, 03:35:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:35:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:35:23 INFO - 'tests': ['a11yr', 03:35:23 INFO - 'ts_paint', 03:35:23 INFO - 'tpaint', 03:35:23 INFO - 'sessionrestore', 03:35:23 INFO - 'sessionrestore_no_auto_restore', 03:35:23 INFO - 'tabpaint']}, 03:35:23 INFO - 'other-e10s': {'tests': ['a11yr', 03:35:23 INFO - 'ts_paint', 03:35:23 INFO - 'tpaint', 03:35:23 INFO - 'sessionrestore', 03:35:23 INFO - 'sessionrestore_no_auto_restore', 03:35:23 INFO - 'tabpaint']}, 03:35:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:35:23 INFO - 'ts_paint', 03:35:23 INFO - 'tpaint', 03:35:23 INFO - 'sessionrestore', 03:35:23 INFO - 'sessionrestore_no_auto_restore', 03:35:23 INFO - 'tabpaint']}, 03:35:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:35:23 INFO - 'ts_paint', 03:35:23 INFO - 'tpaint', 03:35:23 INFO - 'sessionrestore', 03:35:23 INFO - 'sessionrestore_no_auto_restore', 03:35:23 INFO - 'tabpaint']}, 03:35:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:35:23 INFO - 'tests': ['a11yr', 03:35:23 INFO - 'ts_paint', 03:35:23 INFO - 'tpaint', 03:35:23 INFO - 'sessionrestore', 03:35:23 INFO - 'sessionrestore_no_auto_restore', 03:35:23 INFO - 'tabpaint']}, 03:35:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:35:23 INFO - 'tests': ['a11yr', 03:35:23 INFO - 'ts_paint', 03:35:23 INFO - 'tpaint', 03:35:23 INFO - 'sessionrestore', 03:35:23 INFO - 'sessionrestore_no_auto_restore', 03:35:23 INFO - 'tabpaint']}, 03:35:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:35:23 INFO - 'tests': ['tsvgx', 03:35:23 INFO - 'tsvgr_opacity', 03:35:23 INFO - 'tart', 03:35:23 INFO - 'tscrollx', 03:35:23 INFO - 'cart']}, 03:35:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:35:23 INFO - 'tsvgr_opacity', 03:35:23 INFO - 'tart', 03:35:23 INFO - 'tscrollx', 03:35:23 INFO - 'cart']}, 03:35:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:23 INFO - 'talos_options': ['--disable-e10s'], 03:35:23 INFO - 'tests': ['tp5o']}, 03:35:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:23 INFO - 'tests': ['tp5o']}, 03:35:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:23 INFO - 'talos_options': ['--disable-e10s', 03:35:23 INFO - '--xperf_path', 03:35:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:35:23 INFO - 'tests': ['tp5n']}, 03:35:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:23 INFO - 'talos_options': ['--xperf_path', 03:35:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:35:23 INFO - 'tests': ['tp5n']}}, 03:35:23 INFO - 'talos.zip': {'path': '', 03:35:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:35:23 INFO - Running post-action listener: _resource_record_post_action 03:35:23 INFO - ##### 03:35:23 INFO - ##### Finished populate-webroot step (success) 03:35:23 INFO - ##### 03:35:23 INFO - ##### 03:35:23 INFO - ##### Running create-virtualenv step. 03:35:23 INFO - ##### 03:35:23 INFO - Running pre-action listener: _resource_record_pre_action 03:35:23 INFO - Running main action method: create_virtualenv 03:35:23 INFO - Creating virtualenv /builds/slave/test/build/venv 03:35:23 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:35:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:35:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:35:23 INFO - Using real prefix '/usr' 03:35:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:35:24 INFO - Installing distribute.............................................................................................................................................................................................done. 03:35:26 INFO - Installing pip.................done. 03:35:26 INFO - Return code: 0 03:35:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:35: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:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd908c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19041c0>, '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 0x19050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1905550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', '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:35: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', 'pip>=1.5'] in /builds/slave/test/build 03:35: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 pip>=1.5 03:35:26 INFO - Using env: {'DISPLAY': ':0', 03:35:26 INFO - 'HOME': '/home/cltbld', 03:35:26 INFO - 'LANG': 'en_US.UTF-8', 03:35:26 INFO - 'LANGUAGE': 'en_US:en', 03:35:26 INFO - 'LOGNAME': 'cltbld', 03:35:26 INFO - 'MAIL': '/var/mail/cltbld', 03:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:26 INFO - 'MOZ_NO_REMOTE': '1', 03:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:26 INFO - 'NO_EM_RESTART': '1', 03:35:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:26 INFO - 'PWD': '/builds/slave/test', 03:35:26 INFO - 'SHELL': '/bin/bash', 03:35:26 INFO - 'SHLVL': '1', 03:35:26 INFO - 'TERM': 'linux', 03:35:26 INFO - 'TMOUT': '86400', 03:35:26 INFO - 'USER': 'cltbld', 03:35:26 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', 03:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:26 INFO - '_': '/tools/buildbot/bin/python'} 03:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:26 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:35:26 INFO - Cleaning up... 03:35:26 INFO - Return code: 0 03:35:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:35: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:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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', '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 0x7fd908c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19041c0>, '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 0x19050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1905550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', '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:35: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:35: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 psutil>=3.1.1 03:35:26 INFO - Using env: {'DISPLAY': ':0', 03:35:26 INFO - 'HOME': '/home/cltbld', 03:35:26 INFO - 'LANG': 'en_US.UTF-8', 03:35:26 INFO - 'LANGUAGE': 'en_US:en', 03:35:26 INFO - 'LOGNAME': 'cltbld', 03:35:26 INFO - 'MAIL': '/var/mail/cltbld', 03:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:26 INFO - 'MOZ_NO_REMOTE': '1', 03:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:26 INFO - 'NO_EM_RESTART': '1', 03:35:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:26 INFO - 'PWD': '/builds/slave/test', 03:35:26 INFO - 'SHELL': '/bin/bash', 03:35:26 INFO - 'SHLVL': '1', 03:35:26 INFO - 'TERM': 'linux', 03:35:26 INFO - 'TMOUT': '86400', 03:35:26 INFO - 'USER': 'cltbld', 03:35:26 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', 03:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:26 INFO - '_': '/tools/buildbot/bin/python'} 03:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:26 INFO - Downloading/unpacking psutil>=3.1.1 03:35: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:35: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:35: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:35: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:35: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:35: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:35:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:35:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:35:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:35:28 INFO - Installing collected packages: psutil 03:35:28 INFO - Running setup.py install for psutil 03:35:28 INFO - building 'psutil._psutil_linux' extension 03:35:28 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:35:28 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:35:28 INFO - building 'psutil._psutil_posix' extension 03:35:28 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:35:29 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:35:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:35:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:35:29 INFO - Successfully installed psutil 03:35:29 INFO - Cleaning up... 03:35:29 INFO - Return code: 0 03:35:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd908c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19041c0>, '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 0x19050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1905550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', '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:35:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:35:29 INFO - Using env: {'DISPLAY': ':0', 03:35:29 INFO - 'HOME': '/home/cltbld', 03:35:29 INFO - 'LANG': 'en_US.UTF-8', 03:35:29 INFO - 'LANGUAGE': 'en_US:en', 03:35:29 INFO - 'LOGNAME': 'cltbld', 03:35:29 INFO - 'MAIL': '/var/mail/cltbld', 03:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:29 INFO - 'MOZ_NO_REMOTE': '1', 03:35:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:29 INFO - 'NO_EM_RESTART': '1', 03:35:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:29 INFO - 'PWD': '/builds/slave/test', 03:35:29 INFO - 'SHELL': '/bin/bash', 03:35:29 INFO - 'SHLVL': '1', 03:35:29 INFO - 'TERM': 'linux', 03:35:29 INFO - 'TMOUT': '86400', 03:35:29 INFO - 'USER': 'cltbld', 03:35:29 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', 03:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:29 INFO - '_': '/tools/buildbot/bin/python'} 03:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:35:31 INFO - Installing collected packages: mozsystemmonitor 03:35:31 INFO - Running setup.py install for mozsystemmonitor 03:35:31 INFO - Successfully installed mozsystemmonitor 03:35:31 INFO - Cleaning up... 03:35:31 INFO - Return code: 0 03:35:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:35: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:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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:35:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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', '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 0x7fd908c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19041c0>, '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 0x19050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1905550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', '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:35: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:35: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 jsonschema==2.5.1 03:35:31 INFO - Using env: {'DISPLAY': ':0', 03:35:31 INFO - 'HOME': '/home/cltbld', 03:35:31 INFO - 'LANG': 'en_US.UTF-8', 03:35:31 INFO - 'LANGUAGE': 'en_US:en', 03:35:31 INFO - 'LOGNAME': 'cltbld', 03:35:31 INFO - 'MAIL': '/var/mail/cltbld', 03:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:31 INFO - 'MOZ_NO_REMOTE': '1', 03:35:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:31 INFO - 'NO_EM_RESTART': '1', 03:35:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:31 INFO - 'PWD': '/builds/slave/test', 03:35:31 INFO - 'SHELL': '/bin/bash', 03:35:31 INFO - 'SHLVL': '1', 03:35:31 INFO - 'TERM': 'linux', 03:35:31 INFO - 'TMOUT': '86400', 03:35:31 INFO - 'USER': 'cltbld', 03:35:31 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', 03:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:31 INFO - '_': '/tools/buildbot/bin/python'} 03:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:31 INFO - Downloading/unpacking jsonschema==2.5.1 03:35: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:35: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:35: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:35: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:35: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:35: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:35:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:35:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:35: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:35: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:35: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:35: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:35: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:35: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:35:33 INFO - Downloading functools32-3.2.3-2.tar.gz 03:35:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:35:33 INFO - warning: no files found matching '*.txt' 03:35:33 INFO - no previously-included directories found matching 'build' 03:35:33 INFO - no previously-included directories found matching 'dist' 03:35:33 INFO - no previously-included directories found matching '.git*' 03:35:33 INFO - Installing collected packages: jsonschema, functools32 03:35:33 INFO - Running setup.py install for functools32 03:35:33 INFO - warning: no files found matching '*.txt' 03:35:33 INFO - no previously-included directories found matching 'build' 03:35:33 INFO - no previously-included directories found matching 'dist' 03:35:33 INFO - no previously-included directories found matching '.git*' 03:35:33 INFO - Successfully installed jsonschema functools32 03:35:33 INFO - Cleaning up... 03:35:34 INFO - Return code: 0 03:35:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:35: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:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd908c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19041c0>, '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 0x19050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1905550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', '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:35:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:35:34 INFO - Using env: {'DISPLAY': ':0', 03:35:34 INFO - 'HOME': '/home/cltbld', 03:35:34 INFO - 'LANG': 'en_US.UTF-8', 03:35:34 INFO - 'LANGUAGE': 'en_US:en', 03:35:34 INFO - 'LOGNAME': 'cltbld', 03:35:34 INFO - 'MAIL': '/var/mail/cltbld', 03:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:34 INFO - 'MOZ_NO_REMOTE': '1', 03:35:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:34 INFO - 'NO_EM_RESTART': '1', 03:35:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:34 INFO - 'PWD': '/builds/slave/test', 03:35:34 INFO - 'SHELL': '/bin/bash', 03:35:34 INFO - 'SHLVL': '1', 03:35:34 INFO - 'TERM': 'linux', 03:35:34 INFO - 'TMOUT': '86400', 03:35:34 INFO - 'USER': 'cltbld', 03:35:34 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', 03:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:34 INFO - '_': '/tools/buildbot/bin/python'} 03:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:34 INFO - Downloading/unpacking blobuploader==1.2.4 03:35:34 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:35:34 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:35:34 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:35:34 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:35:34 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:35:34 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:35:36 INFO - Downloading blobuploader-1.2.4.tar.gz 03:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:35:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:35:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:36 INFO - Downloading docopt-0.6.1.tar.gz 03:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:35:36 INFO - Installing collected packages: blobuploader, requests, docopt 03:35:36 INFO - Running setup.py install for blobuploader 03:35:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:35:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:35:36 INFO - Running setup.py install for requests 03:35:37 INFO - Running setup.py install for docopt 03:35:37 INFO - Successfully installed blobuploader requests docopt 03:35:37 INFO - Cleaning up... 03:35:37 INFO - Return code: 0 03:35:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35: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:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:37 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 0x7fd908c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19041c0>, '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 0x19050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1905550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', '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:35:37 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:35:37 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:35:37 INFO - Using env: {'DISPLAY': ':0', 03:35:37 INFO - 'HOME': '/home/cltbld', 03:35:37 INFO - 'LANG': 'en_US.UTF-8', 03:35:37 INFO - 'LANGUAGE': 'en_US:en', 03:35:37 INFO - 'LOGNAME': 'cltbld', 03:35:37 INFO - 'MAIL': '/var/mail/cltbld', 03:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:37 INFO - 'MOZ_NO_REMOTE': '1', 03:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:37 INFO - 'NO_EM_RESTART': '1', 03:35:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:37 INFO - 'PWD': '/builds/slave/test', 03:35:37 INFO - 'SHELL': '/bin/bash', 03:35:37 INFO - 'SHLVL': '1', 03:35:37 INFO - 'TERM': 'linux', 03:35:37 INFO - 'TMOUT': '86400', 03:35:37 INFO - 'USER': 'cltbld', 03:35:37 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', 03:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:37 INFO - '_': '/tools/buildbot/bin/python'} 03:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:35:37 INFO - Running setup.py (path:/tmp/pip-JF7cqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:35:37 INFO - Running setup.py (path:/tmp/pip-9XX7Ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:35:37 INFO - Running setup.py (path:/tmp/pip-2R8a_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:35:37 INFO - Running setup.py (path:/tmp/pip-94cw6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:38 INFO - Running setup.py (path:/tmp/pip-PLGYaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:38 INFO - Running setup.py (path:/tmp/pip-0kz_XE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:35:38 INFO - Running setup.py (path:/tmp/pip-nTo3pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:35:38 INFO - Running setup.py (path:/tmp/pip-2MUUSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:35:38 INFO - Running setup.py (path:/tmp/pip-0UvqTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:35:38 INFO - Running setup.py (path:/tmp/pip-2ogIcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:35:38 INFO - Running setup.py (path:/tmp/pip-g7b3sY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:35:38 INFO - Running setup.py (path:/tmp/pip-KvE1MG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:35:38 INFO - Running setup.py (path:/tmp/pip-PhGvdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:35:38 INFO - Running setup.py (path:/tmp/pip-SBKo8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:38 INFO - Running setup.py (path:/tmp/pip-4BMEWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:35:38 INFO - Running setup.py (path:/tmp/pip-VIs_M1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:35:38 INFO - Running setup.py (path:/tmp/pip-iJ8Oc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:35:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:35:38 INFO - Running setup.py install for manifestparser 03:35:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:35:39 INFO - Running setup.py install for mozcrash 03:35:39 INFO - Running setup.py install for mozdebug 03:35:39 INFO - Running setup.py install for mozdevice 03:35:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:35:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:35:39 INFO - Running setup.py install for mozfile 03:35:39 INFO - Running setup.py install for mozhttpd 03:35:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:35:39 INFO - Running setup.py install for mozinfo 03:35:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:35:39 INFO - Running setup.py install for mozInstall 03:35:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:35:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:35:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:35:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:35:39 INFO - Running setup.py install for mozleak 03:35:39 INFO - Running setup.py install for mozlog 03:35:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:35:39 INFO - Running setup.py install for moznetwork 03:35:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:35:40 INFO - Running setup.py install for mozprocess 03:35:40 INFO - Running setup.py install for mozprofile 03:35:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:35:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:35:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:35:40 INFO - Running setup.py install for mozrunner 03:35:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:35:40 INFO - Running setup.py install for mozscreenshot 03:35:40 INFO - Running setup.py install for moztest 03:35:40 INFO - Running setup.py install for mozversion 03:35:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:35:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:35:40 INFO - Cleaning up... 03:35:40 INFO - Return code: 0 03:35:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:40 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 0x7fd908c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19041c0>, '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 0x19050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1905550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', '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:35:40 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:35:40 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:35:40 INFO - Using env: {'DISPLAY': ':0', 03:35:40 INFO - 'HOME': '/home/cltbld', 03:35:40 INFO - 'LANG': 'en_US.UTF-8', 03:35:40 INFO - 'LANGUAGE': 'en_US:en', 03:35:40 INFO - 'LOGNAME': 'cltbld', 03:35:40 INFO - 'MAIL': '/var/mail/cltbld', 03:35:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:40 INFO - 'MOZ_NO_REMOTE': '1', 03:35:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:40 INFO - 'NO_EM_RESTART': '1', 03:35:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:40 INFO - 'PWD': '/builds/slave/test', 03:35:40 INFO - 'SHELL': '/bin/bash', 03:35:40 INFO - 'SHLVL': '1', 03:35:40 INFO - 'TERM': 'linux', 03:35:40 INFO - 'TMOUT': '86400', 03:35:40 INFO - 'USER': 'cltbld', 03:35:40 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', 03:35:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:40 INFO - '_': '/tools/buildbot/bin/python'} 03:35:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:35:40 INFO - Running setup.py (path:/tmp/pip-l_ujga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:35:41 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:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:35:41 INFO - Running setup.py (path:/tmp/pip-bAiKfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:35:41 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:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:35:41 INFO - Running setup.py (path:/tmp/pip-f8USFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:35:41 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:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:35:41 INFO - Running setup.py (path:/tmp/pip-lNqF9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:41 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:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:41 INFO - Running setup.py (path:/tmp/pip-_JxVX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:41 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:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:41 INFO - Running setup.py (path:/tmp/pip-PvSdXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:35:41 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:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:35:41 INFO - Running setup.py (path:/tmp/pip-nIZLpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:35:41 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:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:35:41 INFO - Running setup.py (path:/tmp/pip-b7kGKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:35:41 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:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:35:41 INFO - Running setup.py (path:/tmp/pip-shG3kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:35:41 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:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:35:41 INFO - Running setup.py (path:/tmp/pip-pUBgNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:35:41 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:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:35:41 INFO - Running setup.py (path:/tmp/pip-BRJ_or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:35:41 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:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:35:41 INFO - Running setup.py (path:/tmp/pip-C55DT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:35:41 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:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:35:41 INFO - Running setup.py (path:/tmp/pip-Zih3K1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:35:41 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:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:35:41 INFO - Running setup.py (path:/tmp/pip-dkoMnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:35:41 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:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:41 INFO - Running setup.py (path:/tmp/pip-40JIFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:42 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:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:35:42 INFO - Running setup.py (path:/tmp/pip-Ql8izi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:35:42 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:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:35:42 INFO - Running setup.py (path:/tmp/pip-Isod5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:35:42 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:35:42 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:35:42 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:35:42 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:35:42 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:35:42 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:35:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:35: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:35: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:35: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:35: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:35: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:35: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:35:44 INFO - Downloading blessings-1.6.tar.gz 03:35:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:35:44 INFO - Installing collected packages: blessings 03:35:44 INFO - Running setup.py install for blessings 03:35:44 INFO - Successfully installed blessings 03:35:44 INFO - Cleaning up... 03:35:44 INFO - Return code: 0 03:35:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:35:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:44 INFO - Reading from file tmpfile_stdout 03:35:44 INFO - Current package versions: 03:35:44 INFO - argparse == 1.2.1 03:35:44 INFO - blessings == 1.6 03:35:44 INFO - blobuploader == 1.2.4 03:35:44 INFO - docopt == 0.6.1 03:35:44 INFO - functools32 == 3.2.3-2 03:35:44 INFO - jsonschema == 2.5.1 03:35:44 INFO - manifestparser == 1.1 03:35:44 INFO - mozInstall == 1.12 03:35:44 INFO - mozcrash == 0.17 03:35:44 INFO - mozdebug == 0.1 03:35:44 INFO - mozdevice == 0.48 03:35:44 INFO - mozfile == 1.2 03:35:44 INFO - mozhttpd == 0.7 03:35:44 INFO - mozinfo == 0.9 03:35:44 INFO - mozleak == 0.1 03:35:44 INFO - mozlog == 3.2 03:35:44 INFO - moznetwork == 0.27 03:35:44 INFO - mozprocess == 0.23 03:35:44 INFO - mozprofile == 0.28 03:35:44 INFO - mozrunner == 6.12 03:35:44 INFO - mozscreenshot == 0.1 03:35:44 INFO - mozsystemmonitor == 0.3 03:35:44 INFO - moztest == 0.7 03:35:44 INFO - mozversion == 1.4 03:35:44 INFO - psutil == 3.1.1 03:35:44 INFO - requests == 1.2.3 03:35:44 INFO - wsgiref == 0.1.2 03:35:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:44 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 0x7fd908c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19041c0>, '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 0x19050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1905550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', '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:35:44 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:35:44 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:35:44 INFO - Using env: {'DISPLAY': ':0', 03:35:44 INFO - 'HOME': '/home/cltbld', 03:35:44 INFO - 'LANG': 'en_US.UTF-8', 03:35:44 INFO - 'LANGUAGE': 'en_US:en', 03:35:44 INFO - 'LOGNAME': 'cltbld', 03:35:44 INFO - 'MAIL': '/var/mail/cltbld', 03:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:44 INFO - 'MOZ_NO_REMOTE': '1', 03:35:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:44 INFO - 'NO_EM_RESTART': '1', 03:35:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:44 INFO - 'PWD': '/builds/slave/test', 03:35:44 INFO - 'SHELL': '/bin/bash', 03:35:44 INFO - 'SHLVL': '1', 03:35:44 INFO - 'TERM': 'linux', 03:35:44 INFO - 'TMOUT': '86400', 03:35:44 INFO - 'USER': 'cltbld', 03:35:44 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', 03:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:44 INFO - '_': '/tools/buildbot/bin/python'} 03:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:44 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:35:44 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:35:44 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:35:44 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:35:44 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:35:44 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:35:44 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:35:44 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:35:44 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:35:44 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:35:44 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:35:44 INFO - Cleaning up... 03:35:44 INFO - Return code: 0 03:35:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:44 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 0x7fd908c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19041c0>, '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 0x19050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1905550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', '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:35:44 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:35:44 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:35:44 INFO - Using env: {'DISPLAY': ':0', 03:35:44 INFO - 'HOME': '/home/cltbld', 03:35:44 INFO - 'LANG': 'en_US.UTF-8', 03:35:44 INFO - 'LANGUAGE': 'en_US:en', 03:35:44 INFO - 'LOGNAME': 'cltbld', 03:35:44 INFO - 'MAIL': '/var/mail/cltbld', 03:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:44 INFO - 'MOZ_NO_REMOTE': '1', 03:35:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:44 INFO - 'NO_EM_RESTART': '1', 03:35:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:44 INFO - 'PWD': '/builds/slave/test', 03:35:44 INFO - 'SHELL': '/bin/bash', 03:35:44 INFO - 'SHLVL': '1', 03:35:44 INFO - 'TERM': 'linux', 03:35:44 INFO - 'TMOUT': '86400', 03:35:44 INFO - 'USER': 'cltbld', 03:35:44 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', 03:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:44 INFO - '_': '/tools/buildbot/bin/python'} 03:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:35:44 INFO - Cleaning up... 03:35:44 INFO - Return code: 0 03:35:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:44 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 0x7fd908c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1875350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19041c0>, '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 0x19050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1905550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', '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:35:44 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:35:44 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:35:44 INFO - Using env: {'DISPLAY': ':0', 03:35:44 INFO - 'HOME': '/home/cltbld', 03:35:44 INFO - 'LANG': 'en_US.UTF-8', 03:35:44 INFO - 'LANGUAGE': 'en_US:en', 03:35:44 INFO - 'LOGNAME': 'cltbld', 03:35:44 INFO - 'MAIL': '/var/mail/cltbld', 03:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:44 INFO - 'MOZ_NO_REMOTE': '1', 03:35:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:44 INFO - 'NO_EM_RESTART': '1', 03:35:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:44 INFO - 'PWD': '/builds/slave/test', 03:35:44 INFO - 'SHELL': '/bin/bash', 03:35:44 INFO - 'SHLVL': '1', 03:35:44 INFO - 'TERM': 'linux', 03:35:44 INFO - 'TMOUT': '86400', 03:35:44 INFO - 'USER': 'cltbld', 03:35:44 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', 03:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:44 INFO - '_': '/tools/buildbot/bin/python'} 03:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:45 INFO - Downloading/unpacking flake8 03:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:35:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:35:47 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:35:47 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:35:47 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:35:47 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:35:47 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:35:47 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:35:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:35:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:35:47 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:35:47 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:35:47 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:35:47 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:35:47 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:35:47 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:35:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:35:47 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:35:47 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:35:47 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:35:47 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:35:47 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:35:47 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:35:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:35:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:35:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:35:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:35:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:35:47 INFO - no previously-included directories found matching 'docs/_build' 03:35:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:35:47 INFO - Running setup.py install for pep8 03:35:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:35:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:35:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:35:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:35:47 INFO - no previously-included directories found matching 'docs/_build' 03:35:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:35:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:35:47 INFO - Cleaning up... 03:35:48 INFO - Return code: 0 03:35:48 INFO - Running post-action listener: _resource_record_post_action 03:35:48 INFO - Running post-action listener: _start_resource_monitoring 03:35:48 INFO - Starting resource monitoring. 03:35:48 INFO - ##### 03:35:48 INFO - ##### Finished create-virtualenv step (success) 03:35:48 INFO - ##### 03:35:48 INFO - ##### 03:35:48 INFO - ##### Running install step. 03:35:48 INFO - ##### 03:35:48 INFO - Running pre-action listener: _resource_record_pre_action 03:35:48 INFO - Running main action method: install 03:35:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:48 INFO - Reading from file tmpfile_stdout 03:35:48 INFO - Detecting whether we're running mozinstall >=1.0... 03:35:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:35:48 INFO - Reading from file tmpfile_stdout 03:35:48 INFO - Output received: 03:35:48 INFO - Usage: mozinstall [options] installer 03:35:48 INFO - Options: 03:35:48 INFO - -h, --help show this help message and exit 03:35:48 INFO - -d DEST, --destination=DEST 03:35:48 INFO - Directory to install application into. [default: 03:35:48 INFO - "/builds/slave/test"] 03:35:48 INFO - --app=APP Application being installed. [default: firefox] 03:35:48 INFO - mkdir: /builds/slave/test/build/application 03:35:48 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:35:48 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:36:04 INFO - Reading from file tmpfile_stdout 03:36:04 INFO - Output received: 03:36:04 INFO - /builds/slave/test/build/application/firefox/firefox 03:36:04 INFO - Running post-action listener: _resource_record_post_action 03:36:04 INFO - ##### 03:36:04 INFO - ##### Finished install step (success) 03:36:04 INFO - ##### 03:36:04 INFO - ##### 03:36:04 INFO - ##### Running run-tests step. 03:36:04 INFO - ##### 03:36:04 INFO - Running pre-action listener: _resource_record_pre_action 03:36:04 INFO - Running main action method: run_tests 03:36:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:36:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:36:04 INFO - Python 2.7.3 03:36:04 INFO - Return code: 0 03:36:04 INFO - grabbing minidump binary from tooltool 03:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:04 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 0x19041c0>, '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 0x19050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1905550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:36:04 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:36:04 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:36:04 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:36:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:36:04 INFO - Return code: 0 03:36:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:36:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:36:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:36:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:36:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:36:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:36:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:36:05 INFO - Return code: 0 03:36:05 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/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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:36:05 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/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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:36:05 INFO - Using env: {'DISPLAY': ':0', 03:36:05 INFO - 'HOME': '/home/cltbld', 03:36:05 INFO - 'LANG': 'en_US.UTF-8', 03:36:05 INFO - 'LANGUAGE': 'en_US:en', 03:36:05 INFO - 'LOGNAME': 'cltbld', 03:36:05 INFO - 'MAIL': '/var/mail/cltbld', 03:36:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:36:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:05 INFO - 'MOZ_NO_REMOTE': '1', 03:36:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:05 INFO - 'NO_EM_RESTART': '1', 03:36:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:05 INFO - 'PWD': '/builds/slave/test', 03:36:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:36:05 INFO - 'SHELL': '/bin/bash', 03:36:05 INFO - 'SHLVL': '1', 03:36:05 INFO - 'TERM': 'linux', 03:36:05 INFO - 'TMOUT': '86400', 03:36:05 INFO - 'USER': 'cltbld', 03:36:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799', 03:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:05 INFO - '_': '/tools/buildbot/bin/python'} 03:36:05 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/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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:36:05 INFO - mozversion application_buildid: 20160730004003 03:36:05 INFO - mozversion application_changeset: 8847dd9e9a2da7a4ad074ab97e085295e50746c3 03:36:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:36:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:36:05 INFO - mozversion application_name: Firefox 03:36:05 INFO - mozversion application_remotingname: firefox-dev 03:36:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:36:05 INFO - mozversion application_vendor: Mozilla 03:36:05 INFO - mozversion application_version: 49.0a2 03:36:05 INFO - mozversion platform_buildid: 20160730004003 03:36:05 INFO - mozversion platform_changeset: 8847dd9e9a2da7a4ad074ab97e085295e50746c3 03:36:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:36:05 INFO - mozversion platform_version: 49.0a2 03:36:05 INFO - using testdate: 1469874965 03:36:05 INFO - actual date: 1469874965 03:36:05 INFO - starting webserver on 'localhost:34020' 03:36:05 INFO - SUITE-START | Running 2 tests 03:36:05 INFO - TEST-START | dromaeo_css 03:36:05 INFO - operating with platform_type : linux_ 03:36:05 INFO - Initialising browser for dromaeo_css test... 03:36:05 INFO - TEST-INFO | started process 26885 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNblUJF/profile http://localhost:34020/getInfo.html) 03:36:09 INFO - PROCESS | 26885 | __metrics Screen width/height:1600/1200 03:36:09 INFO - PROCESS | 26885 | colorDepth:24 03:36:09 INFO - PROCESS | 26885 | Browser inner width/height: 1024/697 03:36:09 INFO - PROCESS | 26885 | __metrics 03:36:10 INFO - PROCESS | 26885 | 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:36:10 ERROR - PROCESS | 26885 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:36:11 INFO - TEST-INFO | 26885: exit 0 03:36:11 INFO - Browser initialized. 03:36:11 INFO - Running cycle 1/1 for dromaeo_css test... 03:36:11 INFO - TEST-INFO | started process 26978 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNblUJF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:36:23 INFO - PROCESS | 26978 | RSS: Main: 146149376 03:36:23 INFO - PROCESS | 26978 | 03:37:14 INFO - PROCESS | 26978 | 1469875034662 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:39:21 INFO - PROCESS | 26978 | Cycle 1(1): loaded http://localhost:34020/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34020/tests/dromaeo/cssquery-ext.html) 03:39:22 INFO - PROCESS | 26978 | RSS: Main: 246792192 03:39:22 INFO - PROCESS | 26978 | 03:42:24 INFO - PROCESS | 26978 | Cycle 1(1): loaded http://localhost:34020/tests/dromaeo/cssquery-ext.html (next: http://localhost:34020/tests/dromaeo/cssquery-jquery.html) 03:42:25 INFO - PROCESS | 26978 | RSS: Main: 228986880 03:42:25 INFO - PROCESS | 26978 | 03:45:27 INFO - PROCESS | 26978 | Cycle 1(1): loaded http://localhost:34020/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34020/tests/dromaeo/cssquery-mootools.html) 03:45:27 INFO - PROCESS | 26978 | RSS: Main: 230801408 03:45:27 INFO - PROCESS | 26978 | 03:48:29 INFO - PROCESS | 26978 | Cycle 1(1): loaded http://localhost:34020/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34020/tests/dromaeo/cssquery-prototype.html) 03:48:30 INFO - PROCESS | 26978 | RSS: Main: 225767424 03:48:30 INFO - PROCESS | 26978 | 03:51:32 INFO - PROCESS | 26978 | Cycle 1(1): loaded http://localhost:34020/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34020/tests/dromaeo/cssquery-yui.html) 03:51:33 INFO - PROCESS | 26978 | RSS: Main: 209477632 03:51:33 INFO - PROCESS | 26978 | 03:54:35 INFO - PROCESS | 26978 | Cycle 1(1): loaded http://localhost:34020/tests/dromaeo/cssquery-yui.html (next: http://localhost:34020/tests/dromaeo/cssquery-dojo.html) 03:54:36 INFO - PROCESS | 26978 | RSS: Main: 259530752 03:54:36 INFO - PROCESS | 26978 | 03:54:36 INFO - PROCESS | 26978 | __start_tp_report 03:54:36 INFO - PROCESS | 26978 | _x_x_mozilla_page_load 03:54:36 INFO - PROCESS | 26978 | _x_x_mozilla_page_load_details 03:54:36 INFO - PROCESS | 26978 | |i|pagename|runs| 03:54:36 INFO - PROCESS | 26978 | |0;dojo.html;3167.588213532241;3198.968010319896;3201.2797120647856;3223.5487031815564;3247.3342964692242;4854.8786280342965;4905.166121759301;4916.532929371704;4937.160682683943;4953.306537084802;4903.313536104948;4927.950720492794;4954.801807927679;4955.4548999610015;4974.37820272466;4369.956300437003;4398.208322501949;4515.503294637596;4535.410396648447;4576.633869290449;4453.421055262827;4453.732776033448;4455.086707225028;4490.820367185309;4492.483364413085;4548.090381923612;4569.543045695421;4578.519255478177;4581;4588.197065513538;4568.56598623132;4571.26859702446;4572.474165470963;4574.702644328141;4601.815927362935;4375.496817865923;4391.626711729475;4475.776211189427;4499.89752510637;4528.524504926968;4781.665283430161;4818.831340903052;4833.419989601235;4893;4902.166631672624;5289.629725919187;5290.0477913975465;5296.761645725952;5297.099493086184;5297.602679798992;5044.344235249431;5110.821121260775;5134.512221338967;5181.300524429192;5219.399769026572;4914.164592019365;4920.827771027997;4929.433115191763;4953.157963146274;4968.378952630921;5159.251908473326;5363.19552067193;5365.195220716846;5365.704886231295;5373.704446255493;5105.132127538327;5171.793128274827;5184.585233181337;5209.426963034063;5248.265242866002;5276.973615131977;5295.4969277918535;5296.576273898079;5296.602754793329;5326.707031113248;4975.253711943165;5094.312267843794;5252.606054545924;5260.71066091361;5262.605304602093;5115.360579927509;5165.535101840853;5185.792568297225;5187.714675692798;5208.244804503326;4121.5878412158545;4124.175164967019;4127.9174416511505;4146.129312844337;4150.066235097079;3699.963000370016;3719.20037192005;3739.551253849501;3752.1932784451474;3774;4978.950210497848;4997.3253610762085;4997.825076122318;4999.3000979862845;5009.298698182258;5263.868403289948;5265.605079619044;5274.077036518594;5280.894382112413;5290.947090529045;4744.5492678195515;4917.385326834145;4949.876253093701;4977.129002424561;4994.725290109006;4559.772011399483;4574.611158051603;4575.290829921368;4578.793954272066;4598.724076555351;5465.808696695596;5471.6169868108855;5482.506574408243;5489.505944465017;5492.752826122834;5058;5062.316587260746;5103.617228707936;5120.18077107661;5132.050570644443;5316.574674026146;5330.520253177233;5339.145736682112;5343.732813359395;5346.866328341823;4933.087378834927;5092.236164575195;5093.92359114621;5095.949040509548;5119.308893299357;5160.896782064263;5194.402643696023;5215.530602245816;5232.816851410183;5262;5126.282320475211;5132.255822905732;5134.537891589625;5134.717590532557;5164.1995490699;4866.197077482176;5079.517445842639;5095.490450954875;5119.48805119485;5122.052420302256;5046;5117.334746482933;5125.974805038933;5127.256547800623;5169.353830771153;5216.478352164753;5227.032998895216;5231.084560202025;5240.790368385222;5242.606804489602;4843.588294994824;4898.681585696918;4905.607551395951;5105.412877519133;5131.153359695609 03:54:36 INFO - PROCESS | 26978 | |1;ext.html;609.402785270435;650.5933791380387;652.0675434129195;661.77830426807;664.4285914113864;31434.371312573734;34458.65541344586;34511.654883451156;45901.311480327735;47547.52452475474;47388.763056184755;47685.284720729214;47746;47893;47963.76018119913;7870.842583148334;9087.636494540211;9236.538173091352;9236.815263694722;9247.6300947962;10649.201309901788;10911.290766100217;10931.01620854123;11280.041196498267;11299.604513842018;10984.890151098467;10998.780024399508;11079.058280046165;11094.833577496343;11104.222704410695;7979.122296547375;10693.411862347568;10958.945205274002;10969.725756856102;11035.613753518628;10835.295705779099;10916.235863489559;10943.726406839893;10949.069329107035;10955.616553420592;43537.12925741467;44034;44063.33904991428;44091.11817763659;44096.779516102535;3762.623737626243;3800.7149463790324;3808.257389808988;3829.195868867513;3831.942520862189;33987.66012339894;34689.299969526895;34920;35034.299314013835;35179.4723079154;4321.848735294249;4359.367891655724;4373.781310934441;4407.449068866392;4499.415076040126;376722;378347;378560;378898;379324;37450.43824342637;39360.80319598383;63580;64365.35634643687;64374.67812660907;41174.588254117676;41188.38217426741;41276;41318.1736365271;41328.586714133075;16803.495895123167;16995.83004169967;16997.49007529776;17023.148842558072;17026.148692565323;12485.56300529477;12749;12922.676933076747;14490.347934342979;14908.478203262834;9416.90583094174;9420.481873497023;9427.575759090858;9472.810543789086;9476.573554190078;3512.5960514541157;3535.055719354345;3560.092176494977;3586.55168103987;3596.460530920383;1088.4884104470887;1096.2107282756403;1100.5982816272003;1121.43928035982;1171.2211379432752;34468.31063378719;36144.638553614655;36554.268914621556;36613.08467288339;36613.08467288339;1126.7690123524658;1156.5200441816553;1196.2702751321688;1233.2980486927981;1239.5537606461667;17017.574560635836;17306.653866922592;17321.480355589352;17494;17517.7372339415;610850;611215;612238;615992;622191;62780.68609657014;64130.67934660297;64201.67899160474;64211.678941604994;64215;1303.3483258370813;1442.5167568864338;1482.636753995278;1505.3000354835053;1506.41249912532;32936;34929;35114.47328290129;35171.648283516835;35226.47160292649;53936.19095713646;54259;54593;54693;54753.45246547484;436940;442236;443663;445240;446006;26250.86874565615;29076.27309317284;30817.69182308148;31087.067387978397;32165.678343216267;50379.74810125926;51462.74268628633;51593.08486842742;51892.221616676536;52464.73767631137;41777.373339399324;41888.790556047024;42062.57937420709;42306;43658.690239292875;41666.58333416627;42232.788836055624;42767.78616107024;43000.56999429966;43476.347854782834;42050.78974605107;42334.78832605817;43183.78408107939;43324.35013474863;43706.90732731707;36435.45346819853;37372.81313593415;37813;38152;38590.228195435375;28555.857220713762;28836.42327153487;28879;29092.709072909845;29185.85407072951 03:54:36 INFO - PROCESS | 26978 | |2;jquery.html;420.12194513466847;421.3195688962327;422.90273237155463;437.7789216445695;445.058700847707;18180;18705.064746762677;19628.411147665574;19788.30740924068;19837.305694300703;18695.3456629018;19150.42548723537;19492.12285447155;19926.70109948352;19928.50178745532;4934.235193545006;5205.531502164805;5222.63441559091;5256.973715131419;5272.499112584298;5167.147420675584;5186.948130518685;5228.73856307185;5233.345831771028;5240.056789777838;5223.582113430935;5325.520703136717;5336.59975501837;5341.572674186055;5358.196270559409;5204.401493828221;5276.103062479368;5298.390685071208;5305.549028332596;5326.493983071621;5087.389513258396;5180.740962951875;5216.530512253916;5217.530422261977;5221.791128354861;14243.287835608282;14604.70790584193;21118.366449006553;23775;23793.7620623795;2445.5108978204253;2446.9388265293333;2459;2551;2616.2282126772648;10481.842772358421;10507.106895913856;10533;10831.620893268777;11010.284331518505;2056.249468943825;2071.326818783901;2098.2551194325947;2132.829373650104;2148.52732398872;59949;61652.7039216957;72586.63706681432;82998.58500707518;83420;11599.826002609967;11646.94176529112;11764.705882352831;11829.822552661717;11903.940480297542;14373.13761174312;15172.468963586221;16060;16085.758713619305;16575.41986030483;8303.335733141334;8404.949381327335;8430.072692003874;8554.572271386405;8589.914100858912;8028.879566806502;8029.7189598363775;8097.109317975018;8141.389395795339;8207.220314070153;5003.624728145403;5079.187330027252;5133.666311689728;5166.070107380708;5201.531862132426;2069.134249065056;2071.5339048714222;2106.252280440452;2118.4809721617994;2158.5251244726137;879.569011184515;930.8789857318641;961.8364877970762;990.4601991914424;1048.6015314180563;17936;18871.90564047171;19157.61684766297;20470.18119275242;20562.69155962662;1009.9646512372178;1027.7944411117658;1049.0296475759892;1054.1724746074294;1075.9031687148038;10482.371057736407;10749;10814.89185108139;10928.235023548275;11062.391568463812;560255;582868;587473;591902;596971;92040.53979730059;97486;98008;98392;99189;1074.9462526873624;1080.448971024783;1100.5982816272003;1119.6081371520065;1123.1407972900738;17320.826791732426;17564.297428102735;17616.29534818593;17628.14904435067;17936.641267174324;27593.206172950093;38321.23357532889;39385.80307098446;40689;41509.37735933903;50690;52954;56930;56950.87650934953;57407;8554.443961142506;8769;8818.426802257833;8913.598888049924;8927.687530936386;9452.905470945478;12824.807627885402;13132.540361087316;13174.011949103664;13393.129446585941;10920.726981825517;11320.037796787365;11324.716882078013;11529.538818447169;11702.2978621283;11498.597549085742;11514.481848316678;11550.826737598774;11612.6516204514;11897.405129743305;11509.94245028803;11764.764704706029;11913.583024594098;11928.165028447926;11933.940330298294;8650.697225597074;8786.428882122642;8859.867101993605;8868.11318868108;8929.285657147282;8833.425827321204;11575.363355015555;11607.36159511235;11707.121965852424;11831.230969986924 03:54:36 INFO - PROCESS | 26978 | |3;mootools.html;1367.0567308557088;1579.4235104186969;1607.2526275281994;1824.0697244405349;1908.2939312454394;9195.494247816367;9579.5210239488;9655.275854310928;9937.602495900173;9944.055314745106;9630.903690963089;9854.260930430211;9862.30963832532;9871.703848884545;9879.012098790117;2463.384153961505;2488.4774197418565;2490.091116742385;2492.252324302711;2505.4237525369176;2458.942654658496;2490.5018996200743;2492.8379655322346;2493.5386953413677;2495.563276426627;2448.9755102448926;2458.8893499792553;2487.56467618167;2490.2155820916355;2490.7882829959385;2384.1059602649007;2402.7477114902945;2407.3981504623844;2417.576924038304;2418.117387153694;2391.581473242193;2417.286900364397;2422.9273121806373;2427.757224277576;2429.866357350345;9428.669996550088;9546.904530954671;9660.75848103796;9667.70996870095;9682.419054856731;5631.8028868989795;5787.074068149118;5795.739191736382;5796.420357964212;5800.796972105998;3488.6511348865165;3506.1760486285957;3553.8045407502577;3560.6795388415167;3590.281943611288;1142.8457158283609;1156.4275683536703;1157.2940506291156;1166.7316517201007;1182.9467673954694;13965.301734913315;14067.155970641692;14101.224432656303;14119.788203176859;14124.364403601863;4790.904181916342;4813.78337974785;4901.485344038896;4914.827981020719;4923.75381230937;10808.56765729362;10831.404272764916;10864.674059778219;10872.72818179536;10876.02115809581;5570.944290557042;5615.129654903497;5625.662460252398;5627.155926611041;5628.04323265046;4428.68999170055;4756.7859446325;5045.217991211368;5153.484651534816;5242.16125419931;4399.5380485049245;4539;4554.3168524720895;4557.635389168859;4576.130535198302;1399.734050530396;1444.097439100562;1446.4937271954732;1453.8909581781409;1457.249516499004;840.4873027453249;954.6706386296717;1002.04304888831;1014.5840205515703;1027;6141.447269745655;6355.523335749837;6357.396047375584;6447.618096474658;6503.057056726748;1024.2676486312323;1036.9637062702768;1038.08129805123;1054.6730513540674;1069.812782763029;4375.562443755599;4611.100835337144;4620.1914664934175;4647.209974304376;4728.101660684459;11984.161108722306;12132.15074944763;12403.13178077544;12694.365281735876;12718.427670754838;12158.878411215775;12513.49946002168;12548.18436801605;12662.683432914251;12682.49270029207;8981.191692747683;9001.774955626031;9060.637574497077;9078.228350590274;9078.45529268246;6344.809655710336;6399.584027038228;6433.5496515243485;6485.0596663484475;6489.772857949949;10878.619248326271;11008.449577521253;11015.284006539548;11176.88823111791;11294.04000659953;10356.326838755456;11498.712532186762;11676.649700508999;11717.121215909012;11910.702232444259;9054;9273.582688779155;9299.674511392339;9528.285378596494;9538.95230523843;8767.342449316198;9035.864462033207;9039.864402033843;9274.44353338802;9373.390729602554;7923.603819809102;7981.2018798119725;8013.998250218722;8076.838463230585;8153.1846815317995;8479.533625650649;8504.659813607386;8531.616077276414;8581.914180858112;8656.134386561545;7710.4217183710325;7767.650455729618;7876.527408355517;7879.0939042010905;7882.172371900868;5393.083175860192;5485.369182544058;5612.410696876769;5663.943360566506;5802.216700745345;5550.111982082847;5749.770009199585;5786.826395208151;5830.912536311874;5881.794137205177 03:54:36 INFO - PROCESS | 26978 | |4;prototype.html;335.18382738032886;352.2075330506361;353.4256832646948;370.0526651771467;372.99440508392377;4730.124926888528;4850.417949846014;4924.704517728935;4968.441252754829;4973.17942539481;4840.854774356766;4864.294677271802;4866.659333846632;4882.1700310947135;4892.681975671579;3961.6428225205955;3962.9405558916637;3967.1552727981484;3976.661983731379;3987.7806720630497;3753.887383378503;3830.559485659143;3912.882613521599;3930.6265904739003;3962.177398396741;3897.8051097445154;3924.1759230561615;3928.41073838925;3940.7044471664594;3946.861859834906;3915.295246855565;3927.253821773854;3927.2930872442807;3946.3291240489184;3954.5452272988687;3546.8758593449365;3564.82175891207;3567.714582833367;3578.9621009907096;3590.533230680021;4411.691181617288;4649.18639238132;4649.372334734835;4659.58063774262;4670.649701272384;4384.583464570861;4410.338449232609;4422.955770442319;4438.622717069053;4472.329150627399;5028.874278143039;5040.798368065273;5049.091163590552;5077.162268225738;5092.872678183038;3708.2212735325616;3731.6641502264656;3780.3933328335347;3785.4511095891216;3789.5263092113487;5151.922721159148;5160.174372100483;5166.741662916839;5193.37679478465;5197.168453047532;3858.3633700439113;3894.3768996960353;3896.922061558753;3898.8830335089992;3904.96095039046;3704.944425833615;3881.4760007399204;3957.248122856648;3963.128111815396;3967.3850553164307;4324.200022995756;4340.934885976713;4343.978280108579;4387.298032314814;4392.516823149451;5022.84931452057;5064.746762661852;5069.161269688986;5082.161443361878;5133.358330208724;1273.5669872243298;1303.3092460995688;1321.6167311479562;1328.1765305510646;1334.292824802856;891.3136884598953;897.1701176411793;904.5341649050744;913.1462082952461;915.1260546178383;4324.35134729793;4392.868213953587;4424.358468022118;4457.910841783211;4462.709923855004;4551.429756733922;4611.700239484423;4671.566398696955;4684.508126646721;4693.835715749932;4465.843695470643;4474.664400170001;4484.955150448519;4491.507213496476;4499.280115181556;2392.880355982194;2472.270680149324;2477.2072936660097;2483.2922617054055;2484.987575062113;4725.574698277172;4797.520247975174;4798.760061996886;4824.059308434821;4824.975875120602;4609.354690343354;4644.628429725682;4646.6747327686735;4690.482138396203;4730.219513780256;4494.280960019207;4723.858284251478;4768.475467698481;4787.832425865078;4809.519048095162;4598.3792188054185;4608.193566125848;4634.698744581591;4651.534846515321;4655.0457156283555;4545.704529205591;4563.885902852455;4596.655250856133;4624.676272661016;4625.953740462687;4855.393075865517;5037.546620804145;5445.700486473282;5448.918266226089;5450.509454149145;3783.621637836194;3789.943150852684;3800.6959443243923;3804.8478060877255;3818.389057750858;5101.7704203310195;5235.4502777207845;5281.867953301198;5308.973455132699;5316.946830531645;4987.975060124676;5111.3355263815465;5140.691558506352;5140.789460531858;5158.3552055993005;4985.925211121908;5074.949250507448;5111.667741596784;5133.946421431458;5159.226116082617;4888.755562221946;5006.974965125151;5037.798488060436;5079.263506791568;5082.745862706924;5057.367829021372;5082.847514574569;5087.313212716236;5104.566111880532;5107.186948633182;5012.448630650699;5026.321446604661;5034.546890779848;5069.555176774602;5072.4673909239 03:54:36 INFO - PROCESS | 26978 | |5;yui.html;830.7673851321629;847.6185716427607;850.6384786465751;854.3848429131025;868.7828042989256;15496.767548486767;16837.158142092878;16854.83145168548;16868.40960566379;16887.493375198734;15255.618609534768;15333.69332613347;15429.768553471707;15431.228438578055;15435.536933891974;689.6930865764737;847.2798121596655;864.6930339729399;877.398981697536;882.4220135811054;872.1452976083442;873.8121303919656;874.0385575866528;877.5392918717693;877.8244351129799;930.8417569013284;932.2029664636706;932.7201839448172;934.5700977550335;934.686879895236;735.4006484714967;900.8423525882977;925.6575067225102;928.823523530527;929.061647735785;680.6630717794724;680.7175022365712;680.9557378770364;681.117952251835;681.117952251835;15302.617434564114;15341.309641066178;15342.846571534254;15346.693066138727;15391.538253852403;14637.926810365987;14844;15044.623884402868;15073.849261507354;15224.771628425582;13415.731685366238;13475.19148851072;13512.39194236252;13544.796828047587;13868.93065534676;4001.339778936472;4016.5581786003518;4078.6125318094732;4698.812047518095;4739.36018637483;78033;79829;80959.19040809576;80995.5950220251;81136.18863811345;12048.277103373826;12098.213616114925;12243.816342754866;12377.443015064344;12455.439505222286;21469.78530214709;21529.246476373566;21545.67681484779;21613.351599452042;21681.56636867254;8634.510054771483;8724.389292749574;8724.8691269631;8746.169113934166;8905.643774249087;4812.446568644581;4820.156472617348;4852.684575502581;4938.456769755324;5014.749262536859;3501.9474707878894;3599.280143971216;3621.0766254604905;3626.8911932642063;3632.763870348419;589.6609449566516;649.5940037476577;692.7876216620914;699.237830764459;739.3530660671912;683.1153656015472;692.0518889121835;713.0694443750851;729.9817504562428;743.6542007966214;9730.659426920165;9876.753081172885;10020.24848136378;10197.94901025505;10210;623.9594426362272;715.8282012317111;742.3949481172826;782.1513657681365;803.4135081390617;5072.289879416885;5112.923306150411;5167.974160129175;5204.895902082013;5218.947810521846;76517.61741191258;77591.22408775953;77718;126138.36930815288;126441;61942.69028654828;106105;106244;107452;107670;94777.526112369;94964;95145;97431.51284243676;98537.50731246299;9593.088656577615;9611.855822162814;9671.468069256258;9721.31950763468;9836;55358.72320638371;55711;55892.72053639706;56515.71742141263;57537;76864.61567692125;83693.58153209195;85003;85791.14208857832;86322.56838715766;12700.809487857505;12701.36493175356;12860.807087893501;12964.546240881524;13009.089363744448;13483.46066157382;13613.86386136126;13634.386452609459;13687.657808554866;13735.862641373458;10730.624428144978;13683.86316136826;13799.448022079005;13811.79282310746;14235.50175743844;13171.160200037963;13308.600741977756;13362;14013.43946242139;14160.716785664023;14211.360488777824;14729;15037.774433383289;15047;15313.387464501295;11280;12122.454489548169;12365.876341236473;12634.178778379375;12735.80896286538;12365.258084514959;12520;12535.93732031334;12565.308908010147;12615.180013299107 03:54:36 INFO - PROCESS | 26978 | __end_tp_report 03:54:36 INFO - PROCESS | 26978 | __start_cc_report 03:54:36 INFO - PROCESS | 26978 | _x_x_mozilla_cycle_collect,884 03:54:36 INFO - PROCESS | 26978 | __end_cc_report 03:54:36 INFO - PROCESS | 26978 | __startTimestamp1469876076214__endTimestamp 03:54:36 INFO - PROCESS | 26978 | 03:54:36 INFO - PROCESS | 26978 | ------- Summary: start ------- 03:54:36 INFO - PROCESS | 26978 | Number of tests: 6 03:54:36 INFO - PROCESS | 26978 | 03:54:36 INFO - PROCESS | 26978 | [#0] dojo.html Cycles:165 Average:4888.81 Median:5046.00 stddev:482.32 (9.6%) stddev-sans-first:464.51 03:54:36 INFO - PROCESS | 26978 | Values: 3167.6 3199.0 3201.3 3223.5 3247.3 4854.9 4905.2 4916.5 4937.2 4953.3 4903.3 4928.0 4954.8 4955.5 4974.4 4370.0 4398.2 4515.5 4535.4 4576.6 4453.4 4453.7 4455.1 4490.8 4492.5 4548.1 4569.5 4578.5 4581.0 4588.2 4568.6 4571.3 4572.5 4574.7 4601.8 4375.5 4391.6 4475.8 4499.9 4528.5 4781.7 4818.8 4833.4 4893.0 4902.2 5289.6 5290.0 5296.8 5297.1 5297.6 5044.3 5110.8 5134.5 5181.3 5219.4 4914.2 4920.8 4929.4 4953.2 4968.4 5159.3 5363.2 5365.2 5365.7 5373.7 5105.1 5171.8 5184.6 5209.4 5248.3 5277.0 5295.5 5296.6 5296.6 5326.7 4975.3 5094.3 5252.6 5260.7 5262.6 5115.4 5165.5 5185.8 5187.7 5208.2 4121.6 4124.2 4127.9 4146.1 4150.1 3700.0 3719.2 3739.6 3752.2 3774.0 4979.0 4997.3 4997.8 4999.3 5009.3 5263.9 5265.6 5274.1 5280.9 5290.9 4744.5 4917.4 4949.9 4977.1 4994.7 4559.8 4574.6 4575.3 4578.8 4598.7 5465.8 5471.6 5482.5 5489.5 5492.8 5058.0 5062.3 5103.6 5120.2 5132.1 5316.6 5330.5 5339.1 5343.7 5346.9 4933.1 5092.2 5093.9 5095.9 5119.3 5160.9 5194.4 5215.5 5232.8 5262.0 5126.3 5132.3 5134.5 5134.7 5164.2 4866.2 5079.5 5095.5 5119.5 5122.1 5046.0 5117.3 5126.0 5127.3 5169.4 5216.5 5227.0 5231.1 5240.8 5242.6 4843.6 4898.7 4905.6 5105.4 5131.2 03:54:36 INFO - PROCESS | 26978 | 03:54:36 INFO - PROCESS | 26978 | [#1] ext.html Cycles:180 Average:63518.93 Median:379111.00 stddev:130067.42 (34.3%) stddev-sans-first:130346.53 03:54:36 INFO - PROCESS | 26978 | Values: 609.4 650.6 652.1 661.8 664.4 31434.4 34458.7 34511.7 45901.3 47547.5 47388.8 47685.3 47746.0 47893.0 47963.8 7870.8 9087.6 9236.5 9236.8 9247.6 10649.2 10911.3 10931.0 11280.0 11299.6 10984.9 10998.8 11079.1 11094.8 11104.2 7979.1 10693.4 10958.9 10969.7 11035.6 10835.3 10916.2 10943.7 10949.1 10955.6 43537.1 44034.0 44063.3 44091.1 44096.8 3762.6 3800.7 3808.3 3829.2 3831.9 33987.7 34689.3 34920.0 35034.3 35179.5 4321.8 4359.4 4373.8 4407.4 4499.4 376722.0 378347.0 378560.0 378898.0 379324.0 37450.4 39360.8 63580.0 64365.4 64374.7 41174.6 41188.4 41276.0 41318.2 41328.6 16803.5 16995.8 16997.5 17023.1 17026.1 12485.6 12749.0 12922.7 14490.3 14908.5 9416.9 9420.5 9427.6 9472.8 9476.6 3512.6 3535.1 3560.1 3586.6 3596.5 1088.5 1096.2 1100.6 1121.4 1171.2 34468.3 36144.6 36554.3 36613.1 36613.1 1126.8 1156.5 1196.3 1233.3 1239.6 17017.6 17306.7 17321.5 17494.0 17517.7 610850.0 611215.0 612238.0 615992.0 622191.0 62780.7 64130.7 64201.7 64211.7 64215.0 1303.3 1442.5 1482.6 1505.3 1506.4 32936.0 34929.0 35114.5 35171.6 35226.5 53936.2 54259.0 54593.0 54693.0 54753.5 436940.0 442236.0 443663.0 445240.0 446006.0 26250.9 29076.3 30817.7 31087.1 32165.7 50379.7 51462.7 51593.1 51892.2 52464.7 41777.4 41888.8 42062.6 42306.0 43658.7 41666.6 42232.8 42767.8 43000.6 43476.3 42050.8 42334.8 43183.8 43324.4 43706.9 36435.5 37372.8 37813.0 38152.0 38590.2 28555.9 28836.4 28879.0 29092.7 29185.9 03:54:36 INFO - PROCESS | 26978 | 03:54:36 INFO - PROCESS | 26978 | [#2] jquery.html Cycles:180 Average:31210.90 Median:2452.97 stddev:95837.60 (3907.0%) stddev-sans-first:96078.56 03:54:36 INFO - PROCESS | 26978 | Values: 420.1 421.3 422.9 437.8 445.1 18180.0 18705.1 19628.4 19788.3 19837.3 18695.3 19150.4 19492.1 19926.7 19928.5 4934.2 5205.5 5222.6 5257.0 5272.5 5167.1 5186.9 5228.7 5233.3 5240.1 5223.6 5325.5 5336.6 5341.6 5358.2 5204.4 5276.1 5298.4 5305.5 5326.5 5087.4 5180.7 5216.5 5217.5 5221.8 14243.3 14604.7 21118.4 23775.0 23793.8 2445.5 2446.9 2459.0 2551.0 2616.2 10481.8 10507.1 10533.0 10831.6 11010.3 2056.2 2071.3 2098.3 2132.8 2148.5 59949.0 61652.7 72586.6 82998.6 83420.0 11599.8 11646.9 11764.7 11829.8 11903.9 14373.1 15172.5 16060.0 16085.8 16575.4 8303.3 8404.9 8430.1 8554.6 8589.9 8028.9 8029.7 8097.1 8141.4 8207.2 5003.6 5079.2 5133.7 5166.1 5201.5 2069.1 2071.5 2106.3 2118.5 2158.5 879.6 930.9 961.8 990.5 1048.6 17936.0 18871.9 19157.6 20470.2 20562.7 1010.0 1027.8 1049.0 1054.2 1075.9 10482.4 10749.0 10814.9 10928.2 11062.4 560255.0 582868.0 587473.0 591902.0 596971.0 92040.5 97486.0 98008.0 98392.0 99189.0 1074.9 1080.4 1100.6 1119.6 1123.1 17320.8 17564.3 17616.3 17628.1 17936.6 27593.2 38321.2 39385.8 40689.0 41509.4 50690.0 52954.0 56930.0 56950.9 57407.0 8554.4 8769.0 8818.4 8913.6 8927.7 9452.9 12824.8 13132.5 13174.0 13393.1 10920.7 11320.0 11324.7 11529.5 11702.3 11498.6 11514.5 11550.8 11612.7 11897.4 11509.9 11764.8 11913.6 11928.2 11933.9 8650.7 8786.4 8859.9 8868.1 8929.3 8833.4 11575.4 11607.4 11707.1 11831.2 03:54:36 INFO - PROCESS | 26978 | 03:54:36 INFO - PROCESS | 26978 | [#3] mootools.html Cycles:180 Average:6383.66 Median:4615.65 stddev:3725.26 (80.7%) stddev-sans-first:3716.63 03:54:36 INFO - PROCESS | 26978 | Values: 1367.1 1579.4 1607.3 1824.1 1908.3 9195.5 9579.5 9655.3 9937.6 9944.1 9630.9 9854.3 9862.3 9871.7 9879.0 2463.4 2488.5 2490.1 2492.3 2505.4 2458.9 2490.5 2492.8 2493.5 2495.6 2449.0 2458.9 2487.6 2490.2 2490.8 2384.1 2402.7 2407.4 2417.6 2418.1 2391.6 2417.3 2422.9 2427.8 2429.9 9428.7 9546.9 9660.8 9667.7 9682.4 5631.8 5787.1 5795.7 5796.4 5800.8 3488.7 3506.2 3553.8 3560.7 3590.3 1142.8 1156.4 1157.3 1166.7 1182.9 13965.3 14067.2 14101.2 14119.8 14124.4 4790.9 4813.8 4901.5 4914.8 4923.8 10808.6 10831.4 10864.7 10872.7 10876.0 5570.9 5615.1 5625.7 5627.2 5628.0 4428.7 4756.8 5045.2 5153.5 5242.2 4399.5 4539.0 4554.3 4557.6 4576.1 1399.7 1444.1 1446.5 1453.9 1457.2 840.5 954.7 1002.0 1014.6 1027.0 6141.4 6355.5 6357.4 6447.6 6503.1 1024.3 1037.0 1038.1 1054.7 1069.8 4375.6 4611.1 4620.2 4647.2 4728.1 11984.2 12132.2 12403.1 12694.4 12718.4 12158.9 12513.5 12548.2 12662.7 12682.5 8981.2 9001.8 9060.6 9078.2 9078.5 6344.8 6399.6 6433.5 6485.1 6489.8 10878.6 11008.4 11015.3 11176.9 11294.0 10356.3 11498.7 11676.6 11717.1 11910.7 9054.0 9273.6 9299.7 9528.3 9539.0 8767.3 9035.9 9039.9 9274.4 9373.4 7923.6 7981.2 8014.0 8076.8 8153.2 8479.5 8504.7 8531.6 8581.9 8656.1 7710.4 7767.7 7876.5 7879.1 7882.2 5393.1 5485.4 5612.4 5663.9 5802.2 5550.1 5749.8 5786.8 5830.9 5881.8 03:54:36 INFO - PROCESS | 26978 | 03:54:36 INFO - PROCESS | 26978 | [#4] prototype.html Cycles:180 Average:4191.63 Median:4625.32 stddev:1175.62 (25.4%) stddev-sans-first:1142.73 03:54:36 INFO - PROCESS | 26978 | Values: 335.2 352.2 353.4 370.1 373.0 4730.1 4850.4 4924.7 4968.4 4973.2 4840.9 4864.3 4866.7 4882.2 4892.7 3961.6 3962.9 3967.2 3976.7 3987.8 3753.9 3830.6 3912.9 3930.6 3962.2 3897.8 3924.2 3928.4 3940.7 3946.9 3915.3 3927.3 3927.3 3946.3 3954.5 3546.9 3564.8 3567.7 3579.0 3590.5 4411.7 4649.2 4649.4 4659.6 4670.6 4384.6 4410.3 4423.0 4438.6 4472.3 5028.9 5040.8 5049.1 5077.2 5092.9 3708.2 3731.7 3780.4 3785.5 3789.5 5151.9 5160.2 5166.7 5193.4 5197.2 3858.4 3894.4 3896.9 3898.9 3905.0 3704.9 3881.5 3957.2 3963.1 3967.4 4324.2 4340.9 4344.0 4387.3 4392.5 5022.8 5064.7 5069.2 5082.2 5133.4 1273.6 1303.3 1321.6 1328.2 1334.3 891.3 897.2 904.5 913.1 915.1 4324.4 4392.9 4424.4 4457.9 4462.7 4551.4 4611.7 4671.6 4684.5 4693.8 4465.8 4474.7 4485.0 4491.5 4499.3 2392.9 2472.3 2477.2 2483.3 2485.0 4725.6 4797.5 4798.8 4824.1 4825.0 4609.4 4644.6 4646.7 4690.5 4730.2 4494.3 4723.9 4768.5 4787.8 4809.5 4598.4 4608.2 4634.7 4651.5 4655.0 4545.7 4563.9 4596.7 4624.7 4626.0 4855.4 5037.5 5445.7 5448.9 5450.5 3783.6 3789.9 3800.7 3804.8 3818.4 5101.8 5235.5 5281.9 5309.0 5316.9 4988.0 5111.3 5140.7 5140.8 5158.4 4985.9 5074.9 5111.7 5133.9 5159.2 4888.8 5007.0 5037.8 5079.3 5082.7 5057.4 5082.8 5087.3 5104.6 5107.2 5012.4 5026.3 5034.5 5069.6 5072.5 03:54:36 INFO - PROCESS | 26978 | 03:54:36 INFO - PROCESS | 26978 | [#5] yui.html Cycles:180 Average:21306.35 Median:4836.42 stddev:30235.13 (625.2%) stddev-sans-first:30280.86 03:54:36 INFO - PROCESS | 26978 | Values: 830.8 847.6 850.6 854.4 868.8 15496.8 16837.2 16854.8 16868.4 16887.5 15255.6 15333.7 15429.8 15431.2 15435.5 689.7 847.3 864.7 877.4 882.4 872.1 873.8 874.0 877.5 877.8 930.8 932.2 932.7 934.6 934.7 735.4 900.8 925.7 928.8 929.1 680.7 680.7 681.0 681.1 681.1 15302.6 15341.3 15342.8 15346.7 15391.5 14637.9 14844.0 15044.6 15073.8 15224.8 13415.7 13475.2 13512.4 13544.8 13868.9 4001.3 4016.6 4078.6 4698.8 4739.4 78033.0 79829.0 80959.2 80995.6 81136.2 12048.3 12098.2 12243.8 12377.4 12455.4 21469.8 21529.2 21545.7 21613.4 21681.6 8634.5 8724.4 8724.9 8746.2 8905.6 4812.4 4820.2 4852.7 4938.5 5014.7 3501.9 3599.3 3621.1 3626.9 3632.8 589.7 649.6 692.8 699.2 739.4 683.1 692.1 713.1 730.0 743.7 9730.7 9876.8 10020.2 10197.9 10210.0 624.0 715.8 742.4 782.2 803.4 5072.3 5112.9 5168.0 5204.9 5218.9 76517.6 77591.2 77718.0 126138.4 126441.0 61942.7 106105.0 106244.0 107452.0 107670.0 94777.5 94964.0 95145.0 97431.5 98537.5 9593.1 9611.9 9671.5 9721.3 9836.0 55358.7 55711.0 55892.7 56515.7 57537.0 76864.6 83693.6 85003.0 85791.1 86322.6 12700.8 12701.4 12860.8 12964.5 13009.1 13483.5 13613.9 13634.4 13687.7 13735.9 10730.6 13683.9 13799.4 13811.8 14235.5 13171.2 13308.6 13362.0 14013.4 14160.7 14211.4 14729.0 15037.8 15047.0 15313.4 11280.0 12122.5 12365.9 12634.2 12735.8 12365.3 12520.0 12535.9 12565.3 12615.2 03:54:36 INFO - PROCESS | 26978 | -------- Summary: end -------- 03:54:36 INFO - PROCESS | 26978 | 03:54:36 INFO - TEST-INFO | 26978: exit 0 03:54:36 INFO - TEST-OK | dromaeo_css | took 1111719ms 03:54:36 INFO - TEST-START | kraken 03:54:36 INFO - operating with platform_type : linux_ 03:54:36 INFO - Initialising browser for kraken test... 03:54:36 INFO - TEST-INFO | started process 27167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfn0_K_/profile http://localhost:34020/getInfo.html) 03:54:40 INFO - PROCESS | 27167 | __metrics Screen width/height:1600/1200 03:54:40 INFO - PROCESS | 27167 | colorDepth:24 03:54:40 INFO - PROCESS | 27167 | Browser inner width/height: 1024/697 03:54:40 INFO - PROCESS | 27167 | __metrics 03:54:41 INFO - PROCESS | 27167 | 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:54:41 ERROR - PROCESS | 27167 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:54:42 INFO - TEST-INFO | 27167: exit 0 03:54:42 INFO - Browser initialized. 03:54:42 INFO - Running cycle 1/1 for kraken test... 03:54:42 INFO - TEST-INFO | started process 27254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfn0_K_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:54 INFO - PROCESS | 27254 | RSS: Main: 145584128 03:54:54 INFO - PROCESS | 27254 | 03:54:57 INFO - PROCESS | 27254 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34020/tests/kraken/driver.html?testName=audio-beat-detection) 03:54:57 INFO - PROCESS | 27254 | RSS: Main: 194772992 03:54:57 INFO - PROCESS | 27254 | 03:55:00 INFO - PROCESS | 27254 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34020/tests/kraken/driver.html?testName=audio-dft) 03:55:01 INFO - PROCESS | 27254 | RSS: Main: 193544192 03:55:01 INFO - PROCESS | 27254 | 03:55:04 INFO - PROCESS | 27254 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34020/tests/kraken/driver.html?testName=audio-fft) 03:55:04 INFO - PROCESS | 27254 | RSS: Main: 279408640 03:55:04 INFO - PROCESS | 27254 | 03:55:06 INFO - PROCESS | 27254 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34020/tests/kraken/driver.html?testName=audio-oscillator) 03:55:07 INFO - PROCESS | 27254 | RSS: Main: 187756544 03:55:07 INFO - PROCESS | 27254 | 03:55:09 INFO - PROCESS | 27254 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34020/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:55:10 INFO - PROCESS | 27254 | RSS: Main: 187633664 03:55:10 INFO - PROCESS | 27254 | 03:55:13 INFO - PROCESS | 27254 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34020/tests/kraken/driver.html?testName=imaging-darkroom) 03:55:13 INFO - PROCESS | 27254 | RSS: Main: 222351360 03:55:13 INFO - PROCESS | 27254 | 03:55:17 INFO - PROCESS | 27254 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34020/tests/kraken/driver.html?testName=imaging-desaturate) 03:55:17 INFO - PROCESS | 27254 | RSS: Main: 222957568 03:55:17 INFO - PROCESS | 27254 | 03:55:20 INFO - PROCESS | 27254 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34020/tests/kraken/driver.html?testName=json-parse-financial) 03:55:21 INFO - PROCESS | 27254 | RSS: Main: 222924800 03:55:21 INFO - PROCESS | 27254 | 03:55:22 INFO - PROCESS | 27254 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34020/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:55:23 INFO - PROCESS | 27254 | RSS: Main: 199770112 03:55:23 INFO - PROCESS | 27254 | 03:55:25 INFO - PROCESS | 27254 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34020/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:55:25 INFO - PROCESS | 27254 | RSS: Main: 201895936 03:55:25 INFO - PROCESS | 27254 | 03:55:27 INFO - PROCESS | 27254 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34020/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:55:28 INFO - PROCESS | 27254 | RSS: Main: 208826368 03:55:28 INFO - PROCESS | 27254 | 03:55:30 INFO - PROCESS | 27254 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34020/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:55:31 INFO - PROCESS | 27254 | RSS: Main: 217001984 03:55:31 INFO - PROCESS | 27254 | 03:55:34 INFO - PROCESS | 27254 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34020/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:55:34 INFO - PROCESS | 27254 | RSS: Main: 216662016 03:55:34 INFO - PROCESS | 27254 | 03:55:36 INFO - PROCESS | 27254 | Cycle 1(1): loaded http://localhost:34020/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34020/tests/kraken/driver.html?testName=ai-astar) 03:55:36 INFO - PROCESS | 27254 | RSS: Main: 259166208 03:55:36 INFO - PROCESS | 27254 | 03:55:36 INFO - PROCESS | 27254 | __start_tp_report 03:55:36 INFO - PROCESS | 27254 | _x_x_mozilla_page_load 03:55:36 INFO - PROCESS | 27254 | _x_x_mozilla_page_load_details 03:55:36 INFO - PROCESS | 27254 | |i|pagename|runs| 03:55:36 INFO - PROCESS | 27254 | |0;ai-astar;109;104;109;109;109;109;109;107;111;109 03:55:36 INFO - PROCESS | 27254 | |1;audio-beat-detection;145;130;127;174;132;131;146;125;161;131 03:55:36 INFO - PROCESS | 27254 | |2;audio-dft;163;162;162;163;161;162;162;163;164;161 03:55:36 INFO - PROCESS | 27254 | |3;audio-fft;75;75;76;103;75;75;76;74;97;75 03:55:36 INFO - PROCESS | 27254 | |4;audio-oscillator;84;85;116;85;85;85;132;84;84;134 03:55:36 INFO - PROCESS | 27254 | |5;imaging-gaussian-blur;117;117;116;116;117;116;117;117;117;117 03:55:36 INFO - PROCESS | 27254 | |6;imaging-darkroom;145;146;146;145;146;146;146;147;146;147 03:55:36 INFO - PROCESS | 27254 | |7;imaging-desaturate;95;95;96;95;96;95;95;95;95;95 03:55:36 INFO - PROCESS | 27254 | |8;json-parse-financial;55;55;58;56;56;57;56;58;57;56 03:55:36 INFO - PROCESS | 27254 | |9;json-stringify-tinderbox;60;60;60;61;61;60;59;60;59;60 03:55:36 INFO - PROCESS | 27254 | |10;stanford-crypto-aes;77;76;76;77;78;78;79;79;116;78 03:55:36 INFO - PROCESS | 27254 | |11;stanford-crypto-ccm;129;118;130;130;127;130;118;130;145;120 03:55:36 INFO - PROCESS | 27254 | |12;stanford-crypto-pbkdf2;158;162;159;154;154;163;153;157;155;154 03:55:36 INFO - PROCESS | 27254 | |13;stanford-crypto-sha256-iterative;61;61;61;61;62;63;62;61;61;59 03:55:36 INFO - PROCESS | 27254 | __end_tp_report 03:55:36 INFO - PROCESS | 27254 | __start_cc_report 03:55:36 INFO - PROCESS | 27254 | _x_x_mozilla_cycle_collect,1597 03:55:36 INFO - PROCESS | 27254 | __end_cc_report 03:55:36 INFO - PROCESS | 27254 | __startTimestamp1469876136715__endTimestamp 03:55:36 INFO - PROCESS | 27254 | 03:55:36 INFO - PROCESS | 27254 | ------- Summary: start ------- 03:55:36 INFO - PROCESS | 27254 | Number of tests: 14 03:55:36 INFO - PROCESS | 27254 | 03:55:36 INFO - PROCESS | 27254 | [#0] ai-astar Cycles:10 Average:108.50 Median:109.00 stddev:1.84 (1.7%) stddev-sans-first:1.94 03:55:36 INFO - PROCESS | 27254 | Values: 109.0 104.0 109.0 109.0 109.0 109.0 109.0 107.0 111.0 109.0 03:55:36 INFO - PROCESS | 27254 | 03:55:36 INFO - PROCESS | 27254 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:138.50 stddev:16.25 (11.7%) stddev-sans-first:17.15 03:55:36 INFO - PROCESS | 27254 | Values: 145.0 130.0 127.0 174.0 132.0 131.0 146.0 125.0 161.0 131.0 03:55:36 INFO - PROCESS | 27254 | 03:55:36 INFO - PROCESS | 27254 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 03:55:36 INFO - PROCESS | 27254 | Values: 163.0 162.0 162.0 163.0 161.0 162.0 162.0 163.0 164.0 161.0 03:55:36 INFO - PROCESS | 27254 | 03:55:36 INFO - PROCESS | 27254 | [#3] audio-fft Cycles:10 Average:80.10 Median:75.00 stddev:10.60 (14.1%) stddev-sans-first:11.08 03:55:36 INFO - PROCESS | 27254 | Values: 75.0 75.0 76.0 103.0 75.0 75.0 76.0 74.0 97.0 75.0 03:55:36 INFO - PROCESS | 27254 | 03:55:36 INFO - PROCESS | 27254 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:84.50 stddev:21.18 (25.1%) stddev-sans-first:21.90 03:55:36 INFO - PROCESS | 27254 | Values: 84.0 85.0 116.0 85.0 85.0 85.0 132.0 84.0 84.0 134.0 03:55:36 INFO - PROCESS | 27254 | 03:55:36 INFO - PROCESS | 27254 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:55:36 INFO - PROCESS | 27254 | Values: 117.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 03:55:36 INFO - PROCESS | 27254 | 03:55:36 INFO - PROCESS | 27254 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 03:55:36 INFO - PROCESS | 27254 | Values: 145.0 146.0 146.0 145.0 146.0 146.0 146.0 147.0 146.0 147.0 03:55:36 INFO - PROCESS | 27254 | 03:55:36 INFO - PROCESS | 27254 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:55:36 INFO - PROCESS | 27254 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 03:55:36 INFO - PROCESS | 27254 | 03:55:36 INFO - PROCESS | 27254 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:1.07 (1.9%) stddev-sans-first:1.01 03:55:36 INFO - PROCESS | 27254 | Values: 55.0 55.0 58.0 56.0 56.0 57.0 56.0 58.0 57.0 56.0 03:55:36 INFO - PROCESS | 27254 | 03:55:36 INFO - PROCESS | 27254 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 03:55:36 INFO - PROCESS | 27254 | Values: 60.0 60.0 60.0 61.0 61.0 60.0 59.0 60.0 59.0 60.0 03:55:36 INFO - PROCESS | 27254 | 03:55:36 INFO - PROCESS | 27254 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:78.00 stddev:12.20 (15.6%) stddev-sans-first:12.84 03:55:36 INFO - PROCESS | 27254 | Values: 77.0 76.0 76.0 77.0 78.0 78.0 79.0 79.0 116.0 78.0 03:55:36 INFO - PROCESS | 27254 | 03:55:36 INFO - PROCESS | 27254 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:130.00 stddev:7.96 (6.1%) stddev-sans-first:8.43 03:55:36 INFO - PROCESS | 27254 | Values: 129.0 118.0 130.0 130.0 127.0 130.0 118.0 130.0 145.0 120.0 03:55:36 INFO - PROCESS | 27254 | 03:55:36 INFO - PROCESS | 27254 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.90 Median:157.50 stddev:3.54 (2.2%) stddev-sans-first:3.73 03:55:36 INFO - PROCESS | 27254 | Values: 158.0 162.0 159.0 154.0 154.0 163.0 153.0 157.0 155.0 154.0 03:55:36 INFO - PROCESS | 27254 | 03:55:36 INFO - PROCESS | 27254 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.20 Median:61.00 stddev:1.03 (1.7%) stddev-sans-first:1.09 03:55:36 INFO - PROCESS | 27254 | Values: 61.0 61.0 61.0 61.0 62.0 63.0 62.0 61.0 61.0 59.0 03:55:36 INFO - PROCESS | 27254 | -------- Summary: end -------- 03:55:36 INFO - PROCESS | 27254 | 03:55:37 INFO - TEST-INFO | 27254: exit 0 03:55:37 INFO - TEST-OK | kraken | took 60787ms 03:55:37 INFO - SUITE-END | took 1172s 03:55:37 INFO - Completed test suite (00:19:32) 03:55:37 INFO - javascript benchmark 03:55:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3167.588213532241, 3198.968010319896, 3201.2797120647856, 3223.5487031815564, 3247.3342964692242, 4854.8786280342965, 4905.166121759301, 4916.532929371704, 4937.160682683943, 4953.306537084802, 4903.313536104948, 4927.950720492794, 4954.801807927679, 4955.4548999610015, 4974.37820272466, 4369.956300437003, 4398.208322501949, 4515.503294637596, 4535.410396648447, 4576.633869290449, 4453.421055262827, 4453.732776033448, 4455.086707225028, 4490.820367185309, 4492.483364413085, 4548.090381923612, 4569.543045695421, 4578.519255478177, 4581.0, 4588.197065513538, 4568.56598623132, 4571.26859702446, 4572.474165470963, 4574.702644328141, 4601.815927362935, 4375.496817865923, 4391.626711729475, 4475.776211189427, 4499.89752510637, 4528.524504926968, 4781.665283430161, 4818.831340903052, 4833.419989601235, 4893.0, 4902.166631672624, 5289.629725919187, 5290.0477913975465, 5296.761645725952, 5297.099493086184, 5297.602679798992, 5044.344235249431, 5110.821121260775, 5134.512221338967, 5181.300524429192, 5219.399769026572, 4914.164592019365, 4920.827771027997, 4929.433115191763, 4953.157963146274, 4968.378952630921, 5159.251908473326, 5363.19552067193, 5365.195220716846, 5365.704886231295, 5373.704446255493, 5105.132127538327, 5171.793128274827, 5184.585233181337, 5209.426963034063, 5248.265242866002, 5276.973615131977, 5295.4969277918535, 5296.576273898079, 5296.602754793329, 5326.707031113248, 4975.253711943165, 5094.312267843794, 5252.606054545924, 5260.71066091361, 5262.605304602093, 5115.360579927509, 5165.535101840853, 5185.792568297225, 5187.714675692798, 5208.244804503326, 4121.5878412158545, 4124.175164967019, 4127.9174416511505, 4146.129312844337, 4150.066235097079, 3699.963000370016, 3719.20037192005, 3739.551253849501, 3752.1932784451474, 3774.0, 4978.950210497848, 4997.3253610762085, 4997.825076122318, 4999.3000979862845, 5009.298698182258, 5263.868403289948, 5265.605079619044, 5274.077036518594, 5280.894382112413, 5290.947090529045, 4744.5492678195515, 4917.385326834145, 4949.876253093701, 4977.129002424561, 4994.725290109006, 4559.772011399483, 4574.611158051603, 4575.290829921368, 4578.793954272066, 4598.724076555351, 5465.808696695596, 5471.6169868108855, 5482.506574408243, 5489.505944465017, 5492.752826122834, 5058.0, 5062.316587260746, 5103.617228707936, 5120.18077107661, 5132.050570644443, 5316.574674026146, 5330.520253177233, 5339.145736682112, 5343.732813359395, 5346.866328341823, 4933.087378834927, 5092.236164575195, 5093.92359114621, 5095.949040509548, 5119.308893299357, 5160.896782064263, 5194.402643696023, 5215.530602245816, 5232.816851410183, 5262.0, 5126.282320475211, 5132.255822905732, 5134.537891589625, 5134.717590532557, 5164.1995490699, 4866.197077482176, 5079.517445842639, 5095.490450954875, 5119.48805119485, 5122.052420302256, 5046.0, 5117.334746482933, 5125.974805038933, 5127.256547800623, 5169.353830771153, 5216.478352164753, 5227.032998895216, 5231.084560202025, 5240.790368385222, 5242.606804489602, 4843.588294994824, 4898.681585696918, 4905.607551395951, 5105.412877519133, 5131.153359695609], "value": 4861.954922986681, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.402785270435, 650.5933791380387, 652.0675434129195, 661.77830426807, 664.4285914113864, 31434.371312573734, 34458.65541344586, 34511.654883451156, 45901.311480327735, 47547.52452475474, 47388.763056184755, 47685.284720729214, 47746.0, 47893.0, 47963.76018119913, 7870.842583148334, 9087.636494540211, 9236.538173091352, 9236.815263694722, 9247.6300947962, 10649.201309901788, 10911.290766100217, 10931.01620854123, 11280.041196498267, 11299.604513842018, 10984.890151098467, 10998.780024399508, 11079.058280046165, 11094.833577496343, 11104.222704410695, 7979.122296547375, 10693.411862347568, 10958.945205274002, 10969.725756856102, 11035.613753518628, 10835.295705779099, 10916.235863489559, 10943.726406839893, 10949.069329107035, 10955.616553420592, 43537.12925741467, 44034.0, 44063.33904991428, 44091.11817763659, 44096.779516102535, 3762.623737626243, 3800.7149463790324, 3808.257389808988, 3829.195868867513, 3831.942520862189, 33987.66012339894, 34689.299969526895, 34920.0, 35034.299314013835, 35179.4723079154, 4321.848735294249, 4359.367891655724, 4373.781310934441, 4407.449068866392, 4499.415076040126, 376722.0, 378347.0, 378560.0, 378898.0, 379324.0, 37450.43824342637, 39360.80319598383, 63580.0, 64365.35634643687, 64374.67812660907, 41174.588254117676, 41188.38217426741, 41276.0, 41318.1736365271, 41328.586714133075, 16803.495895123167, 16995.83004169967, 16997.49007529776, 17023.148842558072, 17026.148692565323, 12485.56300529477, 12749.0, 12922.676933076747, 14490.347934342979, 14908.478203262834, 9416.90583094174, 9420.481873497023, 9427.575759090858, 9472.810543789086, 9476.573554190078, 3512.5960514541157, 3535.055719354345, 3560.092176494977, 3586.55168103987, 3596.460530920383, 1088.4884104470887, 1096.2107282756403, 1100.5982816272003, 1121.43928035982, 1171.2211379432752, 34468.31063378719, 36144.638553614655, 36554.268914621556, 36613.08467288339, 36613.08467288339, 1126.7690123524658, 1156.5200441816553, 1196.2702751321688, 1233.2980486927981, 1239.5537606461667, 17017.574560635836, 17306.653866922592, 17321.480355589352, 17494.0, 17517.7372339415, 610850.0, 611215.0, 612238.0, 615992.0, 622191.0, 62780.68609657014, 64130.67934660297, 64201.67899160474, 64211.678941604994, 64215.0, 1303.3483258370813, 1442.5167568864338, 1482.636753995278, 1505.3000354835053, 1506.41249912532, 32936.0, 34929.0, 35114.47328290129, 35171.648283516835, 35226.47160292649, 53936.19095713646, 54259.0, 54593.0, 54693.0, 54753.45246547484, 436940.0, 442236.0, 443663.0, 445240.0, 446006.0, 26250.86874565615, 29076.27309317284, 30817.69182308148, 31087.067387978397, 32165.678343216267, 50379.74810125926, 51462.74268628633, 51593.08486842742, 51892.221616676536, 52464.73767631137, 41777.373339399324, 41888.790556047024, 42062.57937420709, 42306.0, 43658.690239292875, 41666.58333416627, 42232.788836055624, 42767.78616107024, 43000.56999429966, 43476.347854782834, 42050.78974605107, 42334.78832605817, 43183.78408107939, 43324.35013474863, 43706.90732731707, 36435.45346819853, 37372.81313593415, 37813.0, 38152.0, 38590.228195435375, 28555.857220713762, 28836.42327153487, 28879.0, 29092.709072909845, 29185.85407072951], "value": 20336.615046450937, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.12194513466847, 421.3195688962327, 422.90273237155463, 437.7789216445695, 445.058700847707, 18180.0, 18705.064746762677, 19628.411147665574, 19788.30740924068, 19837.305694300703, 18695.3456629018, 19150.42548723537, 19492.12285447155, 19926.70109948352, 19928.50178745532, 4934.235193545006, 5205.531502164805, 5222.63441559091, 5256.973715131419, 5272.499112584298, 5167.147420675584, 5186.948130518685, 5228.73856307185, 5233.345831771028, 5240.056789777838, 5223.582113430935, 5325.520703136717, 5336.59975501837, 5341.572674186055, 5358.196270559409, 5204.401493828221, 5276.103062479368, 5298.390685071208, 5305.549028332596, 5326.493983071621, 5087.389513258396, 5180.740962951875, 5216.530512253916, 5217.530422261977, 5221.791128354861, 14243.287835608282, 14604.70790584193, 21118.366449006553, 23775.0, 23793.7620623795, 2445.5108978204253, 2446.9388265293333, 2459.0, 2551.0, 2616.2282126772648, 10481.842772358421, 10507.106895913856, 10533.0, 10831.620893268777, 11010.284331518505, 2056.249468943825, 2071.326818783901, 2098.2551194325947, 2132.829373650104, 2148.52732398872, 59949.0, 61652.7039216957, 72586.63706681432, 82998.58500707518, 83420.0, 11599.826002609967, 11646.94176529112, 11764.705882352831, 11829.822552661717, 11903.940480297542, 14373.13761174312, 15172.468963586221, 16060.0, 16085.758713619305, 16575.41986030483, 8303.335733141334, 8404.949381327335, 8430.072692003874, 8554.572271386405, 8589.914100858912, 8028.879566806502, 8029.7189598363775, 8097.109317975018, 8141.389395795339, 8207.220314070153, 5003.624728145403, 5079.187330027252, 5133.666311689728, 5166.070107380708, 5201.531862132426, 2069.134249065056, 2071.5339048714222, 2106.252280440452, 2118.4809721617994, 2158.5251244726137, 879.569011184515, 930.8789857318641, 961.8364877970762, 990.4601991914424, 1048.6015314180563, 17936.0, 18871.90564047171, 19157.61684766297, 20470.18119275242, 20562.69155962662, 1009.9646512372178, 1027.7944411117658, 1049.0296475759892, 1054.1724746074294, 1075.9031687148038, 10482.371057736407, 10749.0, 10814.89185108139, 10928.235023548275, 11062.391568463812, 560255.0, 582868.0, 587473.0, 591902.0, 596971.0, 92040.53979730059, 97486.0, 98008.0, 98392.0, 99189.0, 1074.9462526873624, 1080.448971024783, 1100.5982816272003, 1119.6081371520065, 1123.1407972900738, 17320.826791732426, 17564.297428102735, 17616.29534818593, 17628.14904435067, 17936.641267174324, 27593.206172950093, 38321.23357532889, 39385.80307098446, 40689.0, 41509.37735933903, 50690.0, 52954.0, 56930.0, 56950.87650934953, 57407.0, 8554.443961142506, 8769.0, 8818.426802257833, 8913.598888049924, 8927.687530936386, 9452.905470945478, 12824.807627885402, 13132.540361087316, 13174.011949103664, 13393.129446585941, 10920.726981825517, 11320.037796787365, 11324.716882078013, 11529.538818447169, 11702.2978621283, 11498.597549085742, 11514.481848316678, 11550.826737598774, 11612.6516204514, 11897.405129743305, 11509.94245028803, 11764.764704706029, 11913.583024594098, 11928.165028447926, 11933.940330298294, 8650.697225597074, 8786.428882122642, 8859.867101993605, 8868.11318868108, 8929.285657147282, 8833.425827321204, 11575.363355015555, 11607.36159511235, 11707.121965852424, 11831.230969986924], "value": 9220.766746243233, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.0567308557088, 1579.4235104186969, 1607.2526275281994, 1824.0697244405349, 1908.2939312454394, 9195.494247816367, 9579.5210239488, 9655.275854310928, 9937.602495900173, 9944.055314745106, 9630.903690963089, 9854.260930430211, 9862.30963832532, 9871.703848884545, 9879.012098790117, 2463.384153961505, 2488.4774197418565, 2490.091116742385, 2492.252324302711, 2505.4237525369176, 2458.942654658496, 2490.5018996200743, 2492.8379655322346, 2493.5386953413677, 2495.563276426627, 2448.9755102448926, 2458.8893499792553, 2487.56467618167, 2490.2155820916355, 2490.7882829959385, 2384.1059602649007, 2402.7477114902945, 2407.3981504623844, 2417.576924038304, 2418.117387153694, 2391.581473242193, 2417.286900364397, 2422.9273121806373, 2427.757224277576, 2429.866357350345, 9428.669996550088, 9546.904530954671, 9660.75848103796, 9667.70996870095, 9682.419054856731, 5631.8028868989795, 5787.074068149118, 5795.739191736382, 5796.420357964212, 5800.796972105998, 3488.6511348865165, 3506.1760486285957, 3553.8045407502577, 3560.6795388415167, 3590.281943611288, 1142.8457158283609, 1156.4275683536703, 1157.2940506291156, 1166.7316517201007, 1182.9467673954694, 13965.301734913315, 14067.155970641692, 14101.224432656303, 14119.788203176859, 14124.364403601863, 4790.904181916342, 4813.78337974785, 4901.485344038896, 4914.827981020719, 4923.75381230937, 10808.56765729362, 10831.404272764916, 10864.674059778219, 10872.72818179536, 10876.02115809581, 5570.944290557042, 5615.129654903497, 5625.662460252398, 5627.155926611041, 5628.04323265046, 4428.68999170055, 4756.7859446325, 5045.217991211368, 5153.484651534816, 5242.16125419931, 4399.5380485049245, 4539.0, 4554.3168524720895, 4557.635389168859, 4576.130535198302, 1399.734050530396, 1444.097439100562, 1446.4937271954732, 1453.8909581781409, 1457.249516499004, 840.4873027453249, 954.6706386296717, 1002.04304888831, 1014.5840205515703, 1027.0, 6141.447269745655, 6355.523335749837, 6357.396047375584, 6447.618096474658, 6503.057056726748, 1024.2676486312323, 1036.9637062702768, 1038.08129805123, 1054.6730513540674, 1069.812782763029, 4375.562443755599, 4611.100835337144, 4620.1914664934175, 4647.209974304376, 4728.101660684459, 11984.161108722306, 12132.15074944763, 12403.13178077544, 12694.365281735876, 12718.427670754838, 12158.878411215775, 12513.49946002168, 12548.18436801605, 12662.683432914251, 12682.49270029207, 8981.191692747683, 9001.774955626031, 9060.637574497077, 9078.228350590274, 9078.45529268246, 6344.809655710336, 6399.584027038228, 6433.5496515243485, 6485.0596663484475, 6489.772857949949, 10878.619248326271, 11008.449577521253, 11015.284006539548, 11176.88823111791, 11294.04000659953, 10356.326838755456, 11498.712532186762, 11676.649700508999, 11717.121215909012, 11910.702232444259, 9054.0, 9273.582688779155, 9299.674511392339, 9528.285378596494, 9538.95230523843, 8767.342449316198, 9035.864462033207, 9039.864402033843, 9274.44353338802, 9373.390729602554, 7923.603819809102, 7981.2018798119725, 8013.998250218722, 8076.838463230585, 8153.1846815317995, 8479.533625650649, 8504.659813607386, 8531.616077276414, 8581.914180858112, 8656.134386561545, 7710.4217183710325, 7767.650455729618, 7876.527408355517, 7879.0939042010905, 7882.172371900868, 5393.083175860192, 5485.369182544058, 5612.410696876769, 5663.943360566506, 5802.216700745345, 5550.111982082847, 5749.770009199585, 5786.826395208151, 5830.912536311874, 5881.794137205177], "value": 5052.57175712351, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.18382738032886, 352.2075330506361, 353.4256832646948, 370.0526651771467, 372.99440508392377, 4730.124926888528, 4850.417949846014, 4924.704517728935, 4968.441252754829, 4973.17942539481, 4840.854774356766, 4864.294677271802, 4866.659333846632, 4882.1700310947135, 4892.681975671579, 3961.6428225205955, 3962.9405558916637, 3967.1552727981484, 3976.661983731379, 3987.7806720630497, 3753.887383378503, 3830.559485659143, 3912.882613521599, 3930.6265904739003, 3962.177398396741, 3897.8051097445154, 3924.1759230561615, 3928.41073838925, 3940.7044471664594, 3946.861859834906, 3915.295246855565, 3927.253821773854, 3927.2930872442807, 3946.3291240489184, 3954.5452272988687, 3546.8758593449365, 3564.82175891207, 3567.714582833367, 3578.9621009907096, 3590.533230680021, 4411.691181617288, 4649.18639238132, 4649.372334734835, 4659.58063774262, 4670.649701272384, 4384.583464570861, 4410.338449232609, 4422.955770442319, 4438.622717069053, 4472.329150627399, 5028.874278143039, 5040.798368065273, 5049.091163590552, 5077.162268225738, 5092.872678183038, 3708.2212735325616, 3731.6641502264656, 3780.3933328335347, 3785.4511095891216, 3789.5263092113487, 5151.922721159148, 5160.174372100483, 5166.741662916839, 5193.37679478465, 5197.168453047532, 3858.3633700439113, 3894.3768996960353, 3896.922061558753, 3898.8830335089992, 3904.96095039046, 3704.944425833615, 3881.4760007399204, 3957.248122856648, 3963.128111815396, 3967.3850553164307, 4324.200022995756, 4340.934885976713, 4343.978280108579, 4387.298032314814, 4392.516823149451, 5022.84931452057, 5064.746762661852, 5069.161269688986, 5082.161443361878, 5133.358330208724, 1273.5669872243298, 1303.3092460995688, 1321.6167311479562, 1328.1765305510646, 1334.292824802856, 891.3136884598953, 897.1701176411793, 904.5341649050744, 913.1462082952461, 915.1260546178383, 4324.35134729793, 4392.868213953587, 4424.358468022118, 4457.910841783211, 4462.709923855004, 4551.429756733922, 4611.700239484423, 4671.566398696955, 4684.508126646721, 4693.835715749932, 4465.843695470643, 4474.664400170001, 4484.955150448519, 4491.507213496476, 4499.280115181556, 2392.880355982194, 2472.270680149324, 2477.2072936660097, 2483.2922617054055, 2484.987575062113, 4725.574698277172, 4797.520247975174, 4798.760061996886, 4824.059308434821, 4824.975875120602, 4609.354690343354, 4644.628429725682, 4646.6747327686735, 4690.482138396203, 4730.219513780256, 4494.280960019207, 4723.858284251478, 4768.475467698481, 4787.832425865078, 4809.519048095162, 4598.3792188054185, 4608.193566125848, 4634.698744581591, 4651.534846515321, 4655.0457156283555, 4545.704529205591, 4563.885902852455, 4596.655250856133, 4624.676272661016, 4625.953740462687, 4855.393075865517, 5037.546620804145, 5445.700486473282, 5448.918266226089, 5450.509454149145, 3783.621637836194, 3789.943150852684, 3800.6959443243923, 3804.8478060877255, 3818.389057750858, 5101.7704203310195, 5235.4502777207845, 5281.867953301198, 5308.973455132699, 5316.946830531645, 4987.975060124676, 5111.3355263815465, 5140.691558506352, 5140.789460531858, 5158.3552055993005, 4985.925211121908, 5074.949250507448, 5111.667741596784, 5133.946421431458, 5159.226116082617, 4888.755562221946, 5006.974965125151, 5037.798488060436, 5079.263506791568, 5082.745862706924, 5057.367829021372, 5082.847514574569, 5087.313212716236, 5104.566111880532, 5107.186948633182, 5012.448630650699, 5026.321446604661, 5034.546890779848, 5069.555176774602, 5072.4673909239], "value": 3833.9137258604046, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.7673851321629, 847.6185716427607, 850.6384786465751, 854.3848429131025, 868.7828042989256, 15496.767548486767, 16837.158142092878, 16854.83145168548, 16868.40960566379, 16887.493375198734, 15255.618609534768, 15333.69332613347, 15429.768553471707, 15431.228438578055, 15435.536933891974, 689.6930865764737, 847.2798121596655, 864.6930339729399, 877.398981697536, 882.4220135811054, 872.1452976083442, 873.8121303919656, 874.0385575866528, 877.5392918717693, 877.8244351129799, 930.8417569013284, 932.2029664636706, 932.7201839448172, 934.5700977550335, 934.686879895236, 735.4006484714967, 900.8423525882977, 925.6575067225102, 928.823523530527, 929.061647735785, 680.6630717794724, 680.7175022365712, 680.9557378770364, 681.117952251835, 681.117952251835, 15302.617434564114, 15341.309641066178, 15342.846571534254, 15346.693066138727, 15391.538253852403, 14637.926810365987, 14844.0, 15044.623884402868, 15073.849261507354, 15224.771628425582, 13415.731685366238, 13475.19148851072, 13512.39194236252, 13544.796828047587, 13868.93065534676, 4001.339778936472, 4016.5581786003518, 4078.6125318094732, 4698.812047518095, 4739.36018637483, 78033.0, 79829.0, 80959.19040809576, 80995.5950220251, 81136.18863811345, 12048.277103373826, 12098.213616114925, 12243.816342754866, 12377.443015064344, 12455.439505222286, 21469.78530214709, 21529.246476373566, 21545.67681484779, 21613.351599452042, 21681.56636867254, 8634.510054771483, 8724.389292749574, 8724.8691269631, 8746.169113934166, 8905.643774249087, 4812.446568644581, 4820.156472617348, 4852.684575502581, 4938.456769755324, 5014.749262536859, 3501.9474707878894, 3599.280143971216, 3621.0766254604905, 3626.8911932642063, 3632.763870348419, 589.6609449566516, 649.5940037476577, 692.7876216620914, 699.237830764459, 739.3530660671912, 683.1153656015472, 692.0518889121835, 713.0694443750851, 729.9817504562428, 743.6542007966214, 9730.659426920165, 9876.753081172885, 10020.24848136378, 10197.94901025505, 10210.0, 623.9594426362272, 715.8282012317111, 742.3949481172826, 782.1513657681365, 803.4135081390617, 5072.289879416885, 5112.923306150411, 5167.974160129175, 5204.895902082013, 5218.947810521846, 76517.61741191258, 77591.22408775953, 77718.0, 126138.36930815288, 126441.0, 61942.69028654828, 106105.0, 106244.0, 107452.0, 107670.0, 94777.526112369, 94964.0, 95145.0, 97431.51284243676, 98537.50731246299, 9593.088656577615, 9611.855822162814, 9671.468069256258, 9721.31950763468, 9836.0, 55358.72320638371, 55711.0, 55892.72053639706, 56515.71742141263, 57537.0, 76864.61567692125, 83693.58153209195, 85003.0, 85791.14208857832, 86322.56838715766, 12700.809487857505, 12701.36493175356, 12860.807087893501, 12964.546240881524, 13009.089363744448, 13483.46066157382, 13613.86386136126, 13634.386452609459, 13687.657808554866, 13735.862641373458, 10730.624428144978, 13683.86316136826, 13799.448022079005, 13811.79282310746, 14235.50175743844, 13171.160200037963, 13308.600741977756, 13362.0, 14013.43946242139, 14160.716785664023, 14211.360488777824, 14729.0, 15037.774433383289, 15047.0, 15313.387464501295, 11280.0, 12122.454489548169, 12365.876341236473, 12634.178778379375, 12735.80896286538, 12365.258084514959, 12520.0, 12535.93732031334, 12565.308908010147, 12615.180013299107], "value": 7905.809639750945, "unit": "score"}], "name": "dromaeo_css", "value": 7202.799546269527, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 104.0, 109.0, 109.0, 109.0, 109.0, 109.0, 107.0, 111.0, 109.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 130.0, 127.0, 174.0, 132.0, 131.0, 146.0, 125.0, 161.0, 131.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 161.0, 162.0, 162.0, 163.0, 164.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 103.0, 75.0, 75.0, 76.0, 74.0, 97.0, 75.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 116.0, 85.0, 85.0, 85.0, 132.0, 84.0, 84.0, 134.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 58.0, 56.0, 56.0, 57.0, 56.0, 58.0, 57.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 61.0, 61.0, 60.0, 59.0, 60.0, 59.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 77.0, 78.0, 78.0, 79.0, 79.0, 116.0, 78.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 118.0, 130.0, 130.0, 127.0, 130.0, 118.0, 130.0, 145.0, 120.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 162.0, 159.0, 154.0, 154.0, 163.0, 153.0, 157.0, 155.0, 154.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 63.0, 62.0, 61.0, 61.0, 59.0], "value": 61.2, "unit": "score"}], "name": "kraken", "value": 1490.0000000000005, "alertThreshold": 2.0}]} 03:55:37 INFO - Return code: 0 03:55:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:55:37 ERROR - # TBPL SUCCESS # 03:55:37 INFO - Running post-action listener: _resource_record_post_action 03:55:37 INFO - ##### 03:55:37 INFO - ##### Finished run-tests step (success) 03:55:37 INFO - ##### 03:55:37 INFO - Running post-run listener: _resource_record_post_run 03:55:38 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 516694016; Read time: 8; Write time: 510688 03:55:38 INFO - TinderboxPrint: CPU usage
13.1% 03:55:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:55:38 INFO - TinderboxPrint: I/O write bytes / time
516,694,016 / 510,688 03:55:38 INFO - TinderboxPrint: CPU idle
8,246.3 (86.9%) 03:55:38 INFO - TinderboxPrint: CPU user
1,198.5 (12.6%) 03:55:38 INFO - TinderboxPrint: Swap in / out
0 / 0 03:55:38 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 265961472; Read time: 0; Write time: 328104 03:55:38 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250732544; Read time: 8; Write time: 182584 03:55:38 INFO - Running post-run listener: _upload_blobber_files 03:55:38 INFO - Blob upload gear active. 03:55:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:55:38 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:55:38 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:55:38 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:55:39 INFO - (blobuploader) - INFO - Open directory for files ... 03:55:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:55:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:55:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:39 INFO - (blobuploader) - INFO - Done attempting. 03:55:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:55:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:55:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:40 INFO - (blobuploader) - INFO - Done attempting. 03:55:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:55:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:55:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:43 INFO - (blobuploader) - INFO - Done attempting. 03:55:43 INFO - (blobuploader) - INFO - Iteration through files over. 03:55:43 INFO - Return code: 0 03:55:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:55:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:55:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14d4b3301da28218b8a5d26374d9d596b00264651afe1a9494d7cdd3aacacafc63541083f94714141e81eff3001cd839058e9196bce43d2a982907dc7c6f0e56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/006c5027a8b7459cc8afcb6a9eb24197ad1b21708f814c900c5bfc8f1f596dccff5e4bb2a4d0d388a5b43fd335de5d30a50ca8bde09c4fa868b649da2431ac0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d65e77c0c0b6187246ffbbf8dd8d6f8d041a3edd32d7a94a8ce7a9435d77de3d4309de2f08c347c87d36052cdd47fc81aefd23bfce2e320aee6936f123f1cc6"} 03:55:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:55:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:55:43 INFO - Contents: 03:55:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14d4b3301da28218b8a5d26374d9d596b00264651afe1a9494d7cdd3aacacafc63541083f94714141e81eff3001cd839058e9196bce43d2a982907dc7c6f0e56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/006c5027a8b7459cc8afcb6a9eb24197ad1b21708f814c900c5bfc8f1f596dccff5e4bb2a4d0d388a5b43fd335de5d30a50ca8bde09c4fa868b649da2431ac0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d65e77c0c0b6187246ffbbf8dd8d6f8d041a3edd32d7a94a8ce7a9435d77de3d4309de2f08c347c87d36052cdd47fc81aefd23bfce2e320aee6936f123f1cc6"} 03:55:43 INFO - Running post-run listener: copy_logs_to_upload_dir 03:55:43 INFO - Copying logs to upload dir... 03:55:43 INFO - mkdir: /builds/slave/test/build/upload/logs 03:55:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.266098 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-30 03:55:43.342570) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 03:55:43.346420) ========= 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=c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799 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/14d4b3301da28218b8a5d26374d9d596b00264651afe1a9494d7cdd3aacacafc63541083f94714141e81eff3001cd839058e9196bce43d2a982907dc7c6f0e56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/006c5027a8b7459cc8afcb6a9eb24197ad1b21708f814c900c5bfc8f1f596dccff5e4bb2a4d0d388a5b43fd335de5d30a50ca8bde09c4fa868b649da2431ac0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d65e77c0c0b6187246ffbbf8dd8d6f8d041a3edd32d7a94a8ce7a9435d77de3d4309de2f08c347c87d36052cdd47fc81aefd23bfce2e320aee6936f123f1cc6"} build_url:https://queue.taskcluster.net/v1/task/TAW81gvxQt2i0vjUyRcItg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011402 build_url: 'https://queue.taskcluster.net/v1/task/TAW81gvxQt2i0vjUyRcItg/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/14d4b3301da28218b8a5d26374d9d596b00264651afe1a9494d7cdd3aacacafc63541083f94714141e81eff3001cd839058e9196bce43d2a982907dc7c6f0e56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/006c5027a8b7459cc8afcb6a9eb24197ad1b21708f814c900c5bfc8f1f596dccff5e4bb2a4d0d388a5b43fd335de5d30a50ca8bde09c4fa868b649da2431ac0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d65e77c0c0b6187246ffbbf8dd8d6f8d041a3edd32d7a94a8ce7a9435d77de3d4309de2f08c347c87d36052cdd47fc81aefd23bfce2e320aee6936f123f1cc6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 03:55:43.376650) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:55:43.377479) ========= 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=c6927cf182745ad25b1d38b9000001fe-1469874912.130694-272243799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:55:43.457348) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 03:55:43.457736) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 03:55:43.458141) ========= ========= Total master_lag: 0.18 =========